builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1453197578.0 results: success (0) buildid: 20160118233013 builduid: 23dcafae42894c799cfb52876bbe307f revision: 939a20ef46ea94c7ba92b1113382869d7163e06f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:37.996939) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:37.997400) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:37.997741) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006335 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:38.024127) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:38.024458) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:38.073681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:38.073963) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.028710 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:38.129862) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:38.130162) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:38.130568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:38.130873) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 01:59:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-01-19 01:59:38 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170802 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:38.314753) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:38.315207) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.131269 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:38.458134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-19 01:59:38.458514) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 939a20ef46ea94c7ba92b1113382869d7163e06f --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 939a20ef46ea94c7ba92b1113382869d7163e06f --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=337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 01:59:38,980 truncating revision to first 12 chars 2016-01-19 01:59:38,980 Setting DEBUG logging. 2016-01-19 01:59:38,980 attempt 1/10 2016-01-19 01:59:38,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/939a20ef46ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 01:59:39,769 unpacking tar archive at: b2g-inbound-939a20ef46ea/testing/mozharness/ program finished with exit code 0 elapsedTime=1.060528 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-19 01:59:39.530984) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:39.531347) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004694 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:39.582126) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:39.582497) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:39.592721) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:39.593039) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 01:59:39.593529) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-19 01:59:39.593888) ========= /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=337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:59:40 INFO - MultiFileLogger online at 20160119 01:59:40 in /builds/slave/test-pgo 01:59:40 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 01:59:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:59:40 INFO - {'append_to_log': False, 01:59:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:59:40 INFO - 'blob_upload_branch': 'B2G-Inbound', 01:59:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:59:40 INFO - 'branch': 'B2G-Inbound', 01:59:40 INFO - 'buildbot_json_path': 'buildprops.json', 01:59:40 INFO - 'config_files': ('talos/linux_config.py',), 01:59:40 INFO - 'default_actions': ('clobber', 01:59:40 INFO - 'read-buildbot-config', 01:59:40 INFO - 'download-and-extract', 01:59:40 INFO - 'populate-webroot', 01:59:40 INFO - 'create-virtualenv', 01:59:40 INFO - 'install', 01:59:40 INFO - 'run-tests'), 01:59:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:59:40 INFO - 'download_minidump_stackwalk': True, 01:59:40 INFO - 'download_symbols': 'ondemand', 01:59:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:59:40 INFO - 'tooltool.py': '/tools/tooltool.py', 01:59:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:59:40 INFO - '/tools/misc-python/virtualenv.py')}, 01:59:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:59:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:59:40 INFO - 'installer_path': 'installer.exe', 01:59:40 INFO - 'log_level': 'info', 01:59:40 INFO - 'log_name': 'talos', 01:59:40 INFO - 'log_to_console': True, 01:59:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:59:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:59:40 INFO - 'opt_config_files': (), 01:59:40 INFO - 'pip_index': False, 01:59:40 INFO - 'sps_profile': False, 01:59:40 INFO - 'sps_profile_interval': 0, 01:59:40 INFO - 'suite': 'dromaeojs', 01:59:40 INFO - 'system_bits': '32', 01:59:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:59:40 INFO - 'title': 'talos-linux64-ix-060', 01:59:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:59:40 INFO - 'use_talos_json': True, 01:59:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:59:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:59:40 INFO - 'work_dir': 'build'} 01:59:40 INFO - ##### 01:59:40 INFO - ##### Running clobber step. 01:59:40 INFO - ##### 01:59:40 INFO - Running pre-action listener: _resource_record_pre_action 01:59:40 INFO - Running main action method: clobber 01:59:40 INFO - rmtree: /builds/slave/test-pgo/build 01:59:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:59:41 INFO - Running post-action listener: _resource_record_post_action 01:59:41 INFO - ##### 01:59:41 INFO - ##### Running read-buildbot-config step. 01:59:41 INFO - ##### 01:59:41 INFO - Running pre-action listener: _resource_record_pre_action 01:59:41 INFO - Running main action method: read_buildbot_config 01:59:41 INFO - Using buildbot properties: 01:59:41 INFO - { 01:59:41 INFO - "project": "", 01:59:41 INFO - "product": "firefox", 01:59:41 INFO - "script_repo_revision": "production", 01:59:41 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 01:59:41 INFO - "repository": "", 01:59:41 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 01:59:41 INFO - "buildid": "20160118233013", 01:59:41 INFO - "pgo_build": "True", 01:59:41 INFO - "basedir": "/builds/slave/test-pgo", 01:59:41 INFO - "buildnumber": 1117, 01:59:41 INFO - "slavename": "talos-linux64-ix-060", 01:59:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:59:41 INFO - "platform": "ubuntu64_hw", 01:59:41 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 01:59:41 INFO - "branch": "b2g-inbound", 01:59:41 INFO - "repo_path": "integration/b2g-inbound", 01:59:41 INFO - "revision": "939a20ef46ea94c7ba92b1113382869d7163e06f", 01:59:41 INFO - "stage_platform": "linux64-pgo", 01:59:41 INFO - "builduid": "23dcafae42894c799cfb52876bbe307f", 01:59:41 INFO - "slavebuilddir": "test" 01:59:41 INFO - } 01:59:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:59:41 INFO - Running post-action listener: _resource_record_post_action 01:59:41 INFO - ##### 01:59:41 INFO - ##### Running download-and-extract step. 01:59:41 INFO - ##### 01:59:41 INFO - Running pre-action listener: _resource_record_pre_action 01:59:41 INFO - Running main action method: download_and_extract 01:59:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:59:41 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')]} 01:59:41 INFO - https://queue.taskcluster.net/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/test_packages.json 01:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/test_packages.json 01:59:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:59:43 INFO - Downloaded 1448 bytes. 01:59:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:59:43 INFO - Using the following test package requirements: 01:59:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:59:43 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:59:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:43 INFO - u'jsshell-linux-x86_64.zip'], 01:59:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:59:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:59:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:59:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:59:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:59:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:43 INFO - https://queue.taskcluster.net/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:59:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/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 01:59:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/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 01:59:45 INFO - Downloaded 22483616 bytes. 01:59:45 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'] 01:59:45 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 01:59:46 INFO - Return code: 0 01:59:46 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 01:59:46 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')]} 01:59:46 INFO - https://queue.taskcluster.net/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:59:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/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 01:59:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/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 01:59:48 INFO - Downloaded 22483616 bytes. 01:59:48 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'] 01:59:48 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 01:59:49 INFO - Return code: 0 01:59:49 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')]} 01:59:49 INFO - https://queue.taskcluster.net/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:59:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:59:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:59:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/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 01:59:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/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 01:59:50 INFO - Downloaded 11132144 bytes. 01:59:50 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'] 01:59:50 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 01:59:51 INFO - Return code: 0 01:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:51 INFO - https://queue.taskcluster.net/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:59:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:59:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:59:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/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 01:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OpCzLsQATG2nLfzi3ykpSA/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 01:59:54 INFO - Downloaded 55927921 bytes. 01:59:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:59:54 INFO - mkdir: /builds/slave/test-pgo/properties 01:59:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:59:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:59:54 INFO - Contents: 01:59:54 INFO - build_url:https://queue.taskcluster.net/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:59:54 INFO - Running post-action listener: _resource_record_post_action 01:59:54 INFO - Running post-action listener: set_extra_try_arguments 01:59:54 INFO - ##### 01:59:54 INFO - ##### Running populate-webroot step. 01:59:54 INFO - ##### 01:59:54 INFO - Running pre-action listener: _resource_record_pre_action 01:59:54 INFO - Running main action method: populate_webroot 01:59:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:59:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:59:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:59:54 INFO - '--tppagecycles', 01:59:54 INFO - '7'], 01:59:54 INFO - 'tests': ['tsvgm']}}, 01:59:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:59:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:59:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:59:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:59:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:59:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:59:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:59:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:54 INFO - 'talos_options': ['--e10s'], 01:59:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:59:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:54 INFO - 'tests': ['damp', 'tps']}, 01:59:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:54 INFO - 'talos_options': ['--e10s'], 01:59:54 INFO - 'tests': ['damp', 'tps']}, 01:59:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:59:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:59:54 INFO - 'other': {'tests': ['a11yr', 01:59:54 INFO - 'ts_paint', 01:59:54 INFO - 'tpaint', 01:59:54 INFO - 'sessionrestore', 01:59:54 INFO - 'sessionrestore_no_auto_restore']}, 01:59:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:59:54 INFO - 'tests': ['a11yr', 01:59:54 INFO - 'ts_paint', 01:59:54 INFO - 'tpaint', 01:59:54 INFO - 'sessionrestore', 01:59:54 INFO - 'sessionrestore_no_auto_restore']}, 01:59:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:59:54 INFO - 'tests': ['a11yr', 01:59:54 INFO - 'ts_paint', 01:59:54 INFO - 'tpaint', 01:59:54 INFO - 'sessionrestore', 01:59:54 INFO - 'sessionrestore_no_auto_restore']}, 01:59:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:59:54 INFO - 'tests': ['a11yr', 01:59:54 INFO - 'ts_paint', 01:59:54 INFO - 'tpaint', 01:59:54 INFO - 'sessionrestore', 01:59:54 INFO - 'sessionrestore_no_auto_restore']}, 01:59:54 INFO - 'other_l64': {'tests': ['a11yr', 01:59:54 INFO - 'ts_paint', 01:59:54 INFO - 'tpaint', 01:59:54 INFO - 'sessionrestore', 01:59:54 INFO - 'sessionrestore_no_auto_restore']}, 01:59:54 INFO - 'other_nol64': {'tests': ['a11yr', 01:59:54 INFO - 'ts_paint', 01:59:54 INFO - 'tpaint', 01:59:54 INFO - 'sessionrestore', 01:59:54 INFO - 'sessionrestore_no_auto_restore']}, 01:59:54 INFO - 'svgr': {'tests': ['tsvgx', 01:59:54 INFO - 'tsvgr_opacity', 01:59:54 INFO - 'tart', 01:59:54 INFO - 'tscrollx', 01:59:54 INFO - 'cart']}, 01:59:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:59:54 INFO - 'tests': ['tsvgx', 01:59:54 INFO - 'tsvgr_opacity', 01:59:54 INFO - 'tart', 01:59:54 INFO - 'tscrollx', 01:59:54 INFO - 'cart']}, 01:59:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:54 INFO - 'tests': ['tp5o']}, 01:59:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:54 INFO - 'talos_options': ['--e10s'], 01:59:54 INFO - 'tests': ['tp5o']}, 01:59:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:54 INFO - 'talos_options': ['--xperf_path', 01:59:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:59:54 INFO - 'tests': ['tp5n']}, 01:59:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:54 INFO - 'talos_options': ['--e10s', 01:59:54 INFO - '--xperf_path', 01:59:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:59:54 INFO - 'tests': ['tp5n']}}, 01:59:54 INFO - 'talos.zip': {'path': '', 01:59:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:59:54 INFO - Running post-action listener: _resource_record_post_action 01:59:54 INFO - ##### 01:59:54 INFO - ##### Running create-virtualenv step. 01:59:54 INFO - ##### 01:59:54 INFO - Running pre-action listener: _resource_record_pre_action 01:59:54 INFO - Running main action method: create_virtualenv 01:59:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:59:54 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 01:59:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:59:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:59:54 INFO - Using real prefix '/usr' 01:59:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:59:54 INFO - Installing distribute.............................................................................................................................................................................................done. 01:59:56 INFO - Installing pip.................done. 01:59:56 INFO - Return code: 0 01:59:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:59:56 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')]} 01:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:56 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')]} 01:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:56 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 0x7f3a01c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70660>, '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 0x1f71560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f71a10>, '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': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', '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 01:59:56 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 01:59:56 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 01:59:56 INFO - Using env: {'DISPLAY': ':0', 01:59:56 INFO - 'HOME': '/home/cltbld', 01:59:56 INFO - 'LANG': 'en_US.UTF-8', 01:59:56 INFO - 'LANGUAGE': 'en_US:en', 01:59:56 INFO - 'LOGNAME': 'cltbld', 01:59:56 INFO - 'MAIL': '/var/mail/cltbld', 01:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:56 INFO - 'MOZ_NO_REMOTE': '1', 01:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:56 INFO - 'NO_EM_RESTART': '1', 01:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:56 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:56 INFO - 'SHELL': '/bin/bash', 01:59:56 INFO - 'SHLVL': '1', 01:59:56 INFO - 'TERM': 'linux', 01:59:56 INFO - 'TMOUT': '86400', 01:59:56 INFO - 'USER': 'cltbld', 01:59:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', 01:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:56 INFO - '_': '/tools/buildbot/bin/python'} 01:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:57 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 01:59:57 INFO - Cleaning up... 01:59:57 INFO - Return code: 0 01:59:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:59: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')]} 01:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59: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')]} 01:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:57 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 0x7f3a01c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70660>, '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 0x1f71560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f71a10>, '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': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', '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 01:59:57 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 01:59:57 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 01:59:57 INFO - Using env: {'DISPLAY': ':0', 01:59:57 INFO - 'HOME': '/home/cltbld', 01:59:57 INFO - 'LANG': 'en_US.UTF-8', 01:59:57 INFO - 'LANGUAGE': 'en_US:en', 01:59:57 INFO - 'LOGNAME': 'cltbld', 01:59:57 INFO - 'MAIL': '/var/mail/cltbld', 01:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:57 INFO - 'MOZ_NO_REMOTE': '1', 01:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:57 INFO - 'NO_EM_RESTART': '1', 01:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:57 INFO - 'SHELL': '/bin/bash', 01:59:57 INFO - 'SHLVL': '1', 01:59:57 INFO - 'TERM': 'linux', 01:59:57 INFO - 'TMOUT': '86400', 01:59:57 INFO - 'USER': 'cltbld', 01:59:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', 01:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:57 INFO - '_': '/tools/buildbot/bin/python'} 01:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:57 INFO - Downloading/unpacking psutil>=0.7.1 01:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:59 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:59:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:59:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:59:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:59:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:59:59 INFO - Installing collected packages: psutil 01:59:59 INFO - Running setup.py install for psutil 01:59:59 INFO - building 'psutil._psutil_linux' extension 01:59:59 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 01:59:59 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 01:59:59 INFO - building 'psutil._psutil_posix' extension 01:59:59 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 01:59:59 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 01:59:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:59:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:59:59 INFO - Successfully installed psutil 01:59:59 INFO - Cleaning up... 01:59:59 INFO - Return code: 0 01:59:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:59:59 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')]} 01:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:59 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')]} 01:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:59 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 0x7f3a01c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70660>, '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 0x1f71560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f71a10>, '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': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', '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 01:59:59 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 01:59:59 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 01:59:59 INFO - Using env: {'DISPLAY': ':0', 01:59:59 INFO - 'HOME': '/home/cltbld', 01:59:59 INFO - 'LANG': 'en_US.UTF-8', 01:59:59 INFO - 'LANGUAGE': 'en_US:en', 01:59:59 INFO - 'LOGNAME': 'cltbld', 01:59:59 INFO - 'MAIL': '/var/mail/cltbld', 01:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:59 INFO - 'MOZ_NO_REMOTE': '1', 01:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:59 INFO - 'NO_EM_RESTART': '1', 01:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:59 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:59 INFO - 'SHELL': '/bin/bash', 01:59:59 INFO - 'SHLVL': '1', 01:59:59 INFO - 'TERM': 'linux', 01:59:59 INFO - 'TMOUT': '86400', 01:59:59 INFO - 'USER': 'cltbld', 01:59:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', 01:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:59 INFO - '_': '/tools/buildbot/bin/python'} 01:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:59:59 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 01:59:59 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 01:59:59 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 01:59:59 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 01:59:59 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 01:59:59 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 02:00:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:00:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:00:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:00:01 INFO - Installing collected packages: mozsystemmonitor 02:00:01 INFO - Running setup.py install for mozsystemmonitor 02:00:01 INFO - Successfully installed mozsystemmonitor 02:00:01 INFO - Cleaning up... 02:00:01 INFO - Return code: 0 02:00:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:00:01 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')]} 02:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:01 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')]} 02:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:01 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 0x7f3a01c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70660>, '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 0x1f71560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f71a10>, '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': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', '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 02:00:01 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 02:00:01 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 02:00:01 INFO - Using env: {'DISPLAY': ':0', 02:00:01 INFO - 'HOME': '/home/cltbld', 02:00:01 INFO - 'LANG': 'en_US.UTF-8', 02:00:01 INFO - 'LANGUAGE': 'en_US:en', 02:00:01 INFO - 'LOGNAME': 'cltbld', 02:00:01 INFO - 'MAIL': '/var/mail/cltbld', 02:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:01 INFO - 'MOZ_NO_REMOTE': '1', 02:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:01 INFO - 'NO_EM_RESTART': '1', 02:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:01 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:01 INFO - 'SHELL': '/bin/bash', 02:00:01 INFO - 'SHLVL': '1', 02:00:01 INFO - 'TERM': 'linux', 02:00:01 INFO - 'TMOUT': '86400', 02:00:01 INFO - 'USER': 'cltbld', 02:00:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', 02:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:01 INFO - '_': '/tools/buildbot/bin/python'} 02:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:02 INFO - Downloading/unpacking blobuploader==1.2.4 02:00:02 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 02:00:02 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 02:00:02 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 02:00:02 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 02:00:02 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 02:00:02 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 02:00:03 INFO - Downloading blobuploader-1.2.4.tar.gz 02:00:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:00:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:00:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:00:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:00:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:00:04 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 02:00:04 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 02:00:04 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 02:00:04 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 02:00:04 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 02:00:04 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 02:00:04 INFO - Downloading docopt-0.6.1.tar.gz 02:00:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:00:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:00:04 INFO - Installing collected packages: blobuploader, requests, docopt 02:00:04 INFO - Running setup.py install for blobuploader 02:00:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:00:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:00:04 INFO - Running setup.py install for requests 02:00:05 INFO - Running setup.py install for docopt 02:00:05 INFO - Successfully installed blobuploader requests docopt 02:00:05 INFO - Cleaning up... 02:00:05 INFO - Return code: 0 02:00:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:05 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 0x7f3a01c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70660>, '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 0x1f71560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f71a10>, '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': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', '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 02:00:05 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 02:00:05 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 02:00:05 INFO - Using env: {'DISPLAY': ':0', 02:00:05 INFO - 'HOME': '/home/cltbld', 02:00:05 INFO - 'LANG': 'en_US.UTF-8', 02:00:05 INFO - 'LANGUAGE': 'en_US:en', 02:00:05 INFO - 'LOGNAME': 'cltbld', 02:00:05 INFO - 'MAIL': '/var/mail/cltbld', 02:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:05 INFO - 'MOZ_NO_REMOTE': '1', 02:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:05 INFO - 'NO_EM_RESTART': '1', 02:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:05 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:05 INFO - 'SHELL': '/bin/bash', 02:00:05 INFO - 'SHLVL': '1', 02:00:05 INFO - 'TERM': 'linux', 02:00:05 INFO - 'TMOUT': '86400', 02:00:05 INFO - 'USER': 'cltbld', 02:00:05 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', 02:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:05 INFO - '_': '/tools/buildbot/bin/python'} 02:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:00:05 INFO - Running setup.py (path:/tmp/pip-j4FRCD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:00:05 INFO - Running setup.py (path:/tmp/pip-y2sbX8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:00:05 INFO - Running setup.py (path:/tmp/pip-1iiyIv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:05 INFO - Running setup.py (path:/tmp/pip-bhxjfO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:05 INFO - Running setup.py (path:/tmp/pip-UxLa4z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:05 INFO - Running setup.py (path:/tmp/pip-OkTTbC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:05 INFO - Running setup.py (path:/tmp/pip-JLsA_Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:05 INFO - Running setup.py (path:/tmp/pip-uJoQXy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:05 INFO - Running setup.py (path:/tmp/pip-nh4cnM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:05 INFO - Running setup.py (path:/tmp/pip-5ZsI9W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:06 INFO - Running setup.py (path:/tmp/pip-9b4STf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:06 INFO - Running setup.py (path:/tmp/pip-MOKxja-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:06 INFO - Running setup.py (path:/tmp/pip-l4yGZs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:06 INFO - Running setup.py (path:/tmp/pip-CnoaVv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:06 INFO - Running setup.py (path:/tmp/pip-YndMUn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:06 INFO - Running setup.py (path:/tmp/pip-8sWXAE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:06 INFO - Running setup.py (path:/tmp/pip-3zQNmv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:00:06 INFO - Running setup.py install for manifestparser 02:00:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:00:06 INFO - Running setup.py install for mozcrash 02:00:06 INFO - Running setup.py install for mozdebug 02:00:06 INFO - Running setup.py install for mozdevice 02:00:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:00:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:00:06 INFO - Running setup.py install for mozfile 02:00:07 INFO - Running setup.py install for mozhttpd 02:00:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:00:07 INFO - Running setup.py install for mozinfo 02:00:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:00:07 INFO - Running setup.py install for mozInstall 02:00:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:00:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:00:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:00:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:00:07 INFO - Running setup.py install for mozleak 02:00:07 INFO - Running setup.py install for mozlog 02:00:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:00:07 INFO - Running setup.py install for moznetwork 02:00:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:00:07 INFO - Running setup.py install for mozprocess 02:00:07 INFO - Running setup.py install for mozprofile 02:00:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:00:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:00:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:00:07 INFO - Running setup.py install for mozrunner 02:00:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:00:08 INFO - Running setup.py install for mozscreenshot 02:00:08 INFO - Running setup.py install for moztest 02:00:08 INFO - Running setup.py install for mozversion 02:00:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:00:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:00:08 INFO - Cleaning up... 02:00:08 INFO - Return code: 0 02:00:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f3a01c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70660>, '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 0x1f71560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f71a10>, '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': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', '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 02:00:08 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 02:00:08 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 02:00:08 INFO - Using env: {'DISPLAY': ':0', 02:00:08 INFO - 'HOME': '/home/cltbld', 02:00:08 INFO - 'LANG': 'en_US.UTF-8', 02:00:08 INFO - 'LANGUAGE': 'en_US:en', 02:00:08 INFO - 'LOGNAME': 'cltbld', 02:00:08 INFO - 'MAIL': '/var/mail/cltbld', 02:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:08 INFO - 'MOZ_NO_REMOTE': '1', 02:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:08 INFO - 'NO_EM_RESTART': '1', 02:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:08 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:08 INFO - 'SHELL': '/bin/bash', 02:00:08 INFO - 'SHLVL': '1', 02:00:08 INFO - 'TERM': 'linux', 02:00:08 INFO - 'TMOUT': '86400', 02:00:08 INFO - 'USER': 'cltbld', 02:00:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', 02:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:08 INFO - '_': '/tools/buildbot/bin/python'} 02:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:00:08 INFO - Running setup.py (path:/tmp/pip-d5HBRi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:00:08 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)) 02:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:00:08 INFO - Running setup.py (path:/tmp/pip-yroJAt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:00:08 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)) 02:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:00:08 INFO - Running setup.py (path:/tmp/pip-mpoYVB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:00:08 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)) 02:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:08 INFO - Running setup.py (path:/tmp/pip-WpwygX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:08 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)) 02:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:08 INFO - Running setup.py (path:/tmp/pip-PI9iqe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:08 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)) 02:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:08 INFO - Running setup.py (path:/tmp/pip-3PYhGM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:09 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)) 02:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:09 INFO - Running setup.py (path:/tmp/pip-UL_ga7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:09 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)) 02:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:09 INFO - Running setup.py (path:/tmp/pip-h6O271-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:09 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)) 02:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:09 INFO - Running setup.py (path:/tmp/pip-SQztBr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:09 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)) 02:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:09 INFO - Running setup.py (path:/tmp/pip-0ZAmdh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:09 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)) 02:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:09 INFO - Running setup.py (path:/tmp/pip-YzZZ0B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:09 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)) 02:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:09 INFO - Running setup.py (path:/tmp/pip-9ay34S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:09 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)) 02:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:09 INFO - Running setup.py (path:/tmp/pip-Fwf92p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:09 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)) 02:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:09 INFO - Running setup.py (path:/tmp/pip-PYV10e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:09 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)) 02:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:09 INFO - Running setup.py (path:/tmp/pip-zrSGzc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:09 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)) 02:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:09 INFO - Running setup.py (path:/tmp/pip-x9M6Gn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:09 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)) 02:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:09 INFO - Running setup.py (path:/tmp/pip-ek30XE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:09 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)) 02:00:09 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)) 02:00:09 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)) 02:00:09 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)) 02:00:09 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)) 02:00:09 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)) 02:00:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:00:09 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 02:00:09 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 02:00:09 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 02:00:09 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 02:00:09 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 02:00:09 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 02:00:11 INFO - Downloading blessings-1.5.1.tar.gz 02:00:11 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 02:00:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:00:11 INFO - Installing collected packages: blessings 02:00:11 INFO - Running setup.py install for blessings 02:00:11 INFO - Successfully installed blessings 02:00:11 INFO - Cleaning up... 02:00:11 INFO - Return code: 0 02:00:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:00:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:00:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:00:11 INFO - Reading from file tmpfile_stdout 02:00:11 INFO - Current package versions: 02:00:11 INFO - argparse == 1.2.1 02:00:11 INFO - blessings == 1.5.1 02:00:11 INFO - blobuploader == 1.2.4 02:00:11 INFO - docopt == 0.6.1 02:00:11 INFO - manifestparser == 1.1 02:00:11 INFO - mozInstall == 1.12 02:00:11 INFO - mozcrash == 0.16 02:00:11 INFO - mozdebug == 0.1 02:00:11 INFO - mozdevice == 0.48 02:00:11 INFO - mozfile == 1.2 02:00:11 INFO - mozhttpd == 0.7 02:00:11 INFO - mozinfo == 0.9 02:00:11 INFO - mozleak == 0.1 02:00:11 INFO - mozlog == 3.1 02:00:11 INFO - moznetwork == 0.27 02:00:11 INFO - mozprocess == 0.22 02:00:11 INFO - mozprofile == 0.28 02:00:11 INFO - mozrunner == 6.11 02:00:11 INFO - mozscreenshot == 0.1 02:00:11 INFO - mozsystemmonitor == 0.0 02:00:11 INFO - moztest == 0.7 02:00:11 INFO - mozversion == 1.4 02:00:11 INFO - psutil == 3.1.1 02:00:12 INFO - requests == 1.2.3 02:00:12 INFO - wsgiref == 0.1.2 02:00:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:00:12 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')]} 02:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:12 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')]} 02:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:12 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 0x7f3a01c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70660>, '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 0x1f71560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f71a10>, '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': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', '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 02:00:12 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 02:00:12 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 02:00:12 INFO - Using env: {'DISPLAY': ':0', 02:00:12 INFO - 'HOME': '/home/cltbld', 02:00:12 INFO - 'LANG': 'en_US.UTF-8', 02:00:12 INFO - 'LANGUAGE': 'en_US:en', 02:00:12 INFO - 'LOGNAME': 'cltbld', 02:00:12 INFO - 'MAIL': '/var/mail/cltbld', 02:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:12 INFO - 'MOZ_NO_REMOTE': '1', 02:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:12 INFO - 'NO_EM_RESTART': '1', 02:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:12 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:12 INFO - 'SHELL': '/bin/bash', 02:00:12 INFO - 'SHLVL': '1', 02:00:12 INFO - 'TERM': 'linux', 02:00:12 INFO - 'TMOUT': '86400', 02:00:12 INFO - 'USER': 'cltbld', 02:00:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', 02:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:12 INFO - '_': '/tools/buildbot/bin/python'} 02:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:12 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)) 02:00:12 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)) 02:00:12 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)) 02:00:12 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)) 02:00:12 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)) 02:00:12 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)) 02:00:12 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)) 02:00:12 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)) 02:00:12 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)) 02:00:12 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)) 02:00:12 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)) 02:00:12 INFO - Cleaning up... 02:00:12 INFO - Return code: 0 02:00:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:00:12 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')]} 02:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:12 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')]} 02:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:12 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 0x7f3a01c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70660>, '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 0x1f71560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f71a10>, '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': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', '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 02:00:12 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 02:00:12 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 02:00:12 INFO - Using env: {'DISPLAY': ':0', 02:00:12 INFO - 'HOME': '/home/cltbld', 02:00:12 INFO - 'LANG': 'en_US.UTF-8', 02:00:12 INFO - 'LANGUAGE': 'en_US:en', 02:00:12 INFO - 'LOGNAME': 'cltbld', 02:00:12 INFO - 'MAIL': '/var/mail/cltbld', 02:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:12 INFO - 'MOZ_NO_REMOTE': '1', 02:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:12 INFO - 'NO_EM_RESTART': '1', 02:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:12 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:12 INFO - 'SHELL': '/bin/bash', 02:00:12 INFO - 'SHLVL': '1', 02:00:12 INFO - 'TERM': 'linux', 02:00:12 INFO - 'TMOUT': '86400', 02:00:12 INFO - 'USER': 'cltbld', 02:00:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', 02:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:12 INFO - '_': '/tools/buildbot/bin/python'} 02:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:12 INFO - Downloading/unpacking jsonschema 02:00:12 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 02:00:12 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 02:00:12 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 02:00:12 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 02:00:12 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 02:00:12 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 02:00:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:00:14 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 02:00:14 INFO - Downloading/unpacking functools32 (from jsonschema) 02:00:14 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 02:00:14 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 02:00:14 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 02:00:14 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 02:00:14 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 02:00:14 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 02:00:14 INFO - Downloading functools32-3.2.3-2.tar.gz 02:00:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:00:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:00:14 INFO - warning: no files found matching '*.txt' 02:00:14 INFO - no previously-included directories found matching 'build' 02:00:14 INFO - no previously-included directories found matching 'dist' 02:00:14 INFO - no previously-included directories found matching '.git*' 02:00:14 INFO - Installing collected packages: jsonschema, functools32 02:00:14 INFO - Running setup.py install for functools32 02:00:14 INFO - warning: no files found matching '*.txt' 02:00:14 INFO - no previously-included directories found matching 'build' 02:00:14 INFO - no previously-included directories found matching 'dist' 02:00:14 INFO - no previously-included directories found matching '.git*' 02:00:14 INFO - Successfully installed jsonschema functools32 02:00:14 INFO - Cleaning up... 02:00:14 INFO - Return code: 0 02:00:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:00:14 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')]} 02:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:14 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')]} 02:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:14 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 0x7f3a01c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70660>, '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 0x1f71560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f71a10>, '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': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', '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 02:00:14 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 02:00:14 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 02:00:14 INFO - Using env: {'DISPLAY': ':0', 02:00:14 INFO - 'HOME': '/home/cltbld', 02:00:14 INFO - 'LANG': 'en_US.UTF-8', 02:00:14 INFO - 'LANGUAGE': 'en_US:en', 02:00:14 INFO - 'LOGNAME': 'cltbld', 02:00:14 INFO - 'MAIL': '/var/mail/cltbld', 02:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:14 INFO - 'MOZ_NO_REMOTE': '1', 02:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:14 INFO - 'NO_EM_RESTART': '1', 02:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:14 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:14 INFO - 'SHELL': '/bin/bash', 02:00:14 INFO - 'SHLVL': '1', 02:00:14 INFO - 'TERM': 'linux', 02:00:14 INFO - 'TMOUT': '86400', 02:00:14 INFO - 'USER': 'cltbld', 02:00:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', 02:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:14 INFO - '_': '/tools/buildbot/bin/python'} 02:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:14 INFO - Downloading/unpacking flake8 02:00:14 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 02:00:14 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 02:00:14 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 02:00:14 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 02:00:14 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 02:00:14 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 02:00:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:00:16 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 02:00:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:00:16 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 02:00:16 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 02:00:16 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 02:00:16 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 02:00:16 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 02:00:16 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 02:00:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:00:16 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 02:00:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:00:16 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 02:00:16 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 02:00:16 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 02:00:16 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 02:00:16 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 02:00:16 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 02:00:17 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 02:00:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:00:17 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 02:00:17 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 02:00:17 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 02:00:17 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 02:00:17 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 02:00:17 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 02:00:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:00:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:00:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:00:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:00:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:00:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:00:17 INFO - no previously-included directories found matching 'docs/_build' 02:00:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:00:17 INFO - Running setup.py install for pep8 02:00:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:00:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:00:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:00:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:00:17 INFO - no previously-included directories found matching 'docs/_build' 02:00:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:00:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:00:17 INFO - Cleaning up... 02:00:17 INFO - Return code: 0 02:00:17 INFO - Running post-action listener: _resource_record_post_action 02:00:17 INFO - Running post-action listener: _start_resource_monitoring 02:00:17 INFO - Starting resource monitoring. 02:00:17 INFO - ##### 02:00:17 INFO - ##### Running install step. 02:00:17 INFO - ##### 02:00:17 INFO - Running pre-action listener: _resource_record_pre_action 02:00:17 INFO - Running main action method: install 02:00:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:00:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:00:17 INFO - Reading from file tmpfile_stdout 02:00:17 INFO - Detecting whether we're running mozinstall >=1.0... 02:00:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:00:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:00:17 INFO - Reading from file tmpfile_stdout 02:00:17 INFO - Output received: 02:00:17 INFO - Usage: mozinstall [options] installer 02:00:17 INFO - Options: 02:00:17 INFO - -h, --help show this help message and exit 02:00:17 INFO - -d DEST, --destination=DEST 02:00:17 INFO - Directory to install application into. [default: 02:00:17 INFO - "/builds/slave/test-pgo"] 02:00:17 INFO - --app=APP Application being installed. [default: firefox] 02:00:17 INFO - mkdir: /builds/slave/test-pgo/build/application 02:00:17 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'] 02:00:17 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 02:00:33 INFO - Reading from file tmpfile_stdout 02:00:33 INFO - Output received: 02:00:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:00:33 INFO - Running post-action listener: _resource_record_post_action 02:00:33 INFO - ##### 02:00:33 INFO - ##### Running run-tests step. 02:00:33 INFO - ##### 02:00:33 INFO - Running pre-action listener: _resource_record_pre_action 02:00:33 INFO - Running main action method: run_tests 02:00:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:00:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:00:33 INFO - Python 2.7.3 02:00:33 INFO - Return code: 0 02:00:33 INFO - grabbing minidump binary from tooltool 02:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:33 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 0x1f70660>, '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 0x1f71560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f71a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:00:33 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 02:00:33 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 02:00:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:00:33 INFO - Return code: 0 02:00:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:00:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:00:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:00:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:00:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:00:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:00:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:00:34 INFO - Return code: 0 02:00:34 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/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 02:00:34 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/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 02:00:34 INFO - Using env: {'DISPLAY': ':0', 02:00:34 INFO - 'HOME': '/home/cltbld', 02:00:34 INFO - 'LANG': 'en_US.UTF-8', 02:00:34 INFO - 'LANGUAGE': 'en_US:en', 02:00:34 INFO - 'LOGNAME': 'cltbld', 02:00:34 INFO - 'MAIL': '/var/mail/cltbld', 02:00:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:00:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:34 INFO - 'MOZ_NO_REMOTE': '1', 02:00:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:34 INFO - 'NO_EM_RESTART': '1', 02:00:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:34 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:00:34 INFO - 'SHELL': '/bin/bash', 02:00:34 INFO - 'SHLVL': '1', 02:00:34 INFO - 'TERM': 'linux', 02:00:34 INFO - 'TMOUT': '86400', 02:00:34 INFO - 'USER': 'cltbld', 02:00:34 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094', 02:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:34 INFO - '_': '/tools/buildbot/bin/python'} 02:00:34 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/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 02:00:35 INFO - mozversion application_buildid: 20160118233013 02:00:35 INFO - mozversion application_changeset: 939a20ef46ea94c7ba92b1113382869d7163e06f 02:00:35 INFO - mozversion application_display_name: Nightly 02:00:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:00:35 INFO - mozversion application_name: Firefox 02:00:35 INFO - mozversion application_remotingname: firefox 02:00:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 02:00:35 INFO - mozversion application_vendor: Mozilla 02:00:35 INFO - mozversion application_version: 46.0a1 02:00:35 INFO - mozversion platform_buildid: 20160118233013 02:00:35 INFO - mozversion platform_changeset: 939a20ef46ea94c7ba92b1113382869d7163e06f 02:00:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 02:00:35 INFO - mozversion platform_version: 46.0a1 02:00:35 INFO - using testdate: 1453197635 02:00:35 INFO - actual date: 1453197635 02:00:35 INFO - starting webserver on 'localhost:57217' 02:00:35 INFO - SUITE-START | Running 3 tests 02:00:35 INFO - TEST-START | dromaeo_css 02:00:35 INFO - operating with platform_type : linux_ 02:00:35 INFO - Initialising browser for dromaeo_css test... 02:00:35 INFO - TEST-INFO | started process 8715 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdP6S1H/profile http://localhost:57217/getInfo.html) 02:00:38 INFO - PROCESS | 8715 | __metrics Screen width/height:1600/1200 02:00:38 INFO - PROCESS | 8715 | colorDepth:24 02:00:38 INFO - PROCESS | 8715 | Browser inner width/height: 1024/697 02:00:38 INFO - PROCESS | 8715 | __metrics 02:00:39 INFO - PROCESS | 8715 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:00:39 INFO - PROCESS | 8715 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:00:40 INFO - TEST-INFO | 8715: exit 0 02:00:40 INFO - Browser initialized. 02:00:40 INFO - Running cycle 1/1 for dromaeo_css test... 02:00:40 INFO - TEST-INFO | started process 8805 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdP6S1H/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:00:51 INFO - PROCESS | 8805 | RSS: Main: 148705280 02:00:51 INFO - PROCESS | 8805 | 02:01:43 INFO - PROCESS | 8805 | 1453197703420 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] 02:03:51 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:57217/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57217/tests/dromaeo/cssquery-ext.html) 02:03:52 INFO - PROCESS | 8805 | RSS: Main: 234930176 02:03:52 INFO - PROCESS | 8805 | 02:06:54 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:57217/tests/dromaeo/cssquery-ext.html (next: http://localhost:57217/tests/dromaeo/cssquery-jquery.html) 02:06:55 INFO - PROCESS | 8805 | RSS: Main: 229040128 02:06:55 INFO - PROCESS | 8805 | 02:09:57 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:57217/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57217/tests/dromaeo/cssquery-mootools.html) 02:09:57 INFO - PROCESS | 8805 | RSS: Main: 231370752 02:09:57 INFO - PROCESS | 8805 | 02:12:59 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:57217/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57217/tests/dromaeo/cssquery-prototype.html) 02:13:00 INFO - PROCESS | 8805 | RSS: Main: 206000128 02:13:00 INFO - PROCESS | 8805 | 02:16:02 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:57217/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57217/tests/dromaeo/cssquery-yui.html) 02:16:03 INFO - PROCESS | 8805 | RSS: Main: 212545536 02:16:03 INFO - PROCESS | 8805 | 02:19:06 INFO - PROCESS | 8805 | Cycle 1(1): loaded http://localhost:57217/tests/dromaeo/cssquery-yui.html (next: http://localhost:57217/tests/dromaeo/cssquery-dojo.html) 02:19:06 INFO - PROCESS | 8805 | RSS: Main: 235212800 02:19:06 INFO - PROCESS | 8805 | 02:19:06 INFO - PROCESS | 8805 | __start_tp_report 02:19:06 INFO - PROCESS | 8805 | _x_x_mozilla_page_load 02:19:06 INFO - PROCESS | 8805 | _x_x_mozilla_page_load_details 02:19:06 INFO - PROCESS | 8805 | |i|pagename|runs| 02:19:06 INFO - PROCESS | 8805 | |0;dojo.html;3096.845157742113;3108.720215180633;3155.021943197609;3159.7630177736673;3180.777345585809;4997.675151115175;5075.746212689364;5079.79680812767;5098.107831129551;5124.769385377657;5092.923606145901;5123.180291153416;5150.4334523202415;5155.664881782691;5168.767405466753;4599.931001034987;4615.030843522864;4628.675992680513;4673.252279635259;4781.928271075936;4687.921777991064;4696.365990591277;4730.0776348612035;4775.188218002948;4782.04359128174;4523.434570678665;4580.679352445331;4590.495045544987;4600.884977875547;4669.1362098011805;4624.838130665445;4625.838095666669;4629.328747331651;4660;4691.62467002639;4538.183127037132;4617.953820461786;4624.768761561909;4631.62946964242;4659.231226847566;4840.757962101916;4859.73271470069;4867.245576935581;4892.021595680842;4965.205567109281;5284.867878303035;5299.814506492255;5306.071437498423;5306.893862122774;5345.663584103974;5246.501582349709;5349.652272602269;5356.758945847446;5359.633293510169;5359.785608575652;5036.748162591893;5074.188129899236;5078.873028174326;5099.23511473282;5181.093308671006;5479.04116779562;5498.835034948958;5510.090835012258;5517.393086760453;5517.944820551743;5228.477152284817;5301.284326615934;5325.068113080273;5328.547073498718;5341.679499230058;5291.867703307371;5351.277577526984;5351.652142610717;5352.063388907003;5401.513863752202;5312.495312945264;5394.163904594794;5406.756695948692;5413.623490833178;5464.207689884945;5360.142377219626;5407.324084489439;5414.648047876875;5427.891442171213;5456.590755693339;4198.349255865346;4241.597048280409;4250.659947204216;4251.404803327537;4274.957250427518;3786.1291902861944;3822.140018495816;3837.6929845612285;3864.3237433449594;3870.1098747288283;4975.651704380731;5031.22016087507;5060.544550990428;5082.161443361878;5092.567131793839;5407.621466497308;5485.4788795064405;5486.204500347428;5501.477359650827;5505.752241149158;5097.64316497849;5111.207762796773;5123.38519377677;5124.15451450514;5179.482051794866;4633.513481084437;4694.7417892016265;4695.7886895089805;4721.268203428474;4783.904321913612;5598.608097433222;5659.886802263932;5671.858203544944;5694.174344719992;5699.145128230799;5464.28964234647;5478.91781623284;5482.23248745168;5483.7806487740045;5526.55787536988;5544.972275138599;5630.943690563042;5645.520130788929;5687.118496633028;5756.366799651951;5413.323334583177;5413.675179489243;5418.810341638024;5424.728763561885;5427.864303392289;5345.305110335631;5474.288342515448;5483.369412517612;5492.148716948879;5533.695646739468;5169.92245116316;5284.9735751320995;5339.439358867263;5356.089464790917;5387.353517577916;5317.521423071942;5326.6537675050995;5328.60035497347;5330.760115794876;5376.623636345575;5176.689398636094;5237.633365664519;5238.214267859851;5238.476152384731;5269.57843372537;5337.22610221508;5357.598180136583;5364.6512976656395;5396.487333703292;5420.53925416344;5173.896522069613;5190.8961820764125;5196;5196.766145523385;5201 02:19:06 INFO - PROCESS | 8805 | |1;ext.html;517.5600739371534;526.0872386409576;540.3866611396065;559.9412061733518;571.2944513525795;28664.28339291519;28983.420331593356;29082.563761543566;29087.127386178396;29089.563656545168;37850.62149378505;38149.427758583646;38195.23609527808;38198.42702359467;38230.80884595573;8367.288780453653;8563.229309362156;8567.228949394554;8567.700130495434;8570.228679418851;7474.364679002291;7641.732539361124;8256.091829898707;8426.705065322714;9843.507824608741;9800.950995245013;9865.852012219822;9867.309288349818;9879.654212102578;9881.703548893545;9763.316567840255;9828.312018158731;9898.851517227247;9927.503624818766;9933.652322168726;9658.082482164184;9768.36505627139;9792.657256995972;9793.853092203552;9801.852972205423;35525.82237088798;35923;35924.64075359239;35971.82014089913;38759;3229.257270827723;3230.6769323067742;3254.560634314361;3378.1385746634696;3664.175560498893;28519;28867;29635.259118522208;30233.244168895733;30357.696423035708;3935.3703407454955;3940.2513522430645;3998.1204135090234;4002.139539998914;4009.8797036088963;262212;262464;263118;263556.68221658963;263733;51585.484145158065;52413;56355.15467267994;56727.71636141793;56970;52613.7369313151;52720.472795271555;52778.73610631922;52925.20612190743;52941;12339.444724987397;12383.814242786366;12418.565350212699;12421.75156496865;12426.130170887951;10053.04496072872;10168.237382196365;10168.745781355377;10172.542235599416;10174;18497.075146242634;18647.347342842935;19391.22435102608;19393.612127757366;19422.514437139183;7721.65252563636;7899.881501777478;7919.168487308865;7937.880931786028;8045.557494337868;900.6667533012696;912.1608120529129;946.3281070440065;961.4711908450324;1060.4379678770265;24387;24531.264062078168;24708.13521526738;24809.5038099237;25022;988.6885631026204;999.3154689038032;1052.343652865846;1084.6637542361893;1172.8592568891788;13169.407376668072;13599.660008499866;14077;14182.716345673029;14290.142591444546;313741;317747;317973;318254;318608;47358;47741.5225847744;47760.28359574609;47786.522134778905;47791.76104119457;1308.8298521192185;1326.6948601821634;1349.2376807103956;1352.3914238592672;1360.0003997062151;25721;26536.867315663298;26862.865685671448;26969.460610787282;26970.595441068006;43254.13491730211;43650.78174609107;43677.78161109174;43701.344479832194;43704.53693288339;293153;295958;296144;297038;297126;27807.721922780514;27963.58054629223;30346.39307213799;31609.841950790098;32177.83911080523;36973.26053478861;37227;37494.43758343573;37560;37929.62070379261;31603.683963160074;31948.68051319457;32063.35873282568;32441.83779081184;32642.02073937786;29549;33690.954189214644;34113.31773364569;37167.814160929025;38357.424638629884;32091.19772005625;32446.513302300013;33651.49522757112;33658.158546036546;33697.494537581464;28877.7112228875;30195.69804301929;30646.540301895937;30862.228444289074;31111.844440778557;23619.527609448058;23862.88068559646;23896.64155037641;23925;23944.64083038721 02:19:06 INFO - PROCESS | 8805 | |2;jquery.html;370.89800304916145;371.0445602573374;376.9264993326301;376.9509963704718;377.9603141670125;14025.859741402583;14640.707185856276;15587.688246235082;16971;17660.205290761915;10593.629222977197;10897.291676041052;10924.126069914408;10932;13040.869591304085;3817.1983883384523;4890.7554622268835;5075.213341932006;5077.187649976005;5082.110630639641;3877.3602355611292;5362.65142765719;5526.917096243559;5584.888302233953;5593.188987596796;5188.818391356303;5414.810481633143;5418.9458105419035;5539.778408863641;5571.498565129137;5279.577633789288;5297.814576489824;5298.496642818926;5705.65766054034;6097.908531372033;5425.484578964992;5428.728563571805;5434.728263586805;5438.646487978269;5444.6188766786345;14808;18212.90893545537;18722.251109955585;18738.250469981183;19549.902250488798;2038.8368930485526;2058.8455865810124;2142.8928553572414;2159.3953692965993;2174.6082507195406;9604.423734575877;9605.663801766974;9615.23078153753;9650.324477286593;9735.951320243425;1777.306850328373;1803.567143885458;1836.504143881158;1847.5658220318214;1855.2949879045875;56561.717191414195;57245;58621.413785862445;58935.115973260865;59032.704836475976;9907.80184396308;10091.7477063074;10338.37969721804;10347.327423717434;10403;13628.386722597506;13717.519886803913;13727.382267797973;13740.10689305192;13754.65613359674;7131.71473141079;7133.5719856808755;7151.141862976372;7195.280471952763;7234;6614.206295244601;6620.569662971891;6634.170728658918;6681.665916704145;6696.665166741644;4098.897527561775;4285.892852678708;4289.9571004289555;4453.821847126143;4558.3162525620755;1788.839004489602;1808.7015642419117;1820.6449742300124;1853.8146185381624;1875.5967466994662;923.5613083785282;930.1489137439303;936.6862101196176;955.2739917662626;977.1986970684113;15652.373905043898;16561.337546498005;16725;16921.637520031014;16923;909.6004007399849;911.9133682300171;912.4342907397456;948.3503799897093;968.8449848024283;9276.953615231881;9514.38156519824;9876.654317098866;9893.505324733735;9965.302428829913;466570;501769;509907;518813;528051;45418.77290613526;46276.53723462722;46388.53611463909;68986.31013689798;71586;1072.3351522056219;1095.7041598768446;1109.57836022311;1127.3686735428023;1132.6092498088146;11513.481893314653;14413;14494.420223190955;14511.564653060424;14764.187969661773;29259.70740292655;29666.851665741535;29864.25339366446;30552.541711874783;30903;36235.63764362428;39993.400098997954;40822.59177408188;41892.581074190086;42574.361384579875;7083.327083927019;7463.738769143054;7497.325240728361;7567.129780075142;7595.696172153052;9818.558164882741;10332.225083118947;10389.584416623251;10441.033320853612;11491.597794077166;9281.350305478552;9331.58007889633;9623.807523849624;9636.373635713657;9779.657711980046;9689.515524223902;9719.708408747749;9733.659321923698;9851.901480985385;10161.491925403849;9693.515324233618;10102.494875256061;10196.541155647865;10229.590816367261;10253.282270241012;7014.719411223494;7032.663793879146;7236.565806051653;7298.635068246673;7346.375558077623;9219.631214751334;9267.609858521275;9511.714648560554;9533.761655958657;9542.141207291377 02:19:06 INFO - PROCESS | 8805 | |3;mootools.html;1333.1068184316507;1413.9293035348232;1415.915045097294;1528.5567185516195;1698.9745153822694;6937.895931561025;7427.220141885098;7570.470067095299;7584.241575842427;7598.0502437195355;7404.259574042593;7585.658645360958;7599.35405490534;7600.7339743109005;7606.543607383561;2012.7886571909958;2055.722477465538;2310.861348319106;2360.3155085025364;2385.0459816073535;2344.812415006795;2344.9531009379803;2370.182287110944;2371.8576885386847;2373.95252094958;2179.0847843905517;2214.446388402899;2218.4897473581086;2222;2228.342638921522;2269.265535030293;2297.954040919189;2367.4199821043867;2375.572396968545;2378.6907701998803;2354.6232602783643;2365.467769751809;2375.70303712036;2380.976190238093;2405.6271277951946;7843.254890785366;7883.251091146332;7888.802779930547;7899.605019748989;7919.366450683931;4838.661293709441;4908.631852611068;4927.6550641455115;4937.7777999990085;4938.777755001033;3290.3912776136253;3346.7991920484606;3397.711194548466;3423.5549378580627;3429.1255729788745;1081.4679336805684;1090.7273181704575;1091.9316720016777;1101.1521128730913;1117.1063149480383;10706.143508519377;10738.624148154855;10769.138468922545;10775.946120269427;10778.245522813406;4502.527234640381;4516.525764794715;4553.908921821545;4578.908421831545;4596.172688916027;9151.267898568098;9181.908180918106;9186.908130918739;9191.08089191089;9220.262379009662;4943.950560494421;4958.355413796184;4959.479254678206;4962.454130045692;4963.106640804617;4488.416505854283;4534.818607255673;4538.704984176018;4546.636269098464;4548.886277843014;3477.5305333779615;3568.1614820517157;3572.5355703758864;3731.421629647409;3808.447775072599;1214.5020541578087;1237.3132911234352;1238.3003602964297;1264.4436447962867;1270.371166272701;1308.3523655790445;1310.2322188087783;1337.1375462826422;1354.4920654754467;1370.712150448417;7121.501494895308;7184.82037949045;7298.781036568911;7303;7306.671199796022;1097.1771171621283;1109.8002359575194;1116.179607988128;1122.0518661730825;1123.1688550472754;5723.656580605177;5784.421557844266;5786.04530252512;5788.623739456922;5801.216835727123;9170.220531254785;9361.485118318558;9538.475383853816;9578.425294482353;9607.663731769355;9427.481488518197;9490.288228382899;9558.95220523893;9576.521173941275;9600.711978640651;7150.606716630531;7309.232530584319;7341.853162936818;7405.555666660018;7410.740624078024;7069.39910107626;7149.106361704787;7160.606166660884;7160.964195178991;7168.784936451915;8156.510609363457;8432.83134337322;8438.578071096297;8505.149485051692;8625.784355391166;8700.695475658575;8860.601272942862;8862.379633425599;8891.155340242667;8893.199612034949;6882.5870447773295;6968.198657154492;6979.302069793183;7055.153381594037;7059.682314295766;6633.502487313567;6847.1783385994;7127.429805615435;7326.670299836626;7355.521891077063;6802.455803535607;6911.654417279015;6963.303669632996;7017.333353331425;7048.471364647775;6727.192736871607;6851.931480685129;6876.69054892521;6897.827554311182;6960.095187625576;6985.917182836669;7031.1211098612675;7035.964820176071;7036.929630703832;7044.154701435656;6246.063090536274;6299.275583307795;6393.6483493408305;6417.26201486835;6420.775272865428;6527.640979746159;6569.277379488157;6575.046618240232;6578.473722102316;6579.572327798678 02:19:06 INFO - PROCESS | 8805 | |4;prototype.html;340.8721729351493;350.70015137057817;351.9472079188123;354.7959923044249;357.32465639940517;5768.105943578752;5862.648241105531;5875.559333050022;5882.4705776480105;5891.705414729267;5640.971795141028;5823.708814559266;5828.912566311508;5851;5861.325947516037;4541.205289074415;4542.636589072867;4542.8864278392975;4542.909141817162;4543.886402839939;4370.6503479721705;4445.288753799393;4457.531959144292;4544.863654090383;4548.545145485442;4483.968687201946;4494.842680506183;4508.526604706508;4514.661400394967;4514.841980530682;4497.055618320157;4505.481869584991;4514.255147900592;4518.141553104932;4524.411826462571;3980.681545476355;3986.900327491807;3989.4813674222455;3992.3811809169624;3994.1612261425134;5478.123500239983;5580.386157522669;5591.916121258185;5706.514946229576;5723.942760572424;5227.712475813829;5231.790728370861;5236.581073514109;5243.711595862226;5244.501772331622;5901.23283973085;6235.376462353774;6239.688015599202;6240.907841127784;6242.843928901769;4248.447701798777;4252.787360631956;4330.069035157457;4349.847755328548;4354.325079612665;6366.236051673783;6441.484681225537;6454.064160696673;6458.677066146721;6459;4450;4452.30989196675;4455.509893911667;4455.933161002587;4456.598906098402;4374.650027997753;4504.774761261924;4507.684462087688;4512.954870451254;4549.112922979987;5218.582513398919;5219.817306394258;5220.060389129993;5220.791168353299;5222.608304377187;6244.406781355764;6259.624422534663;6271.905921411182;6274.090256912722;6281.246250449975;1572.2296074923206;1603.6792641471518;1604.430427198351;1604.9438269660507;1605.6949179655828;1063.6915294564644;1070.9518071686794;1084.2356138922041;1088.6353071721062;1104.1222228328497;5916.112583112567;5930.851728706731;5934.1692163097205;5941.435563621449;5943;6421.486281097501;6421.614703117828;6422;6423.164988551458;6436.163298771224;5913.438223368773;5914.053751399755;5919.911201331984;5921.703914804242;5926.822195334147;3368.4778859276853;3458.7060099891287;3466.5493485846678;3467.393206188907;3505.5968563615;6748.156480439945;6811.148606424197;6815.7614483493835;6816.727330906709;6817.181938167352;6571.145751052332;6636.30318816527;6638.269790323061;6639.468842492589;6642.66786660665;6597.637129957802;6784.118064651662;6786.423154031962;6795.660216989229;6797.150356205376;6224.408681175281;6395.93604063972;6457.483401327976;6482.70827812759;6484.221893372825;6273.874522509615;6320.178376810985;6395.328490508429;6408;6408.743650253938;6748.325167483409;6771.424428923597;6779.186497620317;6779.457643388616;6784.3894049535775;4365.585269399402;4463.665225108195;4483.170613436525;4489.551044895485;4493.438320209973;6344.302126766144;6350.206224221973;6401.711922963571;6407.679616019273;6420.26166990802;6249.156363890998;6255.593386429868;6257.7184026718;6267.968660156853;6270.2475702915945;6103.420175083537;6242.93870042103;6244.562880598314;6249.7500099997305;6258.530610204162;6164;6191.7523299069335;6193.597416167935;6200.100985357008;6201.81394558164;6313.273973492924;6341.8097457076365;6347.17486726741;6348.714307856065;6360.809175724736;6067.54493412987;6069;6137.3862613738265;6199.690015499117;6203.2556093269095 02:19:06 INFO - PROCESS | 8805 | |5;yui.html;721.4192574977145;754.9924500754997;783.9176886426925;828.701667399736;832.9791755206119;13180.340982950851;13280.402381892814;13288.269145197035;13339.132956357842;13371.531996380116;12046.156769026149;12088.818667719992;12092.093093018037;12102;12130.150889437742;664.2261765043718;672.559473544829;674.9190097188344;750.8761054426027;761.5659074327635;809.9433039687224;811.3711873298182;817.5176645778989;820.9548474833882;825.686239229092;856.2678909532353;857.3612658569343;857.3998201259112;857.4555157475017;862.779991102268;702.8242939265184;708.3872450330452;842.2840585502336;854.8589482735341;863.0765081362944;619.4827319188483;619.6344156947378;620.3672254300589;627.6861569215392;628.3214128740995;13380.330983450789;13404.195748255039;13445;13480.393382297721;13484.865151348458;12064.733203013733;12856.678583035406;12905.741885162339;13058.542950996669;13149.276789776559;10159.746006349826;10239.334443261165;10315.277930544866;10415.791684166274;10521;3530.276293359855;3543.7265386185622;3569.94645080324;3576.8748093816594;3599.4780756790383;45277;45490.95290711926;45604.54395456036;45656.543434565894;45838.999999999665;10005.649802257032;10106.848397274047;10109.34289271195;10241.436720980417;10435.269531132899;17666.293348265925;17705.7344139838;17791.55521111957;17875.106244687715;17962;7209.387202087776;7416.0729908761405;7868.370530357558;7874.566898820505;7901.723439679584;4345.065810850682;4374.671899607542;4381.671374646914;4459.44256967879;4494.235979883428;3011.623547056618;3033.226527235585;3049.4663433898977;3051.908442746721;3061.5713800068006;578.8842231553706;596.7195418153461;606.2936678769184;610.9786157484467;612.1185492890313;538.6148903533992;580.2946948015718;658.808945405827;660.3957378998163;667.9079704682879;7792.532448053135;8114.269715725495;8286.751397458085;8290.253877151084;8396.496210227406;478.73908719747124;485.78139837073456;487.48570258377754;536.265316516375;569.4277251362354;3787.3750831113107;3848.461215429842;3947.684185265172;3980.960190398059;3981.9203615927518;53973;54410.72794636081;54414;54533.45466545284;56067.43932560704;47985;48176;48718.512814872105;48884.51115488871;49154.75422622936;44584;44862.55137448649;45303.54696453059;45314.32028519641;45983.31025034627;7825.686972521035;7959.442839001446;8103.959480202561;8175.509469431853;8281.751547453587;32889.01332960015;33072;33660.831695842346;33969.830150849084;34059.82970085134;39933;41261.79369103135;44456.555434446534;44654.55345446634;45285.32072018857;9715;9920.363140081805;9948.900510994798;10081.395116293046;10198.43908585035;11243.66269011931;11288.096952243965;11321.71695707614;11669.533218671158;11887.346195959306;10201.642942496977;10611.575536978744;10805.51375188134;10967.122630189726;11047.72380690489;10070;10136.290459667753;10296.07335339823;10324.845127323246;10576.314438513053;9828.901710983084;9832.9016709832;10145.08694217524;10164.695059148238;10185.898141018495;8287.544185069879;8590;8703.216710496086;8793.692220772498;8885.378023538291;7892.4080693947035;8138.186181381814;8214.63034163476;8270.751877443687;8682.262007729161 02:19:06 INFO - PROCESS | 8805 | __end_tp_report 02:19:06 INFO - PROCESS | 8805 | __start_cc_report 02:19:06 INFO - PROCESS | 8805 | _x_x_mozilla_cycle_collect,716 02:19:06 INFO - PROCESS | 8805 | __end_cc_report 02:19:06 INFO - PROCESS | 8805 | __startTimestamp1453198746501__endTimestamp 02:19:06 INFO - PROCESS | 8805 | 02:19:06 INFO - PROCESS | 8805 | ------- Summary: start ------- 02:19:06 INFO - PROCESS | 8805 | Number of tests: 6 02:19:06 INFO - PROCESS | 8805 | 02:19:06 INFO - PROCESS | 8805 | [#0] dojo.html Cycles:165 Average:5053.50 Median:5228.48 stddev:532.33 (10.2%) stddev-sans-first:511.35 02:19:06 INFO - PROCESS | 8805 | Values: 3096.8 3108.7 3155.0 3159.8 3180.8 4997.7 5075.7 5079.8 5098.1 5124.8 5092.9 5123.2 5150.4 5155.7 5168.8 4599.9 4615.0 4628.7 4673.3 4781.9 4687.9 4696.4 4730.1 4775.2 4782.0 4523.4 4580.7 4590.5 4600.9 4669.1 4624.8 4625.8 4629.3 4660.0 4691.6 4538.2 4618.0 4624.8 4631.6 4659.2 4840.8 4859.7 4867.2 4892.0 4965.2 5284.9 5299.8 5306.1 5306.9 5345.7 5246.5 5349.7 5356.8 5359.6 5359.8 5036.7 5074.2 5078.9 5099.2 5181.1 5479.0 5498.8 5510.1 5517.4 5517.9 5228.5 5301.3 5325.1 5328.5 5341.7 5291.9 5351.3 5351.7 5352.1 5401.5 5312.5 5394.2 5406.8 5413.6 5464.2 5360.1 5407.3 5414.6 5427.9 5456.6 4198.3 4241.6 4250.7 4251.4 4275.0 3786.1 3822.1 3837.7 3864.3 3870.1 4975.7 5031.2 5060.5 5082.2 5092.6 5407.6 5485.5 5486.2 5501.5 5505.8 5097.6 5111.2 5123.4 5124.2 5179.5 4633.5 4694.7 4695.8 4721.3 4783.9 5598.6 5659.9 5671.9 5694.2 5699.1 5464.3 5478.9 5482.2 5483.8 5526.6 5545.0 5630.9 5645.5 5687.1 5756.4 5413.3 5413.7 5418.8 5424.7 5427.9 5345.3 5474.3 5483.4 5492.1 5533.7 5169.9 5285.0 5339.4 5356.1 5387.4 5317.5 5326.7 5328.6 5330.8 5376.6 5176.7 5237.6 5238.2 5238.5 5269.6 5337.2 5357.6 5364.7 5396.5 5420.5 5173.9 5190.9 5196.0 5196.8 5201.0 02:19:06 INFO - PROCESS | 8805 | 02:19:06 INFO - PROCESS | 8805 | [#1] ext.html Cycles:180 Average:44494.44 Median:33654.83 stddev:76656.29 (227.8%) stddev-sans-first:76800.22 02:19:06 INFO - PROCESS | 8805 | Values: 517.6 526.1 540.4 559.9 571.3 28664.3 28983.4 29082.6 29087.1 29089.6 37850.6 38149.4 38195.2 38198.4 38230.8 8367.3 8563.2 8567.2 8567.7 8570.2 7474.4 7641.7 8256.1 8426.7 9843.5 9801.0 9865.9 9867.3 9879.7 9881.7 9763.3 9828.3 9898.9 9927.5 9933.7 9658.1 9768.4 9792.7 9793.9 9801.9 35525.8 35923.0 35924.6 35971.8 38759.0 3229.3 3230.7 3254.6 3378.1 3664.2 28519.0 28867.0 29635.3 30233.2 30357.7 3935.4 3940.3 3998.1 4002.1 4009.9 262212.0 262464.0 263118.0 263556.7 263733.0 51585.5 52413.0 56355.2 56727.7 56970.0 52613.7 52720.5 52778.7 52925.2 52941.0 12339.4 12383.8 12418.6 12421.8 12426.1 10053.0 10168.2 10168.7 10172.5 10174.0 18497.1 18647.3 19391.2 19393.6 19422.5 7721.7 7899.9 7919.2 7937.9 8045.6 900.7 912.2 946.3 961.5 1060.4 24387.0 24531.3 24708.1 24809.5 25022.0 988.7 999.3 1052.3 1084.7 1172.9 13169.4 13599.7 14077.0 14182.7 14290.1 313741.0 317747.0 317973.0 318254.0 318608.0 47358.0 47741.5 47760.3 47786.5 47791.8 1308.8 1326.7 1349.2 1352.4 1360.0 25721.0 26536.9 26862.9 26969.5 26970.6 43254.1 43650.8 43677.8 43701.3 43704.5 293153.0 295958.0 296144.0 297038.0 297126.0 27807.7 27963.6 30346.4 31609.8 32177.8 36973.3 37227.0 37494.4 37560.0 37929.6 31603.7 31948.7 32063.4 32441.8 32642.0 29549.0 33691.0 34113.3 37167.8 38357.4 32091.2 32446.5 33651.5 33658.2 33697.5 28877.7 30195.7 30646.5 30862.2 31111.8 23619.5 23862.9 23896.6 23925.0 23944.6 02:19:06 INFO - PROCESS | 8805 | 02:19:06 INFO - PROCESS | 8805 | [#2] jquery.html Cycles:180 Average:25713.09 Median:253422.11 stddev:82449.77 (32.5%) stddev-sans-first:82659.11 02:19:06 INFO - PROCESS | 8805 | Values: 370.9 371.0 376.9 377.0 378.0 14025.9 14640.7 15587.7 16971.0 17660.2 10593.6 10897.3 10924.1 10932.0 13040.9 3817.2 4890.8 5075.2 5077.2 5082.1 3877.4 5362.7 5526.9 5584.9 5593.2 5188.8 5414.8 5418.9 5539.8 5571.5 5279.6 5297.8 5298.5 5705.7 6097.9 5425.5 5428.7 5434.7 5438.6 5444.6 14808.0 18212.9 18722.3 18738.3 19549.9 2038.8 2058.8 2142.9 2159.4 2174.6 9604.4 9605.7 9615.2 9650.3 9736.0 1777.3 1803.6 1836.5 1847.6 1855.3 56561.7 57245.0 58621.4 58935.1 59032.7 9907.8 10091.7 10338.4 10347.3 10403.0 13628.4 13717.5 13727.4 13740.1 13754.7 7131.7 7133.6 7151.1 7195.3 7234.0 6614.2 6620.6 6634.2 6681.7 6696.7 4098.9 4285.9 4290.0 4453.8 4558.3 1788.8 1808.7 1820.6 1853.8 1875.6 923.6 930.1 936.7 955.3 977.2 15652.4 16561.3 16725.0 16921.6 16923.0 909.6 911.9 912.4 948.4 968.8 9277.0 9514.4 9876.7 9893.5 9965.3 466570.0 501769.0 509907.0 518813.0 528051.0 45418.8 46276.5 46388.5 68986.3 71586.0 1072.3 1095.7 1109.6 1127.4 1132.6 11513.5 14413.0 14494.4 14511.6 14764.2 29259.7 29666.9 29864.3 30552.5 30903.0 36235.6 39993.4 40822.6 41892.6 42574.4 7083.3 7463.7 7497.3 7567.1 7595.7 9818.6 10332.2 10389.6 10441.0 11491.6 9281.4 9331.6 9623.8 9636.4 9779.7 9689.5 9719.7 9733.7 9851.9 10161.5 9693.5 10102.5 10196.5 10229.6 10253.3 7014.7 7032.7 7236.6 7298.6 7346.4 9219.6 9267.6 9511.7 9533.8 9542.1 02:19:06 INFO - PROCESS | 8805 | 02:19:06 INFO - PROCESS | 8805 | [#3] mootools.html Cycles:180 Average:5502.70 Median:6272.67 stddev:2799.48 (44.6%) stddev-sans-first:2789.79 02:19:06 INFO - PROCESS | 8805 | Values: 1333.1 1413.9 1415.9 1528.6 1699.0 6937.9 7427.2 7570.5 7584.2 7598.1 7404.3 7585.7 7599.4 7600.7 7606.5 2012.8 2055.7 2310.9 2360.3 2385.0 2344.8 2345.0 2370.2 2371.9 2374.0 2179.1 2214.4 2218.5 2222.0 2228.3 2269.3 2298.0 2367.4 2375.6 2378.7 2354.6 2365.5 2375.7 2381.0 2405.6 7843.3 7883.3 7888.8 7899.6 7919.4 4838.7 4908.6 4927.7 4937.8 4938.8 3290.4 3346.8 3397.7 3423.6 3429.1 1081.5 1090.7 1091.9 1101.2 1117.1 10706.1 10738.6 10769.1 10775.9 10778.2 4502.5 4516.5 4553.9 4578.9 4596.2 9151.3 9181.9 9186.9 9191.1 9220.3 4944.0 4958.4 4959.5 4962.5 4963.1 4488.4 4534.8 4538.7 4546.6 4548.9 3477.5 3568.2 3572.5 3731.4 3808.4 1214.5 1237.3 1238.3 1264.4 1270.4 1308.4 1310.2 1337.1 1354.5 1370.7 7121.5 7184.8 7298.8 7303.0 7306.7 1097.2 1109.8 1116.2 1122.1 1123.2 5723.7 5784.4 5786.0 5788.6 5801.2 9170.2 9361.5 9538.5 9578.4 9607.7 9427.5 9490.3 9559.0 9576.5 9600.7 7150.6 7309.2 7341.9 7405.6 7410.7 7069.4 7149.1 7160.6 7161.0 7168.8 8156.5 8432.8 8438.6 8505.1 8625.8 8700.7 8860.6 8862.4 8891.2 8893.2 6882.6 6968.2 6979.3 7055.2 7059.7 6633.5 6847.2 7127.4 7326.7 7355.5 6802.5 6911.7 6963.3 7017.3 7048.5 6727.2 6851.9 6876.7 6897.8 6960.1 6985.9 7031.1 7036.0 7036.9 7044.2 6246.1 6299.3 6393.6 6417.3 6420.8 6527.6 6569.3 6575.0 6578.5 6579.6 02:19:06 INFO - PROCESS | 8805 | 02:19:06 INFO - PROCESS | 8805 | [#4] prototype.html Cycles:180 Average:5232.01 Median:5907.34 stddev:1572.08 (26.6%) stddev-sans-first:1533.02 02:19:06 INFO - PROCESS | 8805 | Values: 340.9 350.7 351.9 354.8 357.3 5768.1 5862.6 5875.6 5882.5 5891.7 5641.0 5823.7 5828.9 5851.0 5861.3 4541.2 4542.6 4542.9 4542.9 4543.9 4370.7 4445.3 4457.5 4544.9 4548.5 4484.0 4494.8 4508.5 4514.7 4514.8 4497.1 4505.5 4514.3 4518.1 4524.4 3980.7 3986.9 3989.5 3992.4 3994.2 5478.1 5580.4 5591.9 5706.5 5723.9 5227.7 5231.8 5236.6 5243.7 5244.5 5901.2 6235.4 6239.7 6240.9 6242.8 4248.4 4252.8 4330.1 4349.8 4354.3 6366.2 6441.5 6454.1 6458.7 6459.0 4450.0 4452.3 4455.5 4455.9 4456.6 4374.7 4504.8 4507.7 4513.0 4549.1 5218.6 5219.8 5220.1 5220.8 5222.6 6244.4 6259.6 6271.9 6274.1 6281.2 1572.2 1603.7 1604.4 1604.9 1605.7 1063.7 1071.0 1084.2 1088.6 1104.1 5916.1 5930.9 5934.2 5941.4 5943.0 6421.5 6421.6 6422.0 6423.2 6436.2 5913.4 5914.1 5919.9 5921.7 5926.8 3368.5 3458.7 3466.5 3467.4 3505.6 6748.2 6811.1 6815.8 6816.7 6817.2 6571.1 6636.3 6638.3 6639.5 6642.7 6597.6 6784.1 6786.4 6795.7 6797.2 6224.4 6395.9 6457.5 6482.7 6484.2 6273.9 6320.2 6395.3 6408.0 6408.7 6748.3 6771.4 6779.2 6779.5 6784.4 4365.6 4463.7 4483.2 4489.6 4493.4 6344.3 6350.2 6401.7 6407.7 6420.3 6249.2 6255.6 6257.7 6268.0 6270.2 6103.4 6242.9 6244.6 6249.8 6258.5 6164.0 6191.8 6193.6 6200.1 6201.8 6313.3 6341.8 6347.2 6348.7 6360.8 6067.5 6069.0 6137.4 6199.7 6203.3 02:19:06 INFO - PROCESS | 8805 | 02:19:06 INFO - PROCESS | 8805 | [#5] yui.html Cycles:180 Average:13198.93 Median:45547.75 stddev:15255.07 (33.5%) stddev-sans-first:15269.09 02:19:06 INFO - PROCESS | 8805 | Values: 721.4 755.0 783.9 828.7 833.0 13180.3 13280.4 13288.3 13339.1 13371.5 12046.2 12088.8 12092.1 12102.0 12130.2 664.2 672.6 674.9 750.9 761.6 809.9 811.4 817.5 821.0 825.7 856.3 857.4 857.4 857.5 862.8 702.8 708.4 842.3 854.9 863.1 619.5 619.6 620.4 627.7 628.3 13380.3 13404.2 13445.0 13480.4 13484.9 12064.7 12856.7 12905.7 13058.5 13149.3 10159.7 10239.3 10315.3 10415.8 10521.0 3530.3 3543.7 3569.9 3576.9 3599.5 45277.0 45491.0 45604.5 45656.5 45839.0 10005.6 10106.8 10109.3 10241.4 10435.3 17666.3 17705.7 17791.6 17875.1 17962.0 7209.4 7416.1 7868.4 7874.6 7901.7 4345.1 4374.7 4381.7 4459.4 4494.2 3011.6 3033.2 3049.5 3051.9 3061.6 578.9 596.7 606.3 611.0 612.1 538.6 580.3 658.8 660.4 667.9 7792.5 8114.3 8286.8 8290.3 8396.5 478.7 485.8 487.5 536.3 569.4 3787.4 3848.5 3947.7 3981.0 3981.9 53973.0 54410.7 54414.0 54533.5 56067.4 47985.0 48176.0 48718.5 48884.5 49154.8 44584.0 44862.6 45303.5 45314.3 45983.3 7825.7 7959.4 8104.0 8175.5 8281.8 32889.0 33072.0 33660.8 33969.8 34059.8 39933.0 41261.8 44456.6 44654.6 45285.3 9715.0 9920.4 9948.9 10081.4 10198.4 11243.7 11288.1 11321.7 11669.5 11887.3 10201.6 10611.6 10805.5 10967.1 11047.7 10070.0 10136.3 10296.1 10324.8 10576.3 9828.9 9832.9 10145.1 10164.7 10185.9 8287.5 8590.0 8703.2 8793.7 8885.4 7892.4 8138.2 8214.6 8270.8 8682.3 02:19:06 INFO - PROCESS | 8805 | -------- Summary: end -------- 02:19:06 INFO - PROCESS | 8805 | 02:19:07 INFO - TEST-INFO | 8805: exit 0 02:19:07 INFO - TEST-OK | dromaeo_css | took 1111997ms 02:19:07 INFO - TEST-START | kraken 02:19:07 INFO - operating with platform_type : linux_ 02:19:07 INFO - Initialising browser for kraken test... 02:19:07 INFO - TEST-INFO | started process 9011 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5u1q0y/profile http://localhost:57217/getInfo.html) 02:19:10 INFO - PROCESS | 9011 | __metrics Screen width/height:1600/1200 02:19:10 INFO - PROCESS | 9011 | colorDepth:24 02:19:10 INFO - PROCESS | 9011 | Browser inner width/height: 1024/697 02:19:10 INFO - PROCESS | 9011 | __metrics 02:19:11 INFO - PROCESS | 9011 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:19:11 INFO - PROCESS | 9011 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:19:12 INFO - TEST-INFO | 9011: exit 0 02:19:12 INFO - Browser initialized. 02:19:12 INFO - Running cycle 1/1 for kraken test... 02:19:12 INFO - TEST-INFO | started process 9092 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5u1q0y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:19:24 INFO - PROCESS | 9092 | RSS: Main: 149311488 02:19:24 INFO - PROCESS | 9092 | 02:19:26 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:57217/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57217/tests/kraken/driver.html?testName=audio-beat-detection) 02:19:27 INFO - PROCESS | 9092 | RSS: Main: 187535360 02:19:27 INFO - PROCESS | 9092 | 02:19:29 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:57217/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57217/tests/kraken/driver.html?testName=audio-dft) 02:19:30 INFO - PROCESS | 9092 | RSS: Main: 178466816 02:19:30 INFO - PROCESS | 9092 | 02:19:33 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:57217/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57217/tests/kraken/driver.html?testName=audio-fft) 02:19:33 INFO - PROCESS | 9092 | RSS: Main: 161628160 02:19:33 INFO - PROCESS | 9092 | 02:19:35 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:57217/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57217/tests/kraken/driver.html?testName=audio-oscillator) 02:19:36 INFO - PROCESS | 9092 | RSS: Main: 164093952 02:19:36 INFO - PROCESS | 9092 | 02:19:38 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:57217/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57217/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:19:39 INFO - PROCESS | 9092 | RSS: Main: 164966400 02:19:39 INFO - PROCESS | 9092 | 02:19:42 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:57217/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57217/tests/kraken/driver.html?testName=imaging-darkroom) 02:19:42 INFO - PROCESS | 9092 | RSS: Main: 167256064 02:19:42 INFO - PROCESS | 9092 | 02:19:45 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:57217/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57217/tests/kraken/driver.html?testName=imaging-desaturate) 02:19:46 INFO - PROCESS | 9092 | RSS: Main: 165978112 02:19:46 INFO - PROCESS | 9092 | 02:19:49 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:57217/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57217/tests/kraken/driver.html?testName=json-parse-financial) 02:19:49 INFO - PROCESS | 9092 | RSS: Main: 167137280 02:19:49 INFO - PROCESS | 9092 | 02:19:51 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:57217/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57217/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:19:51 INFO - PROCESS | 9092 | RSS: Main: 180797440 02:19:51 INFO - PROCESS | 9092 | 02:19:53 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:57217/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57217/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:19:54 INFO - PROCESS | 9092 | RSS: Main: 180133888 02:19:54 INFO - PROCESS | 9092 | 02:19:56 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:57217/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57217/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:19:56 INFO - PROCESS | 9092 | RSS: Main: 189636608 02:19:56 INFO - PROCESS | 9092 | 02:19:59 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:57217/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:19:59 INFO - PROCESS | 9092 | RSS: Main: 195846144 02:19:59 INFO - PROCESS | 9092 | 02:20:02 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:57217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:20:02 INFO - PROCESS | 9092 | RSS: Main: 194560000 02:20:02 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:57217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57217/tests/kraken/driver.html?testName=ai-astar) 02:20:04 INFO - PROCESS | 9092 | RSS: Main: 253251584 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | __start_tp_report 02:20:04 INFO - PROCESS | 9092 | _x_x_mozilla_page_load 02:20:04 INFO - PROCESS | 9092 | _x_x_mozilla_page_load_details 02:20:04 INFO - PROCESS | 9092 | |i|pagename|runs| 02:20:04 INFO - PROCESS | 9092 | |0;ai-astar;112;110;106;110;111;111;111;111;104;111 02:20:04 INFO - PROCESS | 9092 | |1;audio-beat-detection;148;126;147;159;123;154;152;124;173;127 02:20:04 INFO - PROCESS | 9092 | |2;audio-dft;160;159;160;160;161;161;161;161;162;161 02:20:04 INFO - PROCESS | 9092 | |3;audio-fft;74;73;97;91;72;71;72;119;97;71 02:20:04 INFO - PROCESS | 9092 | |4;audio-oscillator;96;95;141;95;95;96;145;95;96;148 02:20:04 INFO - PROCESS | 9092 | |5;imaging-gaussian-blur;109;109;109;109;109;110;111;110;110;109 02:20:04 INFO - PROCESS | 9092 | |6;imaging-darkroom;146;146;145;145;146;145;146;146;146;145 02:20:04 INFO - PROCESS | 9092 | |7;imaging-desaturate;96;96;95;96;96;96;96;95;95;96 02:20:04 INFO - PROCESS | 9092 | |8;json-parse-financial;57;56;58;55;54;63;56;55;58;53 02:20:04 INFO - PROCESS | 9092 | |9;json-stringify-tinderbox;67;68;67;67;67;68;67;68;71;68 02:20:04 INFO - PROCESS | 9092 | |10;stanford-crypto-aes;81;80;81;84;86;83;80;84;82;83 02:20:04 INFO - PROCESS | 9092 | |11;stanford-crypto-ccm;117;117;117;117;125;111;114;121;119;121 02:20:04 INFO - PROCESS | 9092 | |12;stanford-crypto-pbkdf2;144;144;141;153;144;130;140;141;141;142 02:20:04 INFO - PROCESS | 9092 | |13;stanford-crypto-sha256-iterative;66;67;69;67;66;67;67;67;76;66 02:20:04 INFO - PROCESS | 9092 | __end_tp_report 02:20:04 INFO - PROCESS | 9092 | __start_cc_report 02:20:04 INFO - PROCESS | 9092 | _x_x_mozilla_cycle_collect,934 02:20:04 INFO - PROCESS | 9092 | __end_cc_report 02:20:04 INFO - PROCESS | 9092 | __startTimestamp1453198804915__endTimestamp 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | ------- Summary: start ------- 02:20:04 INFO - PROCESS | 9092 | Number of tests: 14 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:2.58 (2.3%) stddev-sans-first:2.60 02:20:04 INFO - PROCESS | 9092 | Values: 112.0 110.0 106.0 110.0 111.0 111.0 111.0 111.0 104.0 111.0 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:150.00 stddev:17.33 (11.6%) stddev-sans-first:18.30 02:20:04 INFO - PROCESS | 9092 | Values: 148.0 126.0 147.0 159.0 123.0 154.0 152.0 124.0 173.0 127.0 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 02:20:04 INFO - PROCESS | 9092 | Values: 160.0 159.0 160.0 160.0 161.0 161.0 161.0 161.0 162.0 161.0 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | [#3] audio-fft Cycles:10 Average:83.70 Median:73.50 stddev:16.53 (22.5%) stddev-sans-first:17.15 02:20:04 INFO - PROCESS | 9092 | Values: 74.0 73.0 97.0 91.0 72.0 71.0 72.0 119.0 97.0 71.0 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:95.00 stddev:23.85 (25.1%) stddev-sans-first:24.73 02:20:04 INFO - PROCESS | 9092 | Values: 96.0 95.0 141.0 95.0 95.0 96.0 145.0 95.0 96.0 148.0 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 02:20:04 INFO - PROCESS | 9092 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 111.0 110.0 110.0 109.0 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:20:04 INFO - PROCESS | 9092 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:20:04 INFO - PROCESS | 9092 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.50 stddev:2.80 (5.0%) stddev-sans-first:2.96 02:20:04 INFO - PROCESS | 9092 | Values: 57.0 56.0 58.0 55.0 54.0 63.0 56.0 55.0 58.0 53.0 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 02:20:04 INFO - PROCESS | 9092 | Values: 67.0 68.0 67.0 67.0 67.0 68.0 67.0 68.0 71.0 68.0 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:1.96 (2.4%) stddev-sans-first:2.01 02:20:04 INFO - PROCESS | 9092 | Values: 81.0 80.0 81.0 84.0 86.0 83.0 80.0 84.0 82.0 83.0 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:118.00 stddev:3.90 (3.3%) stddev-sans-first:4.12 02:20:04 INFO - PROCESS | 9092 | Values: 117.0 117.0 117.0 117.0 125.0 111.0 114.0 121.0 119.0 121.0 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:143.00 stddev:5.62 (3.9%) stddev-sans-first:5.91 02:20:04 INFO - PROCESS | 9092 | Values: 144.0 144.0 141.0 153.0 144.0 130.0 140.0 141.0 141.0 142.0 02:20:04 INFO - PROCESS | 9092 | 02:20:04 INFO - PROCESS | 9092 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.00 stddev:3.01 (4.5%) stddev-sans-first:3.12 02:20:04 INFO - PROCESS | 9092 | Values: 66.0 67.0 69.0 67.0 66.0 67.0 67.0 67.0 76.0 66.0 02:20:04 INFO - PROCESS | 9092 | -------- Summary: end -------- 02:20:04 INFO - PROCESS | 9092 | 02:20:05 INFO - TEST-INFO | 9092: exit 0 02:20:05 INFO - TEST-OK | kraken | took 58623ms 02:20:05 INFO - TEST-START | v8_7 02:20:05 INFO - operating with platform_type : linux_ 02:20:05 INFO - Initialising browser for v8_7 test... 02:20:05 INFO - TEST-INFO | started process 9340 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXJCKwL/profile http://localhost:57217/getInfo.html) 02:20:09 INFO - PROCESS | 9340 | __metrics Screen width/height:1600/1200 02:20:09 INFO - PROCESS | 9340 | colorDepth:24 02:20:09 INFO - PROCESS | 9340 | Browser inner width/height: 1024/697 02:20:09 INFO - PROCESS | 9340 | __metrics 02:20:09 INFO - PROCESS | 9340 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:20:09 INFO - PROCESS | 9340 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:20:10 INFO - TEST-INFO | 9340: exit 0 02:20:10 INFO - Browser initialized. 02:20:10 INFO - Running cycle 1/1 for v8_7 test... 02:20:10 INFO - TEST-INFO | started process 9424 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXJCKwL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:20:22 INFO - PROCESS | 9424 | RSS: Main: 149356544 02:20:22 INFO - PROCESS | 9424 | 02:20:45 INFO - PROCESS | 9424 | Cycle 1(1): loaded http://localhost:57217/tests/v8_7/run.html (next: http://localhost:57217/tests/v8_7/run.html) 02:20:45 INFO - PROCESS | 9424 | RSS: Main: 461803520 02:20:45 INFO - PROCESS | 9424 | 02:20:45 INFO - PROCESS | 9424 | __start_tp_report 02:20:45 INFO - PROCESS | 9424 | _x_x_mozilla_page_load 02:20:45 INFO - PROCESS | 9424 | _x_x_mozilla_page_load_details 02:20:45 INFO - PROCESS | 9424 | |i|pagename|runs| 02:20:45 INFO - PROCESS | 9424 | |0;Richards;168.63406408094434 02:20:45 INFO - PROCESS | 9424 | |1;DeltaBlue;188.9287738522577 02:20:45 INFO - PROCESS | 9424 | |2;Encrypt;282.16704288939053 02:20:45 INFO - PROCESS | 9424 | |3;Decrypt;5181.347150259067 02:20:45 INFO - PROCESS | 9424 | |4;RayTrace;2000 02:20:45 INFO - PROCESS | 9424 | |5;Earley;770.4160246533128 02:20:45 INFO - PROCESS | 9424 | |6;Boyer;12506.172839506173 02:20:45 INFO - PROCESS | 9424 | |7;RegExp;40862.74509803922 02:20:45 INFO - PROCESS | 9424 | |8;Splay;601.3229104028864 02:20:45 INFO - PROCESS | 9424 | |9;NavierStokes;4840.579710144928 02:20:45 INFO - PROCESS | 9424 | __end_tp_report 02:20:45 INFO - PROCESS | 9424 | __startTimestamp1453198845419__endTimestamp 02:20:45 INFO - PROCESS | 9424 | 02:20:45 INFO - PROCESS | 9424 | ------- Summary: start ------- 02:20:45 INFO - PROCESS | 9424 | Number of tests: 10 02:20:45 INFO - PROCESS | 9424 | 02:20:45 INFO - PROCESS | 9424 | [#0] Richards Cycles:1 Average:168.63 Median:168.63 stddev:0.00 (0.0%) 02:20:45 INFO - PROCESS | 9424 | Values: 168.6 02:20:45 INFO - PROCESS | 9424 | 02:20:45 INFO - PROCESS | 9424 | [#1] DeltaBlue Cycles:1 Average:188.93 Median:188.93 stddev:0.00 (0.0%) 02:20:45 INFO - PROCESS | 9424 | Values: 188.9 02:20:45 INFO - PROCESS | 9424 | 02:20:45 INFO - PROCESS | 9424 | [#2] Encrypt Cycles:1 Average:282.17 Median:282.17 stddev:0.00 (0.0%) 02:20:45 INFO - PROCESS | 9424 | Values: 282.2 02:20:45 INFO - PROCESS | 9424 | 02:20:45 INFO - PROCESS | 9424 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 02:20:45 INFO - PROCESS | 9424 | Values: 5181.3 02:20:45 INFO - PROCESS | 9424 | 02:20:45 INFO - PROCESS | 9424 | [#4] RayTrace Cycles:1 Average:2000.00 Median:2000.00 stddev:0.00 (0.0%) 02:20:45 INFO - PROCESS | 9424 | Values: 2000.0 02:20:45 INFO - PROCESS | 9424 | 02:20:45 INFO - PROCESS | 9424 | [#5] Earley Cycles:1 Average:770.42 Median:770.42 stddev:0.00 (0.0%) 02:20:45 INFO - PROCESS | 9424 | Values: 770.4 02:20:45 INFO - PROCESS | 9424 | 02:20:45 INFO - PROCESS | 9424 | [#6] Boyer Cycles:1 Average:12506.17 Median:12506.17 stddev:0.00 (0.0%) 02:20:45 INFO - PROCESS | 9424 | Values: 12506.2 02:20:45 INFO - PROCESS | 9424 | 02:20:45 INFO - PROCESS | 9424 | [#7] RegExp Cycles:1 Average:40862.75 Median:40862.75 stddev:0.00 (0.0%) 02:20:45 INFO - PROCESS | 9424 | Values: 40862.7 02:20:45 INFO - PROCESS | 9424 | 02:20:45 INFO - PROCESS | 9424 | [#8] Splay Cycles:1 Average:601.32 Median:601.32 stddev:0.00 (0.0%) 02:20:45 INFO - PROCESS | 9424 | Values: 601.3 02:20:45 INFO - PROCESS | 9424 | 02:20:45 INFO - PROCESS | 9424 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 02:20:45 INFO - PROCESS | 9424 | Values: 4840.6 02:20:45 INFO - PROCESS | 9424 | -------- Summary: end -------- 02:20:45 INFO - PROCESS | 9424 | 02:20:46 INFO - TEST-INFO | 9424: exit 0 02:20:46 INFO - TEST-OK | v8_7 | took 40528ms 02:20:46 INFO - SUITE-END | took 1211s 02:20:46 INFO - Completed test suite (00:20:11) 02:20:46 INFO - Working with test: dromaeo_css 02:20:46 INFO - Generating results file: dromaeo_css 02:20:46 INFO - Working with test: kraken 02:20:46 INFO - Generating results file: kraken 02:20:46 INFO - javascript benchmark 02:20:46 INFO - Working with test: v8_7 02:20:46 INFO - Generating results file: v8_7 02:20:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:20:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 02:20:46 INFO - process_Request line: dromaeo_css 6702.00 graph.html#tests=[[72,201,35]] 02:20:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:20:46 INFO - process_Request line: kraken 1492.70 graph.html#tests=[[232,201,35]] 02:20:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:20:46 INFO - process_Request line: v8_7 18930.29 graph.html#tests=[[230,201,35]] 02:20:46 INFO - RETURN: dromaeo_css: 6702.00 02:20:46 INFO - RETURN: kraken: 1492.70 02:20:46 INFO - RETURN: v8_7: 18930.29 02:20:46 INFO - javascript benchmark 02:20:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3096.845157742113, 3108.720215180633, 3155.021943197609, 3159.7630177736673, 3180.777345585809, 4997.675151115175, 5075.746212689364, 5079.79680812767, 5098.107831129551, 5124.769385377657, 5092.923606145901, 5123.180291153416, 5150.4334523202415, 5155.664881782691, 5168.767405466753, 4599.931001034987, 4615.030843522864, 4628.675992680513, 4673.252279635259, 4781.928271075936, 4687.921777991064, 4696.365990591277, 4730.0776348612035, 4775.188218002948, 4782.04359128174, 4523.434570678665, 4580.679352445331, 4590.495045544987, 4600.884977875547, 4669.1362098011805, 4624.838130665445, 4625.838095666669, 4629.328747331651, 4660.0, 4691.62467002639, 4538.183127037132, 4617.953820461786, 4624.768761561909, 4631.62946964242, 4659.231226847566, 4840.757962101916, 4859.73271470069, 4867.245576935581, 4892.021595680842, 4965.205567109281, 5284.867878303035, 5299.814506492255, 5306.071437498423, 5306.893862122774, 5345.663584103974, 5246.501582349709, 5349.652272602269, 5356.758945847446, 5359.633293510169, 5359.785608575652, 5036.748162591893, 5074.188129899236, 5078.873028174326, 5099.23511473282, 5181.093308671006, 5479.04116779562, 5498.835034948958, 5510.090835012258, 5517.393086760453, 5517.944820551743, 5228.477152284817, 5301.284326615934, 5325.068113080273, 5328.547073498718, 5341.679499230058, 5291.867703307371, 5351.277577526984, 5351.652142610717, 5352.063388907003, 5401.513863752202, 5312.495312945264, 5394.163904594794, 5406.756695948692, 5413.623490833178, 5464.207689884945, 5360.142377219626, 5407.324084489439, 5414.648047876875, 5427.891442171213, 5456.590755693339, 4198.349255865346, 4241.597048280409, 4250.659947204216, 4251.404803327537, 4274.957250427518, 3786.1291902861944, 3822.140018495816, 3837.6929845612285, 3864.3237433449594, 3870.1098747288283, 4975.651704380731, 5031.22016087507, 5060.544550990428, 5082.161443361878, 5092.567131793839, 5407.621466497308, 5485.4788795064405, 5486.204500347428, 5501.477359650827, 5505.752241149158, 5097.64316497849, 5111.207762796773, 5123.38519377677, 5124.15451450514, 5179.482051794866, 4633.513481084437, 4694.7417892016265, 4695.7886895089805, 4721.268203428474, 4783.904321913612, 5598.608097433222, 5659.886802263932, 5671.858203544944, 5694.174344719992, 5699.145128230799, 5464.28964234647, 5478.91781623284, 5482.23248745168, 5483.7806487740045, 5526.55787536988, 5544.972275138599, 5630.943690563042, 5645.520130788929, 5687.118496633028, 5756.366799651951, 5413.323334583177, 5413.675179489243, 5418.810341638024, 5424.728763561885, 5427.864303392289, 5345.305110335631, 5474.288342515448, 5483.369412517612, 5492.148716948879, 5533.695646739468, 5169.92245116316, 5284.9735751320995, 5339.439358867263, 5356.089464790917, 5387.353517577916, 5317.521423071942, 5326.6537675050995, 5328.60035497347, 5330.760115794876, 5376.623636345575, 5176.689398636094, 5237.633365664519, 5238.214267859851, 5238.476152384731, 5269.57843372537, 5337.22610221508, 5357.598180136583, 5364.6512976656395, 5396.487333703292, 5420.53925416344, 5173.896522069613, 5190.8961820764125, 5196.0, 5196.766145523385, 5201.0], "unit": "score", "name": "dojo.html", "value": 5021.118039103913}, {"lowerIsBetter": false, "replicates": [517.5600739371534, 526.0872386409576, 540.3866611396065, 559.9412061733518, 571.2944513525795, 28664.28339291519, 28983.420331593356, 29082.563761543566, 29087.127386178396, 29089.563656545168, 37850.62149378505, 38149.427758583646, 38195.23609527808, 38198.42702359467, 38230.80884595573, 8367.288780453653, 8563.229309362156, 8567.228949394554, 8567.700130495434, 8570.228679418851, 7474.364679002291, 7641.732539361124, 8256.091829898707, 8426.705065322714, 9843.507824608741, 9800.950995245013, 9865.852012219822, 9867.309288349818, 9879.654212102578, 9881.703548893545, 9763.316567840255, 9828.312018158731, 9898.851517227247, 9927.503624818766, 9933.652322168726, 9658.082482164184, 9768.36505627139, 9792.657256995972, 9793.853092203552, 9801.852972205423, 35525.82237088798, 35923.0, 35924.64075359239, 35971.82014089913, 38759.0, 3229.257270827723, 3230.6769323067742, 3254.560634314361, 3378.1385746634696, 3664.175560498893, 28519.0, 28867.0, 29635.259118522208, 30233.244168895733, 30357.696423035708, 3935.3703407454955, 3940.2513522430645, 3998.1204135090234, 4002.139539998914, 4009.8797036088963, 262212.0, 262464.0, 263118.0, 263556.68221658963, 263733.0, 51585.484145158065, 52413.0, 56355.15467267994, 56727.71636141793, 56970.0, 52613.7369313151, 52720.472795271555, 52778.73610631922, 52925.20612190743, 52941.0, 12339.444724987397, 12383.814242786366, 12418.565350212699, 12421.75156496865, 12426.130170887951, 10053.04496072872, 10168.237382196365, 10168.745781355377, 10172.542235599416, 10174.0, 18497.075146242634, 18647.347342842935, 19391.22435102608, 19393.612127757366, 19422.514437139183, 7721.65252563636, 7899.881501777478, 7919.168487308865, 7937.880931786028, 8045.557494337868, 900.6667533012696, 912.1608120529129, 946.3281070440065, 961.4711908450324, 1060.4379678770265, 24387.0, 24531.264062078168, 24708.13521526738, 24809.5038099237, 25022.0, 988.6885631026204, 999.3154689038032, 1052.343652865846, 1084.6637542361893, 1172.8592568891788, 13169.407376668072, 13599.660008499866, 14077.0, 14182.716345673029, 14290.142591444546, 313741.0, 317747.0, 317973.0, 318254.0, 318608.0, 47358.0, 47741.5225847744, 47760.28359574609, 47786.522134778905, 47791.76104119457, 1308.8298521192185, 1326.6948601821634, 1349.2376807103956, 1352.3914238592672, 1360.0003997062151, 25721.0, 26536.867315663298, 26862.865685671448, 26969.460610787282, 26970.595441068006, 43254.13491730211, 43650.78174609107, 43677.78161109174, 43701.344479832194, 43704.53693288339, 293153.0, 295958.0, 296144.0, 297038.0, 297126.0, 27807.721922780514, 27963.58054629223, 30346.39307213799, 31609.841950790098, 32177.83911080523, 36973.26053478861, 37227.0, 37494.43758343573, 37560.0, 37929.62070379261, 31603.683963160074, 31948.68051319457, 32063.35873282568, 32441.83779081184, 32642.02073937786, 29549.0, 33690.954189214644, 34113.31773364569, 37167.814160929025, 38357.424638629884, 32091.19772005625, 32446.513302300013, 33651.49522757112, 33658.158546036546, 33697.494537581464, 28877.7112228875, 30195.69804301929, 30646.540301895937, 30862.228444289074, 31111.844440778557, 23619.527609448058, 23862.88068559646, 23896.64155037641, 23925.0, 23944.64083038721], "unit": "score", "name": "ext.html", "value": 17537.552188038037}, {"lowerIsBetter": false, "replicates": [370.89800304916145, 371.0445602573374, 376.9264993326301, 376.9509963704718, 377.9603141670125, 14025.859741402583, 14640.707185856276, 15587.688246235082, 16971.0, 17660.205290761915, 10593.629222977197, 10897.291676041052, 10924.126069914408, 10932.0, 13040.869591304085, 3817.1983883384523, 4890.7554622268835, 5075.213341932006, 5077.187649976005, 5082.110630639641, 3877.3602355611292, 5362.65142765719, 5526.917096243559, 5584.888302233953, 5593.188987596796, 5188.818391356303, 5414.810481633143, 5418.9458105419035, 5539.778408863641, 5571.498565129137, 5279.577633789288, 5297.814576489824, 5298.496642818926, 5705.65766054034, 6097.908531372033, 5425.484578964992, 5428.728563571805, 5434.728263586805, 5438.646487978269, 5444.6188766786345, 14808.0, 18212.90893545537, 18722.251109955585, 18738.250469981183, 19549.902250488798, 2038.8368930485526, 2058.8455865810124, 2142.8928553572414, 2159.3953692965993, 2174.6082507195406, 9604.423734575877, 9605.663801766974, 9615.23078153753, 9650.324477286593, 9735.951320243425, 1777.306850328373, 1803.567143885458, 1836.504143881158, 1847.5658220318214, 1855.2949879045875, 56561.717191414195, 57245.0, 58621.413785862445, 58935.115973260865, 59032.704836475976, 9907.80184396308, 10091.7477063074, 10338.37969721804, 10347.327423717434, 10403.0, 13628.386722597506, 13717.519886803913, 13727.382267797973, 13740.10689305192, 13754.65613359674, 7131.71473141079, 7133.5719856808755, 7151.141862976372, 7195.280471952763, 7234.0, 6614.206295244601, 6620.569662971891, 6634.170728658918, 6681.665916704145, 6696.665166741644, 4098.897527561775, 4285.892852678708, 4289.9571004289555, 4453.821847126143, 4558.3162525620755, 1788.839004489602, 1808.7015642419117, 1820.6449742300124, 1853.8146185381624, 1875.5967466994662, 923.5613083785282, 930.1489137439303, 936.6862101196176, 955.2739917662626, 977.1986970684113, 15652.373905043898, 16561.337546498005, 16725.0, 16921.637520031014, 16923.0, 909.6004007399849, 911.9133682300171, 912.4342907397456, 948.3503799897093, 968.8449848024283, 9276.953615231881, 9514.38156519824, 9876.654317098866, 9893.505324733735, 9965.302428829913, 466570.0, 501769.0, 509907.0, 518813.0, 528051.0, 45418.77290613526, 46276.53723462722, 46388.53611463909, 68986.31013689798, 71586.0, 1072.3351522056219, 1095.7041598768446, 1109.57836022311, 1127.3686735428023, 1132.6092498088146, 11513.481893314653, 14413.0, 14494.420223190955, 14511.564653060424, 14764.187969661773, 29259.70740292655, 29666.851665741535, 29864.25339366446, 30552.541711874783, 30903.0, 36235.63764362428, 39993.400098997954, 40822.59177408188, 41892.581074190086, 42574.361384579875, 7083.327083927019, 7463.738769143054, 7497.325240728361, 7567.129780075142, 7595.696172153052, 9818.558164882741, 10332.225083118947, 10389.584416623251, 10441.033320853612, 11491.597794077166, 9281.350305478552, 9331.58007889633, 9623.807523849624, 9636.373635713657, 9779.657711980046, 9689.515524223902, 9719.708408747749, 9733.659321923698, 9851.901480985385, 10161.491925403849, 9693.515324233618, 10102.494875256061, 10196.541155647865, 10229.590816367261, 10253.282270241012, 7014.719411223494, 7032.663793879146, 7236.565806051653, 7298.635068246673, 7346.375558077623, 9219.631214751334, 9267.609858521275, 9511.714648560554, 9533.761655958657, 9542.141207291377], "unit": "score", "name": "jquery.html", "value": 7902.077845770628}, {"lowerIsBetter": false, "replicates": [1333.1068184316507, 1413.9293035348232, 1415.915045097294, 1528.5567185516195, 1698.9745153822694, 6937.895931561025, 7427.220141885098, 7570.470067095299, 7584.241575842427, 7598.0502437195355, 7404.259574042593, 7585.658645360958, 7599.35405490534, 7600.7339743109005, 7606.543607383561, 2012.7886571909958, 2055.722477465538, 2310.861348319106, 2360.3155085025364, 2385.0459816073535, 2344.812415006795, 2344.9531009379803, 2370.182287110944, 2371.8576885386847, 2373.95252094958, 2179.0847843905517, 2214.446388402899, 2218.4897473581086, 2222.0, 2228.342638921522, 2269.265535030293, 2297.954040919189, 2367.4199821043867, 2375.572396968545, 2378.6907701998803, 2354.6232602783643, 2365.467769751809, 2375.70303712036, 2380.976190238093, 2405.6271277951946, 7843.254890785366, 7883.251091146332, 7888.802779930547, 7899.605019748989, 7919.366450683931, 4838.661293709441, 4908.631852611068, 4927.6550641455115, 4937.7777999990085, 4938.777755001033, 3290.3912776136253, 3346.7991920484606, 3397.711194548466, 3423.5549378580627, 3429.1255729788745, 1081.4679336805684, 1090.7273181704575, 1091.9316720016777, 1101.1521128730913, 1117.1063149480383, 10706.143508519377, 10738.624148154855, 10769.138468922545, 10775.946120269427, 10778.245522813406, 4502.527234640381, 4516.525764794715, 4553.908921821545, 4578.908421831545, 4596.172688916027, 9151.267898568098, 9181.908180918106, 9186.908130918739, 9191.08089191089, 9220.262379009662, 4943.950560494421, 4958.355413796184, 4959.479254678206, 4962.454130045692, 4963.106640804617, 4488.416505854283, 4534.818607255673, 4538.704984176018, 4546.636269098464, 4548.886277843014, 3477.5305333779615, 3568.1614820517157, 3572.5355703758864, 3731.421629647409, 3808.447775072599, 1214.5020541578087, 1237.3132911234352, 1238.3003602964297, 1264.4436447962867, 1270.371166272701, 1308.3523655790445, 1310.2322188087783, 1337.1375462826422, 1354.4920654754467, 1370.712150448417, 7121.501494895308, 7184.82037949045, 7298.781036568911, 7303.0, 7306.671199796022, 1097.1771171621283, 1109.8002359575194, 1116.179607988128, 1122.0518661730825, 1123.1688550472754, 5723.656580605177, 5784.421557844266, 5786.04530252512, 5788.623739456922, 5801.216835727123, 9170.220531254785, 9361.485118318558, 9538.475383853816, 9578.425294482353, 9607.663731769355, 9427.481488518197, 9490.288228382899, 9558.95220523893, 9576.521173941275, 9600.711978640651, 7150.606716630531, 7309.232530584319, 7341.853162936818, 7405.555666660018, 7410.740624078024, 7069.39910107626, 7149.106361704787, 7160.606166660884, 7160.964195178991, 7168.784936451915, 8156.510609363457, 8432.83134337322, 8438.578071096297, 8505.149485051692, 8625.784355391166, 8700.695475658575, 8860.601272942862, 8862.379633425599, 8891.155340242667, 8893.199612034949, 6882.5870447773295, 6968.198657154492, 6979.302069793183, 7055.153381594037, 7059.682314295766, 6633.502487313567, 6847.1783385994, 7127.429805615435, 7326.670299836626, 7355.521891077063, 6802.455803535607, 6911.654417279015, 6963.303669632996, 7017.333353331425, 7048.471364647775, 6727.192736871607, 6851.931480685129, 6876.69054892521, 6897.827554311182, 6960.095187625576, 6985.917182836669, 7031.1211098612675, 7035.964820176071, 7036.929630703832, 7044.154701435656, 6246.063090536274, 6299.275583307795, 6393.6483493408305, 6417.26201486835, 6420.775272865428, 6527.640979746159, 6569.277379488157, 6575.046618240232, 6578.473722102316, 6579.572327798678], "unit": "score", "name": "mootools.html", "value": 4560.504603357623}, {"lowerIsBetter": false, "replicates": [340.8721729351493, 350.70015137057817, 351.9472079188123, 354.7959923044249, 357.32465639940517, 5768.105943578752, 5862.648241105531, 5875.559333050022, 5882.4705776480105, 5891.705414729267, 5640.971795141028, 5823.708814559266, 5828.912566311508, 5851.0, 5861.325947516037, 4541.205289074415, 4542.636589072867, 4542.8864278392975, 4542.909141817162, 4543.886402839939, 4370.6503479721705, 4445.288753799393, 4457.531959144292, 4544.863654090383, 4548.545145485442, 4483.968687201946, 4494.842680506183, 4508.526604706508, 4514.661400394967, 4514.841980530682, 4497.055618320157, 4505.481869584991, 4514.255147900592, 4518.141553104932, 4524.411826462571, 3980.681545476355, 3986.900327491807, 3989.4813674222455, 3992.3811809169624, 3994.1612261425134, 5478.123500239983, 5580.386157522669, 5591.916121258185, 5706.514946229576, 5723.942760572424, 5227.712475813829, 5231.790728370861, 5236.581073514109, 5243.711595862226, 5244.501772331622, 5901.23283973085, 6235.376462353774, 6239.688015599202, 6240.907841127784, 6242.843928901769, 4248.447701798777, 4252.787360631956, 4330.069035157457, 4349.847755328548, 4354.325079612665, 6366.236051673783, 6441.484681225537, 6454.064160696673, 6458.677066146721, 6459.0, 4450.0, 4452.30989196675, 4455.509893911667, 4455.933161002587, 4456.598906098402, 4374.650027997753, 4504.774761261924, 4507.684462087688, 4512.954870451254, 4549.112922979987, 5218.582513398919, 5219.817306394258, 5220.060389129993, 5220.791168353299, 5222.608304377187, 6244.406781355764, 6259.624422534663, 6271.905921411182, 6274.090256912722, 6281.246250449975, 1572.2296074923206, 1603.6792641471518, 1604.430427198351, 1604.9438269660507, 1605.6949179655828, 1063.6915294564644, 1070.9518071686794, 1084.2356138922041, 1088.6353071721062, 1104.1222228328497, 5916.112583112567, 5930.851728706731, 5934.1692163097205, 5941.435563621449, 5943.0, 6421.486281097501, 6421.614703117828, 6422.0, 6423.164988551458, 6436.163298771224, 5913.438223368773, 5914.053751399755, 5919.911201331984, 5921.703914804242, 5926.822195334147, 3368.4778859276853, 3458.7060099891287, 3466.5493485846678, 3467.393206188907, 3505.5968563615, 6748.156480439945, 6811.148606424197, 6815.7614483493835, 6816.727330906709, 6817.181938167352, 6571.145751052332, 6636.30318816527, 6638.269790323061, 6639.468842492589, 6642.66786660665, 6597.637129957802, 6784.118064651662, 6786.423154031962, 6795.660216989229, 6797.150356205376, 6224.408681175281, 6395.93604063972, 6457.483401327976, 6482.70827812759, 6484.221893372825, 6273.874522509615, 6320.178376810985, 6395.328490508429, 6408.0, 6408.743650253938, 6748.325167483409, 6771.424428923597, 6779.186497620317, 6779.457643388616, 6784.3894049535775, 4365.585269399402, 4463.665225108195, 4483.170613436525, 4489.551044895485, 4493.438320209973, 6344.302126766144, 6350.206224221973, 6401.711922963571, 6407.679616019273, 6420.26166990802, 6249.156363890998, 6255.593386429868, 6257.7184026718, 6267.968660156853, 6270.2475702915945, 6103.420175083537, 6242.93870042103, 6244.562880598314, 6249.7500099997305, 6258.530610204162, 6164.0, 6191.7523299069335, 6193.597416167935, 6200.100985357008, 6201.81394558164, 6313.273973492924, 6341.8097457076365, 6347.17486726741, 6348.714307856065, 6360.809175724736, 6067.54493412987, 6069.0, 6137.3862613738265, 6199.690015499117, 6203.2556093269095], "unit": "score", "name": "prototype.html", "value": 4729.244768920778}, {"lowerIsBetter": false, "replicates": [721.4192574977145, 754.9924500754997, 783.9176886426925, 828.701667399736, 832.9791755206119, 13180.340982950851, 13280.402381892814, 13288.269145197035, 13339.132956357842, 13371.531996380116, 12046.156769026149, 12088.818667719992, 12092.093093018037, 12102.0, 12130.150889437742, 664.2261765043718, 672.559473544829, 674.9190097188344, 750.8761054426027, 761.5659074327635, 809.9433039687224, 811.3711873298182, 817.5176645778989, 820.9548474833882, 825.686239229092, 856.2678909532353, 857.3612658569343, 857.3998201259112, 857.4555157475017, 862.779991102268, 702.8242939265184, 708.3872450330452, 842.2840585502336, 854.8589482735341, 863.0765081362944, 619.4827319188483, 619.6344156947378, 620.3672254300589, 627.6861569215392, 628.3214128740995, 13380.330983450789, 13404.195748255039, 13445.0, 13480.393382297721, 13484.865151348458, 12064.733203013733, 12856.678583035406, 12905.741885162339, 13058.542950996669, 13149.276789776559, 10159.746006349826, 10239.334443261165, 10315.277930544866, 10415.791684166274, 10521.0, 3530.276293359855, 3543.7265386185622, 3569.94645080324, 3576.8748093816594, 3599.4780756790383, 45277.0, 45490.95290711926, 45604.54395456036, 45656.543434565894, 45838.999999999665, 10005.649802257032, 10106.848397274047, 10109.34289271195, 10241.436720980417, 10435.269531132899, 17666.293348265925, 17705.7344139838, 17791.55521111957, 17875.106244687715, 17962.0, 7209.387202087776, 7416.0729908761405, 7868.370530357558, 7874.566898820505, 7901.723439679584, 4345.065810850682, 4374.671899607542, 4381.671374646914, 4459.44256967879, 4494.235979883428, 3011.623547056618, 3033.226527235585, 3049.4663433898977, 3051.908442746721, 3061.5713800068006, 578.8842231553706, 596.7195418153461, 606.2936678769184, 610.9786157484467, 612.1185492890313, 538.6148903533992, 580.2946948015718, 658.808945405827, 660.3957378998163, 667.9079704682879, 7792.532448053135, 8114.269715725495, 8286.751397458085, 8290.253877151084, 8396.496210227406, 478.73908719747124, 485.78139837073456, 487.48570258377754, 536.265316516375, 569.4277251362354, 3787.3750831113107, 3848.461215429842, 3947.684185265172, 3980.960190398059, 3981.9203615927518, 53973.0, 54410.72794636081, 54414.0, 54533.45466545284, 56067.43932560704, 47985.0, 48176.0, 48718.512814872105, 48884.51115488871, 49154.75422622936, 44584.0, 44862.55137448649, 45303.54696453059, 45314.32028519641, 45983.31025034627, 7825.686972521035, 7959.442839001446, 8103.959480202561, 8175.509469431853, 8281.751547453587, 32889.01332960015, 33072.0, 33660.831695842346, 33969.830150849084, 34059.82970085134, 39933.0, 41261.79369103135, 44456.555434446534, 44654.55345446634, 45285.32072018857, 9715.0, 9920.363140081805, 9948.900510994798, 10081.395116293046, 10198.43908585035, 11243.66269011931, 11288.096952243965, 11321.71695707614, 11669.533218671158, 11887.346195959306, 10201.642942496977, 10611.575536978744, 10805.51375188134, 10967.122630189726, 11047.72380690489, 10070.0, 10136.290459667753, 10296.07335339823, 10324.845127323246, 10576.314438513053, 9828.901710983084, 9832.9016709832, 10145.08694217524, 10164.695059148238, 10185.898141018495, 8287.544185069879, 8590.0, 8703.216710496086, 8793.692220772498, 8885.378023538291, 7892.4080693947035, 8138.186181381814, 8214.63034163476, 8270.751877443687, 8682.262007729161], "unit": "score", "name": "yui.html", "value": 6037.784918311576}], "name": "dromaeo_css", "value": 6702.007439892153}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 106.0, 110.0, 111.0, 111.0, 111.0, 111.0, 104.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 126.0, 147.0, 159.0, 123.0, 154.0, 152.0, 124.0, 173.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 97.0, 91.0, 72.0, 71.0, 72.0, 119.0, 97.0, 71.0], "unit": "score", "name": "audio-fft", "value": 83.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 141.0, 95.0, 95.0, 96.0, 145.0, 95.0, 96.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 111.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 58.0, 55.0, 54.0, 63.0, 56.0, 55.0, 58.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 71.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 81.0, 84.0, 86.0, 83.0, 80.0, 84.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 125.0, 111.0, 114.0, 121.0, 119.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.9}, {"lowerIsBetter": true, "replicates": [144.0, 144.0, 141.0, 153.0, 144.0, 130.0, 140.0, 141.0, 141.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 69.0, 67.0, 66.0, 67.0, 67.0, 67.0, 76.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1492.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.63406408094434], "unit": "score", "name": "Richards", "value": 209.34085999999994}, {"lowerIsBetter": false, "replicates": [188.9287738522577], "unit": "score", "name": "DeltaBlue", "value": 349.96257399999996}, {"lowerIsBetter": false, "replicates": [282.16704288939053], "unit": "score", "name": "Encrypt", "value": 943.3454639999995}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [2000.0], "unit": "score", "name": "RayTrace", "value": 369.9945}, {"lowerIsBetter": false, "replicates": [770.4160246533128], "unit": "score", "name": "Earley", "value": 865.0689739999998}, {"lowerIsBetter": false, "replicates": [12506.172839506173], "unit": "score", "name": "Boyer", "value": 53.29072359328728}, {"lowerIsBetter": false, "replicates": [40862.74509803922], "unit": "score", "name": "RegExp", "value": 22.293778790786927}, {"lowerIsBetter": false, "replicates": [601.3229104028864], "unit": "score", "name": "Splay", "value": 135.519533}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 18930.287045356003}]} 02:20:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "18930.29"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1492.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6702.00"}}} 02:20:46 INFO - Return code: 0 02:20:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:20:46 INFO - # TBPL SUCCESS # 02:20:46 INFO - Running post-action listener: _resource_record_post_action 02:20:46 INFO - Running post-run listener: _resource_record_post_run 02:20:47 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 36864; Write bytes: 551276544; Read time: 396; Write time: 457484 02:20:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 237441024; Read time: 188; Write time: 259564 02:20:47 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 32768; Write bytes: 302489600; Read time: 208; Write time: 195124 02:20:47 INFO - Running post-run listener: _upload_blobber_files 02:20:47 INFO - Blob upload gear active. 02:20:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:20:47 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 02:20:47 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'] 02:20:47 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 02:20:48 INFO - (blobuploader) - INFO - Open directory for files ... 02:20:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:20:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:20:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:20:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:20:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:20:49 INFO - (blobuploader) - INFO - Done attempting. 02:20:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:20:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:20:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:20:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:20:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:20:50 INFO - (blobuploader) - INFO - Done attempting. 02:20:50 INFO - (blobuploader) - INFO - Iteration through files over. 02:20:50 INFO - Return code: 0 02:20:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:20:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:20:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/41368e8215b3ec8e8b8f68e1b543bff34958222124414804b39bcdc924e01164c2c6b7a6597e3e7881bd18597a9e37c6d2ccffa631a0f7ba9c71c7c6a3d1d991", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/55f7017b269ec3b91c16765fe916b4e3ad657039ddaa18ba5d6d1842ead49e1019ac9c0e268efb5b1ac178f058eb33985b7509a04ad01f522ed50273b5fd6177"} 02:20:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:20:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:20:50 INFO - Contents: 02:20:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/41368e8215b3ec8e8b8f68e1b543bff34958222124414804b39bcdc924e01164c2c6b7a6597e3e7881bd18597a9e37c6d2ccffa631a0f7ba9c71c7c6a3d1d991", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/55f7017b269ec3b91c16765fe916b4e3ad657039ddaa18ba5d6d1842ead49e1019ac9c0e268efb5b1ac178f058eb33985b7509a04ad01f522ed50273b5fd6177"} 02:20:50 INFO - Running post-run listener: copy_logs_to_upload_dir 02:20:50 INFO - Copying logs to upload dir... 02:20:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 02:20:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.994876 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-19 02:20:49.604214) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 02:20:49.607812) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094 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/41368e8215b3ec8e8b8f68e1b543bff34958222124414804b39bcdc924e01164c2c6b7a6597e3e7881bd18597a9e37c6d2ccffa631a0f7ba9c71c7c6a3d1d991", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/55f7017b269ec3b91c16765fe916b4e3ad657039ddaa18ba5d6d1842ead49e1019ac9c0e268efb5b1ac178f058eb33985b7509a04ad01f522ed50273b5fd6177"} build_url:https://queue.taskcluster.net/v1/task/OpCzLsQATG2nLfzi3ykpSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/OpCzLsQATG2nLfzi3ykpSA/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/41368e8215b3ec8e8b8f68e1b543bff34958222124414804b39bcdc924e01164c2c6b7a6597e3e7881bd18597a9e37c6d2ccffa631a0f7ba9c71c7c6a3d1d991", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/55f7017b269ec3b91c16765fe916b4e3ad657039ddaa18ba5d6d1842ead49e1019ac9c0e268efb5b1ac178f058eb33985b7509a04ad01f522ed50273b5fd6177"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 02:20:49.632958) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:20:49.633287) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453190267.185461-1488962094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:20:49.718086) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 02:20:49.718647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 02:20:49.719165) ========= ========= Total master_lag: 0.24 =========