builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1452164904.84 results: success (0) buildid: 20160107004004 builduid: 5cf99b7fb1144d5bb1470dc84cfcd4db revision: a1843cf99df14fc791b56b8adddb4d47c078cfec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:24.838949) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:24.839450) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:24.843082) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006469 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:24.879914) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:24.880287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:25.007884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:25.008178) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:25.066250) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:25.066586) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:25.067008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:25.067909) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 03:08:25-- 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.3M=0s 2016-01-07 03:08:26 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173617 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:25.255407) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:25.255789) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017020 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:25.306910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:25.307305) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a1843cf99df14fc791b56b8adddb4d47c078cfec --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a1843cf99df14fc791b56b8adddb4d47c078cfec --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=e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 03:08:26,115 truncating revision to first 12 chars 2016-01-07 03:08:26,115 Setting DEBUG logging. 2016-01-07 03:08:26,115 attempt 1/10 2016-01-07 03:08:26,115 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a1843cf99df1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 03:08:26,678 unpacking tar archive at: mozilla-aurora-a1843cf99df1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.834574 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:26.157704) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:26.158068) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:26.169532) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:26.169893) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 03:08:26.170324) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-07 03:08:26.170604) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:08:27 INFO - MultiFileLogger online at 20160107 03:08:27 in /builds/slave/test-pgo 03:08:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:08:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:08:27 INFO - {'append_to_log': False, 03:08:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:08:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:08:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:08:27 INFO - 'branch': 'Mozilla-Aurora', 03:08:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:08:27 INFO - 'config_files': ('talos/linux_config.py',), 03:08:27 INFO - 'default_actions': ('clobber', 03:08:27 INFO - 'read-buildbot-config', 03:08:27 INFO - 'download-and-extract', 03:08:27 INFO - 'populate-webroot', 03:08:27 INFO - 'create-virtualenv', 03:08:27 INFO - 'install', 03:08:27 INFO - 'run-tests'), 03:08:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:08:27 INFO - 'download_minidump_stackwalk': True, 03:08:27 INFO - 'download_symbols': 'ondemand', 03:08:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:08:27 INFO - 'tooltool.py': '/tools/tooltool.py', 03:08:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:08:27 INFO - '/tools/misc-python/virtualenv.py')}, 03:08:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:08:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:08:27 INFO - 'installer_path': 'installer.exe', 03:08:27 INFO - 'log_level': 'info', 03:08:27 INFO - 'log_name': 'talos', 03:08:27 INFO - 'log_to_console': True, 03:08:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:08:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:08:27 INFO - 'opt_config_files': (), 03:08:27 INFO - 'pip_index': False, 03:08:27 INFO - 'sps_profile': False, 03:08:27 INFO - 'sps_profile_interval': 0, 03:08:27 INFO - 'suite': 'dromaeojs-e10s', 03:08:27 INFO - 'system_bits': '32', 03:08:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:08:27 INFO - 'title': 'talos-linux64-ix-006', 03:08:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:08:27 INFO - 'use_talos_json': True, 03:08:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:08:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:08:27 INFO - 'work_dir': 'build'} 03:08:27 INFO - ##### 03:08:27 INFO - ##### Running clobber step. 03:08:27 INFO - ##### 03:08:27 INFO - Running pre-action listener: _resource_record_pre_action 03:08:27 INFO - Running main action method: clobber 03:08:27 INFO - rmtree: /builds/slave/test-pgo/build 03:08:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:08:27 INFO - Running post-action listener: _resource_record_post_action 03:08:27 INFO - ##### 03:08:27 INFO - ##### Running read-buildbot-config step. 03:08:27 INFO - ##### 03:08:27 INFO - Running pre-action listener: _resource_record_pre_action 03:08:27 INFO - Running main action method: read_buildbot_config 03:08:27 INFO - Using buildbot properties: 03:08:27 INFO - { 03:08:27 INFO - "properties": { 03:08:27 INFO - "buildnumber": 75, 03:08:27 INFO - "product": "firefox", 03:08:27 INFO - "script_repo_revision": "production", 03:08:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:08:27 INFO - "repository": "", 03:08:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:08:27 INFO - "buildid": "20160107004004", 03:08:27 INFO - "slavename": "talos-linux64-ix-006", 03:08:27 INFO - "stage_platform": "linux64-pgo", 03:08:27 INFO - "basedir": "/builds/slave/test-pgo", 03:08:27 INFO - "nightly_build": "True", 03:08:27 INFO - "project": "", 03:08:27 INFO - "platform": "ubuntu64_hw", 03:08:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:08:27 INFO - "slavebuilddir": "test", 03:08:27 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:08:27 INFO - "branch": "mozilla-aurora", 03:08:27 INFO - "repo_path": "releases/mozilla-aurora", 03:08:27 INFO - "pgo_build": "True", 03:08:27 INFO - "builduid": "5cf99b7fb1144d5bb1470dc84cfcd4db", 03:08:27 INFO - "revision": "a1843cf99df14fc791b56b8adddb4d47c078cfec" 03:08:27 INFO - }, 03:08:27 INFO - "sourcestamp": { 03:08:27 INFO - "repository": "", 03:08:27 INFO - "hasPatch": false, 03:08:27 INFO - "project": "", 03:08:27 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:08:27 INFO - "changes": [ 03:08:27 INFO - { 03:08:27 INFO - "category": null, 03:08:27 INFO - "files": [ 03:08:27 INFO - { 03:08:27 INFO - "url": null, 03:08:27 INFO - "name": "https://queue.taskcluster.net/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 03:08:27 INFO - } 03:08:27 INFO - ], 03:08:27 INFO - "repository": "", 03:08:27 INFO - "rev": "a1843cf99df14fc791b56b8adddb4d47c078cfec", 03:08:27 INFO - "who": "sendchange", 03:08:27 INFO - "when": 1452164900, 03:08:27 INFO - "number": 7428190, 03:08:27 INFO - "comments": "", 03:08:27 INFO - "project": "", 03:08:27 INFO - "at": "Thu 07 Jan 2016 03:08:20", 03:08:27 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:08:27 INFO - "revlink": "", 03:08:27 INFO - "properties": [ 03:08:27 INFO - [ 03:08:27 INFO - "buildid", 03:08:27 INFO - "20160107004004", 03:08:27 INFO - "Change" 03:08:27 INFO - ], 03:08:27 INFO - [ 03:08:27 INFO - "builduid", 03:08:27 INFO - "5cf99b7fb1144d5bb1470dc84cfcd4db", 03:08:27 INFO - "Change" 03:08:27 INFO - ], 03:08:27 INFO - [ 03:08:27 INFO - "nightly_build", 03:08:27 INFO - "True", 03:08:27 INFO - "Change" 03:08:27 INFO - ], 03:08:27 INFO - [ 03:08:27 INFO - "pgo_build", 03:08:27 INFO - "True", 03:08:27 INFO - "Change" 03:08:27 INFO - ] 03:08:27 INFO - ], 03:08:27 INFO - "revision": "a1843cf99df14fc791b56b8adddb4d47c078cfec" 03:08:27 INFO - } 03:08:27 INFO - ], 03:08:27 INFO - "revision": "a1843cf99df14fc791b56b8adddb4d47c078cfec" 03:08:27 INFO - } 03:08:27 INFO - } 03:08:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 03:08:27 INFO - Running post-action listener: _resource_record_post_action 03:08:27 INFO - ##### 03:08:27 INFO - ##### Running download-and-extract step. 03:08:27 INFO - ##### 03:08:27 INFO - Running pre-action listener: _resource_record_pre_action 03:08:27 INFO - Running main action method: download_and_extract 03:08:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:27 INFO - https://queue.taskcluster.net/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:08:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/test_packages.json 03:08:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/test_packages.json 03:08:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:08:29 INFO - Downloaded 1302 bytes. 03:08:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:08:29 INFO - Using the following test package requirements: 03:08:29 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:08:29 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:29 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:08:29 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:29 INFO - u'jsshell-linux-x86_64.zip'], 03:08:29 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:29 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:08:29 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:08:29 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:29 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:08:29 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:29 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:08:29 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:29 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:08:29 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:08:29 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:29 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:08:29 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:29 INFO - https://queue.taskcluster.net/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:08:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:08:30 INFO - Downloaded 23024131 bytes. 03:08:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:08:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:08:31 INFO - Return code: 0 03:08:31 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:08: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')]} 03:08:31 INFO - https://queue.taskcluster.net/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:08:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:08:42 INFO - Downloaded 23024131 bytes. 03:08:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:08:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:08:44 INFO - Return code: 0 03:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:44 INFO - https://queue.taskcluster.net/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:08:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:08:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:08:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:08:45 INFO - Downloaded 11132038 bytes. 03:08:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 03:08:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:08:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:08:45 INFO - Return code: 0 03:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:45 INFO - https://queue.taskcluster.net/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:08:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:08:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:08:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:08:48 INFO - Downloaded 58101167 bytes. 03:08:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:08:48 INFO - mkdir: /builds/slave/test-pgo/properties 03:08:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:08:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:08:48 INFO - Contents: 03:08:48 INFO - build_url:https://queue.taskcluster.net/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:08:48 INFO - Running post-action listener: _resource_record_post_action 03:08:48 INFO - Running post-action listener: set_extra_try_arguments 03:08:48 INFO - ##### 03:08:48 INFO - ##### Running populate-webroot step. 03:08:48 INFO - ##### 03:08:48 INFO - Running pre-action listener: _resource_record_pre_action 03:08:48 INFO - Running main action method: populate_webroot 03:08:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:08:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:08:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:08:48 INFO - '--tppagecycles', 03:08:48 INFO - '7'], 03:08:48 INFO - 'tests': ['tsvgm']}}, 03:08:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:08:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:08:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:08:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:08:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:08:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:08:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:48 INFO - 'talos_options': ['--e10s'], 03:08:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:48 INFO - 'tests': ['damp', 'tps']}, 03:08:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:48 INFO - 'talos_options': ['--e10s'], 03:08:48 INFO - 'tests': ['damp', 'tps']}, 03:08:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:08:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:08:48 INFO - 'other': {'tests': ['a11yr', 03:08:48 INFO - 'ts_paint', 03:08:48 INFO - 'tpaint', 03:08:48 INFO - 'sessionrestore', 03:08:48 INFO - 'sessionrestore_no_auto_restore']}, 03:08:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:08:48 INFO - 'tests': ['a11yr', 03:08:48 INFO - 'ts_paint', 03:08:48 INFO - 'tpaint', 03:08:48 INFO - 'sessionrestore', 03:08:48 INFO - 'sessionrestore_no_auto_restore']}, 03:08:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:08:48 INFO - 'tests': ['a11yr', 03:08:48 INFO - 'ts_paint', 03:08:48 INFO - 'tpaint', 03:08:48 INFO - 'sessionrestore', 03:08:48 INFO - 'sessionrestore_no_auto_restore']}, 03:08:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:08:48 INFO - 'tests': ['a11yr', 03:08:48 INFO - 'ts_paint', 03:08:48 INFO - 'tpaint', 03:08:48 INFO - 'sessionrestore', 03:08:48 INFO - 'sessionrestore_no_auto_restore']}, 03:08:48 INFO - 'other_l64': {'tests': ['a11yr', 03:08:48 INFO - 'ts_paint', 03:08:48 INFO - 'tpaint', 03:08:48 INFO - 'sessionrestore', 03:08:48 INFO - 'sessionrestore_no_auto_restore']}, 03:08:48 INFO - 'other_nol64': {'tests': ['a11yr', 03:08:48 INFO - 'ts_paint', 03:08:48 INFO - 'tpaint', 03:08:48 INFO - 'sessionrestore', 03:08:48 INFO - 'sessionrestore_no_auto_restore']}, 03:08:48 INFO - 'svgr': {'tests': ['tsvgx', 03:08:48 INFO - 'tsvgr_opacity', 03:08:48 INFO - 'tart', 03:08:48 INFO - 'tscrollx', 03:08:48 INFO - 'cart']}, 03:08:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:08:48 INFO - 'tests': ['tsvgx', 03:08:48 INFO - 'tsvgr_opacity', 03:08:48 INFO - 'tart', 03:08:48 INFO - 'tscrollx', 03:08:48 INFO - 'cart']}, 03:08:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:48 INFO - 'tests': ['tp5o']}, 03:08:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:48 INFO - 'talos_options': ['--e10s'], 03:08:48 INFO - 'tests': ['tp5o']}, 03:08:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:48 INFO - 'talos_options': ['--xperf_path', 03:08:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:48 INFO - 'tests': ['tp5n']}, 03:08:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:48 INFO - 'talos_options': ['--e10s', 03:08:48 INFO - '--xperf_path', 03:08:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:48 INFO - 'tests': ['tp5n']}}, 03:08:48 INFO - 'talos.zip': {'path': '', 03:08:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:08:48 INFO - Running post-action listener: _resource_record_post_action 03:08:48 INFO - ##### 03:08:48 INFO - ##### Running create-virtualenv step. 03:08:48 INFO - ##### 03:08:48 INFO - Running pre-action listener: _resource_record_pre_action 03:08:48 INFO - Running main action method: create_virtualenv 03:08:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:08:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:08:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:08:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:08:49 INFO - Using real prefix '/usr' 03:08:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:08:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:08:51 INFO - Installing pip.................done. 03:08:51 INFO - Return code: 0 03:08:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7ce0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a50>, '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 0x2624550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26249e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', '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 03:08:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:08:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:08:51 INFO - Using env: {'DISPLAY': ':0', 03:08:51 INFO - 'HOME': '/home/cltbld', 03:08:51 INFO - 'LANG': 'en_US.UTF-8', 03:08:51 INFO - 'LANGUAGE': 'en_US:en', 03:08:51 INFO - 'LOGNAME': 'cltbld', 03:08:51 INFO - 'MAIL': '/var/mail/cltbld', 03:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:51 INFO - 'MOZ_NO_REMOTE': '1', 03:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:51 INFO - 'NO_EM_RESTART': '1', 03:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:51 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:51 INFO - 'SHELL': '/bin/bash', 03:08:51 INFO - 'SHLVL': '1', 03:08:51 INFO - 'TERM': 'linux', 03:08:51 INFO - 'TMOUT': '86400', 03:08:51 INFO - 'USER': 'cltbld', 03:08:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', 03:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:51 INFO - '_': '/tools/buildbot/bin/python'} 03:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:08:51 INFO - Cleaning up... 03:08:51 INFO - Return code: 0 03:08:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7ce0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a50>, '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 0x2624550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26249e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', '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 03:08:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:08:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:08:51 INFO - Using env: {'DISPLAY': ':0', 03:08:51 INFO - 'HOME': '/home/cltbld', 03:08:51 INFO - 'LANG': 'en_US.UTF-8', 03:08:51 INFO - 'LANGUAGE': 'en_US:en', 03:08:51 INFO - 'LOGNAME': 'cltbld', 03:08:51 INFO - 'MAIL': '/var/mail/cltbld', 03:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:51 INFO - 'MOZ_NO_REMOTE': '1', 03:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:51 INFO - 'NO_EM_RESTART': '1', 03:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:51 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:51 INFO - 'SHELL': '/bin/bash', 03:08:51 INFO - 'SHLVL': '1', 03:08:51 INFO - 'TERM': 'linux', 03:08:51 INFO - 'TMOUT': '86400', 03:08:51 INFO - 'USER': 'cltbld', 03:08:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', 03:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:51 INFO - '_': '/tools/buildbot/bin/python'} 03:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:51 INFO - Downloading/unpacking psutil>=0.7.1 03:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:08:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:08:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:08:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:53 INFO - Installing collected packages: psutil 03:08:53 INFO - Running setup.py install for psutil 03:08:53 INFO - building 'psutil._psutil_linux' extension 03:08:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:08: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 03:08:54 INFO - building 'psutil._psutil_posix' extension 03:08: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 03:08: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 03:08:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:54 INFO - Successfully installed psutil 03:08:54 INFO - Cleaning up... 03:08:54 INFO - Return code: 0 03:08:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:08:54 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')]} 03:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:54 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')]} 03:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:54 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 0x7ff7ce0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a50>, '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 0x2624550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26249e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', '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 03:08:54 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 03:08:54 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 03:08:54 INFO - Using env: {'DISPLAY': ':0', 03:08:54 INFO - 'HOME': '/home/cltbld', 03:08:54 INFO - 'LANG': 'en_US.UTF-8', 03:08:54 INFO - 'LANGUAGE': 'en_US:en', 03:08:54 INFO - 'LOGNAME': 'cltbld', 03:08:54 INFO - 'MAIL': '/var/mail/cltbld', 03:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:54 INFO - 'MOZ_NO_REMOTE': '1', 03:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:54 INFO - 'NO_EM_RESTART': '1', 03:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:54 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:54 INFO - 'SHELL': '/bin/bash', 03:08:54 INFO - 'SHLVL': '1', 03:08:54 INFO - 'TERM': 'linux', 03:08:54 INFO - 'TMOUT': '86400', 03:08:54 INFO - 'USER': 'cltbld', 03:08:54 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', 03:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:54 INFO - '_': '/tools/buildbot/bin/python'} 03:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:08:54 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 03:08:54 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 03:08:54 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 03:08:54 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 03:08:54 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 03:08:54 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 03:08:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:08:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:08:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:08:56 INFO - Installing collected packages: mozsystemmonitor 03:08:56 INFO - Running setup.py install for mozsystemmonitor 03:08:56 INFO - Successfully installed mozsystemmonitor 03:08:56 INFO - Cleaning up... 03:08:56 INFO - Return code: 0 03:08:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7ce0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a50>, '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 0x2624550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26249e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', '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 03:08:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:08:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:08:56 INFO - Using env: {'DISPLAY': ':0', 03:08:56 INFO - 'HOME': '/home/cltbld', 03:08:56 INFO - 'LANG': 'en_US.UTF-8', 03:08:56 INFO - 'LANGUAGE': 'en_US:en', 03:08:56 INFO - 'LOGNAME': 'cltbld', 03:08:56 INFO - 'MAIL': '/var/mail/cltbld', 03:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:56 INFO - 'MOZ_NO_REMOTE': '1', 03:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:56 INFO - 'NO_EM_RESTART': '1', 03:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:56 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:56 INFO - 'SHELL': '/bin/bash', 03:08:56 INFO - 'SHLVL': '1', 03:08:56 INFO - 'TERM': 'linux', 03:08:56 INFO - 'TMOUT': '86400', 03:08:56 INFO - 'USER': 'cltbld', 03:08:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', 03:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:56 INFO - '_': '/tools/buildbot/bin/python'} 03:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:56 INFO - Downloading/unpacking blobuploader==1.2.4 03:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:58 INFO - Downloading blobuploader-1.2.4.tar.gz 03:08:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:08:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:08:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:08:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:08:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:58 INFO - Downloading docopt-0.6.1.tar.gz 03:08:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:08:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:08:59 INFO - Installing collected packages: blobuploader, requests, docopt 03:08:59 INFO - Running setup.py install for blobuploader 03:08:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:08:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:08:59 INFO - Running setup.py install for requests 03:08:59 INFO - Running setup.py install for docopt 03:08:59 INFO - Successfully installed blobuploader requests docopt 03:08:59 INFO - Cleaning up... 03:08:59 INFO - Return code: 0 03:08:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7ce0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a50>, '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 0x2624550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26249e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', '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 03:08:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:08:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:08:59 INFO - Using env: {'DISPLAY': ':0', 03:08:59 INFO - 'HOME': '/home/cltbld', 03:08:59 INFO - 'LANG': 'en_US.UTF-8', 03:08:59 INFO - 'LANGUAGE': 'en_US:en', 03:08:59 INFO - 'LOGNAME': 'cltbld', 03:08:59 INFO - 'MAIL': '/var/mail/cltbld', 03:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:59 INFO - 'MOZ_NO_REMOTE': '1', 03:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:59 INFO - 'NO_EM_RESTART': '1', 03:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:59 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:59 INFO - 'SHELL': '/bin/bash', 03:08:59 INFO - 'SHLVL': '1', 03:08:59 INFO - 'TERM': 'linux', 03:08:59 INFO - 'TMOUT': '86400', 03:08:59 INFO - 'USER': 'cltbld', 03:08:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', 03:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:59 INFO - '_': '/tools/buildbot/bin/python'} 03:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:08:59 INFO - Running setup.py (path:/tmp/pip-6uZefe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:08:59 INFO - Running setup.py (path:/tmp/pip-WWl9Jj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:09:00 INFO - Running setup.py (path:/tmp/pip-KB_Uh7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:09:00 INFO - Running setup.py (path:/tmp/pip-B5lhOI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:09:00 INFO - Running setup.py (path:/tmp/pip-_pTahQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:09:00 INFO - Running setup.py (path:/tmp/pip-UNlQX6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:09:00 INFO - Running setup.py (path:/tmp/pip-bJ9Egh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:09:00 INFO - Running setup.py (path:/tmp/pip-RrxBJ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:09:00 INFO - Running setup.py (path:/tmp/pip-G1HGZS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:09:00 INFO - Running setup.py (path:/tmp/pip-muTsVm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:09:00 INFO - Running setup.py (path:/tmp/pip-dLu7YW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:09:00 INFO - Running setup.py (path:/tmp/pip-fuTM8N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:09:00 INFO - Running setup.py (path:/tmp/pip-z1NVpQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:09:00 INFO - Running setup.py (path:/tmp/pip-zMDElO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:09:00 INFO - Running setup.py (path:/tmp/pip-WFSAGv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:09:00 INFO - Running setup.py (path:/tmp/pip-oz7ATB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:09:00 INFO - Running setup.py (path:/tmp/pip-vgIP3l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:09:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:09:01 INFO - Running setup.py install for manifestparser 03:09:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:09:01 INFO - Running setup.py install for mozcrash 03:09:01 INFO - Running setup.py install for mozdebug 03:09:01 INFO - Running setup.py install for mozdevice 03:09:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:09:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:09:01 INFO - Running setup.py install for mozfile 03:09:01 INFO - Running setup.py install for mozhttpd 03:09:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:09:01 INFO - Running setup.py install for mozinfo 03:09:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:09:01 INFO - Running setup.py install for mozInstall 03:09:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:09:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:09:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:09:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:09:01 INFO - Running setup.py install for mozleak 03:09:01 INFO - Running setup.py install for mozlog 03:09:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:09:02 INFO - Running setup.py install for moznetwork 03:09:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:09:02 INFO - Running setup.py install for mozprocess 03:09:02 INFO - Running setup.py install for mozprofile 03:09:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:09:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:09:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:09:02 INFO - Running setup.py install for mozrunner 03:09:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:09:02 INFO - Running setup.py install for mozscreenshot 03:09:02 INFO - Running setup.py install for moztest 03:09:02 INFO - Running setup.py install for mozversion 03:09:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:09:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:09:02 INFO - Cleaning up... 03:09:02 INFO - Return code: 0 03:09:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7ce0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a50>, '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 0x2624550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26249e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', '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 03:09:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:09:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:09:02 INFO - Using env: {'DISPLAY': ':0', 03:09:02 INFO - 'HOME': '/home/cltbld', 03:09:02 INFO - 'LANG': 'en_US.UTF-8', 03:09:02 INFO - 'LANGUAGE': 'en_US:en', 03:09:02 INFO - 'LOGNAME': 'cltbld', 03:09:02 INFO - 'MAIL': '/var/mail/cltbld', 03:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:02 INFO - 'MOZ_NO_REMOTE': '1', 03:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:02 INFO - 'NO_EM_RESTART': '1', 03:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:02 INFO - 'SHELL': '/bin/bash', 03:09:02 INFO - 'SHLVL': '1', 03:09:02 INFO - 'TERM': 'linux', 03:09:02 INFO - 'TMOUT': '86400', 03:09:02 INFO - 'USER': 'cltbld', 03:09:02 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', 03:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:02 INFO - '_': '/tools/buildbot/bin/python'} 03:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:09:03 INFO - Running setup.py (path:/tmp/pip-g_633Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:09: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)) 03:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:09:03 INFO - Running setup.py (path:/tmp/pip-AHORL6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:09: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)) 03:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:09:03 INFO - Running setup.py (path:/tmp/pip-Y2Fiwf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:09:03 INFO - Running setup.py (path:/tmp/pip-rjZi7t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:09:03 INFO - Running setup.py (path:/tmp/pip-uXggJD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:09:03 INFO - Running setup.py (path:/tmp/pip-BpYJ0A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 03:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:09:03 INFO - Running setup.py (path:/tmp/pip-yXo78t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:09:03 INFO - Running setup.py (path:/tmp/pip-gXcg7U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:09:03 INFO - Running setup.py (path:/tmp/pip-7dm2qF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:09:03 INFO - Running setup.py (path:/tmp/pip-hBdbK5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:09:03 INFO - Running setup.py (path:/tmp/pip-jIufOa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:09:03 INFO - Running setup.py (path:/tmp/pip-gS2isQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:09:03 INFO - Running setup.py (path:/tmp/pip-_RKvlf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:09: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)) 03:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:09:04 INFO - Running setup.py (path:/tmp/pip-lB7UBG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:09: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)) 03:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:09:04 INFO - Running setup.py (path:/tmp/pip-16WlBl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:09: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)) 03:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:09:04 INFO - Running setup.py (path:/tmp/pip-XebluW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:09:04 INFO - Running setup.py (path:/tmp/pip-B14tC2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 03:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:09:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:05 INFO - Downloading blessings-1.5.1.tar.gz 03:09:05 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:09:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:09:06 INFO - Installing collected packages: blessings 03:09:06 INFO - Running setup.py install for blessings 03:09:06 INFO - Successfully installed blessings 03:09:06 INFO - Cleaning up... 03:09:06 INFO - Return code: 0 03:09:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:09:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:09:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:09:06 INFO - Reading from file tmpfile_stdout 03:09:06 INFO - Current package versions: 03:09:06 INFO - argparse == 1.2.1 03:09:06 INFO - blessings == 1.5.1 03:09:06 INFO - blobuploader == 1.2.4 03:09:06 INFO - docopt == 0.6.1 03:09:06 INFO - manifestparser == 1.1 03:09:06 INFO - mozInstall == 1.12 03:09:06 INFO - mozcrash == 0.16 03:09:06 INFO - mozdebug == 0.1 03:09:06 INFO - mozdevice == 0.47 03:09:06 INFO - mozfile == 1.2 03:09:06 INFO - mozhttpd == 0.7 03:09:06 INFO - mozinfo == 0.9 03:09:06 INFO - mozleak == 0.1 03:09:06 INFO - mozlog == 3.1 03:09:06 INFO - moznetwork == 0.27 03:09:06 INFO - mozprocess == 0.22 03:09:06 INFO - mozprofile == 0.27 03:09:06 INFO - mozrunner == 6.11 03:09:06 INFO - mozscreenshot == 0.1 03:09:06 INFO - mozsystemmonitor == 0.0 03:09:06 INFO - moztest == 0.7 03:09:06 INFO - mozversion == 1.4 03:09:06 INFO - psutil == 3.1.1 03:09:06 INFO - requests == 1.2.3 03:09:06 INFO - wsgiref == 0.1.2 03:09:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7ce0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a50>, '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 0x2624550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26249e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', '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 03:09:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 03:09:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:09:06 INFO - Using env: {'DISPLAY': ':0', 03:09:06 INFO - 'HOME': '/home/cltbld', 03:09:06 INFO - 'LANG': 'en_US.UTF-8', 03:09:06 INFO - 'LANGUAGE': 'en_US:en', 03:09:06 INFO - 'LOGNAME': 'cltbld', 03:09:06 INFO - 'MAIL': '/var/mail/cltbld', 03:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:06 INFO - 'MOZ_NO_REMOTE': '1', 03:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:06 INFO - 'NO_EM_RESTART': '1', 03:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:06 INFO - 'SHELL': '/bin/bash', 03:09:06 INFO - 'SHLVL': '1', 03:09:06 INFO - 'TERM': 'linux', 03:09:06 INFO - 'TMOUT': '86400', 03:09:06 INFO - 'USER': 'cltbld', 03:09:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', 03:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:06 INFO - '_': '/tools/buildbot/bin/python'} 03:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:09:06 INFO - Cleaning up... 03:09:06 INFO - Return code: 0 03:09:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7ce0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a50>, '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 0x2624550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26249e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', '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 03:09:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 03:09:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:09:06 INFO - Using env: {'DISPLAY': ':0', 03:09:06 INFO - 'HOME': '/home/cltbld', 03:09:06 INFO - 'LANG': 'en_US.UTF-8', 03:09:06 INFO - 'LANGUAGE': 'en_US:en', 03:09:06 INFO - 'LOGNAME': 'cltbld', 03:09:06 INFO - 'MAIL': '/var/mail/cltbld', 03:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:06 INFO - 'MOZ_NO_REMOTE': '1', 03:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:06 INFO - 'NO_EM_RESTART': '1', 03:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:06 INFO - 'SHELL': '/bin/bash', 03:09:06 INFO - 'SHLVL': '1', 03:09:06 INFO - 'TERM': 'linux', 03:09:06 INFO - 'TMOUT': '86400', 03:09:06 INFO - 'USER': 'cltbld', 03:09:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', 03:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:06 INFO - '_': '/tools/buildbot/bin/python'} 03:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:06 INFO - Downloading/unpacking jsonschema 03:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:09:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 03:09:08 INFO - Downloading/unpacking functools32 (from jsonschema) 03:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:08 INFO - Downloading functools32-3.2.3-2.tar.gz 03:09:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:09:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:09:08 INFO - warning: no files found matching '*.txt' 03:09:08 INFO - no previously-included directories found matching 'build' 03:09:08 INFO - no previously-included directories found matching 'dist' 03:09:08 INFO - no previously-included directories found matching '.git*' 03:09:08 INFO - Installing collected packages: jsonschema, functools32 03:09:08 INFO - Running setup.py install for functools32 03:09:08 INFO - warning: no files found matching '*.txt' 03:09:08 INFO - no previously-included directories found matching 'build' 03:09:08 INFO - no previously-included directories found matching 'dist' 03:09:08 INFO - no previously-included directories found matching '.git*' 03:09:09 INFO - Successfully installed jsonschema functools32 03:09:09 INFO - Cleaning up... 03:09:09 INFO - Return code: 0 03:09:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:09: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')]} 03:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09: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')]} 03:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09: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 0x7ff7ce0aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2626450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b8a50>, '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 0x2624550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26249e0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', '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 03:09: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 03:09: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 03:09:09 INFO - Using env: {'DISPLAY': ':0', 03:09:09 INFO - 'HOME': '/home/cltbld', 03:09:09 INFO - 'LANG': 'en_US.UTF-8', 03:09:09 INFO - 'LANGUAGE': 'en_US:en', 03:09:09 INFO - 'LOGNAME': 'cltbld', 03:09:09 INFO - 'MAIL': '/var/mail/cltbld', 03:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:09 INFO - 'MOZ_NO_REMOTE': '1', 03:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:09 INFO - 'NO_EM_RESTART': '1', 03:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:09 INFO - 'SHELL': '/bin/bash', 03:09:09 INFO - 'SHLVL': '1', 03:09:09 INFO - 'TERM': 'linux', 03:09:09 INFO - 'TMOUT': '86400', 03:09:09 INFO - 'USER': 'cltbld', 03:09:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', 03:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:09 INFO - '_': '/tools/buildbot/bin/python'} 03:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:09 INFO - Downloading/unpacking flake8 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:09:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 03:09:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:09: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 03:09:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 03:09:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:09:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:09:11 INFO - no previously-included directories found matching 'docs/_build' 03:09:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:09:11 INFO - Running setup.py install for pep8 03:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:09:11 INFO - no previously-included directories found matching 'docs/_build' 03:09:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:09:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:09:11 INFO - Cleaning up... 03:09:11 INFO - Return code: 0 03:09:11 INFO - Running post-action listener: _resource_record_post_action 03:09:11 INFO - Running post-action listener: _start_resource_monitoring 03:09:11 INFO - Starting resource monitoring. 03:09:11 INFO - ##### 03:09:11 INFO - ##### Running install step. 03:09:11 INFO - ##### 03:09:11 INFO - Running pre-action listener: _resource_record_pre_action 03:09:11 INFO - Running main action method: install 03:09:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:09:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:09:12 INFO - Reading from file tmpfile_stdout 03:09:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:09:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:09:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:09:12 INFO - Reading from file tmpfile_stdout 03:09:12 INFO - Output received: 03:09:12 INFO - Usage: mozinstall [options] installer 03:09:12 INFO - Options: 03:09:12 INFO - -h, --help show this help message and exit 03:09:12 INFO - -d DEST, --destination=DEST 03:09:12 INFO - Directory to install application into. [default: 03:09:12 INFO - "/builds/slave/test-pgo"] 03:09:12 INFO - --app=APP Application being installed. [default: firefox] 03:09:12 INFO - mkdir: /builds/slave/test-pgo/build/application 03:09:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:09:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:09:26 INFO - Reading from file tmpfile_stdout 03:09:26 INFO - Output received: 03:09:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:09:26 INFO - Running post-action listener: _resource_record_post_action 03:09:26 INFO - ##### 03:09:26 INFO - ##### Running run-tests step. 03:09:26 INFO - ##### 03:09:26 INFO - Running pre-action listener: _resource_record_pre_action 03:09:26 INFO - Running main action method: run_tests 03:09:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:09:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:09:26 INFO - Python 2.7.3 03:09:26 INFO - Return code: 0 03:09:26 INFO - grabbing minidump binary from tooltool 03:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:26 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 0x26b8a50>, '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 0x2624550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26249e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:09:26 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 03:09:26 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 03:09:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:09:26 INFO - Return code: 0 03:09:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:09:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:09:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:09:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:09:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:09:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:09:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:09:27 INFO - Return code: 0 03:09:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:09:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost 03:09:27 INFO - Using env: {'DISPLAY': ':0', 03:09:27 INFO - 'HOME': '/home/cltbld', 03:09:27 INFO - 'LANG': 'en_US.UTF-8', 03:09:27 INFO - 'LANGUAGE': 'en_US:en', 03:09:27 INFO - 'LOGNAME': 'cltbld', 03:09:27 INFO - 'MAIL': '/var/mail/cltbld', 03:09:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:09:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:27 INFO - 'MOZ_NO_REMOTE': '1', 03:09:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:27 INFO - 'NO_EM_RESTART': '1', 03:09:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:27 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:09:27 INFO - 'SHELL': '/bin/bash', 03:09:27 INFO - 'SHLVL': '1', 03:09:27 INFO - 'TERM': 'linux', 03:09:27 INFO - 'TMOUT': '86400', 03:09:27 INFO - 'USER': 'cltbld', 03:09:27 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704', 03:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:27 INFO - '_': '/tools/buildbot/bin/python'} 03:09:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost'] with output_timeout 3600 03:09:27 INFO - mozversion INFO | application_buildid: 20160107004004 03:09:27 INFO - mozversion INFO | application_changeset: a1843cf99df14fc791b56b8adddb4d47c078cfec 03:09:27 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:09:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:09:27 INFO - mozversion INFO | application_name: Firefox 03:09:27 INFO - mozversion INFO | application_remotingname: firefox-dev 03:09:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:09:27 INFO - mozversion INFO | application_vendor: Mozilla 03:09:27 INFO - mozversion INFO | application_version: 45.0a2 03:09:27 INFO - mozversion INFO | platform_buildid: 20160107004004 03:09:27 INFO - mozversion INFO | platform_changeset: a1843cf99df14fc791b56b8adddb4d47c078cfec 03:09:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:09:27 INFO - mozversion INFO | platform_version: 45.0a2 03:09:27 INFO - 2016-01-07 03:09:27,959 DEBUG : using testdate: 1452164967 03:09:27 INFO - 2016-01-07 03:09:27,960 DEBUG : actual date: 1452164967 03:09:28 INFO - 2016-01-07 03:09:28,010 INFO : starting webserver on 'localhost:53769' 03:09:28 INFO - 2016-01-07 03:09:28,011 INFO : Starting test suite talos-linux64-ix-006.e 03:09:28 INFO - 2016-01-07 03:09:28,011 INFO : Starting test dromaeo_css 03:09:28 INFO - 2016-01-07 03:09:28,011 DEBUG : operating with platform_type : linux_ 03:09:28 INFO - 2016-01-07 03:09:28,012 INFO : Initialising browser for dromaeo_css test... 03:09:28 INFO - 2016-01-07 03:09:28,024 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWM3XGk/profile http://localhost:53769/getInfo.html 03:09:32 INFO - 2016-01-07 03:09:32,454 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:09:32 INFO - 2016-01-07 03:09:32,455 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:09:32 INFO - 2016-01-07 03:09:32,455 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 03:09:32 INFO - 2016-01-07 03:09:32,455 DEBUG : BROWSER_OUTPUT: __metrics 03:09:33 INFO - 2016-01-07 03:09:33,441 INFO : Browser initialized. 03:09:33 INFO - 2016-01-07 03:09:33,442 INFO : Running cycle 1/1 for dromaeo_css test... 03:09:33 INFO - 2016-01-07 03:09:33,442 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWM3XGk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:09:45 INFO - 2016-01-07 03:09:45,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 136429568 03:09:45 INFO - 2016-01-07 03:09:45,224 DEBUG : BROWSER_OUTPUT: 03:10:34 INFO - 2016-01-07 03:10:34,842 DEBUG : BROWSER_OUTPUT: 1452165034838 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] 03:12:42 INFO - 2016-01-07 03:12:42,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53769/tests/dromaeo/cssquery-ext.html) 03:12:43 INFO - 2016-01-07 03:12:43,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 141979648 03:12:43 INFO - 2016-01-07 03:12:43,749 DEBUG : BROWSER_OUTPUT: 03:15:45 INFO - 2016-01-07 03:15:45,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/dromaeo/cssquery-ext.html (next: http://localhost:53769/tests/dromaeo/cssquery-jquery.html) 03:15:46 INFO - 2016-01-07 03:15:46,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 138883072 03:15:46 INFO - 2016-01-07 03:15:46,122 DEBUG : BROWSER_OUTPUT: 03:18:47 INFO - 2016-01-07 03:18:47,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53769/tests/dromaeo/cssquery-mootools.html) 03:18:48 INFO - 2016-01-07 03:18:48,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 139522048 03:18:48 INFO - 2016-01-07 03:18:48,231 DEBUG : BROWSER_OUTPUT: 03:21:49 INFO - 2016-01-07 03:21:49,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53769/tests/dromaeo/cssquery-prototype.html) 03:21:50 INFO - 2016-01-07 03:21:50,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 139706368 03:21:50 INFO - 2016-01-07 03:21:50,413 DEBUG : BROWSER_OUTPUT: 03:24:52 INFO - 2016-01-07 03:24:52,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53769/tests/dromaeo/cssquery-yui.html) 03:24:53 INFO - 2016-01-07 03:24:53,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 140349440 03:24:53 INFO - 2016-01-07 03:24:53,255 DEBUG : BROWSER_OUTPUT: 03:27:55 INFO - 2016-01-07 03:27:55,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/dromaeo/cssquery-yui.html (next: http://localhost:53769/tests/dromaeo/cssquery-dojo.html) 03:27:55 INFO - 2016-01-07 03:27:55,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 141770752 03:27:55 INFO - 2016-01-07 03:27:55,457 DEBUG : BROWSER_OUTPUT: 03:27:55 INFO - 2016-01-07 03:27:55,457 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:27:55 INFO - 2016-01-07 03:27:55,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:27:55 INFO - 2016-01-07 03:27:55,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:27:55 INFO - 2016-01-07 03:27:55,458 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:27:55 INFO - 2016-01-07 03:27:55,459 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3355.664433556644;3387.339468803584;3399.7960122392674;3415.197428604278;3425.0238681975643;5482.753276102575;5496.780128794843;5502.202180683798;5524.4199359067225;5539.030669632818;5468.863278418042;5525;5537.972310138443;5545.057340252157;5578.274824272849;5032.169692000824;5044.873878153039;5061.240813877929;5131.435542090367;5178.844634660947;4791.305260737191;5001.774920128585;5011.448740638527;5017.824376146836;5130.974345128269;5011.649184557083;5128.282040514331;5144;5146.202338637517;5157.871053223681;5150;5181.455947125554;5182.663126896739;5201.401838788512;5225.137852254374;4891.951080489185;4938.604911607099;4967.652264341497;5065.974670126662;5072.797088116471;5315.946840531584;5325.680459172423;5350.357957045179;5357.785688572452;5372.221027950925;5960.940390596125;5978.2228310319815;5983.491403230731;6035.909461358083;6042.758289668408;5805.158252053428;5859.179714839883;5914.674692891889;5971.790987315467;6062.696865156769;5544.1960915667405;5561.63849349791;5578.553715702734;5580.665160090408;5583.302087239135;6109.969450152721;6110.4500594945775;6112.694365281807;6113.32753397126;6117.388261173847;5728.570357223225;5790.565707571949;5790.768369265266;5836.9124463133085;5882.117682347682;5947.732352044169;5962.314333851663;5970.253718285215;6024.186734790747;6032.728527216286;5735.512481439041;5948.970255148696;5953.226080609493;5975.701214939236;5978.222831031938;5816.098504731774;5834.795782147605;5911.881762364728;5921.052631578927;5939.346671866091;4601.263797792337;4603.217453032926;4621.815127394933;4623.329617205486;4632.2819962905805;4037.6164264394833;4114.0948991221885;4123.670106391482;4155.97922010388;4156.56356082613;5533.944660553343;5631.380548139701;5647.463490968352;5667.574931880043;5721.22763426932;6005.759769609167;6022.608530445507;6032.939670603238;6048.637081775108;6062.9996050652035;5450.700211488406;5524.475174858382;5532.336119665666;5707.8858422832145;5719.370869204384;5203.479652034766;5250.7374631268285;5271.551918087006;5276.472352764693;5282.1548552232225;6200.782972596027;6201.937980620136;6235.844103897348;6236.719347629368;6247.687615619201;5812.360640329476;5916.881662366643;5944.3164036136395;6051.515878729603;6085.817425477243;6106.1451396803595;6172.698292710889;6175.9073613894925;6209.937900620936;6219.222597175353;5945.464908158114;5978.880422391441;5985.760569577343;5986.2217911671205;5986.820395388146;5744.195812586325;5843.094320380348;5906.26171728534;5908.113782932594;5910.054391297372;5797.623154494944;5872.442117998783;5873.530117590497;5882.558808089325;5932.970335148297;5840;5847.181394604674;5861.3845546217035;5869.8239052828485;5877.118432235199;5561.5272701820795;5596.972015139898;5660.85847853807;5662.207290979184;5779.855503612275;5777.480026797609;5803.564732645153;5840.824775256579;5864.413558644102;5906.320773111147;5742.856428589319;5784.595078344475;5784.913226301524;5788.21859049023;5792.768289268382 03:27:55 INFO - 2016-01-07 03:27:55,460 DEBUG : BROWSER_OUTPUT: |1;ext.html;585.6251998720817;591.9319278282996;592.1266132454629;598.5122125467747;615.9753609855607;32112.036638900812;40561.79719101404;41188.38217426741;41249;41268;46100;46436.535634643646;46796.53203467964;46832.76583617086;46892.2966155508;8884.33367497437;8929.419587726778;9002.594883230238;9008.909910900873;9026.052264512231;8834.779130521723;8967.865482017774;8972.282217422624;8986.64053437865;9011.143941325563;8910.643574257021;9000.549972501381;9010.54947252638;9026.187643112118;9028.729138125835;8931.062238464965;8959.5968181432;8979.416337938013;9006.594703238337;9022.684206052789;8867.290616750708;8987.595558199897;8990.325725570543;8994.325425593106;9024.323175761843;40874.591254087674;41023.7948810254;41106.58893411057;41122.38316425256;41244.58755412437;3394.694477497037;3793.65857072862;3973.5231772187235;4057.4928133983253;4089.9386509202386;31376;31462.685373146433;31469.8426507866;31498.212544686565;31562.842185789155;3909.4135879618;3927.7839718815453;3932.2528719543197;3990.6009399059863;4020.9396859047138;305765;308583;308908;308971;309738.99999999773;43071.35392969108;43555.782221088695;43819.56180438219;64256.35743642597;64949.35050649528;41769.79115104405;41922;42186.78906605447;42253.57746422497;42406.57593424026;15552.222388880511;15724.842751572567;15763.605909852346;15808.841911580737;15811.446599368966;11318.60384886525;11361.943190283995;11393.202475826778;11403.885961140282;11441.885581144248;14347.641308967151;14528.418863245352;14554.12675239489;14645.92677036608;14649.85350146485;5928.584999050111;5940;6002.459778619946;6043.48630366415;6060.454559089615;983.1299300119302;994.5723338964315;1113.6714669172613;1138.8633363996207;1168.6143572621015;28088.71911280861;33450;33915.15212119717;34114;34229.828850855585;1041.776018156085;1096.4956120184645;1128.2158899564724;1188.0970462448429;1204.1691233049344;14425.49510767118;14437;14504.709905802036;15038.624034399227;15048;459717;863202;922898;931210;932052;57377.13934290989;58320.4167958315;58435.70782146062;58546.41453585495;58698.41301586929;1482.688635386581;1505.4505105636365;1509.0870023635543;1519.361868015414;1528.3046213972616;29695;30179.849100754356;30464.13670175127;30746.538801918436;30897.227569310948;46822.29766553437;47059.764701176275;47140.29289560728;47198.29202562033;47818.760906195246;336766;339693;340641;341730;344011;33165.66834331722;33261.50107748434;44240.55759442364;44556.554434456535;45028.77485612551;41086.38370424386;45116.097678046914;45696.77151614221;45727.542724572326;46232;39059.6094039056;39415;39488;39537.60462395454;39853.40219896646;38067;38444.61555384522;38459.80770096132;38489.23021539498;38530.422043669925;38149;38172.61827381691;38624.42063368995;38695;38737.225255495294;32682.83658581692;34283;34491.13772155716;45060.32409513794;46174.30738538992;32100.03699889007;32841.17897052593;33346.16634584155;34731.82634086813;37199.814000930906 03:27:55 INFO - 2016-01-07 03:27:55,462 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.1471496336348;356.2732026665602;375.04176828203936;382.45118255303635;382.4645496305174;17531.64936701267;18135.909320453397;18821.99999999998;18833.05834708266;19303.710444343313;11699.707507312321;14082.295885205724;15662.451814186506;16739.66520669589;16858.494245172635;5131.076406246874;5246.396664383607;5249.632525723201;5249.790008399659;5250.343707036621;5118.667286626376;5164.354455693038;5235.136202526579;5253.789848406078;5263.76313065911;5312.096943519611;5337.492938170868;5373.731313434332;5521.696306703129;5547.389787123413;5219.321488206509;5480.479354461359;5506.531944784698;5511.614187006891;5542.63972841766;5199.428062913076;5204.0372531081875;5208.088584497736;5209.192575150858;5215.973920130413;19387.32144374954;19727.40817775469;20272;21377.251796187214;21399.67900481494;697.7836870570139;698.807827847341;701.1691145992016;1509.4829696155402;1525.4203402707012;9661.951690241574;10013.59945602175;10227;10385.169186465064;10486.108680762145;1875.3717504635963;1923.3556758485925;1925.894075825829;1931.2468137426415;1954.5797653504424;63456.38523377224;65786;68270.31729682689;69413.65293173552;69883;10818.29681070728;10881.455927203766;10894.67315980522;10897.727556811144;10927.180461465421;14100.858991409954;14129.364178611782;14153.929230353782;14198.361073751706;14238.644033899236;7906.248906353887;7960.40296977729;8224.424290299741;8255.958720206361;8286.378521610783;8118.553479558563;8143.307818835466;8158.632861521127;8170.591470426455;8204.589770511451;4574.4968053514085;4622.052479241747;4645.326427668037;4707.552782485658;4713.457952335457;1930.3533316338903;1958.0992743338224;1967.675333569945;1990.7212990181386;2015.123421311734;969.0116081596732;1043.88517263101;1044.7805960748176;1047.9476026198658;1051.579368252705;17299;17980.460586182173;18009.18958646864;18388.632227355378;18556.44330670082;1000.6697789729371;1005.1506477026901;1040.54216144896;1043.5095505112586;1080.2870105730337;7647.847043059219;10381.429021403745;10397.220208484394;10421.739456513647;10493.527791249413;674034;684477;689389;690413;706598;88345.55827220823;88959.11040889638;89033;89906;91162;1163.668354518958;1170.5668902506127;1178.929264244148;1179.5163982767197;1182.491528642692;15770.211489425254;16380;16598.25307861173;16643;16799.244034018742;34423.65576344305;34921.301573968885;34950;35164;35841.103972400895;42148.367774482795;42223.57776422196;43313.783431082644;43956.560434395244;45635.54364456313;9999.3000489965;10176.236782241214;10447.425391603534;10455.424951627734;10460.320079194827;12349.012079033835;12486.625401237978;15915.522534323989;19151.425457236306;19466.707999380305;14778.704425911637;15666.295016724047;15861;15872.206389680701;16458.259378327766;15537.378504860131;15864.682706346039;15990.440334588699;16010.839891601401;16017.119058451897;15767.842321576638;15832.654224390595;16110;16121.75817362717;16134.435294764628;10203.336783109075;10229.74425639365;10390.272680912263;10437.217208709226;10448.582056717647;13456;15928.283227255033;15941.44204952821;15979.121148336953;16002.759958600864 03:27:55 INFO - 2016-01-07 03:27:55,465 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1531.5711600751786;1534.6010037390274;1720.509654748397;1791.5162906015373;1822.842495015665;7759.844803103934;7999.160088190736;8028.718994835182;8043.316318112968;8362.498250104998;8364.330853531717;8441.366897482683;8504.234618884298;8532.104129066453;8558.358123140759;2181.7818218178213;2202.50443650179;2215.3353993801875;2217.8891055447243;2220.6335954567476;2199.59307528107;2219.212179676216;2236.552689462106;2245.62947113726;2246.84272100953;2155.622766015949;2163.1996161420298;2188.245055455873;2198.692183094368;2199.25225423356;2123.7982391672767;2146.7638559758416;2158.7301587301586;2169.642009068502;2170.6852506386563;2196.4838263008182;2237.742659594151;2246.3036458697857;2251.234580242709;2258.7628299028693;8172;8265.669373225064;8268.25585697284;8276.131006244317;8299.543525106117;4883.267509873547;4986.301917731521;5004.84985450437;5004.8999020019755;5008;2968.9554656680166;3119.9844000780076;3143.2456210509313;3158.09994151668;3165.6359518655418;951.7620594851287;968.6803354892868;970.0590427285522;971.1745016735719;998.4308943901979;10949.781004379947;10980.945095274472;10985.945070274598;11021.559137634486;11028.834567481574;4346.456692913386;4368.781560922005;4402.449693788277;4417.3815665806815;4435.955640443619;8837.204651581389;8982.640694372152;8986.775330616787;8989.05614910438;8995.28037756991;4901.5343542364135;4905.386826646669;4926.45808961014;4931.087748766418;4947.406311242602;4466.062126953376;4476.104779044204;4525.479569849509;4552.635789136861;4557.293619488984;3427.8628854846024;3443.1736383267835;3443.913902152466;3450.240946991658;3453.1194545390763;1049.3598904668147;1054.541274545575;1056.6196169379018;1058.1851973980147;1068.0547715271884;1108.6784832398675;1117.1732917640886;1174.48322737995;1366.6719987203;1434.698713270204;7732.458727889106;7742.845143097106;7822.2568855959735;7868.921310786819;7885.329746971572;1169.1990986174499;1179.4987130469517;1187.673389817807;1196;1226.0988173692328;6089.8477538061015;6090.665013424215;6102.267727872683;6102.4507794298725;6144.662043587646;9820.803583928282;9921.603135874628;10078.899211007796;10083.142932850644;10095.394276343442;9688;9875;9998.200143988464;10024.749381265527;10044.146247568893;7808.102068262223;7930.286274235346;7931.087924888597;7945.006874140617;7991.520508769492;7677.500962437423;7724.845503089794;7728.381729461517;7759.72840950564;7789.571573563282;8658.177473140042;8751.124887511198;8752.824943500967;8835.381523293308;8907.688230911886;8771.473711577326;8978.191962723386;9020.323475739477;9071.455712657262;9211.631534738535;7184.748533801292;7247.456440766858;7247.4926755128745;7281.963590182228;7297.1973082961895;7840.89382806927;7849.097353804385;7880.448368614371;7880.566568838769;7937.087234968052;7214.855702885808;7290.198078211286;7373.078365204349;7401.370883474965;7466.514676546007;7539.2083831199125;7615.390768738598;7630.923690763243;7715.652795624323;7749.961250193938;7679.884801727867;7721.53670779755;7747;7765.22347765219;7776.105747838845;6967.477439191979;6977.686004129928;7004.159500859726;7004.229534751072;7033.613151276729;7065.975433562207;7101.786946391617;7110.822229444305;7114.14630244374;7125.465590080661 03:27:55 INFO - 2016-01-07 03:27:55,467 DEBUG : BROWSER_OUTPUT: |4;prototype.html;339.6891843962774;343.3699162037661;361.30268581637444;362.3767120552649;369.37575497409387;6318.873622527558;6386.808395748123;6449.903251451226;6450.9999999999945;6526.2168539775175;6325.7153428095735;6355.71399287032;6363.71363288652;6370.426661600467;6442.581232219903;4879.878003049926;4902.142125128106;4905.632077594177;4907.975460122694;4908.43552991407;4910.779014944318;4911.042346742387;4915.2381380885845;4916.483769204236;4927.852164435055;4701.318308845215;4725.432948046239;4776.570108690217;4784.545468180518;4864.343313652665;4748.1928072227975;4766.547178018082;4769;4771.475137734847;4780.545848144421;4221.092465119983;4245;4245.8513952011535;4248.044190057243;4253.680973926967;6029.969850150765;6041.51667866574;6050.515958723336;6054.334023257438;6063.151158837766;5559.332880054379;5634.577406694473;5651.9717401413145;5663.178839068353;5677.148427735831;6688.264290927994;6693.899591506131;6696.966515167393;6701.157181775051;6726.461883049394;4660.37084993525;4671.416072990876;4699.906001879977;4708.552687494683;4708.576228139484;6844.623545704984;6939.20199177096;7008.369246767816;7013.193482749498;7090.574565526033;4724.905501890012;4789.616830653539;4795.304680821261;4796.328514008042;4809.639277054235;4836.879078023007;4839.443464001614;4857.247126695368;4881;4886.706797592155;5636.915446268309;5641;5643;5650.604457688005;5653.180288858092;6564.212294524687;6698.933010669928;6752.257251702309;6771.864562708817;6784.423324017514;1703.0973584000499;1713.6829686508036;1717.3388245525314;1720.4150588799869;1722.121717923868;1094.8795632480421;1106.6624679472839;1116.4864162485185;1123.3596849795701;1147.397616251458;6500.414962653289;6527.771527996498;6537;6546.312637173029;6577.506686998494;6950.895736563955;6996.195437524648;7002.7899163025195;7016.122984626922;7022.6488675566015;6419.16550848396;6472.093906853044;6516.837079072966;6548.476121910236;6628.668566571652;3801.5058042454857;3838.2131663009573;3842.8462861485787;3845.115623406632;3854.8265328060306;7248.96375518119;7273.709051637981;7290.562566245936;7294.270572942663;7321.670524826395;7071.469639777038;7190.7483238086415;7263.745768898063;7282.417406607458;7297.124345078624;7269.6728647211;7282.890756638654;7288.781336559911;7296.927030729731;7309.451791115581;7051.330123638246;7086.929130708627;7106.538075025107;7107.182673992557;7108.644567771694;6762.560433571802;6878.518503704692;6888.724451021903;6995.615241161785;6998.440124789903;7255.274472552703;7294.96352518234;7313;7336.303051210127;7360.374368178765;4834.468208497133;4880.633952453652;4886.340344053508;4894.2658601210105;4897.3878265216845;6894.517383783087;7037.261087585935;7112.182099058675;7128.857422851617;7153.427725781821;6813.659317034029;6818.659067046727;6821.386075253251;6848;6925.68834402443;6759.932400675931;6868.62222577763;6902.482313826584;6906.136732908387;6925.065116209247;6750.729970801113;6773.221079575715;6778.96610516964;6794.150731158606;6802.455803535607;6853.17761868579;6862.451003919575;6882.277360877236;6913.343232392915;6923.273056329013;6586.868262634816;6782.491313151435;6788.86422271542;6790.966045169743;6797.0823938767635 03:27:55 INFO - 2016-01-07 03:27:55,467 DEBUG : BROWSER_OUTPUT: |5;yui.html;823.7487566292282;832.2509741232891;874.1127755328342;920.7882187096967;925.3661242049193;13146.14550054247;13440.3951822168;13490.25803580804;13512;13516;13856.168629882213;13907.652308692288;13946.23295718735;13952.860471395283;13973.882089432846;883.8143989762158;890.7684002159452;898.0301274623391;899.7480705402497;901.2519608724742;888.9155530224618;899.4962820820328;899.5637115998735;901.5537309032038;906.5829718329576;917.729269865388;925.7593025813303;925.842606756853;926.3700683535193;928.7306681062483;915.3318077803208;915.9587818548181;916.9266458683322;924.1959495239117;933.5518950903604;689.1420181873549;693.3309356470979;693.8300116471497;693.8681650486442;694.5971336624796;14772;14972.47596334134;14976.101433914;14986.925065374713;14999.250037498081;11446.771064578661;12443.502259909592;12469.127161098726;12664.493420263178;13138.343082845915;10435.68692939213;10897.782044359148;11043.72390690231;11437;11860.584879529262;3764.209516001643;3769.321522126016;3790.848366065354;3791.620837916214;3810.6379893910034;51940.74029629865;52068.47931520712;52196.73901630506;52200.738996305154;52216;10238.283320167517;10666.413347265974;10708.357498550113;10717.517711702993;10817.567297308176;18585.163667634988;18748.906255468635;18748.906255468635;18761.7185742214;18806.529836753918;7226.241244669339;7252.709891604382;7268.5956973882;7313.451491138079;7376.446766492534;4404.361367601744;4490.236659767847;4495.505494395614;4496.595306422438;4614.838480653161;3253.511973203991;3273;3273.4107860584845;3276.8033917965;3294.061192560109;551.657972057327;553.9335279766453;567.0615131956619;570.5036618142243;591.4469970577524;695.9721611135498;716.7992961970657;730.3572855886891;731.7438896386222;761.466973118819;9187.540622968825;9778.119969202664;9791.118799308097;9819.705408837746;9824.115829575372;571.7341436232172;688.8932215506604;728.9781306560811;733.3656387225119;738.6380673470069;4178.143480586473;4196.6990233027855;4546.704464209815;4570.520095390003;4635.95364046362;63387.68306158532;63960;65516.34483655103;70049.64975175091;70142.64928675425;55243;56290.71854640783;56492.43507564954;56677.716611417505;56937.145942810894;45679.77160114178;49895;49950.750246248535;49979.50020499749;50317;8901.376903616685;8934.910650893667;9083.727488175366;9128.361014728906;9339.719808405758;34902.650973490956;34947.12632184114;35369.46945795764;35991.64008359988;36622.8168859154;46960;47040.29439558478;49235.53822308942;49460.258096127865;49566.75216623894;12428.81356779631;12480.563180288646;12543.811842822182;12878.484860605471;13154.473821047051;13530.797038044635;13557.525486608316;13575;13798.448062077405;13813.171209727449;12898.161619494704;12900.09699321076;13039.087263891437;13054.608361749162;13251.536196233086;11130.387828669502;11284.887151128383;11467.598634047768;12233.449494772578;12326.50693972231;11901.226420282654;11901.285922844658;12303.384830758605;12586.307753073668;12739.426725797175;10695.732606684895;10740.516676749408;10936.070434013198;10960.671179864617;11276.7744645105;10445.63440279617;11108.389038602954;11125.276857004268;11168.944155279172;11184.720381990515 03:27:55 INFO - 2016-01-07 03:27:55,467 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:27:55 INFO - 2016-01-07 03:27:55,467 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:27:55 INFO - 2016-01-07 03:27:55,467 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,307 03:27:55 INFO - 2016-01-07 03:27:55,467 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:27:55 INFO - 2016-01-07 03:27:55,467 DEBUG : BROWSER_OUTPUT: __startTimestamp1452166075455__endTimestamp 03:27:55 INFO - 2016-01-07 03:27:55,467 DEBUG : BROWSER_OUTPUT: 03:27:55 INFO - 2016-01-07 03:27:55,467 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:27:55 INFO - 2016-01-07 03:27:55,467 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:27:55 INFO - 2016-01-07 03:27:55,467 DEBUG : BROWSER_OUTPUT: 03:27:55 INFO - 2016-01-07 03:27:55,467 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5539.75 Median:5744.20 stddev:604.65 (10.5%) stddev-sans-first:581.72 03:27:55 INFO - 2016-01-07 03:27:55,468 DEBUG : BROWSER_OUTPUT: Values: 3355.7 3387.3 3399.8 3415.2 3425.0 5482.8 5496.8 5502.2 5524.4 5539.0 5468.9 5525.0 5538.0 5545.1 5578.3 5032.2 5044.9 5061.2 5131.4 5178.8 4791.3 5001.8 5011.4 5017.8 5131.0 5011.6 5128.3 5144.0 5146.2 5157.9 5150.0 5181.5 5182.7 5201.4 5225.1 4892.0 4938.6 4967.7 5066.0 5072.8 5315.9 5325.7 5350.4 5357.8 5372.2 5960.9 5978.2 5983.5 6035.9 6042.8 5805.2 5859.2 5914.7 5971.8 6062.7 5544.2 5561.6 5578.6 5580.7 5583.3 6110.0 6110.5 6112.7 6113.3 6117.4 5728.6 5790.6 5790.8 5836.9 5882.1 5947.7 5962.3 5970.3 6024.2 6032.7 5735.5 5949.0 5953.2 5975.7 5978.2 5816.1 5834.8 5911.9 5921.1 5939.3 4601.3 4603.2 4621.8 4623.3 4632.3 4037.6 4114.1 4123.7 4156.0 4156.6 5533.9 5631.4 5647.5 5667.6 5721.2 6005.8 6022.6 6032.9 6048.6 6063.0 5450.7 5524.5 5532.3 5707.9 5719.4 5203.5 5250.7 5271.6 5276.5 5282.2 6200.8 6201.9 6235.8 6236.7 6247.7 5812.4 5916.9 5944.3 6051.5 6085.8 6106.1 6172.7 6175.9 6209.9 6219.2 5945.5 5978.9 5985.8 5986.2 5986.8 5744.2 5843.1 5906.3 5908.1 5910.1 5797.6 5872.4 5873.5 5882.6 5933.0 5840.0 5847.2 5861.4 5869.8 5877.1 5561.5 5597.0 5660.9 5662.2 5779.9 5777.5 5803.6 5840.8 5864.4 5906.3 5742.9 5784.6 5784.9 5788.2 5792.8 03:27:55 INFO - 2016-01-07 03:27:55,468 DEBUG : BROWSER_OUTPUT: 03:27:55 INFO - 2016-01-07 03:27:55,468 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:63472.09 Median:4005.77 stddev:150010.13 (3744.9%) stddev-sans-first:150356.64 03:27:55 INFO - 2016-01-07 03:27:55,469 DEBUG : BROWSER_OUTPUT: Values: 585.6 591.9 592.1 598.5 616.0 32112.0 40561.8 41188.4 41249.0 41268.0 46100.0 46436.5 46796.5 46832.8 46892.3 8884.3 8929.4 9002.6 9008.9 9026.1 8834.8 8967.9 8972.3 8986.6 9011.1 8910.6 9000.5 9010.5 9026.2 9028.7 8931.1 8959.6 8979.4 9006.6 9022.7 8867.3 8987.6 8990.3 8994.3 9024.3 40874.6 41023.8 41106.6 41122.4 41244.6 3394.7 3793.7 3973.5 4057.5 4089.9 31376.0 31462.7 31469.8 31498.2 31562.8 3909.4 3927.8 3932.3 3990.6 4020.9 305765.0 308583.0 308908.0 308971.0 309739.0 43071.4 43555.8 43819.6 64256.4 64949.4 41769.8 41922.0 42186.8 42253.6 42406.6 15552.2 15724.8 15763.6 15808.8 15811.4 11318.6 11361.9 11393.2 11403.9 11441.9 14347.6 14528.4 14554.1 14645.9 14649.9 5928.6 5940.0 6002.5 6043.5 6060.5 983.1 994.6 1113.7 1138.9 1168.6 28088.7 33450.0 33915.2 34114.0 34229.8 1041.8 1096.5 1128.2 1188.1 1204.2 14425.5 14437.0 14504.7 15038.6 15048.0 459717.0 863202.0 922898.0 931210.0 932052.0 57377.1 58320.4 58435.7 58546.4 58698.4 1482.7 1505.5 1509.1 1519.4 1528.3 29695.0 30179.8 30464.1 30746.5 30897.2 46822.3 47059.8 47140.3 47198.3 47818.8 336766.0 339693.0 340641.0 341730.0 344011.0 33165.7 33261.5 44240.6 44556.6 45028.8 41086.4 45116.1 45696.8 45727.5 46232.0 39059.6 39415.0 39488.0 39537.6 39853.4 38067.0 38444.6 38459.8 38489.2 38530.4 38149.0 38172.6 38624.4 38695.0 38737.2 32682.8 34283.0 34491.1 45060.3 46174.3 32100.0 32841.2 33346.2 34731.8 37199.8 03:27:55 INFO - 2016-01-07 03:27:55,469 DEBUG : BROWSER_OUTPUT: 03:27:55 INFO - 2016-01-07 03:27:55,469 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33706.48 Median:10617.48 stddev:112545.92 (1060.0%) stddev-sans-first:112833.78 03:27:55 INFO - 2016-01-07 03:27:55,469 DEBUG : BROWSER_OUTPUT: Values: 353.1 356.3 375.0 382.5 382.5 17531.6 18135.9 18822.0 18833.1 19303.7 11699.7 14082.3 15662.5 16739.7 16858.5 5131.1 5246.4 5249.6 5249.8 5250.3 5118.7 5164.4 5235.1 5253.8 5263.8 5312.1 5337.5 5373.7 5521.7 5547.4 5219.3 5480.5 5506.5 5511.6 5542.6 5199.4 5204.0 5208.1 5209.2 5216.0 19387.3 19727.4 20272.0 21377.3 21399.7 697.8 698.8 701.2 1509.5 1525.4 9662.0 10013.6 10227.0 10385.2 10486.1 1875.4 1923.4 1925.9 1931.2 1954.6 63456.4 65786.0 68270.3 69413.7 69883.0 10818.3 10881.5 10894.7 10897.7 10927.2 14100.9 14129.4 14153.9 14198.4 14238.6 7906.2 7960.4 8224.4 8256.0 8286.4 8118.6 8143.3 8158.6 8170.6 8204.6 4574.5 4622.1 4645.3 4707.6 4713.5 1930.4 1958.1 1967.7 1990.7 2015.1 969.0 1043.9 1044.8 1047.9 1051.6 17299.0 17980.5 18009.2 18388.6 18556.4 1000.7 1005.2 1040.5 1043.5 1080.3 7647.8 10381.4 10397.2 10421.7 10493.5 674034.0 684477.0 689389.0 690413.0 706598.0 88345.6 88959.1 89033.0 89906.0 91162.0 1163.7 1170.6 1178.9 1179.5 1182.5 15770.2 16380.0 16598.3 16643.0 16799.2 34423.7 34921.3 34950.0 35164.0 35841.1 42148.4 42223.6 43313.8 43956.6 45635.5 9999.3 10176.2 10447.4 10455.4 10460.3 12349.0 12486.6 15915.5 19151.4 19466.7 14778.7 15666.3 15861.0 15872.2 16458.3 15537.4 15864.7 15990.4 16010.8 16017.1 15767.8 15832.7 16110.0 16121.8 16134.4 10203.3 10229.7 10390.3 10437.2 10448.6 13456.0 15928.3 15941.4 15979.1 16002.8 03:27:55 INFO - 2016-01-07 03:27:55,469 DEBUG : BROWSER_OUTPUT: 03:27:55 INFO - 2016-01-07 03:27:55,469 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5736.17 Median:6972.58 stddev:3026.75 (43.4%) stddev-sans-first:3018.75 03:27:55 INFO - 2016-01-07 03:27:55,469 DEBUG : BROWSER_OUTPUT: Values: 1531.6 1534.6 1720.5 1791.5 1822.8 7759.8 7999.2 8028.7 8043.3 8362.5 8364.3 8441.4 8504.2 8532.1 8558.4 2181.8 2202.5 2215.3 2217.9 2220.6 2199.6 2219.2 2236.6 2245.6 2246.8 2155.6 2163.2 2188.2 2198.7 2199.3 2123.8 2146.8 2158.7 2169.6 2170.7 2196.5 2237.7 2246.3 2251.2 2258.8 8172.0 8265.7 8268.3 8276.1 8299.5 4883.3 4986.3 5004.8 5004.9 5008.0 2969.0 3120.0 3143.2 3158.1 3165.6 951.8 968.7 970.1 971.2 998.4 10949.8 10980.9 10985.9 11021.6 11028.8 4346.5 4368.8 4402.4 4417.4 4436.0 8837.2 8982.6 8986.8 8989.1 8995.3 4901.5 4905.4 4926.5 4931.1 4947.4 4466.1 4476.1 4525.5 4552.6 4557.3 3427.9 3443.2 3443.9 3450.2 3453.1 1049.4 1054.5 1056.6 1058.2 1068.1 1108.7 1117.2 1174.5 1366.7 1434.7 7732.5 7742.8 7822.3 7868.9 7885.3 1169.2 1179.5 1187.7 1196.0 1226.1 6089.8 6090.7 6102.3 6102.5 6144.7 9820.8 9921.6 10078.9 10083.1 10095.4 9688.0 9875.0 9998.2 10024.7 10044.1 7808.1 7930.3 7931.1 7945.0 7991.5 7677.5 7724.8 7728.4 7759.7 7789.6 8658.2 8751.1 8752.8 8835.4 8907.7 8771.5 8978.2 9020.3 9071.5 9211.6 7184.7 7247.5 7247.5 7282.0 7297.2 7840.9 7849.1 7880.4 7880.6 7937.1 7214.9 7290.2 7373.1 7401.4 7466.5 7539.2 7615.4 7630.9 7715.7 7750.0 7679.9 7721.5 7747.0 7765.2 7776.1 6967.5 6977.7 7004.2 7004.2 7033.6 7066.0 7101.8 7110.8 7114.1 7125.5 03:27:55 INFO - 2016-01-07 03:27:55,469 DEBUG : BROWSER_OUTPUT: 03:27:55 INFO - 2016-01-07 03:27:55,471 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5686.51 Median:6486.25 stddev:1726.65 (26.6%) stddev-sans-first:1684.21 03:27:55 INFO - 2016-01-07 03:27:55,471 DEBUG : BROWSER_OUTPUT: Values: 339.7 343.4 361.3 362.4 369.4 6318.9 6386.8 6449.9 6451.0 6526.2 6325.7 6355.7 6363.7 6370.4 6442.6 4879.9 4902.1 4905.6 4908.0 4908.4 4910.8 4911.0 4915.2 4916.5 4927.9 4701.3 4725.4 4776.6 4784.5 4864.3 4748.2 4766.5 4769.0 4771.5 4780.5 4221.1 4245.0 4245.9 4248.0 4253.7 6030.0 6041.5 6050.5 6054.3 6063.2 5559.3 5634.6 5652.0 5663.2 5677.1 6688.3 6693.9 6697.0 6701.2 6726.5 4660.4 4671.4 4699.9 4708.6 4708.6 6844.6 6939.2 7008.4 7013.2 7090.6 4724.9 4789.6 4795.3 4796.3 4809.6 4836.9 4839.4 4857.2 4881.0 4886.7 5636.9 5641.0 5643.0 5650.6 5653.2 6564.2 6698.9 6752.3 6771.9 6784.4 1703.1 1713.7 1717.3 1720.4 1722.1 1094.9 1106.7 1116.5 1123.4 1147.4 6500.4 6527.8 6537.0 6546.3 6577.5 6950.9 6996.2 7002.8 7016.1 7022.6 6419.2 6472.1 6516.8 6548.5 6628.7 3801.5 3838.2 3842.8 3845.1 3854.8 7249.0 7273.7 7290.6 7294.3 7321.7 7071.5 7190.7 7263.7 7282.4 7297.1 7269.7 7282.9 7288.8 7296.9 7309.5 7051.3 7086.9 7106.5 7107.2 7108.6 6762.6 6878.5 6888.7 6995.6 6998.4 7255.3 7295.0 7313.0 7336.3 7360.4 4834.5 4880.6 4886.3 4894.3 4897.4 6894.5 7037.3 7112.2 7128.9 7153.4 6813.7 6818.7 6821.4 6848.0 6925.7 6759.9 6868.6 6902.5 6906.1 6925.1 6750.7 6773.2 6779.0 6794.2 6802.5 6853.2 6862.5 6882.3 6913.3 6923.3 6586.9 6782.5 6788.9 6791.0 6797.1 03:27:55 INFO - 2016-01-07 03:27:55,471 DEBUG : BROWSER_OUTPUT: 03:27:55 INFO - 2016-01-07 03:27:55,471 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14943.73 Median:4521.65 stddev:17542.96 (388.0%) stddev-sans-first:17560.13 03:27:55 INFO - 2016-01-07 03:27:55,471 DEBUG : BROWSER_OUTPUT: Values: 823.7 832.3 874.1 920.8 925.4 13146.1 13440.4 13490.3 13512.0 13516.0 13856.2 13907.7 13946.2 13952.9 13973.9 883.8 890.8 898.0 899.7 901.3 888.9 899.5 899.6 901.6 906.6 917.7 925.8 925.8 926.4 928.7 915.3 916.0 916.9 924.2 933.6 689.1 693.3 693.8 693.9 694.6 14772.0 14972.5 14976.1 14986.9 14999.3 11446.8 12443.5 12469.1 12664.5 13138.3 10435.7 10897.8 11043.7 11437.0 11860.6 3764.2 3769.3 3790.8 3791.6 3810.6 51940.7 52068.5 52196.7 52200.7 52216.0 10238.3 10666.4 10708.4 10717.5 10817.6 18585.2 18748.9 18748.9 18761.7 18806.5 7226.2 7252.7 7268.6 7313.5 7376.4 4404.4 4490.2 4495.5 4496.6 4614.8 3253.5 3273.0 3273.4 3276.8 3294.1 551.7 553.9 567.1 570.5 591.4 696.0 716.8 730.4 731.7 761.5 9187.5 9778.1 9791.1 9819.7 9824.1 571.7 688.9 729.0 733.4 738.6 4178.1 4196.7 4546.7 4570.5 4636.0 63387.7 63960.0 65516.3 70049.6 70142.6 55243.0 56290.7 56492.4 56677.7 56937.1 45679.8 49895.0 49950.8 49979.5 50317.0 8901.4 8934.9 9083.7 9128.4 9339.7 34902.7 34947.1 35369.5 35991.6 36622.8 46960.0 47040.3 49235.5 49460.3 49566.8 12428.8 12480.6 12543.8 12878.5 13154.5 13530.8 13557.5 13575.0 13798.4 13813.2 12898.2 12900.1 13039.1 13054.6 13251.5 11130.4 11284.9 11467.6 12233.4 12326.5 11901.2 11901.3 12303.4 12586.3 12739.4 10695.7 10740.5 10936.1 10960.7 11276.8 10445.6 11108.4 11125.3 11168.9 11184.7 03:27:55 INFO - 2016-01-07 03:27:55,471 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:27:55 INFO - 2016-01-07 03:27:55,471 DEBUG : BROWSER_OUTPUT: 03:27:56 INFO - 2016-01-07 03:27:56,153 INFO : Browser exited with error code: 0 03:27:56 INFO - 2016-01-07 03:27:56,170 INFO : Completed test dromaeo_css (00:18:28) 03:27:56 INFO - 2016-01-07 03:27:56,170 INFO : Starting test kraken 03:27:56 INFO - 2016-01-07 03:27:56,170 DEBUG : operating with platform_type : linux_ 03:27:56 INFO - 2016-01-07 03:27:56,170 INFO : Initialising browser for kraken test... 03:27:56 INFO - 2016-01-07 03:27:56,176 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqNpYcK/profile http://localhost:53769/getInfo.html 03:28:00 INFO - 2016-01-07 03:28:00,448 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:28:00 INFO - 2016-01-07 03:28:00,448 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:28:00 INFO - 2016-01-07 03:28:00,449 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 03:28:00 INFO - 2016-01-07 03:28:00,449 DEBUG : BROWSER_OUTPUT: __metrics 03:28:01 INFO - 2016-01-07 03:28:01,397 INFO : Browser initialized. 03:28:01 INFO - 2016-01-07 03:28:01,398 INFO : Running cycle 1/1 for kraken test... 03:28:01 INFO - 2016-01-07 03:28:01,398 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqNpYcK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:28:13 INFO - 2016-01-07 03:28:13,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 136736768 03:28:13 INFO - 2016-01-07 03:28:13,286 DEBUG : BROWSER_OUTPUT: 03:28:15 INFO - 2016-01-07 03:28:15,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53769/tests/kraken/driver.html?testName=audio-beat-detection) 03:28:16 INFO - 2016-01-07 03:28:16,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 138674176 03:28:16 INFO - 2016-01-07 03:28:16,364 DEBUG : BROWSER_OUTPUT: 03:28:18 INFO - 2016-01-07 03:28:18,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53769/tests/kraken/driver.html?testName=audio-dft) 03:28:19 INFO - 2016-01-07 03:28:19,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 137564160 03:28:19 INFO - 2016-01-07 03:28:19,560 DEBUG : BROWSER_OUTPUT: 03:28:22 INFO - 2016-01-07 03:28:22,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53769/tests/kraken/driver.html?testName=audio-fft) 03:28:22 INFO - 2016-01-07 03:28:22,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 138407936 03:28:22 INFO - 2016-01-07 03:28:22,935 DEBUG : BROWSER_OUTPUT: 03:28:24 INFO - 2016-01-07 03:28:24,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53769/tests/kraken/driver.html?testName=audio-oscillator) 03:28:25 INFO - 2016-01-07 03:28:25,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 139276288 03:28:25 INFO - 2016-01-07 03:28:25,538 DEBUG : BROWSER_OUTPUT: 03:28:27 INFO - 2016-01-07 03:28:27,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53769/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:28:28 INFO - 2016-01-07 03:28:28,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 139415552 03:28:28 INFO - 2016-01-07 03:28:28,307 DEBUG : BROWSER_OUTPUT: 03:28:31 INFO - 2016-01-07 03:28:31,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53769/tests/kraken/driver.html?testName=imaging-darkroom) 03:28:31 INFO - 2016-01-07 03:28:31,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 137887744 03:28:31 INFO - 2016-01-07 03:28:31,905 DEBUG : BROWSER_OUTPUT: 03:28:35 INFO - 2016-01-07 03:28:35,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53769/tests/kraken/driver.html?testName=imaging-desaturate) 03:28:35 INFO - 2016-01-07 03:28:35,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 137932800 03:28:35 INFO - 2016-01-07 03:28:35,828 DEBUG : BROWSER_OUTPUT: 03:28:38 INFO - 2016-01-07 03:28:38,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53769/tests/kraken/driver.html?testName=json-parse-financial) 03:28:39 INFO - 2016-01-07 03:28:39,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 137900032 03:28:39 INFO - 2016-01-07 03:28:39,261 DEBUG : BROWSER_OUTPUT: 03:28:40 INFO - 2016-01-07 03:28:40,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53769/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:28:41 INFO - 2016-01-07 03:28:41,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 138350592 03:28:41 INFO - 2016-01-07 03:28:41,459 DEBUG : BROWSER_OUTPUT: 03:28:43 INFO - 2016-01-07 03:28:43,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53769/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:28:43 INFO - 2016-01-07 03:28:43,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 138326016 03:28:43 INFO - 2016-01-07 03:28:43,837 DEBUG : BROWSER_OUTPUT: 03:28:45 INFO - 2016-01-07 03:28:45,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53769/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:28:46 INFO - 2016-01-07 03:28:46,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 137932800 03:28:46 INFO - 2016-01-07 03:28:46,484 DEBUG : BROWSER_OUTPUT: 03:28:48 INFO - 2016-01-07 03:28:48,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:28:49 INFO - 2016-01-07 03:28:49,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 138493952 03:28:49 INFO - 2016-01-07 03:28:49,449 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-07 03:28:51,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:28:52 INFO - 2016-01-07 03:28:52,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 139071488 03:28:52 INFO - 2016-01-07 03:28:52,538 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53769/tests/kraken/driver.html?testName=ai-astar) 03:28:54 INFO - 2016-01-07 03:28:54,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 138256384 03:28:54 INFO - 2016-01-07 03:28:54,453 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,455 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:28:54 INFO - 2016-01-07 03:28:54,455 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:28:54 INFO - 2016-01-07 03:28:54,455 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:28:54 INFO - 2016-01-07 03:28:54,455 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:28:54 INFO - 2016-01-07 03:28:54,456 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;103;109;109;113;120;110;109;110;110 03:28:54 INFO - 2016-01-07 03:28:54,456 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;123;148;161;122;147;158;126;157;125 03:28:54 INFO - 2016-01-07 03:28:54,456 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;162;161;163;160;159;162;164;162 03:28:54 INFO - 2016-01-07 03:28:54,457 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;72;74;163;72;73;71;72;162;73 03:28:54 INFO - 2016-01-07 03:28:54,457 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;93;136;93;93;93;136;92;94;140 03:28:54 INFO - 2016-01-07 03:28:54,457 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;109;111;109;110;110;110;110;110 03:28:54 INFO - 2016-01-07 03:28:54,457 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;145;147;145;147;146;146;146;146;146 03:28:54 INFO - 2016-01-07 03:28:54,457 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;98;96;96;97;96;96;95 03:28:54 INFO - 2016-01-07 03:28:54,457 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;62;61;66;67;62;69;61;64;64 03:28:54 INFO - 2016-01-07 03:28:54,458 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;64;64;65;64;64;64;64;64 03:28:54 INFO - 2016-01-07 03:28:54,458 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;80;82;83;82;82;82;82;82;83 03:28:54 INFO - 2016-01-07 03:28:54,458 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;114;113;121;121;125;119;120;114;114 03:28:54 INFO - 2016-01-07 03:28:54,458 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;144;134;137;142;147;149;145;144;147 03:28:54 INFO - 2016-01-07 03:28:54,458 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;70;66;68;69;65;73;67;69 03:28:54 INFO - 2016-01-07 03:28:54,458 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:28:54 INFO - 2016-01-07 03:28:54,458 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:28:54 INFO - 2016-01-07 03:28:54,459 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,711 03:28:54 INFO - 2016-01-07 03:28:54,459 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:28:54 INFO - 2016-01-07 03:28:54,459 DEBUG : BROWSER_OUTPUT: __startTimestamp1452166134454__endTimestamp 03:28:54 INFO - 2016-01-07 03:28:54,459 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,459 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:28:54 INFO - 2016-01-07 03:28:54,459 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:28:54 INFO - 2016-01-07 03:28:54,459 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,461 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:110.00 stddev:4.22 (3.8%) stddev-sans-first:4.47 03:28:54 INFO - 2016-01-07 03:28:54,461 DEBUG : BROWSER_OUTPUT: Values: 110.0 103.0 109.0 109.0 113.0 120.0 110.0 109.0 110.0 110.0 03:28:54 INFO - 2016-01-07 03:28:54,461 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,461 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.50 Median:152.50 stddev:16.54 (10.8%) stddev-sans-first:16.57 03:28:54 INFO - 2016-01-07 03:28:54,461 DEBUG : BROWSER_OUTPUT: Values: 158.0 123.0 148.0 161.0 122.0 147.0 158.0 126.0 157.0 125.0 03:28:54 INFO - 2016-01-07 03:28:54,461 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,461 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.48 (0.9%) stddev-sans-first:1.50 03:28:54 INFO - 2016-01-07 03:28:54,461 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 162.0 161.0 163.0 160.0 159.0 162.0 164.0 162.0 03:28:54 INFO - 2016-01-07 03:28:54,462 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,462 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:91.00 Median:72.50 stddev:37.73 (52.0%) stddev-sans-first:39.73 03:28:54 INFO - 2016-01-07 03:28:54,462 DEBUG : BROWSER_OUTPUT: Values: 78.0 72.0 74.0 163.0 72.0 73.0 71.0 72.0 162.0 73.0 03:28:54 INFO - 2016-01-07 03:28:54,462 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,463 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:93.00 stddev:21.32 (22.9%) stddev-sans-first:22.20 03:28:54 INFO - 2016-01-07 03:28:54,463 DEBUG : BROWSER_OUTPUT: Values: 95.0 93.0 136.0 93.0 93.0 93.0 136.0 92.0 94.0 140.0 03:28:54 INFO - 2016-01-07 03:28:54,463 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,463 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 03:28:54 INFO - 2016-01-07 03:28:54,463 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 109.0 111.0 109.0 110.0 110.0 110.0 110.0 110.0 03:28:54 INFO - 2016-01-07 03:28:54,463 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,464 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 03:28:54 INFO - 2016-01-07 03:28:54,464 DEBUG : BROWSER_OUTPUT: Values: 148.0 145.0 147.0 145.0 147.0 146.0 146.0 146.0 146.0 146.0 03:28:54 INFO - 2016-01-07 03:28:54,464 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,464 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 03:28:54 INFO - 2016-01-07 03:28:54,465 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 98.0 96.0 96.0 97.0 96.0 96.0 95.0 03:28:54 INFO - 2016-01-07 03:28:54,465 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,465 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.40 Median:64.00 stddev:3.27 (5.1%) stddev-sans-first:2.83 03:28:54 INFO - 2016-01-07 03:28:54,465 DEBUG : BROWSER_OUTPUT: Values: 58.0 62.0 61.0 66.0 67.0 62.0 69.0 61.0 64.0 64.0 03:28:54 INFO - 2016-01-07 03:28:54,466 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,466 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 03:28:54 INFO - 2016-01-07 03:28:54,466 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 64.0 03:28:54 INFO - 2016-01-07 03:28:54,466 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,466 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:0.88 (1.1%) stddev-sans-first:0.87 03:28:54 INFO - 2016-01-07 03:28:54,466 DEBUG : BROWSER_OUTPUT: Values: 81.0 80.0 82.0 83.0 82.0 82.0 82.0 82.0 82.0 83.0 03:28:54 INFO - 2016-01-07 03:28:54,466 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,466 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:119.50 stddev:4.06 (3.4%) stddev-sans-first:4.26 03:28:54 INFO - 2016-01-07 03:28:54,466 DEBUG : BROWSER_OUTPUT: Values: 116.0 114.0 113.0 121.0 121.0 125.0 119.0 120.0 114.0 114.0 03:28:54 INFO - 2016-01-07 03:28:54,467 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,467 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:144.50 stddev:4.61 (3.2%) stddev-sans-first:4.89 03:28:54 INFO - 2016-01-07 03:28:54,467 DEBUG : BROWSER_OUTPUT: Values: 143.0 144.0 134.0 137.0 142.0 147.0 149.0 145.0 144.0 147.0 03:28:54 INFO - 2016-01-07 03:28:54,467 DEBUG : BROWSER_OUTPUT: 03:28:54 INFO - 2016-01-07 03:28:54,468 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:2.36 (3.4%) stddev-sans-first:2.39 03:28:54 INFO - 2016-01-07 03:28:54,468 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 70.0 66.0 68.0 69.0 65.0 73.0 67.0 69.0 03:28:54 INFO - 2016-01-07 03:28:54,468 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:28:54 INFO - 2016-01-07 03:28:54,468 DEBUG : BROWSER_OUTPUT: 03:28:55 INFO - 2016-01-07 03:28:55,273 INFO : Browser exited with error code: 0 03:28:55 INFO - 2016-01-07 03:28:55,387 INFO : Completed test kraken (00:00:59) 03:28:55 INFO - 2016-01-07 03:28:55,387 INFO : Starting test v8_7 03:28:55 INFO - 2016-01-07 03:28:55,388 DEBUG : operating with platform_type : linux_ 03:28:55 INFO - 2016-01-07 03:28:55,388 INFO : Initialising browser for v8_7 test... 03:28:55 INFO - 2016-01-07 03:28:55,394 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA7J1Fh/profile http://localhost:53769/getInfo.html 03:28:59 INFO - 2016-01-07 03:28:59,591 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:28:59 INFO - 2016-01-07 03:28:59,591 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:28:59 INFO - 2016-01-07 03:28:59,591 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 03:28:59 INFO - 2016-01-07 03:28:59,591 DEBUG : BROWSER_OUTPUT: __metrics 03:29:00 INFO - 2016-01-07 03:29:00,529 INFO : Browser initialized. 03:29:00 INFO - 2016-01-07 03:29:00,530 INFO : Running cycle 1/1 for v8_7 test... 03:29:00 INFO - 2016-01-07 03:29:00,530 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA7J1Fh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:29:12 INFO - 2016-01-07 03:29:12,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 136347648 03:29:12 INFO - 2016-01-07 03:29:12,335 DEBUG : BROWSER_OUTPUT: 03:29:33 INFO - 2016-01-07 03:29:33,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53769/tests/v8_7/run.html (next: http://localhost:53769/tests/v8_7/run.html) 03:29:33 INFO - 2016-01-07 03:29:33,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 135987200 03:29:33 INFO - 2016-01-07 03:29:33,982 DEBUG : BROWSER_OUTPUT: 03:29:33 INFO - 2016-01-07 03:29:33,982 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:29:33 INFO - 2016-01-07 03:29:33,982 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:29:33 INFO - 2016-01-07 03:29:33,982 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:29:33 INFO - 2016-01-07 03:29:33,982 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:29:33 INFO - 2016-01-07 03:29:33,983 DEBUG : BROWSER_OUTPUT: |0;Richards;166.88918558077435 03:29:33 INFO - 2016-01-07 03:29:33,983 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.80567139282735 03:29:33 INFO - 2016-01-07 03:29:33,983 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.09572983533354 03:29:33 INFO - 2016-01-07 03:29:33,983 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5207.253886010362 03:29:33 INFO - 2016-01-07 03:29:33,984 DEBUG : BROWSER_OUTPUT: |4;RayTrace;921.6589861751152 03:29:33 INFO - 2016-01-07 03:29:33,984 DEBUG : BROWSER_OUTPUT: |5;Earley;548.5463521667581 03:29:33 INFO - 2016-01-07 03:29:33,984 DEBUG : BROWSER_OUTPUT: |6;Boyer;11021.978021978022 03:29:33 INFO - 2016-01-07 03:29:33,984 DEBUG : BROWSER_OUTPUT: |7;RegExp;24214.285714285714 03:29:33 INFO - 2016-01-07 03:29:33,985 DEBUG : BROWSER_OUTPUT: |8;Splay;521.9206680584551 03:29:33 INFO - 2016-01-07 03:29:33,985 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 03:29:33 INFO - 2016-01-07 03:29:33,985 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:29:33 INFO - 2016-01-07 03:29:33,985 DEBUG : BROWSER_OUTPUT: __startTimestamp1452166173978__endTimestamp 03:29:33 INFO - 2016-01-07 03:29:33,985 DEBUG : BROWSER_OUTPUT: 03:29:33 INFO - 2016-01-07 03:29:33,985 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:29:33 INFO - 2016-01-07 03:29:33,986 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:29:33 INFO - 2016-01-07 03:29:33,986 DEBUG : BROWSER_OUTPUT: 03:29:33 INFO - 2016-01-07 03:29:33,986 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.89 Median:166.89 stddev:0.00 (0.0%) 03:29:33 INFO - 2016-01-07 03:29:33,986 DEBUG : BROWSER_OUTPUT: Values: 166.9 03:29:33 INFO - 2016-01-07 03:29:33,986 DEBUG : BROWSER_OUTPUT: 03:29:33 INFO - 2016-01-07 03:29:33,986 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.81 Median:166.81 stddev:0.00 (0.0%) 03:29:33 INFO - 2016-01-07 03:29:33,986 DEBUG : BROWSER_OUTPUT: Values: 166.8 03:29:33 INFO - 2016-01-07 03:29:33,987 DEBUG : BROWSER_OUTPUT: 03:29:33 INFO - 2016-01-07 03:29:33,987 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 03:29:33 INFO - 2016-01-07 03:29:33,987 DEBUG : BROWSER_OUTPUT: Values: 279.1 03:29:33 INFO - 2016-01-07 03:29:33,987 DEBUG : BROWSER_OUTPUT: 03:29:33 INFO - 2016-01-07 03:29:33,987 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5207.25 Median:5207.25 stddev:0.00 (0.0%) 03:29:33 INFO - 2016-01-07 03:29:33,987 DEBUG : BROWSER_OUTPUT: Values: 5207.3 03:29:33 INFO - 2016-01-07 03:29:33,987 DEBUG : BROWSER_OUTPUT: 03:29:33 INFO - 2016-01-07 03:29:33,987 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:921.66 Median:921.66 stddev:0.00 (0.0%) 03:29:33 INFO - 2016-01-07 03:29:33,988 DEBUG : BROWSER_OUTPUT: Values: 921.7 03:29:33 INFO - 2016-01-07 03:29:33,988 DEBUG : BROWSER_OUTPUT: 03:29:33 INFO - 2016-01-07 03:29:33,988 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:548.55 Median:548.55 stddev:0.00 (0.0%) 03:29:33 INFO - 2016-01-07 03:29:33,988 DEBUG : BROWSER_OUTPUT: Values: 548.5 03:29:33 INFO - 2016-01-07 03:29:33,988 DEBUG : BROWSER_OUTPUT: 03:29:33 INFO - 2016-01-07 03:29:33,989 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11021.98 Median:11021.98 stddev:0.00 (0.0%) 03:29:33 INFO - 2016-01-07 03:29:33,989 DEBUG : BROWSER_OUTPUT: Values: 11022.0 03:29:33 INFO - 2016-01-07 03:29:33,989 DEBUG : BROWSER_OUTPUT: 03:29:33 INFO - 2016-01-07 03:29:33,989 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24214.29 Median:24214.29 stddev:0.00 (0.0%) 03:29:33 INFO - 2016-01-07 03:29:33,989 DEBUG : BROWSER_OUTPUT: Values: 24214.3 03:29:33 INFO - 2016-01-07 03:29:33,989 DEBUG : BROWSER_OUTPUT: 03:29:33 INFO - 2016-01-07 03:29:33,989 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:521.92 Median:521.92 stddev:0.00 (0.0%) 03:29:33 INFO - 2016-01-07 03:29:33,990 DEBUG : BROWSER_OUTPUT: Values: 521.9 03:29:33 INFO - 2016-01-07 03:29:33,990 DEBUG : BROWSER_OUTPUT: 03:29:33 INFO - 2016-01-07 03:29:33,990 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 03:29:33 INFO - 2016-01-07 03:29:33,990 DEBUG : BROWSER_OUTPUT: Values: 4826.9 03:29:33 INFO - 2016-01-07 03:29:33,990 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:29:33 INFO - 2016-01-07 03:29:33,990 DEBUG : BROWSER_OUTPUT: 03:29:34 INFO - 2016-01-07 03:29:34,862 INFO : Browser exited with error code: 0 03:29:34 INFO - 2016-01-07 03:29:34,876 INFO : Completed test v8_7 (00:00:39) 03:29:35 INFO - 2016-01-07 03:29:35,049 INFO : Completed test suite (00:20:07) 03:29:35 INFO - 2016-01-07 03:29:35,049 DEBUG : Working with test: dromaeo_css 03:29:35 INFO - 2016-01-07 03:29:35,049 DEBUG : Generating results file: dromaeo_css 03:29:35 INFO - 2016-01-07 03:29:35,050 DEBUG : Working with test: kraken 03:29:35 INFO - 2016-01-07 03:29:35,051 DEBUG : Generating results file: kraken 03:29:35 INFO - 2016-01-07 03:29:35,051 INFO : javascript benchmark 03:29:35 INFO - 2016-01-07 03:29:35,051 DEBUG : Working with test: v8_7 03:29:35 INFO - 2016-01-07 03:29:35,051 DEBUG : Generating results file: v8_7 03:29:35 INFO - 2016-01-07 03:29:35,051 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:29:35 INFO - 2016-01-07 03:29:35,195 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 03:29:35 INFO - 2016-01-07 03:29:35,196 DEBUG : process_Request line: dromaeo_css 7371.20 graph.html#tests=[[72,52,43]] 03:29:35 INFO - 2016-01-07 03:29:35,196 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:29:35 INFO - 2016-01-07 03:29:35,298 DEBUG : process_Request line: kraken 1502.90 graph.html#tests=[[232,52,43]] 03:29:35 INFO - 2016-01-07 03:29:35,298 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:29:35 INFO - 2016-01-07 03:29:35,343 DEBUG : process_Request line: v8_7 23205.18 graph.html#tests=[[230,52,43]] 03:29:35 INFO - 2016-01-07 03:29:35,344 INFO : javascript benchmark 03:29:35 INFO - 2016-01-07 03:29:35,348 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3355.664433556644, 3387.339468803584, 3399.7960122392674, 3415.197428604278, 3425.0238681975643, 5482.753276102575, 5496.780128794843, 5502.202180683798, 5524.4199359067225, 5539.030669632818, 5468.863278418042, 5525.0, 5537.972310138443, 5545.057340252157, 5578.274824272849, 5032.169692000824, 5044.873878153039, 5061.240813877929, 5131.435542090367, 5178.844634660947, 4791.305260737191, 5001.774920128585, 5011.448740638527, 5017.824376146836, 5130.974345128269, 5011.649184557083, 5128.282040514331, 5144.0, 5146.202338637517, 5157.871053223681, 5150.0, 5181.455947125554, 5182.663126896739, 5201.401838788512, 5225.137852254374, 4891.951080489185, 4938.604911607099, 4967.652264341497, 5065.974670126662, 5072.797088116471, 5315.946840531584, 5325.680459172423, 5350.357957045179, 5357.785688572452, 5372.221027950925, 5960.940390596125, 5978.2228310319815, 5983.491403230731, 6035.909461358083, 6042.758289668408, 5805.158252053428, 5859.179714839883, 5914.674692891889, 5971.790987315467, 6062.696865156769, 5544.1960915667405, 5561.63849349791, 5578.553715702734, 5580.665160090408, 5583.302087239135, 6109.969450152721, 6110.4500594945775, 6112.694365281807, 6113.32753397126, 6117.388261173847, 5728.570357223225, 5790.565707571949, 5790.768369265266, 5836.9124463133085, 5882.117682347682, 5947.732352044169, 5962.314333851663, 5970.253718285215, 6024.186734790747, 6032.728527216286, 5735.512481439041, 5948.970255148696, 5953.226080609493, 5975.701214939236, 5978.222831031938, 5816.098504731774, 5834.795782147605, 5911.881762364728, 5921.052631578927, 5939.346671866091, 4601.263797792337, 4603.217453032926, 4621.815127394933, 4623.329617205486, 4632.2819962905805, 4037.6164264394833, 4114.0948991221885, 4123.670106391482, 4155.97922010388, 4156.56356082613, 5533.944660553343, 5631.380548139701, 5647.463490968352, 5667.574931880043, 5721.22763426932, 6005.759769609167, 6022.608530445507, 6032.939670603238, 6048.637081775108, 6062.9996050652035, 5450.700211488406, 5524.475174858382, 5532.336119665666, 5707.8858422832145, 5719.370869204384, 5203.479652034766, 5250.7374631268285, 5271.551918087006, 5276.472352764693, 5282.1548552232225, 6200.782972596027, 6201.937980620136, 6235.844103897348, 6236.719347629368, 6247.687615619201, 5812.360640329476, 5916.881662366643, 5944.3164036136395, 6051.515878729603, 6085.817425477243, 6106.1451396803595, 6172.698292710889, 6175.9073613894925, 6209.937900620936, 6219.222597175353, 5945.464908158114, 5978.880422391441, 5985.760569577343, 5986.2217911671205, 5986.820395388146, 5744.195812586325, 5843.094320380348, 5906.26171728534, 5908.113782932594, 5910.054391297372, 5797.623154494944, 5872.442117998783, 5873.530117590497, 5882.558808089325, 5932.970335148297, 5840.0, 5847.181394604674, 5861.3845546217035, 5869.8239052828485, 5877.118432235199, 5561.5272701820795, 5596.972015139898, 5660.85847853807, 5662.207290979184, 5779.855503612275, 5777.480026797609, 5803.564732645153, 5840.824775256579, 5864.413558644102, 5906.320773111147, 5742.856428589319, 5784.595078344475, 5784.913226301524, 5788.21859049023, 5792.768289268382], "unit": "ms", "name": "dojo.html", "value": 5501.54431822767}, {"lowerIsBetter": false, "replicates": [585.6251998720817, 591.9319278282996, 592.1266132454629, 598.5122125467747, 615.9753609855607, 32112.036638900812, 40561.79719101404, 41188.38217426741, 41249.0, 41268.0, 46100.0, 46436.535634643646, 46796.53203467964, 46832.76583617086, 46892.2966155508, 8884.33367497437, 8929.419587726778, 9002.594883230238, 9008.909910900873, 9026.052264512231, 8834.779130521723, 8967.865482017774, 8972.282217422624, 8986.64053437865, 9011.143941325563, 8910.643574257021, 9000.549972501381, 9010.54947252638, 9026.187643112118, 9028.729138125835, 8931.062238464965, 8959.5968181432, 8979.416337938013, 9006.594703238337, 9022.684206052789, 8867.290616750708, 8987.595558199897, 8990.325725570543, 8994.325425593106, 9024.323175761843, 40874.591254087674, 41023.7948810254, 41106.58893411057, 41122.38316425256, 41244.58755412437, 3394.694477497037, 3793.65857072862, 3973.5231772187235, 4057.4928133983253, 4089.9386509202386, 31376.0, 31462.685373146433, 31469.8426507866, 31498.212544686565, 31562.842185789155, 3909.4135879618, 3927.7839718815453, 3932.2528719543197, 3990.6009399059863, 4020.9396859047138, 305765.0, 308583.0, 308908.0, 308971.0, 309738.99999999773, 43071.35392969108, 43555.782221088695, 43819.56180438219, 64256.35743642597, 64949.35050649528, 41769.79115104405, 41922.0, 42186.78906605447, 42253.57746422497, 42406.57593424026, 15552.222388880511, 15724.842751572567, 15763.605909852346, 15808.841911580737, 15811.446599368966, 11318.60384886525, 11361.943190283995, 11393.202475826778, 11403.885961140282, 11441.885581144248, 14347.641308967151, 14528.418863245352, 14554.12675239489, 14645.92677036608, 14649.85350146485, 5928.584999050111, 5940.0, 6002.459778619946, 6043.48630366415, 6060.454559089615, 983.1299300119302, 994.5723338964315, 1113.6714669172613, 1138.8633363996207, 1168.6143572621015, 28088.71911280861, 33450.0, 33915.15212119717, 34114.0, 34229.828850855585, 1041.776018156085, 1096.4956120184645, 1128.2158899564724, 1188.0970462448429, 1204.1691233049344, 14425.49510767118, 14437.0, 14504.709905802036, 15038.624034399227, 15048.0, 459717.0, 863202.0, 922898.0, 931210.0, 932052.0, 57377.13934290989, 58320.4167958315, 58435.70782146062, 58546.41453585495, 58698.41301586929, 1482.688635386581, 1505.4505105636365, 1509.0870023635543, 1519.361868015414, 1528.3046213972616, 29695.0, 30179.849100754356, 30464.13670175127, 30746.538801918436, 30897.227569310948, 46822.29766553437, 47059.764701176275, 47140.29289560728, 47198.29202562033, 47818.760906195246, 336766.0, 339693.0, 340641.0, 341730.0, 344011.0, 33165.66834331722, 33261.50107748434, 44240.55759442364, 44556.554434456535, 45028.77485612551, 41086.38370424386, 45116.097678046914, 45696.77151614221, 45727.542724572326, 46232.0, 39059.6094039056, 39415.0, 39488.0, 39537.60462395454, 39853.40219896646, 38067.0, 38444.61555384522, 38459.80770096132, 38489.23021539498, 38530.422043669925, 38149.0, 38172.61827381691, 38624.42063368995, 38695.0, 38737.225255495294, 32682.83658581692, 34283.0, 34491.13772155716, 45060.32409513794, 46174.30738538992, 32100.03699889007, 32841.17897052593, 33346.16634584155, 34731.82634086813, 37199.814000930906], "unit": "ms", "name": "ext.html", "value": 19671.608096882548}, {"lowerIsBetter": false, "replicates": [353.1471496336348, 356.2732026665602, 375.04176828203936, 382.45118255303635, 382.4645496305174, 17531.64936701267, 18135.909320453397, 18821.99999999998, 18833.05834708266, 19303.710444343313, 11699.707507312321, 14082.295885205724, 15662.451814186506, 16739.66520669589, 16858.494245172635, 5131.076406246874, 5246.396664383607, 5249.632525723201, 5249.790008399659, 5250.343707036621, 5118.667286626376, 5164.354455693038, 5235.136202526579, 5253.789848406078, 5263.76313065911, 5312.096943519611, 5337.492938170868, 5373.731313434332, 5521.696306703129, 5547.389787123413, 5219.321488206509, 5480.479354461359, 5506.531944784698, 5511.614187006891, 5542.63972841766, 5199.428062913076, 5204.0372531081875, 5208.088584497736, 5209.192575150858, 5215.973920130413, 19387.32144374954, 19727.40817775469, 20272.0, 21377.251796187214, 21399.67900481494, 697.7836870570139, 698.807827847341, 701.1691145992016, 1509.4829696155402, 1525.4203402707012, 9661.951690241574, 10013.59945602175, 10227.0, 10385.169186465064, 10486.108680762145, 1875.3717504635963, 1923.3556758485925, 1925.894075825829, 1931.2468137426415, 1954.5797653504424, 63456.38523377224, 65786.0, 68270.31729682689, 69413.65293173552, 69883.0, 10818.29681070728, 10881.455927203766, 10894.67315980522, 10897.727556811144, 10927.180461465421, 14100.858991409954, 14129.364178611782, 14153.929230353782, 14198.361073751706, 14238.644033899236, 7906.248906353887, 7960.40296977729, 8224.424290299741, 8255.958720206361, 8286.378521610783, 8118.553479558563, 8143.307818835466, 8158.632861521127, 8170.591470426455, 8204.589770511451, 4574.4968053514085, 4622.052479241747, 4645.326427668037, 4707.552782485658, 4713.457952335457, 1930.3533316338903, 1958.0992743338224, 1967.675333569945, 1990.7212990181386, 2015.123421311734, 969.0116081596732, 1043.88517263101, 1044.7805960748176, 1047.9476026198658, 1051.579368252705, 17299.0, 17980.460586182173, 18009.18958646864, 18388.632227355378, 18556.44330670082, 1000.6697789729371, 1005.1506477026901, 1040.54216144896, 1043.5095505112586, 1080.2870105730337, 7647.847043059219, 10381.429021403745, 10397.220208484394, 10421.739456513647, 10493.527791249413, 674034.0, 684477.0, 689389.0, 690413.0, 706598.0, 88345.55827220823, 88959.11040889638, 89033.0, 89906.0, 91162.0, 1163.668354518958, 1170.5668902506127, 1178.929264244148, 1179.5163982767197, 1182.491528642692, 15770.211489425254, 16380.0, 16598.25307861173, 16643.0, 16799.244034018742, 34423.65576344305, 34921.301573968885, 34950.0, 35164.0, 35841.103972400895, 42148.367774482795, 42223.57776422196, 43313.783431082644, 43956.560434395244, 45635.54364456313, 9999.3000489965, 10176.236782241214, 10447.425391603534, 10455.424951627734, 10460.320079194827, 12349.012079033835, 12486.625401237978, 15915.522534323989, 19151.425457236306, 19466.707999380305, 14778.704425911637, 15666.295016724047, 15861.0, 15872.206389680701, 16458.259378327766, 15537.378504860131, 15864.682706346039, 15990.440334588699, 16010.839891601401, 16017.119058451897, 15767.842321576638, 15832.654224390595, 16110.0, 16121.75817362717, 16134.435294764628, 10203.336783109075, 10229.74425639365, 10390.272680912263, 10437.217208709226, 10448.582056717647, 13456.0, 15928.283227255033, 15941.44204952821, 15979.121148336953, 16002.759958600864], "unit": "ms", "name": "jquery.html", "value": 9146.96978730136}, {"lowerIsBetter": false, "replicates": [1531.5711600751786, 1534.6010037390274, 1720.509654748397, 1791.5162906015373, 1822.842495015665, 7759.844803103934, 7999.160088190736, 8028.718994835182, 8043.316318112968, 8362.498250104998, 8364.330853531717, 8441.366897482683, 8504.234618884298, 8532.104129066453, 8558.358123140759, 2181.7818218178213, 2202.50443650179, 2215.3353993801875, 2217.8891055447243, 2220.6335954567476, 2199.59307528107, 2219.212179676216, 2236.552689462106, 2245.62947113726, 2246.84272100953, 2155.622766015949, 2163.1996161420298, 2188.245055455873, 2198.692183094368, 2199.25225423356, 2123.7982391672767, 2146.7638559758416, 2158.7301587301586, 2169.642009068502, 2170.6852506386563, 2196.4838263008182, 2237.742659594151, 2246.3036458697857, 2251.234580242709, 2258.7628299028693, 8172.0, 8265.669373225064, 8268.25585697284, 8276.131006244317, 8299.543525106117, 4883.267509873547, 4986.301917731521, 5004.84985450437, 5004.8999020019755, 5008.0, 2968.9554656680166, 3119.9844000780076, 3143.2456210509313, 3158.09994151668, 3165.6359518655418, 951.7620594851287, 968.6803354892868, 970.0590427285522, 971.1745016735719, 998.4308943901979, 10949.781004379947, 10980.945095274472, 10985.945070274598, 11021.559137634486, 11028.834567481574, 4346.456692913386, 4368.781560922005, 4402.449693788277, 4417.3815665806815, 4435.955640443619, 8837.204651581389, 8982.640694372152, 8986.775330616787, 8989.05614910438, 8995.28037756991, 4901.5343542364135, 4905.386826646669, 4926.45808961014, 4931.087748766418, 4947.406311242602, 4466.062126953376, 4476.104779044204, 4525.479569849509, 4552.635789136861, 4557.293619488984, 3427.8628854846024, 3443.1736383267835, 3443.913902152466, 3450.240946991658, 3453.1194545390763, 1049.3598904668147, 1054.541274545575, 1056.6196169379018, 1058.1851973980147, 1068.0547715271884, 1108.6784832398675, 1117.1732917640886, 1174.48322737995, 1366.6719987203, 1434.698713270204, 7732.458727889106, 7742.845143097106, 7822.2568855959735, 7868.921310786819, 7885.329746971572, 1169.1990986174499, 1179.4987130469517, 1187.673389817807, 1196.0, 1226.0988173692328, 6089.8477538061015, 6090.665013424215, 6102.267727872683, 6102.4507794298725, 6144.662043587646, 9820.803583928282, 9921.603135874628, 10078.899211007796, 10083.142932850644, 10095.394276343442, 9688.0, 9875.0, 9998.200143988464, 10024.749381265527, 10044.146247568893, 7808.102068262223, 7930.286274235346, 7931.087924888597, 7945.006874140617, 7991.520508769492, 7677.500962437423, 7724.845503089794, 7728.381729461517, 7759.72840950564, 7789.571573563282, 8658.177473140042, 8751.124887511198, 8752.824943500967, 8835.381523293308, 8907.688230911886, 8771.473711577326, 8978.191962723386, 9020.323475739477, 9071.455712657262, 9211.631534738535, 7184.748533801292, 7247.456440766858, 7247.4926755128745, 7281.963590182228, 7297.1973082961895, 7840.89382806927, 7849.097353804385, 7880.448368614371, 7880.566568838769, 7937.087234968052, 7214.855702885808, 7290.198078211286, 7373.078365204349, 7401.370883474965, 7466.514676546007, 7539.2083831199125, 7615.390768738598, 7630.923690763243, 7715.652795624323, 7749.961250193938, 7679.884801727867, 7721.53670779755, 7747.0, 7765.22347765219, 7776.105747838845, 6967.477439191979, 6977.686004129928, 7004.159500859726, 7004.229534751072, 7033.613151276729, 7065.975433562207, 7101.786946391617, 7110.822229444305, 7114.14630244374, 7125.465590080661], "unit": "ms", "name": "mootools.html", "value": 4652.0203509161765}, {"lowerIsBetter": false, "replicates": [339.6891843962774, 343.3699162037661, 361.30268581637444, 362.3767120552649, 369.37575497409387, 6318.873622527558, 6386.808395748123, 6449.903251451226, 6450.9999999999945, 6526.2168539775175, 6325.7153428095735, 6355.71399287032, 6363.71363288652, 6370.426661600467, 6442.581232219903, 4879.878003049926, 4902.142125128106, 4905.632077594177, 4907.975460122694, 4908.43552991407, 4910.779014944318, 4911.042346742387, 4915.2381380885845, 4916.483769204236, 4927.852164435055, 4701.318308845215, 4725.432948046239, 4776.570108690217, 4784.545468180518, 4864.343313652665, 4748.1928072227975, 4766.547178018082, 4769.0, 4771.475137734847, 4780.545848144421, 4221.092465119983, 4245.0, 4245.8513952011535, 4248.044190057243, 4253.680973926967, 6029.969850150765, 6041.51667866574, 6050.515958723336, 6054.334023257438, 6063.151158837766, 5559.332880054379, 5634.577406694473, 5651.9717401413145, 5663.178839068353, 5677.148427735831, 6688.264290927994, 6693.899591506131, 6696.966515167393, 6701.157181775051, 6726.461883049394, 4660.37084993525, 4671.416072990876, 4699.906001879977, 4708.552687494683, 4708.576228139484, 6844.623545704984, 6939.20199177096, 7008.369246767816, 7013.193482749498, 7090.574565526033, 4724.905501890012, 4789.616830653539, 4795.304680821261, 4796.328514008042, 4809.639277054235, 4836.879078023007, 4839.443464001614, 4857.247126695368, 4881.0, 4886.706797592155, 5636.915446268309, 5641.0, 5643.0, 5650.604457688005, 5653.180288858092, 6564.212294524687, 6698.933010669928, 6752.257251702309, 6771.864562708817, 6784.423324017514, 1703.0973584000499, 1713.6829686508036, 1717.3388245525314, 1720.4150588799869, 1722.121717923868, 1094.8795632480421, 1106.6624679472839, 1116.4864162485185, 1123.3596849795701, 1147.397616251458, 6500.414962653289, 6527.771527996498, 6537.0, 6546.312637173029, 6577.506686998494, 6950.895736563955, 6996.195437524648, 7002.7899163025195, 7016.122984626922, 7022.6488675566015, 6419.16550848396, 6472.093906853044, 6516.837079072966, 6548.476121910236, 6628.668566571652, 3801.5058042454857, 3838.2131663009573, 3842.8462861485787, 3845.115623406632, 3854.8265328060306, 7248.96375518119, 7273.709051637981, 7290.562566245936, 7294.270572942663, 7321.670524826395, 7071.469639777038, 7190.7483238086415, 7263.745768898063, 7282.417406607458, 7297.124345078624, 7269.6728647211, 7282.890756638654, 7288.781336559911, 7296.927030729731, 7309.451791115581, 7051.330123638246, 7086.929130708627, 7106.538075025107, 7107.182673992557, 7108.644567771694, 6762.560433571802, 6878.518503704692, 6888.724451021903, 6995.615241161785, 6998.440124789903, 7255.274472552703, 7294.96352518234, 7313.0, 7336.303051210127, 7360.374368178765, 4834.468208497133, 4880.633952453652, 4886.340344053508, 4894.2658601210105, 4897.3878265216845, 6894.517383783087, 7037.261087585935, 7112.182099058675, 7128.857422851617, 7153.427725781821, 6813.659317034029, 6818.659067046727, 6821.386075253251, 6848.0, 6925.68834402443, 6759.932400675931, 6868.62222577763, 6902.482313826584, 6906.136732908387, 6925.065116209247, 6750.729970801113, 6773.221079575715, 6778.96610516964, 6794.150731158606, 6802.455803535607, 6853.17761868579, 6862.451003919575, 6882.277360877236, 6913.343232392915, 6923.273056329013, 6586.868262634816, 6782.491313151435, 6788.86422271542, 6790.966045169743, 6797.0823938767635], "unit": "ms", "name": "prototype.html", "value": 5120.884253474965}, {"lowerIsBetter": false, "replicates": [823.7487566292282, 832.2509741232891, 874.1127755328342, 920.7882187096967, 925.3661242049193, 13146.14550054247, 13440.3951822168, 13490.25803580804, 13512.0, 13516.0, 13856.168629882213, 13907.652308692288, 13946.23295718735, 13952.860471395283, 13973.882089432846, 883.8143989762158, 890.7684002159452, 898.0301274623391, 899.7480705402497, 901.2519608724742, 888.9155530224618, 899.4962820820328, 899.5637115998735, 901.5537309032038, 906.5829718329576, 917.729269865388, 925.7593025813303, 925.842606756853, 926.3700683535193, 928.7306681062483, 915.3318077803208, 915.9587818548181, 916.9266458683322, 924.1959495239117, 933.5518950903604, 689.1420181873549, 693.3309356470979, 693.8300116471497, 693.8681650486442, 694.5971336624796, 14772.0, 14972.47596334134, 14976.101433914, 14986.925065374713, 14999.250037498081, 11446.771064578661, 12443.502259909592, 12469.127161098726, 12664.493420263178, 13138.343082845915, 10435.68692939213, 10897.782044359148, 11043.72390690231, 11437.0, 11860.584879529262, 3764.209516001643, 3769.321522126016, 3790.848366065354, 3791.620837916214, 3810.6379893910034, 51940.74029629865, 52068.47931520712, 52196.73901630506, 52200.738996305154, 52216.0, 10238.283320167517, 10666.413347265974, 10708.357498550113, 10717.517711702993, 10817.567297308176, 18585.163667634988, 18748.906255468635, 18748.906255468635, 18761.7185742214, 18806.529836753918, 7226.241244669339, 7252.709891604382, 7268.5956973882, 7313.451491138079, 7376.446766492534, 4404.361367601744, 4490.236659767847, 4495.505494395614, 4496.595306422438, 4614.838480653161, 3253.511973203991, 3273.0, 3273.4107860584845, 3276.8033917965, 3294.061192560109, 551.657972057327, 553.9335279766453, 567.0615131956619, 570.5036618142243, 591.4469970577524, 695.9721611135498, 716.7992961970657, 730.3572855886891, 731.7438896386222, 761.466973118819, 9187.540622968825, 9778.119969202664, 9791.118799308097, 9819.705408837746, 9824.115829575372, 571.7341436232172, 688.8932215506604, 728.9781306560811, 733.3656387225119, 738.6380673470069, 4178.143480586473, 4196.6990233027855, 4546.704464209815, 4570.520095390003, 4635.95364046362, 63387.68306158532, 63960.0, 65516.34483655103, 70049.64975175091, 70142.64928675425, 55243.0, 56290.71854640783, 56492.43507564954, 56677.716611417505, 56937.145942810894, 45679.77160114178, 49895.0, 49950.750246248535, 49979.50020499749, 50317.0, 8901.376903616685, 8934.910650893667, 9083.727488175366, 9128.361014728906, 9339.719808405758, 34902.650973490956, 34947.12632184114, 35369.46945795764, 35991.64008359988, 36622.8168859154, 46960.0, 47040.29439558478, 49235.53822308942, 49460.258096127865, 49566.75216623894, 12428.81356779631, 12480.563180288646, 12543.811842822182, 12878.484860605471, 13154.473821047051, 13530.797038044635, 13557.525486608316, 13575.0, 13798.448062077405, 13813.171209727449, 12898.161619494704, 12900.09699321076, 13039.087263891437, 13054.608361749162, 13251.536196233086, 11130.387828669502, 11284.887151128383, 11467.598634047768, 12233.449494772578, 12326.50693972231, 11901.226420282654, 11901.285922844658, 12303.384830758605, 12586.307753073668, 12739.426725797175, 10695.732606684895, 10740.516676749408, 10936.070434013198, 10960.671179864617, 11276.7744645105, 10445.63440279617, 11108.389038602954, 11125.276857004268, 11168.944155279172, 11184.720381990515], "unit": "ms", "name": "yui.html", "value": 6801.500006112795}], "name": "dromaeo_css", "value": 7371.202325134403}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 103.0, 109.0, 109.0, 113.0, 120.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [158.0, 123.0, 148.0, 161.0, 122.0, 147.0, 158.0, 126.0, 157.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 161.0, 163.0, 160.0, 159.0, 162.0, 164.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [78.0, 72.0, 74.0, 163.0, 72.0, 73.0, 71.0, 72.0, 162.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 91.0}, {"lowerIsBetter": true, "replicates": [95.0, 93.0, 136.0, 93.0, 93.0, 93.0, 136.0, 92.0, 94.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 109.0, 111.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 145.0, 147.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 98.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [58.0, 62.0, 61.0, 66.0, 67.0, 62.0, 69.0, 61.0, 64.0, 64.0], "unit": "ms", "name": "json-parse-financial", "value": 63.4}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 82.0, 83.0, 82.0, 82.0, 82.0, 82.0, 82.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [116.0, 114.0, 113.0, 121.0, 121.0, 125.0, 119.0, 120.0, 114.0, 114.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.7}, {"lowerIsBetter": true, "replicates": [143.0, 144.0, 134.0, 137.0, 142.0, 147.0, 149.0, 145.0, 144.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 70.0, 66.0, 68.0, 69.0, 65.0, 73.0, 67.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1502.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.88918558077435], "unit": "score", "name": "Richards", "value": 211.52958400000006}, {"lowerIsBetter": false, "replicates": [166.80567139282735], "unit": "score", "name": "DeltaBlue", "value": 396.37741000000017}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5207.253886010362], "unit": "score", "name": "Decrypt", "value": 51.11734626865668}, {"lowerIsBetter": false, "replicates": [921.6589861751152], "unit": "score", "name": "RayTrace", "value": 802.8880650000001}, {"lowerIsBetter": false, "replicates": [548.5463521667581], "unit": "score", "name": "Earley", "value": 1214.9620489999998}, {"lowerIsBetter": false, "replicates": [11021.978021978022], "unit": "score", "name": "Boyer", "value": 60.46673280159525}, {"lowerIsBetter": false, "replicates": [24214.285714285714], "unit": "score", "name": "RegExp", "value": 37.621799410029524}, {"lowerIsBetter": false, "replicates": [521.9206680584551], "unit": "score", "name": "Splay", "value": 156.13675599999996}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23205.175097385792}]} 03:29:35 INFO - RETURN: dromaeo_css: 7371.20 03:29:35 INFO - RETURN: kraken: 1502.90 03:29:35 INFO - RETURN: v8_7: 23205.18 03:29:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23205.18"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1502.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7371.20"}}} 03:29:35 INFO - Return code: 0 03:29:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:29:35 INFO - # TBPL SUCCESS # 03:29:35 INFO - Running post-action listener: _resource_record_post_action 03:29:35 INFO - Running post-run listener: _resource_record_post_run 03:29:36 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 28672; Write bytes: 514330624; Read time: 276; Write time: 398160 03:29:36 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 4096; Write bytes: 236732416; Read time: 216; Write time: 225240 03:29:36 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 24576; Write bytes: 276733952; Read time: 60; Write time: 172888 03:29:36 INFO - Running post-run listener: _upload_blobber_files 03:29:36 INFO - Blob upload gear active. 03:29:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:29:36 INFO - Copying logs to upload dir... 03:29:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.645617 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-07 03:29:35.835855) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-07 03:29:35.839141) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010095 build_url: 'https://queue.taskcluster.net/v1/task/bnhHizkMSyGvCwizexeCPQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-07 03:29:35.891156) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:29:35.891525) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452164410.680509-563864704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 03:29:35.941754) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 03:29:35.942102) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 03:29:35.942423) ========= ========= Total master_lag: 0.25 =========