builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1452841851.08 results: success (0) buildid: 20160114203113 builduid: a607bff94c7345a4b5bfe71587633ad5 revision: bedcf761e639c9041e047ebbd7fa596a37258f9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.080874) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.081347) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.081663) ========= 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=df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006316 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.115892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.116231) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.155009) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.155297) ========= 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=df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004671 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.203432) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.203738) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.204114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.204382) ========= 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=df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 23:10:51-- 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% 60.9M=0s 2016-01-14 23:10:51 (60.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097418 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.314787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.315086) ========= 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=df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022798 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.370593) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.370938) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev bedcf761e639c9041e047ebbd7fa596a37258f9c --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 bedcf761e639c9041e047ebbd7fa596a37258f9c --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=df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 23:10:51,544 truncating revision to first 12 chars 2016-01-14 23:10:51,544 Setting DEBUG logging. 2016-01-14 23:10:51,544 attempt 1/10 2016-01-14 23:10:51,544 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/bedcf761e639?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 23:10:51,827 unpacking tar archive at: b2g-inbound-bedcf761e639/testing/mozharness/ program finished with exit code 0 elapsedTime=0.593868 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.977055) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.977326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.986533) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.986791) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 23:10:51.987204) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-01-14 23:10:51.987498) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --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', '--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=df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:10:52 INFO - MultiFileLogger online at 20160114 23:10:52 in /builds/slave/test-pgo 23:10:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 23:10:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:10:52 INFO - {'append_to_log': False, 23:10:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:10:52 INFO - 'blob_upload_branch': 'B2G-Inbound', 23:10:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:10:52 INFO - 'branch': 'B2G-Inbound', 23:10:52 INFO - 'buildbot_json_path': 'buildprops.json', 23:10:52 INFO - 'config_files': ('talos/linux_config.py',), 23:10:52 INFO - 'default_actions': ('clobber', 23:10:52 INFO - 'read-buildbot-config', 23:10:52 INFO - 'download-and-extract', 23:10:52 INFO - 'populate-webroot', 23:10:52 INFO - 'create-virtualenv', 23:10:52 INFO - 'install', 23:10:52 INFO - 'run-tests'), 23:10:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:10:52 INFO - 'download_minidump_stackwalk': True, 23:10:52 INFO - 'download_symbols': 'ondemand', 23:10:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:10:52 INFO - 'tooltool.py': '/tools/tooltool.py', 23:10:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:10:52 INFO - '/tools/misc-python/virtualenv.py')}, 23:10:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:10:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:10:52 INFO - 'installer_path': 'installer.exe', 23:10:52 INFO - 'log_level': 'info', 23:10:52 INFO - 'log_name': 'talos', 23:10:52 INFO - 'log_to_console': True, 23:10:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:10:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:10:52 INFO - 'opt_config_files': (), 23:10:52 INFO - 'pip_index': False, 23:10:52 INFO - 'sps_profile': False, 23:10:52 INFO - 'sps_profile_interval': 0, 23:10:52 INFO - 'suite': 'dromaeojs', 23:10:52 INFO - 'system_bits': '32', 23:10:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:10:52 INFO - 'title': 'talos-linux64-ix-021', 23:10:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:10:52 INFO - 'use_talos_json': True, 23:10:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:10:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:10:52 INFO - 'work_dir': 'build'} 23:10:52 INFO - ##### 23:10:52 INFO - ##### Running clobber step. 23:10:52 INFO - ##### 23:10:52 INFO - Running pre-action listener: _resource_record_pre_action 23:10:52 INFO - Running main action method: clobber 23:10:52 INFO - rmtree: /builds/slave/test-pgo/build 23:10:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:10:52 INFO - Running post-action listener: _resource_record_post_action 23:10:52 INFO - ##### 23:10:52 INFO - ##### Running read-buildbot-config step. 23:10:52 INFO - ##### 23:10:52 INFO - Running pre-action listener: _resource_record_pre_action 23:10:52 INFO - Running main action method: read_buildbot_config 23:10:52 INFO - Using buildbot properties: 23:10:52 INFO - { 23:10:52 INFO - "project": "", 23:10:52 INFO - "product": "firefox", 23:10:52 INFO - "script_repo_revision": "production", 23:10:52 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 23:10:52 INFO - "repository": "", 23:10:52 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 23:10:52 INFO - "buildid": "20160114203113", 23:10:52 INFO - "pgo_build": "True", 23:10:52 INFO - "basedir": "/builds/slave/test-pgo", 23:10:52 INFO - "buildnumber": 1114, 23:10:52 INFO - "slavename": "talos-linux64-ix-021", 23:10:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:10:52 INFO - "platform": "ubuntu64_hw", 23:10:52 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 23:10:52 INFO - "branch": "b2g-inbound", 23:10:52 INFO - "repo_path": "integration/b2g-inbound", 23:10:52 INFO - "revision": "bedcf761e639c9041e047ebbd7fa596a37258f9c", 23:10:52 INFO - "stage_platform": "linux64-pgo", 23:10:52 INFO - "builduid": "a607bff94c7345a4b5bfe71587633ad5", 23:10:52 INFO - "slavebuilddir": "test" 23:10:52 INFO - } 23:10:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 23:10:52 INFO - Running post-action listener: _resource_record_post_action 23:10:52 INFO - ##### 23:10:52 INFO - ##### Running download-and-extract step. 23:10:52 INFO - ##### 23:10:52 INFO - Running pre-action listener: _resource_record_pre_action 23:10:52 INFO - Running main action method: download_and_extract 23:10:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:10:52 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')]} 23:10:52 INFO - https://queue.taskcluster.net/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:10:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/test_packages.json 23:10:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/test_packages.json 23:10:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:10:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:10:57 INFO - Downloaded 1448 bytes. 23:10:57 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:10:57 INFO - Using the following test package requirements: 23:10:57 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:10:57 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:10:57 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:10:57 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:57 INFO - u'jsshell-linux-x86_64.zip'], 23:10:57 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:10:57 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:10:57 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:10:57 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:10:57 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:10:57 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:10:57 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:10:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:10:57 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:10:57 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')]} 23:10:57 INFO - https://queue.taskcluster.net/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:10:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:10:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:10:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/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 23:10:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/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 23:11:00 INFO - Downloaded 24030710 bytes. 23:11:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:11:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:11:02 INFO - Return code: 0 23:11:02 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 23:11: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')]} 23:11:02 INFO - https://queue.taskcluster.net/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:11:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:11:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:11:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/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 23:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/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 23:11:05 INFO - Downloaded 24030710 bytes. 23:11:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:11:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:11:07 INFO - Return code: 0 23:11:07 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')]} 23:11:07 INFO - https://queue.taskcluster.net/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:11:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:11:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:11:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/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 23:11:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/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 23:11:09 INFO - Downloaded 11132144 bytes. 23:11:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:11:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 23:11:09 INFO - Return code: 0 23:11:09 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')]} 23:11:09 INFO - https://queue.taskcluster.net/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:11:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:11:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:11:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/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 23:11:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/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 23:11:24 INFO - Downloaded 55837503 bytes. 23:11:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:11:24 INFO - mkdir: /builds/slave/test-pgo/properties 23:11:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:11:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:11:24 INFO - Contents: 23:11:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:11:24 INFO - Running post-action listener: _resource_record_post_action 23:11:24 INFO - Running post-action listener: set_extra_try_arguments 23:11:24 INFO - ##### 23:11:24 INFO - ##### Running populate-webroot step. 23:11:24 INFO - ##### 23:11:24 INFO - Running pre-action listener: _resource_record_pre_action 23:11:24 INFO - Running main action method: populate_webroot 23:11:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:11:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:11:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:11:24 INFO - '--tppagecycles', 23:11:24 INFO - '7'], 23:11:24 INFO - 'tests': ['tsvgm']}}, 23:11:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:11:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:11:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:11:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:11:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:11:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:11:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:11:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:24 INFO - 'talos_options': ['--e10s'], 23:11:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:11:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:24 INFO - 'tests': ['damp', 'tps']}, 23:11:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:24 INFO - 'talos_options': ['--e10s'], 23:11:24 INFO - 'tests': ['damp', 'tps']}, 23:11:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:11:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:11:24 INFO - 'other': {'tests': ['a11yr', 23:11:24 INFO - 'ts_paint', 23:11:24 INFO - 'tpaint', 23:11:24 INFO - 'sessionrestore', 23:11:24 INFO - 'sessionrestore_no_auto_restore']}, 23:11:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:11:24 INFO - 'tests': ['a11yr', 23:11:24 INFO - 'ts_paint', 23:11:24 INFO - 'tpaint', 23:11:24 INFO - 'sessionrestore', 23:11:24 INFO - 'sessionrestore_no_auto_restore']}, 23:11:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:11:24 INFO - 'tests': ['a11yr', 23:11:24 INFO - 'ts_paint', 23:11:24 INFO - 'tpaint', 23:11:24 INFO - 'sessionrestore', 23:11:24 INFO - 'sessionrestore_no_auto_restore']}, 23:11:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:11:24 INFO - 'tests': ['a11yr', 23:11:24 INFO - 'ts_paint', 23:11:24 INFO - 'tpaint', 23:11:24 INFO - 'sessionrestore', 23:11:24 INFO - 'sessionrestore_no_auto_restore']}, 23:11:24 INFO - 'other_l64': {'tests': ['a11yr', 23:11:24 INFO - 'ts_paint', 23:11:24 INFO - 'tpaint', 23:11:24 INFO - 'sessionrestore', 23:11:24 INFO - 'sessionrestore_no_auto_restore']}, 23:11:24 INFO - 'other_nol64': {'tests': ['a11yr', 23:11:24 INFO - 'ts_paint', 23:11:24 INFO - 'tpaint', 23:11:24 INFO - 'sessionrestore', 23:11:24 INFO - 'sessionrestore_no_auto_restore']}, 23:11:24 INFO - 'svgr': {'tests': ['tsvgx', 23:11:24 INFO - 'tsvgr_opacity', 23:11:24 INFO - 'tart', 23:11:24 INFO - 'tscrollx', 23:11:24 INFO - 'cart']}, 23:11:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:11:24 INFO - 'tests': ['tsvgx', 23:11:24 INFO - 'tsvgr_opacity', 23:11:24 INFO - 'tart', 23:11:24 INFO - 'tscrollx', 23:11:24 INFO - 'cart']}, 23:11:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:24 INFO - 'tests': ['tp5o']}, 23:11:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:24 INFO - 'talos_options': ['--e10s'], 23:11:24 INFO - 'tests': ['tp5o']}, 23:11:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:24 INFO - 'talos_options': ['--xperf_path', 23:11:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:11:24 INFO - 'tests': ['tp5n']}, 23:11:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:24 INFO - 'talos_options': ['--e10s', 23:11:24 INFO - '--xperf_path', 23:11:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:11:24 INFO - 'tests': ['tp5n']}}, 23:11:24 INFO - 'talos.zip': {'path': '', 23:11:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:11:24 INFO - Running post-action listener: _resource_record_post_action 23:11:24 INFO - ##### 23:11:24 INFO - ##### Running create-virtualenv step. 23:11:24 INFO - ##### 23:11:24 INFO - Running pre-action listener: _resource_record_pre_action 23:11:24 INFO - Running main action method: create_virtualenv 23:11:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:11:24 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 23:11:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:11:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:11:24 INFO - Using real prefix '/usr' 23:11:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:11:24 INFO - Installing distribute.............................................................................................................................................................................................done. 23:11:26 INFO - Installing pip.................done. 23:11:26 INFO - Return code: 0 23:11:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:11:26 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')]} 23:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:26 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')]} 23:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:26 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 0x7faa34a54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d11840>, '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 0x2c7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7eb60>, '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': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', '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 23:11:26 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 23:11:26 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 23:11:26 INFO - Using env: {'DISPLAY': ':0', 23:11:26 INFO - 'HOME': '/home/cltbld', 23:11:26 INFO - 'LANG': 'en_US.UTF-8', 23:11:26 INFO - 'LANGUAGE': 'en_US:en', 23:11:26 INFO - 'LOGNAME': 'cltbld', 23:11:26 INFO - 'MAIL': '/var/mail/cltbld', 23:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:26 INFO - 'MOZ_NO_REMOTE': '1', 23:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:26 INFO - 'NO_EM_RESTART': '1', 23:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:11:26 INFO - 'PWD': '/builds/slave/test-pgo', 23:11:26 INFO - 'SHELL': '/bin/bash', 23:11:26 INFO - 'SHLVL': '1', 23:11:26 INFO - 'TERM': 'linux', 23:11:26 INFO - 'TMOUT': '86400', 23:11:26 INFO - 'USER': 'cltbld', 23:11:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', 23:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:26 INFO - '_': '/tools/buildbot/bin/python'} 23:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:26 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 23:11:26 INFO - Cleaning up... 23:11:26 INFO - Return code: 0 23:11:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:11:26 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')]} 23:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:26 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')]} 23:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:26 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 0x7faa34a54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d11840>, '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 0x2c7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7eb60>, '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': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', '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 23:11:26 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 23:11:26 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 23:11:26 INFO - Using env: {'DISPLAY': ':0', 23:11:26 INFO - 'HOME': '/home/cltbld', 23:11:26 INFO - 'LANG': 'en_US.UTF-8', 23:11:26 INFO - 'LANGUAGE': 'en_US:en', 23:11:26 INFO - 'LOGNAME': 'cltbld', 23:11:26 INFO - 'MAIL': '/var/mail/cltbld', 23:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:26 INFO - 'MOZ_NO_REMOTE': '1', 23:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:26 INFO - 'NO_EM_RESTART': '1', 23:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:11:26 INFO - 'PWD': '/builds/slave/test-pgo', 23:11:26 INFO - 'SHELL': '/bin/bash', 23:11:26 INFO - 'SHLVL': '1', 23:11:26 INFO - 'TERM': 'linux', 23:11:26 INFO - 'TMOUT': '86400', 23:11:26 INFO - 'USER': 'cltbld', 23:11:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', 23:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:26 INFO - '_': '/tools/buildbot/bin/python'} 23:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:27 INFO - Downloading/unpacking psutil>=0.7.1 23:11:27 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 23:11:27 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 23:11:27 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 23:11:27 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 23:11:27 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 23:11:27 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 23:11:28 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 23:11:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:11:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:11:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:11:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:11:28 INFO - Installing collected packages: psutil 23:11:28 INFO - Running setup.py install for psutil 23:11:29 INFO - building 'psutil._psutil_linux' extension 23:11:29 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 23:11:29 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 23:11:29 INFO - building 'psutil._psutil_posix' extension 23:11:29 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 23:11:29 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 23:11:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:11:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:11:29 INFO - Successfully installed psutil 23:11:29 INFO - Cleaning up... 23:11:29 INFO - Return code: 0 23:11:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:11:29 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')]} 23:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:29 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')]} 23:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:29 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 0x7faa34a54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d11840>, '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 0x2c7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7eb60>, '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': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', '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 23:11:29 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 23:11:29 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 23:11:29 INFO - Using env: {'DISPLAY': ':0', 23:11:29 INFO - 'HOME': '/home/cltbld', 23:11:29 INFO - 'LANG': 'en_US.UTF-8', 23:11:29 INFO - 'LANGUAGE': 'en_US:en', 23:11:29 INFO - 'LOGNAME': 'cltbld', 23:11:29 INFO - 'MAIL': '/var/mail/cltbld', 23:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:29 INFO - 'MOZ_NO_REMOTE': '1', 23:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:29 INFO - 'NO_EM_RESTART': '1', 23:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:11:29 INFO - 'PWD': '/builds/slave/test-pgo', 23:11:29 INFO - 'SHELL': '/bin/bash', 23:11:29 INFO - 'SHLVL': '1', 23:11:29 INFO - 'TERM': 'linux', 23:11:29 INFO - 'TMOUT': '86400', 23:11:29 INFO - 'USER': 'cltbld', 23:11:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', 23:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:29 INFO - '_': '/tools/buildbot/bin/python'} 23:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:11:29 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 23:11:29 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 23:11:29 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 23:11:29 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 23:11:29 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 23:11:29 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 23:11:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:11:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:11:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:11:31 INFO - Installing collected packages: mozsystemmonitor 23:11:31 INFO - Running setup.py install for mozsystemmonitor 23:11:31 INFO - Successfully installed mozsystemmonitor 23:11:31 INFO - Cleaning up... 23:11:31 INFO - Return code: 0 23:11:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:11:31 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')]} 23:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:31 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')]} 23:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:31 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 0x7faa34a54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d11840>, '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 0x2c7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7eb60>, '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': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', '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 23:11:31 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 23:11:31 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 23:11:31 INFO - Using env: {'DISPLAY': ':0', 23:11:31 INFO - 'HOME': '/home/cltbld', 23:11:31 INFO - 'LANG': 'en_US.UTF-8', 23:11:31 INFO - 'LANGUAGE': 'en_US:en', 23:11:31 INFO - 'LOGNAME': 'cltbld', 23:11:31 INFO - 'MAIL': '/var/mail/cltbld', 23:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:31 INFO - 'MOZ_NO_REMOTE': '1', 23:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:31 INFO - 'NO_EM_RESTART': '1', 23:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:11:31 INFO - 'PWD': '/builds/slave/test-pgo', 23:11:31 INFO - 'SHELL': '/bin/bash', 23:11:31 INFO - 'SHLVL': '1', 23:11:31 INFO - 'TERM': 'linux', 23:11:31 INFO - 'TMOUT': '86400', 23:11:31 INFO - 'USER': 'cltbld', 23:11:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', 23:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:31 INFO - '_': '/tools/buildbot/bin/python'} 23:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:31 INFO - Downloading/unpacking blobuploader==1.2.4 23:11:31 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 23:11:31 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 23:11:31 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 23:11:31 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 23:11:31 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 23:11:31 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 23:11:33 INFO - Downloading blobuploader-1.2.4.tar.gz 23:11:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:11:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:11:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:11:33 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 23:11:33 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 23:11:33 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 23:11:33 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 23:11:33 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 23:11:33 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 23:11:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:11:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:11:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:11:34 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 23:11:34 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 23:11:34 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 23:11:34 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 23:11:34 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 23:11:34 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 23:11:34 INFO - Downloading docopt-0.6.1.tar.gz 23:11:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:11:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:11:34 INFO - Installing collected packages: blobuploader, requests, docopt 23:11:34 INFO - Running setup.py install for blobuploader 23:11:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:11:34 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:11:34 INFO - Running setup.py install for requests 23:11:35 INFO - Running setup.py install for docopt 23:11:35 INFO - Successfully installed blobuploader requests docopt 23:11:35 INFO - Cleaning up... 23:11:35 INFO - Return code: 0 23:11:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:11:35 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')]} 23:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:35 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')]} 23:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:35 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 0x7faa34a54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d11840>, '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 0x2c7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7eb60>, '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': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', '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 23:11:35 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 23:11:35 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 23:11:35 INFO - Using env: {'DISPLAY': ':0', 23:11:35 INFO - 'HOME': '/home/cltbld', 23:11:35 INFO - 'LANG': 'en_US.UTF-8', 23:11:35 INFO - 'LANGUAGE': 'en_US:en', 23:11:35 INFO - 'LOGNAME': 'cltbld', 23:11:35 INFO - 'MAIL': '/var/mail/cltbld', 23:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:35 INFO - 'MOZ_NO_REMOTE': '1', 23:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:35 INFO - 'NO_EM_RESTART': '1', 23:11:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:11:35 INFO - 'PWD': '/builds/slave/test-pgo', 23:11:35 INFO - 'SHELL': '/bin/bash', 23:11:35 INFO - 'SHLVL': '1', 23:11:35 INFO - 'TERM': 'linux', 23:11:35 INFO - 'TMOUT': '86400', 23:11:35 INFO - 'USER': 'cltbld', 23:11:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', 23:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:35 INFO - '_': '/tools/buildbot/bin/python'} 23:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:11:35 INFO - Running setup.py (path:/tmp/pip-pcu7nC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:11:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:11:35 INFO - Running setup.py (path:/tmp/pip-GkPzuR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:11:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:11:35 INFO - Running setup.py (path:/tmp/pip-lKa9xA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:11:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:11:35 INFO - Running setup.py (path:/tmp/pip-dJJ8vs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:11:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:11:35 INFO - Running setup.py (path:/tmp/pip-d815rw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:11:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:11:35 INFO - Running setup.py (path:/tmp/pip-rwjGzU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:11:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:11:35 INFO - Running setup.py (path:/tmp/pip-SIpkWA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:11:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:11:35 INFO - Running setup.py (path:/tmp/pip-gGZmuy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:11:36 INFO - Running setup.py (path:/tmp/pip-_mDJuk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:11:36 INFO - Running setup.py (path:/tmp/pip-fwqf2m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:11:36 INFO - Running setup.py (path:/tmp/pip-x83snJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:11:36 INFO - Running setup.py (path:/tmp/pip-aaOlTo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:11:36 INFO - Running setup.py (path:/tmp/pip-cue3jM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:11:36 INFO - Running setup.py (path:/tmp/pip-UGaxFg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:11:36 INFO - Running setup.py (path:/tmp/pip-viBrUf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:11:36 INFO - Running setup.py (path:/tmp/pip-KQ45BL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:11:36 INFO - Running setup.py (path:/tmp/pip-242sm1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:11:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:11:36 INFO - Running setup.py install for manifestparser 23:11:36 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:11:36 INFO - Running setup.py install for mozcrash 23:11:36 INFO - Running setup.py install for mozdebug 23:11:36 INFO - Running setup.py install for mozdevice 23:11:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:11:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:11:37 INFO - Running setup.py install for mozfile 23:11:37 INFO - Running setup.py install for mozhttpd 23:11:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:11:37 INFO - Running setup.py install for mozinfo 23:11:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:11:37 INFO - Running setup.py install for mozInstall 23:11:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:11:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:11:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:11:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:11:37 INFO - Running setup.py install for mozleak 23:11:37 INFO - Running setup.py install for mozlog 23:11:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:11:37 INFO - Running setup.py install for moznetwork 23:11:37 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:11:37 INFO - Running setup.py install for mozprocess 23:11:37 INFO - Running setup.py install for mozprofile 23:11:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:11:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:11:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:11:38 INFO - Running setup.py install for mozrunner 23:11:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:11:38 INFO - Running setup.py install for mozscreenshot 23:11:38 INFO - Running setup.py install for moztest 23:11:38 INFO - Running setup.py install for mozversion 23:11:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:11:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:11:38 INFO - Cleaning up... 23:11:38 INFO - Return code: 0 23:11:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:11:38 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')]} 23:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:38 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')]} 23:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:38 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 0x7faa34a54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d11840>, '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 0x2c7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7eb60>, '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': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', '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 23:11:38 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 23:11:38 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 23:11:38 INFO - Using env: {'DISPLAY': ':0', 23:11:38 INFO - 'HOME': '/home/cltbld', 23:11:38 INFO - 'LANG': 'en_US.UTF-8', 23:11:38 INFO - 'LANGUAGE': 'en_US:en', 23:11:38 INFO - 'LOGNAME': 'cltbld', 23:11:38 INFO - 'MAIL': '/var/mail/cltbld', 23:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:38 INFO - 'MOZ_NO_REMOTE': '1', 23:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:38 INFO - 'NO_EM_RESTART': '1', 23:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:11:38 INFO - 'PWD': '/builds/slave/test-pgo', 23:11:38 INFO - 'SHELL': '/bin/bash', 23:11:38 INFO - 'SHLVL': '1', 23:11:38 INFO - 'TERM': 'linux', 23:11:38 INFO - 'TMOUT': '86400', 23:11:38 INFO - 'USER': 'cltbld', 23:11:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', 23:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:38 INFO - '_': '/tools/buildbot/bin/python'} 23:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:11:38 INFO - Running setup.py (path:/tmp/pip-DplnQp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:11:38 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)) 23:11:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:11:38 INFO - Running setup.py (path:/tmp/pip-M_06Lc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:11:38 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)) 23:11:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:11:38 INFO - Running setup.py (path:/tmp/pip-dZBmOI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:11:38 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)) 23:11:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:11:38 INFO - Running setup.py (path:/tmp/pip-iAB7Hu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 23:11:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:11:38 INFO - Running setup.py (path:/tmp/pip-ZS5NN4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:11:39 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)) 23:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:11:39 INFO - Running setup.py (path:/tmp/pip-qor0zN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:11:39 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)) 23:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:11:39 INFO - Running setup.py (path:/tmp/pip-CH8HZJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:11:39 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)) 23:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:11:39 INFO - Running setup.py (path:/tmp/pip-KHJZEk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:11:39 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)) 23:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:11:39 INFO - Running setup.py (path:/tmp/pip-EXxzDk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:11:39 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)) 23:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:11:39 INFO - Running setup.py (path:/tmp/pip-vdEjO_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:11:39 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)) 23:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:11:39 INFO - Running setup.py (path:/tmp/pip-ijxNwF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:11:39 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)) 23:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:11:39 INFO - Running setup.py (path:/tmp/pip-tssfoJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:11:39 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)) 23:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:11:39 INFO - Running setup.py (path:/tmp/pip-sCWkWh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:11:39 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)) 23:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:11:39 INFO - Running setup.py (path:/tmp/pip-ZCNMDu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:11:39 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)) 23:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:11:39 INFO - Running setup.py (path:/tmp/pip-qdxyQC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:11:39 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)) 23:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:11:39 INFO - Running setup.py (path:/tmp/pip-ZBK2jY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:11:39 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)) 23:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:11:39 INFO - Running setup.py (path:/tmp/pip-du_KVn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:11:39 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)) 23:11:39 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)) 23:11:39 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)) 23:11:39 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)) 23:11:39 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:11:39 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:11:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:11:39 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 23:11:39 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 23:11:39 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 23:11:39 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 23:11:39 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 23:11:39 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 23:11:41 INFO - Downloading blessings-1.5.1.tar.gz 23:11:41 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 23:11:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:11:41 INFO - Installing collected packages: blessings 23:11:41 INFO - Running setup.py install for blessings 23:11:41 INFO - Successfully installed blessings 23:11:41 INFO - Cleaning up... 23:11:41 INFO - Return code: 0 23:11:41 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:11:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:11:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:11:42 INFO - Reading from file tmpfile_stdout 23:11:42 INFO - Current package versions: 23:11:42 INFO - argparse == 1.2.1 23:11:42 INFO - blessings == 1.5.1 23:11:42 INFO - blobuploader == 1.2.4 23:11:42 INFO - docopt == 0.6.1 23:11:42 INFO - manifestparser == 1.1 23:11:42 INFO - mozInstall == 1.12 23:11:42 INFO - mozcrash == 0.16 23:11:42 INFO - mozdebug == 0.1 23:11:42 INFO - mozdevice == 0.48 23:11:42 INFO - mozfile == 1.2 23:11:42 INFO - mozhttpd == 0.7 23:11:42 INFO - mozinfo == 0.9 23:11:42 INFO - mozleak == 0.1 23:11:42 INFO - mozlog == 3.1 23:11:42 INFO - moznetwork == 0.27 23:11:42 INFO - mozprocess == 0.22 23:11:42 INFO - mozprofile == 0.28 23:11:42 INFO - mozrunner == 6.11 23:11:42 INFO - mozscreenshot == 0.1 23:11:42 INFO - mozsystemmonitor == 0.0 23:11:42 INFO - moztest == 0.7 23:11:42 INFO - mozversion == 1.4 23:11:42 INFO - psutil == 3.1.1 23:11:42 INFO - requests == 1.2.3 23:11:42 INFO - wsgiref == 0.1.2 23:11:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:11:42 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')]} 23:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:42 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')]} 23:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:42 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 0x7faa34a54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d11840>, '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 0x2c7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7eb60>, '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': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', '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 23:11:42 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 23:11:42 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 23:11:42 INFO - Using env: {'DISPLAY': ':0', 23:11:42 INFO - 'HOME': '/home/cltbld', 23:11:42 INFO - 'LANG': 'en_US.UTF-8', 23:11:42 INFO - 'LANGUAGE': 'en_US:en', 23:11:42 INFO - 'LOGNAME': 'cltbld', 23:11:42 INFO - 'MAIL': '/var/mail/cltbld', 23:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:42 INFO - 'MOZ_NO_REMOTE': '1', 23:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:42 INFO - 'NO_EM_RESTART': '1', 23:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:11:42 INFO - 'PWD': '/builds/slave/test-pgo', 23:11:42 INFO - 'SHELL': '/bin/bash', 23:11:42 INFO - 'SHLVL': '1', 23:11:42 INFO - 'TERM': 'linux', 23:11:42 INFO - 'TMOUT': '86400', 23:11:42 INFO - 'USER': 'cltbld', 23:11:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', 23:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:42 INFO - '_': '/tools/buildbot/bin/python'} 23:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:42 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)) 23:11:42 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)) 23:11:42 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)) 23:11:42 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)) 23:11:42 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)) 23:11:42 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)) 23:11:42 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)) 23:11:42 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)) 23:11:42 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)) 23:11:42 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)) 23:11:42 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)) 23:11:42 INFO - Cleaning up... 23:11:42 INFO - Return code: 0 23:11:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:11:42 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')]} 23:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:42 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')]} 23:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:42 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 0x7faa34a54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d11840>, '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 0x2c7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7eb60>, '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': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', '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 23:11:42 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 23:11:42 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 23:11:42 INFO - Using env: {'DISPLAY': ':0', 23:11:42 INFO - 'HOME': '/home/cltbld', 23:11:42 INFO - 'LANG': 'en_US.UTF-8', 23:11:42 INFO - 'LANGUAGE': 'en_US:en', 23:11:42 INFO - 'LOGNAME': 'cltbld', 23:11:42 INFO - 'MAIL': '/var/mail/cltbld', 23:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:42 INFO - 'MOZ_NO_REMOTE': '1', 23:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:42 INFO - 'NO_EM_RESTART': '1', 23:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:11:42 INFO - 'PWD': '/builds/slave/test-pgo', 23:11:42 INFO - 'SHELL': '/bin/bash', 23:11:42 INFO - 'SHLVL': '1', 23:11:42 INFO - 'TERM': 'linux', 23:11:42 INFO - 'TMOUT': '86400', 23:11:42 INFO - 'USER': 'cltbld', 23:11:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', 23:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:42 INFO - '_': '/tools/buildbot/bin/python'} 23:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:42 INFO - Downloading/unpacking jsonschema 23:11:42 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 23:11:42 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 23:11:42 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 23:11:42 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 23:11:42 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 23:11:42 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 23:11:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:11:44 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 23:11:44 INFO - Downloading/unpacking functools32 (from jsonschema) 23:11:44 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 23:11:44 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 23:11:44 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 23:11:44 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 23:11:44 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 23:11:44 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 23:11:44 INFO - Downloading functools32-3.2.3-2.tar.gz 23:11:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 23:11:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:11:44 INFO - warning: no files found matching '*.txt' 23:11:44 INFO - no previously-included directories found matching 'build' 23:11:44 INFO - no previously-included directories found matching 'dist' 23:11:44 INFO - no previously-included directories found matching '.git*' 23:11:44 INFO - Installing collected packages: jsonschema, functools32 23:11:44 INFO - Running setup.py install for functools32 23:11:44 INFO - warning: no files found matching '*.txt' 23:11:44 INFO - no previously-included directories found matching 'build' 23:11:44 INFO - no previously-included directories found matching 'dist' 23:11:44 INFO - no previously-included directories found matching '.git*' 23:11:44 INFO - Successfully installed jsonschema functools32 23:11:44 INFO - Cleaning up... 23:11:44 INFO - Return code: 0 23:11:44 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:11: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')]} 23:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11: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')]} 23:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:44 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 0x7faa34a54f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d11840>, '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 0x2c7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7eb60>, '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': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', '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 23:11:44 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 23:11:44 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 23:11:44 INFO - Using env: {'DISPLAY': ':0', 23:11:44 INFO - 'HOME': '/home/cltbld', 23:11:44 INFO - 'LANG': 'en_US.UTF-8', 23:11:44 INFO - 'LANGUAGE': 'en_US:en', 23:11:44 INFO - 'LOGNAME': 'cltbld', 23:11:44 INFO - 'MAIL': '/var/mail/cltbld', 23:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:44 INFO - 'MOZ_NO_REMOTE': '1', 23:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:11:44 INFO - 'NO_EM_RESTART': '1', 23:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:11:44 INFO - 'PWD': '/builds/slave/test-pgo', 23:11:44 INFO - 'SHELL': '/bin/bash', 23:11:44 INFO - 'SHLVL': '1', 23:11:44 INFO - 'TERM': 'linux', 23:11:44 INFO - 'TMOUT': '86400', 23:11:44 INFO - 'USER': 'cltbld', 23:11:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', 23:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:44 INFO - '_': '/tools/buildbot/bin/python'} 23:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:45 INFO - Downloading/unpacking flake8 23:11:45 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 23:11:45 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 23:11:45 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 23:11:45 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 23:11:45 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 23:11:45 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 23:11:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:11:46 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 23:11:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:11:46 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 23:11:46 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 23:11:46 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 23:11:46 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 23:11:46 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 23:11:46 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 23:11:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:11:46 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 23:11:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:11:46 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 23:11:46 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 23:11:46 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 23:11:46 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 23:11:46 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 23:11:46 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 23:11:47 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 23:11:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:11:47 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 23:11:47 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 23:11:47 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 23:11:47 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 23:11:47 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 23:11:47 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 23:11:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 23:11:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:11:47 INFO - no previously-included directories found matching 'docs/_build' 23:11:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:11:47 INFO - Running setup.py install for pep8 23:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:11:47 INFO - no previously-included directories found matching 'docs/_build' 23:11:47 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:11:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:11:47 INFO - Cleaning up... 23:11:47 INFO - Return code: 0 23:11:47 INFO - Running post-action listener: _resource_record_post_action 23:11:47 INFO - Running post-action listener: _start_resource_monitoring 23:11:47 INFO - Starting resource monitoring. 23:11:47 INFO - ##### 23:11:47 INFO - ##### Running install step. 23:11:47 INFO - ##### 23:11:47 INFO - Running pre-action listener: _resource_record_pre_action 23:11:47 INFO - Running main action method: install 23:11:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:11:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:11:47 INFO - Reading from file tmpfile_stdout 23:11:47 INFO - Detecting whether we're running mozinstall >=1.0... 23:11:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:11:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:11:47 INFO - Reading from file tmpfile_stdout 23:11:47 INFO - Output received: 23:11:47 INFO - Usage: mozinstall [options] installer 23:11:47 INFO - Options: 23:11:47 INFO - -h, --help show this help message and exit 23:11:47 INFO - -d DEST, --destination=DEST 23:11:47 INFO - Directory to install application into. [default: 23:11:47 INFO - "/builds/slave/test-pgo"] 23:11:47 INFO - --app=APP Application being installed. [default: firefox] 23:11:47 INFO - mkdir: /builds/slave/test-pgo/build/application 23:11:47 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'] 23:11:47 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 23:12:03 INFO - Reading from file tmpfile_stdout 23:12:03 INFO - Output received: 23:12:03 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:12:03 INFO - Running post-action listener: _resource_record_post_action 23:12:03 INFO - ##### 23:12:03 INFO - ##### Running run-tests step. 23:12:03 INFO - ##### 23:12:03 INFO - Running pre-action listener: _resource_record_pre_action 23:12:03 INFO - Running main action method: run_tests 23:12:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:12:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:12:03 INFO - Python 2.7.3 23:12:03 INFO - Return code: 0 23:12:03 INFO - grabbing minidump binary from tooltool 23:12:03 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')]} 23:12:03 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 0x2d11840>, '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 0x2c7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7eb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:12:03 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 23:12:03 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 23:12:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:12:04 INFO - Return code: 0 23:12:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:12:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:12:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:12:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:12:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:12:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:12:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:12:04 INFO - Return code: 0 23:12:04 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/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 23:12:04 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/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 23:12:04 INFO - Using env: {'DISPLAY': ':0', 23:12:04 INFO - 'HOME': '/home/cltbld', 23:12:04 INFO - 'LANG': 'en_US.UTF-8', 23:12:04 INFO - 'LANGUAGE': 'en_US:en', 23:12:04 INFO - 'LOGNAME': 'cltbld', 23:12:04 INFO - 'MAIL': '/var/mail/cltbld', 23:12:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:12:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:04 INFO - 'MOZ_NO_REMOTE': '1', 23:12:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:04 INFO - 'NO_EM_RESTART': '1', 23:12:04 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:12:04 INFO - 'PWD': '/builds/slave/test-pgo', 23:12:04 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:12:04 INFO - 'SHELL': '/bin/bash', 23:12:04 INFO - 'SHLVL': '1', 23:12:04 INFO - 'TERM': 'linux', 23:12:04 INFO - 'TMOUT': '86400', 23:12:04 INFO - 'USER': 'cltbld', 23:12:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635', 23:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:04 INFO - '_': '/tools/buildbot/bin/python'} 23:12:04 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/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 23:12:05 INFO - mozversion application_buildid: 20160114203113 23:12:05 INFO - mozversion application_changeset: bedcf761e639c9041e047ebbd7fa596a37258f9c 23:12:05 INFO - mozversion application_display_name: Nightly 23:12:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:12:05 INFO - mozversion application_name: Firefox 23:12:05 INFO - mozversion application_remotingname: firefox 23:12:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 23:12:05 INFO - mozversion application_vendor: Mozilla 23:12:05 INFO - mozversion application_version: 46.0a1 23:12:05 INFO - mozversion platform_buildid: 20160114203113 23:12:05 INFO - mozversion platform_changeset: bedcf761e639c9041e047ebbd7fa596a37258f9c 23:12:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 23:12:05 INFO - mozversion platform_version: 46.0a1 23:12:05 INFO - using testdate: 1452841925 23:12:05 INFO - actual date: 1452841925 23:12:05 INFO - starting webserver on 'localhost:46439' 23:12:05 INFO - SUITE-START | Running 3 tests 23:12:05 INFO - TEST-START | dromaeo_css 23:12:05 INFO - operating with platform_type : linux_ 23:12:05 INFO - Initialising browser for dromaeo_css test... 23:12:05 INFO - TEST-INFO | started process 1894 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt9kHte/profile http://localhost:46439/getInfo.html) 23:12:10 INFO - PROCESS | 1894 | __metrics Screen width/height:1600/1200 23:12:10 INFO - PROCESS | 1894 | colorDepth:24 23:12:10 INFO - PROCESS | 1894 | Browser inner width/height: 1024/697 23:12:10 INFO - PROCESS | 1894 | __metrics 23:12:10 INFO - PROCESS | 1894 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:12:10 INFO - PROCESS | 1894 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:12:11 INFO - TEST-INFO | 1894: exit 0 23:12:11 INFO - Browser initialized. 23:12:11 INFO - Running cycle 1/1 for dromaeo_css test... 23:12:11 INFO - TEST-INFO | started process 1993 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt9kHte/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:12:23 INFO - PROCESS | 1993 | RSS: Main: 150646784 23:12:23 INFO - PROCESS | 1993 | 23:13:14 INFO - PROCESS | 1993 | 1452841994936 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] 23:15:23 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:46439/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46439/tests/dromaeo/cssquery-ext.html) 23:15:24 INFO - PROCESS | 1993 | RSS: Main: 247586816 23:15:24 INFO - PROCESS | 1993 | 23:18:26 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:46439/tests/dromaeo/cssquery-ext.html (next: http://localhost:46439/tests/dromaeo/cssquery-jquery.html) 23:18:27 INFO - PROCESS | 1993 | RSS: Main: 226291712 23:18:27 INFO - PROCESS | 1993 | 23:21:29 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:46439/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46439/tests/dromaeo/cssquery-mootools.html) 23:21:29 INFO - PROCESS | 1993 | RSS: Main: 230019072 23:21:29 INFO - PROCESS | 1993 | 23:24:31 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:46439/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46439/tests/dromaeo/cssquery-prototype.html) 23:24:32 INFO - PROCESS | 1993 | RSS: Main: 210534400 23:24:32 INFO - PROCESS | 1993 | 23:27:34 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:46439/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46439/tests/dromaeo/cssquery-yui.html) 23:27:35 INFO - PROCESS | 1993 | RSS: Main: 212828160 23:27:35 INFO - PROCESS | 1993 | 23:30:37 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:46439/tests/dromaeo/cssquery-yui.html (next: http://localhost:46439/tests/dromaeo/cssquery-dojo.html) 23:30:38 INFO - PROCESS | 1993 | RSS: Main: 248070144 23:30:38 INFO - PROCESS | 1993 | 23:30:38 INFO - PROCESS | 1993 | __start_tp_report 23:30:38 INFO - PROCESS | 1993 | _x_x_mozilla_page_load 23:30:38 INFO - PROCESS | 1993 | _x_x_mozilla_page_load_details 23:30:38 INFO - PROCESS | 1993 | |i|pagename|runs| 23:30:38 INFO - PROCESS | 1993 | |0;dojo.html;3079.722824945755;3098.209956461102;3154.7318477929375;3157.36852629474;3163.14595059334;5017.5484206421415;5109.182530795074;5133.332666753321;5173.637845350822;5212.817551385698;5062.493750624935;5106.846794596158;5121.923171152435;5127.461616530257;5132.717700526469;4495.415595972519;4671.322658214565;4681.9063618727605;4747.881302967419;4748.715077095385;4609.953900460986;4679.344891715145;4699.882502937437;4722.551357621038;4810.68730532516;4660.6504512161555;4712.198926182557;4715.622750179978;4728.976355118202;4752.928706069411;4698.201305778026;4707.646926480527;4723.622110231207;4730.810767569293;4737.976310118462;4609.654275929285;4637.86086417408;4674.602658774008;4711.976440117777;4713.505081966413;5046.520580544842;5058.241263810458;5068.645194836363;5069.340985671876;5074.467180945984;5514.779408823642;5522.751476183541;5534.833954981357;5541.33503979521;5587.413321601254;5409.24270602116;5413.9729301353245;5478.698671573062;5489.1217405215375;5549.334079910396;5173.586113110942;5181.663191892515;5217.478252174828;5222.556082732972;5223;5639.436056394327;5651.208830763697;5652.7738890443925;5671.773129074873;5674.546036317085;5309.442508536626;5326.201069839555;5340.626156169031;5394.78420863169;5413.810516631899;5491.423400542965;5515.448455154453;5517.862053448615;5519.613627046068;5520.723963801794;5337.466253374631;5463.754131064032;5480;5480.671159730429;5530.6128571000445;5428.864278393072;5432.565394768409;5436.728163591804;5462.453754624506;5498.120300751861;4275.5296917339065;4289.892752681146;4294.806733696991;4298.548652391516;4333.934990975138;3773.58490566043;3815.04623844039;3834.9424758628643;3859.1316953685196;3894.7468414552964;5047.924281135786;5090.981803639287;5122.410922743932;5144.665596736275;5160.200168973815;5515.889682206413;5534.169874518854;5534.225208470817;5538.695371754592;5539.556835453154;5042.747862606855;5117.360329958755;5165.870853228699;5169.948300517022;5208.765605547759;4622.306654001926;4650.18621741194;4652.604528615038;4655.348251244828;4694.765261736899;5680.857978550569;5686.118651608925;5694.430556944272;5704.80033198836;5760.510356619734;5326.733663316896;5333.439988801275;5396.946030539644;5463.644863083887;5477.1510415885605;5658.773649053992;5686.033374326292;5692;5698.4871361576;5749.396313387201;5386.919196211981;5392.08334583114;5395.325584301962;5400.2709634200455;5400.62195646301;5422.15956526739;5481.451854814487;5497.147942068986;5519.558435325244;5573.136163894603;5254.7898084076205;5260;5263.842084737464;5269.789208431773;5279.366476022902;5244.082285599929;5251.054810134213;5259.132243179985;5274.287971123849;5286.788528458818;5162.380514338303;5226.137687281556;5249.291345668438;5283.286756288006;5312;5388.08402571556;5401.783928642811;5415.6479828811;5419.241306217212;5475.09660905946;5178.792848286026;5317.175837745156;5326.760295786621;5330.70681112527;5334.599905007062 23:30:38 INFO - PROCESS | 1993 | |1;ext.html;512.7436281859068;541.480179028133;544.1973089692704;566.4392251670846;579.3511267380532;28717.712822871767;29350;29360.265993350178;36472;36687.08282292944;39426.408603870965;39959;39966.40050399247;40266;40282.798586007106;8469.78825529362;8613.698520551781;8640.65437382504;8663.35024873137;8691.435056721293;8325.50046997179;8444.071152173256;8452;8452.070272270046;8452.957735211347;8387;8548.145185481464;8556.828863422728;8756.912430875705;8768.473891566526;8643.913560864374;8667;8722.520261385622;8726.563671816384;8730.345224108185;8565;8682.522461264627;8702.086280940473;8702.869456958151;8704.956475217647;39819;40360.39459408111;40371.79814100911;40417;40637.79681101605;3106.6116735408073;3238.77328586999;3253.5770349854606;3445.758796884219;3896.123372241251;30506.38987220243;30996.38007239865;31418.05745827629;31426.37147257065;31427.057188284387;3804.5077531558663;3866.6906647468136;3893.5133108361456;3922.8038598069984;4038.374052021941;217281;217313.22090505966;217853;218555;219027;57031.71484142553;57274;57320.14019789707;57440;61634;65398;65583;65689.6715516429;65837.34162658312;65885.67057164779;15143.697126057417;15381.846181538265;15387.307571159325;15410.229488525529;15412.614684632974;10682.57269709203;10949.343039417661;11107.777844443066;11120.499577518869;11203.60787372438;19373.32193373225;20656.690149647766;20673.793262067185;20837.479063023547;20927.162913483593;6531.804045878631;7913.564753938589;8072.4349295548745;8082.232187942136;8193.910552808995;911.8267529169436;953.1802649721234;981.4405788700515;1007.3099926550336;1057.9471026448646;27167.728322716914;27169.184924452296;27402.45195096087;27703.445931081667;28406.289842753682;1049.9265051446478;1088.080571916729;1106.6126855600637;1160.930344179352;1162.587281515067;15038.774418383733;15054.774178387333;15172.924135379473;15230.543083707507;15361.308741106677;306305;310531;310968;311101;311261;45848.3122753159;46083.76958115188;46376.5362346379;52917.47082529125;53432.46567534275;1277.904157188196;1335.5192130832893;1347.5014244729514;1348.164138234301;1357.694518733297;26410.603840942018;26598.335041624116;26625.866870665523;27197.456050878474;27201.183964481097;40231.798841005606;42599.7870010648;43343.56656433395;47998.28002580034;49105;195716.1499347516;197640;199324;199727;199820;30942.845285773426;31198;31337.216569585944;31341.21646958753;31361.8431907839;41186.79406602948;43257.56742432535;43922.560774391844;44739.77630111828;44771.77614111909;36092.819535902156;37191.814040929625;37695.434568480945;37832.810835946744;37946.241075177786;36879;37369.626303736615;37391.25217495689;37586.805121564976;37673.434898476;36914;36934.26131477409;37188.628113718514;38740.80629596834;39466;30860;33559.83220083884;33653.663463365054;33776.49335260022;33952.66047339594;23835.52328953446;24084;26581.7341826587;26885.596716048884;28164.295892602848 23:30:38 INFO - PROCESS | 1993 | |2;jquery.html;346.9219425629232;362.58665121761186;364.53703796178854;367.72788136778786;369.1969965325417;13761.243131627756;13917.652058698537;15723.292451839667;16244.75632865508;17254.48236552904;15087.547373578784;15634.530964071097;16148.192590370463;16157.272922718477;16226.513204603882;5182.611304152185;5381.596380271476;5382.730863456831;5383;5388.91916621249;4031.2340655275552;4176.1230141670285;5294.867628309304;5406.756695948672;5762.9135562966585;5677.37548869624;5883.911741323884;5941.722529656123;5945.940540594604;5946.613470124428;5922;5932.169496270526;5952.107183922403;5976.2230909981645;5979.940200598004;5109.182530795055;5223.1206948187855;5264.499872512143;5267.5259226669405;5270.262163297141;19757;19765.604687906307;19900.1044952976;20125.094370753206;20139.597208055904;2076.7611724651706;2100.9369718908456;2118.3433135727973;2137.5297434564372;2604.1927002629245;8699.086595907465;9074.909250907473;9134.406263592911;11936.45726826107;12327.198732082386;1677.9748303775452;1731.5324862287112;1735.6094878652202;1735.9132043397906;1765.0733364983357;49571.25643115356;51374.486255137344;59886;60634.393656063316;66664.66667666631;14477.131372117707;15052.247387630574;15172.393104275927;15218.847811521742;15235.466758663393;23116.53766924652;23213.76786232116;23384.298471045895;23402.18092366793;23417.531649366916;8665.306775457948;8785.472871627722;8790.824183516423;8805;8834.55827208637;7346.77959661211;7449.88825167623;7480.476366654282;7516.6993320267675;7532.39740820733;7747.225277472207;7756.4182686298755;7776.261255180749;7827.843443131105;7837.49056311338;2442;2449.8530088194766;2980.3145276586506;3038.62017247844;3044.588980487606;808.8058865872148;879.6085741844818;903.4940433357341;969.3553786731744;995.9053889880449;15782.289796959165;16422.114568246612;16451.177441128137;16538.338466461206;16828.15859207059;866.4706792511223;892.0455113029126;906.6826610686207;907.5598334807613;978.7993461340408;8682.088380720059;8851;8966;9083.68207112748;9098.590563424661;363871;367638;369801;369989;477980;59948.40051599428;65662;67527;68018;69402.3059769406;1150.2983180260035;1162.9825552616549;1170.403094421851;1191.3149938785234;1191.5472120594118;14897.702045959237;15061.548153555412;15304;15347.769783453034;15395.923020384826;32352.83823580867;32712.34575308528;33559.496607551395;33640.49539256962;33645;42817.78591107149;43076;43507.34738978855;43803.342949856415;43891;7025.894611580728;7241.131064272321;7256.854862902818;7302.780916572511;7372.557646541225;9246.4914429707;9922.900770992197;10702.304350217211;10742.946285268523;11017.173711971474;7333.046703928455;8454.492730436194;9276.25789936817;9359.438433694;9479.336446448959;9409.811803763749;9466.432014079177;9470.857937131086;9630.855537167088;9765.316427850266;9833.508324583885;10208.336458130198;10411.791764164826;10466.581336746749;10563.366198028143;6932.064171337007;7100.218975912542;7108.680109394986;7261.854762904818;7362.595057271901;8899.377043606886;9233.676821311223;9473.905260947578;9609.951950240204;9651.565679544578 23:30:38 INFO - PROCESS | 1993 | |3;mootools.html;1313.8226339444172;1443.7906503556983;1449.0943160524669;1599.808023037235;1752.702040653089;6927.341902519259;7548.056492938383;7620.847583048336;7666.3483603893665;7678.462507624468;7571.31858132768;7725.111612164589;7736.458447908634;7772.48436554872;7784.9221507784905;2032.5223572460459;2074.2843718917024;2272.556851413975;2308.7575804540534;2333.4749681321737;2322.953540929189;2328.1851352026824;2329.114936324203;2332.265336419031;2334.3580515358326;2240.473488730147;2309.2494939144763;2311.318161142467;2312.28319221042;2313.8611683298973;2255.751867294596;2289.0271634555247;2318.211807985285;2319.7680231976838;2327.104064935012;2302.067662596651;2319.153508969231;2334.26470661741;2342.5900467418305;2346.249200255919;7774.572398518079;7834.4124190685925;7843.529388236724;7855.5286682799215;7903.486273392211;4803.471618122004;4946.826861059882;4951.480094590052;4956.479569645207;4957.405111386656;3041.0724728957657;3089.243135431811;3143.669914658951;3145.528170774402;3154.0853152585723;973.8539219117118;980.13258266434;1007.249599048706;1014.5485259059722;1018.3075508654113;10915.345079295268;10930.398828064453;10933.781324373547;10935.070519005814;10935.28920620157;4344.847930322424;4401.273789824707;4441.178381999341;4456;4501.729896206172;9361.110694484014;9384.671536496326;9385.530723463937;9396;9397.718068457958;4912.926306105412;4933.210686290248;4943.480934501826;4944.975275123673;4947.084789313916;4421.005273813366;4444.777761111932;4505.346724724962;4507.143642707875;4509.549045095464;3476.947845782315;3571.2678900825267;3739.495168152319;3765.811709414518;3784.6972242220554;1183.988160118388;1214.1622280626339;1220.0849362977767;1230.3356187658744;1235.1909499277808;876.0037543018158;885.6988623867916;891.5408564589242;892.9910700892908;1298.2924306252926;7444.441666875006;7491.10106787189;7493.363064139609;7497.550146991198;7502.62486875654;1112.9554817807198;1123.1969142063465;1137.4710759496709;1152.4007516091585;1166.3060479014973;5758.280214973129;5809.796657116981;5826.038703613856;5851.531877449794;5859.794907178229;8895.377323587416;9077.409968352036;9086.545672716338;9108.908910910806;9201.585928633227;9060.275177985744;9074.546272686339;9081.364304498622;9108.225800807006;9110.316726245557;7212.495125341281;7481.21447248042;7538.472306938571;7552.471327007057;7556.093268807778;7406.44451666138;7426.74006409773;7459.179490256176;7502.774916752506;7509.5869727163345;8409.495430274203;8468.195521425454;8529.616167272363;8680.869786953075;8692.826143476968;8658.956705216433;8886.422382545114;8890.955545222232;8898.911010890068;8916.019237883698;6218.844528886814;6831.9658401707675;6929.5842249465195;6948.756793512202;6951.721931122698;6848.041274221712;7234.276572342724;7407;7408.740694075682;7411.888821667571;6626.933730662631;6922.688479018557;6938.826529336807;6985.615791131537;6996.090508233897;6916.827079323057;6939.16729992384;6974.511784175059;7021;7045.330693584101;6929.549579277331;6956.304369563206;6997.510174287751;7003.229644739176;7012.298770122947;6461.676916154268;6500.122483464861;6508.251551071688;6512.641804700787;6512.674366281762;6319.873602528016;6375.234971803413;6379.138816259746;6381.712822923072;6383.39357761012 23:30:38 INFO - PROCESS | 1993 | |4;prototype.html;342.43156360441657;343.8280859570215;346.20373141773916;350.5582965463515;352.0424445508217;5653.321601407826;5864.970675146624;5882.5588080893895;5912.822615321536;5950.345461999187;5619.859503512414;5774.624649397797;5781.508571771405;5805.506531944779;5827.125931110336;4554.749488778124;4568.817247310104;4576.130535198302;4577.748223847687;4580.725156490605;4401.36180253863;4482;4482.23801953667;4551.112533056055;4575.428071491064;4488.708233964798;4495.190865644183;4497.797599108048;4509.887252818689;4511.278195488722;4520.570545798144;4548.340490628841;4554.27131658933;4560.361549383089;4578.793954272066;4013.4381186633896;4017.975416268862;4020.577839326887;4022.054817117975;4025.81883815229;5486.1222204447095;5609.0184217762135;5624.746886390122;5642.605017648766;5649.067903795869;5251.4485978972425;5251.579873610102;5258.658187217857;5260.105782017066;5290.338707661543;5960.374160713106;6268.78059267928;6273.62358258506;6280.811575652738;6284.18305620271;4311.504177019651;4368.803403846835;4375.7155784873885;4381.6494680425485;4395.648348132142;6361.777337793155;6422.389872962108;6444.258910225337;6466.127072845153;6510.804675859732;4581.266997280486;4584.33527138563;4588.311753236974;4589.265717485253;4593.966357569587;4543.932175938652;4628.259478483426;4630.6758526902795;4634.443866736014;4657.953420465819;5237.580993520509;5238.842834714965;5284.550813180846;5289.20661900718;5291.470852914755;6233.75064997395;6269.247690277196;6269.937300627026;6290.370962903765;6290.402411770874;1633.86112180466;1641.7455294429383;1645.654412573373;1645.6708658268155;1649.2825620854967;1119.0767616716241;1119.8096323625002;1135.7047167736448;1147.7073346296809;1150.6260465348796;5939.613925094855;5944.316403613553;5948.702564871739;5952.434518720715;5956.2852457704485;6397.936020639734;6435.742570297136;6441.5490915635455;6443.742250309935;6444.194475690539;5817.883642327214;5929.110633405024;5939.049752039653;5941.287045554561;5944.197533332945;3445.4659527773233;3471.7743346682387;3474.6351633078666;3482.303539292101;3483.216276337854;6678.7328506859185;6707.865842683119;6712.362325579063;6713.362230588086;6721;6498.447631951242;6522.445592124628;6531.0856480092825;6535.901961470582;6535.967320163464;6507.349265073455;6668.933310666928;6672.165979252496;6687.331266873371;6689.230738465041;6231.283402408781;6379.553431259953;6419.935800641933;6460.418562329413;6493.512986525935;6304.936950630618;6396.136521569529;6399.776007839703;6420.357964203729;6432.903506447314;6726.730930762715;6737.157855268091;6747.055412242388;6752.763653272112;6755.3582409671;4312.676549258756;4605.148047611203;4612.100640375094;4616.3306320584;4620.09908067937;6351.3331100235655;6358.713857876499;6361.586496877688;6361.61830290184;6374.553781235269;6190.690465476799;6202.81391558254;6205.348438414082;6258.874822503433;6263.27972283175;6097;6180.042093475518;6255;6256.343083976299;6258.342873998165;6095.177151084724;6097.4207450293925;6104.664243466652;6150.969245153746;6169;6360.141380913703;6363.745450181941;6368.363163683594;6369.840753981188;6377.585456945284;6109.48069414087;6157.199564056644;6192.659403732658;6216.378362163748;6220.066989951543 23:30:38 INFO - PROCESS | 1993 | |5;yui.html;712.405141706675;761.4974117082724;828.1345993436857;829.5769157729558;834.3325339728219;12868.871311286895;12938.935305323472;12979.870201297985;12983.610491685253;13040.21758694479;12673.809892851592;12692.3653817309;12712.93643531781;12719.809202861965;12742.617721468348;650.0282078292947;665.2150462454302;666.1839246922506;666.5634009723639;667.8931370980644;785.3834739729314;796.6932730898587;799.856025915335;800.1838125112411;803.8432505661369;822.6750433578733;823.8599438095538;832.8958880139983;833.954132522711;836.6862426590029;680.1124532485105;824.9917500825005;829.2619568583965;830.6718846055804;832.8584140696066;509.4447052712524;606.6390497653889;613.9416755408274;614.708013693492;615.0804547201917;12627.05297102721;12699.174553654075;12721.491140354376;12752.617421477371;12792.680182995406;11618.302901825917;12259.448324825315;12382.75234495314;12395.566155184526;12434.875651243463;10132.986701329883;10157.847632285522;10208.897911020944;10209.795804083877;10258;3471.0801637566065;3515.5254040704435;3518.190816112283;3518.9648103518894;3524.0661224775454;45723.31415028744;46033.30950035752;46889.29666055012;47265.76367118177;47352;9814.950925245328;9955.352902061342;10048.156328975409;10210.387376757419;10660.733481662865;18819.71770423445;18941.337053203348;18962.71555926662;18967.71548426775;19031.1435985381;7341.375983041395;7417.59203243816;7442.702291908371;7506.662200201004;7531.8117047073165;4225.218334608107;4302.569743025672;4304.849330273488;4311;4345.652347812167;3037.4228896509594;3097.272141046852;3098.8450577471035;3106.456370135217;3109.3936682347176;540.5108376918895;549.5713343592005;552.7844140785097;563.6589863132828;568.4457653787524;501.1605560685837;590.7755053079802;612.1277180018456;615.5814046448459;621.6705146272483;8399.328053755686;8419.705310314232;8503.532305723122;8790.736277911545;9589.328746987643;481.5160763432798;539.9028174928472;549.3682265394748;549.8048192891546;607.0420856018733;3779.4708740776314;3896.59085795993;4079.8776036718946;4113.197926404382;4151.97924010384;50366;51145.488545114815;51279.48720512747;51365.74317128465;51592.22611660828;45779;49773.253401199014;49845.50154498409;49965.75017124891;50001.74999124981;43375.78312108419;44175.558244417785;44985.325220121726;44991.77504112459;46424.07151857011;8428;8435.873461897954;8837.248833849195;9078.727638170865;9115.680951166678;30195;30256.54615180818;30672.539911901786;31676.208094797814;31927.840360798047;39742.40386394149;40049.399259010555;41632.791836040626;43392;43955.560444395145;10636.30863993838;10660.573577056832;10696.358218506915;10740.83888741685;10846.13230941507;12360.4437800301;12624.11631185845;12672.6831829205;13047.412866420844;13067.738645226853;11085.667429977113;11510.136739744385;11660.53357865676;11836.408179591159;12032.75934481288;10904.618338358438;11407.486663100346;11470.369129697947;11685.591004314809;11794.764104717686;10895.891041089804;11060.446977651247;11103.944480277547;11142.387168705798;11193.944030279796;8890.377673562789;9269.907300926905;9273.536323183678;9275.39709918853;9418.105279998663;8434.409591328547;8619.353548483763;8957.14907083826;9210.263178945803;9684.85472717924 23:30:38 INFO - PROCESS | 1993 | __end_tp_report 23:30:38 INFO - PROCESS | 1993 | __start_cc_report 23:30:38 INFO - PROCESS | 1993 | _x_x_mozilla_cycle_collect,848 23:30:38 INFO - PROCESS | 1993 | __end_cc_report 23:30:38 INFO - PROCESS | 1993 | __startTimestamp1452843038032__endTimestamp 23:30:38 INFO - PROCESS | 1993 | 23:30:38 INFO - PROCESS | 1993 | ------- Summary: start ------- 23:30:38 INFO - PROCESS | 1993 | Number of tests: 6 23:30:38 INFO - PROCESS | 1993 | 23:30:38 INFO - PROCESS | 1993 | [#0] dojo.html Cycles:165 Average:5100.75 Median:5259.13 stddev:546.64 (10.4%) stddev-sans-first:524.82 23:30:38 INFO - PROCESS | 1993 | Values: 3079.7 3098.2 3154.7 3157.4 3163.1 5017.5 5109.2 5133.3 5173.6 5212.8 5062.5 5106.8 5121.9 5127.5 5132.7 4495.4 4671.3 4681.9 4747.9 4748.7 4610.0 4679.3 4699.9 4722.6 4810.7 4660.7 4712.2 4715.6 4729.0 4752.9 4698.2 4707.6 4723.6 4730.8 4738.0 4609.7 4637.9 4674.6 4712.0 4713.5 5046.5 5058.2 5068.6 5069.3 5074.5 5514.8 5522.8 5534.8 5541.3 5587.4 5409.2 5414.0 5478.7 5489.1 5549.3 5173.6 5181.7 5217.5 5222.6 5223.0 5639.4 5651.2 5652.8 5671.8 5674.5 5309.4 5326.2 5340.6 5394.8 5413.8 5491.4 5515.4 5517.9 5519.6 5520.7 5337.5 5463.8 5480.0 5480.7 5530.6 5428.9 5432.6 5436.7 5462.5 5498.1 4275.5 4289.9 4294.8 4298.5 4333.9 3773.6 3815.0 3834.9 3859.1 3894.7 5047.9 5091.0 5122.4 5144.7 5160.2 5515.9 5534.2 5534.2 5538.7 5539.6 5042.7 5117.4 5165.9 5169.9 5208.8 4622.3 4650.2 4652.6 4655.3 4694.8 5680.9 5686.1 5694.4 5704.8 5760.5 5326.7 5333.4 5396.9 5463.6 5477.2 5658.8 5686.0 5692.0 5698.5 5749.4 5386.9 5392.1 5395.3 5400.3 5400.6 5422.2 5481.5 5497.1 5519.6 5573.1 5254.8 5260.0 5263.8 5269.8 5279.4 5244.1 5251.1 5259.1 5274.3 5286.8 5162.4 5226.1 5249.3 5283.3 5312.0 5388.1 5401.8 5415.6 5419.2 5475.1 5178.8 5317.2 5326.8 5330.7 5334.6 23:30:38 INFO - PROCESS | 1993 | 23:30:38 INFO - PROCESS | 1993 | [#1] ext.html Cycles:180 Average:42010.38 Median:37190.22 stddev:64443.02 (173.3%) stddev-sans-first:64548.47 23:30:38 INFO - PROCESS | 1993 | Values: 512.7 541.5 544.2 566.4 579.4 28717.7 29350.0 29360.3 36472.0 36687.1 39426.4 39959.0 39966.4 40266.0 40282.8 8469.8 8613.7 8640.7 8663.4 8691.4 8325.5 8444.1 8452.0 8452.1 8453.0 8387.0 8548.1 8556.8 8756.9 8768.5 8643.9 8667.0 8722.5 8726.6 8730.3 8565.0 8682.5 8702.1 8702.9 8705.0 39819.0 40360.4 40371.8 40417.0 40637.8 3106.6 3238.8 3253.6 3445.8 3896.1 30506.4 30996.4 31418.1 31426.4 31427.1 3804.5 3866.7 3893.5 3922.8 4038.4 217281.0 217313.2 217853.0 218555.0 219027.0 57031.7 57274.0 57320.1 57440.0 61634.0 65398.0 65583.0 65689.7 65837.3 65885.7 15143.7 15381.8 15387.3 15410.2 15412.6 10682.6 10949.3 11107.8 11120.5 11203.6 19373.3 20656.7 20673.8 20837.5 20927.2 6531.8 7913.6 8072.4 8082.2 8193.9 911.8 953.2 981.4 1007.3 1057.9 27167.7 27169.2 27402.5 27703.4 28406.3 1049.9 1088.1 1106.6 1160.9 1162.6 15038.8 15054.8 15172.9 15230.5 15361.3 306305.0 310531.0 310968.0 311101.0 311261.0 45848.3 46083.8 46376.5 52917.5 53432.5 1277.9 1335.5 1347.5 1348.2 1357.7 26410.6 26598.3 26625.9 27197.5 27201.2 40231.8 42599.8 43343.6 47998.3 49105.0 195716.1 197640.0 199324.0 199727.0 199820.0 30942.8 31198.0 31337.2 31341.2 31361.8 41186.8 43257.6 43922.6 44739.8 44771.8 36092.8 37191.8 37695.4 37832.8 37946.2 36879.0 37369.6 37391.3 37586.8 37673.4 36914.0 36934.3 37188.6 38740.8 39466.0 30860.0 33559.8 33653.7 33776.5 33952.7 23835.5 24084.0 26581.7 26885.6 28164.3 23:30:38 INFO - PROCESS | 1993 | 23:30:38 INFO - PROCESS | 1993 | [#2] jquery.html Cycles:180 Average:23740.25 Median:5243.81 stddev:64221.64 (1224.7%) stddev-sans-first:64377.77 23:30:38 INFO - PROCESS | 1993 | Values: 346.9 362.6 364.5 367.7 369.2 13761.2 13917.7 15723.3 16244.8 17254.5 15087.5 15634.5 16148.2 16157.3 16226.5 5182.6 5381.6 5382.7 5383.0 5388.9 4031.2 4176.1 5294.9 5406.8 5762.9 5677.4 5883.9 5941.7 5945.9 5946.6 5922.0 5932.2 5952.1 5976.2 5979.9 5109.2 5223.1 5264.5 5267.5 5270.3 19757.0 19765.6 19900.1 20125.1 20139.6 2076.8 2100.9 2118.3 2137.5 2604.2 8699.1 9074.9 9134.4 11936.5 12327.2 1678.0 1731.5 1735.6 1735.9 1765.1 49571.3 51374.5 59886.0 60634.4 66664.7 14477.1 15052.2 15172.4 15218.8 15235.5 23116.5 23213.8 23384.3 23402.2 23417.5 8665.3 8785.5 8790.8 8805.0 8834.6 7346.8 7449.9 7480.5 7516.7 7532.4 7747.2 7756.4 7776.3 7827.8 7837.5 2442.0 2449.9 2980.3 3038.6 3044.6 808.8 879.6 903.5 969.4 995.9 15782.3 16422.1 16451.2 16538.3 16828.2 866.5 892.0 906.7 907.6 978.8 8682.1 8851.0 8966.0 9083.7 9098.6 363871.0 367638.0 369801.0 369989.0 477980.0 59948.4 65662.0 67527.0 68018.0 69402.3 1150.3 1163.0 1170.4 1191.3 1191.5 14897.7 15061.5 15304.0 15347.8 15395.9 32352.8 32712.3 33559.5 33640.5 33645.0 42817.8 43076.0 43507.3 43803.3 43891.0 7025.9 7241.1 7256.9 7302.8 7372.6 9246.5 9922.9 10702.3 10742.9 11017.2 7333.0 8454.5 9276.3 9359.4 9479.3 9409.8 9466.4 9470.9 9630.9 9765.3 9833.5 10208.3 10411.8 10466.6 10563.4 6932.1 7100.2 7108.7 7261.9 7362.6 8899.4 9233.7 9473.9 9610.0 9651.6 23:30:38 INFO - PROCESS | 1993 | 23:30:38 INFO - PROCESS | 1993 | [#3] mootools.html Cycles:180 Average:5493.62 Median:6480.90 stddev:2833.88 (43.7%) stddev-sans-first:2824.41 23:30:38 INFO - PROCESS | 1993 | Values: 1313.8 1443.8 1449.1 1599.8 1752.7 6927.3 7548.1 7620.8 7666.3 7678.5 7571.3 7725.1 7736.5 7772.5 7784.9 2032.5 2074.3 2272.6 2308.8 2333.5 2323.0 2328.2 2329.1 2332.3 2334.4 2240.5 2309.2 2311.3 2312.3 2313.9 2255.8 2289.0 2318.2 2319.8 2327.1 2302.1 2319.2 2334.3 2342.6 2346.2 7774.6 7834.4 7843.5 7855.5 7903.5 4803.5 4946.8 4951.5 4956.5 4957.4 3041.1 3089.2 3143.7 3145.5 3154.1 973.9 980.1 1007.2 1014.5 1018.3 10915.3 10930.4 10933.8 10935.1 10935.3 4344.8 4401.3 4441.2 4456.0 4501.7 9361.1 9384.7 9385.5 9396.0 9397.7 4912.9 4933.2 4943.5 4945.0 4947.1 4421.0 4444.8 4505.3 4507.1 4509.5 3476.9 3571.3 3739.5 3765.8 3784.7 1184.0 1214.2 1220.1 1230.3 1235.2 876.0 885.7 891.5 893.0 1298.3 7444.4 7491.1 7493.4 7497.6 7502.6 1113.0 1123.2 1137.5 1152.4 1166.3 5758.3 5809.8 5826.0 5851.5 5859.8 8895.4 9077.4 9086.5 9108.9 9201.6 9060.3 9074.5 9081.4 9108.2 9110.3 7212.5 7481.2 7538.5 7552.5 7556.1 7406.4 7426.7 7459.2 7502.8 7509.6 8409.5 8468.2 8529.6 8680.9 8692.8 8659.0 8886.4 8891.0 8898.9 8916.0 6218.8 6832.0 6929.6 6948.8 6951.7 6848.0 7234.3 7407.0 7408.7 7411.9 6626.9 6922.7 6938.8 6985.6 6996.1 6916.8 6939.2 6974.5 7021.0 7045.3 6929.5 6956.3 6997.5 7003.2 7012.3 6461.7 6500.1 6508.3 6512.6 6512.7 6319.9 6375.2 6379.1 6381.7 6383.4 23:30:38 INFO - PROCESS | 1993 | 23:30:38 INFO - PROCESS | 1993 | [#4] prototype.html Cycles:180 Average:5241.88 Median:5934.08 stddev:1549.11 (26.1%) stddev-sans-first:1509.17 23:30:38 INFO - PROCESS | 1993 | Values: 342.4 343.8 346.2 350.6 352.0 5653.3 5865.0 5882.6 5912.8 5950.3 5619.9 5774.6 5781.5 5805.5 5827.1 4554.7 4568.8 4576.1 4577.7 4580.7 4401.4 4482.0 4482.2 4551.1 4575.4 4488.7 4495.2 4497.8 4509.9 4511.3 4520.6 4548.3 4554.3 4560.4 4578.8 4013.4 4018.0 4020.6 4022.1 4025.8 5486.1 5609.0 5624.7 5642.6 5649.1 5251.4 5251.6 5258.7 5260.1 5290.3 5960.4 6268.8 6273.6 6280.8 6284.2 4311.5 4368.8 4375.7 4381.6 4395.6 6361.8 6422.4 6444.3 6466.1 6510.8 4581.3 4584.3 4588.3 4589.3 4594.0 4543.9 4628.3 4630.7 4634.4 4658.0 5237.6 5238.8 5284.6 5289.2 5291.5 6233.8 6269.2 6269.9 6290.4 6290.4 1633.9 1641.7 1645.7 1645.7 1649.3 1119.1 1119.8 1135.7 1147.7 1150.6 5939.6 5944.3 5948.7 5952.4 5956.3 6397.9 6435.7 6441.5 6443.7 6444.2 5817.9 5929.1 5939.0 5941.3 5944.2 3445.5 3471.8 3474.6 3482.3 3483.2 6678.7 6707.9 6712.4 6713.4 6721.0 6498.4 6522.4 6531.1 6535.9 6536.0 6507.3 6668.9 6672.2 6687.3 6689.2 6231.3 6379.6 6419.9 6460.4 6493.5 6304.9 6396.1 6399.8 6420.4 6432.9 6726.7 6737.2 6747.1 6752.8 6755.4 4312.7 4605.1 4612.1 4616.3 4620.1 6351.3 6358.7 6361.6 6361.6 6374.6 6190.7 6202.8 6205.3 6258.9 6263.3 6097.0 6180.0 6255.0 6256.3 6258.3 6095.2 6097.4 6104.7 6151.0 6169.0 6360.1 6363.7 6368.4 6369.8 6377.6 6109.5 6157.2 6192.7 6216.4 6220.1 23:30:38 INFO - PROCESS | 1993 | 23:30:38 INFO - PROCESS | 1993 | [#5] yui.html Cycles:180 Average:13225.47 Median:44988.55 stddev:14881.54 (33.1%) stddev-sans-first:14893.61 23:30:38 INFO - PROCESS | 1993 | Values: 712.4 761.5 828.1 829.6 834.3 12868.9 12938.9 12979.9 12983.6 13040.2 12673.8 12692.4 12712.9 12719.8 12742.6 650.0 665.2 666.2 666.6 667.9 785.4 796.7 799.9 800.2 803.8 822.7 823.9 832.9 834.0 836.7 680.1 825.0 829.3 830.7 832.9 509.4 606.6 613.9 614.7 615.1 12627.1 12699.2 12721.5 12752.6 12792.7 11618.3 12259.4 12382.8 12395.6 12434.9 10133.0 10157.8 10208.9 10209.8 10258.0 3471.1 3515.5 3518.2 3519.0 3524.1 45723.3 46033.3 46889.3 47265.8 47352.0 9815.0 9955.4 10048.2 10210.4 10660.7 18819.7 18941.3 18962.7 18967.7 19031.1 7341.4 7417.6 7442.7 7506.7 7531.8 4225.2 4302.6 4304.8 4311.0 4345.7 3037.4 3097.3 3098.8 3106.5 3109.4 540.5 549.6 552.8 563.7 568.4 501.2 590.8 612.1 615.6 621.7 8399.3 8419.7 8503.5 8790.7 9589.3 481.5 539.9 549.4 549.8 607.0 3779.5 3896.6 4079.9 4113.2 4152.0 50366.0 51145.5 51279.5 51365.7 51592.2 45779.0 49773.3 49845.5 49965.8 50001.7 43375.8 44175.6 44985.3 44991.8 46424.1 8428.0 8435.9 8837.2 9078.7 9115.7 30195.0 30256.5 30672.5 31676.2 31927.8 39742.4 40049.4 41632.8 43392.0 43955.6 10636.3 10660.6 10696.4 10740.8 10846.1 12360.4 12624.1 12672.7 13047.4 13067.7 11085.7 11510.1 11660.5 11836.4 12032.8 10904.6 11407.5 11470.4 11685.6 11794.8 10895.9 11060.4 11103.9 11142.4 11193.9 8890.4 9269.9 9273.5 9275.4 9418.1 8434.4 8619.4 8957.1 9210.3 9684.9 23:30:38 INFO - PROCESS | 1993 | -------- Summary: end -------- 23:30:38 INFO - PROCESS | 1993 | 23:30:38 INFO - TEST-INFO | 1993: exit 0 23:30:38 INFO - TEST-OK | dromaeo_css | took 1113580ms 23:30:38 INFO - TEST-START | kraken 23:30:38 INFO - operating with platform_type : linux_ 23:30:38 INFO - Initialising browser for kraken test... 23:30:38 INFO - TEST-INFO | started process 2187 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMgBonE/profile http://localhost:46439/getInfo.html) 23:30:43 INFO - PROCESS | 2187 | __metrics Screen width/height:1600/1200 23:30:43 INFO - PROCESS | 2187 | colorDepth:24 23:30:43 INFO - PROCESS | 2187 | Browser inner width/height: 1024/697 23:30:43 INFO - PROCESS | 2187 | __metrics 23:30:43 INFO - PROCESS | 2187 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:30:43 INFO - PROCESS | 2187 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:30:44 INFO - TEST-INFO | 2187: exit 0 23:30:44 INFO - Browser initialized. 23:30:44 INFO - Running cycle 1/1 for kraken test... 23:30:44 INFO - TEST-INFO | started process 2272 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMgBonE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:30:56 INFO - PROCESS | 2272 | RSS: Main: 148869120 23:30:56 INFO - PROCESS | 2272 | 23:30:58 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:46439/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46439/tests/kraken/driver.html?testName=audio-beat-detection) 23:30:59 INFO - PROCESS | 2272 | RSS: Main: 187060224 23:30:59 INFO - PROCESS | 2272 | 23:31:01 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:46439/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46439/tests/kraken/driver.html?testName=audio-dft) 23:31:02 INFO - PROCESS | 2272 | RSS: Main: 176099328 23:31:02 INFO - PROCESS | 2272 | 23:31:05 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:46439/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46439/tests/kraken/driver.html?testName=audio-fft) 23:31:05 INFO - PROCESS | 2272 | RSS: Main: 161701888 23:31:05 INFO - PROCESS | 2272 | 23:31:07 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:46439/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46439/tests/kraken/driver.html?testName=audio-oscillator) 23:31:08 INFO - PROCESS | 2272 | RSS: Main: 163528704 23:31:08 INFO - PROCESS | 2272 | 23:31:10 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:46439/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46439/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:31:11 INFO - PROCESS | 2272 | RSS: Main: 166506496 23:31:11 INFO - PROCESS | 2272 | 23:31:14 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:46439/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46439/tests/kraken/driver.html?testName=imaging-darkroom) 23:31:14 INFO - PROCESS | 2272 | RSS: Main: 166187008 23:31:14 INFO - PROCESS | 2272 | 23:31:18 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:46439/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46439/tests/kraken/driver.html?testName=imaging-desaturate) 23:31:18 INFO - PROCESS | 2272 | RSS: Main: 166473728 23:31:18 INFO - PROCESS | 2272 | 23:31:21 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:46439/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46439/tests/kraken/driver.html?testName=json-parse-financial) 23:31:22 INFO - PROCESS | 2272 | RSS: Main: 165380096 23:31:22 INFO - PROCESS | 2272 | 23:31:23 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:46439/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46439/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:31:24 INFO - PROCESS | 2272 | RSS: Main: 175984640 23:31:24 INFO - PROCESS | 2272 | 23:31:26 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:46439/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46439/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:31:26 INFO - PROCESS | 2272 | RSS: Main: 175005696 23:31:26 INFO - PROCESS | 2272 | 23:31:28 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:46439/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46439/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:31:29 INFO - PROCESS | 2272 | RSS: Main: 183922688 23:31:29 INFO - PROCESS | 2272 | 23:31:31 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:46439/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46439/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:31:32 INFO - PROCESS | 2272 | RSS: Main: 190406656 23:31:32 INFO - PROCESS | 2272 | 23:31:34 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:46439/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46439/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:31:35 INFO - PROCESS | 2272 | RSS: Main: 186564608 23:31:35 INFO - PROCESS | 2272 | 23:31:36 INFO - PROCESS | 2272 | Cycle 1(1): loaded http://localhost:46439/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46439/tests/kraken/driver.html?testName=ai-astar) 23:31:37 INFO - PROCESS | 2272 | RSS: Main: 245567488 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | __start_tp_report 23:31:37 INFO - PROCESS | 2272 | _x_x_mozilla_page_load 23:31:37 INFO - PROCESS | 2272 | _x_x_mozilla_page_load_details 23:31:37 INFO - PROCESS | 2272 | |i|pagename|runs| 23:31:37 INFO - PROCESS | 2272 | |0;ai-astar;109;109;103;109;108;109;98;110;109;109 23:31:37 INFO - PROCESS | 2272 | |1;audio-beat-detection;154;132;151;168;129;150;152;126;167;128 23:31:37 INFO - PROCESS | 2272 | |2;audio-dft;161;161;161;161;162;160;161;164;163;163 23:31:37 INFO - PROCESS | 2272 | |3;audio-fft;71;72;110;95;72;71;72;128;92;73 23:31:37 INFO - PROCESS | 2272 | |4;audio-oscillator;95;95;144;95;95;95;140;95;96;137 23:31:37 INFO - PROCESS | 2272 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;110;110;109 23:31:37 INFO - PROCESS | 2272 | |6;imaging-darkroom;146;147;146;147;145;147;146;146;146;147 23:31:37 INFO - PROCESS | 2272 | |7;imaging-desaturate;95;96;95;96;96;96;96;96;95;95 23:31:37 INFO - PROCESS | 2272 | |8;json-parse-financial;56;57;57;56;55;55;57;66;54;55 23:31:37 INFO - PROCESS | 2272 | |9;json-stringify-tinderbox;67;68;69;68;69;68;68;69;68;69 23:31:37 INFO - PROCESS | 2272 | |10;stanford-crypto-aes;80;82;85;84;82;80;80;82;83;81 23:31:37 INFO - PROCESS | 2272 | |11;stanford-crypto-ccm;119;117;117;114;119;116;123;119;114;119 23:31:37 INFO - PROCESS | 2272 | |12;stanford-crypto-pbkdf2;155;135;142;147;143;134;141;142;140;133 23:31:37 INFO - PROCESS | 2272 | |13;stanford-crypto-sha256-iterative;68;65;66;68;69;66;67;67;66;71 23:31:37 INFO - PROCESS | 2272 | __end_tp_report 23:31:37 INFO - PROCESS | 2272 | __start_cc_report 23:31:37 INFO - PROCESS | 2272 | _x_x_mozilla_cycle_collect,942 23:31:37 INFO - PROCESS | 2272 | __end_cc_report 23:31:37 INFO - PROCESS | 2272 | __startTimestamp1452843097200__endTimestamp 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | ------- Summary: start ------- 23:31:37 INFO - PROCESS | 2272 | Number of tests: 14 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | [#0] ai-astar Cycles:10 Average:107.30 Median:109.00 stddev:3.80 (3.5%) stddev-sans-first:3.98 23:31:37 INFO - PROCESS | 2272 | Values: 109.0 109.0 103.0 109.0 108.0 109.0 98.0 110.0 109.0 109.0 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:151.50 stddev:15.90 (10.5%) stddev-sans-first:16.57 23:31:37 INFO - PROCESS | 2272 | Values: 154.0 132.0 151.0 168.0 129.0 150.0 152.0 126.0 167.0 128.0 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 23:31:37 INFO - PROCESS | 2272 | Values: 161.0 161.0 161.0 161.0 162.0 160.0 161.0 164.0 163.0 163.0 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | [#3] audio-fft Cycles:10 Average:85.60 Median:72.00 stddev:20.17 (28.0%) stddev-sans-first:20.69 23:31:37 INFO - PROCESS | 2272 | Values: 71.0 72.0 110.0 95.0 72.0 71.0 72.0 128.0 92.0 73.0 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:95.00 stddev:21.89 (23.0%) stddev-sans-first:22.65 23:31:37 INFO - PROCESS | 2272 | Values: 95.0 95.0 144.0 95.0 95.0 95.0 140.0 95.0 96.0 137.0 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:31:37 INFO - PROCESS | 2272 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 23:31:37 INFO - PROCESS | 2272 | Values: 146.0 147.0 146.0 147.0 145.0 147.0 146.0 146.0 146.0 147.0 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 23:31:37 INFO - PROCESS | 2272 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:3.39 (6.0%) stddev-sans-first:3.59 23:31:37 INFO - PROCESS | 2272 | Values: 56.0 57.0 57.0 56.0 55.0 55.0 57.0 66.0 54.0 55.0 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 23:31:37 INFO - PROCESS | 2272 | Values: 67.0 68.0 69.0 68.0 69.0 68.0 68.0 69.0 68.0 69.0 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:1.73 (2.1%) stddev-sans-first:1.69 23:31:37 INFO - PROCESS | 2272 | Values: 80.0 82.0 85.0 84.0 82.0 80.0 80.0 82.0 83.0 81.0 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:119.00 stddev:2.71 (2.3%) stddev-sans-first:2.83 23:31:37 INFO - PROCESS | 2272 | Values: 119.0 117.0 117.0 114.0 119.0 116.0 123.0 119.0 114.0 119.0 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.20 Median:142.00 stddev:6.56 (4.6%) stddev-sans-first:4.69 23:31:37 INFO - PROCESS | 2272 | Values: 155.0 135.0 142.0 147.0 143.0 134.0 141.0 142.0 140.0 133.0 23:31:37 INFO - PROCESS | 2272 | 23:31:37 INFO - PROCESS | 2272 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.77 (2.6%) stddev-sans-first:1.86 23:31:37 INFO - PROCESS | 2272 | Values: 68.0 65.0 66.0 68.0 69.0 66.0 67.0 67.0 66.0 71.0 23:31:37 INFO - PROCESS | 2272 | -------- Summary: end -------- 23:31:37 INFO - PROCESS | 2272 | 23:31:38 INFO - TEST-INFO | 2272: exit 0 23:31:38 INFO - TEST-OK | kraken | took 59373ms 23:31:38 INFO - TEST-START | v8_7 23:31:38 INFO - operating with platform_type : linux_ 23:31:38 INFO - Initialising browser for v8_7 test... 23:31:38 INFO - TEST-INFO | started process 2616 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0n2K9a/profile http://localhost:46439/getInfo.html) 23:31:42 INFO - PROCESS | 2616 | __metrics Screen width/height:1600/1200 23:31:42 INFO - PROCESS | 2616 | colorDepth:24 23:31:42 INFO - PROCESS | 2616 | Browser inner width/height: 1024/697 23:31:42 INFO - PROCESS | 2616 | __metrics 23:31:43 INFO - PROCESS | 2616 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:31:43 INFO - PROCESS | 2616 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:31:44 INFO - TEST-INFO | 2616: exit 0 23:31:44 INFO - Browser initialized. 23:31:44 INFO - Running cycle 1/1 for v8_7 test... 23:31:44 INFO - TEST-INFO | started process 2738 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0n2K9a/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:31:56 INFO - PROCESS | 2738 | RSS: Main: 149237760 23:31:56 INFO - PROCESS | 2738 | 23:32:18 INFO - PROCESS | 2738 | Cycle 1(1): loaded http://localhost:46439/tests/v8_7/run.html (next: http://localhost:46439/tests/v8_7/run.html) 23:32:19 INFO - PROCESS | 2738 | RSS: Main: 551600128 23:32:19 INFO - PROCESS | 2738 | 23:32:19 INFO - PROCESS | 2738 | __start_tp_report 23:32:19 INFO - PROCESS | 2738 | _x_x_mozilla_page_load 23:32:19 INFO - PROCESS | 2738 | _x_x_mozilla_page_load_details 23:32:19 INFO - PROCESS | 2738 | |i|pagename|runs| 23:32:19 INFO - PROCESS | 2738 | |0;Richards;166.19577862722286 23:32:19 INFO - PROCESS | 2738 | |1;DeltaBlue;188.28845791752966 23:32:19 INFO - PROCESS | 2738 | |2;Encrypt;280.1120448179272 23:32:19 INFO - PROCESS | 2738 | |3;Decrypt;5246.073298429319 23:32:19 INFO - PROCESS | 2738 | |4;RayTrace;1114.8272017837235 23:32:19 INFO - PROCESS | 2738 | |5;Earley;781.8608287724785 23:32:19 INFO - PROCESS | 2738 | |6;Boyer;12240.963855421687 23:32:19 INFO - PROCESS | 2738 | |7;RegExp;43531.914893617024 23:32:19 INFO - PROCESS | 2738 | |8;Splay;574.6013667425968 23:32:19 INFO - PROCESS | 2738 | |9;NavierStokes;4854.368932038835 23:32:19 INFO - PROCESS | 2738 | __end_tp_report 23:32:19 INFO - PROCESS | 2738 | __startTimestamp1452843139157__endTimestamp 23:32:19 INFO - PROCESS | 2738 | 23:32:19 INFO - PROCESS | 2738 | ------- Summary: start ------- 23:32:19 INFO - PROCESS | 2738 | Number of tests: 10 23:32:19 INFO - PROCESS | 2738 | 23:32:19 INFO - PROCESS | 2738 | [#0] Richards Cycles:1 Average:166.20 Median:166.20 stddev:0.00 (0.0%) 23:32:19 INFO - PROCESS | 2738 | Values: 166.2 23:32:19 INFO - PROCESS | 2738 | 23:32:19 INFO - PROCESS | 2738 | [#1] DeltaBlue Cycles:1 Average:188.29 Median:188.29 stddev:0.00 (0.0%) 23:32:19 INFO - PROCESS | 2738 | Values: 188.3 23:32:19 INFO - PROCESS | 2738 | 23:32:19 INFO - PROCESS | 2738 | [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 23:32:19 INFO - PROCESS | 2738 | Values: 280.1 23:32:19 INFO - PROCESS | 2738 | 23:32:19 INFO - PROCESS | 2738 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 23:32:19 INFO - PROCESS | 2738 | Values: 5246.1 23:32:19 INFO - PROCESS | 2738 | 23:32:19 INFO - PROCESS | 2738 | [#4] RayTrace Cycles:1 Average:1114.83 Median:1114.83 stddev:0.00 (0.0%) 23:32:19 INFO - PROCESS | 2738 | Values: 1114.8 23:32:19 INFO - PROCESS | 2738 | 23:32:19 INFO - PROCESS | 2738 | [#5] Earley Cycles:1 Average:781.86 Median:781.86 stddev:0.00 (0.0%) 23:32:19 INFO - PROCESS | 2738 | Values: 781.9 23:32:19 INFO - PROCESS | 2738 | 23:32:19 INFO - PROCESS | 2738 | [#6] Boyer Cycles:1 Average:12240.96 Median:12240.96 stddev:0.00 (0.0%) 23:32:19 INFO - PROCESS | 2738 | Values: 12241.0 23:32:19 INFO - PROCESS | 2738 | 23:32:19 INFO - PROCESS | 2738 | [#7] RegExp Cycles:1 Average:43531.91 Median:43531.91 stddev:0.00 (0.0%) 23:32:19 INFO - PROCESS | 2738 | Values: 43531.9 23:32:19 INFO - PROCESS | 2738 | 23:32:19 INFO - PROCESS | 2738 | [#8] Splay Cycles:1 Average:574.60 Median:574.60 stddev:0.00 (0.0%) 23:32:19 INFO - PROCESS | 2738 | Values: 574.6 23:32:19 INFO - PROCESS | 2738 | 23:32:19 INFO - PROCESS | 2738 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 23:32:19 INFO - PROCESS | 2738 | Values: 4854.4 23:32:19 INFO - PROCESS | 2738 | -------- Summary: end -------- 23:32:19 INFO - PROCESS | 2738 | 23:32:20 INFO - TEST-INFO | 2738: exit 0 23:32:20 INFO - TEST-OK | v8_7 | took 41974ms 23:32:20 INFO - SUITE-END | took 1214s 23:32:20 INFO - Completed test suite (00:20:15) 23:32:20 INFO - Working with test: dromaeo_css 23:32:20 INFO - Generating results file: dromaeo_css 23:32:20 INFO - Working with test: kraken 23:32:20 INFO - Generating results file: kraken 23:32:20 INFO - javascript benchmark 23:32:20 INFO - Working with test: v8_7 23:32:20 INFO - Generating results file: v8_7 23:32:20 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:32:20 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:32:20 INFO - process_Request line: dromaeo_css 6832.23 graph.html#tests=[[72,201,35]] 23:32:20 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:32:20 INFO - process_Request line: kraken 1493.30 graph.html#tests=[[232,201,35]] 23:32:20 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:32:20 INFO - process_Request line: v8_7 20075.55 graph.html#tests=[[230,201,35]] 23:32:20 INFO - RETURN: dromaeo_css: 6832.23 23:32:20 INFO - RETURN: kraken: 1493.30 23:32:20 INFO - RETURN: v8_7: 20075.55 23:32:20 INFO - javascript benchmark 23:32:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3079.722824945755, 3098.209956461102, 3154.7318477929375, 3157.36852629474, 3163.14595059334, 5017.5484206421415, 5109.182530795074, 5133.332666753321, 5173.637845350822, 5212.817551385698, 5062.493750624935, 5106.846794596158, 5121.923171152435, 5127.461616530257, 5132.717700526469, 4495.415595972519, 4671.322658214565, 4681.9063618727605, 4747.881302967419, 4748.715077095385, 4609.953900460986, 4679.344891715145, 4699.882502937437, 4722.551357621038, 4810.68730532516, 4660.6504512161555, 4712.198926182557, 4715.622750179978, 4728.976355118202, 4752.928706069411, 4698.201305778026, 4707.646926480527, 4723.622110231207, 4730.810767569293, 4737.976310118462, 4609.654275929285, 4637.86086417408, 4674.602658774008, 4711.976440117777, 4713.505081966413, 5046.520580544842, 5058.241263810458, 5068.645194836363, 5069.340985671876, 5074.467180945984, 5514.779408823642, 5522.751476183541, 5534.833954981357, 5541.33503979521, 5587.413321601254, 5409.24270602116, 5413.9729301353245, 5478.698671573062, 5489.1217405215375, 5549.334079910396, 5173.586113110942, 5181.663191892515, 5217.478252174828, 5222.556082732972, 5223.0, 5639.436056394327, 5651.208830763697, 5652.7738890443925, 5671.773129074873, 5674.546036317085, 5309.442508536626, 5326.201069839555, 5340.626156169031, 5394.78420863169, 5413.810516631899, 5491.423400542965, 5515.448455154453, 5517.862053448615, 5519.613627046068, 5520.723963801794, 5337.466253374631, 5463.754131064032, 5480.0, 5480.671159730429, 5530.6128571000445, 5428.864278393072, 5432.565394768409, 5436.728163591804, 5462.453754624506, 5498.120300751861, 4275.5296917339065, 4289.892752681146, 4294.806733696991, 4298.548652391516, 4333.934990975138, 3773.58490566043, 3815.04623844039, 3834.9424758628643, 3859.1316953685196, 3894.7468414552964, 5047.924281135786, 5090.981803639287, 5122.410922743932, 5144.665596736275, 5160.200168973815, 5515.889682206413, 5534.169874518854, 5534.225208470817, 5538.695371754592, 5539.556835453154, 5042.747862606855, 5117.360329958755, 5165.870853228699, 5169.948300517022, 5208.765605547759, 4622.306654001926, 4650.18621741194, 4652.604528615038, 4655.348251244828, 4694.765261736899, 5680.857978550569, 5686.118651608925, 5694.430556944272, 5704.80033198836, 5760.510356619734, 5326.733663316896, 5333.439988801275, 5396.946030539644, 5463.644863083887, 5477.1510415885605, 5658.773649053992, 5686.033374326292, 5692.0, 5698.4871361576, 5749.396313387201, 5386.919196211981, 5392.08334583114, 5395.325584301962, 5400.2709634200455, 5400.62195646301, 5422.15956526739, 5481.451854814487, 5497.147942068986, 5519.558435325244, 5573.136163894603, 5254.7898084076205, 5260.0, 5263.842084737464, 5269.789208431773, 5279.366476022902, 5244.082285599929, 5251.054810134213, 5259.132243179985, 5274.287971123849, 5286.788528458818, 5162.380514338303, 5226.137687281556, 5249.291345668438, 5283.286756288006, 5312.0, 5388.08402571556, 5401.783928642811, 5415.6479828811, 5419.241306217212, 5475.09660905946, 5178.792848286026, 5317.175837745156, 5326.760295786621, 5330.70681112527, 5334.599905007062], "unit": "score", "name": "dojo.html", "value": 5066.7506188234165}, {"lowerIsBetter": false, "replicates": [512.7436281859068, 541.480179028133, 544.1973089692704, 566.4392251670846, 579.3511267380532, 28717.712822871767, 29350.0, 29360.265993350178, 36472.0, 36687.08282292944, 39426.408603870965, 39959.0, 39966.40050399247, 40266.0, 40282.798586007106, 8469.78825529362, 8613.698520551781, 8640.65437382504, 8663.35024873137, 8691.435056721293, 8325.50046997179, 8444.071152173256, 8452.0, 8452.070272270046, 8452.957735211347, 8387.0, 8548.145185481464, 8556.828863422728, 8756.912430875705, 8768.473891566526, 8643.913560864374, 8667.0, 8722.520261385622, 8726.563671816384, 8730.345224108185, 8565.0, 8682.522461264627, 8702.086280940473, 8702.869456958151, 8704.956475217647, 39819.0, 40360.39459408111, 40371.79814100911, 40417.0, 40637.79681101605, 3106.6116735408073, 3238.77328586999, 3253.5770349854606, 3445.758796884219, 3896.123372241251, 30506.38987220243, 30996.38007239865, 31418.05745827629, 31426.37147257065, 31427.057188284387, 3804.5077531558663, 3866.6906647468136, 3893.5133108361456, 3922.8038598069984, 4038.374052021941, 217281.0, 217313.22090505966, 217853.0, 218555.0, 219027.0, 57031.71484142553, 57274.0, 57320.14019789707, 57440.0, 61634.0, 65398.0, 65583.0, 65689.6715516429, 65837.34162658312, 65885.67057164779, 15143.697126057417, 15381.846181538265, 15387.307571159325, 15410.229488525529, 15412.614684632974, 10682.57269709203, 10949.343039417661, 11107.777844443066, 11120.499577518869, 11203.60787372438, 19373.32193373225, 20656.690149647766, 20673.793262067185, 20837.479063023547, 20927.162913483593, 6531.804045878631, 7913.564753938589, 8072.4349295548745, 8082.232187942136, 8193.910552808995, 911.8267529169436, 953.1802649721234, 981.4405788700515, 1007.3099926550336, 1057.9471026448646, 27167.728322716914, 27169.184924452296, 27402.45195096087, 27703.445931081667, 28406.289842753682, 1049.9265051446478, 1088.080571916729, 1106.6126855600637, 1160.930344179352, 1162.587281515067, 15038.774418383733, 15054.774178387333, 15172.924135379473, 15230.543083707507, 15361.308741106677, 306305.0, 310531.0, 310968.0, 311101.0, 311261.0, 45848.3122753159, 46083.76958115188, 46376.5362346379, 52917.47082529125, 53432.46567534275, 1277.904157188196, 1335.5192130832893, 1347.5014244729514, 1348.164138234301, 1357.694518733297, 26410.603840942018, 26598.335041624116, 26625.866870665523, 27197.456050878474, 27201.183964481097, 40231.798841005606, 42599.7870010648, 43343.56656433395, 47998.28002580034, 49105.0, 195716.1499347516, 197640.0, 199324.0, 199727.0, 199820.0, 30942.845285773426, 31198.0, 31337.216569585944, 31341.21646958753, 31361.8431907839, 41186.79406602948, 43257.56742432535, 43922.560774391844, 44739.77630111828, 44771.77614111909, 36092.819535902156, 37191.814040929625, 37695.434568480945, 37832.810835946744, 37946.241075177786, 36879.0, 37369.626303736615, 37391.25217495689, 37586.805121564976, 37673.434898476, 36914.0, 36934.26131477409, 37188.628113718514, 38740.80629596834, 39466.0, 30860.0, 33559.83220083884, 33653.663463365054, 33776.49335260022, 33952.66047339594, 23835.52328953446, 24084.0, 26581.7341826587, 26885.596716048884, 28164.295892602848], "unit": "score", "name": "ext.html", "value": 18042.408272220844}, {"lowerIsBetter": false, "replicates": [346.9219425629232, 362.58665121761186, 364.53703796178854, 367.72788136778786, 369.1969965325417, 13761.243131627756, 13917.652058698537, 15723.292451839667, 16244.75632865508, 17254.48236552904, 15087.547373578784, 15634.530964071097, 16148.192590370463, 16157.272922718477, 16226.513204603882, 5182.611304152185, 5381.596380271476, 5382.730863456831, 5383.0, 5388.91916621249, 4031.2340655275552, 4176.1230141670285, 5294.867628309304, 5406.756695948672, 5762.9135562966585, 5677.37548869624, 5883.911741323884, 5941.722529656123, 5945.940540594604, 5946.613470124428, 5922.0, 5932.169496270526, 5952.107183922403, 5976.2230909981645, 5979.940200598004, 5109.182530795055, 5223.1206948187855, 5264.499872512143, 5267.5259226669405, 5270.262163297141, 19757.0, 19765.604687906307, 19900.1044952976, 20125.094370753206, 20139.597208055904, 2076.7611724651706, 2100.9369718908456, 2118.3433135727973, 2137.5297434564372, 2604.1927002629245, 8699.086595907465, 9074.909250907473, 9134.406263592911, 11936.45726826107, 12327.198732082386, 1677.9748303775452, 1731.5324862287112, 1735.6094878652202, 1735.9132043397906, 1765.0733364983357, 49571.25643115356, 51374.486255137344, 59886.0, 60634.393656063316, 66664.66667666631, 14477.131372117707, 15052.247387630574, 15172.393104275927, 15218.847811521742, 15235.466758663393, 23116.53766924652, 23213.76786232116, 23384.298471045895, 23402.18092366793, 23417.531649366916, 8665.306775457948, 8785.472871627722, 8790.824183516423, 8805.0, 8834.55827208637, 7346.77959661211, 7449.88825167623, 7480.476366654282, 7516.6993320267675, 7532.39740820733, 7747.225277472207, 7756.4182686298755, 7776.261255180749, 7827.843443131105, 7837.49056311338, 2442.0, 2449.8530088194766, 2980.3145276586506, 3038.62017247844, 3044.588980487606, 808.8058865872148, 879.6085741844818, 903.4940433357341, 969.3553786731744, 995.9053889880449, 15782.289796959165, 16422.114568246612, 16451.177441128137, 16538.338466461206, 16828.15859207059, 866.4706792511223, 892.0455113029126, 906.6826610686207, 907.5598334807613, 978.7993461340408, 8682.088380720059, 8851.0, 8966.0, 9083.68207112748, 9098.590563424661, 363871.0, 367638.0, 369801.0, 369989.0, 477980.0, 59948.40051599428, 65662.0, 67527.0, 68018.0, 69402.3059769406, 1150.2983180260035, 1162.9825552616549, 1170.403094421851, 1191.3149938785234, 1191.5472120594118, 14897.702045959237, 15061.548153555412, 15304.0, 15347.769783453034, 15395.923020384826, 32352.83823580867, 32712.34575308528, 33559.496607551395, 33640.49539256962, 33645.0, 42817.78591107149, 43076.0, 43507.34738978855, 43803.342949856415, 43891.0, 7025.894611580728, 7241.131064272321, 7256.854862902818, 7302.780916572511, 7372.557646541225, 9246.4914429707, 9922.900770992197, 10702.304350217211, 10742.946285268523, 11017.173711971474, 7333.046703928455, 8454.492730436194, 9276.25789936817, 9359.438433694, 9479.336446448959, 9409.811803763749, 9466.432014079177, 9470.857937131086, 9630.855537167088, 9765.316427850266, 9833.508324583885, 10208.336458130198, 10411.791764164826, 10466.581336746749, 10563.366198028143, 6932.064171337007, 7100.218975912542, 7108.680109394986, 7261.854762904818, 7362.595057271901, 8899.377043606886, 9233.676821311223, 9473.905260947578, 9609.951950240204, 9651.565679544578], "unit": "score", "name": "jquery.html", "value": 8535.552732700293}, {"lowerIsBetter": false, "replicates": [1313.8226339444172, 1443.7906503556983, 1449.0943160524669, 1599.808023037235, 1752.702040653089, 6927.341902519259, 7548.056492938383, 7620.847583048336, 7666.3483603893665, 7678.462507624468, 7571.31858132768, 7725.111612164589, 7736.458447908634, 7772.48436554872, 7784.9221507784905, 2032.5223572460459, 2074.2843718917024, 2272.556851413975, 2308.7575804540534, 2333.4749681321737, 2322.953540929189, 2328.1851352026824, 2329.114936324203, 2332.265336419031, 2334.3580515358326, 2240.473488730147, 2309.2494939144763, 2311.318161142467, 2312.28319221042, 2313.8611683298973, 2255.751867294596, 2289.0271634555247, 2318.211807985285, 2319.7680231976838, 2327.104064935012, 2302.067662596651, 2319.153508969231, 2334.26470661741, 2342.5900467418305, 2346.249200255919, 7774.572398518079, 7834.4124190685925, 7843.529388236724, 7855.5286682799215, 7903.486273392211, 4803.471618122004, 4946.826861059882, 4951.480094590052, 4956.479569645207, 4957.405111386656, 3041.0724728957657, 3089.243135431811, 3143.669914658951, 3145.528170774402, 3154.0853152585723, 973.8539219117118, 980.13258266434, 1007.249599048706, 1014.5485259059722, 1018.3075508654113, 10915.345079295268, 10930.398828064453, 10933.781324373547, 10935.070519005814, 10935.28920620157, 4344.847930322424, 4401.273789824707, 4441.178381999341, 4456.0, 4501.729896206172, 9361.110694484014, 9384.671536496326, 9385.530723463937, 9396.0, 9397.718068457958, 4912.926306105412, 4933.210686290248, 4943.480934501826, 4944.975275123673, 4947.084789313916, 4421.005273813366, 4444.777761111932, 4505.346724724962, 4507.143642707875, 4509.549045095464, 3476.947845782315, 3571.2678900825267, 3739.495168152319, 3765.811709414518, 3784.6972242220554, 1183.988160118388, 1214.1622280626339, 1220.0849362977767, 1230.3356187658744, 1235.1909499277808, 876.0037543018158, 885.6988623867916, 891.5408564589242, 892.9910700892908, 1298.2924306252926, 7444.441666875006, 7491.10106787189, 7493.363064139609, 7497.550146991198, 7502.62486875654, 1112.9554817807198, 1123.1969142063465, 1137.4710759496709, 1152.4007516091585, 1166.3060479014973, 5758.280214973129, 5809.796657116981, 5826.038703613856, 5851.531877449794, 5859.794907178229, 8895.377323587416, 9077.409968352036, 9086.545672716338, 9108.908910910806, 9201.585928633227, 9060.275177985744, 9074.546272686339, 9081.364304498622, 9108.225800807006, 9110.316726245557, 7212.495125341281, 7481.21447248042, 7538.472306938571, 7552.471327007057, 7556.093268807778, 7406.44451666138, 7426.74006409773, 7459.179490256176, 7502.774916752506, 7509.5869727163345, 8409.495430274203, 8468.195521425454, 8529.616167272363, 8680.869786953075, 8692.826143476968, 8658.956705216433, 8886.422382545114, 8890.955545222232, 8898.911010890068, 8916.019237883698, 6218.844528886814, 6831.9658401707675, 6929.5842249465195, 6948.756793512202, 6951.721931122698, 6848.041274221712, 7234.276572342724, 7407.0, 7408.740694075682, 7411.888821667571, 6626.933730662631, 6922.688479018557, 6938.826529336807, 6985.615791131537, 6996.090508233897, 6916.827079323057, 6939.16729992384, 6974.511784175059, 7021.0, 7045.330693584101, 6929.549579277331, 6956.304369563206, 6997.510174287751, 7003.229644739176, 7012.298770122947, 6461.676916154268, 6500.122483464861, 6508.251551071688, 6512.641804700787, 6512.674366281762, 6319.873602528016, 6375.234971803413, 6379.138816259746, 6381.712822923072, 6383.39357761012], "unit": "score", "name": "mootools.html", "value": 4504.956790552692}, {"lowerIsBetter": false, "replicates": [342.43156360441657, 343.8280859570215, 346.20373141773916, 350.5582965463515, 352.0424445508217, 5653.321601407826, 5864.970675146624, 5882.5588080893895, 5912.822615321536, 5950.345461999187, 5619.859503512414, 5774.624649397797, 5781.508571771405, 5805.506531944779, 5827.125931110336, 4554.749488778124, 4568.817247310104, 4576.130535198302, 4577.748223847687, 4580.725156490605, 4401.36180253863, 4482.0, 4482.23801953667, 4551.112533056055, 4575.428071491064, 4488.708233964798, 4495.190865644183, 4497.797599108048, 4509.887252818689, 4511.278195488722, 4520.570545798144, 4548.340490628841, 4554.27131658933, 4560.361549383089, 4578.793954272066, 4013.4381186633896, 4017.975416268862, 4020.577839326887, 4022.054817117975, 4025.81883815229, 5486.1222204447095, 5609.0184217762135, 5624.746886390122, 5642.605017648766, 5649.067903795869, 5251.4485978972425, 5251.579873610102, 5258.658187217857, 5260.105782017066, 5290.338707661543, 5960.374160713106, 6268.78059267928, 6273.62358258506, 6280.811575652738, 6284.18305620271, 4311.504177019651, 4368.803403846835, 4375.7155784873885, 4381.6494680425485, 4395.648348132142, 6361.777337793155, 6422.389872962108, 6444.258910225337, 6466.127072845153, 6510.804675859732, 4581.266997280486, 4584.33527138563, 4588.311753236974, 4589.265717485253, 4593.966357569587, 4543.932175938652, 4628.259478483426, 4630.6758526902795, 4634.443866736014, 4657.953420465819, 5237.580993520509, 5238.842834714965, 5284.550813180846, 5289.20661900718, 5291.470852914755, 6233.75064997395, 6269.247690277196, 6269.937300627026, 6290.370962903765, 6290.402411770874, 1633.86112180466, 1641.7455294429383, 1645.654412573373, 1645.6708658268155, 1649.2825620854967, 1119.0767616716241, 1119.8096323625002, 1135.7047167736448, 1147.7073346296809, 1150.6260465348796, 5939.613925094855, 5944.316403613553, 5948.702564871739, 5952.434518720715, 5956.2852457704485, 6397.936020639734, 6435.742570297136, 6441.5490915635455, 6443.742250309935, 6444.194475690539, 5817.883642327214, 5929.110633405024, 5939.049752039653, 5941.287045554561, 5944.197533332945, 3445.4659527773233, 3471.7743346682387, 3474.6351633078666, 3482.303539292101, 3483.216276337854, 6678.7328506859185, 6707.865842683119, 6712.362325579063, 6713.362230588086, 6721.0, 6498.447631951242, 6522.445592124628, 6531.0856480092825, 6535.901961470582, 6535.967320163464, 6507.349265073455, 6668.933310666928, 6672.165979252496, 6687.331266873371, 6689.230738465041, 6231.283402408781, 6379.553431259953, 6419.935800641933, 6460.418562329413, 6493.512986525935, 6304.936950630618, 6396.136521569529, 6399.776007839703, 6420.357964203729, 6432.903506447314, 6726.730930762715, 6737.157855268091, 6747.055412242388, 6752.763653272112, 6755.3582409671, 4312.676549258756, 4605.148047611203, 4612.100640375094, 4616.3306320584, 4620.09908067937, 6351.3331100235655, 6358.713857876499, 6361.586496877688, 6361.61830290184, 6374.553781235269, 6190.690465476799, 6202.81391558254, 6205.348438414082, 6258.874822503433, 6263.27972283175, 6097.0, 6180.042093475518, 6255.0, 6256.343083976299, 6258.342873998165, 6095.177151084724, 6097.4207450293925, 6104.664243466652, 6150.969245153746, 6169.0, 6360.141380913703, 6363.745450181941, 6368.363163683594, 6369.840753981188, 6377.585456945284, 6109.48069414087, 6157.199564056644, 6192.659403732658, 6216.378362163748, 6220.066989951543], "unit": "score", "name": "prototype.html", "value": 4748.538075054378}, {"lowerIsBetter": false, "replicates": [712.405141706675, 761.4974117082724, 828.1345993436857, 829.5769157729558, 834.3325339728219, 12868.871311286895, 12938.935305323472, 12979.870201297985, 12983.610491685253, 13040.21758694479, 12673.809892851592, 12692.3653817309, 12712.93643531781, 12719.809202861965, 12742.617721468348, 650.0282078292947, 665.2150462454302, 666.1839246922506, 666.5634009723639, 667.8931370980644, 785.3834739729314, 796.6932730898587, 799.856025915335, 800.1838125112411, 803.8432505661369, 822.6750433578733, 823.8599438095538, 832.8958880139983, 833.954132522711, 836.6862426590029, 680.1124532485105, 824.9917500825005, 829.2619568583965, 830.6718846055804, 832.8584140696066, 509.4447052712524, 606.6390497653889, 613.9416755408274, 614.708013693492, 615.0804547201917, 12627.05297102721, 12699.174553654075, 12721.491140354376, 12752.617421477371, 12792.680182995406, 11618.302901825917, 12259.448324825315, 12382.75234495314, 12395.566155184526, 12434.875651243463, 10132.986701329883, 10157.847632285522, 10208.897911020944, 10209.795804083877, 10258.0, 3471.0801637566065, 3515.5254040704435, 3518.190816112283, 3518.9648103518894, 3524.0661224775454, 45723.31415028744, 46033.30950035752, 46889.29666055012, 47265.76367118177, 47352.0, 9814.950925245328, 9955.352902061342, 10048.156328975409, 10210.387376757419, 10660.733481662865, 18819.71770423445, 18941.337053203348, 18962.71555926662, 18967.71548426775, 19031.1435985381, 7341.375983041395, 7417.59203243816, 7442.702291908371, 7506.662200201004, 7531.8117047073165, 4225.218334608107, 4302.569743025672, 4304.849330273488, 4311.0, 4345.652347812167, 3037.4228896509594, 3097.272141046852, 3098.8450577471035, 3106.456370135217, 3109.3936682347176, 540.5108376918895, 549.5713343592005, 552.7844140785097, 563.6589863132828, 568.4457653787524, 501.1605560685837, 590.7755053079802, 612.1277180018456, 615.5814046448459, 621.6705146272483, 8399.328053755686, 8419.705310314232, 8503.532305723122, 8790.736277911545, 9589.328746987643, 481.5160763432798, 539.9028174928472, 549.3682265394748, 549.8048192891546, 607.0420856018733, 3779.4708740776314, 3896.59085795993, 4079.8776036718946, 4113.197926404382, 4151.97924010384, 50366.0, 51145.488545114815, 51279.48720512747, 51365.74317128465, 51592.22611660828, 45779.0, 49773.253401199014, 49845.50154498409, 49965.75017124891, 50001.74999124981, 43375.78312108419, 44175.558244417785, 44985.325220121726, 44991.77504112459, 46424.07151857011, 8428.0, 8435.873461897954, 8837.248833849195, 9078.727638170865, 9115.680951166678, 30195.0, 30256.54615180818, 30672.539911901786, 31676.208094797814, 31927.840360798047, 39742.40386394149, 40049.399259010555, 41632.791836040626, 43392.0, 43955.560444395145, 10636.30863993838, 10660.573577056832, 10696.358218506915, 10740.83888741685, 10846.13230941507, 12360.4437800301, 12624.11631185845, 12672.6831829205, 13047.412866420844, 13067.738645226853, 11085.667429977113, 11510.136739744385, 11660.53357865676, 11836.408179591159, 12032.75934481288, 10904.618338358438, 11407.486663100346, 11470.369129697947, 11685.591004314809, 11794.764104717686, 10895.891041089804, 11060.446977651247, 11103.944480277547, 11142.387168705798, 11193.944030279796, 8890.377673562789, 9269.907300926905, 9273.536323183678, 9275.39709918853, 9418.105279998663, 8434.409591328547, 8619.353548483763, 8957.14907083826, 9210.263178945803, 9684.85472717924], "unit": "score", "name": "yui.html", "value": 6092.973234803407}], "name": "dromaeo_css", "value": 6832.2274936948}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 103.0, 109.0, 108.0, 109.0, 98.0, 110.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [154.0, 132.0, 151.0, 168.0, 129.0, 150.0, 152.0, 126.0, 167.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 161.0, 162.0, 160.0, 161.0, 164.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 110.0, 95.0, 72.0, 71.0, 72.0, 128.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 144.0, 95.0, 95.0, 95.0, 140.0, 95.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 145.0, 147.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 57.0, 56.0, 55.0, 55.0, 57.0, 66.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 85.0, 84.0, 82.0, 80.0, 80.0, 82.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [119.0, 117.0, 117.0, 114.0, 119.0, 116.0, 123.0, 119.0, 114.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.7}, {"lowerIsBetter": true, "replicates": [155.0, 135.0, 142.0, 147.0, 143.0, 134.0, 141.0, 142.0, 140.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.2}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 66.0, 68.0, 69.0, 66.0, 67.0, 67.0, 66.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1493.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.19577862722286], "unit": "score", "name": "Richards", "value": 212.41213400000004}, {"lowerIsBetter": false, "replicates": [188.28845791752966], "unit": "score", "name": "DeltaBlue", "value": 351.152698}, {"lowerIsBetter": false, "replicates": [280.1120448179272], "unit": "score", "name": "Encrypt", "value": 950.2661699999999}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1114.8272017837235], "unit": "score", "name": "RayTrace", "value": 663.7701329999999}, {"lowerIsBetter": false, "replicates": [781.8608287724785], "unit": "score", "name": "Earley", "value": 852.4061770000001}, {"lowerIsBetter": false, "replicates": [12240.963855421687], "unit": "score", "name": "Boyer", "value": 54.4453041338583}, {"lowerIsBetter": false, "replicates": [43531.914893617024], "unit": "score", "name": "RegExp", "value": 20.926830400782002}, {"lowerIsBetter": false, "replicates": [574.6013667425968], "unit": "score", "name": "Splay", "value": 141.82179980178395}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 20075.54541586723}]} 23:32:20 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20075.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1493.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6832.23"}}} 23:32:20 INFO - Return code: 0 23:32:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:32:20 INFO - # TBPL SUCCESS # 23:32:20 INFO - Running post-action listener: _resource_record_post_action 23:32:20 INFO - Running post-run listener: _resource_record_post_run 23:32:21 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 328888320; Read time: 0; Write time: 471172 23:32:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13578240; Read time: 0; Write time: 30968 23:32:21 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 313933824; Read time: 0; Write time: 440068 23:32:21 INFO - Running post-run listener: _upload_blobber_files 23:32:21 INFO - Blob upload gear active. 23:32:21 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:32:21 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 23:32:21 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'] 23:32:21 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 23:32:22 INFO - (blobuploader) - INFO - Open directory for files ... 23:32:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:32:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:32:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:32:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:32:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:32:23 INFO - (blobuploader) - INFO - Done attempting. 23:32:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:32:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:32:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:32:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:32:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:32:24 INFO - (blobuploader) - INFO - Done attempting. 23:32:24 INFO - (blobuploader) - INFO - Iteration through files over. 23:32:24 INFO - Return code: 0 23:32:24 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:32:24 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:32:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0de0ae58090a1103f8402958c819a57c272cc566fd159d8a3997a681b4b01edbcfb3d63d7fa48ea66cd6140813e3ec109870de5fe7ae946b0acc92e2e106e88d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4dfa3f174fe0f9a8db399e227f578f20c9fc9907bc526909149ec566bfc739c01391c2808a0ce33b2326a7aee389a97021feece1d5d577c0e677607b96646df5"} 23:32:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:32:24 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:32:24 INFO - Contents: 23:32:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0de0ae58090a1103f8402958c819a57c272cc566fd159d8a3997a681b4b01edbcfb3d63d7fa48ea66cd6140813e3ec109870de5fe7ae946b0acc92e2e106e88d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4dfa3f174fe0f9a8db399e227f578f20c9fc9907bc526909149ec566bfc739c01391c2808a0ce33b2326a7aee389a97021feece1d5d577c0e677607b96646df5"} 23:32:24 INFO - Copying logs to upload dir... 23:32:24 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1292.422112 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-01-14 23:32:24.436990) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 23:32:24.440249) ========= 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=df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635 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/0de0ae58090a1103f8402958c819a57c272cc566fd159d8a3997a681b4b01edbcfb3d63d7fa48ea66cd6140813e3ec109870de5fe7ae946b0acc92e2e106e88d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4dfa3f174fe0f9a8db399e227f578f20c9fc9907bc526909149ec566bfc739c01391c2808a0ce33b2326a7aee389a97021feece1d5d577c0e677607b96646df5"} build_url:https://queue.taskcluster.net/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011161 build_url: 'https://queue.taskcluster.net/v1/task/Y42WkBFVS1-RO4zJhhh4MQ/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/0de0ae58090a1103f8402958c819a57c272cc566fd159d8a3997a681b4b01edbcfb3d63d7fa48ea66cd6140813e3ec109870de5fe7ae946b0acc92e2e106e88d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4dfa3f174fe0f9a8db399e227f578f20c9fc9907bc526909149ec566bfc739c01391c2808a0ce33b2326a7aee389a97021feece1d5d577c0e677607b96646df5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 23:32:24.467137) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 23:32:24.467799) ========= 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=df17445c3590ff7897617a0e00000225-1452840577.58425-1179565635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 23:32:24.552275) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 23:32:24.552627) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 23:32:24.552946) ========= ========= Total master_lag: 0.25 =========