builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1450431635.86 results: success (0) buildid: 20151217233003 builduid: a27356f9cd7a483f9af5081ede54bd38 revision: 4b36d090fb5d368c7204a9cb44fe6b460be52224 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:35.860330) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:35.860689) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:35.860966) ========= 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=a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006450 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:35.892898) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:35.893209) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:35.928214) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:35.928497) ========= 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=a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004634 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:35.978010) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:35.978283) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:35.978620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:35.978903) ========= 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=a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 01:40:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-12-18 01:40:36 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096049 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:36.089843) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:36.090147) ========= 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=a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022183 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:36.143253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:36.143554) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 4b36d090fb5d368c7204a9cb44fe6b460be52224 --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 4b36d090fb5d368c7204a9cb44fe6b460be52224 --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=a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 01:40:36,374 truncating revision to first 12 chars 2015-12-18 01:40:36,374 Setting DEBUG logging. 2015-12-18 01:40:36,374 attempt 1/10 2015-12-18 01:40:36,374 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/4b36d090fb5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 01:40:37,025 unpacking tar archive at: b2g-inbound-4b36d090fb5d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.965657 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:37.121953) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:37.122264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:37.130688) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:37.130938) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 01:40:37.131326) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-18 01:40:37.131605) ========= /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=a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:40:37 INFO - MultiFileLogger online at 20151218 01:40:37 in /builds/slave/test-pgo 01:40:37 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 01:40:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:40:37 INFO - {'append_to_log': False, 01:40:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:40:37 INFO - 'blob_upload_branch': 'B2G-Inbound', 01:40:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:40:37 INFO - 'branch': 'B2G-Inbound', 01:40:37 INFO - 'buildbot_json_path': 'buildprops.json', 01:40:37 INFO - 'config_files': ('talos/linux_config.py',), 01:40:37 INFO - 'default_actions': ('clobber', 01:40:37 INFO - 'read-buildbot-config', 01:40:37 INFO - 'download-and-extract', 01:40:37 INFO - 'populate-webroot', 01:40:37 INFO - 'create-virtualenv', 01:40:37 INFO - 'install', 01:40:37 INFO - 'run-tests'), 01:40:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:40:37 INFO - 'download_minidump_stackwalk': True, 01:40:37 INFO - 'download_symbols': 'ondemand', 01:40:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:40:37 INFO - 'tooltool.py': '/tools/tooltool.py', 01:40:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:40:37 INFO - '/tools/misc-python/virtualenv.py')}, 01:40:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:40:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:40:37 INFO - 'installer_path': 'installer.exe', 01:40:37 INFO - 'log_level': 'info', 01:40:37 INFO - 'log_name': 'talos', 01:40:37 INFO - 'log_to_console': True, 01:40:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:40:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:40:37 INFO - 'opt_config_files': (), 01:40:37 INFO - 'pip_index': False, 01:40:37 INFO - 'sps_profile': False, 01:40:37 INFO - 'sps_profile_interval': 0, 01:40:37 INFO - 'suite': 'dromaeojs', 01:40:37 INFO - 'system_bits': '64', 01:40:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:40:37 INFO - 'title': 'talos-linux64-ix-033', 01:40:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:40:37 INFO - 'use_talos_json': True, 01:40:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:40:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:40:37 INFO - 'work_dir': 'build'} 01:40:37 INFO - ##### 01:40:37 INFO - ##### Running clobber step. 01:40:37 INFO - ##### 01:40:37 INFO - Running pre-action listener: _resource_record_pre_action 01:40:37 INFO - Running main action method: clobber 01:40:37 INFO - rmtree: /builds/slave/test-pgo/build 01:40:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:40:38 INFO - Running post-action listener: _resource_record_post_action 01:40:38 INFO - ##### 01:40:38 INFO - ##### Running read-buildbot-config step. 01:40:38 INFO - ##### 01:40:38 INFO - Running pre-action listener: _resource_record_pre_action 01:40:38 INFO - Running main action method: read_buildbot_config 01:40:38 INFO - Using buildbot properties: 01:40:38 INFO - { 01:40:38 INFO - "project": "", 01:40:38 INFO - "product": "firefox", 01:40:38 INFO - "script_repo_revision": "production", 01:40:38 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 01:40:38 INFO - "repository": "", 01:40:38 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 01:40:38 INFO - "buildid": "20151217233003", 01:40:38 INFO - "pgo_build": "True", 01:40:38 INFO - "basedir": "/builds/slave/test-pgo", 01:40:38 INFO - "buildnumber": 1065, 01:40:38 INFO - "slavename": "talos-linux64-ix-033", 01:40:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:40:38 INFO - "platform": "ubuntu64_hw", 01:40:38 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 01:40:38 INFO - "branch": "b2g-inbound", 01:40:38 INFO - "repo_path": "integration/b2g-inbound", 01:40:38 INFO - "revision": "4b36d090fb5d368c7204a9cb44fe6b460be52224", 01:40:38 INFO - "stage_platform": "linux64-pgo", 01:40:38 INFO - "builduid": "a27356f9cd7a483f9af5081ede54bd38", 01:40:38 INFO - "slavebuilddir": "test" 01:40:38 INFO - } 01:40:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:40:38 INFO - Running post-action listener: _resource_record_post_action 01:40:38 INFO - ##### 01:40:38 INFO - ##### Running download-and-extract step. 01:40:38 INFO - ##### 01:40:38 INFO - Running pre-action listener: _resource_record_pre_action 01:40:38 INFO - Running main action method: download_and_extract 01:40:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:40: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')]} 01:40:38 INFO - https://queue.taskcluster.net/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:40:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/test_packages.json 01:40:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/test_packages.json 01:40:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:40:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:40:39 INFO - Downloaded 1302 bytes. 01:40:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:40:39 INFO - Using the following test package requirements: 01:40:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:40:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:40:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:40:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:40:39 INFO - u'jsshell-linux-x86_64.zip'], 01:40:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:40:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:40:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:40:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:40:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:40:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:40:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:40:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:40:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:40:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:40:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:40:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:40:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:39 INFO - https://queue.taskcluster.net/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:40:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:40:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:40:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:40:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:40:40 INFO - Downloaded 23119948 bytes. 01:40:40 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 01:40:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:40:40 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 01:40:42 INFO - Return code: 0 01:40:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:42 INFO - https://queue.taskcluster.net/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:40:45 INFO - Downloaded 23119948 bytes. 01:40:45 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 01:40:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:40:45 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 01:40:46 INFO - Return code: 0 01:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:46 INFO - https://queue.taskcluster.net/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:40:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:40:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:40:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:40:47 INFO - Downloaded 11132039 bytes. 01:40:47 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 01:40:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:40:47 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 01:40:47 INFO - Return code: 0 01:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:47 INFO - https://queue.taskcluster.net/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:40:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:40:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:40:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:40:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:40:49 INFO - Downloaded 54655561 bytes. 01:40:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:40:49 INFO - mkdir: /builds/slave/test-pgo/properties 01:40:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:40:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:40:49 INFO - Contents: 01:40:49 INFO - build_url:https://queue.taskcluster.net/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:40:49 INFO - Running post-action listener: _resource_record_post_action 01:40:49 INFO - Running post-action listener: set_extra_try_arguments 01:40:49 INFO - ##### 01:40:49 INFO - ##### Running populate-webroot step. 01:40:49 INFO - ##### 01:40:49 INFO - Running pre-action listener: _resource_record_pre_action 01:40:49 INFO - Running main action method: populate_webroot 01:40:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:40:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:40:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:40:49 INFO - '--tppagecycles', 01:40:49 INFO - '7'], 01:40:49 INFO - 'tests': ['tsvgm']}}, 01:40:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:40:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:40:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:40:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:40:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:40:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:40:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:40:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:49 INFO - 'talos_options': ['--e10s'], 01:40:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:40:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:49 INFO - 'tests': ['damp', 'tps']}, 01:40:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:49 INFO - 'talos_options': ['--e10s'], 01:40:49 INFO - 'tests': ['damp', 'tps']}, 01:40:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:40:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:40:49 INFO - 'other': {'tests': ['a11yr', 01:40:49 INFO - 'ts_paint', 01:40:49 INFO - 'tpaint', 01:40:49 INFO - 'sessionrestore', 01:40:49 INFO - 'sessionrestore_no_auto_restore']}, 01:40:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:40:49 INFO - 'tests': ['a11yr', 01:40:49 INFO - 'ts_paint', 01:40:49 INFO - 'tpaint', 01:40:49 INFO - 'sessionrestore', 01:40:49 INFO - 'sessionrestore_no_auto_restore']}, 01:40:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:40:49 INFO - 'tests': ['a11yr', 01:40:49 INFO - 'ts_paint', 01:40:49 INFO - 'tpaint', 01:40:49 INFO - 'sessionrestore', 01:40:49 INFO - 'sessionrestore_no_auto_restore']}, 01:40:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:40:49 INFO - 'tests': ['a11yr', 01:40:49 INFO - 'ts_paint', 01:40:49 INFO - 'tpaint', 01:40:49 INFO - 'sessionrestore', 01:40:49 INFO - 'sessionrestore_no_auto_restore']}, 01:40:49 INFO - 'other_l64': {'tests': ['a11yr', 01:40:49 INFO - 'ts_paint', 01:40:49 INFO - 'tpaint', 01:40:49 INFO - 'sessionrestore', 01:40:49 INFO - 'sessionrestore_no_auto_restore']}, 01:40:49 INFO - 'other_nol64': {'tests': ['a11yr', 01:40:49 INFO - 'ts_paint', 01:40:49 INFO - 'tpaint', 01:40:49 INFO - 'sessionrestore', 01:40:49 INFO - 'sessionrestore_no_auto_restore']}, 01:40:49 INFO - 'svgr': {'tests': ['tsvgx', 01:40:49 INFO - 'tsvgr_opacity', 01:40:49 INFO - 'tart', 01:40:49 INFO - 'tscrollx', 01:40:49 INFO - 'cart']}, 01:40:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:40:49 INFO - 'tests': ['tsvgx', 01:40:49 INFO - 'tsvgr_opacity', 01:40:49 INFO - 'tart', 01:40:49 INFO - 'tscrollx', 01:40:49 INFO - 'cart']}, 01:40:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:49 INFO - 'tests': ['tp5o']}, 01:40:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:49 INFO - 'talos_options': ['--e10s'], 01:40:49 INFO - 'tests': ['tp5o']}, 01:40:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:49 INFO - 'talos_options': ['--xperf_path', 01:40:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:40:49 INFO - 'tests': ['tp5n']}, 01:40:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:40:49 INFO - 'talos_options': ['--e10s', 01:40:49 INFO - '--xperf_path', 01:40:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:40:49 INFO - 'tests': ['tp5n']}}, 01:40:49 INFO - 'talos.zip': {'path': '', 01:40:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:40:49 INFO - Running post-action listener: _resource_record_post_action 01:40:49 INFO - ##### 01:40:49 INFO - ##### Running create-virtualenv step. 01:40:49 INFO - ##### 01:40:49 INFO - Running pre-action listener: _resource_record_pre_action 01:40:49 INFO - Running main action method: create_virtualenv 01:40:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:40:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 01:40:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:40:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:40:49 INFO - Using real prefix '/usr' 01:40:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:40:50 INFO - Installing distribute.............................................................................................................................................................................................done. 01:40:52 INFO - Installing pip.................done. 01:40:52 INFO - Return code: 0 01:40:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:52 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 0x7faedddfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b29600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb8350>, '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 0x2bb9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb96e0>, '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': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:40:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 01:40:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:40:52 INFO - Using env: {'DISPLAY': ':0', 01:40:52 INFO - 'HOME': '/home/cltbld', 01:40:52 INFO - 'LANG': 'en_US.UTF-8', 01:40:52 INFO - 'LANGUAGE': 'en_US:en', 01:40:52 INFO - 'LOGNAME': 'cltbld', 01:40:52 INFO - 'MAIL': '/var/mail/cltbld', 01:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:52 INFO - 'MOZ_NO_REMOTE': '1', 01:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:52 INFO - 'NO_EM_RESTART': '1', 01:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:40:52 INFO - 'PWD': '/builds/slave/test-pgo', 01:40:52 INFO - 'SHELL': '/bin/bash', 01:40:52 INFO - 'SHLVL': '1', 01:40:52 INFO - 'TERM': 'linux', 01:40:52 INFO - 'TMOUT': '86400', 01:40:52 INFO - 'USER': 'cltbld', 01:40:52 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 01:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:52 INFO - '_': '/tools/buildbot/bin/python'} 01:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:40:52 INFO - Cleaning up... 01:40:52 INFO - Return code: 0 01:40:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:52 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 0x7faedddfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b29600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb8350>, '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 0x2bb9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb96e0>, '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': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:40:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 01:40:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:40:52 INFO - Using env: {'DISPLAY': ':0', 01:40:52 INFO - 'HOME': '/home/cltbld', 01:40:52 INFO - 'LANG': 'en_US.UTF-8', 01:40:52 INFO - 'LANGUAGE': 'en_US:en', 01:40:52 INFO - 'LOGNAME': 'cltbld', 01:40:52 INFO - 'MAIL': '/var/mail/cltbld', 01:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:52 INFO - 'MOZ_NO_REMOTE': '1', 01:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:52 INFO - 'NO_EM_RESTART': '1', 01:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:40:52 INFO - 'PWD': '/builds/slave/test-pgo', 01:40:52 INFO - 'SHELL': '/bin/bash', 01:40:52 INFO - 'SHLVL': '1', 01:40:52 INFO - 'TERM': 'linux', 01:40:52 INFO - 'TMOUT': '86400', 01:40:52 INFO - 'USER': 'cltbld', 01:40:52 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 01:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:52 INFO - '_': '/tools/buildbot/bin/python'} 01:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:52 INFO - Downloading/unpacking psutil>=0.7.1 01:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:40:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:40:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:40:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:40:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:40:54 INFO - Installing collected packages: psutil 01:40:54 INFO - Running setup.py install for psutil 01:40:54 INFO - building 'psutil._psutil_linux' extension 01:40:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:40:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:40:54 INFO - building 'psutil._psutil_posix' extension 01:40:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:40:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:40:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:40:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:40:55 INFO - Successfully installed psutil 01:40:55 INFO - Cleaning up... 01:40:55 INFO - Return code: 0 01:40:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faedddfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b29600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb8350>, '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 0x2bb9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb96e0>, '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': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:40:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:40:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:40:55 INFO - Using env: {'DISPLAY': ':0', 01:40:55 INFO - 'HOME': '/home/cltbld', 01:40:55 INFO - 'LANG': 'en_US.UTF-8', 01:40:55 INFO - 'LANGUAGE': 'en_US:en', 01:40:55 INFO - 'LOGNAME': 'cltbld', 01:40:55 INFO - 'MAIL': '/var/mail/cltbld', 01:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:55 INFO - 'MOZ_NO_REMOTE': '1', 01:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:55 INFO - 'NO_EM_RESTART': '1', 01:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:40:55 INFO - 'PWD': '/builds/slave/test-pgo', 01:40:55 INFO - 'SHELL': '/bin/bash', 01:40:55 INFO - 'SHLVL': '1', 01:40:55 INFO - 'TERM': 'linux', 01:40:55 INFO - 'TMOUT': '86400', 01:40:55 INFO - 'USER': 'cltbld', 01:40:55 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 01:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:55 INFO - '_': '/tools/buildbot/bin/python'} 01:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:40:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:40:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:40:57 INFO - Installing collected packages: mozsystemmonitor 01:40:57 INFO - Running setup.py install for mozsystemmonitor 01:40:57 INFO - Successfully installed mozsystemmonitor 01:40:57 INFO - Cleaning up... 01:40:57 INFO - Return code: 0 01:40:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faedddfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b29600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb8350>, '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 0x2bb9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb96e0>, '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': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:40:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:40:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:40:57 INFO - Using env: {'DISPLAY': ':0', 01:40:57 INFO - 'HOME': '/home/cltbld', 01:40:57 INFO - 'LANG': 'en_US.UTF-8', 01:40:57 INFO - 'LANGUAGE': 'en_US:en', 01:40:57 INFO - 'LOGNAME': 'cltbld', 01:40:57 INFO - 'MAIL': '/var/mail/cltbld', 01:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:57 INFO - 'MOZ_NO_REMOTE': '1', 01:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:57 INFO - 'NO_EM_RESTART': '1', 01:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:40:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:40:57 INFO - 'SHELL': '/bin/bash', 01:40:57 INFO - 'SHLVL': '1', 01:40:57 INFO - 'TERM': 'linux', 01:40:57 INFO - 'TMOUT': '86400', 01:40:57 INFO - 'USER': 'cltbld', 01:40:57 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 01:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:57 INFO - '_': '/tools/buildbot/bin/python'} 01:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:57 INFO - Downloading/unpacking blobuploader==1.2.4 01:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:59 INFO - Downloading blobuploader-1.2.4.tar.gz 01:40:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:40:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:40:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:40:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:40:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:59 INFO - Downloading docopt-0.6.1.tar.gz 01:40:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:40:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:40:59 INFO - Installing collected packages: blobuploader, requests, docopt 01:40:59 INFO - Running setup.py install for blobuploader 01:40:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:40:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:40:59 INFO - Running setup.py install for requests 01:41:00 INFO - Running setup.py install for docopt 01:41:00 INFO - Successfully installed blobuploader requests docopt 01:41:00 INFO - Cleaning up... 01:41:00 INFO - Return code: 0 01:41:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:00 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 0x7faedddfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b29600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb8350>, '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 0x2bb9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb96e0>, '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': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:41:00 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 01:41:00 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 01:41:00 INFO - Using env: {'DISPLAY': ':0', 01:41:00 INFO - 'HOME': '/home/cltbld', 01:41:00 INFO - 'LANG': 'en_US.UTF-8', 01:41:00 INFO - 'LANGUAGE': 'en_US:en', 01:41:00 INFO - 'LOGNAME': 'cltbld', 01:41:00 INFO - 'MAIL': '/var/mail/cltbld', 01:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:00 INFO - 'MOZ_NO_REMOTE': '1', 01:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:00 INFO - 'NO_EM_RESTART': '1', 01:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:41:00 INFO - 'PWD': '/builds/slave/test-pgo', 01:41:00 INFO - 'SHELL': '/bin/bash', 01:41:00 INFO - 'SHLVL': '1', 01:41:00 INFO - 'TERM': 'linux', 01:41:00 INFO - 'TMOUT': '86400', 01:41:00 INFO - 'USER': 'cltbld', 01:41:00 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 01:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:00 INFO - '_': '/tools/buildbot/bin/python'} 01:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:41:00 INFO - Running setup.py (path:/tmp/pip-dzinsf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:41:00 INFO - Running setup.py (path:/tmp/pip-NEZy48-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:41:00 INFO - Running setup.py (path:/tmp/pip-pSYExJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:41:00 INFO - Running setup.py (path:/tmp/pip-4obI1v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:41:00 INFO - Running setup.py (path:/tmp/pip-2kb4fT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:41:00 INFO - Running setup.py (path:/tmp/pip-KNryq9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:41:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:41:01 INFO - Running setup.py (path:/tmp/pip-JdL04M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:41:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:41:01 INFO - Running setup.py (path:/tmp/pip-YoFUl6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:41:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:41:01 INFO - Running setup.py (path:/tmp/pip-8AzUFz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:41:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:41:01 INFO - Running setup.py (path:/tmp/pip-MNh0Pa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:41:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:41:01 INFO - Running setup.py (path:/tmp/pip-OZb31z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:41:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:41:01 INFO - Running setup.py (path:/tmp/pip-F6_Vlf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:41:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:41:01 INFO - Running setup.py (path:/tmp/pip-VnQRgU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:41:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:41:01 INFO - Running setup.py (path:/tmp/pip-epoQoE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:41:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:41:01 INFO - Running setup.py (path:/tmp/pip-IUNzzG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:41:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:41:01 INFO - Running setup.py (path:/tmp/pip-vxh0WN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:41:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:41:01 INFO - Running setup.py (path:/tmp/pip-Iep78_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:41:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:41:01 INFO - Running setup.py install for manifestparser 01:41:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:41:01 INFO - Running setup.py install for mozcrash 01:41:02 INFO - Running setup.py install for mozdebug 01:41:02 INFO - Running setup.py install for mozdevice 01:41:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:41:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:41:02 INFO - Running setup.py install for mozfile 01:41:02 INFO - Running setup.py install for mozhttpd 01:41:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:41:02 INFO - Running setup.py install for mozinfo 01:41:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:41:02 INFO - Running setup.py install for mozInstall 01:41:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:41:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:41:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:41:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:41:02 INFO - Running setup.py install for mozleak 01:41:02 INFO - Running setup.py install for mozlog 01:41:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:41:02 INFO - Running setup.py install for moznetwork 01:41:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:41:02 INFO - Running setup.py install for mozprocess 01:41:03 INFO - Running setup.py install for mozprofile 01:41:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:41:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:41:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:41:03 INFO - Running setup.py install for mozrunner 01:41:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:41:03 INFO - Running setup.py install for mozscreenshot 01:41:03 INFO - Running setup.py install for moztest 01:41:03 INFO - Running setup.py install for mozversion 01:41:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:41:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:41:03 INFO - Cleaning up... 01:41:03 INFO - Return code: 0 01:41:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:03 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 0x7faedddfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b29600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb8350>, '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 0x2bb9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb96e0>, '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': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:41:03 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 01:41:03 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 01:41:03 INFO - Using env: {'DISPLAY': ':0', 01:41:03 INFO - 'HOME': '/home/cltbld', 01:41:03 INFO - 'LANG': 'en_US.UTF-8', 01:41:03 INFO - 'LANGUAGE': 'en_US:en', 01:41:03 INFO - 'LOGNAME': 'cltbld', 01:41:03 INFO - 'MAIL': '/var/mail/cltbld', 01:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:03 INFO - 'MOZ_NO_REMOTE': '1', 01:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:03 INFO - 'NO_EM_RESTART': '1', 01:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:41:03 INFO - 'PWD': '/builds/slave/test-pgo', 01:41:03 INFO - 'SHELL': '/bin/bash', 01:41:03 INFO - 'SHLVL': '1', 01:41:03 INFO - 'TERM': 'linux', 01:41:03 INFO - 'TMOUT': '86400', 01:41:03 INFO - 'USER': 'cltbld', 01:41:03 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 01:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:03 INFO - '_': '/tools/buildbot/bin/python'} 01:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:41:03 INFO - Running setup.py (path:/tmp/pip-iIh024-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:41:03 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)) 01:41:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:41:03 INFO - Running setup.py (path:/tmp/pip-nlTYBt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:41: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)) 01:41:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:41:03 INFO - Running setup.py (path:/tmp/pip-a5sv0i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:41:04 INFO - Running setup.py (path:/tmp/pip-0nED8M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:41:04 INFO - Running setup.py (path:/tmp/pip-8R98bs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:41:04 INFO - Running setup.py (path:/tmp/pip-_9eQYz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:41:04 INFO - Running setup.py (path:/tmp/pip-S4Ibau-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:41:04 INFO - Running setup.py (path:/tmp/pip-1UWcmT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:41:04 INFO - Running setup.py (path:/tmp/pip-lBXBVI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:41:04 INFO - Running setup.py (path:/tmp/pip-IZlfVB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:41:04 INFO - Running setup.py (path:/tmp/pip-xx2rNK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:41:04 INFO - Running setup.py (path:/tmp/pip-hRZASK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:41:04 INFO - Running setup.py (path:/tmp/pip-P0Piqk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:41:04 INFO - Running setup.py (path:/tmp/pip-ei95wa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:41:04 INFO - Running setup.py (path:/tmp/pip-5ZXajJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:41:04 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)) 01:41:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:41:04 INFO - Running setup.py (path:/tmp/pip-yCDA9r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:41:05 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)) 01:41:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:41:05 INFO - Running setup.py (path:/tmp/pip-ROZI7L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:41:05 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)) 01:41:05 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)) 01:41:05 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)) 01:41:05 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)) 01:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:41:05 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)) 01:41:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:06 INFO - Downloading blessings-1.5.1.tar.gz 01:41:06 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 01:41:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:41:06 INFO - Installing collected packages: blessings 01:41:06 INFO - Running setup.py install for blessings 01:41:07 INFO - Successfully installed blessings 01:41:07 INFO - Cleaning up... 01:41:07 INFO - Return code: 0 01:41:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:41:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:41:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:41:07 INFO - Reading from file tmpfile_stdout 01:41:07 INFO - Current package versions: 01:41:07 INFO - argparse == 1.2.1 01:41:07 INFO - blessings == 1.5.1 01:41:07 INFO - blobuploader == 1.2.4 01:41:07 INFO - docopt == 0.6.1 01:41:07 INFO - manifestparser == 1.1 01:41:07 INFO - mozInstall == 1.12 01:41:07 INFO - mozcrash == 0.16 01:41:07 INFO - mozdebug == 0.1 01:41:07 INFO - mozdevice == 0.47 01:41:07 INFO - mozfile == 1.2 01:41:07 INFO - mozhttpd == 0.7 01:41:07 INFO - mozinfo == 0.9 01:41:07 INFO - mozleak == 0.1 01:41:07 INFO - mozlog == 3.1 01:41:07 INFO - moznetwork == 0.27 01:41:07 INFO - mozprocess == 0.22 01:41:07 INFO - mozprofile == 0.27 01:41:07 INFO - mozrunner == 6.11 01:41:07 INFO - mozscreenshot == 0.1 01:41:07 INFO - mozsystemmonitor == 0.0 01:41:07 INFO - moztest == 0.7 01:41:07 INFO - mozversion == 1.4 01:41:07 INFO - psutil == 3.1.1 01:41:07 INFO - requests == 1.2.3 01:41:07 INFO - wsgiref == 0.1.2 01:41:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:07 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 0x7faedddfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b29600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb8350>, '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 0x2bb9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb96e0>, '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': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:41:07 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 01:41:07 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 01:41:07 INFO - Using env: {'DISPLAY': ':0', 01:41:07 INFO - 'HOME': '/home/cltbld', 01:41:07 INFO - 'LANG': 'en_US.UTF-8', 01:41:07 INFO - 'LANGUAGE': 'en_US:en', 01:41:07 INFO - 'LOGNAME': 'cltbld', 01:41:07 INFO - 'MAIL': '/var/mail/cltbld', 01:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:07 INFO - 'MOZ_NO_REMOTE': '1', 01:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:07 INFO - 'NO_EM_RESTART': '1', 01:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:41:07 INFO - 'PWD': '/builds/slave/test-pgo', 01:41:07 INFO - 'SHELL': '/bin/bash', 01:41:07 INFO - 'SHLVL': '1', 01:41:07 INFO - 'TERM': 'linux', 01:41:07 INFO - 'TMOUT': '86400', 01:41:07 INFO - 'USER': 'cltbld', 01:41:07 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 01:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:07 INFO - '_': '/tools/buildbot/bin/python'} 01:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:07 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)) 01:41:07 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)) 01:41:07 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)) 01:41:07 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)) 01:41:07 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)) 01:41:07 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)) 01:41:07 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)) 01:41:07 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)) 01:41:07 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)) 01:41:07 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)) 01:41:07 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)) 01:41:07 INFO - Cleaning up... 01:41:07 INFO - Return code: 0 01:41:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:07 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 0x7faedddfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b29600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb8350>, '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 0x2bb9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb96e0>, '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': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:41:07 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 01:41:07 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 01:41:07 INFO - Using env: {'DISPLAY': ':0', 01:41:07 INFO - 'HOME': '/home/cltbld', 01:41:07 INFO - 'LANG': 'en_US.UTF-8', 01:41:07 INFO - 'LANGUAGE': 'en_US:en', 01:41:07 INFO - 'LOGNAME': 'cltbld', 01:41:07 INFO - 'MAIL': '/var/mail/cltbld', 01:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:07 INFO - 'MOZ_NO_REMOTE': '1', 01:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:07 INFO - 'NO_EM_RESTART': '1', 01:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:41:07 INFO - 'PWD': '/builds/slave/test-pgo', 01:41:07 INFO - 'SHELL': '/bin/bash', 01:41:07 INFO - 'SHLVL': '1', 01:41:07 INFO - 'TERM': 'linux', 01:41:07 INFO - 'TMOUT': '86400', 01:41:07 INFO - 'USER': 'cltbld', 01:41:07 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 01:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:07 INFO - '_': '/tools/buildbot/bin/python'} 01:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:07 INFO - Downloading/unpacking jsonschema 01:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:41:09 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 01:41:09 INFO - Downloading/unpacking functools32 (from jsonschema) 01:41: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 01:41: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 01:41: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 01:41: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 01:41: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 01:41: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 01:41:09 INFO - Downloading functools32-3.2.3-2.tar.gz 01:41:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:41:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:41:09 INFO - warning: no files found matching '*.txt' 01:41:09 INFO - no previously-included directories found matching 'build' 01:41:09 INFO - no previously-included directories found matching 'dist' 01:41:09 INFO - no previously-included directories found matching '.git*' 01:41:09 INFO - Installing collected packages: jsonschema, functools32 01:41:09 INFO - Running setup.py install for functools32 01:41:09 INFO - warning: no files found matching '*.txt' 01:41:09 INFO - no previously-included directories found matching 'build' 01:41:09 INFO - no previously-included directories found matching 'dist' 01:41:09 INFO - no previously-included directories found matching '.git*' 01:41:09 INFO - Successfully installed jsonschema functools32 01:41:09 INFO - Cleaning up... 01:41:09 INFO - Return code: 0 01:41:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:41:09 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 0x7faedddfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b29600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb8350>, '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 0x2bb9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb96e0>, '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': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:41:09 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 01:41:09 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 01:41:09 INFO - Using env: {'DISPLAY': ':0', 01:41:09 INFO - 'HOME': '/home/cltbld', 01:41:09 INFO - 'LANG': 'en_US.UTF-8', 01:41:09 INFO - 'LANGUAGE': 'en_US:en', 01:41:09 INFO - 'LOGNAME': 'cltbld', 01:41:09 INFO - 'MAIL': '/var/mail/cltbld', 01:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:09 INFO - 'MOZ_NO_REMOTE': '1', 01:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:09 INFO - 'NO_EM_RESTART': '1', 01:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:41:09 INFO - 'PWD': '/builds/slave/test-pgo', 01:41:09 INFO - 'SHELL': '/bin/bash', 01:41:09 INFO - 'SHLVL': '1', 01:41:09 INFO - 'TERM': 'linux', 01:41:09 INFO - 'TMOUT': '86400', 01:41:09 INFO - 'USER': 'cltbld', 01:41:09 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 01:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:09 INFO - '_': '/tools/buildbot/bin/python'} 01:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:41:10 INFO - Downloading/unpacking flake8 01:41: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 01:41: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 01:41: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 01:41: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 01:41: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 01:41: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 01:41:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:41:11 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 01:41:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:41: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 01:41: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 01:41: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 01:41: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 01:41: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 01:41: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 01:41:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:41:11 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 01:41:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:41: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 01:41: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 01:41: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 01:41: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 01:41: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 01:41: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 01:41:12 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 01:41:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:41:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:41:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:41:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:41:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:41:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:41:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:41:12 INFO - no previously-included directories found matching 'docs/_build' 01:41:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:41:12 INFO - Running setup.py install for pep8 01:41:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:41:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:41:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:41:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:41:12 INFO - no previously-included directories found matching 'docs/_build' 01:41:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:41:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:41:12 INFO - Cleaning up... 01:41:12 INFO - Return code: 0 01:41:12 INFO - Running post-action listener: _resource_record_post_action 01:41:12 INFO - Running post-action listener: _start_resource_monitoring 01:41:12 INFO - Starting resource monitoring. 01:41:12 INFO - ##### 01:41:12 INFO - ##### Running install step. 01:41:12 INFO - ##### 01:41:12 INFO - Running pre-action listener: _resource_record_pre_action 01:41:12 INFO - Running main action method: install 01:41:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:41:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:41:12 INFO - Reading from file tmpfile_stdout 01:41:12 INFO - Detecting whether we're running mozinstall >=1.0... 01:41:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:41:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:41:12 INFO - Reading from file tmpfile_stdout 01:41:12 INFO - Output received: 01:41:12 INFO - Usage: mozinstall [options] installer 01:41:12 INFO - Options: 01:41:12 INFO - -h, --help show this help message and exit 01:41:12 INFO - -d DEST, --destination=DEST 01:41:12 INFO - Directory to install application into. [default: 01:41:12 INFO - "/builds/slave/test-pgo"] 01:41:12 INFO - --app=APP Application being installed. [default: firefox] 01:41:12 INFO - mkdir: /builds/slave/test-pgo/build/application 01:41:12 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'] 01:41:12 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 01:41:31 INFO - Reading from file tmpfile_stdout 01:41:31 INFO - Output received: 01:41:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:41:31 INFO - Running post-action listener: _resource_record_post_action 01:41:31 INFO - ##### 01:41:31 INFO - ##### Running run-tests step. 01:41:31 INFO - ##### 01:41:31 INFO - Running pre-action listener: _resource_record_pre_action 01:41:31 INFO - Running main action method: run_tests 01:41:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:41:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:41:31 INFO - Python 2.7.3 01:41:31 INFO - Return code: 0 01:41:31 INFO - grabbing minidump binary from tooltool 01:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:31 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 0x2bb8350>, '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 0x2bb9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb96e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:41:31 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 01:41:31 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 01:41:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:41:31 INFO - Return code: 0 01:41:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:41:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:41:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:41:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:41:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:41:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:41:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:41:32 INFO - Return code: 0 01:41:32 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/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 01:41:32 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/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 01:41:32 INFO - Using env: {'DISPLAY': ':0', 01:41:32 INFO - 'HOME': '/home/cltbld', 01:41:32 INFO - 'LANG': 'en_US.UTF-8', 01:41:32 INFO - 'LANGUAGE': 'en_US:en', 01:41:32 INFO - 'LOGNAME': 'cltbld', 01:41:32 INFO - 'MAIL': '/var/mail/cltbld', 01:41:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:41:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:41:32 INFO - 'MOZ_NO_REMOTE': '1', 01:41:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:41:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:41:32 INFO - 'NO_EM_RESTART': '1', 01:41:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:41:32 INFO - 'PWD': '/builds/slave/test-pgo', 01:41:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:41:32 INFO - 'SHELL': '/bin/bash', 01:41:32 INFO - 'SHLVL': '1', 01:41:32 INFO - 'TERM': 'linux', 01:41:32 INFO - 'TMOUT': '86400', 01:41:32 INFO - 'USER': 'cltbld', 01:41:32 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531', 01:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:41:32 INFO - '_': '/tools/buildbot/bin/python'} 01:41:32 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/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 01:41:32 INFO - mozversion INFO | application_buildid: 20151217233003 01:41:32 INFO - mozversion INFO | application_changeset: 4b36d090fb5d368c7204a9cb44fe6b460be52224 01:41:32 INFO - mozversion INFO | application_display_name: Nightly 01:41:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:41:32 INFO - mozversion INFO | application_name: Firefox 01:41:32 INFO - mozversion INFO | application_remotingname: firefox 01:41:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 01:41:32 INFO - mozversion INFO | application_vendor: Mozilla 01:41:32 INFO - mozversion INFO | application_version: 46.0a1 01:41:32 INFO - mozversion INFO | platform_buildid: 20151217233003 01:41:32 INFO - mozversion INFO | platform_changeset: 4b36d090fb5d368c7204a9cb44fe6b460be52224 01:41:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 01:41:32 INFO - mozversion INFO | platform_version: 46.0a1 01:41:32 INFO - 2015-12-18 01:41:32,922 DEBUG : using testdate: 1450431692 01:41:32 INFO - 2015-12-18 01:41:32,922 DEBUG : actual date: 1450431692 01:41:33 INFO - 2015-12-18 01:41:33,012 INFO : starting webserver on 'localhost:49530' 01:41:33 INFO - 2015-12-18 01:41:33,013 INFO : Starting test suite talos-linux64-ix-033 01:41:33 INFO - 2015-12-18 01:41:33,013 INFO : Starting test dromaeo_css 01:41:33 INFO - 2015-12-18 01:41:33,014 DEBUG : operating with platform_type : linux_ 01:41:33 INFO - 2015-12-18 01:41:33,014 INFO : Initialising browser for dromaeo_css test... 01:41:33 INFO - 2015-12-18 01:41:33,030 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9ef1Rv/profile http://localhost:49530/getInfo.html 01:41:38 INFO - 2015-12-18 01:41:38,222 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:41:38 INFO - 2015-12-18 01:41:38,222 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:41:38 INFO - 2015-12-18 01:41:38,222 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:41:38 INFO - 2015-12-18 01:41:38,222 DEBUG : BROWSER_OUTPUT: __metrics 01:41:38 INFO - 2015-12-18 01:41:38,400 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] 01:41:38 INFO - 2015-12-18 01:41:38,455 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] 01:41:39 INFO - 2015-12-18 01:41:39,451 INFO : Browser initialized. 01:41:39 INFO - 2015-12-18 01:41:39,452 INFO : Running cycle 1/1 for dromaeo_css test... 01:41:39 INFO - 2015-12-18 01:41:39,452 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9ef1Rv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:41:51 INFO - 2015-12-18 01:41:51,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 149684224 01:41:51 INFO - 2015-12-18 01:41:51,248 DEBUG : BROWSER_OUTPUT: 01:42:42 INFO - 2015-12-18 01:42:42,517 DEBUG : BROWSER_OUTPUT: 1450431762515 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] 01:44:51 INFO - 2015-12-18 01:44:51,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49530/tests/dromaeo/cssquery-ext.html) 01:44:52 INFO - 2015-12-18 01:44:52,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 246796288 01:44:52 INFO - 2015-12-18 01:44:52,663 DEBUG : BROWSER_OUTPUT: 01:47:55 INFO - 2015-12-18 01:47:55,103 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/dromaeo/cssquery-ext.html (next: http://localhost:49530/tests/dromaeo/cssquery-jquery.html) 01:47:55 INFO - 2015-12-18 01:47:55,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 238485504 01:47:55 INFO - 2015-12-18 01:47:55,685 DEBUG : BROWSER_OUTPUT: 01:50:57 INFO - 2015-12-18 01:50:57,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49530/tests/dromaeo/cssquery-mootools.html) 01:50:58 INFO - 2015-12-18 01:50:58,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 225435648 01:50:58 INFO - 2015-12-18 01:50:58,131 DEBUG : BROWSER_OUTPUT: 01:53:59 INFO - 2015-12-18 01:53:59,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49530/tests/dromaeo/cssquery-prototype.html) 01:54:00 INFO - 2015-12-18 01:54:00,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 217579520 01:54:00 INFO - 2015-12-18 01:54:00,561 DEBUG : BROWSER_OUTPUT: 01:57:02 INFO - 2015-12-18 01:57:02,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49530/tests/dromaeo/cssquery-yui.html) 01:57:03 INFO - 2015-12-18 01:57:03,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 218509312 01:57:03 INFO - 2015-12-18 01:57:03,541 DEBUG : BROWSER_OUTPUT: 02:00:06 INFO - 2015-12-18 02:00:06,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/dromaeo/cssquery-yui.html (next: http://localhost:49530/tests/dromaeo/cssquery-dojo.html) 02:00:06 INFO - 2015-12-18 02:00:06,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 263569408 02:00:06 INFO - 2015-12-18 02:00:06,597 DEBUG : BROWSER_OUTPUT: 02:00:06 INFO - 2015-12-18 02:00:06,597 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:00:06 INFO - 2015-12-18 02:00:06,597 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:00:06 INFO - 2015-12-18 02:00:06,598 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:00:06 INFO - 2015-12-18 02:00:06,598 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:00:06 INFO - 2015-12-18 02:00:06,599 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3104.7826652134354;3176.047185844249;3196.0731387897513;3205.4550726376515;3224.145601415625;5082.84751457456;5177.818776342829;5222.686638801674;5300.045991721484;5334.706591137486;5119.692818430897;5134.743262836852;5195.610329225305;5196.636235463519;5200.817971370993;4659.976700116495;4792.808287668489;4797.280407938811;4886.706797592138;4950.3069570260195;4718.528147185289;4808.278758186282;4877.585405240558;4879.316895634614;4997.6501644884875;4715.669903106784;4770.16522108633;4777.307290442884;4786.593139583105;4789.161896668069;4809.374781278447;4812.061647978646;4823.662343635947;4840.782164802592;4878.585320247783;4714.339992401066;4793.376861008047;4819.9036019279765;4822.590079843218;4837.0809546186465;5025.271335656346;5025.773840177201;5045;5057.2666963290485;5072;5568.805091821767;5646.858828529279;5652.74562644682;5653.802116925929;5654.349749778787;5722.084466485342;5730.942690573124;5748.626339287933;5754.251947246831;5775.826725198251;5355.410904800468;5355.7857685692525;5357.491038351351;5357.732113394315;5368.1679339702405;5511.751971161227;5645.830625081254;5724.255846739898;5788.0739081746715;5797.159411885337;5538.252335934597;5578.24693666358;5581.665100093926;5588;5594;5713.5714821388565;5732.426757324318;5733.397993210736;5737.3688894221605;5741.282339707536;5497.422770609109;5635.464630860061;5641.294838145232;5693.459121383462;5698.715064246771;5520.951019306319;5578.665280083208;5593.328800543961;5594.580406469531;5638.182463542763;4395.384646149541;4412.426384569985;4412.602865742098;4414.536473670282;4452.577005184502;3830.195658911604;3844.4233364995475;3934.272159650474;3944.290027794967;3972.960270397317;5346.5455436287575;5353.411124776349;5354.625176237704;5357.062514060024;5375.59683023767;5660.858478537987;5663.915041274384;5667.886642267132;5684.7157642118555;5688.601797874192;5265.552428043583;5315.73421328932;5362.276092727432;5366.597505187126;5367.329083864517;4876.414830220326;4891.070696567641;4920.581750551171;4923.532264434873;4962.702237865739;5887.969605319052;5893.410658934158;5896.528277737771;5899.793507227227;5906.40935906406;5443.564514838883;5602.243697100839;5607;5696.344920334214;5753.568482363923;5895.882082358415;5964.940350596438;5971.492423144082;6013.7293821779;6015.218021657157;5597.076482380362;5598.468145526169;5601.24383208278;5612.803551875828;5615.578831587729;5501.834944951658;5605.5515558756015;5688.0899056152475;5688.175214593944;5692.601517893708;5466.3986961435;5540.473655002768;5555.666660000413;5592.245046918614;5636.943630563642;5520.420355862577;5537;5545.3622833373065;5546.528545073714;5551.694656793915;5296.390915044819;5407.702576358338;5462.562994960314;5464.836054918359;5475.315585551806;5520.420355862577;5563.944360556343;5564.4713752193475;5601.075822489243;5613.691246981455;5443.755031023693;5463.207834864002;5465.207544906046;5470.070088084955;5472.91790623149 02:00:06 INFO - 2015-12-18 02:00:06,602 DEBUG : BROWSER_OUTPUT: |1;ext.html;585.8418227078689;586.3140126052518;598.1894532907909;610.5451438678183;622.5424313129852;29373.559396609042;36608.973012968585;37044.629553704486;37106.81446592763;37447.251054978886;41852.37221441673;42049.15901681964;42250.36624450636;42483.575164248345;42546.57453425465;7346.742863999761;8603.784905377353;8770.298376129926;8776.780580485474;8777.122287771235;7504.399648028172;7526.849463010763;10349.32729372592;10486.108680762145;10487.842682359771;10315.329503582281;10446.791064178711;10466.110380617656;10483.266171368008;10487.423191724452;7606.65770040344;7834.882476762853;10292.433916134609;10408.687739367831;10414.062734353869;10031.949840250825;10244.28290019699;10244.846327305097;10248.79502409955;10252.077313041787;35193.824030879936;35477;35602;35620.64379356199;35638.64361356379;3207.6631953644996;3502.964970350289;3656.963430365689;3747.163695299838;3978.900527486807;29235.269118272;29552.408951820842;29900.968484559755;30332.393352133055;30979.845100774353;3909.3158697227873;3919.2945269851416;3974;4049.8582549610624;4054.0472988847596;263357;263513;263750;264139.9999999981;264846;51828.22257666138;52896.47103528993;54425;54604;55248;54649.72675136599;54944;55446;55484.445155547925;55502.16746748802;12908.096433249582;13064.21614703121;13078.019148563706;13085.476580936845;13118.540851070167;9437.622495100119;9451.054894510495;9469.90530094704;9497.667581634747;9501.809963800686;18064.18711158001;18125.18436670353;18136.909315453337;18238.90880545589;18249;7075.787726368218;7367.852642947111;7424.925750742424;7497.887531687029;7604.9239507605325;972.363102168081;1001.62439085343;1006.9980369532362;1092.159037541089;1098.6758906122552;27505.17484475469;27540;27645.723542764717;27859.08342752868;28125.296867578476;1028.321307936758;1037.8287582548946;1049.8267785815256;1087.8205096159204;1150.2868221702597;14410.135391876522;14458.566243012727;14618.415263389557;14645.780313295309;14769;299627;300592;303678;304196;304705;50531.24203136956;50746.49253507492;50766.238506422436;50800.491995080316;50811;1305.1581729784425;1334.9933250333686;1347.238810072306;1353.2557093598482;1356.7083077138266;26964.191074267805;27362.863185683946;28070.2982425441;28266.85866570654;28310.575341369484;40685.38971915483;43559.56440435555;43860.342094869244;43961.78019110012;43964.78017609892;213318;372510;380546;381789;382275;29616.259593510335;30161.245968850075;30225.395492089596;30229.09312720622;30240.54639180458;41034.38448423336;41691.79154104331;41755;42606;42628.78685606552;34963.300733985685;35186.47220291749;35377.82311088428;35649.28701425905;36360.818195908854;34208.657913420546;35045.64954350424;35412.64587354093;36020.81989590035;36349.818250908575;30337.696623033487;30946.69053309438;30970.84514577413;31357.372852542365;31396.215094622818;26764;28585;30571.2357191072;31276.374472509968;31333;23298.301050968497;23513.011152416522;23860;23942.88028559846;24000 02:00:06 INFO - 2015-12-18 02:00:06,604 DEBUG : BROWSER_OUTPUT: |2;jquery.html;351.40612365102976;352.8958957107653;353.9168295450569;354.1747727794239;357.46737361331606;13792.310384480761;14161.92919035406;17155.914220428895;17524.56188595286;18181.545461363472;10256.282060255766;12674.176178548389;12833.807492887614;14640.414383424677;14667.633309167277;4918.311436398907;5015.398152221738;5027.648064635477;5027.798888044474;5041.974790126044;3694.3165514379925;4967.925481117768;4986.227134794112;4991.40103187618;5028.597712183035;5503.6147469677135;5549.1676248562835;5568.805091821787;5570.053090974544;5572.136318870582;5498.340199176085;5506.779728810843;5964;5985.461308482258;5987.790427335022;5332.253484512172;5338.839834804923;5344.35867695879;5348.625596208267;5351.411344752074;13571.45714171432;15373.154476503787;15382.230888455533;15412.152331621757;16970.575735606584;1980.7821139674625;1991.104003198552;2029.4723371923258;2049.026712311655;2101.464126647695;9652.083052110038;10125.594976200942;12320.044572235867;12771.552995645108;13305.53430629933;1780.0832571225828;1786.606946471774;1813.3471950097953;1824.8722589418746;1849.1401498303353;57114.428855711325;57691.42308576903;57979.710101449644;59337.40662593362;60641.6967915162;9823.705288841345;10176.694699159038;10324.793504129875;10387.948060259801;10445.791084178274;13582.117162384611;13585;13585.660358490919;13606.115602485806;13607;6890.2076261229595;6961.269066747918;7001.824954376079;7016.614086225307;7054.400375967997;6555.3772391622715;6570.080188773575;6601.075849381091;6602.669866506655;6624.105745724362;4462.464504259445;4494.617957473652;4515.503294637587;4548.840790572381;4549.408576884984;1731.1257814803444;1749.230338651015;1789.2127463915836;1812.963740725178;1832.9816701833079;440.7730019040197;832.5398447587365;869.6738722978882;902.3818684201343;969.2827307792325;10555.788884222273;10596.523156457977;10729.517171727291;11056.668299951014;11227.831582526269;410.2185336933147;455.00127220750795;458.16842430988316;462.2973080916987;467.18009892638884;6014.09788531715;6174.845628859224;6183.81448556544;6284.308726040132;6287.46556542699;505025;532644;553620;560734;563281;80006.59996700096;80516.59741701254;80794;81088.59455702802;81261;483.35472144687236;488.6725893651262;489.1244672037085;489.75267489917366;490.2915287409659;10625.415602141957;10631.468426578795;10649.722033356047;10760.730981725519;14902.77645835335;32517.674823251466;32593.18517037093;34201.144971375914;34280.48579271263;35999;41234.79382603068;42935.78532107444;43000.354994675734;43113.56886431221;45391.319130213735;9862.85205721929;9973.900260997298;10109.797804044025;10170.338927969658;10207.285490015627;11959.222650527689;14184.645383865485;17116.486505404857;17264.482065538054;18051.638967220846;14598.197099159222;14698.63253418673;15035.473758418402;15234.542963711106;15321.6169595761;14042.1574705518;14181.432742690176;14380;15004.924975375054;15049.322780474686;11043.558257669603;14076.929615351857;15023.549293521211;15316.770248446059;15577.76633350478;9340.813183736424;9405.717828465156;9698.27262955267;9706.660266890625;9718.659846905324;10091.444970526398;10188.388696678223;11510.42447877586;14054.718905622034;14155.292235388395 02:00:06 INFO - 2015-12-18 02:00:06,605 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1519.5669234268237;1631.469772323995;1680.7394853797666;1704.9062301573413;1708.0264249377851;6265.968670156649;7234.312740289671;7434.591097489629;7468.850622987537;7490.775276741693;7110.893336599956;7217.170025447075;7229.710811567544;7235.7829265122;7237.819054523627;1938.5832046110083;1971.3494546799593;2020.3332900142918;2053.5276886316155;2137.8931053447345;2178.8692678439265;2180.018991453844;2185.3007037747925;2185.726784151981;2187.3000639795273;2098.653722135846;2163.9134434622597;2167.3172950520616;2167.3497950614833;2168.024389024937;2113.9894300528554;2143.560570083137;2163.9134434622597;2164.448065743241;2170.5333353329033;2028.5942811437624;2039.377989713137;2055.9486012849648;2056.28030189434;2059.855810093294;7315.926840731631;7371.778846634609;7383.187849336568;7384.52000619958;7385;4217.852375166885;4279.015826359955;4306.5478124796755;4307.181635489278;4310.202612516695;2840.4745122152467;2902.3614804742924;2934.413117376533;2940.9852950735108;2952.1586347890748;970.752458123174;980.7155924781805;992.4888682328607;1061.9044286014218;1073.4579037586047;9625.903740962642;9631.277654175965;9650.08324209206;9672.468014259213;9680.273979451498;3710.591834898159;3765.9246815063543;3785.981070094632;3808.1431677872256;3830.693544516432;8321.500709957421;8357.874631880526;8384.119667434832;8392.874106888401;8397.6221070052;4198.076423186894;4201.852935147316;4213.873583792491;4230.534641189467;4230.555791641895;3818.1218319786603;3842.731008829411;3847.3459511883048;3851.056491159684;3852.7303088783515;3200.9679903201136;3238.498032804919;3252.837358132084;3324.0194142727955;3403.5235067090625;1081.729567608098;1102.4377567440504;1104.1994553948323;1109.9167562432688;1112.8775834658181;1022.4274406332329;1084.8264277715527;1269.6381531263546;1327.8406591209116;1345.0382976171888;7041.929580704127;7115.75094871677;7120.964395177991;7123.786286411416;7138.892916606255;1070.2882583082164;1077.8275475923815;1095.0856035210688;1095.6274866545255;1099.9481622275493;5551.167324901297;5621.409751976065;5632.5775566831835;5633.464820842013;5641.435856414408;8649.308055355556;8667.306615470874;8712.477251364939;8777.385583009129;8941.150590693873;8652.956735216283;8824.823503529893;8826.293896488265;8842.867356989651;8855.690050848189;6859.416949559243;6921.8961715574305;6950.200726916368;6979.1973922999505;7053.717851285891;6784.3554862288;6820.624865632438;6823.181218253642;6827.180738311435;6827.283135270924;7592.240775922363;7771.067471903408;7849.843003140019;7867.134615192439;7993.280604745601;7752.41856860749;8023.638936247766;8078.3133433658795;8092.6762929482165;8142.67429302845;6121.4490695837585;6122.7244773984385;6167.167432396569;6226.097215903578;6243.843903902257;6313.810585682437;6424.903626445701;7094.290570942864;7207.783766487014;7241;6613.371729685672;6666.26671066192;6728.529002969745;6814.352636499525;6818.249992500721;6575.342465753386;6647;6693.230278518033;6759.222689390783;6784.491163162881;6787.083743694538;6823.420009299067;6827.6244806536115;6835.760748373982;6840.247572767091;6175.938240617536;6290.622562646256;6337.081123237197;6337.176167098248;6338.461230795434;6379.6810159490915;6427.3251308611925;6432.35676432353;6439.3238709934785;6445.097686323825 02:00:06 INFO - 2015-12-18 02:00:06,606 DEBUG : BROWSER_OUTPUT: |4;prototype.html;327.74927180706754;328.23193726679597;333.0209184996111;333.98664053437864;338.42974587819526;5966.970165149173;5982.162497250383;6012;6022.638641681502;6033.034714445689;5661;5769.394213607574;5778.075507918734;5900.498457631106;5945.940540594593;4525.954740452603;4546.090781843644;4566.10960862632;4584.266517357223;4595.770211489429;4340.414044104053;4532.09358128374;4570.360149579062;4570.862874113782;4583.862484125465;4391.802368893392;4420.3369494575745;4456.8885777855485;4474.657602719188;4544.068465964486;4510.864674059767;4511.368408422823;4514.887127821798;4520.751358675255;4525.804984582475;3951.269015232191;3985.940210896839;3991.840326386941;3993.28120938231;3995.200959808021;5547.805826796042;5644.774209031634;5653.632513886625;5656.519195868356;5659.51894089003;5315.946840531584;5324.866878328034;5330.813421530266;5331.2003199519995;5333;6277.121203031579;6281.057841323793;6284.685765711696;6287.654179020152;6291.119243305895;4463.531329210451;4464.553544645542;4467.508574056851;4467.530909254547;4477.3731677565165;6323.74705011799;6508.967455162694;6529.706163222666;6549.279579246279;6559.737610495575;4536.138133754576;4558.566936141061;4558.908821823611;4559.224931761609;4560.452745670541;4617.953820461819;4619.6073333766335;4622.329762184531;4626.398568186114;4626.514216007338;5293.338332708411;5299.072662284085;5301.522862942276;5305.708186049727;5307.8142265021315;6175.567710260329;6349.936500634934;6357.141785858942;6372;6373.203349581302;1554.230655825351;1578.7316156253464;1580.9051456912623;1580.91304978225;1581.0118675827607;1026.2508368890751;1032.550840384435;1041.146260066738;1055.8205105131992;1062;6077.75688972445;6083.878322433527;6083.969580152071;6085.513158947362;6093.451589356979;6511.479081673455;6513.478921686254;6524.412802847766;6524.836879077966;6541.640209788412;5915.231019967377;6006.069059295816;6085.330613632497;6143.600665956698;6147.84630384244;3537.5931767846514;3546.946795798065;3552.502649629054;3553.68016878477;3557.288542291552;6796.966015169992;6812.455003599799;6822.11312529368;6828.6927088281145;6835.043093966849;6607.933920660828;6770.966145169341;6771.627560484122;6777.1189745332795;6780.8304792379595;6804.285550017276;6826.078479405217;6827.931720682829;6828.556143850634;6829.078074460083;6575.80272591823;6578.144841170617;6578.375054369827;6580.670966451754;6585.670716464253;6340.1440805490665;6490.740370385131;6504.544681872224;6508.219013718384;6511.186101737283;6816.897746533707;6817.147856517935;6819.215790184192;6828;6828.044073829568;4461.420015397977;4506.684532082854;4507.368968344369;4509.030558429953;4509.075639493962;6389.584676995981;6514;6556.868862622626;6596.80209593713;6636.634985075867;6372.936270637234;6396.392342727433;6416.839579010562;6430.2926678066315;6447.580907241015;6425.646589437626;6432.614043157426;6440.452561532322;6441;6442.35576442352;6173.969130154321;6309.842253943688;6313.084602732486;6313.747450101944;6318.589291696025;6419.839504012437;6433.967830160819;6439.7424103035355;6439.8068057958335;6449.451796597342;6282.089097080806;6302.338254483397;6307.3377295383325;6308.463780578519;6311.400416960381 02:00:06 INFO - 2015-12-18 02:00:06,607 DEBUG : BROWSER_OUTPUT: |5;yui.html;701.6772284749015;772.5403384985933;835.1690068381961;851.9275861551768;877.9604917778702;13510.864891351084;13714.245716485602;13724.656883577916;13738.793918091236;13748.656283592914;12463.314517701523;12531.624051278453;12545.059120565948;12574.434150463228;12577.811332829991;686.5503095472449;785.19909692114;796.0487217774762;796.8605494038549;797.4696826610298;690.1649004704313;810.631162820915;819.7622689420061;824.1881746479713;829.340674164041;799.1050023973129;830.9169083091703;849.7535714642746;850.8596081646521;850.9829803403928;704.102269606251;710.3784188834769;845.9746207613781;847.2713466418875;848.9235968762811;614.4531367083299;618.0605479670875;620.3889169168366;622.0979579609584;623.51988968494;11877.940610296979;11940.522379104825;12080.939595301967;12112.697182570419;12116.878831211663;11631.825522617168;11836.053115750805;11938.701532461671;12220.205686630341;12505;9996.200303975736;10009.099181073665;10045.274617761419;10075.848862267072;10439.686809395731;3551.94672079919;3565.6969157621375;3568.6431356864364;3589.192431702872;3728.5525736911472;42930.57069429297;43014.569854301684;43219.35170972438;43311.78344108291;43322.56677433217;9536.761580960392;9547.188488978376;9625.51872406377;9690.612375505041;9841.655542056136;17547.21037553313;17649.294028238983;17657.322554357317;17661.205245763973;17672.646547068987;7002.579845209304;7067.57594544329;7128.786136415916;7167.641617919083;7362.8527429451115;4090.4886889138857;4125.50493940729;4147.958520414818;4169.041120542292;4235.470566179228;2937.794354395172;2956.1722717639095;2966.8664910079096;2966.9851650741607;2974.3307755755213;514.6371807875514;532.1857557936363;533.6237952243658;533.8345113014977;540.4730387871793;613.8557439001831;638.4381744065192;638.47644931156;663.0849427789619;680.7413182990531;8144.796380090545;8222.671093156327;8345.248927596545;8478.23695867375;8487;529.8569386265686;559.1668414063017;631.5989346764745;657.9374959378852;710.6588837358097;3843.8270277837564;3854.402567602026;4102.835886564504;4125.546189919107;4151.8546850860075;55709.1643625346;56577;56805.431945680844;56874.43125568774;56957.14564281539;48336.27495587569;49210;49771;49863.75068124636;50037.49962500401;45126.774366128615;45572;45842.541574583825;46114;46282.537174627825;8117.391195660467;8134.216564060026;8159.3880458967005;8173;8301.377396695152;33925;34188.82905585456;34265.65734342625;34741.47887781635;35443.468347975315;40114.1977160461;43849;44147.77926110478;44744.77627611841;45176.32235516404;10888.51001704941;10950.616728414467;11073.778524429305;11168.162387820783;11353.886461135613;10671;10842;11287.604933827277;11724.472398742248;11823.704407389883;9909.306348555532;10205.183585313305;10263.332883362558;11524.366159861289;11634.70913227176;11152.498137583665;11234.494447749707;11365;11665.941670291595;11755.235909665844;9116.817663646823;10134.783825940935;10790.298630588986;10911.181661375269;11529.481173347387;9433.386829856037;9471.47906865129;9905.55425005862;10244.641437549948;10250.58997640086;9134.908650913672;9521.238300936047;9531.428114313163;9641.469719165514;9697.903020969983 02:00:06 INFO - 2015-12-18 02:00:06,607 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:00:06 INFO - 2015-12-18 02:00:06,607 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:00:06 INFO - 2015-12-18 02:00:06,607 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,827 02:00:06 INFO - 2015-12-18 02:00:06,607 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:00:06 INFO - 2015-12-18 02:00:06,607 DEBUG : BROWSER_OUTPUT: __startTimestamp1450432806596__endTimestamp 02:00:06 INFO - 2015-12-18 02:00:06,607 DEBUG : BROWSER_OUTPUT: 02:00:06 INFO - 2015-12-18 02:00:06,607 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:00:06 INFO - 2015-12-18 02:00:06,607 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:00:06 INFO - 2015-12-18 02:00:06,607 DEBUG : BROWSER_OUTPUT: 02:00:06 INFO - 2015-12-18 02:00:06,607 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5258.81 Median:5465.21 stddev:581.43 (10.6%) stddev-sans-first:558.12 02:00:06 INFO - 2015-12-18 02:00:06,609 DEBUG : BROWSER_OUTPUT: Values: 3104.8 3176.0 3196.1 3205.5 3224.1 5082.8 5177.8 5222.7 5300.0 5334.7 5119.7 5134.7 5195.6 5196.6 5200.8 4660.0 4792.8 4797.3 4886.7 4950.3 4718.5 4808.3 4877.6 4879.3 4997.7 4715.7 4770.2 4777.3 4786.6 4789.2 4809.4 4812.1 4823.7 4840.8 4878.6 4714.3 4793.4 4819.9 4822.6 4837.1 5025.3 5025.8 5045.0 5057.3 5072.0 5568.8 5646.9 5652.7 5653.8 5654.3 5722.1 5730.9 5748.6 5754.3 5775.8 5355.4 5355.8 5357.5 5357.7 5368.2 5511.8 5645.8 5724.3 5788.1 5797.2 5538.3 5578.2 5581.7 5588.0 5594.0 5713.6 5732.4 5733.4 5737.4 5741.3 5497.4 5635.5 5641.3 5693.5 5698.7 5521.0 5578.7 5593.3 5594.6 5638.2 4395.4 4412.4 4412.6 4414.5 4452.6 3830.2 3844.4 3934.3 3944.3 3973.0 5346.5 5353.4 5354.6 5357.1 5375.6 5660.9 5663.9 5667.9 5684.7 5688.6 5265.6 5315.7 5362.3 5366.6 5367.3 4876.4 4891.1 4920.6 4923.5 4962.7 5888.0 5893.4 5896.5 5899.8 5906.4 5443.6 5602.2 5607.0 5696.3 5753.6 5895.9 5964.9 5971.5 6013.7 6015.2 5597.1 5598.5 5601.2 5612.8 5615.6 5501.8 5605.6 5688.1 5688.2 5692.6 5466.4 5540.5 5555.7 5592.2 5636.9 5520.4 5537.0 5545.4 5546.5 5551.7 5296.4 5407.7 5462.6 5464.8 5475.3 5520.4 5563.9 5564.5 5601.1 5613.7 5443.8 5463.2 5465.2 5470.1 5472.9 02:00:06 INFO - 2015-12-18 02:00:06,609 DEBUG : BROWSER_OUTPUT: 02:00:06 INFO - 2015-12-18 02:00:06,609 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46213.08 Median:31376.79 stddev:80951.09 (258.0%) stddev-sans-first:81105.69 02:00:06 INFO - 2015-12-18 02:00:06,609 DEBUG : BROWSER_OUTPUT: Values: 585.8 586.3 598.2 610.5 622.5 29373.6 36609.0 37044.6 37106.8 37447.3 41852.4 42049.2 42250.4 42483.6 42546.6 7346.7 8603.8 8770.3 8776.8 8777.1 7504.4 7526.8 10349.3 10486.1 10487.8 10315.3 10446.8 10466.1 10483.3 10487.4 7606.7 7834.9 10292.4 10408.7 10414.1 10031.9 10244.3 10244.8 10248.8 10252.1 35193.8 35477.0 35602.0 35620.6 35638.6 3207.7 3503.0 3657.0 3747.2 3978.9 29235.3 29552.4 29901.0 30332.4 30979.8 3909.3 3919.3 3974.0 4049.9 4054.0 263357.0 263513.0 263750.0 264140.0 264846.0 51828.2 52896.5 54425.0 54604.0 55248.0 54649.7 54944.0 55446.0 55484.4 55502.2 12908.1 13064.2 13078.0 13085.5 13118.5 9437.6 9451.1 9469.9 9497.7 9501.8 18064.2 18125.2 18136.9 18238.9 18249.0 7075.8 7367.9 7424.9 7497.9 7604.9 972.4 1001.6 1007.0 1092.2 1098.7 27505.2 27540.0 27645.7 27859.1 28125.3 1028.3 1037.8 1049.8 1087.8 1150.3 14410.1 14458.6 14618.4 14645.8 14769.0 299627.0 300592.0 303678.0 304196.0 304705.0 50531.2 50746.5 50766.2 50800.5 50811.0 1305.2 1335.0 1347.2 1353.3 1356.7 26964.2 27362.9 28070.3 28266.9 28310.6 40685.4 43559.6 43860.3 43961.8 43964.8 213318.0 372510.0 380546.0 381789.0 382275.0 29616.3 30161.2 30225.4 30229.1 30240.5 41034.4 41691.8 41755.0 42606.0 42628.8 34963.3 35186.5 35377.8 35649.3 36360.8 34208.7 35045.6 35412.6 36020.8 36349.8 30337.7 30946.7 30970.8 31357.4 31396.2 26764.0 28585.0 30571.2 31276.4 31333.0 23298.3 23513.0 23860.0 23942.9 24000.0 02:00:06 INFO - 2015-12-18 02:00:06,609 DEBUG : BROWSER_OUTPUT: 02:00:06 INFO - 2015-12-18 02:00:06,609 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28089.48 Median:19846.66 stddev:88885.06 (447.9%) stddev-sans-first:89110.00 02:00:06 INFO - 2015-12-18 02:00:06,609 DEBUG : BROWSER_OUTPUT: Values: 351.4 352.9 353.9 354.2 357.5 13792.3 14161.9 17155.9 17524.6 18181.5 10256.3 12674.2 12833.8 14640.4 14667.6 4918.3 5015.4 5027.6 5027.8 5042.0 3694.3 4967.9 4986.2 4991.4 5028.6 5503.6 5549.2 5568.8 5570.1 5572.1 5498.3 5506.8 5964.0 5985.5 5987.8 5332.3 5338.8 5344.4 5348.6 5351.4 13571.5 15373.2 15382.2 15412.2 16970.6 1980.8 1991.1 2029.5 2049.0 2101.5 9652.1 10125.6 12320.0 12771.6 13305.5 1780.1 1786.6 1813.3 1824.9 1849.1 57114.4 57691.4 57979.7 59337.4 60641.7 9823.7 10176.7 10324.8 10387.9 10445.8 13582.1 13585.0 13585.7 13606.1 13607.0 6890.2 6961.3 7001.8 7016.6 7054.4 6555.4 6570.1 6601.1 6602.7 6624.1 4462.5 4494.6 4515.5 4548.8 4549.4 1731.1 1749.2 1789.2 1813.0 1833.0 440.8 832.5 869.7 902.4 969.3 10555.8 10596.5 10729.5 11056.7 11227.8 410.2 455.0 458.2 462.3 467.2 6014.1 6174.8 6183.8 6284.3 6287.5 505025.0 532644.0 553620.0 560734.0 563281.0 80006.6 80516.6 80794.0 81088.6 81261.0 483.4 488.7 489.1 489.8 490.3 10625.4 10631.5 10649.7 10760.7 14902.8 32517.7 32593.2 34201.1 34280.5 35999.0 41234.8 42935.8 43000.4 43113.6 45391.3 9862.9 9973.9 10109.8 10170.3 10207.3 11959.2 14184.6 17116.5 17264.5 18051.6 14598.2 14698.6 15035.5 15234.5 15321.6 14042.2 14181.4 14380.0 15004.9 15049.3 11043.6 14076.9 15023.5 15316.8 15577.8 9340.8 9405.7 9698.3 9706.7 9718.7 10091.4 10188.4 11510.4 14054.7 14155.3 02:00:06 INFO - 2015-12-18 02:00:06,609 DEBUG : BROWSER_OUTPUT: 02:00:06 INFO - 2015-12-18 02:00:06,609 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5127.59 Median:6325.45 stddev:2633.40 (41.6%) stddev-sans-first:2626.82 02:00:06 INFO - 2015-12-18 02:00:06,609 DEBUG : BROWSER_OUTPUT: Values: 1519.6 1631.5 1680.7 1704.9 1708.0 6266.0 7234.3 7434.6 7468.9 7490.8 7110.9 7217.2 7229.7 7235.8 7237.8 1938.6 1971.3 2020.3 2053.5 2137.9 2178.9 2180.0 2185.3 2185.7 2187.3 2098.7 2163.9 2167.3 2167.3 2168.0 2114.0 2143.6 2163.9 2164.4 2170.5 2028.6 2039.4 2055.9 2056.3 2059.9 7315.9 7371.8 7383.2 7384.5 7385.0 4217.9 4279.0 4306.5 4307.2 4310.2 2840.5 2902.4 2934.4 2941.0 2952.2 970.8 980.7 992.5 1061.9 1073.5 9625.9 9631.3 9650.1 9672.5 9680.3 3710.6 3765.9 3786.0 3808.1 3830.7 8321.5 8357.9 8384.1 8392.9 8397.6 4198.1 4201.9 4213.9 4230.5 4230.6 3818.1 3842.7 3847.3 3851.1 3852.7 3201.0 3238.5 3252.8 3324.0 3403.5 1081.7 1102.4 1104.2 1109.9 1112.9 1022.4 1084.8 1269.6 1327.8 1345.0 7041.9 7115.8 7121.0 7123.8 7138.9 1070.3 1077.8 1095.1 1095.6 1099.9 5551.2 5621.4 5632.6 5633.5 5641.4 8649.3 8667.3 8712.5 8777.4 8941.2 8653.0 8824.8 8826.3 8842.9 8855.7 6859.4 6921.9 6950.2 6979.2 7053.7 6784.4 6820.6 6823.2 6827.2 6827.3 7592.2 7771.1 7849.8 7867.1 7993.3 7752.4 8023.6 8078.3 8092.7 8142.7 6121.4 6122.7 6167.2 6226.1 6243.8 6313.8 6424.9 7094.3 7207.8 7241.0 6613.4 6666.3 6728.5 6814.4 6818.2 6575.3 6647.0 6693.2 6759.2 6784.5 6787.1 6823.4 6827.6 6835.8 6840.2 6175.9 6290.6 6337.1 6337.2 6338.5 6379.7 6427.3 6432.4 6439.3 6445.1 02:00:06 INFO - 2015-12-18 02:00:06,609 DEBUG : BROWSER_OUTPUT: 02:00:06 INFO - 2015-12-18 02:00:06,610 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5311.17 Median:6027.84 stddev:1609.33 (26.7%) stddev-sans-first:1569.78 02:00:06 INFO - 2015-12-18 02:00:06,611 DEBUG : BROWSER_OUTPUT: Values: 327.7 328.2 333.0 334.0 338.4 5967.0 5982.2 6012.0 6022.6 6033.0 5661.0 5769.4 5778.1 5900.5 5945.9 4526.0 4546.1 4566.1 4584.3 4595.8 4340.4 4532.1 4570.4 4570.9 4583.9 4391.8 4420.3 4456.9 4474.7 4544.1 4510.9 4511.4 4514.9 4520.8 4525.8 3951.3 3985.9 3991.8 3993.3 3995.2 5547.8 5644.8 5653.6 5656.5 5659.5 5315.9 5324.9 5330.8 5331.2 5333.0 6277.1 6281.1 6284.7 6287.7 6291.1 4463.5 4464.6 4467.5 4467.5 4477.4 6323.7 6509.0 6529.7 6549.3 6559.7 4536.1 4558.6 4558.9 4559.2 4560.5 4618.0 4619.6 4622.3 4626.4 4626.5 5293.3 5299.1 5301.5 5305.7 5307.8 6175.6 6349.9 6357.1 6372.0 6373.2 1554.2 1578.7 1580.9 1580.9 1581.0 1026.3 1032.6 1041.1 1055.8 1062.0 6077.8 6083.9 6084.0 6085.5 6093.5 6511.5 6513.5 6524.4 6524.8 6541.6 5915.2 6006.1 6085.3 6143.6 6147.8 3537.6 3546.9 3552.5 3553.7 3557.3 6797.0 6812.5 6822.1 6828.7 6835.0 6607.9 6771.0 6771.6 6777.1 6780.8 6804.3 6826.1 6827.9 6828.6 6829.1 6575.8 6578.1 6578.4 6580.7 6585.7 6340.1 6490.7 6504.5 6508.2 6511.2 6816.9 6817.1 6819.2 6828.0 6828.0 4461.4 4506.7 4507.4 4509.0 4509.1 6389.6 6514.0 6556.9 6596.8 6636.6 6372.9 6396.4 6416.8 6430.3 6447.6 6425.6 6432.6 6440.5 6441.0 6442.4 6174.0 6309.8 6313.1 6313.7 6318.6 6419.8 6434.0 6439.7 6439.8 6449.5 6282.1 6302.3 6307.3 6308.5 6311.4 02:00:06 INFO - 2015-12-18 02:00:06,611 DEBUG : BROWSER_OUTPUT: 02:00:06 INFO - 2015-12-18 02:00:06,611 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13331.70 Median:45707.27 stddev:15396.77 (33.7%) stddev-sans-first:15410.75 02:00:06 INFO - 2015-12-18 02:00:06,611 DEBUG : BROWSER_OUTPUT: Values: 701.7 772.5 835.2 851.9 878.0 13510.9 13714.2 13724.7 13738.8 13748.7 12463.3 12531.6 12545.1 12574.4 12577.8 686.6 785.2 796.0 796.9 797.5 690.2 810.6 819.8 824.2 829.3 799.1 830.9 849.8 850.9 851.0 704.1 710.4 846.0 847.3 848.9 614.5 618.1 620.4 622.1 623.5 11877.9 11940.5 12080.9 12112.7 12116.9 11631.8 11836.1 11938.7 12220.2 12505.0 9996.2 10009.1 10045.3 10075.8 10439.7 3551.9 3565.7 3568.6 3589.2 3728.6 42930.6 43014.6 43219.4 43311.8 43322.6 9536.8 9547.2 9625.5 9690.6 9841.7 17547.2 17649.3 17657.3 17661.2 17672.6 7002.6 7067.6 7128.8 7167.6 7362.9 4090.5 4125.5 4148.0 4169.0 4235.5 2937.8 2956.2 2966.9 2967.0 2974.3 514.6 532.2 533.6 533.8 540.5 613.9 638.4 638.5 663.1 680.7 8144.8 8222.7 8345.2 8478.2 8487.0 529.9 559.2 631.6 657.9 710.7 3843.8 3854.4 4102.8 4125.5 4151.9 55709.2 56577.0 56805.4 56874.4 56957.1 48336.3 49210.0 49771.0 49863.8 50037.5 45126.8 45572.0 45842.5 46114.0 46282.5 8117.4 8134.2 8159.4 8173.0 8301.4 33925.0 34188.8 34265.7 34741.5 35443.5 40114.2 43849.0 44147.8 44744.8 45176.3 10888.5 10950.6 11073.8 11168.2 11353.9 10671.0 10842.0 11287.6 11724.5 11823.7 9909.3 10205.2 10263.3 11524.4 11634.7 11152.5 11234.5 11365.0 11665.9 11755.2 9116.8 10134.8 10790.3 10911.2 11529.5 9433.4 9471.5 9905.6 10244.6 10250.6 9134.9 9521.2 9531.4 9641.5 9697.9 02:00:06 INFO - 2015-12-18 02:00:06,611 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:00:06 INFO - 2015-12-18 02:00:06,611 DEBUG : BROWSER_OUTPUT: 02:00:07 INFO - 2015-12-18 02:00:07,465 INFO : Browser exited with error code: 0 02:00:07 INFO - 2015-12-18 02:00:07,486 INFO : Completed test dromaeo_css (00:18:34) 02:00:07 INFO - 2015-12-18 02:00:07,486 INFO : Starting test kraken 02:00:07 INFO - 2015-12-18 02:00:07,486 DEBUG : operating with platform_type : linux_ 02:00:07 INFO - 2015-12-18 02:00:07,486 INFO : Initialising browser for kraken test... 02:00:07 INFO - 2015-12-18 02:00:07,493 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnljsMK/profile http://localhost:49530/getInfo.html 02:00:12 INFO - 2015-12-18 02:00:12,434 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:00:12 INFO - 2015-12-18 02:00:12,434 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:00:12 INFO - 2015-12-18 02:00:12,434 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:00:12 INFO - 2015-12-18 02:00:12,434 DEBUG : BROWSER_OUTPUT: __metrics 02:00:12 INFO - 2015-12-18 02:00:12,531 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] 02:00:12 INFO - 2015-12-18 02:00:12,595 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] 02:00:13 INFO - 2015-12-18 02:00:13,498 INFO : Browser initialized. 02:00:13 INFO - 2015-12-18 02:00:13,498 INFO : Running cycle 1/1 for kraken test... 02:00:13 INFO - 2015-12-18 02:00:13,498 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnljsMK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:00:25 INFO - 2015-12-18 02:00:25,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 150360064 02:00:25 INFO - 2015-12-18 02:00:25,281 DEBUG : BROWSER_OUTPUT: 02:00:27 INFO - 2015-12-18 02:00:27,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49530/tests/kraken/driver.html?testName=audio-beat-detection) 02:00:28 INFO - 2015-12-18 02:00:28,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 186843136 02:00:28 INFO - 2015-12-18 02:00:28,358 DEBUG : BROWSER_OUTPUT: 02:00:30 INFO - 2015-12-18 02:00:30,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49530/tests/kraken/driver.html?testName=audio-dft) 02:00:31 INFO - 2015-12-18 02:00:31,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 175284224 02:00:31 INFO - 2015-12-18 02:00:31,494 DEBUG : BROWSER_OUTPUT: 02:00:34 INFO - 2015-12-18 02:00:34,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49530/tests/kraken/driver.html?testName=audio-fft) 02:00:34 INFO - 2015-12-18 02:00:34,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 161173504 02:00:34 INFO - 2015-12-18 02:00:34,920 DEBUG : BROWSER_OUTPUT: 02:00:36 INFO - 2015-12-18 02:00:36,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49530/tests/kraken/driver.html?testName=audio-oscillator) 02:00:37 INFO - 2015-12-18 02:00:37,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 162557952 02:00:37 INFO - 2015-12-18 02:00:37,474 DEBUG : BROWSER_OUTPUT: 02:00:39 INFO - 2015-12-18 02:00:39,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49530/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:00:40 INFO - 2015-12-18 02:00:40,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 165134336 02:00:40 INFO - 2015-12-18 02:00:40,229 DEBUG : BROWSER_OUTPUT: 02:00:43 INFO - 2015-12-18 02:00:43,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49530/tests/kraken/driver.html?testName=imaging-darkroom) 02:00:43 INFO - 2015-12-18 02:00:43,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 165474304 02:00:43 INFO - 2015-12-18 02:00:43,673 DEBUG : BROWSER_OUTPUT: 02:00:47 INFO - 2015-12-18 02:00:47,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49530/tests/kraken/driver.html?testName=imaging-desaturate) 02:00:47 INFO - 2015-12-18 02:00:47,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 164986880 02:00:47 INFO - 2015-12-18 02:00:47,702 DEBUG : BROWSER_OUTPUT: 02:00:50 INFO - 2015-12-18 02:00:50,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49530/tests/kraken/driver.html?testName=json-parse-financial) 02:00:50 INFO - 2015-12-18 02:00:50,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 166580224 02:00:50 INFO - 2015-12-18 02:00:50,978 DEBUG : BROWSER_OUTPUT: 02:00:52 INFO - 2015-12-18 02:00:52,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49530/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:00:53 INFO - 2015-12-18 02:00:53,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 179023872 02:00:53 INFO - 2015-12-18 02:00:53,144 DEBUG : BROWSER_OUTPUT: 02:00:54 INFO - 2015-12-18 02:00:54,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:00:55 INFO - 2015-12-18 02:00:55,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 174952448 02:00:55 INFO - 2015-12-18 02:00:55,528 DEBUG : BROWSER_OUTPUT: 02:00:57 INFO - 2015-12-18 02:00:57,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:00:58 INFO - 2015-12-18 02:00:58,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 186023936 02:00:58 INFO - 2015-12-18 02:00:58,219 DEBUG : BROWSER_OUTPUT: 02:01:00 INFO - 2015-12-18 02:01:00,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:01:01 INFO - 2015-12-18 02:01:01,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 194699264 02:01:01 INFO - 2015-12-18 02:01:01,205 DEBUG : BROWSER_OUTPUT: 02:01:03 INFO - 2015-12-18 02:01:03,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:01:04 INFO - 2015-12-18 02:01:04,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 191598592 02:01:04 INFO - 2015-12-18 02:01:04,373 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,062 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49530/tests/kraken/driver.html?testName=ai-astar) 02:01:06 INFO - 2015-12-18 02:01:06,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 250871808 02:01:06 INFO - 2015-12-18 02:01:06,306 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,309 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:01:06 INFO - 2015-12-18 02:01:06,309 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:01:06 INFO - 2015-12-18 02:01:06,310 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:01:06 INFO - 2015-12-18 02:01:06,310 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:01:06 INFO - 2015-12-18 02:01:06,310 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;105;111;113;113;101;110;112;118 02:01:06 INFO - 2015-12-18 02:01:06,310 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;123;146;158;129;149;146;125;166;123 02:01:06 INFO - 2015-12-18 02:01:06,311 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;162;161;161;159;160;161;161;161 02:01:06 INFO - 2015-12-18 02:01:06,311 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;80;97;70;78;71;119;91;71 02:01:06 INFO - 2015-12-18 02:01:06,311 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;143;93;94;94;139;93;93;133 02:01:06 INFO - 2015-12-18 02:01:06,311 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;110;109;109;110;110 02:01:06 INFO - 2015-12-18 02:01:06,311 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;145;146;145;145;145;146;145 02:01:06 INFO - 2015-12-18 02:01:06,312 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;95;96;95;96;95 02:01:06 INFO - 2015-12-18 02:01:06,312 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;58;58;59;59;59;58;71;57;57 02:01:06 INFO - 2015-12-18 02:01:06,312 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;67;68;68;68;68;68;68;69 02:01:06 INFO - 2015-12-18 02:01:06,312 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;88;87;87;86;87;88;87;94;88 02:01:06 INFO - 2015-12-18 02:01:06,313 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;118;126;116;117;119;121;115;121;124 02:01:06 INFO - 2015-12-18 02:01:06,313 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;154;143;151;155;147;157;157;153;144 02:01:06 INFO - 2015-12-18 02:01:06,313 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;70;70;70;69;70;69;68;68 02:01:06 INFO - 2015-12-18 02:01:06,313 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:01:06 INFO - 2015-12-18 02:01:06,314 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:01:06 INFO - 2015-12-18 02:01:06,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,929 02:01:06 INFO - 2015-12-18 02:01:06,314 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:01:06 INFO - 2015-12-18 02:01:06,314 DEBUG : BROWSER_OUTPUT: __startTimestamp1450432866307__endTimestamp 02:01:06 INFO - 2015-12-18 02:01:06,315 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,316 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:01:06 INFO - 2015-12-18 02:01:06,316 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:01:06 INFO - 2015-12-18 02:01:06,316 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,316 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:4.65 (4.1%) stddev-sans-first:4.93 02:01:06 INFO - 2015-12-18 02:01:06,317 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 105.0 111.0 113.0 113.0 101.0 110.0 112.0 118.0 02:01:06 INFO - 2015-12-18 02:01:06,317 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,317 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.50 Median:147.50 stddev:16.38 (11.1%) stddev-sans-first:16.10 02:01:06 INFO - 2015-12-18 02:01:06,317 DEBUG : BROWSER_OUTPUT: Values: 160.0 123.0 146.0 158.0 129.0 149.0 146.0 125.0 166.0 123.0 02:01:06 INFO - 2015-12-18 02:01:06,317 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,317 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 02:01:06 INFO - 2015-12-18 02:01:06,317 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 162.0 161.0 161.0 159.0 160.0 161.0 161.0 161.0 02:01:06 INFO - 2015-12-18 02:01:06,317 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,318 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.90 Median:74.50 stddev:16.07 (21.6%) stddev-sans-first:16.55 02:01:06 INFO - 2015-12-18 02:01:06,318 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 80.0 97.0 70.0 78.0 71.0 119.0 91.0 71.0 02:01:06 INFO - 2015-12-18 02:01:06,318 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,318 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:93.00 stddev:21.82 (23.5%) stddev-sans-first:22.56 02:01:06 INFO - 2015-12-18 02:01:06,318 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 143.0 93.0 94.0 94.0 139.0 93.0 93.0 133.0 02:01:06 INFO - 2015-12-18 02:01:06,318 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,318 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 02:01:06 INFO - 2015-12-18 02:01:06,318 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 110.0 02:01:06 INFO - 2015-12-18 02:01:06,318 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,319 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 02:01:06 INFO - 2015-12-18 02:01:06,319 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 02:01:06 INFO - 2015-12-18 02:01:06,319 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,319 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:01:06 INFO - 2015-12-18 02:01:06,319 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 02:01:06 INFO - 2015-12-18 02:01:06,319 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,319 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.60 Median:59.00 stddev:4.12 (7.0%) stddev-sans-first:4.36 02:01:06 INFO - 2015-12-18 02:01:06,319 DEBUG : BROWSER_OUTPUT: Values: 60.0 58.0 58.0 59.0 59.0 59.0 58.0 71.0 57.0 57.0 02:01:06 INFO - 2015-12-18 02:01:06,319 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,320 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.60 02:01:06 INFO - 2015-12-18 02:01:06,320 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 67.0 68.0 68.0 68.0 68.0 68.0 68.0 69.0 02:01:06 INFO - 2015-12-18 02:01:06,320 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,320 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:87.50 stddev:2.23 (2.6%) stddev-sans-first:2.35 02:01:06 INFO - 2015-12-18 02:01:06,320 DEBUG : BROWSER_OUTPUT: Values: 87.0 88.0 87.0 87.0 86.0 87.0 88.0 87.0 94.0 88.0 02:01:06 INFO - 2015-12-18 02:01:06,320 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,320 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:121.00 stddev:3.54 (2.9%) stddev-sans-first:3.67 02:01:06 INFO - 2015-12-18 02:01:06,320 DEBUG : BROWSER_OUTPUT: Values: 122.0 118.0 126.0 116.0 117.0 119.0 121.0 115.0 121.0 124.0 02:01:06 INFO - 2015-12-18 02:01:06,320 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,320 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:153.50 stddev:5.83 (3.8%) stddev-sans-first:5.36 02:01:06 INFO - 2015-12-18 02:01:06,321 DEBUG : BROWSER_OUTPUT: Values: 142.0 154.0 143.0 151.0 155.0 147.0 157.0 157.0 153.0 144.0 02:01:06 INFO - 2015-12-18 02:01:06,321 DEBUG : BROWSER_OUTPUT: 02:01:06 INFO - 2015-12-18 02:01:06,321 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:0.84 (1.2%) stddev-sans-first:0.87 02:01:06 INFO - 2015-12-18 02:01:06,321 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 70.0 70.0 69.0 70.0 69.0 68.0 68.0 02:01:06 INFO - 2015-12-18 02:01:06,321 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:01:06 INFO - 2015-12-18 02:01:06,321 DEBUG : BROWSER_OUTPUT: 02:01:07 INFO - 2015-12-18 02:01:07,337 INFO : Browser exited with error code: 0 02:01:07 INFO - 2015-12-18 02:01:07,390 INFO : Completed test kraken (00:00:59) 02:01:07 INFO - 2015-12-18 02:01:07,390 INFO : Starting test v8_7 02:01:07 INFO - 2015-12-18 02:01:07,390 DEBUG : operating with platform_type : linux_ 02:01:07 INFO - 2015-12-18 02:01:07,390 INFO : Initialising browser for v8_7 test... 02:01:07 INFO - 2015-12-18 02:01:07,397 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO9ME6Q/profile http://localhost:49530/getInfo.html 02:01:12 INFO - 2015-12-18 02:01:12,386 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:01:12 INFO - 2015-12-18 02:01:12,386 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:01:12 INFO - 2015-12-18 02:01:12,386 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:01:12 INFO - 2015-12-18 02:01:12,386 DEBUG : BROWSER_OUTPUT: __metrics 02:01:12 INFO - 2015-12-18 02:01:12,585 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] 02:01:12 INFO - 2015-12-18 02:01:12,641 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] 02:01:13 INFO - 2015-12-18 02:01:13,716 INFO : Browser initialized. 02:01:13 INFO - 2015-12-18 02:01:13,716 INFO : Running cycle 1/1 for v8_7 test... 02:01:13 INFO - 2015-12-18 02:01:13,716 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO9ME6Q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:01:25 INFO - 2015-12-18 02:01:25,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 150302720 02:01:25 INFO - 2015-12-18 02:01:25,542 DEBUG : BROWSER_OUTPUT: 02:01:46 INFO - 2015-12-18 02:01:46,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49530/tests/v8_7/run.html (next: http://localhost:49530/tests/v8_7/run.html) 02:01:47 INFO - 2015-12-18 02:01:47,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 613384192 02:01:47 INFO - 2015-12-18 02:01:47,172 DEBUG : BROWSER_OUTPUT: 02:01:47 INFO - 2015-12-18 02:01:47,173 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:01:47 INFO - 2015-12-18 02:01:47,173 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:01:47 INFO - 2015-12-18 02:01:47,173 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:01:47 INFO - 2015-12-18 02:01:47,174 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:01:47 INFO - 2015-12-18 02:01:47,174 DEBUG : BROWSER_OUTPUT: |0;Richards;166.11295681063123 02:01:47 INFO - 2015-12-18 02:01:47,174 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.43037497644622 02:01:47 INFO - 2015-12-18 02:01:47,174 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.50490883590464 02:01:47 INFO - 2015-12-18 02:01:47,175 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 02:01:47 INFO - 2015-12-18 02:01:47,175 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1964.6365422396857 02:01:47 INFO - 2015-12-18 02:01:47,175 DEBUG : BROWSER_OUTPUT: |5;Earley;783.6990595611285 02:01:47 INFO - 2015-12-18 02:01:47,176 DEBUG : BROWSER_OUTPUT: |6;Boyer;12550 02:01:47 INFO - 2015-12-18 02:01:47,176 DEBUG : BROWSER_OUTPUT: |7;RegExp;25820.51282051282 02:01:47 INFO - 2015-12-18 02:01:47,176 DEBUG : BROWSER_OUTPUT: |8;Splay;646.606914212548 02:01:47 INFO - 2015-12-18 02:01:47,176 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 02:01:47 INFO - 2015-12-18 02:01:47,177 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:01:47 INFO - 2015-12-18 02:01:47,177 DEBUG : BROWSER_OUTPUT: __startTimestamp1450432907170__endTimestamp 02:01:47 INFO - 2015-12-18 02:01:47,177 DEBUG : BROWSER_OUTPUT: 02:01:47 INFO - 2015-12-18 02:01:47,177 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:01:47 INFO - 2015-12-18 02:01:47,177 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:01:47 INFO - 2015-12-18 02:01:47,178 DEBUG : BROWSER_OUTPUT: 02:01:47 INFO - 2015-12-18 02:01:47,178 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.11 Median:166.11 stddev:0.00 (0.0%) 02:01:47 INFO - 2015-12-18 02:01:47,178 DEBUG : BROWSER_OUTPUT: Values: 166.1 02:01:47 INFO - 2015-12-18 02:01:47,178 DEBUG : BROWSER_OUTPUT: 02:01:47 INFO - 2015-12-18 02:01:47,178 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.43 Median:188.43 stddev:0.00 (0.0%) 02:01:47 INFO - 2015-12-18 02:01:47,178 DEBUG : BROWSER_OUTPUT: Values: 188.4 02:01:47 INFO - 2015-12-18 02:01:47,178 DEBUG : BROWSER_OUTPUT: 02:01:47 INFO - 2015-12-18 02:01:47,178 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 02:01:47 INFO - 2015-12-18 02:01:47,179 DEBUG : BROWSER_OUTPUT: Values: 280.5 02:01:47 INFO - 2015-12-18 02:01:47,179 DEBUG : BROWSER_OUTPUT: 02:01:47 INFO - 2015-12-18 02:01:47,179 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 02:01:47 INFO - 2015-12-18 02:01:47,179 DEBUG : BROWSER_OUTPUT: Values: 5202.1 02:01:47 INFO - 2015-12-18 02:01:47,179 DEBUG : BROWSER_OUTPUT: 02:01:47 INFO - 2015-12-18 02:01:47,179 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1964.64 Median:1964.64 stddev:0.00 (0.0%) 02:01:47 INFO - 2015-12-18 02:01:47,180 DEBUG : BROWSER_OUTPUT: Values: 1964.6 02:01:47 INFO - 2015-12-18 02:01:47,180 DEBUG : BROWSER_OUTPUT: 02:01:47 INFO - 2015-12-18 02:01:47,180 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.70 Median:783.70 stddev:0.00 (0.0%) 02:01:47 INFO - 2015-12-18 02:01:47,180 DEBUG : BROWSER_OUTPUT: Values: 783.7 02:01:47 INFO - 2015-12-18 02:01:47,180 DEBUG : BROWSER_OUTPUT: 02:01:47 INFO - 2015-12-18 02:01:47,180 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12550.00 Median:12550.00 stddev:0.00 (0.0%) 02:01:47 INFO - 2015-12-18 02:01:47,180 DEBUG : BROWSER_OUTPUT: Values: 12550.0 02:01:47 INFO - 2015-12-18 02:01:47,180 DEBUG : BROWSER_OUTPUT: 02:01:47 INFO - 2015-12-18 02:01:47,180 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25820.51 Median:25820.51 stddev:0.00 (0.0%) 02:01:47 INFO - 2015-12-18 02:01:47,180 DEBUG : BROWSER_OUTPUT: Values: 25820.5 02:01:47 INFO - 2015-12-18 02:01:47,181 DEBUG : BROWSER_OUTPUT: 02:01:47 INFO - 2015-12-18 02:01:47,181 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:646.61 Median:646.61 stddev:0.00 (0.0%) 02:01:47 INFO - 2015-12-18 02:01:47,181 DEBUG : BROWSER_OUTPUT: Values: 646.6 02:01:47 INFO - 2015-12-18 02:01:47,181 DEBUG : BROWSER_OUTPUT: 02:01:47 INFO - 2015-12-18 02:01:47,181 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 02:01:47 INFO - 2015-12-18 02:01:47,181 DEBUG : BROWSER_OUTPUT: Values: 4845.4 02:01:47 INFO - 2015-12-18 02:01:47,181 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:01:47 INFO - 2015-12-18 02:01:47,181 DEBUG : BROWSER_OUTPUT: 02:01:48 INFO - 2015-12-18 02:01:48,145 INFO : Browser exited with error code: 0 02:01:48 INFO - 2015-12-18 02:01:48,162 INFO : Completed test v8_7 (00:00:40) 02:01:48 INFO - 2015-12-18 02:01:48,210 INFO : Completed test suite (00:20:15) 02:01:48 INFO - 2015-12-18 02:01:48,210 DEBUG : Working with test: dromaeo_css 02:01:48 INFO - 2015-12-18 02:01:48,210 DEBUG : Generating results file: dromaeo_css 02:01:48 INFO - 2015-12-18 02:01:48,211 DEBUG : Working with test: kraken 02:01:48 INFO - 2015-12-18 02:01:48,211 DEBUG : Generating results file: kraken 02:01:48 INFO - 2015-12-18 02:01:48,212 INFO : javascript benchmark 02:01:48 INFO - 2015-12-18 02:01:48,212 DEBUG : Working with test: v8_7 02:01:48 INFO - 2015-12-18 02:01:48,212 DEBUG : Generating results file: v8_7 02:01:48 INFO - 2015-12-18 02:01:48,212 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:01:48 INFO - 2015-12-18 02:01:48,266 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 02:01:48 INFO - 2015-12-18 02:01:48,266 DEBUG : process_Request line: dromaeo_css 6736.28 graph.html#tests=[[72,201,35]] 02:01:48 INFO - 2015-12-18 02:01:48,266 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:01:48 INFO - 2015-12-18 02:01:48,301 DEBUG : process_Request line: kraken 1507.40 graph.html#tests=[[232,201,35]] 02:01:48 INFO - 2015-12-18 02:01:48,301 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:01:48 INFO - 2015-12-18 02:01:48,332 DEBUG : process_Request line: v8_7 19681.13 graph.html#tests=[[230,201,35]] 02:01:48 INFO - 2015-12-18 02:01:48,333 INFO : javascript benchmark 02:01:48 INFO - 2015-12-18 02:01:48,337 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3104.7826652134354, 3176.047185844249, 3196.0731387897513, 3205.4550726376515, 3224.145601415625, 5082.84751457456, 5177.818776342829, 5222.686638801674, 5300.045991721484, 5334.706591137486, 5119.692818430897, 5134.743262836852, 5195.610329225305, 5196.636235463519, 5200.817971370993, 4659.976700116495, 4792.808287668489, 4797.280407938811, 4886.706797592138, 4950.3069570260195, 4718.528147185289, 4808.278758186282, 4877.585405240558, 4879.316895634614, 4997.6501644884875, 4715.669903106784, 4770.16522108633, 4777.307290442884, 4786.593139583105, 4789.161896668069, 4809.374781278447, 4812.061647978646, 4823.662343635947, 4840.782164802592, 4878.585320247783, 4714.339992401066, 4793.376861008047, 4819.9036019279765, 4822.590079843218, 4837.0809546186465, 5025.271335656346, 5025.773840177201, 5045.0, 5057.2666963290485, 5072.0, 5568.805091821767, 5646.858828529279, 5652.74562644682, 5653.802116925929, 5654.349749778787, 5722.084466485342, 5730.942690573124, 5748.626339287933, 5754.251947246831, 5775.826725198251, 5355.410904800468, 5355.7857685692525, 5357.491038351351, 5357.732113394315, 5368.1679339702405, 5511.751971161227, 5645.830625081254, 5724.255846739898, 5788.0739081746715, 5797.159411885337, 5538.252335934597, 5578.24693666358, 5581.665100093926, 5588.0, 5594.0, 5713.5714821388565, 5732.426757324318, 5733.397993210736, 5737.3688894221605, 5741.282339707536, 5497.422770609109, 5635.464630860061, 5641.294838145232, 5693.459121383462, 5698.715064246771, 5520.951019306319, 5578.665280083208, 5593.328800543961, 5594.580406469531, 5638.182463542763, 4395.384646149541, 4412.426384569985, 4412.602865742098, 4414.536473670282, 4452.577005184502, 3830.195658911604, 3844.4233364995475, 3934.272159650474, 3944.290027794967, 3972.960270397317, 5346.5455436287575, 5353.411124776349, 5354.625176237704, 5357.062514060024, 5375.59683023767, 5660.858478537987, 5663.915041274384, 5667.886642267132, 5684.7157642118555, 5688.601797874192, 5265.552428043583, 5315.73421328932, 5362.276092727432, 5366.597505187126, 5367.329083864517, 4876.414830220326, 4891.070696567641, 4920.581750551171, 4923.532264434873, 4962.702237865739, 5887.969605319052, 5893.410658934158, 5896.528277737771, 5899.793507227227, 5906.40935906406, 5443.564514838883, 5602.243697100839, 5607.0, 5696.344920334214, 5753.568482363923, 5895.882082358415, 5964.940350596438, 5971.492423144082, 6013.7293821779, 6015.218021657157, 5597.076482380362, 5598.468145526169, 5601.24383208278, 5612.803551875828, 5615.578831587729, 5501.834944951658, 5605.5515558756015, 5688.0899056152475, 5688.175214593944, 5692.601517893708, 5466.3986961435, 5540.473655002768, 5555.666660000413, 5592.245046918614, 5636.943630563642, 5520.420355862577, 5537.0, 5545.3622833373065, 5546.528545073714, 5551.694656793915, 5296.390915044819, 5407.702576358338, 5462.562994960314, 5464.836054918359, 5475.315585551806, 5520.420355862577, 5563.944360556343, 5564.4713752193475, 5601.075822489243, 5613.691246981455, 5443.755031023693, 5463.207834864002, 5465.207544906046, 5470.070088084955, 5472.91790623149], "unit": "score", "name": "dojo.html", "value": 5221.456591987821}, {"lowerIsBetter": false, "replicates": [585.8418227078689, 586.3140126052518, 598.1894532907909, 610.5451438678183, 622.5424313129852, 29373.559396609042, 36608.973012968585, 37044.629553704486, 37106.81446592763, 37447.251054978886, 41852.37221441673, 42049.15901681964, 42250.36624450636, 42483.575164248345, 42546.57453425465, 7346.742863999761, 8603.784905377353, 8770.298376129926, 8776.780580485474, 8777.122287771235, 7504.399648028172, 7526.849463010763, 10349.32729372592, 10486.108680762145, 10487.842682359771, 10315.329503582281, 10446.791064178711, 10466.110380617656, 10483.266171368008, 10487.423191724452, 7606.65770040344, 7834.882476762853, 10292.433916134609, 10408.687739367831, 10414.062734353869, 10031.949840250825, 10244.28290019699, 10244.846327305097, 10248.79502409955, 10252.077313041787, 35193.824030879936, 35477.0, 35602.0, 35620.64379356199, 35638.64361356379, 3207.6631953644996, 3502.964970350289, 3656.963430365689, 3747.163695299838, 3978.900527486807, 29235.269118272, 29552.408951820842, 29900.968484559755, 30332.393352133055, 30979.845100774353, 3909.3158697227873, 3919.2945269851416, 3974.0, 4049.8582549610624, 4054.0472988847596, 263357.0, 263513.0, 263750.0, 264139.9999999981, 264846.0, 51828.22257666138, 52896.47103528993, 54425.0, 54604.0, 55248.0, 54649.72675136599, 54944.0, 55446.0, 55484.445155547925, 55502.16746748802, 12908.096433249582, 13064.21614703121, 13078.019148563706, 13085.476580936845, 13118.540851070167, 9437.622495100119, 9451.054894510495, 9469.90530094704, 9497.667581634747, 9501.809963800686, 18064.18711158001, 18125.18436670353, 18136.909315453337, 18238.90880545589, 18249.0, 7075.787726368218, 7367.852642947111, 7424.925750742424, 7497.887531687029, 7604.9239507605325, 972.363102168081, 1001.62439085343, 1006.9980369532362, 1092.159037541089, 1098.6758906122552, 27505.17484475469, 27540.0, 27645.723542764717, 27859.08342752868, 28125.296867578476, 1028.321307936758, 1037.8287582548946, 1049.8267785815256, 1087.8205096159204, 1150.2868221702597, 14410.135391876522, 14458.566243012727, 14618.415263389557, 14645.780313295309, 14769.0, 299627.0, 300592.0, 303678.0, 304196.0, 304705.0, 50531.24203136956, 50746.49253507492, 50766.238506422436, 50800.491995080316, 50811.0, 1305.1581729784425, 1334.9933250333686, 1347.238810072306, 1353.2557093598482, 1356.7083077138266, 26964.191074267805, 27362.863185683946, 28070.2982425441, 28266.85866570654, 28310.575341369484, 40685.38971915483, 43559.56440435555, 43860.342094869244, 43961.78019110012, 43964.78017609892, 213318.0, 372510.0, 380546.0, 381789.0, 382275.0, 29616.259593510335, 30161.245968850075, 30225.395492089596, 30229.09312720622, 30240.54639180458, 41034.38448423336, 41691.79154104331, 41755.0, 42606.0, 42628.78685606552, 34963.300733985685, 35186.47220291749, 35377.82311088428, 35649.28701425905, 36360.818195908854, 34208.657913420546, 35045.64954350424, 35412.64587354093, 36020.81989590035, 36349.818250908575, 30337.696623033487, 30946.69053309438, 30970.84514577413, 31357.372852542365, 31396.215094622818, 26764.0, 28585.0, 30571.2357191072, 31276.374472509968, 31333.0, 23298.301050968497, 23513.011152416522, 23860.0, 23942.88028559846, 24000.0], "unit": "score", "name": "ext.html", "value": 18093.275552497656}, {"lowerIsBetter": false, "replicates": [351.40612365102976, 352.8958957107653, 353.9168295450569, 354.1747727794239, 357.46737361331606, 13792.310384480761, 14161.92919035406, 17155.914220428895, 17524.56188595286, 18181.545461363472, 10256.282060255766, 12674.176178548389, 12833.807492887614, 14640.414383424677, 14667.633309167277, 4918.311436398907, 5015.398152221738, 5027.648064635477, 5027.798888044474, 5041.974790126044, 3694.3165514379925, 4967.925481117768, 4986.227134794112, 4991.40103187618, 5028.597712183035, 5503.6147469677135, 5549.1676248562835, 5568.805091821787, 5570.053090974544, 5572.136318870582, 5498.340199176085, 5506.779728810843, 5964.0, 5985.461308482258, 5987.790427335022, 5332.253484512172, 5338.839834804923, 5344.35867695879, 5348.625596208267, 5351.411344752074, 13571.45714171432, 15373.154476503787, 15382.230888455533, 15412.152331621757, 16970.575735606584, 1980.7821139674625, 1991.104003198552, 2029.4723371923258, 2049.026712311655, 2101.464126647695, 9652.083052110038, 10125.594976200942, 12320.044572235867, 12771.552995645108, 13305.53430629933, 1780.0832571225828, 1786.606946471774, 1813.3471950097953, 1824.8722589418746, 1849.1401498303353, 57114.428855711325, 57691.42308576903, 57979.710101449644, 59337.40662593362, 60641.6967915162, 9823.705288841345, 10176.694699159038, 10324.793504129875, 10387.948060259801, 10445.791084178274, 13582.117162384611, 13585.0, 13585.660358490919, 13606.115602485806, 13607.0, 6890.2076261229595, 6961.269066747918, 7001.824954376079, 7016.614086225307, 7054.400375967997, 6555.3772391622715, 6570.080188773575, 6601.075849381091, 6602.669866506655, 6624.105745724362, 4462.464504259445, 4494.617957473652, 4515.503294637587, 4548.840790572381, 4549.408576884984, 1731.1257814803444, 1749.230338651015, 1789.2127463915836, 1812.963740725178, 1832.9816701833079, 440.7730019040197, 832.5398447587365, 869.6738722978882, 902.3818684201343, 969.2827307792325, 10555.788884222273, 10596.523156457977, 10729.517171727291, 11056.668299951014, 11227.831582526269, 410.2185336933147, 455.00127220750795, 458.16842430988316, 462.2973080916987, 467.18009892638884, 6014.09788531715, 6174.845628859224, 6183.81448556544, 6284.308726040132, 6287.46556542699, 505025.0, 532644.0, 553620.0, 560734.0, 563281.0, 80006.59996700096, 80516.59741701254, 80794.0, 81088.59455702802, 81261.0, 483.35472144687236, 488.6725893651262, 489.1244672037085, 489.75267489917366, 490.2915287409659, 10625.415602141957, 10631.468426578795, 10649.722033356047, 10760.730981725519, 14902.77645835335, 32517.674823251466, 32593.18517037093, 34201.144971375914, 34280.48579271263, 35999.0, 41234.79382603068, 42935.78532107444, 43000.354994675734, 43113.56886431221, 45391.319130213735, 9862.85205721929, 9973.900260997298, 10109.797804044025, 10170.338927969658, 10207.285490015627, 11959.222650527689, 14184.645383865485, 17116.486505404857, 17264.482065538054, 18051.638967220846, 14598.197099159222, 14698.63253418673, 15035.473758418402, 15234.542963711106, 15321.6169595761, 14042.1574705518, 14181.432742690176, 14380.0, 15004.924975375054, 15049.322780474686, 11043.558257669603, 14076.929615351857, 15023.549293521211, 15316.770248446059, 15577.76633350478, 9340.813183736424, 9405.717828465156, 9698.27262955267, 9706.660266890625, 9718.659846905324, 10091.444970526398, 10188.388696678223, 11510.42447877586, 14054.718905622034, 14155.292235388395], "unit": "score", "name": "jquery.html", "value": 7980.664482531206}, {"lowerIsBetter": false, "replicates": [1519.5669234268237, 1631.469772323995, 1680.7394853797666, 1704.9062301573413, 1708.0264249377851, 6265.968670156649, 7234.312740289671, 7434.591097489629, 7468.850622987537, 7490.775276741693, 7110.893336599956, 7217.170025447075, 7229.710811567544, 7235.7829265122, 7237.819054523627, 1938.5832046110083, 1971.3494546799593, 2020.3332900142918, 2053.5276886316155, 2137.8931053447345, 2178.8692678439265, 2180.018991453844, 2185.3007037747925, 2185.726784151981, 2187.3000639795273, 2098.653722135846, 2163.9134434622597, 2167.3172950520616, 2167.3497950614833, 2168.024389024937, 2113.9894300528554, 2143.560570083137, 2163.9134434622597, 2164.448065743241, 2170.5333353329033, 2028.5942811437624, 2039.377989713137, 2055.9486012849648, 2056.28030189434, 2059.855810093294, 7315.926840731631, 7371.778846634609, 7383.187849336568, 7384.52000619958, 7385.0, 4217.852375166885, 4279.015826359955, 4306.5478124796755, 4307.181635489278, 4310.202612516695, 2840.4745122152467, 2902.3614804742924, 2934.413117376533, 2940.9852950735108, 2952.1586347890748, 970.752458123174, 980.7155924781805, 992.4888682328607, 1061.9044286014218, 1073.4579037586047, 9625.903740962642, 9631.277654175965, 9650.08324209206, 9672.468014259213, 9680.273979451498, 3710.591834898159, 3765.9246815063543, 3785.981070094632, 3808.1431677872256, 3830.693544516432, 8321.500709957421, 8357.874631880526, 8384.119667434832, 8392.874106888401, 8397.6221070052, 4198.076423186894, 4201.852935147316, 4213.873583792491, 4230.534641189467, 4230.555791641895, 3818.1218319786603, 3842.731008829411, 3847.3459511883048, 3851.056491159684, 3852.7303088783515, 3200.9679903201136, 3238.498032804919, 3252.837358132084, 3324.0194142727955, 3403.5235067090625, 1081.729567608098, 1102.4377567440504, 1104.1994553948323, 1109.9167562432688, 1112.8775834658181, 1022.4274406332329, 1084.8264277715527, 1269.6381531263546, 1327.8406591209116, 1345.0382976171888, 7041.929580704127, 7115.75094871677, 7120.964395177991, 7123.786286411416, 7138.892916606255, 1070.2882583082164, 1077.8275475923815, 1095.0856035210688, 1095.6274866545255, 1099.9481622275493, 5551.167324901297, 5621.409751976065, 5632.5775566831835, 5633.464820842013, 5641.435856414408, 8649.308055355556, 8667.306615470874, 8712.477251364939, 8777.385583009129, 8941.150590693873, 8652.956735216283, 8824.823503529893, 8826.293896488265, 8842.867356989651, 8855.690050848189, 6859.416949559243, 6921.8961715574305, 6950.200726916368, 6979.1973922999505, 7053.717851285891, 6784.3554862288, 6820.624865632438, 6823.181218253642, 6827.180738311435, 6827.283135270924, 7592.240775922363, 7771.067471903408, 7849.843003140019, 7867.134615192439, 7993.280604745601, 7752.41856860749, 8023.638936247766, 8078.3133433658795, 8092.6762929482165, 8142.67429302845, 6121.4490695837585, 6122.7244773984385, 6167.167432396569, 6226.097215903578, 6243.843903902257, 6313.810585682437, 6424.903626445701, 7094.290570942864, 7207.783766487014, 7241.0, 6613.371729685672, 6666.26671066192, 6728.529002969745, 6814.352636499525, 6818.249992500721, 6575.342465753386, 6647.0, 6693.230278518033, 6759.222689390783, 6784.491163162881, 6787.083743694538, 6823.420009299067, 6827.6244806536115, 6835.760748373982, 6840.247572767091, 6175.938240617536, 6290.622562646256, 6337.081123237197, 6337.176167098248, 6338.461230795434, 6379.6810159490915, 6427.3251308611925, 6432.35676432353, 6439.3238709934785, 6445.097686323825], "unit": "score", "name": "mootools.html", "value": 4238.314258363413}, {"lowerIsBetter": false, "replicates": [327.74927180706754, 328.23193726679597, 333.0209184996111, 333.98664053437864, 338.42974587819526, 5966.970165149173, 5982.162497250383, 6012.0, 6022.638641681502, 6033.034714445689, 5661.0, 5769.394213607574, 5778.075507918734, 5900.498457631106, 5945.940540594593, 4525.954740452603, 4546.090781843644, 4566.10960862632, 4584.266517357223, 4595.770211489429, 4340.414044104053, 4532.09358128374, 4570.360149579062, 4570.862874113782, 4583.862484125465, 4391.802368893392, 4420.3369494575745, 4456.8885777855485, 4474.657602719188, 4544.068465964486, 4510.864674059767, 4511.368408422823, 4514.887127821798, 4520.751358675255, 4525.804984582475, 3951.269015232191, 3985.940210896839, 3991.840326386941, 3993.28120938231, 3995.200959808021, 5547.805826796042, 5644.774209031634, 5653.632513886625, 5656.519195868356, 5659.51894089003, 5315.946840531584, 5324.866878328034, 5330.813421530266, 5331.2003199519995, 5333.0, 6277.121203031579, 6281.057841323793, 6284.685765711696, 6287.654179020152, 6291.119243305895, 4463.531329210451, 4464.553544645542, 4467.508574056851, 4467.530909254547, 4477.3731677565165, 6323.74705011799, 6508.967455162694, 6529.706163222666, 6549.279579246279, 6559.737610495575, 4536.138133754576, 4558.566936141061, 4558.908821823611, 4559.224931761609, 4560.452745670541, 4617.953820461819, 4619.6073333766335, 4622.329762184531, 4626.398568186114, 4626.514216007338, 5293.338332708411, 5299.072662284085, 5301.522862942276, 5305.708186049727, 5307.8142265021315, 6175.567710260329, 6349.936500634934, 6357.141785858942, 6372.0, 6373.203349581302, 1554.230655825351, 1578.7316156253464, 1580.9051456912623, 1580.91304978225, 1581.0118675827607, 1026.2508368890751, 1032.550840384435, 1041.146260066738, 1055.8205105131992, 1062.0, 6077.75688972445, 6083.878322433527, 6083.969580152071, 6085.513158947362, 6093.451589356979, 6511.479081673455, 6513.478921686254, 6524.412802847766, 6524.836879077966, 6541.640209788412, 5915.231019967377, 6006.069059295816, 6085.330613632497, 6143.600665956698, 6147.84630384244, 3537.5931767846514, 3546.946795798065, 3552.502649629054, 3553.68016878477, 3557.288542291552, 6796.966015169992, 6812.455003599799, 6822.11312529368, 6828.6927088281145, 6835.043093966849, 6607.933920660828, 6770.966145169341, 6771.627560484122, 6777.1189745332795, 6780.8304792379595, 6804.285550017276, 6826.078479405217, 6827.931720682829, 6828.556143850634, 6829.078074460083, 6575.80272591823, 6578.144841170617, 6578.375054369827, 6580.670966451754, 6585.670716464253, 6340.1440805490665, 6490.740370385131, 6504.544681872224, 6508.219013718384, 6511.186101737283, 6816.897746533707, 6817.147856517935, 6819.215790184192, 6828.0, 6828.044073829568, 4461.420015397977, 4506.684532082854, 4507.368968344369, 4509.030558429953, 4509.075639493962, 6389.584676995981, 6514.0, 6556.868862622626, 6596.80209593713, 6636.634985075867, 6372.936270637234, 6396.392342727433, 6416.839579010562, 6430.2926678066315, 6447.580907241015, 6425.646589437626, 6432.614043157426, 6440.452561532322, 6441.0, 6442.35576442352, 6173.969130154321, 6309.842253943688, 6313.084602732486, 6313.747450101944, 6318.589291696025, 6419.839504012437, 6433.967830160819, 6439.7424103035355, 6439.8068057958335, 6449.451796597342, 6282.089097080806, 6302.338254483397, 6307.3377295383325, 6308.463780578519, 6311.400416960381], "unit": "score", "name": "prototype.html", "value": 4782.79511007575}, {"lowerIsBetter": false, "replicates": [701.6772284749015, 772.5403384985933, 835.1690068381961, 851.9275861551768, 877.9604917778702, 13510.864891351084, 13714.245716485602, 13724.656883577916, 13738.793918091236, 13748.656283592914, 12463.314517701523, 12531.624051278453, 12545.059120565948, 12574.434150463228, 12577.811332829991, 686.5503095472449, 785.19909692114, 796.0487217774762, 796.8605494038549, 797.4696826610298, 690.1649004704313, 810.631162820915, 819.7622689420061, 824.1881746479713, 829.340674164041, 799.1050023973129, 830.9169083091703, 849.7535714642746, 850.8596081646521, 850.9829803403928, 704.102269606251, 710.3784188834769, 845.9746207613781, 847.2713466418875, 848.9235968762811, 614.4531367083299, 618.0605479670875, 620.3889169168366, 622.0979579609584, 623.51988968494, 11877.940610296979, 11940.522379104825, 12080.939595301967, 12112.697182570419, 12116.878831211663, 11631.825522617168, 11836.053115750805, 11938.701532461671, 12220.205686630341, 12505.0, 9996.200303975736, 10009.099181073665, 10045.274617761419, 10075.848862267072, 10439.686809395731, 3551.94672079919, 3565.6969157621375, 3568.6431356864364, 3589.192431702872, 3728.5525736911472, 42930.57069429297, 43014.569854301684, 43219.35170972438, 43311.78344108291, 43322.56677433217, 9536.761580960392, 9547.188488978376, 9625.51872406377, 9690.612375505041, 9841.655542056136, 17547.21037553313, 17649.294028238983, 17657.322554357317, 17661.205245763973, 17672.646547068987, 7002.579845209304, 7067.57594544329, 7128.786136415916, 7167.641617919083, 7362.8527429451115, 4090.4886889138857, 4125.50493940729, 4147.958520414818, 4169.041120542292, 4235.470566179228, 2937.794354395172, 2956.1722717639095, 2966.8664910079096, 2966.9851650741607, 2974.3307755755213, 514.6371807875514, 532.1857557936363, 533.6237952243658, 533.8345113014977, 540.4730387871793, 613.8557439001831, 638.4381744065192, 638.47644931156, 663.0849427789619, 680.7413182990531, 8144.796380090545, 8222.671093156327, 8345.248927596545, 8478.23695867375, 8487.0, 529.8569386265686, 559.1668414063017, 631.5989346764745, 657.9374959378852, 710.6588837358097, 3843.8270277837564, 3854.402567602026, 4102.835886564504, 4125.546189919107, 4151.8546850860075, 55709.1643625346, 56577.0, 56805.431945680844, 56874.43125568774, 56957.14564281539, 48336.27495587569, 49210.0, 49771.0, 49863.75068124636, 50037.49962500401, 45126.774366128615, 45572.0, 45842.541574583825, 46114.0, 46282.537174627825, 8117.391195660467, 8134.216564060026, 8159.3880458967005, 8173.0, 8301.377396695152, 33925.0, 34188.82905585456, 34265.65734342625, 34741.47887781635, 35443.468347975315, 40114.1977160461, 43849.0, 44147.77926110478, 44744.77627611841, 45176.32235516404, 10888.51001704941, 10950.616728414467, 11073.778524429305, 11168.162387820783, 11353.886461135613, 10671.0, 10842.0, 11287.604933827277, 11724.472398742248, 11823.704407389883, 9909.306348555532, 10205.183585313305, 10263.332883362558, 11524.366159861289, 11634.70913227176, 11152.498137583665, 11234.494447749707, 11365.0, 11665.941670291595, 11755.235909665844, 9116.817663646823, 10134.783825940935, 10790.298630588986, 10911.181661375269, 11529.481173347387, 9433.386829856037, 9471.47906865129, 9905.55425005862, 10244.641437549948, 10250.58997640086, 9134.908650913672, 9521.238300936047, 9531.428114313163, 9641.469719165514, 9697.903020969983], "unit": "score", "name": "yui.html", "value": 6113.06460402486}], "name": "dromaeo_css", "value": 6736.280337934309}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 105.0, 111.0, 113.0, 113.0, 101.0, 110.0, 112.0, 118.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [160.0, 123.0, 146.0, 158.0, 129.0, 149.0, 146.0, 125.0, 166.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 159.0, 160.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 80.0, 97.0, 70.0, 78.0, 71.0, 119.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 143.0, 93.0, 94.0, 94.0, 139.0, 93.0, 93.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 58.0, 59.0, 59.0, 59.0, 58.0, 71.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 87.0, 87.0, 86.0, 87.0, 88.0, 87.0, 94.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.9}, {"lowerIsBetter": true, "replicates": [122.0, 118.0, 126.0, 116.0, 117.0, 119.0, 121.0, 115.0, 121.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.9}, {"lowerIsBetter": true, "replicates": [142.0, 154.0, 143.0, 151.0, 155.0, 147.0, 157.0, 157.0, 153.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 70.0, 70.0, 69.0, 70.0, 69.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1507.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.11295681063123], "unit": "score", "name": "Richards", "value": 212.51804000000004}, {"lowerIsBetter": false, "replicates": [188.43037497644622], "unit": "score", "name": "DeltaBlue", "value": 350.8882260000001}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1964.6365422396857], "unit": "score", "name": "RayTrace", "value": 376.654401}, {"lowerIsBetter": false, "replicates": [783.6990595611285], "unit": "score", "name": "Earley", "value": 850.4067880000003}, {"lowerIsBetter": false, "replicates": [12550.0], "unit": "score", "name": "Boyer", "value": 53.10462151394425}, {"lowerIsBetter": false, "replicates": [25820.51282051282], "unit": "score", "name": "RegExp", "value": 35.28144488579943}, {"lowerIsBetter": false, "replicates": [646.606914212548], "unit": "score", "name": "Splay", "value": 126.02865544554456}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19681.130077614853}]} 02:01:48 INFO - RETURN: dromaeo_css: 6736.28 02:01:48 INFO - RETURN: kraken: 1507.40 02:01:48 INFO - RETURN: v8_7: 19681.13 02:01:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19681.13"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1507.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6736.28"}}} 02:01:48 INFO - Return code: 0 02:01:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:01:48 INFO - # TBPL SUCCESS # 02:01:48 INFO - Running post-action listener: _resource_record_post_action 02:01:48 INFO - Running post-run listener: _resource_record_post_run 02:01:49 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 8192; Write bytes: 566472704; Read time: 20; Write time: 1937384 02:01:49 INFO - install - Wall time: 19s; CPU: 18.0%; Read bytes: 4096; Write bytes: 251088896; Read time: 12; Write time: 914996 02:01:49 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 315383808; Read time: 8; Write time: 1022388 02:01:49 INFO - Running post-run listener: _upload_blobber_files 02:01:49 INFO - Blob upload gear active. 02:01:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:01:49 INFO - Copying logs to upload dir... 02:01:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.281315 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-18 02:01:49.439462) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 02:01:49.443461) ========= 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=a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hMsZtEqcQA-cCL1esIM4DQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010052 build_url: 'https://queue.taskcluster.net/v1/task/hMsZtEqcQA-cCL1esIM4DQ/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-18 02:01:49.495302) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:01:49.495676) ========= 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=a194aa7faa1be204aaca7d660000020b-1450422228.230172-824722531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004606 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 02:01:49.544998) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 02:01:49.545309) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 02:01:49.545603) ========= ========= Total master_lag: 0.24 =========