builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1450738349.24 results: success (0) buildid: 20151221113016 builduid: 99624db733524d7cac9a0bc6882974ea revision: 12d44899c6fd466d00d71638cb3501a703938569 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:29.237045) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:29.238718) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:29.239283) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006455 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:29.266869) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:29.267174) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:29.312986) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:29.313270) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004752 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:29.365012) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:29.365325) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:29.365730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:29.366035) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 14:52:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-12-21 14:52:30 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125388 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:29.511120) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:29.511449) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022466 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:29.565037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:29.565386) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 12d44899c6fd466d00d71638cb3501a703938569 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 12d44899c6fd466d00d71638cb3501a703938569 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 14:52:30,635 truncating revision to first 12 chars 2015-12-21 14:52:30,635 Setting DEBUG logging. 2015-12-21 14:52:30,636 attempt 1/10 2015-12-21 14:52:30,636 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/12d44899c6fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 14:52:30,905 unpacking tar archive at: b2g-inbound-12d44899c6fd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.607688 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:30.188434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:30.189069) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:30.200414) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:30.200992) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 14:52:30.201866) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-21 14:52:30.202552) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:52:31 INFO - MultiFileLogger online at 20151221 14:52:31 in /builds/slave/test-pgo 14:52:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 14:52:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:52:31 INFO - {'append_to_log': False, 14:52:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:52:31 INFO - 'blob_upload_branch': 'B2G-Inbound', 14:52:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:52:31 INFO - 'branch': 'B2G-Inbound', 14:52:31 INFO - 'buildbot_json_path': 'buildprops.json', 14:52:31 INFO - 'config_files': ('talos/linux_config.py',), 14:52:31 INFO - 'default_actions': ('clobber', 14:52:31 INFO - 'read-buildbot-config', 14:52:31 INFO - 'download-and-extract', 14:52:31 INFO - 'populate-webroot', 14:52:31 INFO - 'create-virtualenv', 14:52:31 INFO - 'install', 14:52:31 INFO - 'run-tests'), 14:52:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:52:31 INFO - 'download_minidump_stackwalk': True, 14:52:31 INFO - 'download_symbols': 'ondemand', 14:52:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:52:31 INFO - 'tooltool.py': '/tools/tooltool.py', 14:52:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:52:31 INFO - '/tools/misc-python/virtualenv.py')}, 14:52:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:52:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:52:31 INFO - 'installer_path': 'installer.exe', 14:52:31 INFO - 'log_level': 'info', 14:52:31 INFO - 'log_name': 'talos', 14:52:31 INFO - 'log_to_console': True, 14:52:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:52:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:52:31 INFO - 'opt_config_files': (), 14:52:31 INFO - 'pip_index': False, 14:52:31 INFO - 'sps_profile': False, 14:52:31 INFO - 'sps_profile_interval': 0, 14:52:31 INFO - 'suite': 'dromaeojs', 14:52:31 INFO - 'system_bits': '64', 14:52:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:52:31 INFO - 'title': 'talos-linux64-ix-061', 14:52:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:52:31 INFO - 'use_talos_json': True, 14:52:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:52:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:52:31 INFO - 'work_dir': 'build'} 14:52:31 INFO - ##### 14:52:31 INFO - ##### Running clobber step. 14:52:31 INFO - ##### 14:52:31 INFO - Running pre-action listener: _resource_record_pre_action 14:52:31 INFO - Running main action method: clobber 14:52:31 INFO - rmtree: /builds/slave/test-pgo/build 14:52:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:52:32 INFO - Running post-action listener: _resource_record_post_action 14:52:32 INFO - ##### 14:52:32 INFO - ##### Running read-buildbot-config step. 14:52:32 INFO - ##### 14:52:32 INFO - Running pre-action listener: _resource_record_pre_action 14:52:32 INFO - Running main action method: read_buildbot_config 14:52:32 INFO - Using buildbot properties: 14:52:32 INFO - { 14:52:32 INFO - "project": "", 14:52:32 INFO - "product": "firefox", 14:52:32 INFO - "script_repo_revision": "production", 14:52:32 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 14:52:32 INFO - "repository": "", 14:52:32 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 14:52:32 INFO - "buildid": "20151221113016", 14:52:32 INFO - "pgo_build": "True", 14:52:32 INFO - "basedir": "/builds/slave/test-pgo", 14:52:32 INFO - "buildnumber": 138, 14:52:32 INFO - "slavename": "talos-linux64-ix-061", 14:52:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:52:32 INFO - "platform": "ubuntu64_hw", 14:52:32 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 14:52:32 INFO - "branch": "b2g-inbound", 14:52:32 INFO - "repo_path": "integration/b2g-inbound", 14:52:32 INFO - "revision": "12d44899c6fd466d00d71638cb3501a703938569", 14:52:32 INFO - "stage_platform": "linux64-pgo", 14:52:32 INFO - "builduid": "99624db733524d7cac9a0bc6882974ea", 14:52:32 INFO - "slavebuilddir": "test" 14:52:32 INFO - } 14:52:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:52:32 INFO - Running post-action listener: _resource_record_post_action 14:52:32 INFO - ##### 14:52:32 INFO - ##### Running download-and-extract step. 14:52:32 INFO - ##### 14:52:32 INFO - Running pre-action listener: _resource_record_pre_action 14:52:32 INFO - Running main action method: download_and_extract 14:52:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:32 INFO - https://queue.taskcluster.net/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:52:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/test_packages.json 14:52:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/test_packages.json 14:52:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:52:33 INFO - Downloaded 1302 bytes. 14:52:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:52:33 INFO - Using the following test package requirements: 14:52:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:52:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:52:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:33 INFO - u'jsshell-linux-x86_64.zip'], 14:52:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:52:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:52:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:52:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:52:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:52:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:52:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:52:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:33 INFO - https://queue.taskcluster.net/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:52:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:52:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:52:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:52:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:52:35 INFO - Downloaded 23175235 bytes. 14:52:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:52:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:52:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:52:36 INFO - Return code: 0 14:52:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:36 INFO - https://queue.taskcluster.net/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:52:42 INFO - Downloaded 23175235 bytes. 14:52:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:52:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:52:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:52:43 INFO - Return code: 0 14:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:43 INFO - https://queue.taskcluster.net/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:52:44 INFO - Downloaded 11132277 bytes. 14:52:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 14:52:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:52:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:52:44 INFO - Return code: 0 14:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:44 INFO - https://queue.taskcluster.net/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:52:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:52:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:52:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:52:48 INFO - Downloaded 54930763 bytes. 14:52:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:52:48 INFO - mkdir: /builds/slave/test-pgo/properties 14:52:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:52:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:52:48 INFO - Contents: 14:52:48 INFO - build_url:https://queue.taskcluster.net/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:52:48 INFO - Running post-action listener: _resource_record_post_action 14:52:48 INFO - Running post-action listener: set_extra_try_arguments 14:52:48 INFO - ##### 14:52:48 INFO - ##### Running populate-webroot step. 14:52:48 INFO - ##### 14:52:48 INFO - Running pre-action listener: _resource_record_pre_action 14:52:48 INFO - Running main action method: populate_webroot 14:52:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:52:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:52:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:52:48 INFO - '--tppagecycles', 14:52:48 INFO - '7'], 14:52:48 INFO - 'tests': ['tsvgm']}}, 14:52:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:52:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:52:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:52:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:52:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:52:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:52:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:52:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:48 INFO - 'talos_options': ['--e10s'], 14:52:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:52:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:48 INFO - 'tests': ['damp', 'tps']}, 14:52:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:48 INFO - 'talos_options': ['--e10s'], 14:52:48 INFO - 'tests': ['damp', 'tps']}, 14:52:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:52:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:52:48 INFO - 'other': {'tests': ['a11yr', 14:52:48 INFO - 'ts_paint', 14:52:48 INFO - 'tpaint', 14:52:48 INFO - 'sessionrestore', 14:52:48 INFO - 'sessionrestore_no_auto_restore']}, 14:52:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:52:48 INFO - 'tests': ['a11yr', 14:52:48 INFO - 'ts_paint', 14:52:48 INFO - 'tpaint', 14:52:48 INFO - 'sessionrestore', 14:52:48 INFO - 'sessionrestore_no_auto_restore']}, 14:52:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:52:48 INFO - 'tests': ['a11yr', 14:52:48 INFO - 'ts_paint', 14:52:48 INFO - 'tpaint', 14:52:48 INFO - 'sessionrestore', 14:52:48 INFO - 'sessionrestore_no_auto_restore']}, 14:52:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:52:48 INFO - 'tests': ['a11yr', 14:52:48 INFO - 'ts_paint', 14:52:48 INFO - 'tpaint', 14:52:48 INFO - 'sessionrestore', 14:52:48 INFO - 'sessionrestore_no_auto_restore']}, 14:52:48 INFO - 'other_l64': {'tests': ['a11yr', 14:52:48 INFO - 'ts_paint', 14:52:48 INFO - 'tpaint', 14:52:48 INFO - 'sessionrestore', 14:52:48 INFO - 'sessionrestore_no_auto_restore']}, 14:52:48 INFO - 'other_nol64': {'tests': ['a11yr', 14:52:48 INFO - 'ts_paint', 14:52:48 INFO - 'tpaint', 14:52:48 INFO - 'sessionrestore', 14:52:48 INFO - 'sessionrestore_no_auto_restore']}, 14:52:48 INFO - 'svgr': {'tests': ['tsvgx', 14:52:48 INFO - 'tsvgr_opacity', 14:52:48 INFO - 'tart', 14:52:48 INFO - 'tscrollx', 14:52:48 INFO - 'cart']}, 14:52:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:52:48 INFO - 'tests': ['tsvgx', 14:52:48 INFO - 'tsvgr_opacity', 14:52:48 INFO - 'tart', 14:52:48 INFO - 'tscrollx', 14:52:48 INFO - 'cart']}, 14:52:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:48 INFO - 'tests': ['tp5o']}, 14:52:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:48 INFO - 'talos_options': ['--e10s'], 14:52:48 INFO - 'tests': ['tp5o']}, 14:52:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:48 INFO - 'talos_options': ['--xperf_path', 14:52:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:52:48 INFO - 'tests': ['tp5n']}, 14:52:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:48 INFO - 'talos_options': ['--e10s', 14:52:48 INFO - '--xperf_path', 14:52:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:52:48 INFO - 'tests': ['tp5n']}}, 14:52:48 INFO - 'talos.zip': {'path': '', 14:52:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:52:48 INFO - Running post-action listener: _resource_record_post_action 14:52:48 INFO - ##### 14:52:48 INFO - ##### Running create-virtualenv step. 14:52:48 INFO - ##### 14:52:48 INFO - Running pre-action listener: _resource_record_pre_action 14:52:48 INFO - Running main action method: create_virtualenv 14:52:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:52:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 14:52:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:52:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:52:48 INFO - Using real prefix '/usr' 14:52:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:52:48 INFO - Installing distribute.............................................................................................................................................................................................done. 14:52:50 INFO - Installing pip.................done. 14:52:50 INFO - Return code: 0 14:52:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face0704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ea630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:52:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:52:50 INFO - Using env: {'DISPLAY': ':0', 14:52:50 INFO - 'HOME': '/home/cltbld', 14:52:50 INFO - 'LANG': 'en_US.UTF-8', 14:52:50 INFO - 'LANGUAGE': 'en_US:en', 14:52:50 INFO - 'LOGNAME': 'cltbld', 14:52:50 INFO - 'MAIL': '/var/mail/cltbld', 14:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:50 INFO - 'MOZ_NO_REMOTE': '1', 14:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:50 INFO - 'NO_EM_RESTART': '1', 14:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:52:50 INFO - 'PWD': '/builds/slave/test-pgo', 14:52:50 INFO - 'SHELL': '/bin/bash', 14:52:50 INFO - 'SHLVL': '1', 14:52:50 INFO - 'TERM': 'linux', 14:52:50 INFO - 'TMOUT': '86400', 14:52:50 INFO - 'USER': 'cltbld', 14:52:50 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 14:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:50 INFO - '_': '/tools/buildbot/bin/python'} 14:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:52:51 INFO - Cleaning up... 14:52:51 INFO - Return code: 0 14:52:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face0704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ea630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:52:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:52:51 INFO - Using env: {'DISPLAY': ':0', 14:52:51 INFO - 'HOME': '/home/cltbld', 14:52:51 INFO - 'LANG': 'en_US.UTF-8', 14:52:51 INFO - 'LANGUAGE': 'en_US:en', 14:52:51 INFO - 'LOGNAME': 'cltbld', 14:52:51 INFO - 'MAIL': '/var/mail/cltbld', 14:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:51 INFO - 'MOZ_NO_REMOTE': '1', 14:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:51 INFO - 'NO_EM_RESTART': '1', 14:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:52:51 INFO - 'PWD': '/builds/slave/test-pgo', 14:52:51 INFO - 'SHELL': '/bin/bash', 14:52:51 INFO - 'SHLVL': '1', 14:52:51 INFO - 'TERM': 'linux', 14:52:51 INFO - 'TMOUT': '86400', 14:52:51 INFO - 'USER': 'cltbld', 14:52:51 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 14:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:51 INFO - '_': '/tools/buildbot/bin/python'} 14:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:51 INFO - Downloading/unpacking psutil>=0.7.1 14:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:52:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:52:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:52:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:52:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:52:53 INFO - Installing collected packages: psutil 14:52:53 INFO - Running setup.py install for psutil 14:52:53 INFO - building 'psutil._psutil_linux' extension 14:52:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:52:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:52:53 INFO - building 'psutil._psutil_posix' extension 14:52:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:52:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:52:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:52:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:52:53 INFO - Successfully installed psutil 14:52:53 INFO - Cleaning up... 14:52:53 INFO - Return code: 0 14:52:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face0704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ea630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:52:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:52:53 INFO - Using env: {'DISPLAY': ':0', 14:52:53 INFO - 'HOME': '/home/cltbld', 14:52:53 INFO - 'LANG': 'en_US.UTF-8', 14:52:53 INFO - 'LANGUAGE': 'en_US:en', 14:52:53 INFO - 'LOGNAME': 'cltbld', 14:52:53 INFO - 'MAIL': '/var/mail/cltbld', 14:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:53 INFO - 'MOZ_NO_REMOTE': '1', 14:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:53 INFO - 'NO_EM_RESTART': '1', 14:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:52:53 INFO - 'PWD': '/builds/slave/test-pgo', 14:52:53 INFO - 'SHELL': '/bin/bash', 14:52:53 INFO - 'SHLVL': '1', 14:52:53 INFO - 'TERM': 'linux', 14:52:53 INFO - 'TMOUT': '86400', 14:52:53 INFO - 'USER': 'cltbld', 14:52:53 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 14:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:53 INFO - '_': '/tools/buildbot/bin/python'} 14:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:52:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:52:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:52:55 INFO - Installing collected packages: mozsystemmonitor 14:52:55 INFO - Running setup.py install for mozsystemmonitor 14:52:55 INFO - Successfully installed mozsystemmonitor 14:52:55 INFO - Cleaning up... 14:52:55 INFO - Return code: 0 14:52:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face0704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ea630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:52:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:52:55 INFO - Using env: {'DISPLAY': ':0', 14:52:55 INFO - 'HOME': '/home/cltbld', 14:52:55 INFO - 'LANG': 'en_US.UTF-8', 14:52:55 INFO - 'LANGUAGE': 'en_US:en', 14:52:55 INFO - 'LOGNAME': 'cltbld', 14:52:55 INFO - 'MAIL': '/var/mail/cltbld', 14:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:55 INFO - 'MOZ_NO_REMOTE': '1', 14:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:55 INFO - 'NO_EM_RESTART': '1', 14:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:52:55 INFO - 'PWD': '/builds/slave/test-pgo', 14:52:55 INFO - 'SHELL': '/bin/bash', 14:52:55 INFO - 'SHLVL': '1', 14:52:55 INFO - 'TERM': 'linux', 14:52:55 INFO - 'TMOUT': '86400', 14:52:55 INFO - 'USER': 'cltbld', 14:52:55 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 14:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:55 INFO - '_': '/tools/buildbot/bin/python'} 14:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:55 INFO - Downloading/unpacking blobuploader==1.2.4 14:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:57 INFO - Downloading blobuploader-1.2.4.tar.gz 14:52:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:52:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:52:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:52:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:52:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:58 INFO - Downloading docopt-0.6.1.tar.gz 14:52:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:52:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:52:58 INFO - Installing collected packages: blobuploader, requests, docopt 14:52:58 INFO - Running setup.py install for blobuploader 14:52:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:52:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:52:58 INFO - Running setup.py install for requests 14:52:58 INFO - Running setup.py install for docopt 14:52:58 INFO - Successfully installed blobuploader requests docopt 14:52:58 INFO - Cleaning up... 14:52:58 INFO - Return code: 0 14:52:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face0704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ea630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:52:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:52:58 INFO - Using env: {'DISPLAY': ':0', 14:52:58 INFO - 'HOME': '/home/cltbld', 14:52:58 INFO - 'LANG': 'en_US.UTF-8', 14:52:58 INFO - 'LANGUAGE': 'en_US:en', 14:52:58 INFO - 'LOGNAME': 'cltbld', 14:52:58 INFO - 'MAIL': '/var/mail/cltbld', 14:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:58 INFO - 'MOZ_NO_REMOTE': '1', 14:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:58 INFO - 'NO_EM_RESTART': '1', 14:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:52:58 INFO - 'PWD': '/builds/slave/test-pgo', 14:52:58 INFO - 'SHELL': '/bin/bash', 14:52:58 INFO - 'SHLVL': '1', 14:52:58 INFO - 'TERM': 'linux', 14:52:58 INFO - 'TMOUT': '86400', 14:52:58 INFO - 'USER': 'cltbld', 14:52:58 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 14:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:58 INFO - '_': '/tools/buildbot/bin/python'} 14:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:52:59 INFO - Running setup.py (path:/tmp/pip-Kn1uyH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:52:59 INFO - Running setup.py (path:/tmp/pip-zE2Vfd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:52:59 INFO - Running setup.py (path:/tmp/pip-SZFpjJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:52:59 INFO - Running setup.py (path:/tmp/pip-vEFoSa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:52:59 INFO - Running setup.py (path:/tmp/pip-c6cVJM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:52:59 INFO - Running setup.py (path:/tmp/pip-OonRd8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:52:59 INFO - Running setup.py (path:/tmp/pip-7W6nZc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:52:59 INFO - Running setup.py (path:/tmp/pip-lHiAhM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:52:59 INFO - Running setup.py (path:/tmp/pip-e3o7Du-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:52:59 INFO - Running setup.py (path:/tmp/pip-0DThSx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:52:59 INFO - Running setup.py (path:/tmp/pip-kOh4dv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:52:59 INFO - Running setup.py (path:/tmp/pip-NZHVps-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:53:00 INFO - Running setup.py (path:/tmp/pip-hXiH4c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:53:00 INFO - Running setup.py (path:/tmp/pip-E7WZ4v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:53:00 INFO - Running setup.py (path:/tmp/pip-dvY09D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:53:00 INFO - Running setup.py (path:/tmp/pip-z0U91P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:53:00 INFO - Running setup.py (path:/tmp/pip-ZteDtp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:53:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:53:00 INFO - Running setup.py install for manifestparser 14:53:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:53:00 INFO - Running setup.py install for mozcrash 14:53:00 INFO - Running setup.py install for mozdebug 14:53:00 INFO - Running setup.py install for mozdevice 14:53:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:53:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:53:00 INFO - Running setup.py install for mozfile 14:53:00 INFO - Running setup.py install for mozhttpd 14:53:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:53:00 INFO - Running setup.py install for mozinfo 14:53:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:53:01 INFO - Running setup.py install for mozInstall 14:53:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:53:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:53:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:53:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:53:01 INFO - Running setup.py install for mozleak 14:53:01 INFO - Running setup.py install for mozlog 14:53:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:53:01 INFO - Running setup.py install for moznetwork 14:53:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:53:01 INFO - Running setup.py install for mozprocess 14:53:01 INFO - Running setup.py install for mozprofile 14:53:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:53:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:53:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:53:01 INFO - Running setup.py install for mozrunner 14:53:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:53:01 INFO - Running setup.py install for mozscreenshot 14:53:01 INFO - Running setup.py install for moztest 14:53:02 INFO - Running setup.py install for mozversion 14:53:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:53:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:53:02 INFO - Cleaning up... 14:53:02 INFO - Return code: 0 14:53:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face0704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ea630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:53:02 INFO - Using env: {'DISPLAY': ':0', 14:53:02 INFO - 'HOME': '/home/cltbld', 14:53:02 INFO - 'LANG': 'en_US.UTF-8', 14:53:02 INFO - 'LANGUAGE': 'en_US:en', 14:53:02 INFO - 'LOGNAME': 'cltbld', 14:53:02 INFO - 'MAIL': '/var/mail/cltbld', 14:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:02 INFO - 'MOZ_NO_REMOTE': '1', 14:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:02 INFO - 'NO_EM_RESTART': '1', 14:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:53:02 INFO - 'PWD': '/builds/slave/test-pgo', 14:53:02 INFO - 'SHELL': '/bin/bash', 14:53:02 INFO - 'SHLVL': '1', 14:53:02 INFO - 'TERM': 'linux', 14:53:02 INFO - 'TMOUT': '86400', 14:53:02 INFO - 'USER': 'cltbld', 14:53:02 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 14:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:02 INFO - '_': '/tools/buildbot/bin/python'} 14:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:53:02 INFO - Running setup.py (path:/tmp/pip-OPeHS7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 14:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:53:02 INFO - Running setup.py (path:/tmp/pip-JcLhvh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:53:02 INFO - Running setup.py (path:/tmp/pip-GLHdc8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:53:02 INFO - Running setup.py (path:/tmp/pip-kDRvhj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:53:02 INFO - Running setup.py (path:/tmp/pip-WVJ7y5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 14:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:53:02 INFO - Running setup.py (path:/tmp/pip-p2e1Ol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 14:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:53:02 INFO - Running setup.py (path:/tmp/pip-PWXnQM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 14:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:53:02 INFO - Running setup.py (path:/tmp/pip-8FczhX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 14:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:53:02 INFO - Running setup.py (path:/tmp/pip-XJbVsU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 14:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:53:03 INFO - Running setup.py (path:/tmp/pip-DbZm4S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:53:03 INFO - Running setup.py (path:/tmp/pip-efL9u9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 14:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:53:03 INFO - Running setup.py (path:/tmp/pip-tigZFL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 14:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:53:03 INFO - Running setup.py (path:/tmp/pip-2QELpX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 14:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:53:03 INFO - Running setup.py (path:/tmp/pip-THfKcz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 14:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:53:03 INFO - Running setup.py (path:/tmp/pip-KNwTwv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 14:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:53:03 INFO - Running setup.py (path:/tmp/pip-1igv59-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 14:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:53:03 INFO - Running setup.py (path:/tmp/pip-fw9gaP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 14:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:53:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:05 INFO - Downloading blessings-1.5.1.tar.gz 14:53:05 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:53:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:53:05 INFO - Installing collected packages: blessings 14:53:05 INFO - Running setup.py install for blessings 14:53:05 INFO - Successfully installed blessings 14:53:05 INFO - Cleaning up... 14:53:05 INFO - Return code: 0 14:53:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:53:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:53:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:53:05 INFO - Reading from file tmpfile_stdout 14:53:05 INFO - Current package versions: 14:53:05 INFO - argparse == 1.2.1 14:53:05 INFO - blessings == 1.5.1 14:53:05 INFO - blobuploader == 1.2.4 14:53:05 INFO - docopt == 0.6.1 14:53:05 INFO - manifestparser == 1.1 14:53:05 INFO - mozInstall == 1.12 14:53:05 INFO - mozcrash == 0.16 14:53:05 INFO - mozdebug == 0.1 14:53:05 INFO - mozdevice == 0.47 14:53:05 INFO - mozfile == 1.2 14:53:05 INFO - mozhttpd == 0.7 14:53:05 INFO - mozinfo == 0.9 14:53:05 INFO - mozleak == 0.1 14:53:05 INFO - mozlog == 3.1 14:53:05 INFO - moznetwork == 0.27 14:53:05 INFO - mozprocess == 0.22 14:53:05 INFO - mozprofile == 0.28 14:53:05 INFO - mozrunner == 6.11 14:53:05 INFO - mozscreenshot == 0.1 14:53:05 INFO - mozsystemmonitor == 0.0 14:53:05 INFO - moztest == 0.7 14:53:05 INFO - mozversion == 1.4 14:53:05 INFO - psutil == 3.1.1 14:53:05 INFO - requests == 1.2.3 14:53:05 INFO - wsgiref == 0.1.2 14:53:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face0704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ea630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:53:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:53:05 INFO - Using env: {'DISPLAY': ':0', 14:53:05 INFO - 'HOME': '/home/cltbld', 14:53:05 INFO - 'LANG': 'en_US.UTF-8', 14:53:05 INFO - 'LANGUAGE': 'en_US:en', 14:53:05 INFO - 'LOGNAME': 'cltbld', 14:53:05 INFO - 'MAIL': '/var/mail/cltbld', 14:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:05 INFO - 'MOZ_NO_REMOTE': '1', 14:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:05 INFO - 'NO_EM_RESTART': '1', 14:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:53:05 INFO - 'PWD': '/builds/slave/test-pgo', 14:53:05 INFO - 'SHELL': '/bin/bash', 14:53:05 INFO - 'SHLVL': '1', 14:53:05 INFO - 'TERM': 'linux', 14:53:05 INFO - 'TMOUT': '86400', 14:53:05 INFO - 'USER': 'cltbld', 14:53:05 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 14:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:05 INFO - '_': '/tools/buildbot/bin/python'} 14:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 14:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 14:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 14:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 14:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 14:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 14:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:53:05 INFO - Cleaning up... 14:53:05 INFO - Return code: 0 14:53:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face0704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ea630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:53:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:53:05 INFO - Using env: {'DISPLAY': ':0', 14:53:05 INFO - 'HOME': '/home/cltbld', 14:53:05 INFO - 'LANG': 'en_US.UTF-8', 14:53:05 INFO - 'LANGUAGE': 'en_US:en', 14:53:05 INFO - 'LOGNAME': 'cltbld', 14:53:05 INFO - 'MAIL': '/var/mail/cltbld', 14:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:05 INFO - 'MOZ_NO_REMOTE': '1', 14:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:05 INFO - 'NO_EM_RESTART': '1', 14:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:53:05 INFO - 'PWD': '/builds/slave/test-pgo', 14:53:05 INFO - 'SHELL': '/bin/bash', 14:53:05 INFO - 'SHLVL': '1', 14:53:05 INFO - 'TERM': 'linux', 14:53:05 INFO - 'TMOUT': '86400', 14:53:05 INFO - 'USER': 'cltbld', 14:53:05 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 14:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:05 INFO - '_': '/tools/buildbot/bin/python'} 14:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:06 INFO - Downloading/unpacking jsonschema 14:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:53:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 14:53:07 INFO - Downloading/unpacking functools32 (from jsonschema) 14:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:08 INFO - Downloading functools32-3.2.3-2.tar.gz 14:53:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:53:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:53:08 INFO - warning: no files found matching '*.txt' 14:53:08 INFO - no previously-included directories found matching 'build' 14:53:08 INFO - no previously-included directories found matching 'dist' 14:53:08 INFO - no previously-included directories found matching '.git*' 14:53:08 INFO - Installing collected packages: jsonschema, functools32 14:53:08 INFO - Running setup.py install for functools32 14:53:08 INFO - warning: no files found matching '*.txt' 14:53:08 INFO - no previously-included directories found matching 'build' 14:53:08 INFO - no previously-included directories found matching 'dist' 14:53:08 INFO - no previously-included directories found matching '.git*' 14:53:08 INFO - Successfully installed jsonschema functools32 14:53:08 INFO - Cleaning up... 14:53:08 INFO - Return code: 0 14:53:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7face0704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ea630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:53:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:53:08 INFO - Using env: {'DISPLAY': ':0', 14:53:08 INFO - 'HOME': '/home/cltbld', 14:53:08 INFO - 'LANG': 'en_US.UTF-8', 14:53:08 INFO - 'LANGUAGE': 'en_US:en', 14:53:08 INFO - 'LOGNAME': 'cltbld', 14:53:08 INFO - 'MAIL': '/var/mail/cltbld', 14:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:08 INFO - 'MOZ_NO_REMOTE': '1', 14:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:08 INFO - 'NO_EM_RESTART': '1', 14:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:53:08 INFO - 'PWD': '/builds/slave/test-pgo', 14:53:08 INFO - 'SHELL': '/bin/bash', 14:53:08 INFO - 'SHLVL': '1', 14:53:08 INFO - 'TERM': 'linux', 14:53:08 INFO - 'TMOUT': '86400', 14:53:08 INFO - 'USER': 'cltbld', 14:53:08 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 14:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:08 INFO - '_': '/tools/buildbot/bin/python'} 14:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:08 INFO - Downloading/unpacking flake8 14:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:53:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 14:53:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:53:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 14:53:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 14:53:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:53:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:53:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:53:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:53:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:53:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:53:11 INFO - no previously-included directories found matching 'docs/_build' 14:53:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:53:11 INFO - Running setup.py install for pep8 14:53:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:53:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:53:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:53:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:53:11 INFO - no previously-included directories found matching 'docs/_build' 14:53:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:53:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:53:11 INFO - Cleaning up... 14:53:11 INFO - Return code: 0 14:53:11 INFO - Running post-action listener: _resource_record_post_action 14:53:11 INFO - Running post-action listener: _start_resource_monitoring 14:53:11 INFO - Starting resource monitoring. 14:53:11 INFO - ##### 14:53:11 INFO - ##### Running install step. 14:53:11 INFO - ##### 14:53:11 INFO - Running pre-action listener: _resource_record_pre_action 14:53:11 INFO - Running main action method: install 14:53:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:53:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:53:11 INFO - Reading from file tmpfile_stdout 14:53:11 INFO - Detecting whether we're running mozinstall >=1.0... 14:53:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:53:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:53:11 INFO - Reading from file tmpfile_stdout 14:53:11 INFO - Output received: 14:53:11 INFO - Usage: mozinstall [options] installer 14:53:11 INFO - Options: 14:53:11 INFO - -h, --help show this help message and exit 14:53:11 INFO - -d DEST, --destination=DEST 14:53:11 INFO - Directory to install application into. [default: 14:53:11 INFO - "/builds/slave/test-pgo"] 14:53:11 INFO - --app=APP Application being installed. [default: firefox] 14:53:11 INFO - mkdir: /builds/slave/test-pgo/build/application 14:53:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:53:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:53:27 INFO - Reading from file tmpfile_stdout 14:53:27 INFO - Output received: 14:53:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:53:27 INFO - Running post-action listener: _resource_record_post_action 14:53:27 INFO - ##### 14:53:27 INFO - ##### Running run-tests step. 14:53:27 INFO - ##### 14:53:27 INFO - Running pre-action listener: _resource_record_pre_action 14:53:27 INFO - Running main action method: run_tests 14:53:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:53:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:53:27 INFO - Python 2.7.3 14:53:27 INFO - Return code: 0 14:53:27 INFO - grabbing minidump binary from tooltool 14:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e8b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:53:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 14:53:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:53:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:53:27 INFO - Return code: 0 14:53:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:53:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:53:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:53:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:53:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:53:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:53:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:53:28 INFO - Return code: 0 14:53:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 14:53:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 14:53:28 INFO - Using env: {'DISPLAY': ':0', 14:53:28 INFO - 'HOME': '/home/cltbld', 14:53:28 INFO - 'LANG': 'en_US.UTF-8', 14:53:28 INFO - 'LANGUAGE': 'en_US:en', 14:53:28 INFO - 'LOGNAME': 'cltbld', 14:53:28 INFO - 'MAIL': '/var/mail/cltbld', 14:53:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:53:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:28 INFO - 'MOZ_NO_REMOTE': '1', 14:53:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:28 INFO - 'NO_EM_RESTART': '1', 14:53:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:53:28 INFO - 'PWD': '/builds/slave/test-pgo', 14:53:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:53:28 INFO - 'SHELL': '/bin/bash', 14:53:28 INFO - 'SHLVL': '1', 14:53:28 INFO - 'TERM': 'linux', 14:53:28 INFO - 'TMOUT': '86400', 14:53:28 INFO - 'USER': 'cltbld', 14:53:28 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535', 14:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:28 INFO - '_': '/tools/buildbot/bin/python'} 14:53:28 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:53:28 INFO - mozversion application_buildid: 20151221113016 14:53:28 INFO - mozversion application_changeset: 12d44899c6fd466d00d71638cb3501a703938569 14:53:28 INFO - mozversion application_display_name: Nightly 14:53:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:53:28 INFO - mozversion application_name: Firefox 14:53:28 INFO - mozversion application_remotingname: firefox 14:53:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 14:53:28 INFO - mozversion application_vendor: Mozilla 14:53:28 INFO - mozversion application_version: 46.0a1 14:53:28 INFO - mozversion platform_buildid: 20151221113016 14:53:28 INFO - mozversion platform_changeset: 12d44899c6fd466d00d71638cb3501a703938569 14:53:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 14:53:28 INFO - mozversion platform_version: 46.0a1 14:53:28 INFO - using testdate: 1450738408 14:53:28 INFO - actual date: 1450738408 14:53:28 INFO - starting webserver on 'localhost:52049' 14:53:28 INFO - SUITE-START | Running 3 tests 14:53:28 INFO - TEST-START | dromaeo_css 14:53:28 INFO - operating with platform_type : linux_ 14:53:28 INFO - Initialising browser for dromaeo_css test... 14:53:28 INFO - TEST-INFO | started process 8608 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn5JW3V/profile http://localhost:52049/getInfo.html) 14:53:32 INFO - PROCESS | 8608 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 14:53:32 INFO - PROCESS | 8608 | __metrics Screen width/height:1600/1200 14:53:32 INFO - PROCESS | 8608 | colorDepth:24 14:53:32 INFO - PROCESS | 8608 | Browser inner width/height: 1024/697 14:53:32 INFO - PROCESS | 8608 | __metrics 14:53:32 INFO - PROCESS | 8608 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:53:33 INFO - PROCESS | 8608 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:53:33 ERROR - PROCESS | 8608 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 14:53:33 INFO - TEST-INFO | 8608: exit 0 14:53:33 INFO - Browser initialized. 14:53:33 INFO - Running cycle 1/1 for dromaeo_css test... 14:53:33 INFO - TEST-INFO | started process 8702 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn5JW3V/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:53:45 INFO - PROCESS | 8702 | RSS: Main: 150253568 14:53:45 INFO - PROCESS | 8702 | 14:54:36 INFO - PROCESS | 8702 | 1450738476938 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:56:45 INFO - PROCESS | 8702 | Cycle 1(1): loaded http://localhost:52049/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52049/tests/dromaeo/cssquery-ext.html) 14:56:47 INFO - PROCESS | 8702 | RSS: Main: 331812864 14:56:47 INFO - PROCESS | 8702 | 14:59:49 INFO - PROCESS | 8702 | Cycle 1(1): loaded http://localhost:52049/tests/dromaeo/cssquery-ext.html (next: http://localhost:52049/tests/dromaeo/cssquery-jquery.html) 14:59:50 INFO - PROCESS | 8702 | RSS: Main: 233975808 14:59:50 INFO - PROCESS | 8702 | 15:02:52 INFO - PROCESS | 8702 | Cycle 1(1): loaded http://localhost:52049/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52049/tests/dromaeo/cssquery-mootools.html) 15:02:52 INFO - PROCESS | 8702 | RSS: Main: 223506432 15:02:52 INFO - PROCESS | 8702 | 15:05:54 INFO - PROCESS | 8702 | Cycle 1(1): loaded http://localhost:52049/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52049/tests/dromaeo/cssquery-prototype.html) 15:05:55 INFO - PROCESS | 8702 | RSS: Main: 212488192 15:05:55 INFO - PROCESS | 8702 | 15:08:57 INFO - PROCESS | 8702 | Cycle 1(1): loaded http://localhost:52049/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52049/tests/dromaeo/cssquery-yui.html) 15:08:58 INFO - PROCESS | 8702 | RSS: Main: 217440256 15:08:58 INFO - PROCESS | 8702 | 15:12:00 INFO - PROCESS | 8702 | Cycle 1(1): loaded http://localhost:52049/tests/dromaeo/cssquery-yui.html (next: http://localhost:52049/tests/dromaeo/cssquery-dojo.html) 15:12:01 INFO - PROCESS | 8702 | RSS: Main: 317992960 15:12:01 INFO - PROCESS | 8702 | 15:12:01 INFO - PROCESS | 8702 | __start_tp_report 15:12:01 INFO - PROCESS | 8702 | _x_x_mozilla_page_load 15:12:01 INFO - PROCESS | 8702 | _x_x_mozilla_page_load_details 15:12:01 INFO - PROCESS | 8702 | |i|pagename|runs| 15:12:01 INFO - PROCESS | 8702 | |0;dojo.html;3130.389574033063;3167.7940933839286;3215.3730022645577;3218.147190994387;3235.3367559650274;5276.894462110756;5361.865953351164;5369.677819330838;5396.028714831329;5433.91849122263;5367.704776237305;5434.3207099112615;5479.013777520045;5481.725913704308;5487.286652735139;4841.491643377448;4883.731394773286;4908.0429316283335;4921.384826896638;4930.531599498042;4889.437714662806;5012.799488020475;5014.047331007097;5019.899602007958;5057.645964782467;4743;4827.203511420611;4944.802207911679;4962.702237865721;5028.170351891933;4827.131116399047;4830.7101573905675;4845.781939812717;4850.369451971256;4856.0287942411305;4850.902981940377;4861.513848615145;4864.246041863482;4874.610031197496;4883.413990321184;5109.770060347293;5139.58883289336;5201.219817027439;5205.765740541685;5253.001929633396;5766.394528574481;5767.769289228426;5782.595218334718;5782.653040817564;5849.03490923997;5747.913781293284;5751.482366586985;5752.712364381764;5757.884842303172;5794.304683437972;5242.18746094356;5398.163284690879;5399.028174928511;5429.995450841568;5441.374241962186;5860.413958604106;5944.346121926585;5945.881082378415;5948.10778383246;5950.137230101611;5625.38120806711;5638.351589567253;5639.774409023593;5643.858903527444;5693.28833895763;5544.944550554443;5671.234383358194;5673.035583950738;5732.7706891723865;5741.598088133874;5629.662220266797;5662.858428539237;5664.235328230719;5690.345610254791;5706.71466426677;5749.338826034976;5777.682227477445;5779.537636989115;5781.682007489544;5781.768729250867;4384.583464570861;4414.867553973386;4476.2837945928495;4477.910441791211;4515.88710282239;3976.224636195914;3994.2410941920944;4001.2997725398523;4004.379321205218;4013.538443079083;5427.294451721251;5440.211169380497;5448.264484294569;5462.781488740486;5491.780328786804;5639.577031722637;5692.316921969307;5745.8563535911935;5751.683657398883;5794.681292528867;5423.159410291411;5463.453654634504;5474.507294343449;5487.670739755627;5489.725513724298;5042.924356134661;5055.368078990126;5063.316452278968;5066.949330506648;5099.898002040012;5543.805966791224;5672.319321681424;5675.631083979528;5806.883862322815;5823.79616713413;5798.449147330997;5813.447722466359;5815.360310365941;5824.592278540631;5849.736761845812;5833.79581714638;5860.2967643883;5863.237779088691;5867.237259156283;5867.73595188209;5581.5255703265675;5719.8570035749435;5730.885382292414;5746.511546518593;5747.971260143672;5703.486686198262;5739.426057394227;5782.277215348082;5783.479486846036;5789.507891829073;5603.523700485504;5642.097264437671;5652.4064973178865;5684.9431505684415;5703.5722320826935;5593.356763972195;5598.804041858515;5605.299337582802;5612.382637909745;5669.603127781016;5446.346438427414;5492.5331346835965;5500.092484739973;5500.1749737539685;5508.752106155152;5464.644798088111;5547.667139971614;5556.583256255716;5559.694216818114;5688.544916406595;5574.275344205227;5635.436456354331;5639.661620302795;5645.237892884408;5646.576506761927 15:12:01 INFO - PROCESS | 8702 | |1;ext.html;550.6118186678392;581.9796307129249;582.883423315337;598.6168851934762;613.2548953022077;25529;25806.22581322561;38281.80859095707;38752.612473875255;38816.61183388165;41636.583634163646;42245;42343.36484952728;42359.57640423595;42426.151476970444;8565.657373705044;8828.690995815115;8830.337724670644;8839.116088391174;8842.469451832878;7428.145763237216;7613.885791713129;10412.062914337708;10590.364578125298;10656.413897235649;10293.845592316122;10343.482825858677;10375.377477351345;10382;10413.791724165512;7382.33558979689;7558.168601453835;10244.743881402987;10302.124319432858;10373.273870828969;10364.48177591125;10632.362058276529;10638.095761860252;10642.893571064267;10648.14814814813;39734.40398394026;40035.399469007694;40138.197236055115;40193.39709904324;40220.39669404961;3114.5639610454555;3176.65056843747;3235.223546348883;3591.5510561179854;3745.138618117821;29871;29979.550306745416;30123.397532049454;30186.54720179199;30775.538366924513;3872.6901847852105;3915.549711783153;3944.842206311744;3988.4216788565786;4108.979455102735;274586;276128;276682;277331;277457.61271193717;45698.31452528215;45751;46619;53854.19218711722;55040;57836.554086148186;57847.421525785045;58351;58368.4163158363;58406.12390814141;14108.85891141096;14172.220527871066;14186.077904936146;14206.715865682836;14222.786658200135;11468.942655286837;11508.194426390073;11524.481398337095;11525.654230373102;11531.538738450536;19714;19753;19801.702974455395;19916;19982.20071197165;7150.356467917808;7532.079319773532;7542.849143017109;7561.130469996021;7588.354989825927;841.9223394055618;899.7165892743765;982.8967958364269;1046.6179844356907;1085.625459216569;27500;27647.58528622072;27695.723042769718;27848.721512785018;28018.579721304195;944.7213072143734;953.4374718915734;1026.5329275179774;1033.6950599572995;1037.0770014686934;13573.59279221625;13744.312784360742;13846.93076534611;13920.651983700285;13933.790993135111;324991;329670;329802;330438;330844;49671.751641242285;50103.74948125236;50237.74881125644;50266.497335026914;50277.24584131241;1284.1396264502805;1289.4906511927736;1302.4594793161111;1308.1758492150075;1313.441787240438;26238.86880565585;27153.1854044379;27228.727712723412;27284.863575681993;31870.6812931877;35529.82235088912;35931.46102808512;46675;47374.526254737015;47805.76097119492;242611;242784;245102;245212;245278;36477.81761091284;37399.813000934824;37774.24451510899;40370.59629403668;41458.58541414547;33586.49620255747;41117.79441102775;41291.38062928998;41364.79317603393;41674.791626041675;35396;35721.1069723259;35781.28437431289;35941.82029089838;36581;33657.3074154072;35497;35576.82211589029;35651.10872228111;36010;34478.65521344754;35306.29387412186;35334.46998295079;35382.46926296056;35499.82250088733;30280.697193027787;32120.196995075312;32569;32987.67012329942;33035.504467432525;22219.444513887283;22499.437514061625;22623.886880565493;22635.320940371814;22663 15:12:01 INFO - PROCESS | 8702 | |2;jquery.html;349.1863956980236;349.2578271173756;349.98075105869174;353.8867562380036;353.94867744177094;13368;13910.443582256697;16080.678386432264;16720;17861.82138178618;16273.837261627381;16294.266757995889;16480.752788708178;16490.917545412256;16572.41996530122;5188.636795424312;5407.026735187665;5416.322959630046;5462;5462.289902312714;3992.2614316351423;4095.4266402703647;4115.218108559364;4118.196951594426;5400.648957817749;4294.742315461082;6026.337102918676;6026.608270462406;6030.276366835986;6033.939660603403;5580.581456390767;6072.119542666289;6087.269527656687;6111.755529778803;6112.144299798032;5302.2841916341185;5306.8407947761625;5311.654742441768;5316.707581083039;5332.946670533283;20314;20543.28098516545;20915.058822353032;21224.363269101796;21232.681509777212;2084.98957505213;2111.102781317934;2158.136745301892;2188.72640919885;2190;11888.346140962243;13417.262050587215;13629.386677599532;13662.316884155853;13999.370028348647;1937.2638397409034;1983.6925276582008;1983.8611297209202;1987.7714062882665;2010.98994505028;57980;62612.68693656503;62686.686566566874;62783;63245.367546324866;14552.781708274384;14556.781648275284;14565.563033109023;14595.124292542268;14600.926995364955;22796.658050129263;22842.42893927632;23222.41943951381;23793.048278068683;23887.641685374732;8508.234258916727;8570;9127.995920448746;9168.44989300644;9189.862152067724;7094.92905070953;7233.746818861315;7515.774526764206;7562.886556701654;7568.8486230276185;7549.131849837229;7580.924190758022;7581.3176814087;7647.961760191275;7758.107817600935;1797.7932537758063;1804.6390721855419;1805.656925184237;2199.9990004547894;2920.707929207062;887.9689210877589;892.9196372326522;913.2146354135439;976.9609215631295;997.2919227348664;15270.618234544225;15779.368825246862;16111;16664.08347540897;16922.49232523026;868.774118729135;892.0722448653457;900.5002223765873;922.110163692027;994;9312.580933857993;9449.43303401798;9452.621895124255;9467.763305917408;9482;493660;495739;525213.8537439322;555002;557734;78791.60604197058;81206.59396703097;82430.58784706038;83185;84685.57657211674;997.1673652500099;1023.8054769593754;1028.0285130551556;1074.382230217628;1129.768397478515;14583.915665056087;14857.702845942804;15663.608409789846;15713.764293535378;15922.840771592599;35099.59601615907;35642.821785891945;36045.45931810972;36064.459033114;36318.27363452769;46605.30092048554;48291;49050.26424603562;49535.50464495453;51658.22512662388;9426.717198484057;9715.22278217755;9759.12167904892;9837.163841073303;9847.803043939224;11539.249948753304;13317.134386264861;13584.524541640994;15679.68640627204;16346.100964447069;13841.723165536834;13960.511382101578;14269.71460570762;14409.207493587954;14662.780058299348;12812.807807883075;12865.163764355288;13510.256935868621;13934.442622294995;13947.37236824325;14027.50903718365;14328.49850255236;14372.856271437151;14537.41850325975;14956.850431495981;9564.521773911416;9597.376170548892;9673.806523869342;9675.661351852652;9865.26010549226;10996.340219586851;14505;14601.561953141423;14839.851601483848;14878.10731356122 15:12:01 INFO - PROCESS | 8702 | |3;mootools.html;1245.545375937783;1591.6020994751311;1607.067900617641;1619.2227730689272;1697.8896371735832;6486.675666216688;7579.090509138904;7691.730789422371;7718.536887786737;7722.8455430891345;7455.70177192913;7618.7714368568895;7628.199039100898;7629.809254768634;7643.350315223212;1958.637652034371;2006.1173083843134;2220.378294077661;2246.067881829039;2246.34855891792;2232.743234528026;2236.1390864517116;2240.439890027493;2241.1147596699293;2243.6634504824324;2181.2474696229774;2252.6733623624646;2256.131389415079;2264.5697317509703;2266.7733226677283;2243.349428665685;2258.8870556472193;2270.0579259607243;2270.262164796448;2279.5326957973575;2241.3612120545567;2242.2936774915847;2253.830962677789;2259.051198496635;2295;7656.732014379526;7705.113911900147;7728.806779830549;7731.265529774662;7739.57432341221;4546.863594092182;4628.39830821991;4633.119707255611;4660.650451216173;4662.347271382009;3007.9398412031856;3049.878004879802;3080.738137258336;3088.2896933705147;3123.5627012218306;930.5114814722257;939.6523286384013;941.0354386753633;963.0995019656574;981.4601968917138;10599.523021464052;10757.677269682;10763.300385474919;10779.5688172473;10822.134229261641;4250.149970005949;4299.032717638506;4355.673324500612;4359.411479450297;4388.166248412856;9299.95350023259;9335.579898904565;9343.672971445967;9345.813083738287;9356.578953947088;4681.976590117028;4698.718076915396;4712.963148107411;4713.599344055725;4716.080364328923;4283.957160428356;4297.978510107429;4313.935290970638;4313.935290970638;4320.071184695305;3139.748820094387;3169.5245713142754;3381.6956473917467;3558.8042657654078;3599.1002249437643;1130.496928866663;1131.6887855839545;1141.1384404774342;1143.9418537852453;1173.3663821536445;975.6292608808608;975.9219262458986;1023.0076825479273;1041.568315650868;1212.0788200967152;6869.381755641916;6925;6930.3762661360715;6931.6880740366805;6937.063496428019;570.6034306157181;581.7702007706932;582.3041465448832;586.3989410853824;721.3796135323618;5000.424951130593;5030.346055012898;5043.041822053798;5055.216441451581;5063.594912406998;8962.058983806737;9093.181613654802;9270.536473176315;9317.208037316768;9328.860067098998;9043.502607356528;9121;9133.223675987483;9223.492707900996;9243.907560924305;7108.857822843514;7198.776208044645;7244.818879528054;7259.89110163348;7299;6669.566478178903;6694;6714.362135597111;6717.193936727624;6718.529702920749;7740.26467485588;8101.10887802353;8194.22154895284;8351.540665263468;8368.790780230544;8206.507609543447;8539.359548033797;8566.400351975552;8703.43427677199;8737.56312184401;6671;6898.517103802686;6922.411595014481;6962.443004559522;6991.545549539263;6209.130721698875;6425.775097871552;7281.2718728126765;7453.552786832807;7485.850282994201;6915.861682766417;6980.476464265099;7070.257622949516;7134.108236470442;7145.714171433085;6687.331266873273;6896.310368963063;6897.310268973062;6903.206131294764;7063;6762.797116086525;6802.489813263926;6802.6598670065305;6808.897866532105;6810.931890681228;6089.177960975212;6133.44798968095;6280;6288;6332.810015699536;6339.144215531029;6366.586171898812;6380.457661098859;6382.36176382358;6385.265694445013 15:12:01 INFO - PROCESS | 8702 | |4;prototype.html;341.62250712962174;344.75715047254647;345.37831902575357;345.49040165755497;349.5944704143196;5862.120681897717;5997.700114994254;6023.156758053876;6047.758089676413;6082.513398928087;5795.710214489269;5944.702764861761;5951.047832346825;5966;5967.104934259853;4627.282771170466;4638.165130276566;4638.582527572517;4645.651576131787;4652.209124448835;4422.402975598286;4514.27771556551;4522.29904364824;4528.026474308023;4654.115718013567;4489.079738653568;4520.50274469808;4599.609033232163;4611.953880461203;4617.976910115444;4555.772211389434;4607.470140933802;4611.723296602215;4621.792019359137;4628.5371462853445;4078.898027549335;4083.020075181965;4085.407615895708;4089.672826173899;4090.018395585068;5523.613347065707;5674.914876276859;5676.829695109153;5701.914471282934;5707.800226992035;5339.919901201446;5342.439043900412;5350.5987050971335;5352.571794256489;5352.652077614943;6104.267487901436;6391;6391.744330226786;6397.776077837299;6398.8720225595225;4242.766647834368;4271.209826182167;4342.478902531685;4352.7605981670995;4362.738235705868;6580.638064906429;6637.269900310962;6641.236257830363;6654;6669.699863506154;4560.110778398181;4562.201614717477;4568.017876156576;4568.040711450566;4570.405847239904;4527.253003254492;4620.838270660511;4624.953750462452;4628.930566041512;4652.441706995182;5305.124654432053;5305.8938821223355;5308.787648494094;5309.3894202166475;5343.385510666245;6415.390537898892;6422.2293324800385;6422.839429014312;6430.164078669836;6432.099506069154;1616.450406861649;1633.6242664187303;1633.7712720219179;1634.2809163968054;1641.015390765555;1090.8145615245428;1098.0611577101622;1104.3373975614568;1114.3536748685742;1124.3141683573015;6149.661768602769;6170.753169873155;6176.722047507873;6182.258129024546;6188.2883468400805;6630.701618427086;6648.8670226595195;6651.235107962646;6654.334566543307;6655.301193374723;6007.8197654070445;6132.202813634199;6177.042558403455;6186.566940314225;6188.412100850412;3563.0914116900026;3580.8925732228076;3587.6232995535615;3588.174719814457;3589.4795254687924;6661.966690166615;6664.233613134552;6666.866662666816;6670;6673.399394054559;6631.10480085192;6765.1205343305055;6766.864662706718;6768.086308348408;6785.389314961579;6615.404613584704;6638.6680665966505;6657.833554161088;6659.500537459709;6669.499787515956;6369;6558.376954189344;6602.9009564855605;6603;6603.339666033358;6453.290138084901;6589.967050164719;6600.471962242913;6604.207495100426;6614.8346291343105;6732.057511948233;6732.091167692299;6737.393634572912;6740.865182696417;6746.662666866735;4450;4499.055198408371;4537.727736335831;4538;4539.205639013226;6640.966795166187;6683.532152749261;6688.030235615711;6688.4983626229205;6701;6495.577787443801;6498.350164983463;6499.0901273820755;6499.642519661464;6501.187351581052;6310.968445157745;6434.131392261985;6479.287278399466;6489.545731798728;6507.414332710079;6388.4569811566535;6390;6395.072714456471;6398.5521013528605;6398.744050237939;6536.084948107364;6537.542372033912;6542.607443553402;6545.247296560766;6552.57408268461;6179.752809887555;6348.047792831112;6353.809385718436;6356.396142366468;6379.298277189413 15:12:01 INFO - PROCESS | 8702 | |5;yui.html;729.314444422243;740.9239291720245;817.3706246190434;825.7481468152213;826.1573195340752;12321.691957701061;12627.810582841264;12652.683682907931;12680.365981700912;12683.873161268373;12849.93575032126;12896.161749486277;12938.094333396666;12964.157329773558;12973.675658108552;813.1177672225642;829.6598394658191;830.4062595244399;830.6552780596045;831.0567505880839;563.8054871069495;603.1947350287371;820.8891799607036;822.6174828704651;833.1918039501674;776.8290975985274;778.0896351269;783.3733013589106;784.7606480023619;785.3442375616339;775.2480094308512;775.3719487215374;775.5501808950795;776.4138075752827;776.7553220735479;492.55915955220235;499.15891722447793;626.1421852062704;632.2792017100509;637.6747858592151;12434.316112613802;12525.74948501034;12552.058595605366;12559.058070644647;12560.685982850411;11625.418729063513;12062.095342849321;12084.335361555111;12111.576094836726;12407.193532420453;10260.435676037814;10296.536655850505;10472.947635261775;10558.630447934362;10677.572897084106;3605.6394360563995;3656.3053019926397;3680.926381472382;3685.539307586552;3686.3364594373;46058.53941460576;46190.76904615456;46469.20507815433;46485.53514464846;46634.30048549241;9136.655844317831;9308.301877359225;9323.160915517636;9383.202427793578;9427.198688111588;18106;18143.27426902909;18176.1820718068;18176.909115454604;18178.091095445176;7364.116306043309;7460.253974602605;7637.19809420014;7773.68905243784;7878.172791856887;4183.435236243129;4220.577942205755;4220.6412454941055;4237.449131612871;4342.305231162999;3057.5260834570677;3092.0105566219045;3092.412441636082;3092.7989680670685;3095.3035566997696;543.9129739241703;554.9250851135126;556.1324334038832;556.9192467092249;568.6076607141059;526.7734874004138;602.6715440085164;604.8306474187235;651.9496184499816;662.2648859765657;8491.278241349431;8493.320534357237;8528.957355213184;8575.656973720981;8634.740957771277;548.5830768615881;572.5648507134524;630.158738084653;636.6959354761843;700.0689083518907;3706.1475860552223;3756.286305601927;3840.9231815363537;3979.6816254699556;4250.298700714409;51036.23445648318;51619.48380516222;52155.73922130365;52238.21642675363;52314;47329.76335118302;48368.51631483711;48485.5151448481;48541.27188092181;48766;43693.12613747771;44147.89630259205;44407;44576.10847783026;45711.54288457139;8351.41540092212;8425.2838508725;8456.873146902924;8620.568971551273;8796.780080498038;34324.65675343315;34726.47910281398;36055.81972090123;36719.81640091782;38464;46619.30071048869;46985.53014469812;47557.524424756695;47634;47704.7614761924;10790.67627971162;10935.45322733876;11054.170937179582;11153.163512736739;11341;12195.939020304842;12201.20692155007;12335.198212116184;12898.742025159632;12903.483860645845;10644.946775266384;11220.831687524531;11524.82712759326;11605.767884642091;11928.642140735792;11520.53917843277;11548.94225528867;11910.583129590423;11935.940320298343;12324.137310388187;8293.543855088028;10137.64518241858;11067.944660276647;11172.553097875994;11509;9088.727338179866;9795.265355098254;9846.852297215692;10099.14157296638;10191.133753631024;8450.323974081935;9010.369274150746;9542;9625.51872406363;9705.417674939526 15:12:01 INFO - PROCESS | 8702 | __end_tp_report 15:12:01 INFO - PROCESS | 8702 | __start_cc_report 15:12:01 INFO - PROCESS | 8702 | _x_x_mozilla_cycle_collect,1544 15:12:01 INFO - PROCESS | 8702 | __end_cc_report 15:12:01 INFO - PROCESS | 8702 | __startTimestamp1450739521143__endTimestamp 15:12:01 INFO - PROCESS | 8702 | 15:12:01 INFO - PROCESS | 8702 | ------- Summary: start ------- 15:12:01 INFO - PROCESS | 8702 | Number of tests: 6 15:12:01 INFO - PROCESS | 8702 | 15:12:01 INFO - PROCESS | 8702 | [#0] dojo.html Cycles:165 Average:5342.24 Median:5544.94 stddev:580.08 (10.5%) stddev-sans-first:555.30 15:12:01 INFO - PROCESS | 8702 | Values: 3130.4 3167.8 3215.4 3218.1 3235.3 5276.9 5361.9 5369.7 5396.0 5433.9 5367.7 5434.3 5479.0 5481.7 5487.3 4841.5 4883.7 4908.0 4921.4 4930.5 4889.4 5012.8 5014.0 5019.9 5057.6 4743.0 4827.2 4944.8 4962.7 5028.2 4827.1 4830.7 4845.8 4850.4 4856.0 4850.9 4861.5 4864.2 4874.6 4883.4 5109.8 5139.6 5201.2 5205.8 5253.0 5766.4 5767.8 5782.6 5782.7 5849.0 5747.9 5751.5 5752.7 5757.9 5794.3 5242.2 5398.2 5399.0 5430.0 5441.4 5860.4 5944.3 5945.9 5948.1 5950.1 5625.4 5638.4 5639.8 5643.9 5693.3 5544.9 5671.2 5673.0 5732.8 5741.6 5629.7 5662.9 5664.2 5690.3 5706.7 5749.3 5777.7 5779.5 5781.7 5781.8 4384.6 4414.9 4476.3 4477.9 4515.9 3976.2 3994.2 4001.3 4004.4 4013.5 5427.3 5440.2 5448.3 5462.8 5491.8 5639.6 5692.3 5745.9 5751.7 5794.7 5423.2 5463.5 5474.5 5487.7 5489.7 5042.9 5055.4 5063.3 5066.9 5099.9 5543.8 5672.3 5675.6 5806.9 5823.8 5798.4 5813.4 5815.4 5824.6 5849.7 5833.8 5860.3 5863.2 5867.2 5867.7 5581.5 5719.9 5730.9 5746.5 5748.0 5703.5 5739.4 5782.3 5783.5 5789.5 5603.5 5642.1 5652.4 5684.9 5703.6 5593.4 5598.8 5605.3 5612.4 5669.6 5446.3 5492.5 5500.1 5500.2 5508.8 5464.6 5547.7 5556.6 5559.7 5688.5 5574.3 5635.4 5639.7 5645.2 5646.6 15:12:01 INFO - PROCESS | 8702 | 15:12:01 INFO - PROCESS | 8702 | [#1] ext.html Cycles:180 Average:44931.44 Median:182215.25 stddev:74523.04 (40.9%) stddev-sans-first:74657.59 15:12:01 INFO - PROCESS | 8702 | Values: 550.6 582.0 582.9 598.6 613.3 25529.0 25806.2 38281.8 38752.6 38816.6 41636.6 42245.0 42343.4 42359.6 42426.2 8565.7 8828.7 8830.3 8839.1 8842.5 7428.1 7613.9 10412.1 10590.4 10656.4 10293.8 10343.5 10375.4 10382.0 10413.8 7382.3 7558.2 10244.7 10302.1 10373.3 10364.5 10632.4 10638.1 10642.9 10648.1 39734.4 40035.4 40138.2 40193.4 40220.4 3114.6 3176.7 3235.2 3591.6 3745.1 29871.0 29979.6 30123.4 30186.5 30775.5 3872.7 3915.5 3944.8 3988.4 4109.0 274586.0 276128.0 276682.0 277331.0 277457.6 45698.3 45751.0 46619.0 53854.2 55040.0 57836.6 57847.4 58351.0 58368.4 58406.1 14108.9 14172.2 14186.1 14206.7 14222.8 11468.9 11508.2 11524.5 11525.7 11531.5 19714.0 19753.0 19801.7 19916.0 19982.2 7150.4 7532.1 7542.8 7561.1 7588.4 841.9 899.7 982.9 1046.6 1085.6 27500.0 27647.6 27695.7 27848.7 28018.6 944.7 953.4 1026.5 1033.7 1037.1 13573.6 13744.3 13846.9 13920.7 13933.8 324991.0 329670.0 329802.0 330438.0 330844.0 49671.8 50103.7 50237.7 50266.5 50277.2 1284.1 1289.5 1302.5 1308.2 1313.4 26238.9 27153.2 27228.7 27284.9 31870.7 35529.8 35931.5 46675.0 47374.5 47805.8 242611.0 242784.0 245102.0 245212.0 245278.0 36477.8 37399.8 37774.2 40370.6 41458.6 33586.5 41117.8 41291.4 41364.8 41674.8 35396.0 35721.1 35781.3 35941.8 36581.0 33657.3 35497.0 35576.8 35651.1 36010.0 34478.7 35306.3 35334.5 35382.5 35499.8 30280.7 32120.2 32569.0 32987.7 33035.5 22219.4 22499.4 22623.9 22635.3 22663.0 15:12:01 INFO - PROCESS | 8702 | 15:12:01 INFO - PROCESS | 8702 | [#2] jquery.html Cycles:180 Average:29136.58 Median:35844.14 stddev:85967.99 (239.8%) stddev-sans-first:86181.98 15:12:01 INFO - PROCESS | 8702 | Values: 349.2 349.3 350.0 353.9 353.9 13368.0 13910.4 16080.7 16720.0 17861.8 16273.8 16294.3 16480.8 16490.9 16572.4 5188.6 5407.0 5416.3 5462.0 5462.3 3992.3 4095.4 4115.2 4118.2 5400.6 4294.7 6026.3 6026.6 6030.3 6033.9 5580.6 6072.1 6087.3 6111.8 6112.1 5302.3 5306.8 5311.7 5316.7 5332.9 20314.0 20543.3 20915.1 21224.4 21232.7 2085.0 2111.1 2158.1 2188.7 2190.0 11888.3 13417.3 13629.4 13662.3 13999.4 1937.3 1983.7 1983.9 1987.8 2011.0 57980.0 62612.7 62686.7 62783.0 63245.4 14552.8 14556.8 14565.6 14595.1 14600.9 22796.7 22842.4 23222.4 23793.0 23887.6 8508.2 8570.0 9128.0 9168.4 9189.9 7094.9 7233.7 7515.8 7562.9 7568.8 7549.1 7580.9 7581.3 7648.0 7758.1 1797.8 1804.6 1805.7 2200.0 2920.7 888.0 892.9 913.2 977.0 997.3 15270.6 15779.4 16111.0 16664.1 16922.5 868.8 892.1 900.5 922.1 994.0 9312.6 9449.4 9452.6 9467.8 9482.0 493660.0 495739.0 525213.9 555002.0 557734.0 78791.6 81206.6 82430.6 83185.0 84685.6 997.2 1023.8 1028.0 1074.4 1129.8 14583.9 14857.7 15663.6 15713.8 15922.8 35099.6 35642.8 36045.5 36064.5 36318.3 46605.3 48291.0 49050.3 49535.5 51658.2 9426.7 9715.2 9759.1 9837.2 9847.8 11539.2 13317.1 13584.5 15679.7 16346.1 13841.7 13960.5 14269.7 14409.2 14662.8 12812.8 12865.2 13510.3 13934.4 13947.4 14027.5 14328.5 14372.9 14537.4 14956.9 9564.5 9597.4 9673.8 9675.7 9865.3 10996.3 14505.0 14601.6 14839.9 14878.1 15:12:01 INFO - PROCESS | 8702 | 15:12:01 INFO - PROCESS | 8702 | [#3] mootools.html Cycles:180 Average:5327.83 Median:6381.41 stddev:2814.26 (44.1%) stddev-sans-first:2805.43 15:12:01 INFO - PROCESS | 8702 | Values: 1245.5 1591.6 1607.1 1619.2 1697.9 6486.7 7579.1 7691.7 7718.5 7722.8 7455.7 7618.8 7628.2 7629.8 7643.4 1958.6 2006.1 2220.4 2246.1 2246.3 2232.7 2236.1 2240.4 2241.1 2243.7 2181.2 2252.7 2256.1 2264.6 2266.8 2243.3 2258.9 2270.1 2270.3 2279.5 2241.4 2242.3 2253.8 2259.1 2295.0 7656.7 7705.1 7728.8 7731.3 7739.6 4546.9 4628.4 4633.1 4660.7 4662.3 3007.9 3049.9 3080.7 3088.3 3123.6 930.5 939.7 941.0 963.1 981.5 10599.5 10757.7 10763.3 10779.6 10822.1 4250.1 4299.0 4355.7 4359.4 4388.2 9300.0 9335.6 9343.7 9345.8 9356.6 4682.0 4698.7 4713.0 4713.6 4716.1 4284.0 4298.0 4313.9 4313.9 4320.1 3139.7 3169.5 3381.7 3558.8 3599.1 1130.5 1131.7 1141.1 1143.9 1173.4 975.6 975.9 1023.0 1041.6 1212.1 6869.4 6925.0 6930.4 6931.7 6937.1 570.6 581.8 582.3 586.4 721.4 5000.4 5030.3 5043.0 5055.2 5063.6 8962.1 9093.2 9270.5 9317.2 9328.9 9043.5 9121.0 9133.2 9223.5 9243.9 7108.9 7198.8 7244.8 7259.9 7299.0 6669.6 6694.0 6714.4 6717.2 6718.5 7740.3 8101.1 8194.2 8351.5 8368.8 8206.5 8539.4 8566.4 8703.4 8737.6 6671.0 6898.5 6922.4 6962.4 6991.5 6209.1 6425.8 7281.3 7453.6 7485.9 6915.9 6980.5 7070.3 7134.1 7145.7 6687.3 6896.3 6897.3 6903.2 7063.0 6762.8 6802.5 6802.7 6808.9 6810.9 6089.2 6133.4 6280.0 6288.0 6332.8 6339.1 6366.6 6380.5 6382.4 6385.3 15:12:01 INFO - PROCESS | 8702 | 15:12:01 INFO - PROCESS | 8702 | [#4] prototype.html Cycles:180 Average:5347.25 Median:6093.39 stddev:1607.81 (26.4%) stddev-sans-first:1567.81 15:12:01 INFO - PROCESS | 8702 | Values: 341.6 344.8 345.4 345.5 349.6 5862.1 5997.7 6023.2 6047.8 6082.5 5795.7 5944.7 5951.0 5966.0 5967.1 4627.3 4638.2 4638.6 4645.7 4652.2 4422.4 4514.3 4522.3 4528.0 4654.1 4489.1 4520.5 4599.6 4612.0 4618.0 4555.8 4607.5 4611.7 4621.8 4628.5 4078.9 4083.0 4085.4 4089.7 4090.0 5523.6 5674.9 5676.8 5701.9 5707.8 5339.9 5342.4 5350.6 5352.6 5352.7 6104.3 6391.0 6391.7 6397.8 6398.9 4242.8 4271.2 4342.5 4352.8 4362.7 6580.6 6637.3 6641.2 6654.0 6669.7 4560.1 4562.2 4568.0 4568.0 4570.4 4527.3 4620.8 4625.0 4628.9 4652.4 5305.1 5305.9 5308.8 5309.4 5343.4 6415.4 6422.2 6422.8 6430.2 6432.1 1616.5 1633.6 1633.8 1634.3 1641.0 1090.8 1098.1 1104.3 1114.4 1124.3 6149.7 6170.8 6176.7 6182.3 6188.3 6630.7 6648.9 6651.2 6654.3 6655.3 6007.8 6132.2 6177.0 6186.6 6188.4 3563.1 3580.9 3587.6 3588.2 3589.5 6662.0 6664.2 6666.9 6670.0 6673.4 6631.1 6765.1 6766.9 6768.1 6785.4 6615.4 6638.7 6657.8 6659.5 6669.5 6369.0 6558.4 6602.9 6603.0 6603.3 6453.3 6590.0 6600.5 6604.2 6614.8 6732.1 6732.1 6737.4 6740.9 6746.7 4450.0 4499.1 4537.7 4538.0 4539.2 6641.0 6683.5 6688.0 6688.5 6701.0 6495.6 6498.4 6499.1 6499.6 6501.2 6311.0 6434.1 6479.3 6489.5 6507.4 6388.5 6390.0 6395.1 6398.6 6398.7 6536.1 6537.5 6542.6 6545.2 6552.6 6179.8 6348.0 6353.8 6356.4 6379.3 15:12:01 INFO - PROCESS | 8702 | 15:12:01 INFO - PROCESS | 8702 | [#5] yui.html Cycles:180 Average:13460.82 Median:46626.80 stddev:15347.30 (32.9%) stddev-sans-first:15360.57 15:12:01 INFO - PROCESS | 8702 | Values: 729.3 740.9 817.4 825.7 826.2 12321.7 12627.8 12652.7 12680.4 12683.9 12849.9 12896.2 12938.1 12964.2 12973.7 813.1 829.7 830.4 830.7 831.1 563.8 603.2 820.9 822.6 833.2 776.8 778.1 783.4 784.8 785.3 775.2 775.4 775.6 776.4 776.8 492.6 499.2 626.1 632.3 637.7 12434.3 12525.7 12552.1 12559.1 12560.7 11625.4 12062.1 12084.3 12111.6 12407.2 10260.4 10296.5 10472.9 10558.6 10677.6 3605.6 3656.3 3680.9 3685.5 3686.3 46058.5 46190.8 46469.2 46485.5 46634.3 9136.7 9308.3 9323.2 9383.2 9427.2 18106.0 18143.3 18176.2 18176.9 18178.1 7364.1 7460.3 7637.2 7773.7 7878.2 4183.4 4220.6 4220.6 4237.4 4342.3 3057.5 3092.0 3092.4 3092.8 3095.3 543.9 554.9 556.1 556.9 568.6 526.8 602.7 604.8 651.9 662.3 8491.3 8493.3 8529.0 8575.7 8634.7 548.6 572.6 630.2 636.7 700.1 3706.1 3756.3 3840.9 3979.7 4250.3 51036.2 51619.5 52155.7 52238.2 52314.0 47329.8 48368.5 48485.5 48541.3 48766.0 43693.1 44147.9 44407.0 44576.1 45711.5 8351.4 8425.3 8456.9 8620.6 8796.8 34324.7 34726.5 36055.8 36719.8 38464.0 46619.3 46985.5 47557.5 47634.0 47704.8 10790.7 10935.5 11054.2 11153.2 11341.0 12195.9 12201.2 12335.2 12898.7 12903.5 10644.9 11220.8 11524.8 11605.8 11928.6 11520.5 11548.9 11910.6 11935.9 12324.1 8293.5 10137.6 11067.9 11172.6 11509.0 9088.7 9795.3 9846.9 10099.1 10191.1 8450.3 9010.4 9542.0 9625.5 9705.4 15:12:01 INFO - PROCESS | 8702 | -------- Summary: end -------- 15:12:01 INFO - PROCESS | 8702 | 15:12:01 INFO - TEST-INFO | 8702: exit 0 15:12:01 INFO - TEST-OK | dromaeo_css | took 1113217ms 15:12:01 INFO - TEST-START | kraken 15:12:01 INFO - operating with platform_type : linux_ 15:12:01 INFO - Initialising browser for kraken test... 15:12:01 INFO - TEST-INFO | started process 8889 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpe2fzKo/profile http://localhost:52049/getInfo.html) 15:12:05 INFO - PROCESS | 8889 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 15:12:05 INFO - PROCESS | 8889 | __metrics Screen width/height:1600/1200 15:12:05 INFO - PROCESS | 8889 | colorDepth:24 15:12:05 INFO - PROCESS | 8889 | Browser inner width/height: 1024/697 15:12:05 INFO - PROCESS | 8889 | __metrics 15:12:05 INFO - PROCESS | 8889 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:12:06 INFO - PROCESS | 8889 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:12:06 INFO - TEST-INFO | 8889: exit 0 15:12:06 INFO - Browser initialized. 15:12:06 INFO - Running cycle 1/1 for kraken test... 15:12:06 INFO - TEST-INFO | started process 8971 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpe2fzKo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:12:18 INFO - PROCESS | 8971 | RSS: Main: 149889024 15:12:18 INFO - PROCESS | 8971 | 15:12:21 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52049/tests/kraken/driver.html?testName=audio-beat-detection) 15:12:21 INFO - PROCESS | 8971 | RSS: Main: 186273792 15:12:21 INFO - PROCESS | 8971 | 15:12:24 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52049/tests/kraken/driver.html?testName=audio-dft) 15:12:24 INFO - PROCESS | 8971 | RSS: Main: 175620096 15:12:24 INFO - PROCESS | 8971 | 15:12:27 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52049/tests/kraken/driver.html?testName=audio-fft) 15:12:28 INFO - PROCESS | 8971 | RSS: Main: 159277056 15:12:28 INFO - PROCESS | 8971 | 15:12:30 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52049/tests/kraken/driver.html?testName=audio-oscillator) 15:12:30 INFO - PROCESS | 8971 | RSS: Main: 162631680 15:12:30 INFO - PROCESS | 8971 | 15:12:32 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52049/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:12:33 INFO - PROCESS | 8971 | RSS: Main: 165167104 15:12:33 INFO - PROCESS | 8971 | 15:12:36 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52049/tests/kraken/driver.html?testName=imaging-darkroom) 15:12:36 INFO - PROCESS | 8971 | RSS: Main: 166285312 15:12:36 INFO - PROCESS | 8971 | 15:12:40 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52049/tests/kraken/driver.html?testName=imaging-desaturate) 15:12:40 INFO - PROCESS | 8971 | RSS: Main: 165408768 15:12:40 INFO - PROCESS | 8971 | 15:12:43 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52049/tests/kraken/driver.html?testName=json-parse-financial) 15:12:44 INFO - PROCESS | 8971 | RSS: Main: 166522880 15:12:44 INFO - PROCESS | 8971 | 15:12:45 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52049/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:12:46 INFO - PROCESS | 8971 | RSS: Main: 173907968 15:12:46 INFO - PROCESS | 8971 | 15:12:48 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:12:48 INFO - PROCESS | 8971 | RSS: Main: 172728320 15:12:48 INFO - PROCESS | 8971 | 15:12:50 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:12:51 INFO - PROCESS | 8971 | RSS: Main: 186769408 15:12:51 INFO - PROCESS | 8971 | 15:12:53 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:12:54 INFO - PROCESS | 8971 | RSS: Main: 195198976 15:12:54 INFO - PROCESS | 8971 | 15:12:57 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:12:57 INFO - PROCESS | 8971 | RSS: Main: 191979520 15:12:57 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52049/tests/kraken/driver.html?testName=ai-astar) 15:12:59 INFO - PROCESS | 8971 | RSS: Main: 249958400 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | __start_tp_report 15:12:59 INFO - PROCESS | 8971 | _x_x_mozilla_page_load 15:12:59 INFO - PROCESS | 8971 | _x_x_mozilla_page_load_details 15:12:59 INFO - PROCESS | 8971 | |i|pagename|runs| 15:12:59 INFO - PROCESS | 8971 | |0;ai-astar;108;109;104;110;111;112;100;110;110;112 15:12:59 INFO - PROCESS | 8971 | |1;audio-beat-detection;147;122;146;160;124;148;152;140;174;123 15:12:59 INFO - PROCESS | 8971 | |2;audio-dft;160;161;159;160;159;159;160;163;159;160 15:12:59 INFO - PROCESS | 8971 | |3;audio-fft;72;71;87;95;71;71;71;103;89;73 15:12:59 INFO - PROCESS | 8971 | |4;audio-oscillator;93;93;138;92;94;94;143;93;93;142 15:12:59 INFO - PROCESS | 8971 | |5;imaging-gaussian-blur;110;110;110;110;110;109;109;111;110;110 15:12:59 INFO - PROCESS | 8971 | |6;imaging-darkroom;146;148;145;146;145;147;146;147;146;146 15:12:59 INFO - PROCESS | 8971 | |7;imaging-desaturate;96;96;96;96;95;96;95;96;95;96 15:12:59 INFO - PROCESS | 8971 | |8;json-parse-financial;59;58;58;57;60;58;58;67;56;57 15:12:59 INFO - PROCESS | 8971 | |9;json-stringify-tinderbox;67;66;67;67;66;67;66;67;66;67 15:12:59 INFO - PROCESS | 8971 | |10;stanford-crypto-aes;85;85;88;84;86;86;95;85;94;85 15:12:59 INFO - PROCESS | 8971 | |11;stanford-crypto-ccm;121;123;122;124;114;117;128;122;124;128 15:12:59 INFO - PROCESS | 8971 | |12;stanford-crypto-pbkdf2;144;153;159;156;153;140;153;150;150;141 15:12:59 INFO - PROCESS | 8971 | |13;stanford-crypto-sha256-iterative;69;66;67;68;66;68;66;67;66;66 15:12:59 INFO - PROCESS | 8971 | __end_tp_report 15:12:59 INFO - PROCESS | 8971 | __start_cc_report 15:12:59 INFO - PROCESS | 8971 | _x_x_mozilla_cycle_collect,959 15:12:59 INFO - PROCESS | 8971 | __end_cc_report 15:12:59 INFO - PROCESS | 8971 | __startTimestamp1450739579512__endTimestamp 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | ------- Summary: start ------- 15:12:59 INFO - PROCESS | 8971 | Number of tests: 14 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.81 (3.5%) stddev-sans-first:4.03 15:12:59 INFO - PROCESS | 8971 | Values: 108.0 109.0 104.0 110.0 111.0 112.0 100.0 110.0 110.0 112.0 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:147.50 stddev:16.96 (11.5%) stddev-sans-first:17.94 15:12:59 INFO - PROCESS | 8971 | Values: 147.0 122.0 146.0 160.0 124.0 148.0 152.0 140.0 174.0 123.0 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 15:12:59 INFO - PROCESS | 8971 | Values: 160.0 161.0 159.0 160.0 159.0 159.0 160.0 163.0 159.0 160.0 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | [#3] audio-fft Cycles:10 Average:80.30 Median:72.50 stddev:12.11 (16.7%) stddev-sans-first:12.47 15:12:59 INFO - PROCESS | 8971 | Values: 72.0 71.0 87.0 95.0 71.0 71.0 71.0 103.0 89.0 73.0 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:93.00 stddev:23.16 (24.9%) stddev-sans-first:23.96 15:12:59 INFO - PROCESS | 8971 | Values: 93.0 93.0 138.0 92.0 94.0 94.0 143.0 93.0 93.0 142.0 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:12:59 INFO - PROCESS | 8971 | Values: 110.0 110.0 110.0 110.0 110.0 109.0 109.0 111.0 110.0 110.0 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 15:12:59 INFO - PROCESS | 8971 | Values: 146.0 148.0 145.0 146.0 145.0 147.0 146.0 147.0 146.0 146.0 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 15:12:59 INFO - PROCESS | 8971 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:58.00 stddev:3.08 (5.3%) stddev-sans-first:3.27 15:12:59 INFO - PROCESS | 8971 | Values: 59.0 58.0 58.0 57.0 60.0 58.0 58.0 67.0 56.0 57.0 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 15:12:59 INFO - PROCESS | 8971 | Values: 67.0 66.0 67.0 67.0 66.0 67.0 66.0 67.0 66.0 67.0 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:86.00 stddev:3.95 (4.6%) stddev-sans-first:4.10 15:12:59 INFO - PROCESS | 8971 | Values: 85.0 85.0 88.0 84.0 86.0 86.0 95.0 85.0 94.0 85.0 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:123.50 stddev:4.35 (3.5%) stddev-sans-first:4.59 15:12:59 INFO - PROCESS | 8971 | Values: 121.0 123.0 122.0 124.0 114.0 117.0 128.0 122.0 124.0 128.0 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.90 Median:153.00 stddev:6.33 (4.1%) stddev-sans-first:6.35 15:12:59 INFO - PROCESS | 8971 | Values: 144.0 153.0 159.0 156.0 153.0 140.0 153.0 150.0 150.0 141.0 15:12:59 INFO - PROCESS | 8971 | 15:12:59 INFO - PROCESS | 8971 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:0.87 15:12:59 INFO - PROCESS | 8971 | Values: 69.0 66.0 67.0 68.0 66.0 68.0 66.0 67.0 66.0 66.0 15:12:59 INFO - PROCESS | 8971 | -------- Summary: end -------- 15:12:59 INFO - PROCESS | 8971 | 15:13:00 INFO - TEST-INFO | 8971: exit 0 15:13:00 INFO - TEST-OK | kraken | took 58494ms 15:13:00 INFO - TEST-START | v8_7 15:13:00 INFO - operating with platform_type : linux_ 15:13:00 INFO - Initialising browser for v8_7 test... 15:13:00 INFO - TEST-INFO | started process 9221 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxqXFV4/profile http://localhost:52049/getInfo.html) 15:13:04 INFO - PROCESS | 9221 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 15:13:04 INFO - PROCESS | 9221 | __metrics Screen width/height:1600/1200 15:13:04 INFO - PROCESS | 9221 | colorDepth:24 15:13:04 INFO - PROCESS | 9221 | Browser inner width/height: 1024/697 15:13:04 INFO - PROCESS | 9221 | __metrics 15:13:04 INFO - PROCESS | 9221 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:13:04 INFO - PROCESS | 9221 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:13:05 INFO - TEST-INFO | 9221: exit 0 15:13:05 INFO - Browser initialized. 15:13:05 INFO - Running cycle 1/1 for v8_7 test... 15:13:05 INFO - TEST-INFO | started process 9303 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxqXFV4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:17 INFO - PROCESS | 9303 | RSS: Main: 149639168 15:13:17 INFO - PROCESS | 9303 | 15:13:38 INFO - PROCESS | 9303 | Cycle 1(1): loaded http://localhost:52049/tests/v8_7/run.html (next: http://localhost:52049/tests/v8_7/run.html) 15:13:38 INFO - PROCESS | 9303 | RSS: Main: 615464960 15:13:38 INFO - PROCESS | 9303 | 15:13:38 INFO - PROCESS | 9303 | __start_tp_report 15:13:38 INFO - PROCESS | 9303 | _x_x_mozilla_page_load 15:13:38 INFO - PROCESS | 9303 | _x_x_mozilla_page_load_details 15:13:38 INFO - PROCESS | 9303 | |i|pagename|runs| 15:13:38 INFO - PROCESS | 9303 | |0;Richards;165.50810989738497 15:13:38 INFO - PROCESS | 9303 | |1;DeltaBlue;189.89745537409797 15:13:38 INFO - PROCESS | 9303 | |2;Encrypt;280.3476310625175 15:13:38 INFO - PROCESS | 9303 | |3;Decrypt;5181.347150259067 15:13:38 INFO - PROCESS | 9303 | |4;RayTrace;1088.139281828074 15:13:38 INFO - PROCESS | 9303 | |5;Earley;778.816199376947 15:13:38 INFO - PROCESS | 9303 | |6;Boyer;11917.64705882353 15:13:38 INFO - PROCESS | 9303 | |7;RegExp;25641.02564102564 15:13:38 INFO - PROCESS | 9303 | |8;Splay;691.8325326012355 15:13:38 INFO - PROCESS | 9303 | |9;NavierStokes;4835.748792270531 15:13:38 INFO - PROCESS | 9303 | __end_tp_report 15:13:38 INFO - PROCESS | 9303 | __startTimestamp1450739618833__endTimestamp 15:13:38 INFO - PROCESS | 9303 | 15:13:38 INFO - PROCESS | 9303 | ------- Summary: start ------- 15:13:38 INFO - PROCESS | 9303 | Number of tests: 10 15:13:38 INFO - PROCESS | 9303 | 15:13:38 INFO - PROCESS | 9303 | [#0] Richards Cycles:1 Average:165.51 Median:165.51 stddev:0.00 (0.0%) 15:13:38 INFO - PROCESS | 9303 | Values: 165.5 15:13:38 INFO - PROCESS | 9303 | 15:13:38 INFO - PROCESS | 9303 | [#1] DeltaBlue Cycles:1 Average:189.90 Median:189.90 stddev:0.00 (0.0%) 15:13:38 INFO - PROCESS | 9303 | Values: 189.9 15:13:38 INFO - PROCESS | 9303 | 15:13:38 INFO - PROCESS | 9303 | [#2] Encrypt Cycles:1 Average:280.35 Median:280.35 stddev:0.00 (0.0%) 15:13:38 INFO - PROCESS | 9303 | Values: 280.3 15:13:38 INFO - PROCESS | 9303 | 15:13:38 INFO - PROCESS | 9303 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 15:13:38 INFO - PROCESS | 9303 | Values: 5181.3 15:13:38 INFO - PROCESS | 9303 | 15:13:38 INFO - PROCESS | 9303 | [#4] RayTrace Cycles:1 Average:1088.14 Median:1088.14 stddev:0.00 (0.0%) 15:13:38 INFO - PROCESS | 9303 | Values: 1088.1 15:13:38 INFO - PROCESS | 9303 | 15:13:38 INFO - PROCESS | 9303 | [#5] Earley Cycles:1 Average:778.82 Median:778.82 stddev:0.00 (0.0%) 15:13:38 INFO - PROCESS | 9303 | Values: 778.8 15:13:38 INFO - PROCESS | 9303 | 15:13:38 INFO - PROCESS | 9303 | [#6] Boyer Cycles:1 Average:11917.65 Median:11917.65 stddev:0.00 (0.0%) 15:13:38 INFO - PROCESS | 9303 | Values: 11917.6 15:13:38 INFO - PROCESS | 9303 | 15:13:38 INFO - PROCESS | 9303 | [#7] RegExp Cycles:1 Average:25641.03 Median:25641.03 stddev:0.00 (0.0%) 15:13:38 INFO - PROCESS | 9303 | Values: 25641.0 15:13:38 INFO - PROCESS | 9303 | 15:13:38 INFO - PROCESS | 9303 | [#8] Splay Cycles:1 Average:691.83 Median:691.83 stddev:0.00 (0.0%) 15:13:38 INFO - PROCESS | 9303 | Values: 691.8 15:13:38 INFO - PROCESS | 9303 | 15:13:38 INFO - PROCESS | 9303 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 15:13:38 INFO - PROCESS | 9303 | Values: 4835.7 15:13:38 INFO - PROCESS | 9303 | -------- Summary: end -------- 15:13:38 INFO - PROCESS | 9303 | 15:13:39 INFO - TEST-INFO | 9303: exit 0 15:13:39 INFO - TEST-OK | v8_7 | took 39314ms 15:13:39 INFO - SUITE-END | took 1211s 15:13:39 INFO - Completed test suite (00:20:11) 15:13:39 INFO - Working with test: dromaeo_css 15:13:39 INFO - Generating results file: dromaeo_css 15:13:39 INFO - Working with test: kraken 15:13:39 INFO - Generating results file: kraken 15:13:39 INFO - javascript benchmark 15:13:39 INFO - Working with test: v8_7 15:13:39 INFO - Generating results file: v8_7 15:13:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:13:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 15:13:39 INFO - process_Request line: dromaeo_css 6977.13 graph.html#tests=[[72,201,35]] 15:13:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:13:39 INFO - process_Request line: kraken 1503.60 graph.html#tests=[[232,201,35]] 15:13:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:13:39 INFO - process_Request line: v8_7 20880.73 graph.html#tests=[[230,201,35]] 15:13:39 INFO - RETURN: dromaeo_css: 6977.13 15:13:39 INFO - RETURN: kraken: 1503.60 15:13:39 INFO - RETURN: v8_7: 20880.73 15:13:39 INFO - javascript benchmark 15:13:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3130.389574033063, 3167.7940933839286, 3215.3730022645577, 3218.147190994387, 3235.3367559650274, 5276.894462110756, 5361.865953351164, 5369.677819330838, 5396.028714831329, 5433.91849122263, 5367.704776237305, 5434.3207099112615, 5479.013777520045, 5481.725913704308, 5487.286652735139, 4841.491643377448, 4883.731394773286, 4908.0429316283335, 4921.384826896638, 4930.531599498042, 4889.437714662806, 5012.799488020475, 5014.047331007097, 5019.899602007958, 5057.645964782467, 4743.0, 4827.203511420611, 4944.802207911679, 4962.702237865721, 5028.170351891933, 4827.131116399047, 4830.7101573905675, 4845.781939812717, 4850.369451971256, 4856.0287942411305, 4850.902981940377, 4861.513848615145, 4864.246041863482, 4874.610031197496, 4883.413990321184, 5109.770060347293, 5139.58883289336, 5201.219817027439, 5205.765740541685, 5253.001929633396, 5766.394528574481, 5767.769289228426, 5782.595218334718, 5782.653040817564, 5849.03490923997, 5747.913781293284, 5751.482366586985, 5752.712364381764, 5757.884842303172, 5794.304683437972, 5242.18746094356, 5398.163284690879, 5399.028174928511, 5429.995450841568, 5441.374241962186, 5860.413958604106, 5944.346121926585, 5945.881082378415, 5948.10778383246, 5950.137230101611, 5625.38120806711, 5638.351589567253, 5639.774409023593, 5643.858903527444, 5693.28833895763, 5544.944550554443, 5671.234383358194, 5673.035583950738, 5732.7706891723865, 5741.598088133874, 5629.662220266797, 5662.858428539237, 5664.235328230719, 5690.345610254791, 5706.71466426677, 5749.338826034976, 5777.682227477445, 5779.537636989115, 5781.682007489544, 5781.768729250867, 4384.583464570861, 4414.867553973386, 4476.2837945928495, 4477.910441791211, 4515.88710282239, 3976.224636195914, 3994.2410941920944, 4001.2997725398523, 4004.379321205218, 4013.538443079083, 5427.294451721251, 5440.211169380497, 5448.264484294569, 5462.781488740486, 5491.780328786804, 5639.577031722637, 5692.316921969307, 5745.8563535911935, 5751.683657398883, 5794.681292528867, 5423.159410291411, 5463.453654634504, 5474.507294343449, 5487.670739755627, 5489.725513724298, 5042.924356134661, 5055.368078990126, 5063.316452278968, 5066.949330506648, 5099.898002040012, 5543.805966791224, 5672.319321681424, 5675.631083979528, 5806.883862322815, 5823.79616713413, 5798.449147330997, 5813.447722466359, 5815.360310365941, 5824.592278540631, 5849.736761845812, 5833.79581714638, 5860.2967643883, 5863.237779088691, 5867.237259156283, 5867.73595188209, 5581.5255703265675, 5719.8570035749435, 5730.885382292414, 5746.511546518593, 5747.971260143672, 5703.486686198262, 5739.426057394227, 5782.277215348082, 5783.479486846036, 5789.507891829073, 5603.523700485504, 5642.097264437671, 5652.4064973178865, 5684.9431505684415, 5703.5722320826935, 5593.356763972195, 5598.804041858515, 5605.299337582802, 5612.382637909745, 5669.603127781016, 5446.346438427414, 5492.5331346835965, 5500.092484739973, 5500.1749737539685, 5508.752106155152, 5464.644798088111, 5547.667139971614, 5556.583256255716, 5559.694216818114, 5688.544916406595, 5574.275344205227, 5635.436456354331, 5639.661620302795, 5645.237892884408, 5646.576506761927], "unit": "score", "name": "dojo.html", "value": 5305.025109164884}, {"lowerIsBetter": false, "replicates": [550.6118186678392, 581.9796307129249, 582.883423315337, 598.6168851934762, 613.2548953022077, 25529.0, 25806.22581322561, 38281.80859095707, 38752.612473875255, 38816.61183388165, 41636.583634163646, 42245.0, 42343.36484952728, 42359.57640423595, 42426.151476970444, 8565.657373705044, 8828.690995815115, 8830.337724670644, 8839.116088391174, 8842.469451832878, 7428.145763237216, 7613.885791713129, 10412.062914337708, 10590.364578125298, 10656.413897235649, 10293.845592316122, 10343.482825858677, 10375.377477351345, 10382.0, 10413.791724165512, 7382.33558979689, 7558.168601453835, 10244.743881402987, 10302.124319432858, 10373.273870828969, 10364.48177591125, 10632.362058276529, 10638.095761860252, 10642.893571064267, 10648.14814814813, 39734.40398394026, 40035.399469007694, 40138.197236055115, 40193.39709904324, 40220.39669404961, 3114.5639610454555, 3176.65056843747, 3235.223546348883, 3591.5510561179854, 3745.138618117821, 29871.0, 29979.550306745416, 30123.397532049454, 30186.54720179199, 30775.538366924513, 3872.6901847852105, 3915.549711783153, 3944.842206311744, 3988.4216788565786, 4108.979455102735, 274586.0, 276128.0, 276682.0, 277331.0, 277457.61271193717, 45698.31452528215, 45751.0, 46619.0, 53854.19218711722, 55040.0, 57836.554086148186, 57847.421525785045, 58351.0, 58368.4163158363, 58406.12390814141, 14108.85891141096, 14172.220527871066, 14186.077904936146, 14206.715865682836, 14222.786658200135, 11468.942655286837, 11508.194426390073, 11524.481398337095, 11525.654230373102, 11531.538738450536, 19714.0, 19753.0, 19801.702974455395, 19916.0, 19982.20071197165, 7150.356467917808, 7532.079319773532, 7542.849143017109, 7561.130469996021, 7588.354989825927, 841.9223394055618, 899.7165892743765, 982.8967958364269, 1046.6179844356907, 1085.625459216569, 27500.0, 27647.58528622072, 27695.723042769718, 27848.721512785018, 28018.579721304195, 944.7213072143734, 953.4374718915734, 1026.5329275179774, 1033.6950599572995, 1037.0770014686934, 13573.59279221625, 13744.312784360742, 13846.93076534611, 13920.651983700285, 13933.790993135111, 324991.0, 329670.0, 329802.0, 330438.0, 330844.0, 49671.751641242285, 50103.74948125236, 50237.74881125644, 50266.497335026914, 50277.24584131241, 1284.1396264502805, 1289.4906511927736, 1302.4594793161111, 1308.1758492150075, 1313.441787240438, 26238.86880565585, 27153.1854044379, 27228.727712723412, 27284.863575681993, 31870.6812931877, 35529.82235088912, 35931.46102808512, 46675.0, 47374.526254737015, 47805.76097119492, 242611.0, 242784.0, 245102.0, 245212.0, 245278.0, 36477.81761091284, 37399.813000934824, 37774.24451510899, 40370.59629403668, 41458.58541414547, 33586.49620255747, 41117.79441102775, 41291.38062928998, 41364.79317603393, 41674.791626041675, 35396.0, 35721.1069723259, 35781.28437431289, 35941.82029089838, 36581.0, 33657.3074154072, 35497.0, 35576.82211589029, 35651.10872228111, 36010.0, 34478.65521344754, 35306.29387412186, 35334.46998295079, 35382.46926296056, 35499.82250088733, 30280.697193027787, 32120.196995075312, 32569.0, 32987.67012329942, 33035.504467432525, 22219.444513887283, 22499.437514061625, 22623.886880565493, 22635.320940371814, 22663.0], "unit": "score", "name": "ext.html", "value": 18232.89376320387}, {"lowerIsBetter": false, "replicates": [349.1863956980236, 349.2578271173756, 349.98075105869174, 353.8867562380036, 353.94867744177094, 13368.0, 13910.443582256697, 16080.678386432264, 16720.0, 17861.82138178618, 16273.837261627381, 16294.266757995889, 16480.752788708178, 16490.917545412256, 16572.41996530122, 5188.636795424312, 5407.026735187665, 5416.322959630046, 5462.0, 5462.289902312714, 3992.2614316351423, 4095.4266402703647, 4115.218108559364, 4118.196951594426, 5400.648957817749, 4294.742315461082, 6026.337102918676, 6026.608270462406, 6030.276366835986, 6033.939660603403, 5580.581456390767, 6072.119542666289, 6087.269527656687, 6111.755529778803, 6112.144299798032, 5302.2841916341185, 5306.8407947761625, 5311.654742441768, 5316.707581083039, 5332.946670533283, 20314.0, 20543.28098516545, 20915.058822353032, 21224.363269101796, 21232.681509777212, 2084.98957505213, 2111.102781317934, 2158.136745301892, 2188.72640919885, 2190.0, 11888.346140962243, 13417.262050587215, 13629.386677599532, 13662.316884155853, 13999.370028348647, 1937.2638397409034, 1983.6925276582008, 1983.8611297209202, 1987.7714062882665, 2010.98994505028, 57980.0, 62612.68693656503, 62686.686566566874, 62783.0, 63245.367546324866, 14552.781708274384, 14556.781648275284, 14565.563033109023, 14595.124292542268, 14600.926995364955, 22796.658050129263, 22842.42893927632, 23222.41943951381, 23793.048278068683, 23887.641685374732, 8508.234258916727, 8570.0, 9127.995920448746, 9168.44989300644, 9189.862152067724, 7094.92905070953, 7233.746818861315, 7515.774526764206, 7562.886556701654, 7568.8486230276185, 7549.131849837229, 7580.924190758022, 7581.3176814087, 7647.961760191275, 7758.107817600935, 1797.7932537758063, 1804.6390721855419, 1805.656925184237, 2199.9990004547894, 2920.707929207062, 887.9689210877589, 892.9196372326522, 913.2146354135439, 976.9609215631295, 997.2919227348664, 15270.618234544225, 15779.368825246862, 16111.0, 16664.08347540897, 16922.49232523026, 868.774118729135, 892.0722448653457, 900.5002223765873, 922.110163692027, 994.0, 9312.580933857993, 9449.43303401798, 9452.621895124255, 9467.763305917408, 9482.0, 493660.0, 495739.0, 525213.8537439322, 555002.0, 557734.0, 78791.60604197058, 81206.59396703097, 82430.58784706038, 83185.0, 84685.57657211674, 997.1673652500099, 1023.8054769593754, 1028.0285130551556, 1074.382230217628, 1129.768397478515, 14583.915665056087, 14857.702845942804, 15663.608409789846, 15713.764293535378, 15922.840771592599, 35099.59601615907, 35642.821785891945, 36045.45931810972, 36064.459033114, 36318.27363452769, 46605.30092048554, 48291.0, 49050.26424603562, 49535.50464495453, 51658.22512662388, 9426.717198484057, 9715.22278217755, 9759.12167904892, 9837.163841073303, 9847.803043939224, 11539.249948753304, 13317.134386264861, 13584.524541640994, 15679.68640627204, 16346.100964447069, 13841.723165536834, 13960.511382101578, 14269.71460570762, 14409.207493587954, 14662.780058299348, 12812.807807883075, 12865.163764355288, 13510.256935868621, 13934.442622294995, 13947.37236824325, 14027.50903718365, 14328.49850255236, 14372.856271437151, 14537.41850325975, 14956.850431495981, 9564.521773911416, 9597.376170548892, 9673.806523869342, 9675.661351852652, 9865.26010549226, 10996.340219586851, 14505.0, 14601.561953141423, 14839.851601483848, 14878.10731356122], "unit": "score", "name": "jquery.html", "value": 9327.627190018799}, {"lowerIsBetter": false, "replicates": [1245.545375937783, 1591.6020994751311, 1607.067900617641, 1619.2227730689272, 1697.8896371735832, 6486.675666216688, 7579.090509138904, 7691.730789422371, 7718.536887786737, 7722.8455430891345, 7455.70177192913, 7618.7714368568895, 7628.199039100898, 7629.809254768634, 7643.350315223212, 1958.637652034371, 2006.1173083843134, 2220.378294077661, 2246.067881829039, 2246.34855891792, 2232.743234528026, 2236.1390864517116, 2240.439890027493, 2241.1147596699293, 2243.6634504824324, 2181.2474696229774, 2252.6733623624646, 2256.131389415079, 2264.5697317509703, 2266.7733226677283, 2243.349428665685, 2258.8870556472193, 2270.0579259607243, 2270.262164796448, 2279.5326957973575, 2241.3612120545567, 2242.2936774915847, 2253.830962677789, 2259.051198496635, 2295.0, 7656.732014379526, 7705.113911900147, 7728.806779830549, 7731.265529774662, 7739.57432341221, 4546.863594092182, 4628.39830821991, 4633.119707255611, 4660.650451216173, 4662.347271382009, 3007.9398412031856, 3049.878004879802, 3080.738137258336, 3088.2896933705147, 3123.5627012218306, 930.5114814722257, 939.6523286384013, 941.0354386753633, 963.0995019656574, 981.4601968917138, 10599.523021464052, 10757.677269682, 10763.300385474919, 10779.5688172473, 10822.134229261641, 4250.149970005949, 4299.032717638506, 4355.673324500612, 4359.411479450297, 4388.166248412856, 9299.95350023259, 9335.579898904565, 9343.672971445967, 9345.813083738287, 9356.578953947088, 4681.976590117028, 4698.718076915396, 4712.963148107411, 4713.599344055725, 4716.080364328923, 4283.957160428356, 4297.978510107429, 4313.935290970638, 4313.935290970638, 4320.071184695305, 3139.748820094387, 3169.5245713142754, 3381.6956473917467, 3558.8042657654078, 3599.1002249437643, 1130.496928866663, 1131.6887855839545, 1141.1384404774342, 1143.9418537852453, 1173.3663821536445, 975.6292608808608, 975.9219262458986, 1023.0076825479273, 1041.568315650868, 1212.0788200967152, 6869.381755641916, 6925.0, 6930.3762661360715, 6931.6880740366805, 6937.063496428019, 570.6034306157181, 581.7702007706932, 582.3041465448832, 586.3989410853824, 721.3796135323618, 5000.424951130593, 5030.346055012898, 5043.041822053798, 5055.216441451581, 5063.594912406998, 8962.058983806737, 9093.181613654802, 9270.536473176315, 9317.208037316768, 9328.860067098998, 9043.502607356528, 9121.0, 9133.223675987483, 9223.492707900996, 9243.907560924305, 7108.857822843514, 7198.776208044645, 7244.818879528054, 7259.89110163348, 7299.0, 6669.566478178903, 6694.0, 6714.362135597111, 6717.193936727624, 6718.529702920749, 7740.26467485588, 8101.10887802353, 8194.22154895284, 8351.540665263468, 8368.790780230544, 8206.507609543447, 8539.359548033797, 8566.400351975552, 8703.43427677199, 8737.56312184401, 6671.0, 6898.517103802686, 6922.411595014481, 6962.443004559522, 6991.545549539263, 6209.130721698875, 6425.775097871552, 7281.2718728126765, 7453.552786832807, 7485.850282994201, 6915.861682766417, 6980.476464265099, 7070.257622949516, 7134.108236470442, 7145.714171433085, 6687.331266873273, 6896.310368963063, 6897.310268973062, 6903.206131294764, 7063.0, 6762.797116086525, 6802.489813263926, 6802.6598670065305, 6808.897866532105, 6810.931890681228, 6089.177960975212, 6133.44798968095, 6280.0, 6288.0, 6332.810015699536, 6339.144215531029, 6366.586171898812, 6380.457661098859, 6382.36176382358, 6385.265694445013], "unit": "score", "name": "mootools.html", "value": 4306.883926101034}, {"lowerIsBetter": false, "replicates": [341.62250712962174, 344.75715047254647, 345.37831902575357, 345.49040165755497, 349.5944704143196, 5862.120681897717, 5997.700114994254, 6023.156758053876, 6047.758089676413, 6082.513398928087, 5795.710214489269, 5944.702764861761, 5951.047832346825, 5966.0, 5967.104934259853, 4627.282771170466, 4638.165130276566, 4638.582527572517, 4645.651576131787, 4652.209124448835, 4422.402975598286, 4514.27771556551, 4522.29904364824, 4528.026474308023, 4654.115718013567, 4489.079738653568, 4520.50274469808, 4599.609033232163, 4611.953880461203, 4617.976910115444, 4555.772211389434, 4607.470140933802, 4611.723296602215, 4621.792019359137, 4628.5371462853445, 4078.898027549335, 4083.020075181965, 4085.407615895708, 4089.672826173899, 4090.018395585068, 5523.613347065707, 5674.914876276859, 5676.829695109153, 5701.914471282934, 5707.800226992035, 5339.919901201446, 5342.439043900412, 5350.5987050971335, 5352.571794256489, 5352.652077614943, 6104.267487901436, 6391.0, 6391.744330226786, 6397.776077837299, 6398.8720225595225, 4242.766647834368, 4271.209826182167, 4342.478902531685, 4352.7605981670995, 4362.738235705868, 6580.638064906429, 6637.269900310962, 6641.236257830363, 6654.0, 6669.699863506154, 4560.110778398181, 4562.201614717477, 4568.017876156576, 4568.040711450566, 4570.405847239904, 4527.253003254492, 4620.838270660511, 4624.953750462452, 4628.930566041512, 4652.441706995182, 5305.124654432053, 5305.8938821223355, 5308.787648494094, 5309.3894202166475, 5343.385510666245, 6415.390537898892, 6422.2293324800385, 6422.839429014312, 6430.164078669836, 6432.099506069154, 1616.450406861649, 1633.6242664187303, 1633.7712720219179, 1634.2809163968054, 1641.015390765555, 1090.8145615245428, 1098.0611577101622, 1104.3373975614568, 1114.3536748685742, 1124.3141683573015, 6149.661768602769, 6170.753169873155, 6176.722047507873, 6182.258129024546, 6188.2883468400805, 6630.701618427086, 6648.8670226595195, 6651.235107962646, 6654.334566543307, 6655.301193374723, 6007.8197654070445, 6132.202813634199, 6177.042558403455, 6186.566940314225, 6188.412100850412, 3563.0914116900026, 3580.8925732228076, 3587.6232995535615, 3588.174719814457, 3589.4795254687924, 6661.966690166615, 6664.233613134552, 6666.866662666816, 6670.0, 6673.399394054559, 6631.10480085192, 6765.1205343305055, 6766.864662706718, 6768.086308348408, 6785.389314961579, 6615.404613584704, 6638.6680665966505, 6657.833554161088, 6659.500537459709, 6669.499787515956, 6369.0, 6558.376954189344, 6602.9009564855605, 6603.0, 6603.339666033358, 6453.290138084901, 6589.967050164719, 6600.471962242913, 6604.207495100426, 6614.8346291343105, 6732.057511948233, 6732.091167692299, 6737.393634572912, 6740.865182696417, 6746.662666866735, 4450.0, 4499.055198408371, 4537.727736335831, 4538.0, 4539.205639013226, 6640.966795166187, 6683.532152749261, 6688.030235615711, 6688.4983626229205, 6701.0, 6495.577787443801, 6498.350164983463, 6499.0901273820755, 6499.642519661464, 6501.187351581052, 6310.968445157745, 6434.131392261985, 6479.287278399466, 6489.545731798728, 6507.414332710079, 6388.4569811566535, 6390.0, 6395.072714456471, 6398.5521013528605, 6398.744050237939, 6536.084948107364, 6537.542372033912, 6542.607443553402, 6545.247296560766, 6552.57408268461, 6179.752809887555, 6348.047792831112, 6353.809385718436, 6356.396142366468, 6379.298277189413], "unit": "score", "name": "prototype.html", "value": 4828.387469475496}, {"lowerIsBetter": false, "replicates": [729.314444422243, 740.9239291720245, 817.3706246190434, 825.7481468152213, 826.1573195340752, 12321.691957701061, 12627.810582841264, 12652.683682907931, 12680.365981700912, 12683.873161268373, 12849.93575032126, 12896.161749486277, 12938.094333396666, 12964.157329773558, 12973.675658108552, 813.1177672225642, 829.6598394658191, 830.4062595244399, 830.6552780596045, 831.0567505880839, 563.8054871069495, 603.1947350287371, 820.8891799607036, 822.6174828704651, 833.1918039501674, 776.8290975985274, 778.0896351269, 783.3733013589106, 784.7606480023619, 785.3442375616339, 775.2480094308512, 775.3719487215374, 775.5501808950795, 776.4138075752827, 776.7553220735479, 492.55915955220235, 499.15891722447793, 626.1421852062704, 632.2792017100509, 637.6747858592151, 12434.316112613802, 12525.74948501034, 12552.058595605366, 12559.058070644647, 12560.685982850411, 11625.418729063513, 12062.095342849321, 12084.335361555111, 12111.576094836726, 12407.193532420453, 10260.435676037814, 10296.536655850505, 10472.947635261775, 10558.630447934362, 10677.572897084106, 3605.6394360563995, 3656.3053019926397, 3680.926381472382, 3685.539307586552, 3686.3364594373, 46058.53941460576, 46190.76904615456, 46469.20507815433, 46485.53514464846, 46634.30048549241, 9136.655844317831, 9308.301877359225, 9323.160915517636, 9383.202427793578, 9427.198688111588, 18106.0, 18143.27426902909, 18176.1820718068, 18176.909115454604, 18178.091095445176, 7364.116306043309, 7460.253974602605, 7637.19809420014, 7773.68905243784, 7878.172791856887, 4183.435236243129, 4220.577942205755, 4220.6412454941055, 4237.449131612871, 4342.305231162999, 3057.5260834570677, 3092.0105566219045, 3092.412441636082, 3092.7989680670685, 3095.3035566997696, 543.9129739241703, 554.9250851135126, 556.1324334038832, 556.9192467092249, 568.6076607141059, 526.7734874004138, 602.6715440085164, 604.8306474187235, 651.9496184499816, 662.2648859765657, 8491.278241349431, 8493.320534357237, 8528.957355213184, 8575.656973720981, 8634.740957771277, 548.5830768615881, 572.5648507134524, 630.158738084653, 636.6959354761843, 700.0689083518907, 3706.1475860552223, 3756.286305601927, 3840.9231815363537, 3979.6816254699556, 4250.298700714409, 51036.23445648318, 51619.48380516222, 52155.73922130365, 52238.21642675363, 52314.0, 47329.76335118302, 48368.51631483711, 48485.5151448481, 48541.27188092181, 48766.0, 43693.12613747771, 44147.89630259205, 44407.0, 44576.10847783026, 45711.54288457139, 8351.41540092212, 8425.2838508725, 8456.873146902924, 8620.568971551273, 8796.780080498038, 34324.65675343315, 34726.47910281398, 36055.81972090123, 36719.81640091782, 38464.0, 46619.30071048869, 46985.53014469812, 47557.524424756695, 47634.0, 47704.7614761924, 10790.67627971162, 10935.45322733876, 11054.170937179582, 11153.163512736739, 11341.0, 12195.939020304842, 12201.20692155007, 12335.198212116184, 12898.742025159632, 12903.483860645845, 10644.946775266384, 11220.831687524531, 11524.82712759326, 11605.767884642091, 11928.642140735792, 11520.53917843277, 11548.94225528867, 11910.583129590423, 11935.940320298343, 12324.137310388187, 8293.543855088028, 10137.64518241858, 11067.944660276647, 11172.553097875994, 11509.0, 9088.727338179866, 9795.265355098254, 9846.852297215692, 10099.14157296638, 10191.133753631024, 8450.323974081935, 9010.369274150746, 9542.0, 9625.51872406363, 9705.417674939526], "unit": "score", "name": "yui.html", "value": 6148.109555375896}], "name": "dromaeo_css", "value": 6977.1310635510445}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 104.0, 110.0, 111.0, 112.0, 100.0, 110.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [147.0, 122.0, 146.0, 160.0, 124.0, 148.0, 152.0, 140.0, 174.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 159.0, 160.0, 159.0, 159.0, 160.0, 163.0, 159.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.0}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 87.0, 95.0, 71.0, 71.0, 71.0, 103.0, 89.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 138.0, 92.0, 94.0, 94.0, 143.0, 93.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 145.0, 146.0, 145.0, 147.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 58.0, 57.0, 60.0, 58.0, 58.0, 67.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.8}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 88.0, 84.0, 86.0, 86.0, 95.0, 85.0, 94.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.3}, {"lowerIsBetter": true, "replicates": [121.0, 123.0, 122.0, 124.0, 114.0, 117.0, 128.0, 122.0, 124.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.3}, {"lowerIsBetter": true, "replicates": [144.0, 153.0, 159.0, 156.0, 153.0, 140.0, 153.0, 150.0, 150.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.9}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 67.0, 68.0, 66.0, 68.0, 66.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1503.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.50810989738497], "unit": "score", "name": "Richards", "value": 213.294684}, {"lowerIsBetter": false, "replicates": [189.89745537409797], "unit": "score", "name": "DeltaBlue", "value": 348.1773879999999}, {"lowerIsBetter": false, "replicates": [280.3476310625175], "unit": "score", "name": "Encrypt", "value": 949.4676269999999}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1088.139281828074], "unit": "score", "name": "RayTrace", "value": 680.0498910000001}, {"lowerIsBetter": false, "replicates": [778.816199376947], "unit": "score", "name": "Earley", "value": 855.7384919999998}, {"lowerIsBetter": false, "replicates": [11917.64705882353], "unit": "score", "name": "Boyer", "value": 55.922364264560706}, {"lowerIsBetter": false, "replicates": [25641.02564102564], "unit": "score", "name": "RegExp", "value": 35.52841499999999}, {"lowerIsBetter": false, "replicates": [691.8325326012355], "unit": "score", "name": "Splay", "value": 117.79006646825394}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20880.729677598167}]} 15:13:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20880.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1503.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6977.13"}}} 15:13:40 INFO - Return code: 0 15:13:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:13:40 ERROR - # TBPL SUCCESS # 15:13:40 INFO - Running post-action listener: _resource_record_post_action 15:13:40 INFO - Running post-run listener: _resource_record_post_run 15:13:41 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547201024; Read time: 8; Write time: 323000 15:13:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 235212800; Read time: 0; Write time: 162912 15:13:41 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311988224; Read time: 8; Write time: 160088 15:13:41 INFO - Running post-run listener: _upload_blobber_files 15:13:41 INFO - Blob upload gear active. 15:13:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 15:13:41 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:13:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 15:13:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 15:13:41 INFO - (blobuploader) - INFO - Open directory for files ... 15:13:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:13:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:13:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:42 INFO - (blobuploader) - INFO - Done attempting. 15:13:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 15:13:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:13:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:43 INFO - (blobuploader) - INFO - Done attempting. 15:13:43 INFO - (blobuploader) - INFO - Iteration through files over. 15:13:43 INFO - Return code: 0 15:13:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 15:13:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 15:13:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d62070cb3615cc7e0426653b88db69ebd32bcdd689f158beeb7437cd371cd60b15486aab9fd4b508073f7e67b2722cb6739d9fa635d7752cb8ee6b6acbfde735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/636ae41d03053458ccfc2fea56fa5f87b698007386ee614acaadf4307543eaa8c39b89ffaf15fb1fe26b8d90833e948db5cad19ac7ca1373df7bc6ccae671efb"} 15:13:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 15:13:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 15:13:43 INFO - Contents: 15:13:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d62070cb3615cc7e0426653b88db69ebd32bcdd689f158beeb7437cd371cd60b15486aab9fd4b508073f7e67b2722cb6739d9fa635d7752cb8ee6b6acbfde735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/636ae41d03053458ccfc2fea56fa5f87b698007386ee614acaadf4307543eaa8c39b89ffaf15fb1fe26b8d90833e948db5cad19ac7ca1373df7bc6ccae671efb"} 15:13:43 INFO - Copying logs to upload dir... 15:13:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.029233 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-21 15:13:42.253321) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 15:13:42.257095) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d62070cb3615cc7e0426653b88db69ebd32bcdd689f158beeb7437cd371cd60b15486aab9fd4b508073f7e67b2722cb6739d9fa635d7752cb8ee6b6acbfde735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/636ae41d03053458ccfc2fea56fa5f87b698007386ee614acaadf4307543eaa8c39b89ffaf15fb1fe26b8d90833e948db5cad19ac7ca1373df7bc6ccae671efb"} build_url:https://queue.taskcluster.net/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/aZIhUFcJT_uQphE6t9nuew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d62070cb3615cc7e0426653b88db69ebd32bcdd689f158beeb7437cd371cd60b15486aab9fd4b508073f7e67b2722cb6739d9fa635d7752cb8ee6b6acbfde735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/636ae41d03053458ccfc2fea56fa5f87b698007386ee614acaadf4307543eaa8c39b89ffaf15fb1fe26b8d90833e948db5cad19ac7ca1373df7bc6ccae671efb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 15:13:42.288419) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 15:13:42.289013) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1450738048.835323-195986535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 15:13:42.372202) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 15:13:42.372558) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 15:13:42.372890) ========= ========= Total master_lag: 0.25 =========