builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1452053144.97 results: success (0) buildid: 20160105175404 builduid: f39a17b44c4843b8bd929868ee8331b4 revision: 7e1284abc4733ef0372cd96671cfaac3227e2214 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:44.969634) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:44.970560) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:44.971159) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004317 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:44.989915) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:44.990572) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:45.003692) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:45.004075) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:45.054869) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:45.055619) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:45.056350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:45.056963) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 20:05:45-- 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.2M=0s 2016-01-05 20:05:45 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161898 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:45.233150) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:45.233882) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013377 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:45.285534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 20:05:45.285899) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7e1284abc4733ef0372cd96671cfaac3227e2214 --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 7e1284abc4733ef0372cd96671cfaac3227e2214 --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=78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 20:05:45,342 truncating revision to first 12 chars 2016-01-05 20:05:45,342 Setting DEBUG logging. 2016-01-05 20:05:45,342 attempt 1/10 2016-01-05 20:05:45,342 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7e1284abc473?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 20:05:46,337 unpacking tar archive at: mozilla-aurora-7e1284abc473/testing/mozharness/ program finished with exit code 0 elapsedTime=1.265775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 20:05:46.566222) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:46.566642) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:46.576583) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:46.576907) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:46.577387) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-01-05 20:05:46.577730) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:05:46 INFO - MultiFileLogger online at 20160105 20:05:46 in /builds/slave/test-pgo 20:05:46 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 20:05:46 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:05:46 INFO - {'append_to_log': False, 20:05:46 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:05:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:05:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:05:46 INFO - 'branch': 'Mozilla-Aurora', 20:05:46 INFO - 'buildbot_json_path': 'buildprops.json', 20:05:46 INFO - 'config_files': ('talos/linux_config.py',), 20:05:46 INFO - 'default_actions': ('clobber', 20:05:46 INFO - 'read-buildbot-config', 20:05:46 INFO - 'download-and-extract', 20:05:46 INFO - 'populate-webroot', 20:05:46 INFO - 'create-virtualenv', 20:05:46 INFO - 'install', 20:05:46 INFO - 'run-tests'), 20:05:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:05:46 INFO - 'download_minidump_stackwalk': True, 20:05:46 INFO - 'download_symbols': 'ondemand', 20:05:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:05:46 INFO - 'tooltool.py': '/tools/tooltool.py', 20:05:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:05:46 INFO - '/tools/misc-python/virtualenv.py')}, 20:05:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:05:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:05:46 INFO - 'installer_path': 'installer.exe', 20:05:46 INFO - 'log_level': 'info', 20:05:46 INFO - 'log_name': 'talos', 20:05:46 INFO - 'log_to_console': True, 20:05:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:05:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:05:46 INFO - 'opt_config_files': (), 20:05:46 INFO - 'pip_index': False, 20:05:46 INFO - 'sps_profile': False, 20:05:46 INFO - 'sps_profile_interval': 0, 20:05:46 INFO - 'suite': 'dromaeojs-e10s', 20:05:46 INFO - 'system_bits': '32', 20:05:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:05:46 INFO - 'title': 'talos-linux64-ix-019', 20:05:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:05:46 INFO - 'use_talos_json': True, 20:05:46 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:05:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:05:46 INFO - 'work_dir': 'build'} 20:05:46 INFO - ##### 20:05:46 INFO - ##### Running clobber step. 20:05:46 INFO - ##### 20:05:46 INFO - Running pre-action listener: _resource_record_pre_action 20:05:46 INFO - Running main action method: clobber 20:05:46 INFO - rmtree: /builds/slave/test-pgo/build 20:05:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:05:47 INFO - Running post-action listener: _resource_record_post_action 20:05:47 INFO - ##### 20:05:47 INFO - ##### Running read-buildbot-config step. 20:05:47 INFO - ##### 20:05:47 INFO - Running pre-action listener: _resource_record_pre_action 20:05:47 INFO - Running main action method: read_buildbot_config 20:05:47 INFO - Using buildbot properties: 20:05:47 INFO - { 20:05:47 INFO - "properties": { 20:05:47 INFO - "buildnumber": 35, 20:05:47 INFO - "product": "firefox", 20:05:47 INFO - "script_repo_revision": "production", 20:05:47 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 20:05:47 INFO - "repository": "", 20:05:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 20:05:47 INFO - "buildid": "20160105175404", 20:05:47 INFO - "slavename": "talos-linux64-ix-019", 20:05:47 INFO - "pgo_build": "True", 20:05:47 INFO - "basedir": "/builds/slave/test-pgo", 20:05:47 INFO - "project": "", 20:05:47 INFO - "platform": "ubuntu64_hw", 20:05:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:05:47 INFO - "slavebuilddir": "test", 20:05:47 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:05:47 INFO - "branch": "mozilla-aurora", 20:05:47 INFO - "repo_path": "releases/mozilla-aurora", 20:05:47 INFO - "stage_platform": "linux64-pgo", 20:05:47 INFO - "builduid": "f39a17b44c4843b8bd929868ee8331b4", 20:05:47 INFO - "revision": "7e1284abc4733ef0372cd96671cfaac3227e2214" 20:05:47 INFO - }, 20:05:47 INFO - "sourcestamp": { 20:05:47 INFO - "repository": "", 20:05:47 INFO - "hasPatch": false, 20:05:47 INFO - "project": "", 20:05:47 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 20:05:47 INFO - "changes": [ 20:05:47 INFO - { 20:05:47 INFO - "category": null, 20:05:47 INFO - "files": [ 20:05:47 INFO - { 20:05:47 INFO - "url": null, 20:05:47 INFO - "name": "https://queue.taskcluster.net/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 20:05:47 INFO - } 20:05:47 INFO - ], 20:05:47 INFO - "repository": "", 20:05:47 INFO - "rev": "7e1284abc4733ef0372cd96671cfaac3227e2214", 20:05:47 INFO - "who": "kwierso@gmail.com", 20:05:47 INFO - "when": 1452053030, 20:05:47 INFO - "number": 7422194, 20:05:47 INFO - "comments": "Bug 1143380 - [mozrunner] Increase timeout value for waiting emulator to start; r=ahal a=test-only", 20:05:47 INFO - "project": "", 20:05:47 INFO - "at": "Tue 05 Jan 2016 20:03:50", 20:05:47 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 20:05:47 INFO - "revlink": "", 20:05:47 INFO - "properties": [ 20:05:47 INFO - [ 20:05:47 INFO - "buildid", 20:05:47 INFO - "20160105175404", 20:05:47 INFO - "Change" 20:05:47 INFO - ], 20:05:47 INFO - [ 20:05:47 INFO - "builduid", 20:05:47 INFO - "f39a17b44c4843b8bd929868ee8331b4", 20:05:47 INFO - "Change" 20:05:47 INFO - ], 20:05:47 INFO - [ 20:05:47 INFO - "pgo_build", 20:05:47 INFO - "True", 20:05:47 INFO - "Change" 20:05:47 INFO - ] 20:05:47 INFO - ], 20:05:47 INFO - "revision": "7e1284abc4733ef0372cd96671cfaac3227e2214" 20:05:47 INFO - } 20:05:47 INFO - ], 20:05:47 INFO - "revision": "7e1284abc4733ef0372cd96671cfaac3227e2214" 20:05:47 INFO - } 20:05:47 INFO - } 20:05:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 20:05:47 INFO - Running post-action listener: _resource_record_post_action 20:05:47 INFO - ##### 20:05:47 INFO - ##### Running download-and-extract step. 20:05:47 INFO - ##### 20:05:47 INFO - Running pre-action listener: _resource_record_pre_action 20:05:47 INFO - Running main action method: download_and_extract 20:05:47 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:47 INFO - https://queue.taskcluster.net/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:05:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/test_packages.json 20:05:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/test_packages.json 20:05:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:05:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:05:47 INFO - Downloaded 1302 bytes. 20:05:47 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:05:47 INFO - Using the following test package requirements: 20:05:47 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 20:05:47 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:47 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:05:47 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:47 INFO - u'jsshell-linux-x86_64.zip'], 20:05:47 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:47 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:05:47 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 20:05:47 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:47 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:05:47 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:47 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:05:47 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:47 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:05:47 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 20:05:47 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:47 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:05:47 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:47 INFO - https://queue.taskcluster.net/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 20:05:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 20:05:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/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 20:05:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/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 20:05:48 INFO - Downloaded 23023610 bytes. 20:05:48 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 20:05:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 20:05:48 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 20:05:49 INFO - Return code: 0 20:05:49 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 20:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:49 INFO - https://queue.taskcluster.net/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 20:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 20:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/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 20:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/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 20:05:50 INFO - Downloaded 23023610 bytes. 20:05:50 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 20:05:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 20:05:50 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 20:05:52 INFO - Return code: 0 20:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:52 INFO - https://queue.taskcluster.net/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:05:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 20:05:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 20:05:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/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 20:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/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 20:05:53 INFO - Downloaded 11132038 bytes. 20:05:53 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 20:05:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 20:05:53 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 20:05:53 INFO - Return code: 0 20:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:53 INFO - https://queue.taskcluster.net/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:05:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 20:05:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 20:05:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/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 20:05:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYr0vyouRqi9B8bS5EzPkQ/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 20:05:54 INFO - Downloaded 58126885 bytes. 20:05:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 20:05:54 INFO - mkdir: /builds/slave/test-pgo/properties 20:05:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:05:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:05:54 INFO - Contents: 20:05:54 INFO - build_url:https://queue.taskcluster.net/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 20:05:54 INFO - Running post-action listener: _resource_record_post_action 20:05:54 INFO - Running post-action listener: set_extra_try_arguments 20:05:54 INFO - ##### 20:05:54 INFO - ##### Running populate-webroot step. 20:05:54 INFO - ##### 20:05:54 INFO - Running pre-action listener: _resource_record_pre_action 20:05:54 INFO - Running main action method: populate_webroot 20:05:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:05:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:05:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:05:54 INFO - '--tppagecycles', 20:05:54 INFO - '7'], 20:05:54 INFO - 'tests': ['tsvgm']}}, 20:05:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:05:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:05:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:05:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:05:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:05:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:05:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:54 INFO - 'talos_options': ['--e10s'], 20:05:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:54 INFO - 'tests': ['damp', 'tps']}, 20:05:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:54 INFO - 'talos_options': ['--e10s'], 20:05:54 INFO - 'tests': ['damp', 'tps']}, 20:05:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:05:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:05:54 INFO - 'other': {'tests': ['a11yr', 20:05:54 INFO - 'ts_paint', 20:05:54 INFO - 'tpaint', 20:05:54 INFO - 'sessionrestore', 20:05:54 INFO - 'sessionrestore_no_auto_restore']}, 20:05:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:05:54 INFO - 'tests': ['a11yr', 20:05:54 INFO - 'ts_paint', 20:05:54 INFO - 'tpaint', 20:05:54 INFO - 'sessionrestore', 20:05:54 INFO - 'sessionrestore_no_auto_restore']}, 20:05:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:05:54 INFO - 'tests': ['a11yr', 20:05:54 INFO - 'ts_paint', 20:05:54 INFO - 'tpaint', 20:05:54 INFO - 'sessionrestore', 20:05:54 INFO - 'sessionrestore_no_auto_restore']}, 20:05:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:05:54 INFO - 'tests': ['a11yr', 20:05:54 INFO - 'ts_paint', 20:05:54 INFO - 'tpaint', 20:05:54 INFO - 'sessionrestore', 20:05:54 INFO - 'sessionrestore_no_auto_restore']}, 20:05:54 INFO - 'other_l64': {'tests': ['a11yr', 20:05:54 INFO - 'ts_paint', 20:05:54 INFO - 'tpaint', 20:05:54 INFO - 'sessionrestore', 20:05:54 INFO - 'sessionrestore_no_auto_restore']}, 20:05:54 INFO - 'other_nol64': {'tests': ['a11yr', 20:05:54 INFO - 'ts_paint', 20:05:54 INFO - 'tpaint', 20:05:54 INFO - 'sessionrestore', 20:05:54 INFO - 'sessionrestore_no_auto_restore']}, 20:05:54 INFO - 'svgr': {'tests': ['tsvgx', 20:05:54 INFO - 'tsvgr_opacity', 20:05:54 INFO - 'tart', 20:05:54 INFO - 'tscrollx', 20:05:54 INFO - 'cart']}, 20:05:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:05:54 INFO - 'tests': ['tsvgx', 20:05:54 INFO - 'tsvgr_opacity', 20:05:54 INFO - 'tart', 20:05:54 INFO - 'tscrollx', 20:05:54 INFO - 'cart']}, 20:05:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:54 INFO - 'tests': ['tp5o']}, 20:05:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:54 INFO - 'talos_options': ['--e10s'], 20:05:54 INFO - 'tests': ['tp5o']}, 20:05:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:54 INFO - 'talos_options': ['--xperf_path', 20:05:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:54 INFO - 'tests': ['tp5n']}, 20:05:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:54 INFO - 'talos_options': ['--e10s', 20:05:54 INFO - '--xperf_path', 20:05:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:54 INFO - 'tests': ['tp5n']}}, 20:05:54 INFO - 'talos.zip': {'path': '', 20:05:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:05:54 INFO - Running post-action listener: _resource_record_post_action 20:05:54 INFO - ##### 20:05:54 INFO - ##### Running create-virtualenv step. 20:05:54 INFO - ##### 20:05:54 INFO - Running pre-action listener: _resource_record_pre_action 20:05:54 INFO - Running main action method: create_virtualenv 20:05:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:05:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 20:05:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:05:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:05:54 INFO - Using real prefix '/usr' 20:05:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:05:55 INFO - Installing distribute.............................................................................................................................................................................................done. 20:05:57 INFO - Installing pip.................done. 20:05:57 INFO - Return code: 0 20:05:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4a2c2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250aa50>, '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 0x2476550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24769e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', '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 20:05:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 20:05:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:05:57 INFO - Using env: {'DISPLAY': ':0', 20:05:57 INFO - 'HOME': '/home/cltbld', 20:05:57 INFO - 'LANG': 'en_US.UTF-8', 20:05:57 INFO - 'LANGUAGE': 'en_US:en', 20:05:57 INFO - 'LOGNAME': 'cltbld', 20:05:57 INFO - 'MAIL': '/var/mail/cltbld', 20:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:57 INFO - 'MOZ_NO_REMOTE': '1', 20:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:57 INFO - 'NO_EM_RESTART': '1', 20:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:05:57 INFO - 'PWD': '/builds/slave/test-pgo', 20:05:57 INFO - 'SHELL': '/bin/bash', 20:05:57 INFO - 'SHLVL': '1', 20:05:57 INFO - 'TERM': 'linux', 20:05:57 INFO - 'TMOUT': '86400', 20:05:57 INFO - 'USER': 'cltbld', 20:05:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', 20:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:57 INFO - '_': '/tools/buildbot/bin/python'} 20:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:05:57 INFO - Cleaning up... 20:05:57 INFO - Return code: 0 20:05:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4a2c2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250aa50>, '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 0x2476550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24769e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', '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 20:05:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 20:05:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:05:57 INFO - Using env: {'DISPLAY': ':0', 20:05:57 INFO - 'HOME': '/home/cltbld', 20:05:57 INFO - 'LANG': 'en_US.UTF-8', 20:05:57 INFO - 'LANGUAGE': 'en_US:en', 20:05:57 INFO - 'LOGNAME': 'cltbld', 20:05:57 INFO - 'MAIL': '/var/mail/cltbld', 20:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:57 INFO - 'MOZ_NO_REMOTE': '1', 20:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:57 INFO - 'NO_EM_RESTART': '1', 20:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:05:57 INFO - 'PWD': '/builds/slave/test-pgo', 20:05:57 INFO - 'SHELL': '/bin/bash', 20:05:57 INFO - 'SHLVL': '1', 20:05:57 INFO - 'TERM': 'linux', 20:05:57 INFO - 'TMOUT': '86400', 20:05:57 INFO - 'USER': 'cltbld', 20:05:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', 20:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:57 INFO - '_': '/tools/buildbot/bin/python'} 20:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:57 INFO - Downloading/unpacking psutil>=0.7.1 20:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:59 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 20:05:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:05:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:05:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:59 INFO - Installing collected packages: psutil 20:05:59 INFO - Running setup.py install for psutil 20:05:59 INFO - building 'psutil._psutil_linux' extension 20:05:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:05:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:06:00 INFO - building 'psutil._psutil_posix' extension 20:06:00 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 20:06:00 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 20:06:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:00 INFO - Successfully installed psutil 20:06:00 INFO - Cleaning up... 20:06:00 INFO - Return code: 0 20:06:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:00 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 0x7f4a2c2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250aa50>, '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 0x2476550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24769e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', '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 20:06:00 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 20:06:00 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 20:06:00 INFO - Using env: {'DISPLAY': ':0', 20:06:00 INFO - 'HOME': '/home/cltbld', 20:06:00 INFO - 'LANG': 'en_US.UTF-8', 20:06:00 INFO - 'LANGUAGE': 'en_US:en', 20:06:00 INFO - 'LOGNAME': 'cltbld', 20:06:00 INFO - 'MAIL': '/var/mail/cltbld', 20:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:00 INFO - 'MOZ_NO_REMOTE': '1', 20:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:00 INFO - 'NO_EM_RESTART': '1', 20:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:00 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:00 INFO - 'SHELL': '/bin/bash', 20:06:00 INFO - 'SHLVL': '1', 20:06:00 INFO - 'TERM': 'linux', 20:06:00 INFO - 'TMOUT': '86400', 20:06:00 INFO - 'USER': 'cltbld', 20:06:00 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', 20:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:00 INFO - '_': '/tools/buildbot/bin/python'} 20:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:06:00 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 20:06:00 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 20:06:00 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 20:06:00 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 20:06:00 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 20:06:00 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 20:06:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:06:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:06:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:06:02 INFO - Installing collected packages: mozsystemmonitor 20:06:02 INFO - Running setup.py install for mozsystemmonitor 20:06:02 INFO - Successfully installed mozsystemmonitor 20:06:02 INFO - Cleaning up... 20:06:02 INFO - Return code: 0 20:06:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:06: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')]} 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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', '--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 0x7f4a2c2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250aa50>, '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 0x2476550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24769e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', '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 20:06:02 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 20:06:02 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 20:06:02 INFO - Using env: {'DISPLAY': ':0', 20:06:02 INFO - 'HOME': '/home/cltbld', 20:06:02 INFO - 'LANG': 'en_US.UTF-8', 20:06:02 INFO - 'LANGUAGE': 'en_US:en', 20:06:02 INFO - 'LOGNAME': 'cltbld', 20:06:02 INFO - 'MAIL': '/var/mail/cltbld', 20:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:02 INFO - 'MOZ_NO_REMOTE': '1', 20:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:02 INFO - 'NO_EM_RESTART': '1', 20:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:02 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:02 INFO - 'SHELL': '/bin/bash', 20:06:02 INFO - 'SHLVL': '1', 20:06:02 INFO - 'TERM': 'linux', 20:06:02 INFO - 'TMOUT': '86400', 20:06:02 INFO - 'USER': 'cltbld', 20:06:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', 20:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:02 INFO - '_': '/tools/buildbot/bin/python'} 20:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:03 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:04 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:06:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:06:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:06:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:05 INFO - Downloading docopt-0.6.1.tar.gz 20:06:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:06:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:05 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:05 INFO - Running setup.py install for blobuploader 20:06:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:06:05 INFO - Running setup.py install for requests 20:06:06 INFO - Running setup.py install for docopt 20:06:06 INFO - Successfully installed blobuploader requests docopt 20:06:06 INFO - Cleaning up... 20:06:06 INFO - Return code: 0 20:06:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:06: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')]} 20:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:06 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 0x7f4a2c2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250aa50>, '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 0x2476550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24769e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', '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 20:06:06 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 20:06:06 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 20:06:06 INFO - Using env: {'DISPLAY': ':0', 20:06:06 INFO - 'HOME': '/home/cltbld', 20:06:06 INFO - 'LANG': 'en_US.UTF-8', 20:06:06 INFO - 'LANGUAGE': 'en_US:en', 20:06:06 INFO - 'LOGNAME': 'cltbld', 20:06:06 INFO - 'MAIL': '/var/mail/cltbld', 20:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:06 INFO - 'MOZ_NO_REMOTE': '1', 20:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:06 INFO - 'NO_EM_RESTART': '1', 20:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:06 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:06 INFO - 'SHELL': '/bin/bash', 20:06:06 INFO - 'SHLVL': '1', 20:06:06 INFO - 'TERM': 'linux', 20:06:06 INFO - 'TMOUT': '86400', 20:06:06 INFO - 'USER': 'cltbld', 20:06:06 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', 20:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:06 INFO - '_': '/tools/buildbot/bin/python'} 20:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:06:06 INFO - Running setup.py (path:/tmp/pip-P1Llej-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:06:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:06:06 INFO - Running setup.py (path:/tmp/pip-xmkdqc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:06:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:06:06 INFO - Running setup.py (path:/tmp/pip-IJiPpf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:06:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:06:06 INFO - Running setup.py (path:/tmp/pip-lj_VNJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:06:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:06:06 INFO - Running setup.py (path:/tmp/pip-xeRnUG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:06:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:06:07 INFO - Running setup.py (path:/tmp/pip-tMdRC9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:06:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:06:07 INFO - Running setup.py (path:/tmp/pip-b1R3Zg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:06:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:06:07 INFO - Running setup.py (path:/tmp/pip-HTA4ll-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:06:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:06:07 INFO - Running setup.py (path:/tmp/pip-pYAoDm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:06:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:06:07 INFO - Running setup.py (path:/tmp/pip-ti2Cc0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:06:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:06:07 INFO - Running setup.py (path:/tmp/pip-llqsga-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:06:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:06:07 INFO - Running setup.py (path:/tmp/pip-dTHsuz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:06:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:06:07 INFO - Running setup.py (path:/tmp/pip-MXZzVx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:06:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:06:07 INFO - Running setup.py (path:/tmp/pip-kxNut5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:06:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:06:07 INFO - Running setup.py (path:/tmp/pip-VPjkqD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:06:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:06:07 INFO - Running setup.py (path:/tmp/pip-EY0Q2I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:06:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:06:07 INFO - Running setup.py (path:/tmp/pip-SXAFwV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:06:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:07 INFO - Running setup.py install for manifestparser 20:06:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:06:07 INFO - Running setup.py install for mozcrash 20:06:08 INFO - Running setup.py install for mozdebug 20:06:08 INFO - Running setup.py install for mozdevice 20:06:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:06:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:06:08 INFO - Running setup.py install for mozfile 20:06:08 INFO - Running setup.py install for mozhttpd 20:06:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:06:08 INFO - Running setup.py install for mozinfo 20:06:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:06:08 INFO - Running setup.py install for mozInstall 20:06:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:06:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:06:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:06:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:06:08 INFO - Running setup.py install for mozleak 20:06:08 INFO - Running setup.py install for mozlog 20:06:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:06:08 INFO - Running setup.py install for moznetwork 20:06:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:06:08 INFO - Running setup.py install for mozprocess 20:06:09 INFO - Running setup.py install for mozprofile 20:06:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:06:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:06:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:06:09 INFO - Running setup.py install for mozrunner 20:06:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:06:09 INFO - Running setup.py install for mozscreenshot 20:06:09 INFO - Running setup.py install for moztest 20:06:09 INFO - Running setup.py install for mozversion 20:06:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:06:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:09 INFO - Cleaning up... 20:06:09 INFO - Return code: 0 20:06:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:06: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')]} 20:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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', '-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 0x7f4a2c2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250aa50>, '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 0x2476550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24769e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', '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 20:06:09 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 20:06:09 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 20:06:09 INFO - Using env: {'DISPLAY': ':0', 20:06:09 INFO - 'HOME': '/home/cltbld', 20:06:09 INFO - 'LANG': 'en_US.UTF-8', 20:06:09 INFO - 'LANGUAGE': 'en_US:en', 20:06:09 INFO - 'LOGNAME': 'cltbld', 20:06:09 INFO - 'MAIL': '/var/mail/cltbld', 20:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:09 INFO - 'MOZ_NO_REMOTE': '1', 20:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:09 INFO - 'NO_EM_RESTART': '1', 20:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:09 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:09 INFO - 'SHELL': '/bin/bash', 20:06:09 INFO - 'SHLVL': '1', 20:06:09 INFO - 'TERM': 'linux', 20:06:09 INFO - 'TMOUT': '86400', 20:06:09 INFO - 'USER': 'cltbld', 20:06:09 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', 20:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:09 INFO - '_': '/tools/buildbot/bin/python'} 20:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:06:09 INFO - Running setup.py (path:/tmp/pip-6xHuxb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:06:09 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)) 20:06:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:06:09 INFO - Running setup.py (path:/tmp/pip-FIoaf4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:06:10 INFO - Running setup.py (path:/tmp/pip-m1_g5P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:06:10 INFO - Running setup.py (path:/tmp/pip-zcpFqb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:06:10 INFO - Running setup.py (path:/tmp/pip-OtGBYP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:06:10 INFO - Running setup.py (path:/tmp/pip-6YQO7_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:06:10 INFO - Running setup.py (path:/tmp/pip-1434gD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:06:10 INFO - Running setup.py (path:/tmp/pip-aCfTTj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:06:10 INFO - Running setup.py (path:/tmp/pip-pYVS3p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:06:10 INFO - Running setup.py (path:/tmp/pip-yKnTLF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:06:10 INFO - Running setup.py (path:/tmp/pip-p1ZfVz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:06:10 INFO - Running setup.py (path:/tmp/pip-JiUx7D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:06:10 INFO - Running setup.py (path:/tmp/pip-Wy1BJM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:06:10 INFO - Running setup.py (path:/tmp/pip-3QlTxS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:06:10 INFO - Running setup.py (path:/tmp/pip-9zTLwf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:06:10 INFO - Running setup.py (path:/tmp/pip-lh9CCZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:06:11 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)) 20:06:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:06:11 INFO - Running setup.py (path:/tmp/pip-8lCJyK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:06:11 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)) 20:06:11 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)) 20:06:11 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)) 20:06:11 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)) 20:06:11 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)) 20:06:11 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)) 20:06:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:12 INFO - Downloading blessings-1.5.1.tar.gz 20:06:12 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 20:06:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:12 INFO - Installing collected packages: blessings 20:06:12 INFO - Running setup.py install for blessings 20:06:13 INFO - Successfully installed blessings 20:06:13 INFO - Cleaning up... 20:06:13 INFO - Return code: 0 20:06:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:06:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:06:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:06:13 INFO - Reading from file tmpfile_stdout 20:06:13 INFO - Current package versions: 20:06:13 INFO - argparse == 1.2.1 20:06:13 INFO - blessings == 1.5.1 20:06:13 INFO - blobuploader == 1.2.4 20:06:13 INFO - docopt == 0.6.1 20:06:13 INFO - manifestparser == 1.1 20:06:13 INFO - mozInstall == 1.12 20:06:13 INFO - mozcrash == 0.16 20:06:13 INFO - mozdebug == 0.1 20:06:13 INFO - mozdevice == 0.47 20:06:13 INFO - mozfile == 1.2 20:06:13 INFO - mozhttpd == 0.7 20:06:13 INFO - mozinfo == 0.9 20:06:13 INFO - mozleak == 0.1 20:06:13 INFO - mozlog == 3.1 20:06:13 INFO - moznetwork == 0.27 20:06:13 INFO - mozprocess == 0.22 20:06:13 INFO - mozprofile == 0.27 20:06:13 INFO - mozrunner == 6.11 20:06:13 INFO - mozscreenshot == 0.1 20:06:13 INFO - mozsystemmonitor == 0.0 20:06:13 INFO - moztest == 0.7 20:06:13 INFO - mozversion == 1.4 20:06:13 INFO - psutil == 3.1.1 20:06:13 INFO - requests == 1.2.3 20:06:13 INFO - wsgiref == 0.1.2 20:06:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:06:13 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')]} 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:13 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')]} 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:13 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 0x7f4a2c2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250aa50>, '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 0x2476550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24769e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', '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 20:06:13 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 20:06:13 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 20:06:13 INFO - Using env: {'DISPLAY': ':0', 20:06:13 INFO - 'HOME': '/home/cltbld', 20:06:13 INFO - 'LANG': 'en_US.UTF-8', 20:06:13 INFO - 'LANGUAGE': 'en_US:en', 20:06:13 INFO - 'LOGNAME': 'cltbld', 20:06:13 INFO - 'MAIL': '/var/mail/cltbld', 20:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:13 INFO - 'MOZ_NO_REMOTE': '1', 20:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:13 INFO - 'NO_EM_RESTART': '1', 20:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:13 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:13 INFO - 'SHELL': '/bin/bash', 20:06:13 INFO - 'SHLVL': '1', 20:06:13 INFO - 'TERM': 'linux', 20:06:13 INFO - 'TMOUT': '86400', 20:06:13 INFO - 'USER': 'cltbld', 20:06:13 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', 20:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:13 INFO - '_': '/tools/buildbot/bin/python'} 20:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 INFO - Cleaning up... 20:06:13 INFO - Return code: 0 20:06:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:06:13 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')]} 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:13 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')]} 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:13 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 0x7f4a2c2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250aa50>, '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 0x2476550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24769e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', '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 20:06:13 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 20:06:13 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 20:06:13 INFO - Using env: {'DISPLAY': ':0', 20:06:13 INFO - 'HOME': '/home/cltbld', 20:06:13 INFO - 'LANG': 'en_US.UTF-8', 20:06:13 INFO - 'LANGUAGE': 'en_US:en', 20:06:13 INFO - 'LOGNAME': 'cltbld', 20:06:13 INFO - 'MAIL': '/var/mail/cltbld', 20:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:13 INFO - 'MOZ_NO_REMOTE': '1', 20:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:13 INFO - 'NO_EM_RESTART': '1', 20:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:13 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:13 INFO - 'SHELL': '/bin/bash', 20:06:13 INFO - 'SHLVL': '1', 20:06:13 INFO - 'TERM': 'linux', 20:06:13 INFO - 'TMOUT': '86400', 20:06:13 INFO - 'USER': 'cltbld', 20:06:13 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', 20:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:13 INFO - '_': '/tools/buildbot/bin/python'} 20:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:13 INFO - Downloading/unpacking jsonschema 20:06:13 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 20:06:13 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 20:06:13 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 20:06:13 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 20:06:13 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 20:06:13 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 20:06:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:15 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 20:06:15 INFO - Downloading/unpacking functools32 (from jsonschema) 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:06:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:15 INFO - warning: no files found matching '*.txt' 20:06:15 INFO - no previously-included directories found matching 'build' 20:06:15 INFO - no previously-included directories found matching 'dist' 20:06:15 INFO - no previously-included directories found matching '.git*' 20:06:15 INFO - Installing collected packages: jsonschema, functools32 20:06:15 INFO - Running setup.py install for functools32 20:06:15 INFO - warning: no files found matching '*.txt' 20:06:15 INFO - no previously-included directories found matching 'build' 20:06:15 INFO - no previously-included directories found matching 'dist' 20:06:15 INFO - no previously-included directories found matching '.git*' 20:06:15 INFO - Successfully installed jsonschema functools32 20:06:15 INFO - Cleaning up... 20:06:15 INFO - Return code: 0 20:06:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:06:15 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')]} 20:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:15 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')]} 20:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:15 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 0x7f4a2c2aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250aa50>, '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 0x2476550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24769e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', '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 20:06:15 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 20:06:15 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 20:06:15 INFO - Using env: {'DISPLAY': ':0', 20:06:15 INFO - 'HOME': '/home/cltbld', 20:06:15 INFO - 'LANG': 'en_US.UTF-8', 20:06:15 INFO - 'LANGUAGE': 'en_US:en', 20:06:15 INFO - 'LOGNAME': 'cltbld', 20:06:15 INFO - 'MAIL': '/var/mail/cltbld', 20:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:15 INFO - 'MOZ_NO_REMOTE': '1', 20:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:15 INFO - 'NO_EM_RESTART': '1', 20:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:15 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:15 INFO - 'SHELL': '/bin/bash', 20:06:15 INFO - 'SHLVL': '1', 20:06:15 INFO - 'TERM': 'linux', 20:06:15 INFO - 'TMOUT': '86400', 20:06:15 INFO - 'USER': 'cltbld', 20:06:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', 20:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:15 INFO - '_': '/tools/buildbot/bin/python'} 20:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:16 INFO - Downloading/unpacking flake8 20:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:06:17 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 20:06:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:06:17 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 20:06:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:18 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 20:06:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:06:18 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 20:06:18 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 20:06:18 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 20:06:18 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 20:06:18 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 20:06:18 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 20:06:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:06:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:06:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:18 INFO - no previously-included directories found matching 'docs/_build' 20:06:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:06:18 INFO - Running setup.py install for pep8 20:06:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:18 INFO - no previously-included directories found matching 'docs/_build' 20:06:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:06:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:06:18 INFO - Cleaning up... 20:06:18 INFO - Return code: 0 20:06:18 INFO - Running post-action listener: _resource_record_post_action 20:06:18 INFO - Running post-action listener: _start_resource_monitoring 20:06:18 INFO - Starting resource monitoring. 20:06:18 INFO - ##### 20:06:18 INFO - ##### Running install step. 20:06:18 INFO - ##### 20:06:18 INFO - Running pre-action listener: _resource_record_pre_action 20:06:18 INFO - Running main action method: install 20:06:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:06:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:06:18 INFO - Reading from file tmpfile_stdout 20:06:18 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:06:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:06:18 INFO - Reading from file tmpfile_stdout 20:06:18 INFO - Output received: 20:06:18 INFO - Usage: mozinstall [options] installer 20:06:18 INFO - Options: 20:06:18 INFO - -h, --help show this help message and exit 20:06:18 INFO - -d DEST, --destination=DEST 20:06:18 INFO - Directory to install application into. [default: 20:06:18 INFO - "/builds/slave/test-pgo"] 20:06:18 INFO - --app=APP Application being installed. [default: firefox] 20:06:18 INFO - mkdir: /builds/slave/test-pgo/build/application 20:06:18 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'] 20:06:18 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 20:06:33 INFO - Reading from file tmpfile_stdout 20:06:33 INFO - Output received: 20:06:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:06:33 INFO - Running post-action listener: _resource_record_post_action 20:06:33 INFO - ##### 20:06:33 INFO - ##### Running run-tests step. 20:06:33 INFO - ##### 20:06:33 INFO - Running pre-action listener: _resource_record_pre_action 20:06:33 INFO - Running main action method: run_tests 20:06:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:06:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:06:33 INFO - Python 2.7.3 20:06:33 INFO - Return code: 0 20:06:33 INFO - grabbing minidump binary from tooltool 20:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250aa50>, '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 0x2476550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24769e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:06:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 20:06:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:06:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:06:33 INFO - Return code: 0 20:06:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:06:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:06:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:06:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:06:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:06:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:06:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:06:34 INFO - Return code: 0 20:06:34 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/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 20:06:34 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/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost 20:06:34 INFO - Using env: {'DISPLAY': ':0', 20:06:34 INFO - 'HOME': '/home/cltbld', 20:06:34 INFO - 'LANG': 'en_US.UTF-8', 20:06:34 INFO - 'LANGUAGE': 'en_US:en', 20:06:34 INFO - 'LOGNAME': 'cltbld', 20:06:34 INFO - 'MAIL': '/var/mail/cltbld', 20:06:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:06:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:34 INFO - 'MOZ_NO_REMOTE': '1', 20:06:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:34 INFO - 'NO_EM_RESTART': '1', 20:06:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:34 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:06:34 INFO - 'SHELL': '/bin/bash', 20:06:34 INFO - 'SHLVL': '1', 20:06:34 INFO - 'TERM': 'linux', 20:06:34 INFO - 'TMOUT': '86400', 20:06:34 INFO - 'USER': 'cltbld', 20:06:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510', 20:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:34 INFO - '_': '/tools/buildbot/bin/python'} 20:06:34 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/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] with output_timeout 3600 20:06:34 INFO - mozversion INFO | application_buildid: 20160105175404 20:06:34 INFO - mozversion INFO | application_changeset: 7e1284abc4733ef0372cd96671cfaac3227e2214 20:06:34 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 20:06:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:06:34 INFO - mozversion INFO | application_name: Firefox 20:06:34 INFO - mozversion INFO | application_remotingname: firefox-dev 20:06:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:06:34 INFO - mozversion INFO | application_vendor: Mozilla 20:06:34 INFO - mozversion INFO | application_version: 45.0a2 20:06:34 INFO - mozversion INFO | platform_buildid: 20160105175404 20:06:34 INFO - mozversion INFO | platform_changeset: 7e1284abc4733ef0372cd96671cfaac3227e2214 20:06:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:06:34 INFO - mozversion INFO | platform_version: 45.0a2 20:06:34 INFO - 2016-01-05 20:06:34,733 DEBUG : using testdate: 1452053194 20:06:34 INFO - 2016-01-05 20:06:34,733 DEBUG : actual date: 1452053194 20:06:34 INFO - 2016-01-05 20:06:34,742 INFO : starting webserver on 'localhost:53449' 20:06:34 INFO - 2016-01-05 20:06:34,743 INFO : Starting test suite talos-linux64-ix-019.e 20:06:34 INFO - 2016-01-05 20:06:34,743 INFO : Starting test dromaeo_css 20:06:34 INFO - 2016-01-05 20:06:34,743 DEBUG : operating with platform_type : linux_ 20:06:34 INFO - 2016-01-05 20:06:34,744 INFO : Initialising browser for dromaeo_css test... 20:06:34 INFO - 2016-01-05 20:06:34,760 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9lB4zl/profile http://localhost:53449/getInfo.html 20:06:39 INFO - 2016-01-05 20:06:39,248 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:06:39 INFO - 2016-01-05 20:06:39,248 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:06:39 INFO - 2016-01-05 20:06:39,248 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:06:39 INFO - 2016-01-05 20:06:39,248 DEBUG : BROWSER_OUTPUT: __metrics 20:06:40 INFO - 2016-01-05 20:06:40,231 INFO : Browser initialized. 20:06:40 INFO - 2016-01-05 20:06:40,232 INFO : Running cycle 1/1 for dromaeo_css test... 20:06:40 INFO - 2016-01-05 20:06:40,232 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9lB4zl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:06:52 INFO - 2016-01-05 20:06:52,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 137269248 20:06:52 INFO - 2016-01-05 20:06:52,055 DEBUG : BROWSER_OUTPUT: 20:07:41 INFO - 2016-01-05 20:07:41,656 DEBUG : BROWSER_OUTPUT: 1452053261654 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] 20:09:49 INFO - 2016-01-05 20:09:49,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53449/tests/dromaeo/cssquery-ext.html) 20:09:50 INFO - 2016-01-05 20:09:50,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 142028800 20:09:50 INFO - 2016-01-05 20:09:50,826 DEBUG : BROWSER_OUTPUT: 20:12:52 INFO - 2016-01-05 20:12:52,587 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/dromaeo/cssquery-ext.html (next: http://localhost:53449/tests/dromaeo/cssquery-jquery.html) 20:12:53 INFO - 2016-01-05 20:12:53,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 140271616 20:12:53 INFO - 2016-01-05 20:12:53,170 DEBUG : BROWSER_OUTPUT: 20:15:54 INFO - 2016-01-05 20:15:54,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53449/tests/dromaeo/cssquery-mootools.html) 20:15:55 INFO - 2016-01-05 20:15:55,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 138858496 20:15:55 INFO - 2016-01-05 20:15:55,333 DEBUG : BROWSER_OUTPUT: 20:18:56 INFO - 2016-01-05 20:18:56,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53449/tests/dromaeo/cssquery-prototype.html) 20:18:57 INFO - 2016-01-05 20:18:57,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 140324864 20:18:57 INFO - 2016-01-05 20:18:57,522 DEBUG : BROWSER_OUTPUT: 20:21:59 INFO - 2016-01-05 20:21:59,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53449/tests/dromaeo/cssquery-yui.html) 20:22:00 INFO - 2016-01-05 20:22:00,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 139530240 20:22:00 INFO - 2016-01-05 20:22:00,311 DEBUG : BROWSER_OUTPUT: 20:25:02 INFO - 2016-01-05 20:25:02,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/dromaeo/cssquery-yui.html (next: http://localhost:53449/tests/dromaeo/cssquery-dojo.html) 20:25:02 INFO - 2016-01-05 20:25:02,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 141971456 20:25:02 INFO - 2016-01-05 20:25:02,476 DEBUG : BROWSER_OUTPUT: 20:25:02 INFO - 2016-01-05 20:25:02,477 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:25:02 INFO - 2016-01-05 20:25:02,477 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:25:02 INFO - 2016-01-05 20:25:02,477 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:25:02 INFO - 2016-01-05 20:25:02,477 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:25:02 INFO - 2016-01-05 20:25:02,478 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3347.179940914476;3379.817064027589;3391.186115332321;3418.3505134024535;3428.5371474850886;5465.945340546593;5484.9177262341045;5497.065498865192;5515.034868897942;5515.917261241085;5490.396056433789;5524.977879092371;5563.388027316992;5568.443155684439;5591.9720401397935;4991.326170966919;5051.772670229849;5113.488651134894;5121.078205922932;5146.073706732786;4920.3111564381015;5011.624128190382;5057.595392368602;5063.797448102072;5087.643864929457;4989.825356112537;5039.344885164924;5047.3438453001245;5059.772310246048;5103.362079740033;5082.720450375228;5101.974490127563;5113.411957624883;5130.256112863651;5146.691198528081;4783.5933945614315;4816.975915120437;4887.560119589254;5027.120253955543;5051.1413059779925;5299.920501192485;5312.362516498007;5313.8937221255355;5319.148936170232;5359.598030147716;5923.614965027259;5926.348101708809;5938.435848594377;5971.701414929236;5999.430054144849;5636.859078523029;5742.799002034909;5750.3962083981;5800.245968024172;5963.5527335450015;5573.470520300565;5609.3268807742925;5611.663300202001;5613.691246981414;5614.69119198448;6124.356942520971;6124.816255512342;6125.938740612626;6133.1413602095745;6135.631862088289;5745.626534275259;5747.453991870766;5834.941650583524;5837.795677151279;5894.292684877756;5853.707314634251;5875.383084776037;5885.941140588539;5886.61736987103;5962.731677074542;5833.854153646193;5834.124881267844;5835.095560188178;5843.0066888629035;5851.912221316684;5613.8596535086135;5650.208970744099;5680.261565996394;5707.115397113371;5787.479126878601;4508.639308855284;4513.871532116905;4533.342665313511;4539.0921815637;4593.19619066662;3965.2466031453932;4072.1855628874346;4073.8185926081696;4094.3449048152747;4112.773797441169;5469.671819690831;5502.972485137629;5534.1975413565615;5556.694381809039;5597.412271711493;6012.669303188279;6050.848728781728;6053.727582258809;6062.575619706578;6064.545159112996;5452.563794896399;5536.474034966672;5711.657300561979;5713.657180569179;5732.398098199629;5028.195488721787;5075.873103172376;5112.821051263188;5113.411957624847;5139.7687104080405;5985.281766187998;5986.700664966735;5995;5998.4601385875485;6047.606905551125;5748.54011679073;5823.82528524145;5872.060470324727;5881.382454842265;5908.822735317947;6025.849353766015;6033.12519684652;6038.335783063947;6055.333913269625;6055.727492262947;5709.600327977168;5789.2763404574425;5825.6795876225515;5825.70871456434;5836.503897168618;5683.772649094155;5773.624714393551;5906.940930590639;5925.377835327228;6024;5817.592768506164;5880.14737863016;5880.705964701833;5890.381509941394;5895.852603684943;5781.4218578141845;5789.710514474344;5808.244928159313;5856.531477481876;5874.647521148745;5555.194496797861;5611.775528978795;5687.232223649919;5733.971330143323;5749.712514374348;5743.483086522233;5750.166225897305;5761.107028410603;5763.51010164124;5881.4118588142555;5645.435456454322;5648.293963254593;5648.943510564842;5667.886642267049;5671.574631902541 20:25:02 INFO - 2016-01-05 20:25:02,478 DEBUG : BROWSER_OUTPUT: |1;ext.html;581.8196359128668;590.4213870407001;623.4077626255059;627.952903532235;634.2895956528689;31336;40637.59362406375;41186.38220426696;41281.79359103208;41323.79338103313;45193.548064519426;45628.315575266315;45794.7710261449;45805.541944580546;46014.53985460144;8866.468011919289;9111.908880911205;9134.36059475837;9135.725928222164;9181.127792859701;8975.102489751005;9122.543872806365;9126.543672816333;9131.817363652723;9138.451692898414;9012.594433250486;9124.726258212264;9138.0405057469;9139.497327646977;9158.221551168159;8964.372493925428;9033.638654453847;9064.048274931136;9066;9089.909100909039;8918.643254269886;8949.463032218022;9068.682596109105;9076.683880837307;9095.863562046508;39544.40683389751;39590.802045989876;41062.38406423906;41141.58858411408;41155.588444115776;3441.776284541522;3477.2871561329866;3522.771019883725;3737.121776382548;4040.5353384360883;31607.525887111482;31849.52225716616;31939.201519961953;32430.189245268823;33032.50451243209;3979.422983667381;4105.2405305018665;4114.814833332507;4145.2124096421885;4146.129312844307;279842;282336;283314;501326;503428;63411;63678.36321636817;64139;64188.35811641917;64658;68403.65798171077;68766.31233687598;68854.65572672205;68933.31066689269;69058;16692;16703.665926681642;16763.245653945603;16823.663526729397;16863.241154148094;12631.810522842165;12640.431180596896;12779.680507987188;12796.040296977764;12838.743225135446;21525.78474215269;21950.243980481522;21981.560368792536;22000.88999555024;22034.779652203593;8473.49159050459;8503.447275927045;8549.786255343543;8648.221660050625;8737.694180703646;906.4606559097326;920.1266538954003;932.9579028771894;938.3244064273712;1137.3062431916524;29226.707732922823;29399.82400703948;29436.264093397407;29488.262793430335;29832.10503684893;1074.989250107489;1096.5010920031366;1097.6048622495896;1105.182165197748;1151.7696460707891;15438.305276262596;16104.355825766837;17284.962902225907;17365.218565164345;17998.730019049726;781914;825111;829180;834649;835643;59311;59507.70246148742;59790;60333.69833150806;60490;1504.5561559340022;1506.8493150685063;1508.8415716349846;1508.9924550377177;1613.370785393674;30409.695903040687;30719.846400768747;30734.077977660705;31449.52825707662;31494.212644684067;48757.51242487672;49734;50338.244926326865;50349.496505035946;50435.243471347225;320376;320475;320539;320575;322384;33464;34367;34796.82601586976;34898.82550587231;34927;44193;45161.32258016067;45228;45631.54368456273;45814.54185458236;37509.249815003;38790;38862.2227555453;39621;39649.80175099106;44915;46206.53793462157;46448.30327545022;46828.29757553708;47510;38927;38934.415983759696;39485.80257098696;39511.60488395079;39705;30037.399252014402;30228.697713023466;30254.54618180773;30383.240418989702;30499.695003050572;26279.474410512066;26327;26463.470730585665;26582.335441614116;26645.200643980712 20:25:02 INFO - 2016-01-05 20:25:02,478 DEBUG : BROWSER_OUTPUT: |2;jquery.html;391.8706826747174;393.23908237560306;394.13487395167607;396.5697218517908;398.09433538699454;15872.523824285261;17158;17258.2233799479;18710;18789;11200.047995920337;11545.711357216074;11592.884071159307;15786.368545258176;17017.319307227695;4951.084049450863;4987.351644286237;5052.065367906949;5063;5077.64456488046;3843.385058390658;3929.2337994091163;4997.175466048097;5381.139017757159;5480.205370221315;5499.1476321170285;5502.669839809604;5504.0643090674685;5523;5543.36251331096;5245.370555533342;5342.946570534304;5344.893102137936;5380.300560927054;5468.152436372368;5173.456787037345;5184.403793563713;5190.195519694454;5205.557527610158;5365.356157261114;12415.130940834146;12618.242905425612;12628.17916835412;12991.870081299161;20963.5807283855;2174.8695078295355;2243.8317126215434;2286.5541219462043;2380.3811009137576;2452.619843924195;9875.90124098757;10000.649977250761;10134.087932086073;10362.792744145076;12418.627441176688;1898.4209816006112;1931.6329897319604;1956.0610906764691;1957.6084783043307;1979.1687491253708;61856.38143618596;63056.68471657658;63990;64007.67996160036;64225.67887160534;10638.361698298128;10805.783884322269;10836.458177091114;10838.13294936419;10942.890571094347;13872.930635346758;13939.16365018102;13949;14005.579832605039;14043.578692639237;7814.648340824677;7856.25365590268;7869.685212591547;7877.172896845863;7961.845532397886;7260.346568808833;7267.818304542323;7300.452466065067;7330.157031941289;7480.401567874557;4528.456585209796;4552.658550608718;4595.195840727859;4644.256918892961;4666.4633567139535;1927.9325223617107;1931.5557421793067;1957.5204075001432;1974.9506262343557;1981.6532106881239;940.5579377692474;980.2501086668705;996.7906739584769;999.8000399920045;1066.8293073108266;16485.752713709306;16549;16597.419090332023;16820;16974.745378819327;985.935914165577;1005.9245556583286;1012.8126296635146;1016.6949915025463;1026.6047571684805;9906.55420506079;10017.549210285555;10290.948545257226;10480.318779279323;10558.736031599272;578610;584020;594334;594885;602618;77763.22236777673;80131.19868801237;85395.57302213449;86658.133418665;87218.56390718005;1226.5032661771997;1228.4533382644638;1252.3550371558654;1266.4427651833164;1288.375138058041;16046.037237765771;16354.91224751876;16594.58513537171;16654.666906661558;16655.83344166543;38144.23711525698;38162.42756358601;38456;38648.2270354597;38722.22555548817;50933.74533127311;51288.230676540625;52347.73826130845;53093;55811.720941396656;10032.147267482054;10047.346922450017;10116.84824727615;10130.696079117639;10284.177265818567;14806;15457.5362739118;18462.538436539195;18666.81333186705;18972.241110355983;14161.787573186617;15180.240987950338;15180.468683596022;15194.620134496285;15581.688366232838;14539.85460145385;14900.776488352467;14913.328900199735;15148.091114533163;15444.22778861075;15231.086134831945;15405.998610090308;15451.304691289144;15731.606709831887;15763;9529.904700952902;9537.427754334762;9588.993155718548;9633.373830700983;9903.613494110974;10450.895491044992;11576.768464630828;14155.36300866484;14344.56966291013;14732.705345893237 20:25:02 INFO - 2016-01-05 20:25:02,479 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1360.9251491167986;1426.4009116171208;1615.604176976641;1899.078946710845;1911.23550579768;7697.422693298004;7924.603769811501;8115.797105072362;8151.266386025257;8188.54962977036;8021.91978080219;8091.433599648027;8181.018277806656;8184.468009579373;8189.95905020474;2261.4346413396693;2294.5869743446174;2301.5166814968875;2304.43541332373;2305.4582173189287;2280.4184932842104;2331.8367714260007;2339.1695947938492;2340.4616938104245;2343.5898717724417;2235.61994460942;2285.714285714286;2293.4495721027;2293.5412917416584;2318.8608683479047;2265.456290490287;2285.1887579909226;2290.0496294037953;2291.072115793098;2297.9655305170436;2250.1224522436264;2253.740819805727;2270.71616047994;2271.4889149941296;2277.829162812796;7878.921210787876;7908.090569584457;7930.246626570467;7945.649239629277;7980.920190798076;4732.503087175865;4807.423109226916;4819.228923372279;4826.227803551415;4831.05794370098;3037.119235421725;3047.0706434537456;3061.984690076558;3078.5843911072166;3102.0383681058943;929.7071422501958;938.699616122841;948.6158105967095;960.8174446855076;988.2785566536469;10732.463376831127;10774.622888198875;10803.5678572857;10858;10859.565617375296;4011.7592944423427;4033.8184781684895;4048.7570745755347;4070.043539768152;4188.916221675549;8470;8524.829503410021;8526.914730852735;8538.188872057144;8555.871661925075;4663.183942809995;4688.8124475021295;4692.389989301369;4693.859184224479;4699.412573428322;4247.895547157699;4270.701050926467;4285.357196420562;4289.528151903351;4299.247631664446;3501.3347463981763;3505.5793304803587;3510;3534.699550538233;3555.0756803231347;1064.9307794993301;1066.7759770448292;1080.2384319055047;1086.0605576176708;1093.9343639381664;1036.6164519127972;1069.1713921710582;1079.2175672637275;1211.0674780419029;1316.2628927800463;7383.2985866342615;7402.185759566443;7432.702691892264;7438.107427108674;7461.925380746123;1150.2523359816187;1182.5979167083233;1195.677167164878;1197.5449329254827;1202.2245651554872;5893.381194974551;5922.674252916131;5971.820845374646;5990.4908082813445;6012.098185272157;9339.346245762732;9712.22302215821;9817.852732209023;9818.41089534616;9835.508224588742;9551.14039736427;9565.473898935625;9590.712278631652;9645.951770241103;9653.131218190396;7449.702011919462;7514.511556748794;7524.510906791041;7526.435517336222;7549.320561149523;7129.643517823984;7137.643117844191;7154.928450715634;7232.963835180791;7303.963480182565;8433.072362040293;8460.661573536989;8560.657573697232;8582.356323275655;8582.742517724479;8598.441101328393;8667.479951202948;8669;8685.869711954452;8722.127787221227;7081.362677359062;7129.607871567114;7141.571505709674;7144.607046612487;7168.641567921687;7531.171571127062;7609.733659321897;7619.619019049136;7652.426068044808;7666.731664391719;7062.752803651848;7244.565326080241;7360.1535823381;7360.227176146427;7487.138979017483;7062.8940565890525;7074.717011319695;7162.641867906688;7200.71197152108;7211.495195336276;7112.146542414944;7163.892541611985;7167.068281123421;7177.282271772781;7182.6408679564765;6594.241662208908;6644.900326495203;6656.167979002625;6656.167979002625;6691.59850408977;6581;6683.398494135551;6736.393724564813;6740.6966686498245;6746.527743057939 20:25:02 INFO - 2016-01-05 20:25:02,479 DEBUG : BROWSER_OUTPUT: |4;prototype.html;348.8465075366839;356.29098094791374;356.94110471772166;361.97828130312183;362.929228800384;6091.994820854554;6259.029850373194;6280.089387038876;6297.811065668026;6380.234371875382;6030.819075427733;6206.7827626033095;6216.440520353167;6218.7201575929075;6237.220347456557;4835.202191638376;4837.516248375161;4840.927386089212;4842.370491836056;4849.199882019462;4839.879003024917;4844.830430934918;4847.224444088946;4851.975740121312;4852.927206091894;4679.064187162581;4788.784504697297;4821.638377121712;4829.082474329884;4830.082284365977;4809.927851082237;4814.75926203692;4816.97591512042;4818.951810481885;4820.517948205169;4241.554636763157;4245.617894389489;4249.575042495757;4261.126469073833;4263.019505513718;5926.170336152942;5939.287285525721;5954.285485741695;5957.404259574051;5964.284285885721;5461.5357694596005;5568.49883510482;5594.580406469531;5611.691356975365;5613.46672066153;6628.93371066288;6642.269350371455;6645.368689974444;6649.102371179877;6660.733570657217;4705.411823522059;4708.7051060958165;4709.364235828154;4711.882202944919;4712.269598212282;6775.0514927910135;6905.723771049203;6912.447004239699;6919.930800691979;6970.651467426659;4686.976565117221;4743.66794324394;4745.1221524018165;4756.453007904066;4756.904861902743;4803;4803.615710743132;4810.0139471408975;4814.133455977888;4816.8314109006715;5511.862203444946;5515.889682206333;5523.475269849358;5527.778888844482;5528.889422211533;6471.449926756184;6646.401823835878;6695.899561506581;6733.360330768667;6752.122224110933;1656.3871367593827;1664.3342662934922;1695.6439147778858;1696.1180186303054;1701.5235733994502;1118.2731224704007;1144.582227486978;1144.7481554058095;1145.066770581973;1154.9018333441752;6390.201224846895;6440.323766004596;6443.355664433613;6459.870802583922;6461.709223084972;6824.078749368871;6845.281245469254;6855.417289530346;6858.485613579001;6858.9368647859665;6359.17330747;6400.167978162809;6418.807435776934;6431.196100487439;6439.549231553746;3738.27103714773;3766.0584853786554;3772.43413487979;3776.86780962665;3779.149691319431;7082.504224704324;7117;7133.286671332825;7181.784546463615;7195.388391986635;6980.917957716562;7095.964520177469;7164.749233776793;7166.713331466787;7182.317679820409;7162.713491460283;7166.247544007804;7178.964105179441;7179.605121718251;7191.244919283505;6988.79033628992;6994.2656021117045;6994.895076573754;6998.370146686822;7007.159140903124;6734.696938637675;6852.349026842442;6864.6910889011115;6892.517523773488;6896.620685862325;7144.4998850082075;7150.034745309316;7150.892736609059;7158;7174.784756457315;4763.54746299101;4794.880127996828;4795.017021510652;4798.064377446364;4824.517548245148;6882.449404047564;6980.336867997532;6981.162260528769;6986.860262794614;6992.860142797217;6776.220734615582;6783.694733736895;6818.113645226089;6825.55633883796;6829.965850170717;6766.695498702472;6791.592504449749;6804.455643548603;6807.285235050248;6808.046873437822;6490.448311893542;6602.60384376939;6611.140551728437;6666.466682665472;6667.733290668319;6779.15260592426;6809.557378770364;6818.045473633794;6821.215560210441;6823.965880170766;6600.933990660032;6634.203895532567;6635.369639884203;6641.203055633162;6661.833454163685 20:25:02 INFO - 2016-01-05 20:25:02,481 DEBUG : BROWSER_OUTPUT: |5;yui.html;842.3934766967785;845.437783873724;847.9491230526169;853.1255463150267;881.9514926679034;13331.133476324032;13580;13597.592072237823;13601.93199034006;13605.047646664738;13087;13253.536126235584;13325.933370333134;13449.193048417103;13470.124441911268;857.7684025313177;879.7888506758364;895.8566629339307;911.307406371156;917.8669092981513;887.9023307436177;888.071964796789;890.528020149322;897.4256475855458;904.92308153807;932.9766755831091;933.9719808405724;935.7660584853786;939.8496240601505;942.6229508196708;918.0406475233397;925.2228128372166;927.5918595817818;929.6606738540452;930.776613612728;683.565935630873;687.041577000082;687.8005378440247;688.2326206280012;690.5960013392172;13521.459141634323;13593.59219223425;13702.10936289138;13761;13789.172649641054;12874.549390771279;13036.804447933193;13231.27228002469;13286.26925519096;13820.861791382158;10351.534180961875;10791.83812242817;11015.504302306335;11122.49948752308;11200.943995279971;3870.0518372998513;3896.629820167108;3918.921621567581;3954.1498577805623;3958.34687276599;51236.48763512354;51711;51941.48058519442;52024;52122;10318.122959548522;10347.689569312932;10391.37651740898;10496.737581560523;10572.471376431147;18658.720119198224;18683.532911677044;19737.210511579662;19977;20013.899930500545;8091.919080809116;8168.632411541495;8261.8347633047;8317.168283171635;8529.104444033288;4738.881527961828;4815.927761083586;4870.245112007645;4912.164931961575;4962.5533701967;3319.0374791310733;3327.168207948013;3335.466325387975;3366.259422926952;3366.898993030164;594.0406243916044;597.235538510707;603.1435361786274;603.6860832367232;603.6951339573575;655.7573697731774;668.12809283885;671.771597656799;676.2763842688374;678.9966050169718;8395.664173433117;8466.788330291793;8916.37585369031;9635.710928672152;10092.861926610054;695.8720551122635;700.3276854219904;704.8484575816224;718.4791026505742;739.0872272743158;4226.218149642326;4415.66882483815;4531.048479819275;4531.18438681034;4572.6799124061;67282.66358668273;68719;68743.3125668747;68853;69378;57795.71102144462;58640;58813;59228.70385648044;60446.395536044074;54004;54412.72793636007;54495.72752136214;54901.45098549043;54932.17601735897;8666.436681615927;8720.258778003941;8823.60293786794;9158.084191580789;9303.023182566003;38169.427458588696;38843.61002763312;39635.405468917415;39644.603553965244;40008;47855.28217076677;52977.7351113242;53744.462555373946;53806;54403.45596544142;10175.389476631426;11020.559177632806;11249.493772780408;11275.323480590863;11391.373474458984;12409;12641.431135599105;12965.416556254802;13181.143225690299;13650.044496885519;12200.084993625691;12380.319082450551;12392.070594705252;12573.74852502963;12670.746585068431;12411.689707757378;12422.440990155645;12489.687757806127;12551.3096779678;12726;12029.85730844547;12098.516059357878;12123.211991220542;12152.696182595506;12355.32045737493;10250.692479225636;10540.472976350999;10563.63027294041;10618.73453163677;10732.67801965911;9984.850227246452;10520.265880353718;10544.15646748243;10644.946775266075;10729.678109656723 20:25:02 INFO - 2016-01-05 20:25:02,481 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:25:02 INFO - 2016-01-05 20:25:02,481 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:25:02 INFO - 2016-01-05 20:25:02,481 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,288 20:25:02 INFO - 2016-01-05 20:25:02,481 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:25:02 INFO - 2016-01-05 20:25:02,481 DEBUG : BROWSER_OUTPUT: __startTimestamp1452054302469__endTimestamp 20:25:02 INFO - 2016-01-05 20:25:02,481 DEBUG : BROWSER_OUTPUT: 20:25:02 INFO - 2016-01-05 20:25:02,481 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:25:02 INFO - 2016-01-05 20:25:02,482 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:25:02 INFO - 2016-01-05 20:25:02,482 DEBUG : BROWSER_OUTPUT: 20:25:02 INFO - 2016-01-05 20:25:02,482 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5481.79 Median:5680.26 stddev:591.43 (10.4%) stddev-sans-first:569.04 20:25:02 INFO - 2016-01-05 20:25:02,482 DEBUG : BROWSER_OUTPUT: Values: 3347.2 3379.8 3391.2 3418.4 3428.5 5465.9 5484.9 5497.1 5515.0 5515.9 5490.4 5525.0 5563.4 5568.4 5592.0 4991.3 5051.8 5113.5 5121.1 5146.1 4920.3 5011.6 5057.6 5063.8 5087.6 4989.8 5039.3 5047.3 5059.8 5103.4 5082.7 5102.0 5113.4 5130.3 5146.7 4783.6 4817.0 4887.6 5027.1 5051.1 5299.9 5312.4 5313.9 5319.1 5359.6 5923.6 5926.3 5938.4 5971.7 5999.4 5636.9 5742.8 5750.4 5800.2 5963.6 5573.5 5609.3 5611.7 5613.7 5614.7 6124.4 6124.8 6125.9 6133.1 6135.6 5745.6 5747.5 5834.9 5837.8 5894.3 5853.7 5875.4 5885.9 5886.6 5962.7 5833.9 5834.1 5835.1 5843.0 5851.9 5613.9 5650.2 5680.3 5707.1 5787.5 4508.6 4513.9 4533.3 4539.1 4593.2 3965.2 4072.2 4073.8 4094.3 4112.8 5469.7 5503.0 5534.2 5556.7 5597.4 6012.7 6050.8 6053.7 6062.6 6064.5 5452.6 5536.5 5711.7 5713.7 5732.4 5028.2 5075.9 5112.8 5113.4 5139.8 5985.3 5986.7 5995.0 5998.5 6047.6 5748.5 5823.8 5872.1 5881.4 5908.8 6025.8 6033.1 6038.3 6055.3 6055.7 5709.6 5789.3 5825.7 5825.7 5836.5 5683.8 5773.6 5906.9 5925.4 6024.0 5817.6 5880.1 5880.7 5890.4 5895.9 5781.4 5789.7 5808.2 5856.5 5874.6 5555.2 5611.8 5687.2 5734.0 5749.7 5743.5 5750.2 5761.1 5763.5 5881.4 5645.4 5648.3 5648.9 5667.9 5671.6 20:25:02 INFO - 2016-01-05 20:25:02,482 DEBUG : BROWSER_OUTPUT: 20:25:02 INFO - 2016-01-05 20:25:02,482 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:65776.61 Median:22588.60 stddev:150008.23 (664.1%) stddev-sans-first:150349.18 20:25:02 INFO - 2016-01-05 20:25:02,483 DEBUG : BROWSER_OUTPUT: Values: 581.8 590.4 623.4 628.0 634.3 31336.0 40637.6 41186.4 41281.8 41323.8 45193.5 45628.3 45794.8 45805.5 46014.5 8866.5 9111.9 9134.4 9135.7 9181.1 8975.1 9122.5 9126.5 9131.8 9138.5 9012.6 9124.7 9138.0 9139.5 9158.2 8964.4 9033.6 9064.0 9066.0 9089.9 8918.6 8949.5 9068.7 9076.7 9095.9 39544.4 39590.8 41062.4 41141.6 41155.6 3441.8 3477.3 3522.8 3737.1 4040.5 31607.5 31849.5 31939.2 32430.2 33032.5 3979.4 4105.2 4114.8 4145.2 4146.1 279842.0 282336.0 283314.0 501326.0 503428.0 63411.0 63678.4 64139.0 64188.4 64658.0 68403.7 68766.3 68854.7 68933.3 69058.0 16692.0 16703.7 16763.2 16823.7 16863.2 12631.8 12640.4 12779.7 12796.0 12838.7 21525.8 21950.2 21981.6 22000.9 22034.8 8473.5 8503.4 8549.8 8648.2 8737.7 906.5 920.1 933.0 938.3 1137.3 29226.7 29399.8 29436.3 29488.3 29832.1 1075.0 1096.5 1097.6 1105.2 1151.8 15438.3 16104.4 17285.0 17365.2 17998.7 781914.0 825111.0 829180.0 834649.0 835643.0 59311.0 59507.7 59790.0 60333.7 60490.0 1504.6 1506.8 1508.8 1509.0 1613.4 30409.7 30719.8 30734.1 31449.5 31494.2 48757.5 49734.0 50338.2 50349.5 50435.2 320376.0 320475.0 320539.0 320575.0 322384.0 33464.0 34367.0 34796.8 34898.8 34927.0 44193.0 45161.3 45228.0 45631.5 45814.5 37509.2 38790.0 38862.2 39621.0 39649.8 44915.0 46206.5 46448.3 46828.3 47510.0 38927.0 38934.4 39485.8 39511.6 39705.0 30037.4 30228.7 30254.5 30383.2 30499.7 26279.5 26327.0 26463.5 26582.3 26645.2 20:25:02 INFO - 2016-01-05 20:25:02,483 DEBUG : BROWSER_OUTPUT: 20:25:02 INFO - 2016-01-05 20:25:02,484 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30668.77 Median:1980.41 stddev:96599.22 (4877.7%) stddev-sans-first:96843.45 20:25:02 INFO - 2016-01-05 20:25:02,484 DEBUG : BROWSER_OUTPUT: Values: 391.9 393.2 394.1 396.6 398.1 15872.5 17158.0 17258.2 18710.0 18789.0 11200.0 11545.7 11592.9 15786.4 17017.3 4951.1 4987.4 5052.1 5063.0 5077.6 3843.4 3929.2 4997.2 5381.1 5480.2 5499.1 5502.7 5504.1 5523.0 5543.4 5245.4 5342.9 5344.9 5380.3 5468.2 5173.5 5184.4 5190.2 5205.6 5365.4 12415.1 12618.2 12628.2 12991.9 20963.6 2174.9 2243.8 2286.6 2380.4 2452.6 9875.9 10000.6 10134.1 10362.8 12418.6 1898.4 1931.6 1956.1 1957.6 1979.2 61856.4 63056.7 63990.0 64007.7 64225.7 10638.4 10805.8 10836.5 10838.1 10942.9 13872.9 13939.2 13949.0 14005.6 14043.6 7814.6 7856.3 7869.7 7877.2 7961.8 7260.3 7267.8 7300.5 7330.2 7480.4 4528.5 4552.7 4595.2 4644.3 4666.5 1927.9 1931.6 1957.5 1975.0 1981.7 940.6 980.3 996.8 999.8 1066.8 16485.8 16549.0 16597.4 16820.0 16974.7 985.9 1005.9 1012.8 1016.7 1026.6 9906.6 10017.5 10290.9 10480.3 10558.7 578610.0 584020.0 594334.0 594885.0 602618.0 77763.2 80131.2 85395.6 86658.1 87218.6 1226.5 1228.5 1252.4 1266.4 1288.4 16046.0 16354.9 16594.6 16654.7 16655.8 38144.2 38162.4 38456.0 38648.2 38722.2 50933.7 51288.2 52347.7 53093.0 55811.7 10032.1 10047.3 10116.8 10130.7 10284.2 14806.0 15457.5 18462.5 18666.8 18972.2 14161.8 15180.2 15180.5 15194.6 15581.7 14539.9 14900.8 14913.3 15148.1 15444.2 15231.1 15406.0 15451.3 15731.6 15763.0 9529.9 9537.4 9589.0 9633.4 9903.6 10450.9 11576.8 14155.4 14344.6 14732.7 20:25:02 INFO - 2016-01-05 20:25:02,485 DEBUG : BROWSER_OUTPUT: 20:25:02 INFO - 2016-01-05 20:25:02,485 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5543.86 Median:6687.50 stddev:2887.08 (43.2%) stddev-sans-first:2878.06 20:25:02 INFO - 2016-01-05 20:25:02,486 DEBUG : BROWSER_OUTPUT: Values: 1360.9 1426.4 1615.6 1899.1 1911.2 7697.4 7924.6 8115.8 8151.3 8188.5 8021.9 8091.4 8181.0 8184.5 8190.0 2261.4 2294.6 2301.5 2304.4 2305.5 2280.4 2331.8 2339.2 2340.5 2343.6 2235.6 2285.7 2293.4 2293.5 2318.9 2265.5 2285.2 2290.0 2291.1 2298.0 2250.1 2253.7 2270.7 2271.5 2277.8 7878.9 7908.1 7930.2 7945.6 7980.9 4732.5 4807.4 4819.2 4826.2 4831.1 3037.1 3047.1 3062.0 3078.6 3102.0 929.7 938.7 948.6 960.8 988.3 10732.5 10774.6 10803.6 10858.0 10859.6 4011.8 4033.8 4048.8 4070.0 4188.9 8470.0 8524.8 8526.9 8538.2 8555.9 4663.2 4688.8 4692.4 4693.9 4699.4 4247.9 4270.7 4285.4 4289.5 4299.2 3501.3 3505.6 3510.0 3534.7 3555.1 1064.9 1066.8 1080.2 1086.1 1093.9 1036.6 1069.2 1079.2 1211.1 1316.3 7383.3 7402.2 7432.7 7438.1 7461.9 1150.3 1182.6 1195.7 1197.5 1202.2 5893.4 5922.7 5971.8 5990.5 6012.1 9339.3 9712.2 9817.9 9818.4 9835.5 9551.1 9565.5 9590.7 9646.0 9653.1 7449.7 7514.5 7524.5 7526.4 7549.3 7129.6 7137.6 7154.9 7233.0 7304.0 8433.1 8460.7 8560.7 8582.4 8582.7 8598.4 8667.5 8669.0 8685.9 8722.1 7081.4 7129.6 7141.6 7144.6 7168.6 7531.2 7609.7 7619.6 7652.4 7666.7 7062.8 7244.6 7360.2 7360.2 7487.1 7062.9 7074.7 7162.6 7200.7 7211.5 7112.1 7163.9 7167.1 7177.3 7182.6 6594.2 6644.9 6656.2 6656.2 6691.6 6581.0 6683.4 6736.4 6740.7 6746.5 20:25:02 INFO - 2016-01-05 20:25:02,486 DEBUG : BROWSER_OUTPUT: 20:25:02 INFO - 2016-01-05 20:25:02,486 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5610.72 Median:6385.22 stddev:1690.23 (26.5%) stddev-sans-first:1648.18 20:25:02 INFO - 2016-01-05 20:25:02,486 DEBUG : BROWSER_OUTPUT: Values: 348.8 356.3 356.9 362.0 362.9 6092.0 6259.0 6280.1 6297.8 6380.2 6030.8 6206.8 6216.4 6218.7 6237.2 4835.2 4837.5 4840.9 4842.4 4849.2 4839.9 4844.8 4847.2 4852.0 4852.9 4679.1 4788.8 4821.6 4829.1 4830.1 4809.9 4814.8 4817.0 4819.0 4820.5 4241.6 4245.6 4249.6 4261.1 4263.0 5926.2 5939.3 5954.3 5957.4 5964.3 5461.5 5568.5 5594.6 5611.7 5613.5 6628.9 6642.3 6645.4 6649.1 6660.7 4705.4 4708.7 4709.4 4711.9 4712.3 6775.1 6905.7 6912.4 6919.9 6970.7 4687.0 4743.7 4745.1 4756.5 4756.9 4803.0 4803.6 4810.0 4814.1 4816.8 5511.9 5515.9 5523.5 5527.8 5528.9 6471.4 6646.4 6695.9 6733.4 6752.1 1656.4 1664.3 1695.6 1696.1 1701.5 1118.3 1144.6 1144.7 1145.1 1154.9 6390.2 6440.3 6443.4 6459.9 6461.7 6824.1 6845.3 6855.4 6858.5 6858.9 6359.2 6400.2 6418.8 6431.2 6439.5 3738.3 3766.1 3772.4 3776.9 3779.1 7082.5 7117.0 7133.3 7181.8 7195.4 6980.9 7096.0 7164.7 7166.7 7182.3 7162.7 7166.2 7179.0 7179.6 7191.2 6988.8 6994.3 6994.9 6998.4 7007.2 6734.7 6852.3 6864.7 6892.5 6896.6 7144.5 7150.0 7150.9 7158.0 7174.8 4763.5 4794.9 4795.0 4798.1 4824.5 6882.4 6980.3 6981.2 6986.9 6992.9 6776.2 6783.7 6818.1 6825.6 6830.0 6766.7 6791.6 6804.5 6807.3 6808.0 6490.4 6602.6 6611.1 6666.5 6667.7 6779.2 6809.6 6818.0 6821.2 6824.0 6600.9 6634.2 6635.4 6641.2 6661.8 20:25:02 INFO - 2016-01-05 20:25:02,487 DEBUG : BROWSER_OUTPUT: 20:25:02 INFO - 2016-01-05 20:25:02,487 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15346.32 Median:26297.08 stddev:18523.21 (70.4%) stddev-sans-first:18543.15 20:25:02 INFO - 2016-01-05 20:25:02,488 DEBUG : BROWSER_OUTPUT: Values: 842.4 845.4 847.9 853.1 882.0 13331.1 13580.0 13597.6 13601.9 13605.0 13087.0 13253.5 13325.9 13449.2 13470.1 857.8 879.8 895.9 911.3 917.9 887.9 888.1 890.5 897.4 904.9 933.0 934.0 935.8 939.8 942.6 918.0 925.2 927.6 929.7 930.8 683.6 687.0 687.8 688.2 690.6 13521.5 13593.6 13702.1 13761.0 13789.2 12874.5 13036.8 13231.3 13286.3 13820.9 10351.5 10791.8 11015.5 11122.5 11200.9 3870.1 3896.6 3918.9 3954.1 3958.3 51236.5 51711.0 51941.5 52024.0 52122.0 10318.1 10347.7 10391.4 10496.7 10572.5 18658.7 18683.5 19737.2 19977.0 20013.9 8091.9 8168.6 8261.8 8317.2 8529.1 4738.9 4815.9 4870.2 4912.2 4962.6 3319.0 3327.2 3335.5 3366.3 3366.9 594.0 597.2 603.1 603.7 603.7 655.8 668.1 671.8 676.3 679.0 8395.7 8466.8 8916.4 9635.7 10092.9 695.9 700.3 704.8 718.5 739.1 4226.2 4415.7 4531.0 4531.2 4572.7 67282.7 68719.0 68743.3 68853.0 69378.0 57795.7 58640.0 58813.0 59228.7 60446.4 54004.0 54412.7 54495.7 54901.5 54932.2 8666.4 8720.3 8823.6 9158.1 9303.0 38169.4 38843.6 39635.4 39644.6 40008.0 47855.3 52977.7 53744.5 53806.0 54403.5 10175.4 11020.6 11249.5 11275.3 11391.4 12409.0 12641.4 12965.4 13181.1 13650.0 12200.1 12380.3 12392.1 12573.7 12670.7 12411.7 12422.4 12489.7 12551.3 12726.0 12029.9 12098.5 12123.2 12152.7 12355.3 10250.7 10540.5 10563.6 10618.7 10732.7 9984.9 10520.3 10544.2 10644.9 10729.7 20:25:02 INFO - 2016-01-05 20:25:02,488 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:25:02 INFO - 2016-01-05 20:25:02,488 DEBUG : BROWSER_OUTPUT: 20:25:03 INFO - 2016-01-05 20:25:03,135 INFO : Browser exited with error code: 0 20:25:03 INFO - 2016-01-05 20:25:03,156 INFO : Completed test dromaeo_css (00:18:28) 20:25:03 INFO - 2016-01-05 20:25:03,157 INFO : Starting test kraken 20:25:03 INFO - 2016-01-05 20:25:03,157 DEBUG : operating with platform_type : linux_ 20:25:03 INFO - 2016-01-05 20:25:03,157 INFO : Initialising browser for kraken test... 20:25:03 INFO - 2016-01-05 20:25:03,163 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptlRspc/profile http://localhost:53449/getInfo.html 20:25:07 INFO - 2016-01-05 20:25:07,757 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:25:07 INFO - 2016-01-05 20:25:07,757 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:25:07 INFO - 2016-01-05 20:25:07,757 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:25:07 INFO - 2016-01-05 20:25:07,757 DEBUG : BROWSER_OUTPUT: __metrics 20:25:08 INFO - 2016-01-05 20:25:08,767 INFO : Browser initialized. 20:25:08 INFO - 2016-01-05 20:25:08,768 INFO : Running cycle 1/1 for kraken test... 20:25:08 INFO - 2016-01-05 20:25:08,768 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptlRspc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:25:20 INFO - 2016-01-05 20:25:20,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 136523776 20:25:20 INFO - 2016-01-05 20:25:20,533 DEBUG : BROWSER_OUTPUT: 20:25:22 INFO - 2016-01-05 20:25:22,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53449/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:23 INFO - 2016-01-05 20:25:23,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 139116544 20:25:23 INFO - 2016-01-05 20:25:23,596 DEBUG : BROWSER_OUTPUT: 20:25:26 INFO - 2016-01-05 20:25:26,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53449/tests/kraken/driver.html?testName=audio-dft) 20:25:26 INFO - 2016-01-05 20:25:26,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 137994240 20:25:26 INFO - 2016-01-05 20:25:26,783 DEBUG : BROWSER_OUTPUT: 20:25:29 INFO - 2016-01-05 20:25:29,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53449/tests/kraken/driver.html?testName=audio-fft) 20:25:30 INFO - 2016-01-05 20:25:30,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 137670656 20:25:30 INFO - 2016-01-05 20:25:30,197 DEBUG : BROWSER_OUTPUT: 20:25:32 INFO - 2016-01-05 20:25:32,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53449/tests/kraken/driver.html?testName=audio-oscillator) 20:25:32 INFO - 2016-01-05 20:25:32,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 137719808 20:25:32 INFO - 2016-01-05 20:25:32,786 DEBUG : BROWSER_OUTPUT: 20:25:34 INFO - 2016-01-05 20:25:34,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53449/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:25:35 INFO - 2016-01-05 20:25:35,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 137760768 20:25:35 INFO - 2016-01-05 20:25:35,562 DEBUG : BROWSER_OUTPUT: 20:25:38 INFO - 2016-01-05 20:25:38,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53449/tests/kraken/driver.html?testName=imaging-darkroom) 20:25:39 INFO - 2016-01-05 20:25:39,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 137797632 20:25:39 INFO - 2016-01-05 20:25:39,103 DEBUG : BROWSER_OUTPUT: 20:25:42 INFO - 2016-01-05 20:25:42,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53449/tests/kraken/driver.html?testName=imaging-desaturate) 20:25:43 INFO - 2016-01-05 20:25:43,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 137863168 20:25:43 INFO - 2016-01-05 20:25:43,072 DEBUG : BROWSER_OUTPUT: 20:25:45 INFO - 2016-01-05 20:25:45,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53449/tests/kraken/driver.html?testName=json-parse-financial) 20:25:46 INFO - 2016-01-05 20:25:46,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 138588160 20:25:46 INFO - 2016-01-05 20:25:46,417 DEBUG : BROWSER_OUTPUT: 20:25:48 INFO - 2016-01-05 20:25:48,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53449/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:25:48 INFO - 2016-01-05 20:25:48,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 139001856 20:25:48 INFO - 2016-01-05 20:25:48,577 DEBUG : BROWSER_OUTPUT: 20:25:50 INFO - 2016-01-05 20:25:50,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53449/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:25:50 INFO - 2016-01-05 20:25:50,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 138289152 20:25:50 INFO - 2016-01-05 20:25:50,950 DEBUG : BROWSER_OUTPUT: 20:25:52 INFO - 2016-01-05 20:25:52,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53449/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:25:53 INFO - 2016-01-05 20:25:53,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 138977280 20:25:53 INFO - 2016-01-05 20:25:53,545 DEBUG : BROWSER_OUTPUT: 20:25:55 INFO - 2016-01-05 20:25:55,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:25:56 INFO - 2016-01-05 20:25:56,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 139018240 20:25:56 INFO - 2016-01-05 20:25:56,472 DEBUG : BROWSER_OUTPUT: 20:25:58 INFO - 2016-01-05 20:25:58,976 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:25:59 INFO - 2016-01-05 20:25:59,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 138735616 20:25:59 INFO - 2016-01-05 20:25:59,578 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53449/tests/kraken/driver.html?testName=ai-astar) 20:26:01 INFO - 2016-01-05 20:26:01,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 139390976 20:26:01 INFO - 2016-01-05 20:26:01,499 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,499 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:26:01 INFO - 2016-01-05 20:26:01,499 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:26:01 INFO - 2016-01-05 20:26:01,499 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:26:01 INFO - 2016-01-05 20:26:01,499 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:26:01 INFO - 2016-01-05 20:26:01,499 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;105;112;110;110;121;110;109;110;111 20:26:01 INFO - 2016-01-05 20:26:01,500 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;122;147;162;122;149;148;124;165;125 20:26:01 INFO - 2016-01-05 20:26:01,500 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;162;160;162;163;165;160;164;161 20:26:01 INFO - 2016-01-05 20:26:01,500 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;72;152;71;72;71;72;173;71 20:26:01 INFO - 2016-01-05 20:26:01,500 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;136;91;93;92;142;92;93;136 20:26:01 INFO - 2016-01-05 20:26:01,500 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;111;110;109;109;109;109;109;109 20:26:01 INFO - 2016-01-05 20:26:01,500 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;146;147;147;148;148;146;146;147 20:26:01 INFO - 2016-01-05 20:26:01,501 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;96;96;97;96;96;96 20:26:01 INFO - 2016-01-05 20:26:01,501 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;62;73;64;63;62;60;61;59;58 20:26:01 INFO - 2016-01-05 20:26:01,501 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;66;65;66;65;66;65;65;66;66 20:26:01 INFO - 2016-01-05 20:26:01,501 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;79;80;82;81;82;80;87;81;80 20:26:01 INFO - 2016-01-05 20:26:01,501 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;118;113;120;116;117;113;112;118;111 20:26:01 INFO - 2016-01-05 20:26:01,501 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;143;145;145;146;133;136;144;143;146 20:26:01 INFO - 2016-01-05 20:26:01,502 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;64;66;65;69;66;65;68;65;64 20:26:01 INFO - 2016-01-05 20:26:01,502 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:26:01 INFO - 2016-01-05 20:26:01,502 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:26:01 INFO - 2016-01-05 20:26:01,502 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,712 20:26:01 INFO - 2016-01-05 20:26:01,502 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:26:01 INFO - 2016-01-05 20:26:01,502 DEBUG : BROWSER_OUTPUT: __startTimestamp1452054361497__endTimestamp 20:26:01 INFO - 2016-01-05 20:26:01,503 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,506 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:26:01 INFO - 2016-01-05 20:26:01,506 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:26:01 INFO - 2016-01-05 20:26:01,506 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,507 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.00 Median:110.50 stddev:4.03 (3.6%) stddev-sans-first:4.26 20:26:01 INFO - 2016-01-05 20:26:01,507 DEBUG : BROWSER_OUTPUT: Values: 112.0 105.0 112.0 110.0 110.0 121.0 110.0 109.0 110.0 111.0 20:26:01 INFO - 2016-01-05 20:26:01,507 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,507 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.00 Median:147.50 stddev:16.53 (11.2%) stddev-sans-first:17.43 20:26:01 INFO - 2016-01-05 20:26:01,507 DEBUG : BROWSER_OUTPUT: Values: 146.0 122.0 147.0 162.0 122.0 149.0 148.0 124.0 165.0 125.0 20:26:01 INFO - 2016-01-05 20:26:01,507 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,507 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.62 (1.0%) stddev-sans-first:1.69 20:26:01 INFO - 2016-01-05 20:26:01,507 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 162.0 160.0 162.0 163.0 165.0 160.0 164.0 161.0 20:26:01 INFO - 2016-01-05 20:26:01,507 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,508 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.80 Median:71.50 stddev:38.64 (54.0%) stddev-sans-first:40.38 20:26:01 INFO - 2016-01-05 20:26:01,508 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 72.0 152.0 71.0 72.0 71.0 72.0 173.0 71.0 20:26:01 INFO - 2016-01-05 20:26:01,508 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,508 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:92.50 stddev:22.02 (23.8%) stddev-sans-first:22.83 20:26:01 INFO - 2016-01-05 20:26:01,508 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 136.0 91.0 93.0 92.0 142.0 92.0 93.0 136.0 20:26:01 INFO - 2016-01-05 20:26:01,508 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,508 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 20:26:01 INFO - 2016-01-05 20:26:01,508 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 111.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 20:26:01 INFO - 2016-01-05 20:26:01,508 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,508 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 20:26:01 INFO - 2016-01-05 20:26:01,508 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 146.0 147.0 147.0 148.0 148.0 146.0 146.0 147.0 20:26:01 INFO - 2016-01-05 20:26:01,509 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,509 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 20:26:01 INFO - 2016-01-05 20:26:01,509 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 20:26:01 INFO - 2016-01-05 20:26:01,509 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,509 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.00 stddev:4.37 (7.1%) stddev-sans-first:4.39 20:26:01 INFO - 2016-01-05 20:26:01,509 DEBUG : BROWSER_OUTPUT: Values: 58.0 62.0 73.0 64.0 63.0 62.0 60.0 61.0 59.0 58.0 20:26:01 INFO - 2016-01-05 20:26:01,509 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,509 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 20:26:01 INFO - 2016-01-05 20:26:01,509 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 65.0 66.0 65.0 66.0 65.0 65.0 66.0 66.0 20:26:01 INFO - 2016-01-05 20:26:01,509 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,509 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:2.25 (2.8%) stddev-sans-first:2.35 20:26:01 INFO - 2016-01-05 20:26:01,509 DEBUG : BROWSER_OUTPUT: Values: 80.0 79.0 80.0 82.0 81.0 82.0 80.0 87.0 81.0 80.0 20:26:01 INFO - 2016-01-05 20:26:01,509 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,509 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.40 Median:116.50 stddev:2.99 (2.6%) stddev-sans-first:3.16 20:26:01 INFO - 2016-01-05 20:26:01,510 DEBUG : BROWSER_OUTPUT: Values: 116.0 118.0 113.0 120.0 116.0 117.0 113.0 112.0 118.0 111.0 20:26:01 INFO - 2016-01-05 20:26:01,510 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,510 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.60 Median:145.00 stddev:4.45 (3.1%) stddev-sans-first:4.64 20:26:01 INFO - 2016-01-05 20:26:01,510 DEBUG : BROWSER_OUTPUT: Values: 145.0 143.0 145.0 145.0 146.0 133.0 136.0 144.0 143.0 146.0 20:26:01 INFO - 2016-01-05 20:26:01,510 DEBUG : BROWSER_OUTPUT: 20:26:01 INFO - 2016-01-05 20:26:01,510 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.62 (2.5%) stddev-sans-first:1.72 20:26:01 INFO - 2016-01-05 20:26:01,510 DEBUG : BROWSER_OUTPUT: Values: 66.0 64.0 66.0 65.0 69.0 66.0 65.0 68.0 65.0 64.0 20:26:01 INFO - 2016-01-05 20:26:01,510 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:26:01 INFO - 2016-01-05 20:26:01,510 DEBUG : BROWSER_OUTPUT: 20:26:02 INFO - 2016-01-05 20:26:02,267 INFO : Browser exited with error code: 0 20:26:02 INFO - 2016-01-05 20:26:02,417 INFO : Completed test kraken (00:00:59) 20:26:02 INFO - 2016-01-05 20:26:02,417 INFO : Starting test v8_7 20:26:02 INFO - 2016-01-05 20:26:02,417 DEBUG : operating with platform_type : linux_ 20:26:02 INFO - 2016-01-05 20:26:02,418 INFO : Initialising browser for v8_7 test... 20:26:02 INFO - 2016-01-05 20:26:02,424 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVP2cnP/profile http://localhost:53449/getInfo.html 20:26:06 INFO - 2016-01-05 20:26:06,818 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:26:06 INFO - 2016-01-05 20:26:06,818 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:26:06 INFO - 2016-01-05 20:26:06,818 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:26:06 INFO - 2016-01-05 20:26:06,818 DEBUG : BROWSER_OUTPUT: __metrics 20:26:07 INFO - 2016-01-05 20:26:07,859 INFO : Browser initialized. 20:26:07 INFO - 2016-01-05 20:26:07,860 INFO : Running cycle 1/1 for v8_7 test... 20:26:07 INFO - 2016-01-05 20:26:07,860 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVP2cnP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:26:19 INFO - 2016-01-05 20:26:19,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 136323072 20:26:19 INFO - 2016-01-05 20:26:19,609 DEBUG : BROWSER_OUTPUT: 20:26:40 INFO - 2016-01-05 20:26:40,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53449/tests/v8_7/run.html (next: http://localhost:53449/tests/v8_7/run.html) 20:26:41 INFO - 2016-01-05 20:26:41,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 134815744 20:26:41 INFO - 2016-01-05 20:26:41,220 DEBUG : BROWSER_OUTPUT: 20:26:41 INFO - 2016-01-05 20:26:41,221 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:26:41 INFO - 2016-01-05 20:26:41,221 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:26:41 INFO - 2016-01-05 20:26:41,221 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:26:41 INFO - 2016-01-05 20:26:41,221 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:26:41 INFO - 2016-01-05 20:26:41,222 DEBUG : BROWSER_OUTPUT: |0;Richards;168.94745734076702 20:26:41 INFO - 2016-01-05 20:26:41,222 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.16817118020728 20:26:41 INFO - 2016-01-05 20:26:41,222 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 20:26:41 INFO - 2016-01-05 20:26:41,222 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 20:26:41 INFO - 2016-01-05 20:26:41,222 DEBUG : BROWSER_OUTPUT: |4;RayTrace;916.5902841429881 20:26:41 INFO - 2016-01-05 20:26:41,222 DEBUG : BROWSER_OUTPUT: |5;Earley;543.1830526887561 20:26:41 INFO - 2016-01-05 20:26:41,222 DEBUG : BROWSER_OUTPUT: |6;Boyer;10817.20430107527 20:26:41 INFO - 2016-01-05 20:26:41,223 DEBUG : BROWSER_OUTPUT: |7;RegExp;23833.333333333332 20:26:41 INFO - 2016-01-05 20:26:41,223 DEBUG : BROWSER_OUTPUT: |8;Splay;523.0125523012553 20:26:41 INFO - 2016-01-05 20:26:41,223 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 20:26:41 INFO - 2016-01-05 20:26:41,223 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:26:41 INFO - 2016-01-05 20:26:41,223 DEBUG : BROWSER_OUTPUT: __startTimestamp1452054401220__endTimestamp 20:26:41 INFO - 2016-01-05 20:26:41,223 DEBUG : BROWSER_OUTPUT: 20:26:41 INFO - 2016-01-05 20:26:41,223 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:26:41 INFO - 2016-01-05 20:26:41,223 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:26:41 INFO - 2016-01-05 20:26:41,223 DEBUG : BROWSER_OUTPUT: 20:26:41 INFO - 2016-01-05 20:26:41,223 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.95 Median:168.95 stddev:0.00 (0.0%) 20:26:41 INFO - 2016-01-05 20:26:41,224 DEBUG : BROWSER_OUTPUT: Values: 168.9 20:26:41 INFO - 2016-01-05 20:26:41,224 DEBUG : BROWSER_OUTPUT: 20:26:41 INFO - 2016-01-05 20:26:41,224 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.17 Median:167.17 stddev:0.00 (0.0%) 20:26:41 INFO - 2016-01-05 20:26:41,225 DEBUG : BROWSER_OUTPUT: Values: 167.2 20:26:41 INFO - 2016-01-05 20:26:41,225 DEBUG : BROWSER_OUTPUT: 20:26:41 INFO - 2016-01-05 20:26:41,225 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 20:26:41 INFO - 2016-01-05 20:26:41,225 DEBUG : BROWSER_OUTPUT: Values: 278.1 20:26:41 INFO - 2016-01-05 20:26:41,225 DEBUG : BROWSER_OUTPUT: 20:26:41 INFO - 2016-01-05 20:26:41,225 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 20:26:41 INFO - 2016-01-05 20:26:41,225 DEBUG : BROWSER_OUTPUT: Values: 5191.7 20:26:41 INFO - 2016-01-05 20:26:41,225 DEBUG : BROWSER_OUTPUT: 20:26:41 INFO - 2016-01-05 20:26:41,225 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:916.59 Median:916.59 stddev:0.00 (0.0%) 20:26:41 INFO - 2016-01-05 20:26:41,225 DEBUG : BROWSER_OUTPUT: Values: 916.6 20:26:41 INFO - 2016-01-05 20:26:41,226 DEBUG : BROWSER_OUTPUT: 20:26:41 INFO - 2016-01-05 20:26:41,226 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:543.18 Median:543.18 stddev:0.00 (0.0%) 20:26:41 INFO - 2016-01-05 20:26:41,226 DEBUG : BROWSER_OUTPUT: Values: 543.2 20:26:41 INFO - 2016-01-05 20:26:41,226 DEBUG : BROWSER_OUTPUT: 20:26:41 INFO - 2016-01-05 20:26:41,226 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10817.20 Median:10817.20 stddev:0.00 (0.0%) 20:26:41 INFO - 2016-01-05 20:26:41,226 DEBUG : BROWSER_OUTPUT: Values: 10817.2 20:26:41 INFO - 2016-01-05 20:26:41,226 DEBUG : BROWSER_OUTPUT: 20:26:41 INFO - 2016-01-05 20:26:41,226 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23833.33 Median:23833.33 stddev:0.00 (0.0%) 20:26:41 INFO - 2016-01-05 20:26:41,226 DEBUG : BROWSER_OUTPUT: Values: 23833.3 20:26:41 INFO - 2016-01-05 20:26:41,226 DEBUG : BROWSER_OUTPUT: 20:26:41 INFO - 2016-01-05 20:26:41,226 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:523.01 Median:523.01 stddev:0.00 (0.0%) 20:26:41 INFO - 2016-01-05 20:26:41,227 DEBUG : BROWSER_OUTPUT: Values: 523.0 20:26:41 INFO - 2016-01-05 20:26:41,227 DEBUG : BROWSER_OUTPUT: 20:26:41 INFO - 2016-01-05 20:26:41,227 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 20:26:41 INFO - 2016-01-05 20:26:41,227 DEBUG : BROWSER_OUTPUT: Values: 4840.6 20:26:41 INFO - 2016-01-05 20:26:41,227 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:26:41 INFO - 2016-01-05 20:26:41,227 DEBUG : BROWSER_OUTPUT: 20:26:42 INFO - 2016-01-05 20:26:42,083 INFO : Browser exited with error code: 0 20:26:42 INFO - 2016-01-05 20:26:42,095 INFO : Completed test v8_7 (00:00:39) 20:26:42 INFO - 2016-01-05 20:26:42,288 INFO : Completed test suite (00:20:07) 20:26:42 INFO - 2016-01-05 20:26:42,288 DEBUG : Working with test: dromaeo_css 20:26:42 INFO - 2016-01-05 20:26:42,288 DEBUG : Generating results file: dromaeo_css 20:26:42 INFO - 2016-01-05 20:26:42,290 DEBUG : Working with test: kraken 20:26:42 INFO - 2016-01-05 20:26:42,290 DEBUG : Generating results file: kraken 20:26:42 INFO - 2016-01-05 20:26:42,290 INFO : javascript benchmark 20:26:42 INFO - 2016-01-05 20:26:42,290 DEBUG : Working with test: v8_7 20:26:42 INFO - 2016-01-05 20:26:42,290 DEBUG : Generating results file: v8_7 20:26:42 INFO - 2016-01-05 20:26:42,291 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:26:42 INFO - 2016-01-05 20:26:42,343 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 20:26:42 INFO - 2016-01-05 20:26:42,343 DEBUG : process_Request line: dromaeo_css 7358.16 graph.html#tests=[[72,52,43]] 20:26:42 INFO - 2016-01-05 20:26:42,343 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:26:42 INFO - 2016-01-05 20:26:42,380 DEBUG : process_Request line: kraken 1495.10 graph.html#tests=[[232,52,43]] 20:26:42 INFO - 2016-01-05 20:26:42,380 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:26:42 INFO - 2016-01-05 20:26:42,415 DEBUG : process_Request line: v8_7 23290.44 graph.html#tests=[[230,52,43]] 20:26:42 INFO - 2016-01-05 20:26:42,416 INFO : javascript benchmark 20:26:42 INFO - 2016-01-05 20:26:42,420 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3347.179940914476, 3379.817064027589, 3391.186115332321, 3418.3505134024535, 3428.5371474850886, 5465.945340546593, 5484.9177262341045, 5497.065498865192, 5515.034868897942, 5515.917261241085, 5490.396056433789, 5524.977879092371, 5563.388027316992, 5568.443155684439, 5591.9720401397935, 4991.326170966919, 5051.772670229849, 5113.488651134894, 5121.078205922932, 5146.073706732786, 4920.3111564381015, 5011.624128190382, 5057.595392368602, 5063.797448102072, 5087.643864929457, 4989.825356112537, 5039.344885164924, 5047.3438453001245, 5059.772310246048, 5103.362079740033, 5082.720450375228, 5101.974490127563, 5113.411957624883, 5130.256112863651, 5146.691198528081, 4783.5933945614315, 4816.975915120437, 4887.560119589254, 5027.120253955543, 5051.1413059779925, 5299.920501192485, 5312.362516498007, 5313.8937221255355, 5319.148936170232, 5359.598030147716, 5923.614965027259, 5926.348101708809, 5938.435848594377, 5971.701414929236, 5999.430054144849, 5636.859078523029, 5742.799002034909, 5750.3962083981, 5800.245968024172, 5963.5527335450015, 5573.470520300565, 5609.3268807742925, 5611.663300202001, 5613.691246981414, 5614.69119198448, 6124.356942520971, 6124.816255512342, 6125.938740612626, 6133.1413602095745, 6135.631862088289, 5745.626534275259, 5747.453991870766, 5834.941650583524, 5837.795677151279, 5894.292684877756, 5853.707314634251, 5875.383084776037, 5885.941140588539, 5886.61736987103, 5962.731677074542, 5833.854153646193, 5834.124881267844, 5835.095560188178, 5843.0066888629035, 5851.912221316684, 5613.8596535086135, 5650.208970744099, 5680.261565996394, 5707.115397113371, 5787.479126878601, 4508.639308855284, 4513.871532116905, 4533.342665313511, 4539.0921815637, 4593.19619066662, 3965.2466031453932, 4072.1855628874346, 4073.8185926081696, 4094.3449048152747, 4112.773797441169, 5469.671819690831, 5502.972485137629, 5534.1975413565615, 5556.694381809039, 5597.412271711493, 6012.669303188279, 6050.848728781728, 6053.727582258809, 6062.575619706578, 6064.545159112996, 5452.563794896399, 5536.474034966672, 5711.657300561979, 5713.657180569179, 5732.398098199629, 5028.195488721787, 5075.873103172376, 5112.821051263188, 5113.411957624847, 5139.7687104080405, 5985.281766187998, 5986.700664966735, 5995.0, 5998.4601385875485, 6047.606905551125, 5748.54011679073, 5823.82528524145, 5872.060470324727, 5881.382454842265, 5908.822735317947, 6025.849353766015, 6033.12519684652, 6038.335783063947, 6055.333913269625, 6055.727492262947, 5709.600327977168, 5789.2763404574425, 5825.6795876225515, 5825.70871456434, 5836.503897168618, 5683.772649094155, 5773.624714393551, 5906.940930590639, 5925.377835327228, 6024.0, 5817.592768506164, 5880.14737863016, 5880.705964701833, 5890.381509941394, 5895.852603684943, 5781.4218578141845, 5789.710514474344, 5808.244928159313, 5856.531477481876, 5874.647521148745, 5555.194496797861, 5611.775528978795, 5687.232223649919, 5733.971330143323, 5749.712514374348, 5743.483086522233, 5750.166225897305, 5761.107028410603, 5763.51010164124, 5881.4118588142555, 5645.435456454322, 5648.293963254593, 5648.943510564842, 5667.886642267049, 5671.574631902541], "unit": "ms", "name": "dojo.html", "value": 5444.853460319193}, {"lowerIsBetter": false, "replicates": [581.8196359128668, 590.4213870407001, 623.4077626255059, 627.952903532235, 634.2895956528689, 31336.0, 40637.59362406375, 41186.38220426696, 41281.79359103208, 41323.79338103313, 45193.548064519426, 45628.315575266315, 45794.7710261449, 45805.541944580546, 46014.53985460144, 8866.468011919289, 9111.908880911205, 9134.36059475837, 9135.725928222164, 9181.127792859701, 8975.102489751005, 9122.543872806365, 9126.543672816333, 9131.817363652723, 9138.451692898414, 9012.594433250486, 9124.726258212264, 9138.0405057469, 9139.497327646977, 9158.221551168159, 8964.372493925428, 9033.638654453847, 9064.048274931136, 9066.0, 9089.909100909039, 8918.643254269886, 8949.463032218022, 9068.682596109105, 9076.683880837307, 9095.863562046508, 39544.40683389751, 39590.802045989876, 41062.38406423906, 41141.58858411408, 41155.588444115776, 3441.776284541522, 3477.2871561329866, 3522.771019883725, 3737.121776382548, 4040.5353384360883, 31607.525887111482, 31849.52225716616, 31939.201519961953, 32430.189245268823, 33032.50451243209, 3979.422983667381, 4105.2405305018665, 4114.814833332507, 4145.2124096421885, 4146.129312844307, 279842.0, 282336.0, 283314.0, 501326.0, 503428.0, 63411.0, 63678.36321636817, 64139.0, 64188.35811641917, 64658.0, 68403.65798171077, 68766.31233687598, 68854.65572672205, 68933.31066689269, 69058.0, 16692.0, 16703.665926681642, 16763.245653945603, 16823.663526729397, 16863.241154148094, 12631.810522842165, 12640.431180596896, 12779.680507987188, 12796.040296977764, 12838.743225135446, 21525.78474215269, 21950.243980481522, 21981.560368792536, 22000.88999555024, 22034.779652203593, 8473.49159050459, 8503.447275927045, 8549.786255343543, 8648.221660050625, 8737.694180703646, 906.4606559097326, 920.1266538954003, 932.9579028771894, 938.3244064273712, 1137.3062431916524, 29226.707732922823, 29399.82400703948, 29436.264093397407, 29488.262793430335, 29832.10503684893, 1074.989250107489, 1096.5010920031366, 1097.6048622495896, 1105.182165197748, 1151.7696460707891, 15438.305276262596, 16104.355825766837, 17284.962902225907, 17365.218565164345, 17998.730019049726, 781914.0, 825111.0, 829180.0, 834649.0, 835643.0, 59311.0, 59507.70246148742, 59790.0, 60333.69833150806, 60490.0, 1504.5561559340022, 1506.8493150685063, 1508.8415716349846, 1508.9924550377177, 1613.370785393674, 30409.695903040687, 30719.846400768747, 30734.077977660705, 31449.52825707662, 31494.212644684067, 48757.51242487672, 49734.0, 50338.244926326865, 50349.496505035946, 50435.243471347225, 320376.0, 320475.0, 320539.0, 320575.0, 322384.0, 33464.0, 34367.0, 34796.82601586976, 34898.82550587231, 34927.0, 44193.0, 45161.32258016067, 45228.0, 45631.54368456273, 45814.54185458236, 37509.249815003, 38790.0, 38862.2227555453, 39621.0, 39649.80175099106, 44915.0, 46206.53793462157, 46448.30327545022, 46828.29757553708, 47510.0, 38927.0, 38934.415983759696, 39485.80257098696, 39511.60488395079, 39705.0, 30037.399252014402, 30228.697713023466, 30254.54618180773, 30383.240418989702, 30499.695003050572, 26279.474410512066, 26327.0, 26463.470730585665, 26582.335441614116, 26645.200643980712], "unit": "ms", "name": "ext.html", "value": 20440.915147532156}, {"lowerIsBetter": false, "replicates": [391.8706826747174, 393.23908237560306, 394.13487395167607, 396.5697218517908, 398.09433538699454, 15872.523824285261, 17158.0, 17258.2233799479, 18710.0, 18789.0, 11200.047995920337, 11545.711357216074, 11592.884071159307, 15786.368545258176, 17017.319307227695, 4951.084049450863, 4987.351644286237, 5052.065367906949, 5063.0, 5077.64456488046, 3843.385058390658, 3929.2337994091163, 4997.175466048097, 5381.139017757159, 5480.205370221315, 5499.1476321170285, 5502.669839809604, 5504.0643090674685, 5523.0, 5543.36251331096, 5245.370555533342, 5342.946570534304, 5344.893102137936, 5380.300560927054, 5468.152436372368, 5173.456787037345, 5184.403793563713, 5190.195519694454, 5205.557527610158, 5365.356157261114, 12415.130940834146, 12618.242905425612, 12628.17916835412, 12991.870081299161, 20963.5807283855, 2174.8695078295355, 2243.8317126215434, 2286.5541219462043, 2380.3811009137576, 2452.619843924195, 9875.90124098757, 10000.649977250761, 10134.087932086073, 10362.792744145076, 12418.627441176688, 1898.4209816006112, 1931.6329897319604, 1956.0610906764691, 1957.6084783043307, 1979.1687491253708, 61856.38143618596, 63056.68471657658, 63990.0, 64007.67996160036, 64225.67887160534, 10638.361698298128, 10805.783884322269, 10836.458177091114, 10838.13294936419, 10942.890571094347, 13872.930635346758, 13939.16365018102, 13949.0, 14005.579832605039, 14043.578692639237, 7814.648340824677, 7856.25365590268, 7869.685212591547, 7877.172896845863, 7961.845532397886, 7260.346568808833, 7267.818304542323, 7300.452466065067, 7330.157031941289, 7480.401567874557, 4528.456585209796, 4552.658550608718, 4595.195840727859, 4644.256918892961, 4666.4633567139535, 1927.9325223617107, 1931.5557421793067, 1957.5204075001432, 1974.9506262343557, 1981.6532106881239, 940.5579377692474, 980.2501086668705, 996.7906739584769, 999.8000399920045, 1066.8293073108266, 16485.752713709306, 16549.0, 16597.419090332023, 16820.0, 16974.745378819327, 985.935914165577, 1005.9245556583286, 1012.8126296635146, 1016.6949915025463, 1026.6047571684805, 9906.55420506079, 10017.549210285555, 10290.948545257226, 10480.318779279323, 10558.736031599272, 578610.0, 584020.0, 594334.0, 594885.0, 602618.0, 77763.22236777673, 80131.19868801237, 85395.57302213449, 86658.133418665, 87218.56390718005, 1226.5032661771997, 1228.4533382644638, 1252.3550371558654, 1266.4427651833164, 1288.375138058041, 16046.037237765771, 16354.91224751876, 16594.58513537171, 16654.666906661558, 16655.83344166543, 38144.23711525698, 38162.42756358601, 38456.0, 38648.2270354597, 38722.22555548817, 50933.74533127311, 51288.230676540625, 52347.73826130845, 53093.0, 55811.720941396656, 10032.147267482054, 10047.346922450017, 10116.84824727615, 10130.696079117639, 10284.177265818567, 14806.0, 15457.5362739118, 18462.538436539195, 18666.81333186705, 18972.241110355983, 14161.787573186617, 15180.240987950338, 15180.468683596022, 15194.620134496285, 15581.688366232838, 14539.85460145385, 14900.776488352467, 14913.328900199735, 15148.091114533163, 15444.22778861075, 15231.086134831945, 15405.998610090308, 15451.304691289144, 15731.606709831887, 15763.0, 9529.904700952902, 9537.427754334762, 9588.993155718548, 9633.373830700983, 9903.613494110974, 10450.895491044992, 11576.768464630828, 14155.36300866484, 14344.56966291013, 14732.705345893237], "unit": "ms", "name": "jquery.html", "value": 9084.653417962134}, {"lowerIsBetter": false, "replicates": [1360.9251491167986, 1426.4009116171208, 1615.604176976641, 1899.078946710845, 1911.23550579768, 7697.422693298004, 7924.603769811501, 8115.797105072362, 8151.266386025257, 8188.54962977036, 8021.91978080219, 8091.433599648027, 8181.018277806656, 8184.468009579373, 8189.95905020474, 2261.4346413396693, 2294.5869743446174, 2301.5166814968875, 2304.43541332373, 2305.4582173189287, 2280.4184932842104, 2331.8367714260007, 2339.1695947938492, 2340.4616938104245, 2343.5898717724417, 2235.61994460942, 2285.714285714286, 2293.4495721027, 2293.5412917416584, 2318.8608683479047, 2265.456290490287, 2285.1887579909226, 2290.0496294037953, 2291.072115793098, 2297.9655305170436, 2250.1224522436264, 2253.740819805727, 2270.71616047994, 2271.4889149941296, 2277.829162812796, 7878.921210787876, 7908.090569584457, 7930.246626570467, 7945.649239629277, 7980.920190798076, 4732.503087175865, 4807.423109226916, 4819.228923372279, 4826.227803551415, 4831.05794370098, 3037.119235421725, 3047.0706434537456, 3061.984690076558, 3078.5843911072166, 3102.0383681058943, 929.7071422501958, 938.699616122841, 948.6158105967095, 960.8174446855076, 988.2785566536469, 10732.463376831127, 10774.622888198875, 10803.5678572857, 10858.0, 10859.565617375296, 4011.7592944423427, 4033.8184781684895, 4048.7570745755347, 4070.043539768152, 4188.916221675549, 8470.0, 8524.829503410021, 8526.914730852735, 8538.188872057144, 8555.871661925075, 4663.183942809995, 4688.8124475021295, 4692.389989301369, 4693.859184224479, 4699.412573428322, 4247.895547157699, 4270.701050926467, 4285.357196420562, 4289.528151903351, 4299.247631664446, 3501.3347463981763, 3505.5793304803587, 3510.0, 3534.699550538233, 3555.0756803231347, 1064.9307794993301, 1066.7759770448292, 1080.2384319055047, 1086.0605576176708, 1093.9343639381664, 1036.6164519127972, 1069.1713921710582, 1079.2175672637275, 1211.0674780419029, 1316.2628927800463, 7383.2985866342615, 7402.185759566443, 7432.702691892264, 7438.107427108674, 7461.925380746123, 1150.2523359816187, 1182.5979167083233, 1195.677167164878, 1197.5449329254827, 1202.2245651554872, 5893.381194974551, 5922.674252916131, 5971.820845374646, 5990.4908082813445, 6012.098185272157, 9339.346245762732, 9712.22302215821, 9817.852732209023, 9818.41089534616, 9835.508224588742, 9551.14039736427, 9565.473898935625, 9590.712278631652, 9645.951770241103, 9653.131218190396, 7449.702011919462, 7514.511556748794, 7524.510906791041, 7526.435517336222, 7549.320561149523, 7129.643517823984, 7137.643117844191, 7154.928450715634, 7232.963835180791, 7303.963480182565, 8433.072362040293, 8460.661573536989, 8560.657573697232, 8582.356323275655, 8582.742517724479, 8598.441101328393, 8667.479951202948, 8669.0, 8685.869711954452, 8722.127787221227, 7081.362677359062, 7129.607871567114, 7141.571505709674, 7144.607046612487, 7168.641567921687, 7531.171571127062, 7609.733659321897, 7619.619019049136, 7652.426068044808, 7666.731664391719, 7062.752803651848, 7244.565326080241, 7360.1535823381, 7360.227176146427, 7487.138979017483, 7062.8940565890525, 7074.717011319695, 7162.641867906688, 7200.71197152108, 7211.495195336276, 7112.146542414944, 7163.892541611985, 7167.068281123421, 7177.282271772781, 7182.6408679564765, 6594.241662208908, 6644.900326495203, 6656.167979002625, 6656.167979002625, 6691.59850408977, 6581.0, 6683.398494135551, 6736.393724564813, 6740.6966686498245, 6746.527743057939], "unit": "ms", "name": "mootools.html", "value": 4535.171399008316}, {"lowerIsBetter": false, "replicates": [348.8465075366839, 356.29098094791374, 356.94110471772166, 361.97828130312183, 362.929228800384, 6091.994820854554, 6259.029850373194, 6280.089387038876, 6297.811065668026, 6380.234371875382, 6030.819075427733, 6206.7827626033095, 6216.440520353167, 6218.7201575929075, 6237.220347456557, 4835.202191638376, 4837.516248375161, 4840.927386089212, 4842.370491836056, 4849.199882019462, 4839.879003024917, 4844.830430934918, 4847.224444088946, 4851.975740121312, 4852.927206091894, 4679.064187162581, 4788.784504697297, 4821.638377121712, 4829.082474329884, 4830.082284365977, 4809.927851082237, 4814.75926203692, 4816.97591512042, 4818.951810481885, 4820.517948205169, 4241.554636763157, 4245.617894389489, 4249.575042495757, 4261.126469073833, 4263.019505513718, 5926.170336152942, 5939.287285525721, 5954.285485741695, 5957.404259574051, 5964.284285885721, 5461.5357694596005, 5568.49883510482, 5594.580406469531, 5611.691356975365, 5613.46672066153, 6628.93371066288, 6642.269350371455, 6645.368689974444, 6649.102371179877, 6660.733570657217, 4705.411823522059, 4708.7051060958165, 4709.364235828154, 4711.882202944919, 4712.269598212282, 6775.0514927910135, 6905.723771049203, 6912.447004239699, 6919.930800691979, 6970.651467426659, 4686.976565117221, 4743.66794324394, 4745.1221524018165, 4756.453007904066, 4756.904861902743, 4803.0, 4803.615710743132, 4810.0139471408975, 4814.133455977888, 4816.8314109006715, 5511.862203444946, 5515.889682206333, 5523.475269849358, 5527.778888844482, 5528.889422211533, 6471.449926756184, 6646.401823835878, 6695.899561506581, 6733.360330768667, 6752.122224110933, 1656.3871367593827, 1664.3342662934922, 1695.6439147778858, 1696.1180186303054, 1701.5235733994502, 1118.2731224704007, 1144.582227486978, 1144.7481554058095, 1145.066770581973, 1154.9018333441752, 6390.201224846895, 6440.323766004596, 6443.355664433613, 6459.870802583922, 6461.709223084972, 6824.078749368871, 6845.281245469254, 6855.417289530346, 6858.485613579001, 6858.9368647859665, 6359.17330747, 6400.167978162809, 6418.807435776934, 6431.196100487439, 6439.549231553746, 3738.27103714773, 3766.0584853786554, 3772.43413487979, 3776.86780962665, 3779.149691319431, 7082.504224704324, 7117.0, 7133.286671332825, 7181.784546463615, 7195.388391986635, 6980.917957716562, 7095.964520177469, 7164.749233776793, 7166.713331466787, 7182.317679820409, 7162.713491460283, 7166.247544007804, 7178.964105179441, 7179.605121718251, 7191.244919283505, 6988.79033628992, 6994.2656021117045, 6994.895076573754, 6998.370146686822, 7007.159140903124, 6734.696938637675, 6852.349026842442, 6864.6910889011115, 6892.517523773488, 6896.620685862325, 7144.4998850082075, 7150.034745309316, 7150.892736609059, 7158.0, 7174.784756457315, 4763.54746299101, 4794.880127996828, 4795.017021510652, 4798.064377446364, 4824.517548245148, 6882.449404047564, 6980.336867997532, 6981.162260528769, 6986.860262794614, 6992.860142797217, 6776.220734615582, 6783.694733736895, 6818.113645226089, 6825.55633883796, 6829.965850170717, 6766.695498702472, 6791.592504449749, 6804.455643548603, 6807.285235050248, 6808.046873437822, 6490.448311893542, 6602.60384376939, 6611.140551728437, 6666.466682665472, 6667.733290668319, 6779.15260592426, 6809.557378770364, 6818.045473633794, 6821.215560210441, 6823.965880170766, 6600.933990660032, 6634.203895532567, 6635.369639884203, 6641.203055633162, 6661.833454163685], "unit": "ms", "name": "prototype.html", "value": 5061.376540853359}, {"lowerIsBetter": false, "replicates": [842.3934766967785, 845.437783873724, 847.9491230526169, 853.1255463150267, 881.9514926679034, 13331.133476324032, 13580.0, 13597.592072237823, 13601.93199034006, 13605.047646664738, 13087.0, 13253.536126235584, 13325.933370333134, 13449.193048417103, 13470.124441911268, 857.7684025313177, 879.7888506758364, 895.8566629339307, 911.307406371156, 917.8669092981513, 887.9023307436177, 888.071964796789, 890.528020149322, 897.4256475855458, 904.92308153807, 932.9766755831091, 933.9719808405724, 935.7660584853786, 939.8496240601505, 942.6229508196708, 918.0406475233397, 925.2228128372166, 927.5918595817818, 929.6606738540452, 930.776613612728, 683.565935630873, 687.041577000082, 687.8005378440247, 688.2326206280012, 690.5960013392172, 13521.459141634323, 13593.59219223425, 13702.10936289138, 13761.0, 13789.172649641054, 12874.549390771279, 13036.804447933193, 13231.27228002469, 13286.26925519096, 13820.861791382158, 10351.534180961875, 10791.83812242817, 11015.504302306335, 11122.49948752308, 11200.943995279971, 3870.0518372998513, 3896.629820167108, 3918.921621567581, 3954.1498577805623, 3958.34687276599, 51236.48763512354, 51711.0, 51941.48058519442, 52024.0, 52122.0, 10318.122959548522, 10347.689569312932, 10391.37651740898, 10496.737581560523, 10572.471376431147, 18658.720119198224, 18683.532911677044, 19737.210511579662, 19977.0, 20013.899930500545, 8091.919080809116, 8168.632411541495, 8261.8347633047, 8317.168283171635, 8529.104444033288, 4738.881527961828, 4815.927761083586, 4870.245112007645, 4912.164931961575, 4962.5533701967, 3319.0374791310733, 3327.168207948013, 3335.466325387975, 3366.259422926952, 3366.898993030164, 594.0406243916044, 597.235538510707, 603.1435361786274, 603.6860832367232, 603.6951339573575, 655.7573697731774, 668.12809283885, 671.771597656799, 676.2763842688374, 678.9966050169718, 8395.664173433117, 8466.788330291793, 8916.37585369031, 9635.710928672152, 10092.861926610054, 695.8720551122635, 700.3276854219904, 704.8484575816224, 718.4791026505742, 739.0872272743158, 4226.218149642326, 4415.66882483815, 4531.048479819275, 4531.18438681034, 4572.6799124061, 67282.66358668273, 68719.0, 68743.3125668747, 68853.0, 69378.0, 57795.71102144462, 58640.0, 58813.0, 59228.70385648044, 60446.395536044074, 54004.0, 54412.72793636007, 54495.72752136214, 54901.45098549043, 54932.17601735897, 8666.436681615927, 8720.258778003941, 8823.60293786794, 9158.084191580789, 9303.023182566003, 38169.427458588696, 38843.61002763312, 39635.405468917415, 39644.603553965244, 40008.0, 47855.28217076677, 52977.7351113242, 53744.462555373946, 53806.0, 54403.45596544142, 10175.389476631426, 11020.559177632806, 11249.493772780408, 11275.323480590863, 11391.373474458984, 12409.0, 12641.431135599105, 12965.416556254802, 13181.143225690299, 13650.044496885519, 12200.084993625691, 12380.319082450551, 12392.070594705252, 12573.74852502963, 12670.746585068431, 12411.689707757378, 12422.440990155645, 12489.687757806127, 12551.3096779678, 12726.0, 12029.85730844547, 12098.516059357878, 12123.211991220542, 12152.696182595506, 12355.32045737493, 10250.692479225636, 10540.472976350999, 10563.63027294041, 10618.73453163677, 10732.67801965911, 9984.850227246452, 10520.265880353718, 10544.15646748243, 10644.946775266075, 10729.678109656723], "unit": "ms", "name": "yui.html", "value": 6837.808742242762}], "name": "dromaeo_css", "value": 7358.156005909512}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 112.0, 110.0, 110.0, 121.0, 110.0, 109.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [146.0, 122.0, 147.0, 162.0, 122.0, 149.0, 148.0, 124.0, 165.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.0}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 160.0, 162.0, 163.0, 165.0, 160.0, 164.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 72.0, 152.0, 71.0, 72.0, 71.0, 72.0, 173.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 89.8}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 136.0, 91.0, 93.0, 92.0, 142.0, 92.0, 93.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 111.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 146.0, 147.0, 147.0, 148.0, 148.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [58.0, 62.0, 73.0, 64.0, 63.0, 62.0, 60.0, 61.0, 59.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 62.0}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.5}, {"lowerIsBetter": true, "replicates": [80.0, 79.0, 80.0, 82.0, 81.0, 82.0, 80.0, 87.0, 81.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.2}, {"lowerIsBetter": true, "replicates": [116.0, 118.0, 113.0, 120.0, 116.0, 117.0, 113.0, 112.0, 118.0, 111.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.4}, {"lowerIsBetter": true, "replicates": [145.0, 143.0, 145.0, 145.0, 146.0, 133.0, 136.0, 144.0, 143.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.6}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 66.0, 65.0, 69.0, 66.0, 65.0, 68.0, 65.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1495.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.94745734076702], "unit": "score", "name": "Richards", "value": 208.952538}, {"lowerIsBetter": false, "replicates": [167.16817118020728], "unit": "score", "name": "DeltaBlue", "value": 395.5178759999999}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [916.5902841429881], "unit": "score", "name": "RayTrace", "value": 807.327999}, {"lowerIsBetter": false, "replicates": [543.1830526887561], "unit": "score", "name": "Earley", "value": 1226.958383}, {"lowerIsBetter": false, "replicates": [10817.20430107527], "unit": "score", "name": "Boyer", "value": 61.611390656063655}, {"lowerIsBetter": false, "replicates": [23833.333333333332], "unit": "score", "name": "RegExp", "value": 38.22314685314689}, {"lowerIsBetter": false, "replicates": [523.0125523012553], "unit": "score", "name": "Splay", "value": 155.810792}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23290.43885141387}]} 20:26:42 INFO - RETURN: dromaeo_css: 7358.16 20:26:42 INFO - RETURN: kraken: 1495.10 20:26:42 INFO - RETURN: v8_7: 23290.44 20:26:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23290.44"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1495.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7358.16"}}} 20:26:42 INFO - Return code: 0 20:26:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:26:42 INFO - # TBPL SUCCESS # 20:26:42 INFO - Running post-action listener: _resource_record_post_action 20:26:42 INFO - Running post-run listener: _resource_record_post_run 20:26:43 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 790528; Write bytes: 280383488; Read time: 96; Write time: 205768 20:26:43 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 5435392; Read time: 0; Write time: 320 20:26:43 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 790528; Write bytes: 274948096; Read time: 96; Write time: 205448 20:26:43 INFO - Running post-run listener: _upload_blobber_files 20:26:43 INFO - Blob upload gear active. 20:26:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:26:43 INFO - Copying logs to upload dir... 20:26:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.056983 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-01-05 20:26:43.652413) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-05 20:26:43.655802) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/eYr0vyouRqi9B8bS5EzPkQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009949 build_url: 'https://queue.taskcluster.net/v1/task/eYr0vyouRqi9B8bS5EzPkQ/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-05 20:26:43.707113) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 20:26:43.707419) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452053143.539899-1421545510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 20:26:43.757061) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 20:26:43.757340) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 20:26:43.757864) ========= ========= Total master_lag: 0.23 =========