builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1450551513.19 results: success (0) buildid: 20151219083114 builduid: 492d4da61bc94cb6a80592622af8ae2b revision: ef961a0fe82f1b2938dcaa47f9911f5de0d08109 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:33.188772) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:33.189438) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:33.189775) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006333 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:33.214714) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:33.215028) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:33.283454) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:33.284109) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:33.336260) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:33.336549) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:33.336935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:33.337207) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-19 10:58:33-- 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% 86.7M=0s 2015-12-19 10:58:33 (86.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128514 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:33.479401) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:33.479741) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022423 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:33.529740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:33.530096) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev ef961a0fe82f1b2938dcaa47f9911f5de0d08109 --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 ef961a0fe82f1b2938dcaa47f9911f5de0d08109 --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=23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-19 10:58:33,614 truncating revision to first 12 chars 2015-12-19 10:58:33,614 Setting DEBUG logging. 2015-12-19 10:58:33,614 attempt 1/10 2015-12-19 10:58:33,614 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/ef961a0fe82f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-19 10:58:33,885 unpacking tar archive at: b2g-inbound-ef961a0fe82f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564948 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:34.108349) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:34.108687) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:34.118198) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:34.118612) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-19 10:58:34.119096) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-19 10:58:34.119435) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:58:34 INFO - MultiFileLogger online at 20151219 10:58:34 in /builds/slave/test-pgo 10:58:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 10:58:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:58:34 INFO - {'append_to_log': False, 10:58:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:58:34 INFO - 'blob_upload_branch': 'B2G-Inbound', 10:58:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:58:34 INFO - 'branch': 'B2G-Inbound', 10:58:34 INFO - 'buildbot_json_path': 'buildprops.json', 10:58:34 INFO - 'config_files': ('talos/linux_config.py',), 10:58:34 INFO - 'default_actions': ('clobber', 10:58:34 INFO - 'read-buildbot-config', 10:58:34 INFO - 'download-and-extract', 10:58:34 INFO - 'populate-webroot', 10:58:34 INFO - 'create-virtualenv', 10:58:34 INFO - 'install', 10:58:34 INFO - 'run-tests'), 10:58:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:58:34 INFO - 'download_minidump_stackwalk': True, 10:58:34 INFO - 'download_symbols': 'ondemand', 10:58:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:58:34 INFO - 'tooltool.py': '/tools/tooltool.py', 10:58:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:58:34 INFO - '/tools/misc-python/virtualenv.py')}, 10:58:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:58:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:58:34 INFO - 'installer_path': 'installer.exe', 10:58:34 INFO - 'log_level': 'info', 10:58:34 INFO - 'log_name': 'talos', 10:58:34 INFO - 'log_to_console': True, 10:58:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:58:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:58:34 INFO - 'opt_config_files': (), 10:58:34 INFO - 'pip_index': False, 10:58:34 INFO - 'sps_profile': False, 10:58:34 INFO - 'sps_profile_interval': 0, 10:58:34 INFO - 'suite': 'dromaeojs', 10:58:34 INFO - 'system_bits': '64', 10:58:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:58:34 INFO - 'title': 'talos-linux64-ix-030', 10:58:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:58:34 INFO - 'use_talos_json': True, 10:58:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:58:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:58:34 INFO - 'work_dir': 'build'} 10:58:34 INFO - ##### 10:58:34 INFO - ##### Running clobber step. 10:58:34 INFO - ##### 10:58:34 INFO - Running pre-action listener: _resource_record_pre_action 10:58:34 INFO - Running main action method: clobber 10:58:34 INFO - rmtree: /builds/slave/test-pgo/build 10:58:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:58:35 INFO - Running post-action listener: _resource_record_post_action 10:58:35 INFO - ##### 10:58:35 INFO - ##### Running read-buildbot-config step. 10:58:35 INFO - ##### 10:58:35 INFO - Running pre-action listener: _resource_record_pre_action 10:58:35 INFO - Running main action method: read_buildbot_config 10:58:35 INFO - Using buildbot properties: 10:58:35 INFO - { 10:58:35 INFO - "project": "", 10:58:35 INFO - "product": "firefox", 10:58:35 INFO - "script_repo_revision": "production", 10:58:35 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 10:58:35 INFO - "repository": "", 10:58:35 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 10:58:35 INFO - "buildid": "20151219083114", 10:58:35 INFO - "pgo_build": "True", 10:58:35 INFO - "basedir": "/builds/slave/test-pgo", 10:58:35 INFO - "buildnumber": 135, 10:58:35 INFO - "slavename": "talos-linux64-ix-030", 10:58:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:58:35 INFO - "platform": "ubuntu64_hw", 10:58:35 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 10:58:35 INFO - "branch": "b2g-inbound", 10:58:35 INFO - "repo_path": "integration/b2g-inbound", 10:58:35 INFO - "revision": "ef961a0fe82f1b2938dcaa47f9911f5de0d08109", 10:58:35 INFO - "stage_platform": "linux64-pgo", 10:58:35 INFO - "builduid": "492d4da61bc94cb6a80592622af8ae2b", 10:58:35 INFO - "slavebuilddir": "test" 10:58:35 INFO - } 10:58:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:58:35 INFO - Running post-action listener: _resource_record_post_action 10:58:35 INFO - ##### 10:58:35 INFO - ##### Running download-and-extract step. 10:58:35 INFO - ##### 10:58:35 INFO - Running pre-action listener: _resource_record_pre_action 10:58:35 INFO - Running main action method: download_and_extract 10:58:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:35 INFO - https://queue.taskcluster.net/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/test_packages.json 10:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/test_packages.json 10:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:58:36 INFO - Downloaded 1302 bytes. 10:58:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:58:36 INFO - Using the following test package requirements: 10:58:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:58:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:58:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:36 INFO - u'jsshell-linux-x86_64.zip'], 10:58:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:58:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:58:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:58:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:58:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:58:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:58:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:58:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:36 INFO - https://queue.taskcluster.net/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:58:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:58:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:58:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/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 10:58:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/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 10:58:37 INFO - Downloaded 23121884 bytes. 10:58:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:58:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:58:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:58:38 INFO - Return code: 0 10:58:38 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 10:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:38 INFO - https://queue.taskcluster.net/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:58:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:58:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:58:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/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 10:58:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/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 10:58:43 INFO - Downloaded 23121884 bytes. 10:58:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:58:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:58:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:58:44 INFO - Return code: 0 10:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:44 INFO - https://queue.taskcluster.net/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:58:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:58:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:58:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/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 10:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/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 10:58:45 INFO - Downloaded 11132039 bytes. 10:58:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 10:58:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:58:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:58:45 INFO - Return code: 0 10:58:45 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')]} 10:58:45 INFO - https://queue.taskcluster.net/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:58:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:58:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:58:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/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 10:58:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pDhZf0LQQ46GjDKRTTlYaw/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 10:58:47 INFO - Downloaded 54644034 bytes. 10:58:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:58:47 INFO - mkdir: /builds/slave/test-pgo/properties 10:58:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:58:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:58:47 INFO - Contents: 10:58:47 INFO - build_url:https://queue.taskcluster.net/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:58:47 INFO - Running post-action listener: _resource_record_post_action 10:58:47 INFO - Running post-action listener: set_extra_try_arguments 10:58:47 INFO - ##### 10:58:47 INFO - ##### Running populate-webroot step. 10:58:47 INFO - ##### 10:58:47 INFO - Running pre-action listener: _resource_record_pre_action 10:58:47 INFO - Running main action method: populate_webroot 10:58:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:58:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:58:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:58:47 INFO - '--tppagecycles', 10:58:47 INFO - '7'], 10:58:47 INFO - 'tests': ['tsvgm']}}, 10:58:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:58:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:58:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:58:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:58:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:58:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:58:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:58:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:47 INFO - 'talos_options': ['--e10s'], 10:58:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:58:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:47 INFO - 'tests': ['damp', 'tps']}, 10:58:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:47 INFO - 'talos_options': ['--e10s'], 10:58:47 INFO - 'tests': ['damp', 'tps']}, 10:58:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:58:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:58:47 INFO - 'other': {'tests': ['a11yr', 10:58:47 INFO - 'ts_paint', 10:58:47 INFO - 'tpaint', 10:58:47 INFO - 'sessionrestore', 10:58:47 INFO - 'sessionrestore_no_auto_restore']}, 10:58:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:58:47 INFO - 'tests': ['a11yr', 10:58:47 INFO - 'ts_paint', 10:58:47 INFO - 'tpaint', 10:58:47 INFO - 'sessionrestore', 10:58:47 INFO - 'sessionrestore_no_auto_restore']}, 10:58:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:58:47 INFO - 'tests': ['a11yr', 10:58:47 INFO - 'ts_paint', 10:58:47 INFO - 'tpaint', 10:58:47 INFO - 'sessionrestore', 10:58:47 INFO - 'sessionrestore_no_auto_restore']}, 10:58:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:58:47 INFO - 'tests': ['a11yr', 10:58:47 INFO - 'ts_paint', 10:58:47 INFO - 'tpaint', 10:58:47 INFO - 'sessionrestore', 10:58:47 INFO - 'sessionrestore_no_auto_restore']}, 10:58:47 INFO - 'other_l64': {'tests': ['a11yr', 10:58:47 INFO - 'ts_paint', 10:58:47 INFO - 'tpaint', 10:58:47 INFO - 'sessionrestore', 10:58:47 INFO - 'sessionrestore_no_auto_restore']}, 10:58:47 INFO - 'other_nol64': {'tests': ['a11yr', 10:58:47 INFO - 'ts_paint', 10:58:47 INFO - 'tpaint', 10:58:47 INFO - 'sessionrestore', 10:58:47 INFO - 'sessionrestore_no_auto_restore']}, 10:58:47 INFO - 'svgr': {'tests': ['tsvgx', 10:58:47 INFO - 'tsvgr_opacity', 10:58:47 INFO - 'tart', 10:58:47 INFO - 'tscrollx', 10:58:47 INFO - 'cart']}, 10:58:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:58:47 INFO - 'tests': ['tsvgx', 10:58:47 INFO - 'tsvgr_opacity', 10:58:47 INFO - 'tart', 10:58:47 INFO - 'tscrollx', 10:58:47 INFO - 'cart']}, 10:58:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:47 INFO - 'tests': ['tp5o']}, 10:58:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:47 INFO - 'talos_options': ['--e10s'], 10:58:47 INFO - 'tests': ['tp5o']}, 10:58:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:47 INFO - 'talos_options': ['--xperf_path', 10:58:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:58:47 INFO - 'tests': ['tp5n']}, 10:58:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:47 INFO - 'talos_options': ['--e10s', 10:58:47 INFO - '--xperf_path', 10:58:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:58:47 INFO - 'tests': ['tp5n']}}, 10:58:47 INFO - 'talos.zip': {'path': '', 10:58:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:58:47 INFO - Running post-action listener: _resource_record_post_action 10:58:47 INFO - ##### 10:58:47 INFO - ##### Running create-virtualenv step. 10:58:47 INFO - ##### 10:58:47 INFO - Running pre-action listener: _resource_record_pre_action 10:58:47 INFO - Running main action method: create_virtualenv 10:58:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:58:47 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 10:58:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:58:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:58:47 INFO - Using real prefix '/usr' 10:58:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:58:48 INFO - Installing distribute.............................................................................................................................................................................................done. 10:58:50 INFO - Installing pip.................done. 10:58:50 INFO - Return code: 0 10:58:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f68ab45af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d350>, '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 0x2d3e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3e6e0>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', '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 10:58:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:58:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:58:50 INFO - Using env: {'DISPLAY': ':0', 10:58:50 INFO - 'HOME': '/home/cltbld', 10:58:50 INFO - 'LANG': 'en_US.UTF-8', 10:58:50 INFO - 'LANGUAGE': 'en_US:en', 10:58:50 INFO - 'LOGNAME': 'cltbld', 10:58:50 INFO - 'MAIL': '/var/mail/cltbld', 10:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:50 INFO - 'MOZ_NO_REMOTE': '1', 10:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:50 INFO - 'NO_EM_RESTART': '1', 10:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:50 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:50 INFO - 'SHELL': '/bin/bash', 10:58:50 INFO - 'SHLVL': '1', 10:58:50 INFO - 'TERM': 'linux', 10:58:50 INFO - 'TMOUT': '86400', 10:58:50 INFO - 'USER': 'cltbld', 10:58:50 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', 10:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:50 INFO - '_': '/tools/buildbot/bin/python'} 10:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:50 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 10:58:50 INFO - Cleaning up... 10:58:50 INFO - Return code: 0 10:58:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f68ab45af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d350>, '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 0x2d3e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3e6e0>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', '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 10:58:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:58:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:58:50 INFO - Using env: {'DISPLAY': ':0', 10:58:50 INFO - 'HOME': '/home/cltbld', 10:58:50 INFO - 'LANG': 'en_US.UTF-8', 10:58:50 INFO - 'LANGUAGE': 'en_US:en', 10:58:50 INFO - 'LOGNAME': 'cltbld', 10:58:50 INFO - 'MAIL': '/var/mail/cltbld', 10:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:50 INFO - 'MOZ_NO_REMOTE': '1', 10:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:50 INFO - 'NO_EM_RESTART': '1', 10:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:50 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:50 INFO - 'SHELL': '/bin/bash', 10:58:50 INFO - 'SHLVL': '1', 10:58:50 INFO - 'TERM': 'linux', 10:58:50 INFO - 'TMOUT': '86400', 10:58:50 INFO - 'USER': 'cltbld', 10:58:50 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', 10:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:50 INFO - '_': '/tools/buildbot/bin/python'} 10:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:50 INFO - Downloading/unpacking psutil>=0.7.1 10:58:50 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 10:58:50 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 10:58:50 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 10:58:50 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 10:58:50 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 10:58:50 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 10:58:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:58:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:58:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:58:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:58:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:58:52 INFO - Installing collected packages: psutil 10:58:52 INFO - Running setup.py install for psutil 10:58:52 INFO - building 'psutil._psutil_linux' extension 10:58:52 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 10:58:52 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 10:58:52 INFO - building 'psutil._psutil_posix' extension 10:58:52 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 10:58:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:58:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:58:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:58:53 INFO - Successfully installed psutil 10:58:53 INFO - Cleaning up... 10:58:53 INFO - Return code: 0 10:58:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f68ab45af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d350>, '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 0x2d3e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3e6e0>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', '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 10:58:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:58:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:58:53 INFO - Using env: {'DISPLAY': ':0', 10:58:53 INFO - 'HOME': '/home/cltbld', 10:58:53 INFO - 'LANG': 'en_US.UTF-8', 10:58:53 INFO - 'LANGUAGE': 'en_US:en', 10:58:53 INFO - 'LOGNAME': 'cltbld', 10:58:53 INFO - 'MAIL': '/var/mail/cltbld', 10:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:53 INFO - 'MOZ_NO_REMOTE': '1', 10:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:53 INFO - 'NO_EM_RESTART': '1', 10:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:53 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:53 INFO - 'SHELL': '/bin/bash', 10:58:53 INFO - 'SHLVL': '1', 10:58:53 INFO - 'TERM': 'linux', 10:58:53 INFO - 'TMOUT': '86400', 10:58:53 INFO - 'USER': 'cltbld', 10:58:53 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', 10:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:53 INFO - '_': '/tools/buildbot/bin/python'} 10:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:58:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:58:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:58:56 INFO - Installing collected packages: mozsystemmonitor 10:58:56 INFO - Running setup.py install for mozsystemmonitor 10:58:56 INFO - Successfully installed mozsystemmonitor 10:58:56 INFO - Cleaning up... 10:58:56 INFO - Return code: 0 10:58:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:58: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')]} 10:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58: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')]} 10:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58: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', '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 0x7f68ab45af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d350>, '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 0x2d3e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3e6e0>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', '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 10:58: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:58: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 blobuploader==1.2.4 10:58:56 INFO - Using env: {'DISPLAY': ':0', 10:58:56 INFO - 'HOME': '/home/cltbld', 10:58:56 INFO - 'LANG': 'en_US.UTF-8', 10:58:56 INFO - 'LANGUAGE': 'en_US:en', 10:58:56 INFO - 'LOGNAME': 'cltbld', 10:58:56 INFO - 'MAIL': '/var/mail/cltbld', 10:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:56 INFO - 'MOZ_NO_REMOTE': '1', 10:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:56 INFO - 'NO_EM_RESTART': '1', 10:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:56 INFO - 'SHELL': '/bin/bash', 10:58:56 INFO - 'SHLVL': '1', 10:58:56 INFO - 'TERM': 'linux', 10:58:56 INFO - 'TMOUT': '86400', 10:58:56 INFO - 'USER': 'cltbld', 10:58:56 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', 10:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:56 INFO - '_': '/tools/buildbot/bin/python'} 10:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:56 INFO - Downloading/unpacking blobuploader==1.2.4 10:58:56 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 10:58:56 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 10:58:56 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 10:58:56 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 10:58:56 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 10:58:56 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 10:58:58 INFO - Downloading blobuploader-1.2.4.tar.gz 10:58:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:58:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:58:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:58:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:58:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:58 INFO - Downloading docopt-0.6.1.tar.gz 10:58:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:58:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:58:58 INFO - Installing collected packages: blobuploader, requests, docopt 10:58:58 INFO - Running setup.py install for blobuploader 10:58:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:58:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:58:58 INFO - Running setup.py install for requests 10:58:59 INFO - Running setup.py install for docopt 10:58:59 INFO - Successfully installed blobuploader requests docopt 10:58:59 INFO - Cleaning up... 10:58:59 INFO - Return code: 0 10:58:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:58: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')]} 10:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58: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')]} 10:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:59 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 0x7f68ab45af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d350>, '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 0x2d3e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3e6e0>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', '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 10:58:59 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 10:58:59 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 10:58:59 INFO - Using env: {'DISPLAY': ':0', 10:58:59 INFO - 'HOME': '/home/cltbld', 10:58:59 INFO - 'LANG': 'en_US.UTF-8', 10:58:59 INFO - 'LANGUAGE': 'en_US:en', 10:58:59 INFO - 'LOGNAME': 'cltbld', 10:58:59 INFO - 'MAIL': '/var/mail/cltbld', 10:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:59 INFO - 'MOZ_NO_REMOTE': '1', 10:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:59 INFO - 'NO_EM_RESTART': '1', 10:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:59 INFO - 'SHELL': '/bin/bash', 10:58:59 INFO - 'SHLVL': '1', 10:58:59 INFO - 'TERM': 'linux', 10:58:59 INFO - 'TMOUT': '86400', 10:58:59 INFO - 'USER': 'cltbld', 10:58:59 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', 10:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:59 INFO - '_': '/tools/buildbot/bin/python'} 10:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:58:59 INFO - Running setup.py (path:/tmp/pip-AX_Y2O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:58:59 INFO - Running setup.py (path:/tmp/pip-XXPR0W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:58:59 INFO - Running setup.py (path:/tmp/pip-rCIzXU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:58:59 INFO - Running setup.py (path:/tmp/pip-Q62TZm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:58:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:58:59 INFO - Running setup.py (path:/tmp/pip-PW5GuN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:59:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:59:00 INFO - Running setup.py (path:/tmp/pip-wXt9qj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:59:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:59:00 INFO - Running setup.py (path:/tmp/pip-fTdCpM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:59:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:59:00 INFO - Running setup.py (path:/tmp/pip-n3JdOI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:59:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:59:00 INFO - Running setup.py (path:/tmp/pip-cKikQn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:59:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:59:00 INFO - Running setup.py (path:/tmp/pip-dlZQFR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:59:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:59:00 INFO - Running setup.py (path:/tmp/pip-lbmcCo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:59:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:59:00 INFO - Running setup.py (path:/tmp/pip-g0olS6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:59:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:59:00 INFO - Running setup.py (path:/tmp/pip-jpTxlh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:59:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:59:00 INFO - Running setup.py (path:/tmp/pip-4yDRWG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:59:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:59:00 INFO - Running setup.py (path:/tmp/pip-aw1gAH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:59:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:59:00 INFO - Running setup.py (path:/tmp/pip-Imai2F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:59:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:59:00 INFO - Running setup.py (path:/tmp/pip-CTEZqU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:59:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:59:00 INFO - Running setup.py install for manifestparser 10:59:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:59:01 INFO - Running setup.py install for mozcrash 10:59:01 INFO - Running setup.py install for mozdebug 10:59:01 INFO - Running setup.py install for mozdevice 10:59:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:59:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:59:01 INFO - Running setup.py install for mozfile 10:59:01 INFO - Running setup.py install for mozhttpd 10:59:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:59:01 INFO - Running setup.py install for mozinfo 10:59:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:59:01 INFO - Running setup.py install for mozInstall 10:59:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:59:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:59:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:59:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:59:01 INFO - Running setup.py install for mozleak 10:59:01 INFO - Running setup.py install for mozlog 10:59:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:59:01 INFO - Running setup.py install for moznetwork 10:59:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:59:02 INFO - Running setup.py install for mozprocess 10:59:02 INFO - Running setup.py install for mozprofile 10:59:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:59:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:59:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:59:02 INFO - Running setup.py install for mozrunner 10:59:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:59:02 INFO - Running setup.py install for mozscreenshot 10:59:02 INFO - Running setup.py install for moztest 10:59:02 INFO - Running setup.py install for mozversion 10:59:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:59:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:59:02 INFO - Cleaning up... 10:59:02 INFO - Return code: 0 10:59:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f68ab45af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d350>, '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 0x2d3e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3e6e0>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', '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 10:59:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:59:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:59:02 INFO - Using env: {'DISPLAY': ':0', 10:59:02 INFO - 'HOME': '/home/cltbld', 10:59:02 INFO - 'LANG': 'en_US.UTF-8', 10:59:02 INFO - 'LANGUAGE': 'en_US:en', 10:59:02 INFO - 'LOGNAME': 'cltbld', 10:59:02 INFO - 'MAIL': '/var/mail/cltbld', 10:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:02 INFO - 'MOZ_NO_REMOTE': '1', 10:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:02 INFO - 'NO_EM_RESTART': '1', 10:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:59:02 INFO - 'PWD': '/builds/slave/test-pgo', 10:59:02 INFO - 'SHELL': '/bin/bash', 10:59:02 INFO - 'SHLVL': '1', 10:59:02 INFO - 'TERM': 'linux', 10:59:02 INFO - 'TMOUT': '86400', 10:59:02 INFO - 'USER': 'cltbld', 10:59:02 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', 10:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:02 INFO - '_': '/tools/buildbot/bin/python'} 10:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:59:02 INFO - Running setup.py (path:/tmp/pip-BV27fJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:59:02 INFO - Running setup.py (path:/tmp/pip-7dVMKM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:59:03 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)) 10:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:59:03 INFO - Running setup.py (path:/tmp/pip-xd6H0N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:59:03 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)) 10:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:59:03 INFO - Running setup.py (path:/tmp/pip-5cRNJb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:59:03 INFO - Running setup.py (path:/tmp/pip-A0szbi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:59:03 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)) 10:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:59:03 INFO - Running setup.py (path:/tmp/pip-dvGRYP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:59:03 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)) 10:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:59:03 INFO - Running setup.py (path:/tmp/pip-MmDY1S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:59:03 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)) 10:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:59:03 INFO - Running setup.py (path:/tmp/pip-7ceAiS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:59:03 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)) 10:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:59:03 INFO - Running setup.py (path:/tmp/pip-bcw_ql-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 10:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:59:03 INFO - Running setup.py (path:/tmp/pip-oprW8M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:59:03 INFO - Running setup.py (path:/tmp/pip-4UsudE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:59:03 INFO - Running setup.py (path:/tmp/pip-K9tntQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 10:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:59:03 INFO - Running setup.py (path:/tmp/pip-9DCkX_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 10:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:59:03 INFO - Running setup.py (path:/tmp/pip-iSqFAp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:59:03 INFO - Running setup.py (path:/tmp/pip-yjvEFJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:59:03 INFO - Running setup.py (path:/tmp/pip-m2fmFh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:59:04 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)) 10:59:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:59:04 INFO - Running setup.py (path:/tmp/pip-wP29ly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:59:04 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)) 10:59:04 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)) 10:59:04 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)) 10:59:04 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)) 10:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:59:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59:05 INFO - Downloading blessings-1.5.1.tar.gz 10:59:05 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 10:59:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:59:05 INFO - Installing collected packages: blessings 10:59:05 INFO - Running setup.py install for blessings 10:59:05 INFO - Successfully installed blessings 10:59:05 INFO - Cleaning up... 10:59:06 INFO - Return code: 0 10:59:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:59:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:59:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:59:06 INFO - Reading from file tmpfile_stdout 10:59:06 INFO - Current package versions: 10:59:06 INFO - argparse == 1.2.1 10:59:06 INFO - blessings == 1.5.1 10:59:06 INFO - blobuploader == 1.2.4 10:59:06 INFO - docopt == 0.6.1 10:59:06 INFO - manifestparser == 1.1 10:59:06 INFO - mozInstall == 1.12 10:59:06 INFO - mozcrash == 0.16 10:59:06 INFO - mozdebug == 0.1 10:59:06 INFO - mozdevice == 0.47 10:59:06 INFO - mozfile == 1.2 10:59:06 INFO - mozhttpd == 0.7 10:59:06 INFO - mozinfo == 0.9 10:59:06 INFO - mozleak == 0.1 10:59:06 INFO - mozlog == 3.1 10:59:06 INFO - moznetwork == 0.27 10:59:06 INFO - mozprocess == 0.22 10:59:06 INFO - mozprofile == 0.27 10:59:06 INFO - mozrunner == 6.11 10:59:06 INFO - mozscreenshot == 0.1 10:59:06 INFO - mozsystemmonitor == 0.0 10:59:06 INFO - moztest == 0.7 10:59:06 INFO - mozversion == 1.4 10:59:06 INFO - psutil == 3.1.1 10:59:06 INFO - requests == 1.2.3 10:59:06 INFO - wsgiref == 0.1.2 10:59:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:59:06 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')]} 10:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:06 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')]} 10:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:06 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 0x7f68ab45af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d350>, '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 0x2d3e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3e6e0>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', '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 10:59:06 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 10:59:06 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 10:59:06 INFO - Using env: {'DISPLAY': ':0', 10:59:06 INFO - 'HOME': '/home/cltbld', 10:59:06 INFO - 'LANG': 'en_US.UTF-8', 10:59:06 INFO - 'LANGUAGE': 'en_US:en', 10:59:06 INFO - 'LOGNAME': 'cltbld', 10:59:06 INFO - 'MAIL': '/var/mail/cltbld', 10:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:06 INFO - 'MOZ_NO_REMOTE': '1', 10:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:06 INFO - 'NO_EM_RESTART': '1', 10:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:59:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:59:06 INFO - 'SHELL': '/bin/bash', 10:59:06 INFO - 'SHLVL': '1', 10:59:06 INFO - 'TERM': 'linux', 10:59:06 INFO - 'TMOUT': '86400', 10:59:06 INFO - 'USER': 'cltbld', 10:59:06 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', 10:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:06 INFO - '_': '/tools/buildbot/bin/python'} 10:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:06 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 1)) 10:59:06 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 2)) 10:59:06 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 3)) 10:59:06 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 4)) 10:59:06 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 5)) 10:59:06 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 6)) 10:59:06 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 7)) 10:59:06 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 8)) 10:59:06 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:59:06 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 3)) 10:59:06 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:59:06 INFO - Cleaning up... 10:59:06 INFO - Return code: 0 10:59:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:59:06 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')]} 10:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:06 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')]} 10:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:06 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 0x7f68ab45af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d350>, '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 0x2d3e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3e6e0>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', '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 10:59:06 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 10:59:06 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 10:59:06 INFO - Using env: {'DISPLAY': ':0', 10:59:06 INFO - 'HOME': '/home/cltbld', 10:59:06 INFO - 'LANG': 'en_US.UTF-8', 10:59:06 INFO - 'LANGUAGE': 'en_US:en', 10:59:06 INFO - 'LOGNAME': 'cltbld', 10:59:06 INFO - 'MAIL': '/var/mail/cltbld', 10:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:06 INFO - 'MOZ_NO_REMOTE': '1', 10:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:06 INFO - 'NO_EM_RESTART': '1', 10:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:59:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:59:06 INFO - 'SHELL': '/bin/bash', 10:59:06 INFO - 'SHLVL': '1', 10:59:06 INFO - 'TERM': 'linux', 10:59:06 INFO - 'TMOUT': '86400', 10:59:06 INFO - 'USER': 'cltbld', 10:59:06 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', 10:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:06 INFO - '_': '/tools/buildbot/bin/python'} 10:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:06 INFO - Downloading/unpacking jsonschema 10:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:59:08 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 10:59:08 INFO - Downloading/unpacking functools32 (from jsonschema) 10:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:08 INFO - Downloading functools32-3.2.3-2.tar.gz 10:59:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:59:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:59:08 INFO - warning: no files found matching '*.txt' 10:59:08 INFO - no previously-included directories found matching 'build' 10:59:08 INFO - no previously-included directories found matching 'dist' 10:59:08 INFO - no previously-included directories found matching '.git*' 10:59:08 INFO - Installing collected packages: jsonschema, functools32 10:59:08 INFO - Running setup.py install for functools32 10:59:08 INFO - warning: no files found matching '*.txt' 10:59:08 INFO - no previously-included directories found matching 'build' 10:59:08 INFO - no previously-included directories found matching 'dist' 10:59:08 INFO - no previously-included directories found matching '.git*' 10:59:08 INFO - Successfully installed jsonschema functools32 10:59:08 INFO - Cleaning up... 10:59:08 INFO - Return code: 0 10:59:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:59: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')]} 10:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59: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')]} 10:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f68ab45af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d350>, '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 0x2d3e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3e6e0>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', '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 10:59:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 10:59:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:59:08 INFO - Using env: {'DISPLAY': ':0', 10:59:08 INFO - 'HOME': '/home/cltbld', 10:59:08 INFO - 'LANG': 'en_US.UTF-8', 10:59:08 INFO - 'LANGUAGE': 'en_US:en', 10:59:08 INFO - 'LOGNAME': 'cltbld', 10:59:08 INFO - 'MAIL': '/var/mail/cltbld', 10:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:08 INFO - 'MOZ_NO_REMOTE': '1', 10:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:08 INFO - 'NO_EM_RESTART': '1', 10:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:59:08 INFO - 'PWD': '/builds/slave/test-pgo', 10:59:08 INFO - 'SHELL': '/bin/bash', 10:59:08 INFO - 'SHLVL': '1', 10:59:08 INFO - 'TERM': 'linux', 10:59:08 INFO - 'TMOUT': '86400', 10:59:08 INFO - 'USER': 'cltbld', 10:59:08 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', 10:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:08 INFO - '_': '/tools/buildbot/bin/python'} 10:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:09 INFO - Downloading/unpacking flake8 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:59:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 10:59:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:59:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 10:59:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:11 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 10:59:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:59:11 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 10:59:11 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 10:59:11 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 10:59:11 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 10:59:11 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 10:59:11 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 10:59:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:59:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:59:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:59:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:59:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:59:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:59:11 INFO - no previously-included directories found matching 'docs/_build' 10:59:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:59:11 INFO - Running setup.py install for pep8 10:59:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:59:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:59:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:59:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:59:11 INFO - no previously-included directories found matching 'docs/_build' 10:59:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:59:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:59:11 INFO - Cleaning up... 10:59:11 INFO - Return code: 0 10:59:11 INFO - Running post-action listener: _resource_record_post_action 10:59:11 INFO - Running post-action listener: _start_resource_monitoring 10:59:11 INFO - Starting resource monitoring. 10:59:11 INFO - ##### 10:59:11 INFO - ##### Running install step. 10:59:11 INFO - ##### 10:59:11 INFO - Running pre-action listener: _resource_record_pre_action 10:59:11 INFO - Running main action method: install 10:59:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:59:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:59:11 INFO - Reading from file tmpfile_stdout 10:59:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:59:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:59:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:59:11 INFO - Reading from file tmpfile_stdout 10:59:11 INFO - Output received: 10:59:11 INFO - Usage: mozinstall [options] installer 10:59:11 INFO - Options: 10:59:11 INFO - -h, --help show this help message and exit 10:59:11 INFO - -d DEST, --destination=DEST 10:59:11 INFO - Directory to install application into. [default: 10:59:11 INFO - "/builds/slave/test-pgo"] 10:59:11 INFO - --app=APP Application being installed. [default: firefox] 10:59:11 INFO - mkdir: /builds/slave/test-pgo/build/application 10:59:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:59:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:59:27 INFO - Reading from file tmpfile_stdout 10:59:27 INFO - Output received: 10:59:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:59:27 INFO - Running post-action listener: _resource_record_post_action 10:59:27 INFO - ##### 10:59:27 INFO - ##### Running run-tests step. 10:59:27 INFO - ##### 10:59:27 INFO - Running pre-action listener: _resource_record_pre_action 10:59:27 INFO - Running main action method: run_tests 10:59:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:59:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:59:27 INFO - Python 2.7.3 10:59:27 INFO - Return code: 0 10:59:27 INFO - grabbing minidump binary from tooltool 10:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3d350>, '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 0x2d3e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d3e6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:59:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 10:59:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:59:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:59:27 INFO - Return code: 0 10:59:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:59:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:59:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:59:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:59:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:59:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:59:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:59:28 INFO - Return code: 0 10:59:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:59:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost 10:59:28 INFO - Using env: {'DISPLAY': ':0', 10:59:28 INFO - 'HOME': '/home/cltbld', 10:59:28 INFO - 'LANG': 'en_US.UTF-8', 10:59:28 INFO - 'LANGUAGE': 'en_US:en', 10:59:28 INFO - 'LOGNAME': 'cltbld', 10:59:28 INFO - 'MAIL': '/var/mail/cltbld', 10:59:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:59:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:28 INFO - 'MOZ_NO_REMOTE': '1', 10:59:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:59:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:28 INFO - 'NO_EM_RESTART': '1', 10:59:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:59:28 INFO - 'PWD': '/builds/slave/test-pgo', 10:59:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:59:28 INFO - 'SHELL': '/bin/bash', 10:59:28 INFO - 'SHLVL': '1', 10:59:28 INFO - 'TERM': 'linux', 10:59:28 INFO - 'TMOUT': '86400', 10:59:28 INFO - 'USER': 'cltbld', 10:59:28 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441', 10:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:28 INFO - '_': '/tools/buildbot/bin/python'} 10:59:28 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] with output_timeout 3600 10:59:28 INFO - mozversion INFO | application_buildid: 20151219083114 10:59:28 INFO - mozversion INFO | application_changeset: ef961a0fe82f1b2938dcaa47f9911f5de0d08109 10:59:28 INFO - mozversion INFO | application_display_name: Nightly 10:59:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:59:28 INFO - mozversion INFO | application_name: Firefox 10:59:28 INFO - mozversion INFO | application_remotingname: firefox 10:59:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 10:59:28 INFO - mozversion INFO | application_vendor: Mozilla 10:59:28 INFO - mozversion INFO | application_version: 46.0a1 10:59:28 INFO - mozversion INFO | platform_buildid: 20151219083114 10:59:28 INFO - mozversion INFO | platform_changeset: ef961a0fe82f1b2938dcaa47f9911f5de0d08109 10:59:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 10:59:28 INFO - mozversion INFO | platform_version: 46.0a1 10:59:28 INFO - 2015-12-19 10:59:28,822 DEBUG : using testdate: 1450551568 10:59:28 INFO - 2015-12-19 10:59:28,822 DEBUG : actual date: 1450551568 10:59:28 INFO - 2015-12-19 10:59:28,830 INFO : starting webserver on 'localhost:58760' 10:59:28 INFO - 2015-12-19 10:59:28,831 INFO : Starting test suite talos-linux64-ix-030 10:59:28 INFO - 2015-12-19 10:59:28,831 INFO : Starting test dromaeo_css 10:59:28 INFO - 2015-12-19 10:59:28,831 DEBUG : operating with platform_type : linux_ 10:59:28 INFO - 2015-12-19 10:59:28,832 INFO : Initialising browser for dromaeo_css test... 10:59:28 INFO - 2015-12-19 10:59:28,844 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTKp6mZ/profile http://localhost:58760/getInfo.html 10:59:33 INFO - 2015-12-19 10:59:33,202 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:59:33 INFO - 2015-12-19 10:59:33,202 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:59:33 INFO - 2015-12-19 10:59:33,202 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:59:33 INFO - 2015-12-19 10:59:33,203 DEBUG : BROWSER_OUTPUT: __metrics 10:59:33 INFO - 2015-12-19 10:59:33,291 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:59:33 INFO - 2015-12-19 10:59:33,339 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:59:33 ERROR - 2015-12-19 10:59:33,355 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 10:59:34 INFO - 2015-12-19 10:59:34,113 INFO : Browser initialized. 10:59:34 INFO - 2015-12-19 10:59:34,113 INFO : Running cycle 1/1 for dromaeo_css test... 10:59:34 INFO - 2015-12-19 10:59:34,114 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTKp6mZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:59:45 INFO - 2015-12-19 10:59:45,888 DEBUG : BROWSER_OUTPUT: RSS: Main: 150020096 10:59:45 INFO - 2015-12-19 10:59:45,888 DEBUG : BROWSER_OUTPUT: 11:00:37 INFO - 2015-12-19 11:00:37,491 DEBUG : BROWSER_OUTPUT: 1450551637491 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] 11:02:46 INFO - 2015-12-19 11:02:46,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58760/tests/dromaeo/cssquery-ext.html) 11:02:47 INFO - 2015-12-19 11:02:47,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 274616320 11:02:47 INFO - 2015-12-19 11:02:47,189 DEBUG : BROWSER_OUTPUT: 11:05:49 INFO - 2015-12-19 11:05:49,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/dromaeo/cssquery-ext.html (next: http://localhost:58760/tests/dromaeo/cssquery-jquery.html) 11:05:50 INFO - 2015-12-19 11:05:50,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 229191680 11:05:50 INFO - 2015-12-19 11:05:50,280 DEBUG : BROWSER_OUTPUT: 11:08:52 INFO - 2015-12-19 11:08:52,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58760/tests/dromaeo/cssquery-mootools.html) 11:08:52 INFO - 2015-12-19 11:08:52,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 228888576 11:08:52 INFO - 2015-12-19 11:08:52,859 DEBUG : BROWSER_OUTPUT: 11:11:54 INFO - 2015-12-19 11:11:54,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58760/tests/dromaeo/cssquery-prototype.html) 11:11:55 INFO - 2015-12-19 11:11:55,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 209465344 11:11:55 INFO - 2015-12-19 11:11:55,204 DEBUG : BROWSER_OUTPUT: 11:14:57 INFO - 2015-12-19 11:14:57,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58760/tests/dromaeo/cssquery-yui.html) 11:14:58 INFO - 2015-12-19 11:14:58,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 217886720 11:14:58 INFO - 2015-12-19 11:14:58,183 DEBUG : BROWSER_OUTPUT: 11:18:00 INFO - 2015-12-19 11:18:00,735 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/dromaeo/cssquery-yui.html (next: http://localhost:58760/tests/dromaeo/cssquery-dojo.html) 11:18:00 INFO - 2015-12-19 11:18:00,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 295235584 11:18:00 INFO - 2015-12-19 11:18:00,993 DEBUG : BROWSER_OUTPUT: 11:18:00 INFO - 2015-12-19 11:18:00,993 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:18:00 INFO - 2015-12-19 11:18:00,994 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:18:00 INFO - 2015-12-19 11:18:00,994 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:18:00 INFO - 2015-12-19 11:18:00,994 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:18:00 INFO - 2015-12-19 11:18:00,994 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3164.968350316497;3190.5214217867333;3249.2201871550833;3253.446914024617;3265.363254165438;5214.973925130369;5344.011357898791;5397.4332695067;5408.756605952732;5477.561795056391;5288.2596436498925;5289.523942845143;5343.145096784515;5354.5716342692585;5391.973040134794;4846.1034708578845;4851.781669824849;4868.367112275399;4916.680415772981;4934.259861020858;4943.036107958949;4961.70229786214;4990.75046247688;5006.849794506171;5022.673526220784;4757.9286310705365;4768.117898188846;4863.197572400567;4878.853634390938;4903.01939612079;4772.689775164603;4779.904401911942;4781.737004464753;4794.328793968847;4828.227483602606;4763.190257656172;4763.976180119077;4792.353032340624;4795.784189711471;4825.5174482551465;5131.53816156544;5189.714565698885;5234.057869583474;5283.9207411888465;5305.31030965972;5794.942050579482;5797.565182611279;5802.5938184327115;5804.042333015047;5806.303243610793;5758;5817.680027598481;5837.532997360201;5845.210896528956;5856.502197313233;5417.6207665463435;5442.047641662693;5451.700156491392;5479.53423958968;5508;5878.588498805043;5882.911756323659;5884.499817515473;5885.293764748172;5931.228940237742;5522.66863988162;5677.971610142005;5680.943190568041;5682.7442765075675;5709.942900571024;5778.162166485836;5785.82642520725;5819.73811178498;5837.445442683023;5913.408659134138;5694.430556944272;5739.62692424991;5742.196092547047;5748.425157484218;5749.3963133871175;5586.16207568868;5690.345610254791;5702.144678298206;5712.200291959129;5714.7428365723645;4412.205802955499;4447.110577884436;4450.5549445055885;4501.909961800811;4502.797374118107;3978.0054986253435;3979.9801000994808;3989.58109398509;4009.939850902239;4032.3145065338963;5450;5463.726813659301;5470.699111548824;5473.397926228112;5523.199136125239;5659.462351076641;5828.184054232411;5852.473277405054;5855.063189889597;5865.442782935615;5400.91898621521;5401.918971215435;5403.459654034565;5403.864903377447;5443.673379597237;5018.824341148043;5019.67372120811;5025.723585202776;5026.874328141826;5029.044481548494;5782.7686892523825;5876.823695289148;5904.0553511437965;6001.789937352171;6002;5864.472197502245;5876.6180198286975;5884.499817515559;5887.558433117448;5890.64656120617;5966.522678185648;5967.1049342597225;5971.402859713994;5971.552133589911;5973.790917318047;5603.915941260802;5633.8309850704545;5683.8863222736145;5745.712714364181;5779.393163717918;5749.913751293818;5764.884702305846;5765.279340082489;5768.077107662753;5892.057270836645;5574.498295153456;5625.774969001194;5629.718514074198;5632.915506267327;5641.210230567642;5419.593530485151;5526.143447765603;5533.114701647717;5593.188987596857;5631.887362252814;5596.748146333343;5603.663780173202;5605.019121653613;5605.1872478491205;5643.294588176478;5667.971660141673;5689.487946084872;5692;5696.316442026983;5745;5483.588730845282;5528.280582374526;5531.225628412106;5576.609637325349;5595.776168953196 11:18:00 INFO - 2015-12-19 11:18:00,994 DEBUG : BROWSER_OUTPUT: |1;ext.html;546.8183150499968;585.5959388022264;591.396775289205;598.0431309904151;603.0652488642603;29535.704642953566;37801;37837.432438513446;37841.43237851431;37981.430278545806;40815.387769183486;41037.58962410375;41151;41231.58768412315;41259.587404126025;7518.248175182493;7613.7335193268245;8576.614052367659;8892.110788921122;8895.377323587352;10411.479426028669;10588.78822423551;10614.04473597376;10673.19951003674;10681.893181068206;10305;10398;10398.324108932895;10403.791924161513;10407;7697.884531732028;7900.2889739923685;7915;10284.742881427987;10395.272330936838;10027.89972100277;10122.696319110439;10144.594216231342;10151.543180556893;10155.796884062278;39252;40041.59958400408;40077.19845603072;40098.195581198626;40121.59878401208;3406.0633325835593;3415.777974431654;3518.489818976234;3588.784672919607;3720.2001569662652;32043.679563204303;32110.839445802856;32455.837720811243;32786.836065819756;33215.83392083048;3921.372730224531;3925.234579257046;3969.6625786808154;4010.1177740896956;4051.5745846686264;263969;265867.6706616474;266120;266317;266333;54298.384637305484;55657.16514252289;57313;62474;64017.67991160014;56812.727490900725;57008.714956425785;57048.71475642678;57280.42719572834;57370.42629573734;14629.195394253205;14761.77857332141;14769.852301476847;14770.630734231516;14781.704365912836;10995.780084398268;11028.28316159447;11038.613648522423;11054.115670746321;11158.665240042812;19346.903265483863;19702.40892773219;19707;19885.105170267085;19891.303804367068;7813.101493328227;7820.843583128306;8001.399895007898;8029.397795165386;8037.839243215103;963.5326866469757;974.936629119105;1004.322082594246;1047.0785708576557;1122.7642195139113;26288.737112629013;26993.325166870593;27030.729692703215;27477.31306717348;27680.30799229995;1022.8874823769528;1083.869935607732;1087.8803331633515;1094.370736826328;1117.9776404471866;13869.583912482642;13891.527118220445;14037.087589306866;14056.297185140907;14071.929640351733;397492;403421;404530;404715;404796;51036.23445648318;51479.22781158286;51533.48466515287;51570.22644660333;51600.74199628978;1319.9802002969964;1336.5054929676082;1337.5051231044577;1340.2561578323928;1349.0826238158343;24783.752162478864;31300.843495782374;31715;31727.36545269128;32169.35661286808;49208.26187607117;49526.75236623794;49884;49884.25173622326;49933.75033124811;294685;296538;297413;298508;298824;35613.709203954444;36393.272134557694;36552.81723591365;36556.26887462289;41200.587994119676;39340.80329598448;40968.79515602522;42117.78941105275;42248.36627450652;42885;35329.82335088308;36022.45966310455;36379.27241455103;36666.26667466689;41275.38086928758;30071.837234809656;35493.82253088718;36108.458373123896;40242;41954.580454195064;35405.291894161455;35415.291694165455;35429.46855797217;35497.1125721859;35558.46662300016;28467.857660711565;32173;33396.49905251375;33584.16039599029;33588.496172556945;25590.48819023572;26377.208683739518;26535.33661658474;26580.867095665173;26777.19668409951 11:18:00 INFO - 2015-12-19 11:18:00,994 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.6710858901221;355.08742531693525;356.96430356964305;358.8205897051474;359.7553663508814;13661.658458538517;14021.439142434316;16419.58951026225;16439.671206575862;16933.83066169338;9869.062439068295;10146.949265253681;10180.949095254531;13145.934270328635;13422.530211442601;4775.331453596499;4873.293372460991;4893.29047288143;4896.290037944496;4898.583620392253;3737.1591391936868;3832.712546559005;5240.842774716745;5240.895182096356;5414.35027796665;5373.408925018264;5374.414547708436;5375.301210842585;5395.622306438551;5396.97457483079;5208.270842082112;5280.419153893069;5282.7622756976025;5289.947100528984;5363.249145119687;5124.231365295198;5124.359455068116;5127.282180494733;5127.589792816603;5134.2812006319145;12502.49990000399;13292.468301267938;17542.561435964075;19925.20299188031;19950.20199192045;2100.2859027930426;2120.6076875777876;2138.593667203242;2445.3519817248443;2462.8132175302057;9508.334416590842;9694.272929530243;9709.223262139083;9788.657396991071;9882.160016398615;1776.422662634649;1821.6903126468533;1855.2949879046012;1917.587718640485;1922.807719228066;61678.69160654213;63239;63484;63887.361126388605;64585.99999999953;9330.95334523323;9379.5310234488;9502.192313653417;9685.6610018649;9723.367981081348;12252.81620775689;12420.75158496825;12452.128351015343;12454.750904982031;12459.626211213677;7149.177844547944;7151;7195.2444993276;7225.89161162583;7362.44781641379;6786.626735529495;6788.253292137861;6848.315168483212;6854.931450685529;6856.862862742717;4039.091204478969;4157.771322577288;4175.749455032707;4282.957170428318;4503.392042074343;1648.1100205888924;1661.3852874436536;1686.8987860728396;1690.0535700008036;1716.313474610141;893.4996402014892;924.523870206844;929.1962452478557;958.8274110660009;1010.6816352848977;15795.763063554055;16200.75698864518;16447.83552164487;16642.833571664127;16697.83302166987;910.153557191818;916.7341470973344;940.4592359393376;943.8065196634674;962.5455089521691;9543.188828949478;9665.758356041015;10077.748056298504;10121.59513619447;10150.44172570501;546300;562555;566563;584335;588773;82481;83770;83805;84089;84454.15545844586;1138.1065863297272;1155.5031336525374;1158.6987383280239;1167.0780083733925;1174.0959461214645;14730.779038314648;15460.768088478457;15633.609159771097;15718.842811571738;16041.438549650706;32858;33935.490967636;34170.658293416745;34430.31139377148;36708.44937325889;41424;41832.163356733305;42413.78793106015;42628.573714262464;43980.56019439764;9317.72046838596;9340.299477539076;9343.551749478842;9574.138327550554;9584.952075239578;17358.73961890598;17467.737983930507;17607.031613261395;17784.911075445056;18034;10988.780224395627;11567.537298507965;12574.559890403792;13468.124571902796;14383.20892350889;11737.178397512092;12699.55551555728;13377.866221337663;13590.708882656132;13978.580642580739;11929.522819087138;13771.586852394445;14320.856791431952;14416.855831441551;14936.85063149398;9084.273258139201;9244.399114057565;9252.629894804133;9310.487923164292;9517.191038761783;13827.101238419471;13865.09876858001;13916.373763180478;14096.295185240902;14149.36327865269 11:18:00 INFO - 2015-12-19 11:18:00,995 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1369.7467665689935;1518.7038527487136;1583.6990971715372;1674;1761.0930370859003;6756.932430675692;7203.099612548432;7345.228750981137;7364.484486085963;7364.926350736498;7465.552066875991;7626.847463050735;7633.236676332364;7634.465587408884;7643.388528917687;2124.755653099894;2162.589108069462;2164.8809315487642;2165.036558731365;2167.3497950614833;2117.1319758898853;2154.1168121070364;2195.6157672407267;2197.461621902636;2199.2082850173924;2143.3141394753684;2167.371462275938;2181.2365672014826;2204.944876378095;2206.8344874134423;2178.1505212966954;2205.3604454708197;2205.8345624078256;2206.878621675807;2206.933791986243;2121.2151503943487;2145.570885822826;2148.602508535926;2148.645473496871;2150.3333966470445;7124.073870396815;7180.425565954711;7185;7193.172785129725;7203.279672032807;4341.522432532419;4405.361222622734;4407.625351845097;4409.074094440171;4418.536053714346;3093.675164107759;3127.9218019549467;3131.170239886432;3140.1678555182893;3157.6684448133074;955.1165172215742;1008.1531513528671;1031.8658574385356;1085.4626959654943;1142.851429314192;9593.47235902025;9595.616175352978;9608;9625.759356016086;9654.131128198425;3895.8831235062994;3918.8236529356245;3943.3493473577114;3948.6446219839777;3978.104926391539;8421.326293896474;8445.493270403795;8451.53516556583;8452.323814094858;8459.407841451162;4433.6009759121835;4433.844815431445;4437.445319335083;4438.334249862482;4442.911141777146;3657.04916721649;3750.3436898542645;4026.3557830747527;4058.4521089652517;4068.6745060395097;3588.551431071116;3638.5633723953297;3647.76289541179;3668.3030224257304;3694.6674799268194;1171.3674615707423;1175.14801768717;1177.5937301630925;1184.4847491341122;1188.0792385900822;1325.072449285504;1330.0755974597562;1349.1500354776624;1372.1286982765816;1389.7637401641746;7329.486935914435;7333.230010848784;7476.850462990709;7495.175530691619;7533.2466753325325;1124.600766727816;1131.089202478742;1132.17351333527;1146.3236690352733;1162.8895254950767;5641.605087643908;5699.487046165865;5704;5755.8561035974435;5771.769129234784;8842.646294148162;9026.503542305105;9091.31815113869;9319.953400233091;9344.252459803336;9182.403143795633;9189.310801689766;9234.076592340847;9234.122758337948;9243.815123697623;6976.5814051157095;7038.612876291853;7045.365917067488;7049.92950070503;7213.89179162313;7144.821379465555;7154.749583764543;7155.356017958408;7163.391111755351;7170.605616690923;7950.602469876368;8270.966129233846;8280.958595206985;8290.668373265002;8291.792705182419;8344.791380215544;8478.660853565789;8484.872726909225;8575.95712021436;8576.914230857612;5914.822555323347;6056.121862329849;6065.60573562717;6156.722947467285;6411.839704007437;7092.929070709227;7169.211386747349;7192.712291508281;7212.783616491513;7219.241979592277;6872.209695885037;6977.372036516738;6986.196587392312;6999.51003429755;7207.171175314906;6886.173659160932;6991.44068474531;7007.404370628554;7013.4038606719005;7090.4327653788605;7041.401480874183;7047.859042819013;7097.041899343522;7115.395191408788;7146.749863754743;6544.149260596092;6553.311902250195;6583.901241481477;6596.472282217315;6600.53796234259;6248.218972628421;6635.369639884203;6703.8324041897395;6704.027915952257;6716.1604799400075 11:18:00 INFO - 2015-12-19 11:18:00,997 DEBUG : BROWSER_OUTPUT: |4;prototype.html;331.38362645479407;334.62856229585157;337.7686284894846;342.9348423799476;346.35059263880225;6012.068129439933;6046.3349031606485;6052.273727152737;6062.120992456097;6113.388661133884;5887.470127688507;5927.051671732524;5934.8219553413355;5945.762169513214;5979.073243647231;4604.838830640928;4609.792559334821;4612.377329060584;4614.30785382192;4631.212693842055;4403.119376124771;4554.316852472122;4564.589186973171;4611.746353950532;4632.884177895563;4543.65922555808;4543.681942264043;4543.909121817562;4551.817927282905;4569.771511424432;4329.393884856091;4465.218586747339;4539.59143677069;4549.385832912548;4552.726836389811;3859.7684138951754;3861;3861.806909654506;3874.070223146453;3957;5725.599208055438;5747.281589801275;5760.2511673482595;5761.107028410561;5798.971005144947;5014.272930425068;5309.548688361494;5318.175682769177;5319.069162896478;5326.2543243945875;6190.442860142609;6214.0989556514505;6322.430981211713;6337.904931425986;6346.9682651586445;4265.893352666177;4274.7435153890865;4283.485981682187;4284.164587905359;4286.507051689034;6551.672416379162;6629.801105966829;6638.668066596699;6639;6641.535092543476;4364.934525982113;4426.75652839097;4445.377647129404;4461.709988850715;4506.526814684476;4556.384888040138;4563.041761230179;4563.429571303587;4563.9087218255445;4566.543345665474;5300.6024548158275;5303.416624171338;5315.893682126336;5318.122509785842;5320.760565774472;6318.652474113968;6444.838879027968;6445.9355406446275;6449.677516124175;6456.451201647913;1582.485692150056;1599.1204837339417;1599.5681166085092;1599.7760313556112;1602.8477294656989;1049.5539395756773;1052.7262911642874;1055.9757035675382;1057.6509751781894;1062.5006247063868;6170.7223174957235;6182.598131121463;6186.721597528122;6188.783392581328;6189.690515474208;6631.86736265272;6644.302348253364;6646.036324732887;6648.069270302161;6657.267700552935;6027.849303767441;6177.907331390033;6178.969105154445;6187.566870319124;6189.412005859436;3558.3594952908725;3586;3592.1019745063736;3592.7844329340323;3593.6406359363855;6762.391384775394;6767.1879374475375;6776.220734615484;6788.049673045777;6796.660166991631;6674.699638516278;6795.422389096982;6803.183617965876;6805;6812.897806532906;6561.671916404256;6590.110335104795;6697.062411262427;6704.83237919056;6726.461883049345;6576.112224849584;6635.303293154342;6653.9667301663185;6656.334366563498;6667.599944003376;6573.309802470863;6577.276499585138;6579.539432239697;6580.901286480803;6580.967095164494;6641.1034510342415;6781.898271525833;6782.491313151435;6793.218779840382;6794.082798822095;4386.64906807461;4402.8679139625865;4414.381986521954;4423.137488189772;4423.712458690175;6672.099266598947;6675.299093595297;6680.231773345933;6681.699323530355;6686.197656281277;6357.904631430625;6489.5781774184525;6494.285628580947;6495.870082598416;6499.1876015498065;6447.419732223935;6467.191601049869;6473.385028422293;6478.384553467413;6487.416132548094;6340.112384266298;6361.173047503795;6362.586431881913;6369.522285828489;6377.202849643794;6413.102165696713;6528.543001990005;6531.379518945692;6533.150690410216;6536.738530458729;6371.649559274099;6372.617642941253;6374.07575901501;6374.26695929974;6377.489800815831 11:18:00 INFO - 2015-12-19 11:18:00,998 DEBUG : BROWSER_OUTPUT: |5;yui.html;808.6239898447222;837.254843189561;871.2768402226153;885.4244740918402;896.5338024227398;13561;13985.230812305319;14009.29953502326;14033.438662453502;14055.789163162548;13094.345282735872;13110;13195.6701082473;13199.736005279889;13228.933855330733;679.3003206697098;690.1097584116484;820.1101804542079;835.5195762436593;840.5545061117617;836.0970152235572;837.2632083766277;844.3878188313485;844.932405407569;845.1337379186352;717.2074857282706;871.5163084488106;877.4603618774472;877.6796469288696;878.2227728460294;719.5215181904027;863.0549548244693;867.2368315882046;870.4168207301155;877.929765618749;640.0367446992246;646.8770933522616;647.1780838335335;647.3138473218404;647.33971349224;13353.666158346023;13520.93239533796;13563.59309220725;13621.523246686418;13688.726225475435;11876.52493900243;12222.694432639166;12280.447379867928;12421.130520863544;12664.17682850621;10329.84505232422;10376.79246415075;10426.895731042669;10427.558618504454;10471.109955653703;3643.2531331077066;3679.3745063339297;3703.592604813495;3767.5478942526797;3818.1409182933894;45253.32120018202;45763.54236457659;45769;45779.31331030037;45983;9927.50362481873;9985.20118390527;10246;10386.11718003963;10634.46827658614;17941.461756147335;17948;17962.371317003843;17967.820321796877;17976.640467190584;7554.395648348229;7702.537847729154;7773.961130194313;7790.844183116419;7889;4218.8312467500955;4268;4308.375285583573;4385.166818304512;4403.339499075164;3034;3053.633563972293;3061.0204734485196;3067.2638566744267;3070.4626690329105;553.6152374100043;559.8068666310116;561.0686260807122;561.7893290016244;578.6499168003381;602.4668168670757;607.1924340626956;636.1856823266227;649.3538928765814;663.3896814930275;8462.19609137131;8488.957555212184;8542.273906717874;8568.314534837198;8687.695930642523;501.68143229049815;597.3548567547039;610.767908194892;611.8378629663143;637.416763661254;4083.387491876183;4128.318827393507;4152.8338866445;4163.333866581393;4193.916121677549;58794.41205587975;59201.11198332028;59395.703021484616;59444.70277648671;61156.38843611507;51227.23159152616;52394;52769.47230527645;52838;52947.205791913155;44508.55491445109;44848.3272750909;45941;46754.76622616933;47482.28776568354;9058.36591438593;9063.773405664911;9127;9130.406523575946;9300.11648893354;34220;34934.47598285977;34998.82500587481;35004;35388.292234155684;42878.571214288706;45578;46220.76889615531;46299;46476.30285545787;10860.728481788019;10960.671179864617;10977.560897564328;11173.970336170281;11294.887051129384;11993.868247207492;12119.394030298274;12122.575709850113;12192.51229950792;12253.816192756938;11448.713782155513;11540.134489913122;11616.94191529037;12352.25886446816;12389.380530973234;11510.712232194262;11782.882171178178;11896.940515297369;11966.341851198267;12331.50673973031;10791.56833726642;10954.726131846768;10956.671299861016;10964.177686673691;11049.447527623748;10067.345622534513;10096.394216347042;10166.881643019115;10190.110298673937;10461.633842815465;9487.430754154773;9491.620335186792;9576.664816731382;9798.706038818847;9826.787943287021 11:18:00 INFO - 2015-12-19 11:18:00,998 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:18:00 INFO - 2015-12-19 11:18:00,998 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:18:00 INFO - 2015-12-19 11:18:00,998 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,913 11:18:00 INFO - 2015-12-19 11:18:00,998 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:18:00 INFO - 2015-12-19 11:18:00,998 DEBUG : BROWSER_OUTPUT: __startTimestamp1450552680987__endTimestamp 11:18:00 INFO - 2015-12-19 11:18:00,998 DEBUG : BROWSER_OUTPUT: 11:18:00 INFO - 2015-12-19 11:18:00,998 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:18:01 INFO - 2015-12-19 11:18:00,999 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:18:01 INFO - 2015-12-19 11:18:00,999 DEBUG : BROWSER_OUTPUT: 11:18:01 INFO - 2015-12-19 11:18:00,999 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5356.10 Median:5574.50 stddev:598.09 (10.7%) stddev-sans-first:574.69 11:18:01 INFO - 2015-12-19 11:18:00,999 DEBUG : BROWSER_OUTPUT: Values: 3165.0 3190.5 3249.2 3253.4 3265.4 5215.0 5344.0 5397.4 5408.8 5477.6 5288.3 5289.5 5343.1 5354.6 5392.0 4846.1 4851.8 4868.4 4916.7 4934.3 4943.0 4961.7 4990.8 5006.8 5022.7 4757.9 4768.1 4863.2 4878.9 4903.0 4772.7 4779.9 4781.7 4794.3 4828.2 4763.2 4764.0 4792.4 4795.8 4825.5 5131.5 5189.7 5234.1 5283.9 5305.3 5794.9 5797.6 5802.6 5804.0 5806.3 5758.0 5817.7 5837.5 5845.2 5856.5 5417.6 5442.0 5451.7 5479.5 5508.0 5878.6 5882.9 5884.5 5885.3 5931.2 5522.7 5678.0 5680.9 5682.7 5709.9 5778.2 5785.8 5819.7 5837.4 5913.4 5694.4 5739.6 5742.2 5748.4 5749.4 5586.2 5690.3 5702.1 5712.2 5714.7 4412.2 4447.1 4450.6 4501.9 4502.8 3978.0 3980.0 3989.6 4009.9 4032.3 5450.0 5463.7 5470.7 5473.4 5523.2 5659.5 5828.2 5852.5 5855.1 5865.4 5400.9 5401.9 5403.5 5403.9 5443.7 5018.8 5019.7 5025.7 5026.9 5029.0 5782.8 5876.8 5904.1 6001.8 6002.0 5864.5 5876.6 5884.5 5887.6 5890.6 5966.5 5967.1 5971.4 5971.6 5973.8 5603.9 5633.8 5683.9 5745.7 5779.4 5749.9 5764.9 5765.3 5768.1 5892.1 5574.5 5625.8 5629.7 5632.9 5641.2 5419.6 5526.1 5533.1 5593.2 5631.9 5596.7 5603.7 5605.0 5605.2 5643.3 5668.0 5689.5 5692.0 5696.3 5745.0 5483.6 5528.3 5531.2 5576.6 5595.8 11:18:01 INFO - 2015-12-19 11:18:00,999 DEBUG : BROWSER_OUTPUT: 11:18:01 INFO - 2015-12-19 11:18:00,999 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49000.59 Median:35367.56 stddev:85943.85 (243.0%) stddev-sans-first:86107.95 11:18:01 INFO - 2015-12-19 11:18:00,999 DEBUG : BROWSER_OUTPUT: Values: 546.8 585.6 591.4 598.0 603.1 29535.7 37801.0 37837.4 37841.4 37981.4 40815.4 41037.6 41151.0 41231.6 41259.6 7518.2 7613.7 8576.6 8892.1 8895.4 10411.5 10588.8 10614.0 10673.2 10681.9 10305.0 10398.0 10398.3 10403.8 10407.0 7697.9 7900.3 7915.0 10284.7 10395.3 10027.9 10122.7 10144.6 10151.5 10155.8 39252.0 40041.6 40077.2 40098.2 40121.6 3406.1 3415.8 3518.5 3588.8 3720.2 32043.7 32110.8 32455.8 32786.8 33215.8 3921.4 3925.2 3969.7 4010.1 4051.6 263969.0 265867.7 266120.0 266317.0 266333.0 54298.4 55657.2 57313.0 62474.0 64017.7 56812.7 57008.7 57048.7 57280.4 57370.4 14629.2 14761.8 14769.9 14770.6 14781.7 10995.8 11028.3 11038.6 11054.1 11158.7 19346.9 19702.4 19707.0 19885.1 19891.3 7813.1 7820.8 8001.4 8029.4 8037.8 963.5 974.9 1004.3 1047.1 1122.8 26288.7 26993.3 27030.7 27477.3 27680.3 1022.9 1083.9 1087.9 1094.4 1118.0 13869.6 13891.5 14037.1 14056.3 14071.9 397492.0 403421.0 404530.0 404715.0 404796.0 51036.2 51479.2 51533.5 51570.2 51600.7 1320.0 1336.5 1337.5 1340.3 1349.1 24783.8 31300.8 31715.0 31727.4 32169.4 49208.3 49526.8 49884.0 49884.3 49933.8 294685.0 296538.0 297413.0 298508.0 298824.0 35613.7 36393.3 36552.8 36556.3 41200.6 39340.8 40968.8 42117.8 42248.4 42885.0 35329.8 36022.5 36379.3 36666.3 41275.4 30071.8 35493.8 36108.5 40242.0 41954.6 35405.3 35415.3 35429.5 35497.1 35558.5 28467.9 32173.0 33396.5 33584.2 33588.5 25590.5 26377.2 26535.3 26580.9 26777.2 11:18:01 INFO - 2015-12-19 11:18:00,999 DEBUG : BROWSER_OUTPUT: 11:18:01 INFO - 2015-12-19 11:18:00,999 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29258.44 Median:22731.55 stddev:93216.03 (410.1%) stddev-sans-first:93452.25 11:18:01 INFO - 2015-12-19 11:18:01,000 DEBUG : BROWSER_OUTPUT: Values: 353.7 355.1 357.0 358.8 359.8 13661.7 14021.4 16419.6 16439.7 16933.8 9869.1 10146.9 10180.9 13145.9 13422.5 4775.3 4873.3 4893.3 4896.3 4898.6 3737.2 3832.7 5240.8 5240.9 5414.4 5373.4 5374.4 5375.3 5395.6 5397.0 5208.3 5280.4 5282.8 5289.9 5363.2 5124.2 5124.4 5127.3 5127.6 5134.3 12502.5 13292.5 17542.6 19925.2 19950.2 2100.3 2120.6 2138.6 2445.4 2462.8 9508.3 9694.3 9709.2 9788.7 9882.2 1776.4 1821.7 1855.3 1917.6 1922.8 61678.7 63239.0 63484.0 63887.4 64586.0 9331.0 9379.5 9502.2 9685.7 9723.4 12252.8 12420.8 12452.1 12454.8 12459.6 7149.2 7151.0 7195.2 7225.9 7362.4 6786.6 6788.3 6848.3 6854.9 6856.9 4039.1 4157.8 4175.7 4283.0 4503.4 1648.1 1661.4 1686.9 1690.1 1716.3 893.5 924.5 929.2 958.8 1010.7 15795.8 16200.8 16447.8 16642.8 16697.8 910.2 916.7 940.5 943.8 962.5 9543.2 9665.8 10077.7 10121.6 10150.4 546300.0 562555.0 566563.0 584335.0 588773.0 82481.0 83770.0 83805.0 84089.0 84454.2 1138.1 1155.5 1158.7 1167.1 1174.1 14730.8 15460.8 15633.6 15718.8 16041.4 32858.0 33935.5 34170.7 34430.3 36708.4 41424.0 41832.2 42413.8 42628.6 43980.6 9317.7 9340.3 9343.6 9574.1 9585.0 17358.7 17467.7 17607.0 17784.9 18034.0 10988.8 11567.5 12574.6 13468.1 14383.2 11737.2 12699.6 13377.9 13590.7 13978.6 11929.5 13771.6 14320.9 14416.9 14936.9 9084.3 9244.4 9252.6 9310.5 9517.2 13827.1 13865.1 13916.4 14096.3 14149.4 11:18:01 INFO - 2015-12-19 11:18:01,000 DEBUG : BROWSER_OUTPUT: 11:18:01 INFO - 2015-12-19 11:18:01,001 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5295.89 Median:6548.73 stddev:2701.55 (41.3%) stddev-sans-first:2693.00 11:18:01 INFO - 2015-12-19 11:18:01,001 DEBUG : BROWSER_OUTPUT: Values: 1369.7 1518.7 1583.7 1674.0 1761.1 6756.9 7203.1 7345.2 7364.5 7364.9 7465.6 7626.8 7633.2 7634.5 7643.4 2124.8 2162.6 2164.9 2165.0 2167.3 2117.1 2154.1 2195.6 2197.5 2199.2 2143.3 2167.4 2181.2 2204.9 2206.8 2178.2 2205.4 2205.8 2206.9 2206.9 2121.2 2145.6 2148.6 2148.6 2150.3 7124.1 7180.4 7185.0 7193.2 7203.3 4341.5 4405.4 4407.6 4409.1 4418.5 3093.7 3127.9 3131.2 3140.2 3157.7 955.1 1008.2 1031.9 1085.5 1142.9 9593.5 9595.6 9608.0 9625.8 9654.1 3895.9 3918.8 3943.3 3948.6 3978.1 8421.3 8445.5 8451.5 8452.3 8459.4 4433.6 4433.8 4437.4 4438.3 4442.9 3657.0 3750.3 4026.4 4058.5 4068.7 3588.6 3638.6 3647.8 3668.3 3694.7 1171.4 1175.1 1177.6 1184.5 1188.1 1325.1 1330.1 1349.2 1372.1 1389.8 7329.5 7333.2 7476.9 7495.2 7533.2 1124.6 1131.1 1132.2 1146.3 1162.9 5641.6 5699.5 5704.0 5755.9 5771.8 8842.6 9026.5 9091.3 9320.0 9344.3 9182.4 9189.3 9234.1 9234.1 9243.8 6976.6 7038.6 7045.4 7049.9 7213.9 7144.8 7154.7 7155.4 7163.4 7170.6 7950.6 8271.0 8281.0 8290.7 8291.8 8344.8 8478.7 8484.9 8576.0 8576.9 5914.8 6056.1 6065.6 6156.7 6411.8 7092.9 7169.2 7192.7 7212.8 7219.2 6872.2 6977.4 6986.2 6999.5 7207.2 6886.2 6991.4 7007.4 7013.4 7090.4 7041.4 7047.9 7097.0 7115.4 7146.7 6544.1 6553.3 6583.9 6596.5 6600.5 6248.2 6635.4 6703.8 6704.0 6716.2 11:18:01 INFO - 2015-12-19 11:18:01,001 DEBUG : BROWSER_OUTPUT: 11:18:01 INFO - 2015-12-19 11:18:01,001 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5334.25 Median:6142.06 stddev:1631.54 (26.6%) stddev-sans-first:1592.32 11:18:01 INFO - 2015-12-19 11:18:01,001 DEBUG : BROWSER_OUTPUT: Values: 331.4 334.6 337.8 342.9 346.4 6012.1 6046.3 6052.3 6062.1 6113.4 5887.5 5927.1 5934.8 5945.8 5979.1 4604.8 4609.8 4612.4 4614.3 4631.2 4403.1 4554.3 4564.6 4611.7 4632.9 4543.7 4543.7 4543.9 4551.8 4569.8 4329.4 4465.2 4539.6 4549.4 4552.7 3859.8 3861.0 3861.8 3874.1 3957.0 5725.6 5747.3 5760.3 5761.1 5799.0 5014.3 5309.5 5318.2 5319.1 5326.3 6190.4 6214.1 6322.4 6337.9 6347.0 4265.9 4274.7 4283.5 4284.2 4286.5 6551.7 6629.8 6638.7 6639.0 6641.5 4364.9 4426.8 4445.4 4461.7 4506.5 4556.4 4563.0 4563.4 4563.9 4566.5 5300.6 5303.4 5315.9 5318.1 5320.8 6318.7 6444.8 6445.9 6449.7 6456.5 1582.5 1599.1 1599.6 1599.8 1602.8 1049.6 1052.7 1056.0 1057.7 1062.5 6170.7 6182.6 6186.7 6188.8 6189.7 6631.9 6644.3 6646.0 6648.1 6657.3 6027.8 6177.9 6179.0 6187.6 6189.4 3558.4 3586.0 3592.1 3592.8 3593.6 6762.4 6767.2 6776.2 6788.0 6796.7 6674.7 6795.4 6803.2 6805.0 6812.9 6561.7 6590.1 6697.1 6704.8 6726.5 6576.1 6635.3 6654.0 6656.3 6667.6 6573.3 6577.3 6579.5 6580.9 6581.0 6641.1 6781.9 6782.5 6793.2 6794.1 4386.6 4402.9 4414.4 4423.1 4423.7 6672.1 6675.3 6680.2 6681.7 6686.2 6357.9 6489.6 6494.3 6495.9 6499.2 6447.4 6467.2 6473.4 6478.4 6487.4 6340.1 6361.2 6362.6 6369.5 6377.2 6413.1 6528.5 6531.4 6533.2 6536.7 6371.6 6372.6 6374.1 6374.3 6377.5 11:18:01 INFO - 2015-12-19 11:18:01,001 DEBUG : BROWSER_OUTPUT: 11:18:01 INFO - 2015-12-19 11:18:01,001 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13905.04 Median:45050.82 stddev:16045.66 (35.6%) stddev-sans-first:16060.53 11:18:01 INFO - 2015-12-19 11:18:01,001 DEBUG : BROWSER_OUTPUT: Values: 808.6 837.3 871.3 885.4 896.5 13561.0 13985.2 14009.3 14033.4 14055.8 13094.3 13110.0 13195.7 13199.7 13228.9 679.3 690.1 820.1 835.5 840.6 836.1 837.3 844.4 844.9 845.1 717.2 871.5 877.5 877.7 878.2 719.5 863.1 867.2 870.4 877.9 640.0 646.9 647.2 647.3 647.3 13353.7 13520.9 13563.6 13621.5 13688.7 11876.5 12222.7 12280.4 12421.1 12664.2 10329.8 10376.8 10426.9 10427.6 10471.1 3643.3 3679.4 3703.6 3767.5 3818.1 45253.3 45763.5 45769.0 45779.3 45983.0 9927.5 9985.2 10246.0 10386.1 10634.5 17941.5 17948.0 17962.4 17967.8 17976.6 7554.4 7702.5 7774.0 7790.8 7889.0 4218.8 4268.0 4308.4 4385.2 4403.3 3034.0 3053.6 3061.0 3067.3 3070.5 553.6 559.8 561.1 561.8 578.6 602.5 607.2 636.2 649.4 663.4 8462.2 8489.0 8542.3 8568.3 8687.7 501.7 597.4 610.8 611.8 637.4 4083.4 4128.3 4152.8 4163.3 4193.9 58794.4 59201.1 59395.7 59444.7 61156.4 51227.2 52394.0 52769.5 52838.0 52947.2 44508.6 44848.3 45941.0 46754.8 47482.3 9058.4 9063.8 9127.0 9130.4 9300.1 34220.0 34934.5 34998.8 35004.0 35388.3 42878.6 45578.0 46220.8 46299.0 46476.3 10860.7 10960.7 10977.6 11174.0 11294.9 11993.9 12119.4 12122.6 12192.5 12253.8 11448.7 11540.1 11616.9 12352.3 12389.4 11510.7 11782.9 11896.9 11966.3 12331.5 10791.6 10954.7 10956.7 10964.2 11049.4 10067.3 10096.4 10166.9 10190.1 10461.6 9487.4 9491.6 9576.7 9798.7 9826.8 11:18:01 INFO - 2015-12-19 11:18:01,001 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:18:01 INFO - 2015-12-19 11:18:01,001 DEBUG : BROWSER_OUTPUT: 11:18:01 INFO - 2015-12-19 11:18:01,717 INFO : Browser exited with error code: 0 11:18:01 INFO - 2015-12-19 11:18:01,736 INFO : Completed test dromaeo_css (00:18:32) 11:18:01 INFO - 2015-12-19 11:18:01,736 INFO : Starting test kraken 11:18:01 INFO - 2015-12-19 11:18:01,736 DEBUG : operating with platform_type : linux_ 11:18:01 INFO - 2015-12-19 11:18:01,736 INFO : Initialising browser for kraken test... 11:18:01 INFO - 2015-12-19 11:18:01,742 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9MsDD1/profile http://localhost:58760/getInfo.html 11:18:06 INFO - 2015-12-19 11:18:06,148 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:18:06 INFO - 2015-12-19 11:18:06,148 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:18:06 INFO - 2015-12-19 11:18:06,148 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:18:06 INFO - 2015-12-19 11:18:06,148 DEBUG : BROWSER_OUTPUT: __metrics 11:18:06 INFO - 2015-12-19 11:18:06,271 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:18:06 INFO - 2015-12-19 11:18:06,327 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:18:07 INFO - 2015-12-19 11:18:07,212 INFO : Browser initialized. 11:18:07 INFO - 2015-12-19 11:18:07,213 INFO : Running cycle 1/1 for kraken test... 11:18:07 INFO - 2015-12-19 11:18:07,213 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9MsDD1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:18:19 INFO - 2015-12-19 11:18:19,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 150650880 11:18:19 INFO - 2015-12-19 11:18:19,030 DEBUG : BROWSER_OUTPUT: 11:18:21 INFO - 2015-12-19 11:18:21,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58760/tests/kraken/driver.html?testName=audio-beat-detection) 11:18:22 INFO - 2015-12-19 11:18:22,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 186380288 11:18:22 INFO - 2015-12-19 11:18:22,077 DEBUG : BROWSER_OUTPUT: 11:18:24 INFO - 2015-12-19 11:18:24,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58760/tests/kraken/driver.html?testName=audio-dft) 11:18:25 INFO - 2015-12-19 11:18:25,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 177401856 11:18:25 INFO - 2015-12-19 11:18:25,239 DEBUG : BROWSER_OUTPUT: 11:18:28 INFO - 2015-12-19 11:18:28,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58760/tests/kraken/driver.html?testName=audio-fft) 11:18:28 INFO - 2015-12-19 11:18:28,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 161173504 11:18:28 INFO - 2015-12-19 11:18:28,659 DEBUG : BROWSER_OUTPUT: 11:18:30 INFO - 2015-12-19 11:18:30,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58760/tests/kraken/driver.html?testName=audio-oscillator) 11:18:31 INFO - 2015-12-19 11:18:31,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 163831808 11:18:31 INFO - 2015-12-19 11:18:31,217 DEBUG : BROWSER_OUTPUT: 11:18:33 INFO - 2015-12-19 11:18:33,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58760/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:18:33 INFO - 2015-12-19 11:18:33,982 DEBUG : BROWSER_OUTPUT: RSS: Main: 164507648 11:18:33 INFO - 2015-12-19 11:18:33,983 DEBUG : BROWSER_OUTPUT: 11:18:36 INFO - 2015-12-19 11:18:36,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58760/tests/kraken/driver.html?testName=imaging-darkroom) 11:18:37 INFO - 2015-12-19 11:18:37,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 164495360 11:18:37 INFO - 2015-12-19 11:18:37,426 DEBUG : BROWSER_OUTPUT: 11:18:40 INFO - 2015-12-19 11:18:40,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58760/tests/kraken/driver.html?testName=imaging-desaturate) 11:18:41 INFO - 2015-12-19 11:18:41,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 165605376 11:18:41 INFO - 2015-12-19 11:18:41,341 DEBUG : BROWSER_OUTPUT: 11:18:44 INFO - 2015-12-19 11:18:44,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58760/tests/kraken/driver.html?testName=json-parse-financial) 11:18:44 INFO - 2015-12-19 11:18:44,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 166875136 11:18:44 INFO - 2015-12-19 11:18:44,633 DEBUG : BROWSER_OUTPUT: 11:18:46 INFO - 2015-12-19 11:18:46,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58760/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:18:46 INFO - 2015-12-19 11:18:46,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 174505984 11:18:46 INFO - 2015-12-19 11:18:46,742 DEBUG : BROWSER_OUTPUT: 11:18:48 INFO - 2015-12-19 11:18:48,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58760/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:18:49 INFO - 2015-12-19 11:18:49,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 174080000 11:18:49 INFO - 2015-12-19 11:18:49,159 DEBUG : BROWSER_OUTPUT: 11:18:51 INFO - 2015-12-19 11:18:51,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58760/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:18:51 INFO - 2015-12-19 11:18:51,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 186146816 11:18:51 INFO - 2015-12-19 11:18:51,772 DEBUG : BROWSER_OUTPUT: 11:18:54 INFO - 2015-12-19 11:18:54,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58760/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:18:54 INFO - 2015-12-19 11:18:54,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 194060288 11:18:54 INFO - 2015-12-19 11:18:54,752 DEBUG : BROWSER_OUTPUT: 11:18:57 INFO - 2015-12-19 11:18:57,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58760/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:18:57 INFO - 2015-12-19 11:18:57,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 191270912 11:18:57 INFO - 2015-12-19 11:18:57,885 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58760/tests/kraken/driver.html?testName=ai-astar) 11:18:59 INFO - 2015-12-19 11:18:59,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 248360960 11:18:59 INFO - 2015-12-19 11:18:59,820 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,821 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:18:59 INFO - 2015-12-19 11:18:59,821 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:18:59 INFO - 2015-12-19 11:18:59,822 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:18:59 INFO - 2015-12-19 11:18:59,822 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:18:59 INFO - 2015-12-19 11:18:59,822 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;105;111;114;112;98;111;109;116 11:18:59 INFO - 2015-12-19 11:18:59,822 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;131;152;161;135;162;149;121;161;122 11:18:59 INFO - 2015-12-19 11:18:59,823 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;159;161;161;159;159;163;161;160 11:18:59 INFO - 2015-12-19 11:18:59,823 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;71;84;97;72;78;73;116;93;73 11:18:59 INFO - 2015-12-19 11:18:59,823 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;139;92;93;93;139;93;93;136 11:18:59 INFO - 2015-12-19 11:18:59,824 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;110;110;109;109;109;109 11:18:59 INFO - 2015-12-19 11:18:59,824 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;145;145;145;145;145;145;145 11:18:59 INFO - 2015-12-19 11:18:59,824 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;95;95;95;95;96;95 11:18:59 INFO - 2015-12-19 11:18:59,824 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;59;59;60;59;60;66;57;56 11:18:59 INFO - 2015-12-19 11:18:59,825 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;66;67;67;67;67;67;67;67 11:18:59 INFO - 2015-12-19 11:18:59,825 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;87;87;85;83;84;84;92;100;94 11:18:59 INFO - 2015-12-19 11:18:59,825 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;122;120;127;118;119;120;114;115;120 11:18:59 INFO - 2015-12-19 11:18:59,826 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;149;148;147;151;138;149;147;148;137 11:18:59 INFO - 2015-12-19 11:18:59,826 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;67;66;68;65;66;67;65;66 11:18:59 INFO - 2015-12-19 11:18:59,826 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:18:59 INFO - 2015-12-19 11:18:59,826 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:18:59 INFO - 2015-12-19 11:18:59,826 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,928 11:18:59 INFO - 2015-12-19 11:18:59,827 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:18:59 INFO - 2015-12-19 11:18:59,827 DEBUG : BROWSER_OUTPUT: __startTimestamp1450552739820__endTimestamp 11:18:59 INFO - 2015-12-19 11:18:59,827 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,831 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:18:59 INFO - 2015-12-19 11:18:59,831 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:18:59 INFO - 2015-12-19 11:18:59,831 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,831 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.60 Median:111.50 stddev:5.04 (4.5%) stddev-sans-first:5.34 11:18:59 INFO - 2015-12-19 11:18:59,832 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 105.0 111.0 114.0 112.0 98.0 111.0 109.0 116.0 11:18:59 INFO - 2015-12-19 11:18:59,832 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,832 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.10 Median:150.50 stddev:15.86 (10.5%) stddev-sans-first:16.78 11:18:59 INFO - 2015-12-19 11:18:59,832 DEBUG : BROWSER_OUTPUT: Values: 147.0 131.0 152.0 161.0 135.0 162.0 149.0 121.0 161.0 122.0 11:18:59 INFO - 2015-12-19 11:18:59,833 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,833 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.35 (0.8%) stddev-sans-first:1.33 11:18:59 INFO - 2015-12-19 11:18:59,833 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 159.0 161.0 161.0 159.0 159.0 163.0 161.0 160.0 11:18:59 INFO - 2015-12-19 11:18:59,833 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,833 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.10 Median:76.00 stddev:14.75 (19.4%) stddev-sans-first:15.27 11:18:59 INFO - 2015-12-19 11:18:59,834 DEBUG : BROWSER_OUTPUT: Values: 74.0 71.0 84.0 97.0 72.0 78.0 73.0 116.0 93.0 73.0 11:18:59 INFO - 2015-12-19 11:18:59,834 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,834 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:93.00 stddev:21.76 (23.4%) stddev-sans-first:22.52 11:18:59 INFO - 2015-12-19 11:18:59,834 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 139.0 92.0 93.0 93.0 139.0 93.0 93.0 136.0 11:18:59 INFO - 2015-12-19 11:18:59,834 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,834 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:18:59 INFO - 2015-12-19 11:18:59,834 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 11:18:59 INFO - 2015-12-19 11:18:59,835 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,835 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 11:18:59 INFO - 2015-12-19 11:18:59,835 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 11:18:59 INFO - 2015-12-19 11:18:59,835 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,835 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:18:59 INFO - 2015-12-19 11:18:59,835 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 11:18:59 INFO - 2015-12-19 11:18:59,835 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,835 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.20 Median:59.00 stddev:2.70 (4.6%) stddev-sans-first:2.83 11:18:59 INFO - 2015-12-19 11:18:59,836 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 59.0 59.0 60.0 59.0 60.0 66.0 57.0 56.0 11:18:59 INFO - 2015-12-19 11:18:59,836 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,836 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 11:18:59 INFO - 2015-12-19 11:18:59,836 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 66.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 11:18:59 INFO - 2015-12-19 11:18:59,836 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,836 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:86.00 stddev:5.77 (6.7%) stddev-sans-first:5.73 11:18:59 INFO - 2015-12-19 11:18:59,836 DEBUG : BROWSER_OUTPUT: Values: 82.0 87.0 87.0 85.0 83.0 84.0 84.0 92.0 100.0 94.0 11:18:59 INFO - 2015-12-19 11:18:59,836 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,837 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.10 Median:120.00 stddev:3.75 (3.1%) stddev-sans-first:3.81 11:18:59 INFO - 2015-12-19 11:18:59,837 DEBUG : BROWSER_OUTPUT: Values: 116.0 122.0 120.0 127.0 118.0 119.0 120.0 114.0 115.0 120.0 11:18:59 INFO - 2015-12-19 11:18:59,837 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,837 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.50 Median:148.00 stddev:4.95 (3.3%) stddev-sans-first:4.97 11:18:59 INFO - 2015-12-19 11:18:59,837 DEBUG : BROWSER_OUTPUT: Values: 141.0 149.0 148.0 147.0 151.0 138.0 149.0 147.0 148.0 137.0 11:18:59 INFO - 2015-12-19 11:18:59,837 DEBUG : BROWSER_OUTPUT: 11:18:59 INFO - 2015-12-19 11:18:59,837 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 11:18:59 INFO - 2015-12-19 11:18:59,837 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 67.0 66.0 68.0 65.0 66.0 67.0 65.0 66.0 11:18:59 INFO - 2015-12-19 11:18:59,837 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:18:59 INFO - 2015-12-19 11:18:59,838 DEBUG : BROWSER_OUTPUT: 11:19:00 INFO - 2015-12-19 11:19:00,638 INFO : Browser exited with error code: 0 11:19:00 INFO - 2015-12-19 11:19:00,689 INFO : Completed test kraken (00:00:58) 11:19:00 INFO - 2015-12-19 11:19:00,689 INFO : Starting test v8_7 11:19:00 INFO - 2015-12-19 11:19:00,689 DEBUG : operating with platform_type : linux_ 11:19:00 INFO - 2015-12-19 11:19:00,689 INFO : Initialising browser for v8_7 test... 11:19:00 INFO - 2015-12-19 11:19:00,695 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwGe6mO/profile http://localhost:58760/getInfo.html 11:19:05 INFO - 2015-12-19 11:19:05,091 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:19:05 INFO - 2015-12-19 11:19:05,092 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:19:05 INFO - 2015-12-19 11:19:05,092 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:19:05 INFO - 2015-12-19 11:19:05,092 DEBUG : BROWSER_OUTPUT: __metrics 11:19:05 INFO - 2015-12-19 11:19:05,168 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:19:05 INFO - 2015-12-19 11:19:05,232 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:19:06 INFO - 2015-12-19 11:19:06,115 INFO : Browser initialized. 11:19:06 INFO - 2015-12-19 11:19:06,116 INFO : Running cycle 1/1 for v8_7 test... 11:19:06 INFO - 2015-12-19 11:19:06,116 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwGe6mO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:19:17 INFO - 2015-12-19 11:19:17,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 149835776 11:19:17 INFO - 2015-12-19 11:19:17,930 DEBUG : BROWSER_OUTPUT: 11:19:39 INFO - 2015-12-19 11:19:39,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58760/tests/v8_7/run.html (next: http://localhost:58760/tests/v8_7/run.html) 11:19:39 INFO - 2015-12-19 11:19:39,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 571924480 11:19:39 INFO - 2015-12-19 11:19:39,505 DEBUG : BROWSER_OUTPUT: 11:19:39 INFO - 2015-12-19 11:19:39,507 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:19:39 INFO - 2015-12-19 11:19:39,507 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:19:39 INFO - 2015-12-19 11:19:39,507 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:19:39 INFO - 2015-12-19 11:19:39,507 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:19:39 INFO - 2015-12-19 11:19:39,507 DEBUG : BROWSER_OUTPUT: |0;Richards;166.11295681063123 11:19:39 INFO - 2015-12-19 11:19:39,507 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.1821603312006 11:19:39 INFO - 2015-12-19 11:19:39,507 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.87685418415896 11:19:39 INFO - 2015-12-19 11:19:39,508 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5138.461538461538 11:19:39 INFO - 2015-12-19 11:19:39,508 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1123.5955056179776 11:19:39 INFO - 2015-12-19 11:19:39,508 DEBUG : BROWSER_OUTPUT: |5;Earley;783.2550860719875 11:19:39 INFO - 2015-12-19 11:19:39,508 DEBUG : BROWSER_OUTPUT: |6;Boyer;11709.302325581395 11:19:39 INFO - 2015-12-19 11:19:39,508 DEBUG : BROWSER_OUTPUT: |7;RegExp;25948.71794871795 11:19:39 INFO - 2015-12-19 11:19:39,508 DEBUG : BROWSER_OUTPUT: |8;Splay;636.9426751592357 11:19:39 INFO - 2015-12-19 11:19:39,508 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 11:19:39 INFO - 2015-12-19 11:19:39,509 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:19:39 INFO - 2015-12-19 11:19:39,509 DEBUG : BROWSER_OUTPUT: __startTimestamp1450552779505__endTimestamp 11:19:39 INFO - 2015-12-19 11:19:39,509 DEBUG : BROWSER_OUTPUT: 11:19:39 INFO - 2015-12-19 11:19:39,509 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:19:39 INFO - 2015-12-19 11:19:39,509 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:19:39 INFO - 2015-12-19 11:19:39,510 DEBUG : BROWSER_OUTPUT: 11:19:39 INFO - 2015-12-19 11:19:39,510 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.11 Median:166.11 stddev:0.00 (0.0%) 11:19:39 INFO - 2015-12-19 11:19:39,510 DEBUG : BROWSER_OUTPUT: Values: 166.1 11:19:39 INFO - 2015-12-19 11:19:39,510 DEBUG : BROWSER_OUTPUT: 11:19:39 INFO - 2015-12-19 11:19:39,511 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.18 Median:188.18 stddev:0.00 (0.0%) 11:19:39 INFO - 2015-12-19 11:19:39,512 DEBUG : BROWSER_OUTPUT: Values: 188.2 11:19:39 INFO - 2015-12-19 11:19:39,512 DEBUG : BROWSER_OUTPUT: 11:19:39 INFO - 2015-12-19 11:19:39,512 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 11:19:39 INFO - 2015-12-19 11:19:39,512 DEBUG : BROWSER_OUTPUT: Values: 279.9 11:19:39 INFO - 2015-12-19 11:19:39,512 DEBUG : BROWSER_OUTPUT: 11:19:39 INFO - 2015-12-19 11:19:39,512 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 11:19:39 INFO - 2015-12-19 11:19:39,512 DEBUG : BROWSER_OUTPUT: Values: 5138.5 11:19:39 INFO - 2015-12-19 11:19:39,512 DEBUG : BROWSER_OUTPUT: 11:19:39 INFO - 2015-12-19 11:19:39,513 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1123.60 Median:1123.60 stddev:0.00 (0.0%) 11:19:39 INFO - 2015-12-19 11:19:39,513 DEBUG : BROWSER_OUTPUT: Values: 1123.6 11:19:39 INFO - 2015-12-19 11:19:39,513 DEBUG : BROWSER_OUTPUT: 11:19:39 INFO - 2015-12-19 11:19:39,513 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.26 Median:783.26 stddev:0.00 (0.0%) 11:19:39 INFO - 2015-12-19 11:19:39,513 DEBUG : BROWSER_OUTPUT: Values: 783.3 11:19:39 INFO - 2015-12-19 11:19:39,513 DEBUG : BROWSER_OUTPUT: 11:19:39 INFO - 2015-12-19 11:19:39,513 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11709.30 Median:11709.30 stddev:0.00 (0.0%) 11:19:39 INFO - 2015-12-19 11:19:39,514 DEBUG : BROWSER_OUTPUT: Values: 11709.3 11:19:39 INFO - 2015-12-19 11:19:39,514 DEBUG : BROWSER_OUTPUT: 11:19:39 INFO - 2015-12-19 11:19:39,514 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25948.72 Median:25948.72 stddev:0.00 (0.0%) 11:19:39 INFO - 2015-12-19 11:19:39,514 DEBUG : BROWSER_OUTPUT: Values: 25948.7 11:19:39 INFO - 2015-12-19 11:19:39,514 DEBUG : BROWSER_OUTPUT: 11:19:39 INFO - 2015-12-19 11:19:39,514 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:636.94 Median:636.94 stddev:0.00 (0.0%) 11:19:39 INFO - 2015-12-19 11:19:39,514 DEBUG : BROWSER_OUTPUT: Values: 636.9 11:19:39 INFO - 2015-12-19 11:19:39,514 DEBUG : BROWSER_OUTPUT: 11:19:39 INFO - 2015-12-19 11:19:39,515 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 11:19:39 INFO - 2015-12-19 11:19:39,515 DEBUG : BROWSER_OUTPUT: Values: 4826.9 11:19:39 INFO - 2015-12-19 11:19:39,515 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:19:39 INFO - 2015-12-19 11:19:39,515 DEBUG : BROWSER_OUTPUT: 11:19:40 INFO - 2015-12-19 11:19:40,329 INFO : Browser exited with error code: 0 11:19:40 INFO - 2015-12-19 11:19:40,346 INFO : Completed test v8_7 (00:00:39) 11:19:40 INFO - 2015-12-19 11:19:40,553 INFO : Completed test suite (00:20:11) 11:19:40 INFO - 2015-12-19 11:19:40,553 DEBUG : Working with test: dromaeo_css 11:19:40 INFO - 2015-12-19 11:19:40,553 DEBUG : Generating results file: dromaeo_css 11:19:40 INFO - 2015-12-19 11:19:40,555 DEBUG : Working with test: kraken 11:19:40 INFO - 2015-12-19 11:19:40,555 DEBUG : Generating results file: kraken 11:19:40 INFO - 2015-12-19 11:19:40,555 INFO : javascript benchmark 11:19:40 INFO - 2015-12-19 11:19:40,555 DEBUG : Working with test: v8_7 11:19:40 INFO - 2015-12-19 11:19:40,555 DEBUG : Generating results file: v8_7 11:19:40 INFO - 2015-12-19 11:19:40,556 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:19:40 INFO - 2015-12-19 11:19:40,607 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 11:19:40 INFO - 2015-12-19 11:19:40,607 DEBUG : process_Request line: dromaeo_css 6975.37 graph.html#tests=[[72,201,35]] 11:19:40 INFO - 2015-12-19 11:19:40,607 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:19:40 INFO - 2015-12-19 11:19:40,652 DEBUG : process_Request line: kraken 1498.40 graph.html#tests=[[232,201,35]] 11:19:40 INFO - 2015-12-19 11:19:40,652 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:19:40 INFO - 2015-12-19 11:19:40,683 DEBUG : process_Request line: v8_7 21021.99 graph.html#tests=[[230,201,35]] 11:19:40 INFO - 2015-12-19 11:19:40,684 INFO : javascript benchmark 11:19:40 INFO - 2015-12-19 11:19:40,687 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3164.968350316497, 3190.5214217867333, 3249.2201871550833, 3253.446914024617, 3265.363254165438, 5214.973925130369, 5344.011357898791, 5397.4332695067, 5408.756605952732, 5477.561795056391, 5288.2596436498925, 5289.523942845143, 5343.145096784515, 5354.5716342692585, 5391.973040134794, 4846.1034708578845, 4851.781669824849, 4868.367112275399, 4916.680415772981, 4934.259861020858, 4943.036107958949, 4961.70229786214, 4990.75046247688, 5006.849794506171, 5022.673526220784, 4757.9286310705365, 4768.117898188846, 4863.197572400567, 4878.853634390938, 4903.01939612079, 4772.689775164603, 4779.904401911942, 4781.737004464753, 4794.328793968847, 4828.227483602606, 4763.190257656172, 4763.976180119077, 4792.353032340624, 4795.784189711471, 4825.5174482551465, 5131.53816156544, 5189.714565698885, 5234.057869583474, 5283.9207411888465, 5305.31030965972, 5794.942050579482, 5797.565182611279, 5802.5938184327115, 5804.042333015047, 5806.303243610793, 5758.0, 5817.680027598481, 5837.532997360201, 5845.210896528956, 5856.502197313233, 5417.6207665463435, 5442.047641662693, 5451.700156491392, 5479.53423958968, 5508.0, 5878.588498805043, 5882.911756323659, 5884.499817515473, 5885.293764748172, 5931.228940237742, 5522.66863988162, 5677.971610142005, 5680.943190568041, 5682.7442765075675, 5709.942900571024, 5778.162166485836, 5785.82642520725, 5819.73811178498, 5837.445442683023, 5913.408659134138, 5694.430556944272, 5739.62692424991, 5742.196092547047, 5748.425157484218, 5749.3963133871175, 5586.16207568868, 5690.345610254791, 5702.144678298206, 5712.200291959129, 5714.7428365723645, 4412.205802955499, 4447.110577884436, 4450.5549445055885, 4501.909961800811, 4502.797374118107, 3978.0054986253435, 3979.9801000994808, 3989.58109398509, 4009.939850902239, 4032.3145065338963, 5450.0, 5463.726813659301, 5470.699111548824, 5473.397926228112, 5523.199136125239, 5659.462351076641, 5828.184054232411, 5852.473277405054, 5855.063189889597, 5865.442782935615, 5400.91898621521, 5401.918971215435, 5403.459654034565, 5403.864903377447, 5443.673379597237, 5018.824341148043, 5019.67372120811, 5025.723585202776, 5026.874328141826, 5029.044481548494, 5782.7686892523825, 5876.823695289148, 5904.0553511437965, 6001.789937352171, 6002.0, 5864.472197502245, 5876.6180198286975, 5884.499817515559, 5887.558433117448, 5890.64656120617, 5966.522678185648, 5967.1049342597225, 5971.402859713994, 5971.552133589911, 5973.790917318047, 5603.915941260802, 5633.8309850704545, 5683.8863222736145, 5745.712714364181, 5779.393163717918, 5749.913751293818, 5764.884702305846, 5765.279340082489, 5768.077107662753, 5892.057270836645, 5574.498295153456, 5625.774969001194, 5629.718514074198, 5632.915506267327, 5641.210230567642, 5419.593530485151, 5526.143447765603, 5533.114701647717, 5593.188987596857, 5631.887362252814, 5596.748146333343, 5603.663780173202, 5605.019121653613, 5605.1872478491205, 5643.294588176478, 5667.971660141673, 5689.487946084872, 5692.0, 5696.316442026983, 5745.0, 5483.588730845282, 5528.280582374526, 5531.225628412106, 5576.609637325349, 5595.776168953196], "unit": "score", "name": "dojo.html", "value": 5317.1484740772685}, {"lowerIsBetter": false, "replicates": [546.8183150499968, 585.5959388022264, 591.396775289205, 598.0431309904151, 603.0652488642603, 29535.704642953566, 37801.0, 37837.432438513446, 37841.43237851431, 37981.430278545806, 40815.387769183486, 41037.58962410375, 41151.0, 41231.58768412315, 41259.587404126025, 7518.248175182493, 7613.7335193268245, 8576.614052367659, 8892.110788921122, 8895.377323587352, 10411.479426028669, 10588.78822423551, 10614.04473597376, 10673.19951003674, 10681.893181068206, 10305.0, 10398.0, 10398.324108932895, 10403.791924161513, 10407.0, 7697.884531732028, 7900.2889739923685, 7915.0, 10284.742881427987, 10395.272330936838, 10027.89972100277, 10122.696319110439, 10144.594216231342, 10151.543180556893, 10155.796884062278, 39252.0, 40041.59958400408, 40077.19845603072, 40098.195581198626, 40121.59878401208, 3406.0633325835593, 3415.777974431654, 3518.489818976234, 3588.784672919607, 3720.2001569662652, 32043.679563204303, 32110.839445802856, 32455.837720811243, 32786.836065819756, 33215.83392083048, 3921.372730224531, 3925.234579257046, 3969.6625786808154, 4010.1177740896956, 4051.5745846686264, 263969.0, 265867.6706616474, 266120.0, 266317.0, 266333.0, 54298.384637305484, 55657.16514252289, 57313.0, 62474.0, 64017.67991160014, 56812.727490900725, 57008.714956425785, 57048.71475642678, 57280.42719572834, 57370.42629573734, 14629.195394253205, 14761.77857332141, 14769.852301476847, 14770.630734231516, 14781.704365912836, 10995.780084398268, 11028.28316159447, 11038.613648522423, 11054.115670746321, 11158.665240042812, 19346.903265483863, 19702.40892773219, 19707.0, 19885.105170267085, 19891.303804367068, 7813.101493328227, 7820.843583128306, 8001.399895007898, 8029.397795165386, 8037.839243215103, 963.5326866469757, 974.936629119105, 1004.322082594246, 1047.0785708576557, 1122.7642195139113, 26288.737112629013, 26993.325166870593, 27030.729692703215, 27477.31306717348, 27680.30799229995, 1022.8874823769528, 1083.869935607732, 1087.8803331633515, 1094.370736826328, 1117.9776404471866, 13869.583912482642, 13891.527118220445, 14037.087589306866, 14056.297185140907, 14071.929640351733, 397492.0, 403421.0, 404530.0, 404715.0, 404796.0, 51036.23445648318, 51479.22781158286, 51533.48466515287, 51570.22644660333, 51600.74199628978, 1319.9802002969964, 1336.5054929676082, 1337.5051231044577, 1340.2561578323928, 1349.0826238158343, 24783.752162478864, 31300.843495782374, 31715.0, 31727.36545269128, 32169.35661286808, 49208.26187607117, 49526.75236623794, 49884.0, 49884.25173622326, 49933.75033124811, 294685.0, 296538.0, 297413.0, 298508.0, 298824.0, 35613.709203954444, 36393.272134557694, 36552.81723591365, 36556.26887462289, 41200.587994119676, 39340.80329598448, 40968.79515602522, 42117.78941105275, 42248.36627450652, 42885.0, 35329.82335088308, 36022.45966310455, 36379.27241455103, 36666.26667466689, 41275.38086928758, 30071.837234809656, 35493.82253088718, 36108.458373123896, 40242.0, 41954.580454195064, 35405.291894161455, 35415.291694165455, 35429.46855797217, 35497.1125721859, 35558.46662300016, 28467.857660711565, 32173.0, 33396.49905251375, 33584.16039599029, 33588.496172556945, 25590.48819023572, 26377.208683739518, 26535.33661658474, 26580.867095665173, 26777.19668409951], "unit": "score", "name": "ext.html", "value": 18946.493119846433}, {"lowerIsBetter": false, "replicates": [353.6710858901221, 355.08742531693525, 356.96430356964305, 358.8205897051474, 359.7553663508814, 13661.658458538517, 14021.439142434316, 16419.58951026225, 16439.671206575862, 16933.83066169338, 9869.062439068295, 10146.949265253681, 10180.949095254531, 13145.934270328635, 13422.530211442601, 4775.331453596499, 4873.293372460991, 4893.29047288143, 4896.290037944496, 4898.583620392253, 3737.1591391936868, 3832.712546559005, 5240.842774716745, 5240.895182096356, 5414.35027796665, 5373.408925018264, 5374.414547708436, 5375.301210842585, 5395.622306438551, 5396.97457483079, 5208.270842082112, 5280.419153893069, 5282.7622756976025, 5289.947100528984, 5363.249145119687, 5124.231365295198, 5124.359455068116, 5127.282180494733, 5127.589792816603, 5134.2812006319145, 12502.49990000399, 13292.468301267938, 17542.561435964075, 19925.20299188031, 19950.20199192045, 2100.2859027930426, 2120.6076875777876, 2138.593667203242, 2445.3519817248443, 2462.8132175302057, 9508.334416590842, 9694.272929530243, 9709.223262139083, 9788.657396991071, 9882.160016398615, 1776.422662634649, 1821.6903126468533, 1855.2949879046012, 1917.587718640485, 1922.807719228066, 61678.69160654213, 63239.0, 63484.0, 63887.361126388605, 64585.99999999953, 9330.95334523323, 9379.5310234488, 9502.192313653417, 9685.6610018649, 9723.367981081348, 12252.81620775689, 12420.75158496825, 12452.128351015343, 12454.750904982031, 12459.626211213677, 7149.177844547944, 7151.0, 7195.2444993276, 7225.89161162583, 7362.44781641379, 6786.626735529495, 6788.253292137861, 6848.315168483212, 6854.931450685529, 6856.862862742717, 4039.091204478969, 4157.771322577288, 4175.749455032707, 4282.957170428318, 4503.392042074343, 1648.1100205888924, 1661.3852874436536, 1686.8987860728396, 1690.0535700008036, 1716.313474610141, 893.4996402014892, 924.523870206844, 929.1962452478557, 958.8274110660009, 1010.6816352848977, 15795.763063554055, 16200.75698864518, 16447.83552164487, 16642.833571664127, 16697.83302166987, 910.153557191818, 916.7341470973344, 940.4592359393376, 943.8065196634674, 962.5455089521691, 9543.188828949478, 9665.758356041015, 10077.748056298504, 10121.59513619447, 10150.44172570501, 546300.0, 562555.0, 566563.0, 584335.0, 588773.0, 82481.0, 83770.0, 83805.0, 84089.0, 84454.15545844586, 1138.1065863297272, 1155.5031336525374, 1158.6987383280239, 1167.0780083733925, 1174.0959461214645, 14730.779038314648, 15460.768088478457, 15633.609159771097, 15718.842811571738, 16041.438549650706, 32858.0, 33935.490967636, 34170.658293416745, 34430.31139377148, 36708.44937325889, 41424.0, 41832.163356733305, 42413.78793106015, 42628.573714262464, 43980.56019439764, 9317.72046838596, 9340.299477539076, 9343.551749478842, 9574.138327550554, 9584.952075239578, 17358.73961890598, 17467.737983930507, 17607.031613261395, 17784.911075445056, 18034.0, 10988.780224395627, 11567.537298507965, 12574.559890403792, 13468.124571902796, 14383.20892350889, 11737.178397512092, 12699.55551555728, 13377.866221337663, 13590.708882656132, 13978.580642580739, 11929.522819087138, 13771.586852394445, 14320.856791431952, 14416.855831441551, 14936.85063149398, 9084.273258139201, 9244.399114057565, 9252.629894804133, 9310.487923164292, 9517.191038761783, 13827.101238419471, 13865.09876858001, 13916.373763180478, 14096.295185240902, 14149.36327865269], "unit": "score", "name": "jquery.html", "value": 8532.87658998324}, {"lowerIsBetter": false, "replicates": [1369.7467665689935, 1518.7038527487136, 1583.6990971715372, 1674.0, 1761.0930370859003, 6756.932430675692, 7203.099612548432, 7345.228750981137, 7364.484486085963, 7364.926350736498, 7465.552066875991, 7626.847463050735, 7633.236676332364, 7634.465587408884, 7643.388528917687, 2124.755653099894, 2162.589108069462, 2164.8809315487642, 2165.036558731365, 2167.3497950614833, 2117.1319758898853, 2154.1168121070364, 2195.6157672407267, 2197.461621902636, 2199.2082850173924, 2143.3141394753684, 2167.371462275938, 2181.2365672014826, 2204.944876378095, 2206.8344874134423, 2178.1505212966954, 2205.3604454708197, 2205.8345624078256, 2206.878621675807, 2206.933791986243, 2121.2151503943487, 2145.570885822826, 2148.602508535926, 2148.645473496871, 2150.3333966470445, 7124.073870396815, 7180.425565954711, 7185.0, 7193.172785129725, 7203.279672032807, 4341.522432532419, 4405.361222622734, 4407.625351845097, 4409.074094440171, 4418.536053714346, 3093.675164107759, 3127.9218019549467, 3131.170239886432, 3140.1678555182893, 3157.6684448133074, 955.1165172215742, 1008.1531513528671, 1031.8658574385356, 1085.4626959654943, 1142.851429314192, 9593.47235902025, 9595.616175352978, 9608.0, 9625.759356016086, 9654.131128198425, 3895.8831235062994, 3918.8236529356245, 3943.3493473577114, 3948.6446219839777, 3978.104926391539, 8421.326293896474, 8445.493270403795, 8451.53516556583, 8452.323814094858, 8459.407841451162, 4433.6009759121835, 4433.844815431445, 4437.445319335083, 4438.334249862482, 4442.911141777146, 3657.04916721649, 3750.3436898542645, 4026.3557830747527, 4058.4521089652517, 4068.6745060395097, 3588.551431071116, 3638.5633723953297, 3647.76289541179, 3668.3030224257304, 3694.6674799268194, 1171.3674615707423, 1175.14801768717, 1177.5937301630925, 1184.4847491341122, 1188.0792385900822, 1325.072449285504, 1330.0755974597562, 1349.1500354776624, 1372.1286982765816, 1389.7637401641746, 7329.486935914435, 7333.230010848784, 7476.850462990709, 7495.175530691619, 7533.2466753325325, 1124.600766727816, 1131.089202478742, 1132.17351333527, 1146.3236690352733, 1162.8895254950767, 5641.605087643908, 5699.487046165865, 5704.0, 5755.8561035974435, 5771.769129234784, 8842.646294148162, 9026.503542305105, 9091.31815113869, 9319.953400233091, 9344.252459803336, 9182.403143795633, 9189.310801689766, 9234.076592340847, 9234.122758337948, 9243.815123697623, 6976.5814051157095, 7038.612876291853, 7045.365917067488, 7049.92950070503, 7213.89179162313, 7144.821379465555, 7154.749583764543, 7155.356017958408, 7163.391111755351, 7170.605616690923, 7950.602469876368, 8270.966129233846, 8280.958595206985, 8290.668373265002, 8291.792705182419, 8344.791380215544, 8478.660853565789, 8484.872726909225, 8575.95712021436, 8576.914230857612, 5914.822555323347, 6056.121862329849, 6065.60573562717, 6156.722947467285, 6411.839704007437, 7092.929070709227, 7169.211386747349, 7192.712291508281, 7212.783616491513, 7219.241979592277, 6872.209695885037, 6977.372036516738, 6986.196587392312, 6999.51003429755, 7207.171175314906, 6886.173659160932, 6991.44068474531, 7007.404370628554, 7013.4038606719005, 7090.4327653788605, 7041.401480874183, 7047.859042819013, 7097.041899343522, 7115.395191408788, 7146.749863754743, 6544.149260596092, 6553.311902250195, 6583.901241481477, 6596.472282217315, 6600.53796234259, 6248.218972628421, 6635.369639884203, 6703.8324041897395, 6704.027915952257, 6716.1604799400075], "unit": "score", "name": "mootools.html", "value": 4388.532720576358}, {"lowerIsBetter": false, "replicates": [331.38362645479407, 334.62856229585157, 337.7686284894846, 342.9348423799476, 346.35059263880225, 6012.068129439933, 6046.3349031606485, 6052.273727152737, 6062.120992456097, 6113.388661133884, 5887.470127688507, 5927.051671732524, 5934.8219553413355, 5945.762169513214, 5979.073243647231, 4604.838830640928, 4609.792559334821, 4612.377329060584, 4614.30785382192, 4631.212693842055, 4403.119376124771, 4554.316852472122, 4564.589186973171, 4611.746353950532, 4632.884177895563, 4543.65922555808, 4543.681942264043, 4543.909121817562, 4551.817927282905, 4569.771511424432, 4329.393884856091, 4465.218586747339, 4539.59143677069, 4549.385832912548, 4552.726836389811, 3859.7684138951754, 3861.0, 3861.806909654506, 3874.070223146453, 3957.0, 5725.599208055438, 5747.281589801275, 5760.2511673482595, 5761.107028410561, 5798.971005144947, 5014.272930425068, 5309.548688361494, 5318.175682769177, 5319.069162896478, 5326.2543243945875, 6190.442860142609, 6214.0989556514505, 6322.430981211713, 6337.904931425986, 6346.9682651586445, 4265.893352666177, 4274.7435153890865, 4283.485981682187, 4284.164587905359, 4286.507051689034, 6551.672416379162, 6629.801105966829, 6638.668066596699, 6639.0, 6641.535092543476, 4364.934525982113, 4426.75652839097, 4445.377647129404, 4461.709988850715, 4506.526814684476, 4556.384888040138, 4563.041761230179, 4563.429571303587, 4563.9087218255445, 4566.543345665474, 5300.6024548158275, 5303.416624171338, 5315.893682126336, 5318.122509785842, 5320.760565774472, 6318.652474113968, 6444.838879027968, 6445.9355406446275, 6449.677516124175, 6456.451201647913, 1582.485692150056, 1599.1204837339417, 1599.5681166085092, 1599.7760313556112, 1602.8477294656989, 1049.5539395756773, 1052.7262911642874, 1055.9757035675382, 1057.6509751781894, 1062.5006247063868, 6170.7223174957235, 6182.598131121463, 6186.721597528122, 6188.783392581328, 6189.690515474208, 6631.86736265272, 6644.302348253364, 6646.036324732887, 6648.069270302161, 6657.267700552935, 6027.849303767441, 6177.907331390033, 6178.969105154445, 6187.566870319124, 6189.412005859436, 3558.3594952908725, 3586.0, 3592.1019745063736, 3592.7844329340323, 3593.6406359363855, 6762.391384775394, 6767.1879374475375, 6776.220734615484, 6788.049673045777, 6796.660166991631, 6674.699638516278, 6795.422389096982, 6803.183617965876, 6805.0, 6812.897806532906, 6561.671916404256, 6590.110335104795, 6697.062411262427, 6704.83237919056, 6726.461883049345, 6576.112224849584, 6635.303293154342, 6653.9667301663185, 6656.334366563498, 6667.599944003376, 6573.309802470863, 6577.276499585138, 6579.539432239697, 6580.901286480803, 6580.967095164494, 6641.1034510342415, 6781.898271525833, 6782.491313151435, 6793.218779840382, 6794.082798822095, 4386.64906807461, 4402.8679139625865, 4414.381986521954, 4423.137488189772, 4423.712458690175, 6672.099266598947, 6675.299093595297, 6680.231773345933, 6681.699323530355, 6686.197656281277, 6357.904631430625, 6489.5781774184525, 6494.285628580947, 6495.870082598416, 6499.1876015498065, 6447.419732223935, 6467.191601049869, 6473.385028422293, 6478.384553467413, 6487.416132548094, 6340.112384266298, 6361.173047503795, 6362.586431881913, 6369.522285828489, 6377.202849643794, 6413.102165696713, 6528.543001990005, 6531.379518945692, 6533.150690410216, 6536.738530458729, 6371.649559274099, 6372.617642941253, 6374.07575901501, 6374.26695929974, 6377.489800815831], "unit": "score", "name": "prototype.html", "value": 4802.0211329159}, {"lowerIsBetter": false, "replicates": [808.6239898447222, 837.254843189561, 871.2768402226153, 885.4244740918402, 896.5338024227398, 13561.0, 13985.230812305319, 14009.29953502326, 14033.438662453502, 14055.789163162548, 13094.345282735872, 13110.0, 13195.6701082473, 13199.736005279889, 13228.933855330733, 679.3003206697098, 690.1097584116484, 820.1101804542079, 835.5195762436593, 840.5545061117617, 836.0970152235572, 837.2632083766277, 844.3878188313485, 844.932405407569, 845.1337379186352, 717.2074857282706, 871.5163084488106, 877.4603618774472, 877.6796469288696, 878.2227728460294, 719.5215181904027, 863.0549548244693, 867.2368315882046, 870.4168207301155, 877.929765618749, 640.0367446992246, 646.8770933522616, 647.1780838335335, 647.3138473218404, 647.33971349224, 13353.666158346023, 13520.93239533796, 13563.59309220725, 13621.523246686418, 13688.726225475435, 11876.52493900243, 12222.694432639166, 12280.447379867928, 12421.130520863544, 12664.17682850621, 10329.84505232422, 10376.79246415075, 10426.895731042669, 10427.558618504454, 10471.109955653703, 3643.2531331077066, 3679.3745063339297, 3703.592604813495, 3767.5478942526797, 3818.1409182933894, 45253.32120018202, 45763.54236457659, 45769.0, 45779.31331030037, 45983.0, 9927.50362481873, 9985.20118390527, 10246.0, 10386.11718003963, 10634.46827658614, 17941.461756147335, 17948.0, 17962.371317003843, 17967.820321796877, 17976.640467190584, 7554.395648348229, 7702.537847729154, 7773.961130194313, 7790.844183116419, 7889.0, 4218.8312467500955, 4268.0, 4308.375285583573, 4385.166818304512, 4403.339499075164, 3034.0, 3053.633563972293, 3061.0204734485196, 3067.2638566744267, 3070.4626690329105, 553.6152374100043, 559.8068666310116, 561.0686260807122, 561.7893290016244, 578.6499168003381, 602.4668168670757, 607.1924340626956, 636.1856823266227, 649.3538928765814, 663.3896814930275, 8462.19609137131, 8488.957555212184, 8542.273906717874, 8568.314534837198, 8687.695930642523, 501.68143229049815, 597.3548567547039, 610.767908194892, 611.8378629663143, 637.416763661254, 4083.387491876183, 4128.318827393507, 4152.8338866445, 4163.333866581393, 4193.916121677549, 58794.41205587975, 59201.11198332028, 59395.703021484616, 59444.70277648671, 61156.38843611507, 51227.23159152616, 52394.0, 52769.47230527645, 52838.0, 52947.205791913155, 44508.55491445109, 44848.3272750909, 45941.0, 46754.76622616933, 47482.28776568354, 9058.36591438593, 9063.773405664911, 9127.0, 9130.406523575946, 9300.11648893354, 34220.0, 34934.47598285977, 34998.82500587481, 35004.0, 35388.292234155684, 42878.571214288706, 45578.0, 46220.76889615531, 46299.0, 46476.30285545787, 10860.728481788019, 10960.671179864617, 10977.560897564328, 11173.970336170281, 11294.887051129384, 11993.868247207492, 12119.394030298274, 12122.575709850113, 12192.51229950792, 12253.816192756938, 11448.713782155513, 11540.134489913122, 11616.94191529037, 12352.25886446816, 12389.380530973234, 11510.712232194262, 11782.882171178178, 11896.940515297369, 11966.341851198267, 12331.50673973031, 10791.56833726642, 10954.726131846768, 10956.671299861016, 10964.177686673691, 11049.447527623748, 10067.345622534513, 10096.394216347042, 10166.881643019115, 10190.110298673937, 10461.633842815465, 9487.430754154773, 9491.620335186792, 9576.664816731382, 9798.706038818847, 9826.787943287021], "unit": "score", "name": "yui.html", "value": 6357.972349452077}], "name": "dromaeo_css", "value": 6975.373383522077}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 111.0, 114.0, 112.0, 98.0, 111.0, 109.0, 116.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 131.0, 152.0, 161.0, 135.0, 162.0, 149.0, 121.0, 161.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 159.0, 161.0, 161.0, 159.0, 159.0, 163.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 84.0, 97.0, 72.0, 78.0, 73.0, 116.0, 93.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.1}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 139.0, 92.0, 93.0, 93.0, 139.0, 93.0, 93.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 59.0, 59.0, 60.0, 59.0, 60.0, 66.0, 57.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [82.0, 87.0, 87.0, 85.0, 83.0, 84.0, 84.0, 92.0, 100.0, 94.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [116.0, 122.0, 120.0, 127.0, 118.0, 119.0, 120.0, 114.0, 115.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.1}, {"lowerIsBetter": true, "replicates": [141.0, 149.0, 148.0, 147.0, 151.0, 138.0, 149.0, 147.0, 148.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.5}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 66.0, 68.0, 65.0, 66.0, 67.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1498.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.11295681063123], "unit": "score", "name": "Richards", "value": 212.51804000000004}, {"lowerIsBetter": false, "replicates": [188.1821603312006], "unit": "score", "name": "DeltaBlue", "value": 351.351052}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [1123.5955056179776], "unit": "score", "name": "RayTrace", "value": 658.5902099999998}, {"lowerIsBetter": false, "replicates": [783.2550860719875], "unit": "score", "name": "Earley", "value": 850.8888251748249}, {"lowerIsBetter": false, "replicates": [11709.302325581395], "unit": "score", "name": "Boyer", "value": 56.91739622641514}, {"lowerIsBetter": false, "replicates": [25948.71794871795], "unit": "score", "name": "RegExp", "value": 35.107129446640336}, {"lowerIsBetter": false, "replicates": [636.9426751592357], "unit": "score", "name": "Splay", "value": 127.94086999999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21021.98840323159}]} 11:19:40 INFO - RETURN: dromaeo_css: 6975.37 11:19:40 INFO - RETURN: kraken: 1498.40 11:19:40 INFO - RETURN: v8_7: 21021.99 11:19:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "21021.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1498.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6975.37"}}} 11:19:40 INFO - Return code: 0 11:19:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:19:40 ERROR - # TBPL SUCCESS # 11:19:40 INFO - Running post-action listener: _resource_record_post_action 11:19:40 INFO - Running post-run listener: _resource_record_post_run 11:19:41 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 561557504; Read time: 8; Write time: 684572 11:19:41 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 251416576; Read time: 0; Write time: 451096 11:19:41 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310140928; Read time: 8; Write time: 233476 11:19:41 INFO - Running post-run listener: _upload_blobber_files 11:19:41 INFO - Blob upload gear active. 11:19:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:19:41 INFO - Copying logs to upload dir... 11:19:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.778534 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-19 11:19:41.923747) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-19 11:19:41.927870) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010049 build_url: 'https://queue.taskcluster.net/v1/task/pDhZf0LQQ46GjDKRTTlYaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-19 11:19:41.979679) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 11:19:41.980012) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450548735.530364-1462456441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-19 11:19:42.029496) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-19 11:19:42.029808) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-19 11:19:42.030126) ========= ========= Total master_lag: 0.23 =========