builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1453730352.51 results: success (0) buildid: 20160125032007 builduid: 6b155104e8bd444aa46ec60f987516d6 revision: c07136d9322ae89f391372e736bb34787e70328d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:12.506352) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:12.506870) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:12.507331) ========= 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=82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006301 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:12.533003) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:12.533358) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:12.557484) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:12.557873) ========= 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=82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004669 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:12.607698) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:12.608055) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:12.608659) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:12.609033) ========= 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=82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 05:59:12-- 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% 82.9M=0s 2016-01-25 05:59:12 (82.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103883 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:12.734588) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:12.734946) ========= 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=82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022195 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:12.791983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:12.792467) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c07136d9322ae89f391372e736bb34787e70328d --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 c07136d9322ae89f391372e736bb34787e70328d --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=82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 05:59:12,894 truncating revision to first 12 chars 2016-01-25 05:59:12,894 Setting DEBUG logging. 2016-01-25 05:59:12,894 attempt 1/10 2016-01-25 05:59:12,894 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c07136d9322a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 05:59:13,236 unpacking tar archive at: mozilla-aurora-c07136d9322a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656410 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:13.463295) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:13.463731) ========= echo c07136d9322ae89f391372e736bb34787e70328d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c07136d9322ae89f391372e736bb34787e70328d'] 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=82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c07136d9322ae89f391372e736bb34787e70328d program finished with exit code 0 elapsedTime=0.004174 script_repo_revision: 'c07136d9322ae89f391372e736bb34787e70328d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:13.514481) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:13.514841) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:13.525504) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-01-25 05:59:13.525922) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:59:13 INFO - MultiFileLogger online at 20160125 05:59:13 in /builds/slave/test-pgo 05:59:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:59:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:59:13 INFO - {'append_to_log': False, 05:59:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:59:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:59:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:59:13 INFO - 'branch': 'Mozilla-Aurora', 05:59:13 INFO - 'buildbot_json_path': 'buildprops.json', 05:59:13 INFO - 'config_files': ('talos/linux_config.py',), 05:59:13 INFO - 'default_actions': ('clobber', 05:59:13 INFO - 'read-buildbot-config', 05:59:13 INFO - 'download-and-extract', 05:59:13 INFO - 'populate-webroot', 05:59:13 INFO - 'create-virtualenv', 05:59:13 INFO - 'install', 05:59:13 INFO - 'run-tests'), 05:59:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:59:13 INFO - 'download_minidump_stackwalk': True, 05:59:13 INFO - 'download_symbols': 'ondemand', 05:59:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:59:13 INFO - 'tooltool.py': '/tools/tooltool.py', 05:59:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:59:13 INFO - '/tools/misc-python/virtualenv.py')}, 05:59:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:59:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:59:13 INFO - 'installer_path': 'installer.exe', 05:59:13 INFO - 'log_level': 'info', 05:59:13 INFO - 'log_name': 'talos', 05:59:13 INFO - 'log_to_console': True, 05:59:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:59:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:59:13 INFO - 'opt_config_files': (), 05:59:13 INFO - 'pip_index': False, 05:59:13 INFO - 'sps_profile': False, 05:59:13 INFO - 'sps_profile_interval': 0, 05:59:13 INFO - 'suite': 'dromaeojs', 05:59:13 INFO - 'system_bits': '32', 05:59:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:59:13 INFO - 'title': 'talos-linux64-ix-055', 05:59:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:59:13 INFO - 'use_talos_json': True, 05:59:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:59:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:59:13 INFO - 'work_dir': 'build'} 05:59:13 INFO - ##### 05:59:13 INFO - ##### Running clobber step. 05:59:13 INFO - ##### 05:59:13 INFO - Running pre-action listener: _resource_record_pre_action 05:59:13 INFO - Running main action method: clobber 05:59:13 INFO - rmtree: /builds/slave/test-pgo/build 05:59:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:59:14 INFO - Running post-action listener: _resource_record_post_action 05:59:14 INFO - ##### 05:59:14 INFO - ##### Running read-buildbot-config step. 05:59:14 INFO - ##### 05:59:14 INFO - Running pre-action listener: _resource_record_pre_action 05:59:14 INFO - Running main action method: read_buildbot_config 05:59:14 INFO - Using buildbot properties: 05:59:14 INFO - { 05:59:14 INFO - "properties": { 05:59:14 INFO - "buildnumber": 122, 05:59:14 INFO - "product": "firefox", 05:59:14 INFO - "script_repo_revision": "production", 05:59:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 05:59:14 INFO - "repository": "", 05:59:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 05:59:14 INFO - "buildid": "20160125032007", 05:59:14 INFO - "slavename": "talos-linux64-ix-055", 05:59:14 INFO - "pgo_build": "True", 05:59:14 INFO - "basedir": "/builds/slave/test-pgo", 05:59:14 INFO - "project": "", 05:59:14 INFO - "platform": "ubuntu64_hw", 05:59:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:59:14 INFO - "slavebuilddir": "test", 05:59:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:59:14 INFO - "branch": "mozilla-aurora", 05:59:14 INFO - "repo_path": "releases/mozilla-aurora", 05:59:14 INFO - "stage_platform": "linux64-pgo", 05:59:14 INFO - "builduid": "6b155104e8bd444aa46ec60f987516d6", 05:59:14 INFO - "revision": "c07136d9322ae89f391372e736bb34787e70328d" 05:59:14 INFO - }, 05:59:14 INFO - "sourcestamp": { 05:59:14 INFO - "repository": "", 05:59:14 INFO - "hasPatch": false, 05:59:14 INFO - "project": "", 05:59:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 05:59:14 INFO - "changes": [ 05:59:14 INFO - { 05:59:14 INFO - "category": null, 05:59:14 INFO - "files": [ 05:59:14 INFO - { 05:59:14 INFO - "url": null, 05:59:14 INFO - "name": "https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 05:59:14 INFO - } 05:59:14 INFO - ], 05:59:14 INFO - "repository": "", 05:59:14 INFO - "rev": "c07136d9322ae89f391372e736bb34787e70328d", 05:59:14 INFO - "who": "cbook@mozilla.com", 05:59:14 INFO - "when": 1453730294, 05:59:14 INFO - "number": 7510929, 05:59:14 INFO - "comments": "Bug 1240607 - Force CreateWindow hooks to be detours. r=jmathies, a=sylvestre", 05:59:14 INFO - "project": "", 05:59:14 INFO - "at": "Mon 25 Jan 2016 05:58:14", 05:59:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 05:59:14 INFO - "revlink": "", 05:59:14 INFO - "properties": [ 05:59:14 INFO - [ 05:59:14 INFO - "buildid", 05:59:14 INFO - "20160125032007", 05:59:14 INFO - "Change" 05:59:14 INFO - ], 05:59:14 INFO - [ 05:59:14 INFO - "builduid", 05:59:14 INFO - "6b155104e8bd444aa46ec60f987516d6", 05:59:14 INFO - "Change" 05:59:14 INFO - ], 05:59:14 INFO - [ 05:59:14 INFO - "pgo_build", 05:59:14 INFO - "True", 05:59:14 INFO - "Change" 05:59:14 INFO - ] 05:59:14 INFO - ], 05:59:14 INFO - "revision": "c07136d9322ae89f391372e736bb34787e70328d" 05:59:14 INFO - } 05:59:14 INFO - ], 05:59:14 INFO - "revision": "c07136d9322ae89f391372e736bb34787e70328d" 05:59:14 INFO - } 05:59:14 INFO - } 05:59:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 05:59:14 INFO - Running post-action listener: _resource_record_post_action 05:59:14 INFO - ##### 05:59:14 INFO - ##### Running download-and-extract step. 05:59:14 INFO - ##### 05:59:14 INFO - Running pre-action listener: _resource_record_pre_action 05:59:14 INFO - Running main action method: download_and_extract 05:59:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:14 INFO - https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:59:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/test_packages.json 05:59:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/test_packages.json 05:59:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:59:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:59:18 INFO - Downloaded 1302 bytes. 05:59:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:59:18 INFO - Using the following test package requirements: 05:59:18 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 05:59:18 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:18 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:59:18 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:18 INFO - u'jsshell-linux-x86_64.zip'], 05:59:18 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:18 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:59:18 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 05:59:18 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:18 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:59:18 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:18 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:59:18 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:18 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:59:18 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 05:59:18 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:18 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:59:18 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:59:18 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')]} 05:59:18 INFO - https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:59:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:59:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:59:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/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 05:59:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/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 05:59:20 INFO - Downloaded 21579566 bytes. 05:59:20 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 05:59:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:59:20 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 05:59:21 INFO - Return code: 0 05:59:21 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 05:59:21 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')]} 05:59:21 INFO - https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:59:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:59:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:59:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/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 05:59:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/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 05:59:22 INFO - Downloaded 21579566 bytes. 05:59:22 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 05:59:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:59:22 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 05:59:24 INFO - Return code: 0 05:59:24 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')]} 05:59:24 INFO - https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:59:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 05:59:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 05:59:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/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 05:59:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/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 05:59:25 INFO - Downloaded 11132038 bytes. 05:59:25 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 05:59:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 05:59:25 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 05:59:25 INFO - Return code: 0 05:59:25 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')]} 05:59:25 INFO - https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:59:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:59:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:59:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/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 05:59:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/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 05:59:27 INFO - Downloaded 58068148 bytes. 05:59:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:59:27 INFO - mkdir: /builds/slave/test-pgo/properties 05:59:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:59:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:59:27 INFO - Contents: 05:59:27 INFO - build_url:https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:59:27 INFO - Running post-action listener: _resource_record_post_action 05:59:27 INFO - Running post-action listener: set_extra_try_arguments 05:59:27 INFO - ##### 05:59:27 INFO - ##### Running populate-webroot step. 05:59:27 INFO - ##### 05:59:27 INFO - Running pre-action listener: _resource_record_pre_action 05:59:27 INFO - Running main action method: populate_webroot 05:59:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:59:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:59:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:59:27 INFO - '--tppagecycles', 05:59:27 INFO - '7'], 05:59:27 INFO - 'tests': ['tsvgm']}}, 05:59:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:59:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:59:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:59:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:59:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:59:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:59:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:27 INFO - 'talos_options': ['--e10s'], 05:59:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:27 INFO - 'tests': ['damp', 'tps']}, 05:59:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:27 INFO - 'talos_options': ['--e10s'], 05:59:27 INFO - 'tests': ['damp', 'tps']}, 05:59:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:59:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:59:27 INFO - 'other': {'tests': ['a11yr', 05:59:27 INFO - 'ts_paint', 05:59:27 INFO - 'tpaint', 05:59:27 INFO - 'sessionrestore', 05:59:27 INFO - 'sessionrestore_no_auto_restore']}, 05:59:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:59:27 INFO - 'tests': ['a11yr', 05:59:27 INFO - 'ts_paint', 05:59:27 INFO - 'tpaint', 05:59:27 INFO - 'sessionrestore', 05:59:27 INFO - 'sessionrestore_no_auto_restore']}, 05:59:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:59:27 INFO - 'tests': ['a11yr', 05:59:27 INFO - 'ts_paint', 05:59:27 INFO - 'tpaint', 05:59:27 INFO - 'sessionrestore', 05:59:27 INFO - 'sessionrestore_no_auto_restore']}, 05:59:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:59:27 INFO - 'tests': ['a11yr', 05:59:27 INFO - 'ts_paint', 05:59:27 INFO - 'tpaint', 05:59:27 INFO - 'sessionrestore', 05:59:27 INFO - 'sessionrestore_no_auto_restore']}, 05:59:27 INFO - 'other_l64': {'tests': ['a11yr', 05:59:27 INFO - 'ts_paint', 05:59:27 INFO - 'tpaint', 05:59:27 INFO - 'sessionrestore', 05:59:27 INFO - 'sessionrestore_no_auto_restore']}, 05:59:27 INFO - 'other_nol64': {'tests': ['a11yr', 05:59:27 INFO - 'ts_paint', 05:59:27 INFO - 'tpaint', 05:59:27 INFO - 'sessionrestore', 05:59:27 INFO - 'sessionrestore_no_auto_restore']}, 05:59:27 INFO - 'svgr': {'tests': ['tsvgx', 05:59:27 INFO - 'tsvgr_opacity', 05:59:27 INFO - 'tart', 05:59:27 INFO - 'tscrollx', 05:59:27 INFO - 'cart']}, 05:59:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:59:27 INFO - 'tests': ['tsvgx', 05:59:27 INFO - 'tsvgr_opacity', 05:59:27 INFO - 'tart', 05:59:27 INFO - 'tscrollx', 05:59:27 INFO - 'cart']}, 05:59:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:27 INFO - 'tests': ['tp5o']}, 05:59:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:27 INFO - 'talos_options': ['--e10s'], 05:59:27 INFO - 'tests': ['tp5o']}, 05:59:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:27 INFO - 'talos_options': ['--xperf_path', 05:59:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:27 INFO - 'tests': ['tp5n']}, 05:59:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:27 INFO - 'talos_options': ['--e10s', 05:59:27 INFO - '--xperf_path', 05:59:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:27 INFO - 'tests': ['tp5n']}}, 05:59:27 INFO - 'talos.zip': {'path': '', 05:59:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:59:27 INFO - Running post-action listener: _resource_record_post_action 05:59:27 INFO - ##### 05:59:27 INFO - ##### Running create-virtualenv step. 05:59:27 INFO - ##### 05:59:27 INFO - Running pre-action listener: _resource_record_pre_action 05:59:27 INFO - Running main action method: create_virtualenv 05:59:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:59:27 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 05:59:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:59:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:59:27 INFO - Using real prefix '/usr' 05:59:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:59:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:59:29 INFO - Installing pip.................done. 05:59:29 INFO - Return code: 0 05:59:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb8b5448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145ce30>, '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 0x145dd30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145e1c0>, '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': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', '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 05:59:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:59:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:59:29 INFO - Using env: {'DISPLAY': ':0', 05:59:29 INFO - 'HOME': '/home/cltbld', 05:59:29 INFO - 'LANG': 'en_US.UTF-8', 05:59:29 INFO - 'LANGUAGE': 'en_US:en', 05:59:29 INFO - 'LOGNAME': 'cltbld', 05:59:29 INFO - 'MAIL': '/var/mail/cltbld', 05:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:29 INFO - 'MOZ_NO_REMOTE': '1', 05:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:29 INFO - 'NO_EM_RESTART': '1', 05:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:29 INFO - 'SHELL': '/bin/bash', 05:59:29 INFO - 'SHLVL': '1', 05:59:29 INFO - 'TERM': 'linux', 05:59:29 INFO - 'TMOUT': '86400', 05:59:29 INFO - 'USER': 'cltbld', 05:59:29 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', 05:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:29 INFO - '_': '/tools/buildbot/bin/python'} 05:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:30 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 05:59:30 INFO - Cleaning up... 05:59:30 INFO - Return code: 0 05:59:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:59:30 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')]} 05:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:30 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')]} 05:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb8b5448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145ce30>, '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 0x145dd30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145e1c0>, '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': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', '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 05:59:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:59:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:59:30 INFO - Using env: {'DISPLAY': ':0', 05:59:30 INFO - 'HOME': '/home/cltbld', 05:59:30 INFO - 'LANG': 'en_US.UTF-8', 05:59:30 INFO - 'LANGUAGE': 'en_US:en', 05:59:30 INFO - 'LOGNAME': 'cltbld', 05:59:30 INFO - 'MAIL': '/var/mail/cltbld', 05:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:30 INFO - 'MOZ_NO_REMOTE': '1', 05:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:30 INFO - 'NO_EM_RESTART': '1', 05:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:30 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:30 INFO - 'SHELL': '/bin/bash', 05:59:30 INFO - 'SHLVL': '1', 05:59:30 INFO - 'TERM': 'linux', 05:59:30 INFO - 'TMOUT': '86400', 05:59:30 INFO - 'USER': 'cltbld', 05:59:30 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', 05:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:30 INFO - '_': '/tools/buildbot/bin/python'} 05:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:30 INFO - Downloading/unpacking psutil>=0.7.1 05:59:30 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 05:59:30 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 05:59:30 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 05:59:30 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 05:59:30 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 05:59:30 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 05:59:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:59:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:32 INFO - Installing collected packages: psutil 05:59:32 INFO - Running setup.py install for psutil 05:59:32 INFO - building 'psutil._psutil_linux' extension 05:59:32 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 05:59:32 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 05:59:32 INFO - building 'psutil._psutil_posix' extension 05:59:32 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 05:59:32 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 05:59:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:32 INFO - Successfully installed psutil 05:59:32 INFO - Cleaning up... 05:59:32 INFO - Return code: 0 05:59:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:59:32 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')]} 05:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:32 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')]} 05:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb8b5448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145ce30>, '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 0x145dd30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145e1c0>, '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': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', '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 05:59:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:59:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:59:32 INFO - Using env: {'DISPLAY': ':0', 05:59:32 INFO - 'HOME': '/home/cltbld', 05:59:32 INFO - 'LANG': 'en_US.UTF-8', 05:59:32 INFO - 'LANGUAGE': 'en_US:en', 05:59:32 INFO - 'LOGNAME': 'cltbld', 05:59:32 INFO - 'MAIL': '/var/mail/cltbld', 05:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:32 INFO - 'MOZ_NO_REMOTE': '1', 05:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:32 INFO - 'NO_EM_RESTART': '1', 05:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:32 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:32 INFO - 'SHELL': '/bin/bash', 05:59:32 INFO - 'SHLVL': '1', 05:59:32 INFO - 'TERM': 'linux', 05:59:32 INFO - 'TMOUT': '86400', 05:59:32 INFO - 'USER': 'cltbld', 05:59:32 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', 05:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:32 INFO - '_': '/tools/buildbot/bin/python'} 05:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:59:32 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 05:59:32 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 05:59:32 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 05:59:32 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 05:59:32 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 05:59:32 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 05:59:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:59:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:59:35 INFO - Installing collected packages: mozsystemmonitor 05:59:35 INFO - Running setup.py install for mozsystemmonitor 05:59:35 INFO - Successfully installed mozsystemmonitor 05:59:35 INFO - Cleaning up... 05:59:35 INFO - Return code: 0 05:59:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb8b5448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145ce30>, '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 0x145dd30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145e1c0>, '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': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', '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 05:59:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:59:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:59:35 INFO - Using env: {'DISPLAY': ':0', 05:59:35 INFO - 'HOME': '/home/cltbld', 05:59:35 INFO - 'LANG': 'en_US.UTF-8', 05:59:35 INFO - 'LANGUAGE': 'en_US:en', 05:59:35 INFO - 'LOGNAME': 'cltbld', 05:59:35 INFO - 'MAIL': '/var/mail/cltbld', 05:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:35 INFO - 'MOZ_NO_REMOTE': '1', 05:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:35 INFO - 'NO_EM_RESTART': '1', 05:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:35 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:35 INFO - 'SHELL': '/bin/bash', 05:59:35 INFO - 'SHLVL': '1', 05:59:35 INFO - 'TERM': 'linux', 05:59:35 INFO - 'TMOUT': '86400', 05:59:35 INFO - 'USER': 'cltbld', 05:59:35 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', 05:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:35 INFO - '_': '/tools/buildbot/bin/python'} 05:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:36 INFO - Downloading/unpacking blobuploader==1.2.4 05:59:36 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 05:59:36 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 05:59:36 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 05:59:36 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 05:59:36 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 05:59:36 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 05:59:37 INFO - Downloading blobuploader-1.2.4.tar.gz 05:59:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:59:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:59:37 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 05:59:37 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 05:59:37 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 05:59:37 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 05:59:37 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 05:59:37 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 05:59:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:59:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:59:38 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 05:59:38 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 05:59:38 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 05:59:38 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 05:59:38 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 05:59:38 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 05:59:38 INFO - Downloading docopt-0.6.1.tar.gz 05:59:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:59:38 INFO - Installing collected packages: blobuploader, requests, docopt 05:59:38 INFO - Running setup.py install for blobuploader 05:59:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:59:38 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:59:38 INFO - Running setup.py install for requests 05:59:39 INFO - Running setup.py install for docopt 05:59:39 INFO - Successfully installed blobuploader requests docopt 05:59:39 INFO - Cleaning up... 05:59:39 INFO - Return code: 0 05:59:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fb8b5448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145ce30>, '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 0x145dd30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145e1c0>, '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': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', '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 05:59:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 05:59:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 05:59:39 INFO - Using env: {'DISPLAY': ':0', 05:59:39 INFO - 'HOME': '/home/cltbld', 05:59:39 INFO - 'LANG': 'en_US.UTF-8', 05:59:39 INFO - 'LANGUAGE': 'en_US:en', 05:59:39 INFO - 'LOGNAME': 'cltbld', 05:59:39 INFO - 'MAIL': '/var/mail/cltbld', 05:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:39 INFO - 'MOZ_NO_REMOTE': '1', 05:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:39 INFO - 'NO_EM_RESTART': '1', 05:59:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:39 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:39 INFO - 'SHELL': '/bin/bash', 05:59:39 INFO - 'SHLVL': '1', 05:59:39 INFO - 'TERM': 'linux', 05:59:39 INFO - 'TMOUT': '86400', 05:59:39 INFO - 'USER': 'cltbld', 05:59:39 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', 05:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:39 INFO - '_': '/tools/buildbot/bin/python'} 05:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:59:39 INFO - Running setup.py (path:/tmp/pip-eJ2GKN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:59:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:59:39 INFO - Running setup.py (path:/tmp/pip-bHX2bY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:59:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:59:39 INFO - Running setup.py (path:/tmp/pip-mcbgpt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:59:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:59:39 INFO - Running setup.py (path:/tmp/pip-O7IYqp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:59:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:59:39 INFO - Running setup.py (path:/tmp/pip-1dFUar-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:59:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:59:39 INFO - Running setup.py (path:/tmp/pip-QXR_e7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:59:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:59:39 INFO - Running setup.py (path:/tmp/pip-JKGWiN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:59:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:59:39 INFO - Running setup.py (path:/tmp/pip-ETW91k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:59:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:59:39 INFO - Running setup.py (path:/tmp/pip-H899aS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:59:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:59:39 INFO - Running setup.py (path:/tmp/pip-4ihufw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:59:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:59:40 INFO - Running setup.py (path:/tmp/pip-coFS2u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:59:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:59:40 INFO - Running setup.py (path:/tmp/pip-MBLZRS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:59:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:59:40 INFO - Running setup.py (path:/tmp/pip-drjWyc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:59:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:59:40 INFO - Running setup.py (path:/tmp/pip-Bj5TWx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:59:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:59:40 INFO - Running setup.py (path:/tmp/pip-d0nnwV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:59:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:59:40 INFO - Running setup.py (path:/tmp/pip-KFmoGI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:59:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:59:40 INFO - Running setup.py (path:/tmp/pip-90xreO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:59:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:59:40 INFO - Running setup.py install for manifestparser 05:59:40 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:59:40 INFO - Running setup.py install for mozcrash 05:59:40 INFO - Running setup.py install for mozdebug 05:59:40 INFO - Running setup.py install for mozdevice 05:59:40 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:59:40 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:59:40 INFO - Running setup.py install for mozfile 05:59:41 INFO - Running setup.py install for mozhttpd 05:59:41 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:59:41 INFO - Running setup.py install for mozinfo 05:59:41 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:59:41 INFO - Running setup.py install for mozInstall 05:59:41 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:59:41 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:59:41 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:59:41 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:59:41 INFO - Running setup.py install for mozleak 05:59:41 INFO - Running setup.py install for mozlog 05:59:41 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:59:41 INFO - Running setup.py install for moznetwork 05:59:41 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:59:41 INFO - Running setup.py install for mozprocess 05:59:41 INFO - Running setup.py install for mozprofile 05:59:41 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:59:41 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:59:41 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:59:41 INFO - Running setup.py install for mozrunner 05:59:42 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:59:42 INFO - Running setup.py install for mozscreenshot 05:59:42 INFO - Running setup.py install for moztest 05:59:42 INFO - Running setup.py install for mozversion 05:59:42 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:59:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:59:42 INFO - Cleaning up... 05:59:42 INFO - Return code: 0 05:59:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb8b5448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145ce30>, '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 0x145dd30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145e1c0>, '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': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', '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 05:59:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:59:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:59:42 INFO - Using env: {'DISPLAY': ':0', 05:59:42 INFO - 'HOME': '/home/cltbld', 05:59:42 INFO - 'LANG': 'en_US.UTF-8', 05:59:42 INFO - 'LANGUAGE': 'en_US:en', 05:59:42 INFO - 'LOGNAME': 'cltbld', 05:59:42 INFO - 'MAIL': '/var/mail/cltbld', 05:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:42 INFO - 'MOZ_NO_REMOTE': '1', 05:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:42 INFO - 'NO_EM_RESTART': '1', 05:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:42 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:42 INFO - 'SHELL': '/bin/bash', 05:59:42 INFO - 'SHLVL': '1', 05:59:42 INFO - 'TERM': 'linux', 05:59:42 INFO - 'TMOUT': '86400', 05:59:42 INFO - 'USER': 'cltbld', 05:59:42 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', 05:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:42 INFO - '_': '/tools/buildbot/bin/python'} 05:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:59:42 INFO - Running setup.py (path:/tmp/pip-Up4eeq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:59:42 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)) 05:59:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:59:42 INFO - Running setup.py (path:/tmp/pip-4JMhoG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:59:42 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)) 05:59:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:59:42 INFO - Running setup.py (path:/tmp/pip-quPa4P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:59:42 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)) 05:59:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:59:42 INFO - Running setup.py (path:/tmp/pip-U_YUb2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:59:42 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)) 05:59:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:59:42 INFO - Running setup.py (path:/tmp/pip-MpZapf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:59:42 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)) 05:59:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:59:42 INFO - Running setup.py (path:/tmp/pip-V_uQbE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:59:42 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)) 05:59:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:59:42 INFO - Running setup.py (path:/tmp/pip-ywA26N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:59:43 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)) 05:59:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:59:43 INFO - Running setup.py (path:/tmp/pip-YzmE4m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:59:43 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)) 05:59:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:59:43 INFO - Running setup.py (path:/tmp/pip-s0Yd92-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:59:43 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)) 05:59:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:59:43 INFO - Running setup.py (path:/tmp/pip-nsX47f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:59:43 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)) 05:59:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:59:43 INFO - Running setup.py (path:/tmp/pip-AwbZzP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:59:43 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)) 05:59:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:59:43 INFO - Running setup.py (path:/tmp/pip-GiNQVk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:59:43 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)) 05:59:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:59:43 INFO - Running setup.py (path:/tmp/pip-dUb0cw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:59:43 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)) 05:59:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:59:43 INFO - Running setup.py (path:/tmp/pip-82eZEQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:59:43 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)) 05:59:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:59:43 INFO - Running setup.py (path:/tmp/pip-KLggF1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:59:43 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)) 05:59:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:59:43 INFO - Running setup.py (path:/tmp/pip-C4TJhA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:59:43 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)) 05:59:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:59:43 INFO - Running setup.py (path:/tmp/pip-ABB7hQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:59:43 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)) 05:59:43 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)) 05:59:43 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)) 05:59:43 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)) 05:59:43 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)) 05:59:43 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)) 05:59:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:59:43 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 05:59:43 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 05:59:43 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 05:59:43 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 05:59:43 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 05:59:43 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 05:59:45 INFO - Downloading blessings-1.6.tar.gz 05:59:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:59:45 INFO - Installing collected packages: blessings 05:59:45 INFO - Running setup.py install for blessings 05:59:45 INFO - Successfully installed blessings 05:59:45 INFO - Cleaning up... 05:59:45 INFO - Return code: 0 05:59:45 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:59:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:59:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:59:45 INFO - Reading from file tmpfile_stdout 05:59:45 INFO - Current package versions: 05:59:45 INFO - argparse == 1.2.1 05:59:45 INFO - blessings == 1.6 05:59:45 INFO - blobuploader == 1.2.4 05:59:45 INFO - docopt == 0.6.1 05:59:45 INFO - manifestparser == 1.1 05:59:45 INFO - mozInstall == 1.12 05:59:45 INFO - mozcrash == 0.16 05:59:45 INFO - mozdebug == 0.1 05:59:45 INFO - mozdevice == 0.47 05:59:45 INFO - mozfile == 1.2 05:59:45 INFO - mozhttpd == 0.7 05:59:45 INFO - mozinfo == 0.9 05:59:45 INFO - mozleak == 0.1 05:59:45 INFO - mozlog == 3.1 05:59:45 INFO - moznetwork == 0.27 05:59:45 INFO - mozprocess == 0.22 05:59:45 INFO - mozprofile == 0.27 05:59:45 INFO - mozrunner == 6.11 05:59:45 INFO - mozscreenshot == 0.1 05:59:45 INFO - mozsystemmonitor == 0.0 05:59:45 INFO - moztest == 0.7 05:59:45 INFO - mozversion == 1.4 05:59:45 INFO - psutil == 3.1.1 05:59:45 INFO - requests == 1.2.3 05:59:45 INFO - wsgiref == 0.1.2 05:59:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb8b5448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145ce30>, '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 0x145dd30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145e1c0>, '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': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', '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 05:59:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:59:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:59:46 INFO - Using env: {'DISPLAY': ':0', 05:59:46 INFO - 'HOME': '/home/cltbld', 05:59:46 INFO - 'LANG': 'en_US.UTF-8', 05:59:46 INFO - 'LANGUAGE': 'en_US:en', 05:59:46 INFO - 'LOGNAME': 'cltbld', 05:59:46 INFO - 'MAIL': '/var/mail/cltbld', 05:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:46 INFO - 'MOZ_NO_REMOTE': '1', 05:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:46 INFO - 'NO_EM_RESTART': '1', 05:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:46 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:46 INFO - 'SHELL': '/bin/bash', 05:59:46 INFO - 'SHLVL': '1', 05:59:46 INFO - 'TERM': 'linux', 05:59:46 INFO - 'TMOUT': '86400', 05:59:46 INFO - 'USER': 'cltbld', 05:59:46 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', 05:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:46 INFO - '_': '/tools/buildbot/bin/python'} 05:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:46 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)) 05:59:46 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)) 05:59:46 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)) 05:59:46 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)) 05:59:46 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)) 05:59:46 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)) 05:59:46 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)) 05:59:46 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)) 05:59:46 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)) 05:59:46 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)) 05:59:46 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)) 05:59:46 INFO - Cleaning up... 05:59:46 INFO - Return code: 0 05:59:46 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb8b5448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145ce30>, '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 0x145dd30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145e1c0>, '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': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', '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 05:59:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:59:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:59:46 INFO - Using env: {'DISPLAY': ':0', 05:59:46 INFO - 'HOME': '/home/cltbld', 05:59:46 INFO - 'LANG': 'en_US.UTF-8', 05:59:46 INFO - 'LANGUAGE': 'en_US:en', 05:59:46 INFO - 'LOGNAME': 'cltbld', 05:59:46 INFO - 'MAIL': '/var/mail/cltbld', 05:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:46 INFO - 'MOZ_NO_REMOTE': '1', 05:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:46 INFO - 'NO_EM_RESTART': '1', 05:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:46 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:46 INFO - 'SHELL': '/bin/bash', 05:59:46 INFO - 'SHLVL': '1', 05:59:46 INFO - 'TERM': 'linux', 05:59:46 INFO - 'TMOUT': '86400', 05:59:46 INFO - 'USER': 'cltbld', 05:59:46 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', 05:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:46 INFO - '_': '/tools/buildbot/bin/python'} 05:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:46 INFO - Downloading/unpacking jsonschema 05:59:46 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 05:59:46 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 05:59:46 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 05:59:46 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 05:59:46 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 05:59:46 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 05:59:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:59:48 INFO - Downloading/unpacking functools32 (from jsonschema) 05:59:48 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 05:59:48 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 05:59:48 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 05:59:48 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 05:59:48 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 05:59:48 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 05:59:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:59:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:59:48 INFO - warning: no files found matching '*.txt' 05:59:48 INFO - no previously-included directories found matching 'build' 05:59:48 INFO - no previously-included directories found matching 'dist' 05:59:48 INFO - no previously-included directories found matching '.git*' 05:59:48 INFO - Installing collected packages: jsonschema, functools32 05:59:48 INFO - Running setup.py install for functools32 05:59:48 INFO - warning: no files found matching '*.txt' 05:59:48 INFO - no previously-included directories found matching 'build' 05:59:48 INFO - no previously-included directories found matching 'dist' 05:59:48 INFO - no previously-included directories found matching '.git*' 05:59:48 INFO - Successfully installed jsonschema functools32 05:59:48 INFO - Cleaning up... 05:59:48 INFO - Return code: 0 05:59:48 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:59:48 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')]} 05:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:48 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')]} 05:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb8b5448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145ce30>, '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 0x145dd30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145e1c0>, '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': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', '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 05:59:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:59:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:59:48 INFO - Using env: {'DISPLAY': ':0', 05:59:48 INFO - 'HOME': '/home/cltbld', 05:59:48 INFO - 'LANG': 'en_US.UTF-8', 05:59:48 INFO - 'LANGUAGE': 'en_US:en', 05:59:48 INFO - 'LOGNAME': 'cltbld', 05:59:48 INFO - 'MAIL': '/var/mail/cltbld', 05:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:48 INFO - 'MOZ_NO_REMOTE': '1', 05:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:48 INFO - 'NO_EM_RESTART': '1', 05:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:48 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:48 INFO - 'SHELL': '/bin/bash', 05:59:48 INFO - 'SHLVL': '1', 05:59:48 INFO - 'TERM': 'linux', 05:59:48 INFO - 'TMOUT': '86400', 05:59:48 INFO - 'USER': 'cltbld', 05:59:48 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', 05:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:48 INFO - '_': '/tools/buildbot/bin/python'} 05:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:48 INFO - Downloading/unpacking flake8 05:59:48 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 05:59:48 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 05:59:48 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 05:59:48 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 05:59:48 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 05:59:48 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 05:59:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:59:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:59:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:59:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:59:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:59:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:59:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:59:51 INFO - no previously-included directories found matching 'docs/_build' 05:59:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:59:51 INFO - Running setup.py install for pep8 05:59:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:59:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:59:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:59:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:59:51 INFO - no previously-included directories found matching 'docs/_build' 05:59:51 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:59:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:59:51 INFO - Cleaning up... 05:59:51 INFO - Return code: 0 05:59:51 INFO - Running post-action listener: _resource_record_post_action 05:59:51 INFO - Running post-action listener: _start_resource_monitoring 05:59:51 INFO - Starting resource monitoring. 05:59:51 INFO - ##### 05:59:51 INFO - ##### Running install step. 05:59:51 INFO - ##### 05:59:51 INFO - Running pre-action listener: _resource_record_pre_action 05:59:51 INFO - Running main action method: install 05:59:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:59:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:59:51 INFO - Reading from file tmpfile_stdout 05:59:51 INFO - Detecting whether we're running mozinstall >=1.0... 05:59:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:59:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:59:51 INFO - Reading from file tmpfile_stdout 05:59:51 INFO - Output received: 05:59:51 INFO - Usage: mozinstall [options] installer 05:59:51 INFO - Options: 05:59:51 INFO - -h, --help show this help message and exit 05:59:51 INFO - -d DEST, --destination=DEST 05:59:51 INFO - Directory to install application into. [default: 05:59:51 INFO - "/builds/slave/test-pgo"] 05:59:51 INFO - --app=APP Application being installed. [default: firefox] 05:59:51 INFO - mkdir: /builds/slave/test-pgo/build/application 05:59:51 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'] 05:59:51 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 06:00:06 INFO - Reading from file tmpfile_stdout 06:00:06 INFO - Output received: 06:00:06 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:00:06 INFO - Running post-action listener: _resource_record_post_action 06:00:06 INFO - ##### 06:00:06 INFO - ##### Running run-tests step. 06:00:06 INFO - ##### 06:00:06 INFO - Running pre-action listener: _resource_record_pre_action 06:00:06 INFO - Running main action method: run_tests 06:00:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:00:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:00:06 INFO - Python 2.7.3 06:00:06 INFO - Return code: 0 06:00:06 INFO - grabbing minidump binary from tooltool 06:00: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')]} 06:00:06 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 0x145ce30>, '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 0x145dd30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145e1c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:00:06 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 06:00:06 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 06:00:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:00:06 INFO - Return code: 0 06:00:06 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:00:06 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:00:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:00:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:00:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:00:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:00:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:00:07 INFO - Return code: 0 06:00:07 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:00:07 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost 06:00:07 INFO - Using env: {'DISPLAY': ':0', 06:00:07 INFO - 'HOME': '/home/cltbld', 06:00:07 INFO - 'LANG': 'en_US.UTF-8', 06:00:07 INFO - 'LANGUAGE': 'en_US:en', 06:00:07 INFO - 'LOGNAME': 'cltbld', 06:00:07 INFO - 'MAIL': '/var/mail/cltbld', 06:00:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:00:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:07 INFO - 'MOZ_NO_REMOTE': '1', 06:00:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:07 INFO - 'NO_EM_RESTART': '1', 06:00:07 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:07 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:07 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:00:07 INFO - 'SHELL': '/bin/bash', 06:00:07 INFO - 'SHLVL': '1', 06:00:07 INFO - 'TERM': 'linux', 06:00:07 INFO - 'TMOUT': '86400', 06:00:07 INFO - 'USER': 'cltbld', 06:00:07 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756', 06:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:07 INFO - '_': '/tools/buildbot/bin/python'} 06:00:07 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] with output_timeout 3600 06:00:07 INFO - mozversion INFO | application_buildid: 20160125032007 06:00:07 INFO - mozversion INFO | application_changeset: c07136d9322ae89f391372e736bb34787e70328d 06:00:07 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 06:00:07 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:00:07 INFO - mozversion INFO | application_name: Firefox 06:00:07 INFO - mozversion INFO | application_remotingname: firefox-dev 06:00:07 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:00:07 INFO - mozversion INFO | application_vendor: Mozilla 06:00:07 INFO - mozversion INFO | application_version: 45.0a2 06:00:07 INFO - mozversion INFO | platform_buildid: 20160125032007 06:00:07 INFO - mozversion INFO | platform_changeset: c07136d9322ae89f391372e736bb34787e70328d 06:00:07 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:00:07 INFO - mozversion INFO | platform_version: 45.0a2 06:00:07 INFO - 2016-01-25 06:00:07,727 DEBUG : using testdate: 1453730407 06:00:07 INFO - 2016-01-25 06:00:07,727 DEBUG : actual date: 1453730407 06:00:07 INFO - 2016-01-25 06:00:07,735 INFO : starting webserver on 'localhost:48995' 06:00:07 INFO - 2016-01-25 06:00:07,736 INFO : Starting test suite talos-linux64-ix-055 06:00:07 INFO - 2016-01-25 06:00:07,736 INFO : Starting test dromaeo_css 06:00:07 INFO - 2016-01-25 06:00:07,736 DEBUG : operating with platform_type : linux_ 06:00:07 INFO - 2016-01-25 06:00:07,737 INFO : Initialising browser for dromaeo_css test... 06:00:07 INFO - 2016-01-25 06:00:07,751 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv3nTGF/profile http://localhost:48995/getInfo.html 06:00:12 INFO - 2016-01-25 06:00:12,172 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:00:12 INFO - 2016-01-25 06:00:12,172 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:00:12 INFO - 2016-01-25 06:00:12,172 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:00:12 INFO - 2016-01-25 06:00:12,172 DEBUG : BROWSER_OUTPUT: __metrics 06:00:12 INFO - 2016-01-25 06:00:12,293 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:00:13 INFO - 2016-01-25 06:00:13,271 INFO : Browser initialized. 06:00:13 INFO - 2016-01-25 06:00:13,272 INFO : Running cycle 1/1 for dromaeo_css test... 06:00:13 INFO - 2016-01-25 06:00:13,272 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv3nTGF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:00:25 INFO - 2016-01-25 06:00:25,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 137949184 06:00:25 INFO - 2016-01-25 06:00:25,055 DEBUG : BROWSER_OUTPUT: 06:01:15 INFO - 2016-01-25 06:01:15,781 DEBUG : BROWSER_OUTPUT: 1453730475780 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] 06:03:24 INFO - 2016-01-25 06:03:24,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48995/tests/dromaeo/cssquery-ext.html) 06:03:25 INFO - 2016-01-25 06:03:25,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 227074048 06:03:25 INFO - 2016-01-25 06:03:25,093 DEBUG : BROWSER_OUTPUT: 06:06:27 INFO - 2016-01-25 06:06:27,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/dromaeo/cssquery-ext.html (next: http://localhost:48995/tests/dromaeo/cssquery-jquery.html) 06:06:27 INFO - 2016-01-25 06:06:27,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 210964480 06:06:27 INFO - 2016-01-25 06:06:27,904 DEBUG : BROWSER_OUTPUT: 06:09:29 INFO - 2016-01-25 06:09:29,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48995/tests/dromaeo/cssquery-mootools.html) 06:09:30 INFO - 2016-01-25 06:09:30,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 212152320 06:09:30 INFO - 2016-01-25 06:09:30,343 DEBUG : BROWSER_OUTPUT: 06:12:32 INFO - 2016-01-25 06:12:32,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48995/tests/dromaeo/cssquery-prototype.html) 06:12:32 INFO - 2016-01-25 06:12:32,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 200720384 06:12:32 INFO - 2016-01-25 06:12:32,659 DEBUG : BROWSER_OUTPUT: 06:15:35 INFO - 2016-01-25 06:15:35,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48995/tests/dromaeo/cssquery-yui.html) 06:15:35 INFO - 2016-01-25 06:15:35,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 205479936 06:15:35 INFO - 2016-01-25 06:15:35,566 DEBUG : BROWSER_OUTPUT: 06:18:37 INFO - 2016-01-25 06:18:37,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/dromaeo/cssquery-yui.html (next: http://localhost:48995/tests/dromaeo/cssquery-dojo.html) 06:18:37 INFO - 2016-01-25 06:18:37,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 212783104 06:18:37 INFO - 2016-01-25 06:18:37,942 DEBUG : BROWSER_OUTPUT: 06:18:37 INFO - 2016-01-25 06:18:37,942 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:18:37 INFO - 2016-01-25 06:18:37,942 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:18:37 INFO - 2016-01-25 06:18:37,942 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:18:37 INFO - 2016-01-25 06:18:37,942 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:18:37 INFO - 2016-01-25 06:18:37,942 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3255.2024753935284;3322.88369907053;3345.297487527619;3348.732101431884;3365.74756893233;5429.918551221735;5465.945340546593;5478.698671573067;5490.533304669098;5503.587230957674;5484.8354549363585;5512.614117011811;5519.503244707976;5520.475554822296;5539.335279766424;4873.8781530461665;4986.626003049786;4994.150994330972;5047.64666473347;5088.643794934356;5000.399952005764;5059.974700126494;5068.4171320298265;5080.034793389244;5080.034793389263;4906.607471402279;4936.654434189608;5005.0990821652085;5022.246663000543;5075.720835354073;4998.025385049917;5035.345405097314;5044.319016932741;5044.965782014679;5069.721165335905;4977.527134922177;4987.650864439491;4993.525615066563;5010.674306170087;5048.091343558158;5035.169197082477;5117.130087885032;5143.12566863634;5264.131418315973;5301;5806.59353845231;5857.4435428634215;5858.326292476378;5858.677772722499;5859.4433528815125;5720.570957178228;5856.76572937082;5867.11993201019;5868.853278668024;5891.882162356729;5365.195220716884;5415.566754659618;5452.100403433389;5456.972715136439;5488.643238189505;5983.1623572699855;6003.039513677878;6006.189164462741;6009.338972712998;6011.158437818709;5659.547236221092;5760.193572899798;5816.069428891357;5819.156222347736;5821.505172060422;5712.457316554921;5796.1595568642315;5802.622829516068;5803.47768700819;5828.6211396259105;5862.648241105548;5876.559258055578;5909.497692696169;5910.231669882888;5914.852128696817;5609.046462101453;5715.828525144252;5836.737346819404;5908.911366329508;5909.970450147722;4576.885577860514;4587.2201725706045;4588.587027167571;4608.976955115203;4610.631149508032;4099.815508302134;4111.527174374925;4116.506019277646;4117.3618089196225;4144.316187828975;5352.411234764173;5488.259085023471;5513.5037846594;5653.80211692597;5679.630823996427;5919.4080591940465;5922.49658779;5955.196048533393;5961.493273071751;5964.7315870785915;5645.2096706461125;5653.830385088454;5654.886902262014;5660.518855897295;5660.632058916157;5022.397312322471;5110.61670374716;5126.820561280338;5180.663256888365;5223.947760522422;6051;6060.090986351995;6065.75736970525;6070.3929607038945;6070.575059745864;5900.793472228452;5903.881922361528;5905.793297234576;5906.881862362815;5907;5839.737211825393;5875.059990401515;5949.1076338549565;5983.850403739942;6013.5189184865985;5800.4489573490455;5807.419258074159;5857.560682948711;5864.824055278348;5889.676067816311;5611.6352437091455;5861.9413805861395;5904.498117659875;5918.319393269657;5924.644521328734;5590.496855283044;5675.404082571271;5689.089745640677;5691.060974939089;5713.400092990176;5775.711214439345;5798.884022319446;5801.680907550125;5804.535637148933;5809.24479817621;5494.230807686847;5548.861278467909;5705.486506214461;5751.568632352507;5759;5682.147677848356;5763;5765.019946609003;5784.305883294031;5801.042827933513;5620.437956204347;5669.376368599534;5672.773089076556;5673.716314184192;5713.028785106459 06:18:37 INFO - 2016-01-25 06:18:37,943 DEBUG : BROWSER_OUTPUT: |1;ext.html;611.4771870051106;617.287033476335;637.2798737426708;644.0853987337978;675.9290274521176;32207;32961;41566.16867662645;42003.15993680125;42136;46116.538834611645;46519.53480465194;46584;46613.30080048802;46636.53363466365;8046.678132874678;8995.235404990584;9148.8627670585;9157.175854173123;9157.908420915772;8261.297789687884;10849.837252441219;11114.05530529906;11124.666260012173;11126.777464450706;10787.78424431511;10903.454827258645;10905.672829815117;10913.563457461692;10921.235513514057;10723.731906702316;10794.02853743163;10805.13558915285;10837.133029357632;10856.34861908284;10516.158707303397;10614.469276536141;10637.787244255149;10638.57445702171;10642.787144257149;43609.781951090044;44087.11825763499;44155.337669934976;44177;44181.11637767259;3826.502554667903;3831.65515103642;4157.459530261077;4262.744235345889;4348.065165989327;31844.681553184404;32256.677433225603;32365;32517.837410812794;32641.67358326434;4301.526832048472;4360.869173924787;4369.410129632491;4370.56517640053;4411.044600117929;295153;295320;295532;295603;296254.51872740715;57567;65467.67266163639;65727.67136164289;65745;65866.67066664636;51039.74480127576;51266.23100653493;51277;51300.74349628302;75864;18115.63768724618;18132.274709011494;18204.726929096076;18299;18357.3574924877;14104.294785260901;14179.85820141806;14182.290885455686;14186.858131418554;14189.432422702976;18885.62228755417;19277;21628.675569866464;22076.668849967264;22239.777602224094;7717.807054823675;7983.72056978003;7991.8012298155745;7998.160193179632;8146.470479418819;1020.2246292817364;1073.6027669762238;1082.718493191776;1089.1559041742555;1126.796982610739;30142;30374.696253037186;30484.39031219363;30654.69345306563;30951;1110.938898360598;1140.589387820384;1146.7190538317998;1178.8682864450052;1202.0804084875078;13721.656958575915;14262.643433914234;14722.852771472362;14744.778828317583;15497.302621382065;364907;365877;366222;366570;366744;55795.72102139463;56021;56077.43922560804;56107.719461402434;56164.157537636966;1380.3719307714966;1391.923444210578;1448.9492867749577;1484.7104814561058;1505.902116362433;26583.46833063289;26926;27198.456030879668;27319.590206146528;29956.850215749655;46374.76812615915;46426.53573464357;46512.06975860396;46590.767046164554;49275;186853;326466;327488;327562;328571;33105.50341744828;33633;33734;33748.15629609279;33750.15624609405;43963;45416.54583454123;47354.289685654054;47684.284735729685;48717.75641121772;35205.29589408249;38287.42568861525;38802.223955521295;39021;39932.401013984236;38426.61573384342;38981.02547436337;39082.413763792996;39821.80089099536;40439.39340909947;35124;35414.114647134025;40294.79852600718;40481;41118.79440602778;29040.273993149494;31313.8434307827;32051.35897282088;32105;32379.35241295114;26314.473710526065;27057.59413608837;27103.1869043929;27237.727622724313;29204.26989325284 06:18:37 INFO - 2016-01-25 06:18:37,944 DEBUG : BROWSER_OUTPUT: |2;jquery.html;385.7781775479098;388.5104767992329;393.9369700847865;396.2036307022884;399.3311203733745;15048.804246267599;15894.284757185926;16778.580535486602;18089.27642894284;18100.90949545252;17795.555111122227;17914.64170716585;18128.72806907894;18308.908455457706;18358.26566937321;6046.30467496237;6158.84602884927;6162.537809664271;6193.1948846649875;6196.070589411579;4536.047430039679;4664.556867097637;6103.115048317991;6738.561993470434;6943.027976083353;5469.124940009599;6871.312868713114;6886.483513736464;6926.203486599055;6929.064576282188;5630.605857589971;5672.631278966875;5692.829215123553;5698.772049118051;5700.629459085146;5459.290292262021;5498.697571633558;5501.202325662796;5501.504864562208;5602;14249.358778854976;14385.136891786422;14481.045058917121;19599.804001960085;22777.43056423586;2321.593721098801;2336.6144586143264;2344.765523447659;2346.9295921122393;2362.598358279097;10393.48032598367;10547.894521054845;10732.517036733365;10743.086837618812;12708.555200568027;1985.205917632944;2005.8696184748092;2031.2179810772811;2065.5868826234814;2080.3966849613594;64926.675366623334;67003.66498167478;67638.32361676419;67663.66168169177;69397.99999999949;11248.550057997752;11250.49372778227;11258.268212566158;11263.549458021587;11353.886461135447;14276.643083922985;15047.699046019019;15049.473268435551;15065.397384104514;15070.321835517429;8294.170582941657;8472.66109355619;8630.093840146694;8658.653653853775;8688.695895643748;8565.14348565151;8577.785555361166;8599.14008599135;8632.870506942401;8646.135386461303;4564.2240819060835;4763.285507173882;4825;4832.44426890905;4854.150523658416;1724.2992402978987;1916.57835276239;1956.814102660245;1958.0601311370622;1978.7427634407723;854.4616891358529;1000.1698590170141;1026.7895081508273;1061.4109169411051;1064.882862885082;14397.496087636882;16173.67652646964;17315.134243287786;17599.384021559184;17963.550911227325;984.8571957066185;992.7766252593109;996.14829320931;1017.308230403318;1031.3141760729031;9075;9555.331126821056;9973.202143828476;10762.73093172677;10816.729581760519;455990;456205;458962;477942;663602;45230.773846130556;45302.54697452983;75714.62142689251;79932;80552;524.6537285391623;534.4762133109497;537.935447746273;539.0620320642133;541.1449909143544;11128.165387596124;11207.271527350696;11316.15128865355;11509.884901150881;11562.364069976233;37330.44004339883;38699.6130038696;38859;39323.213535729694;39695.603043970346;51538.48461515337;51636.741816290676;51864.740676297886;51960;57425.42574574201;10278.33190842593;10335.121514671036;10444.634437794944;10533.473326333806;10547.525361358605;12342.81485777696;12431.254124752544;12502.562410315595;12598.118131730691;18401.72397414013;15313.6171595711;15591.532254032398;15731;15837.604059898134;16189.433369831999;11865.466054027416;15127.092374457568;15264;15709.528714138594;15715.764263536284;15118.773218401513;15356.539303820904;15439.459618913284;15677.451289204822;15793.289301981667;10164.695059148238;10261.9486902565;10288.537015834456;10351.223658225814;10427.582896684351;14111.2944352784;15039.774403384177;15151.318190681666;15338.38646454174;15401.76897346563 06:18:37 INFO - 2016-01-25 06:18:37,944 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1585.1598652714065;1592.3312208872273;1661.5929097371145;1808.6925222712139;1845.8800177988435;7123.501354905159;8085.636146373413;8191.098979112293;8202.261796438319;8206.179382061791;7871.685132594704;8028.277455029046;8030;8031.678732850693;8032.317253033484;2014.0936578539643;2042.0300357330223;2044.1516770540209;2191.7808219178073;2227.2984010036866;2022;2267.059170444272;2344.3201471573225;2347.4835536182013;2347.929562113139;2237.742659594151;2276.931692049241;2295.9897645036212;2329.7087864017;2337.567550003246;2296.59809533331;2314.1206341590173;2337.2520793346134;2341.9648705269433;2342.543204075206;2298.10373954158;2315.560043591729;2321.419645088728;2322.303309007308;2324;8051.154628763954;8151.266386025227;8153.30696890765;8156.143604921516;8158.388120890957;4716.551927566876;4860.781264843055;4882.877928051792;4914.3611330527165;4917.704937703749;3000.234940090285;3055.847207639609;3056.7401770849506;3059.8776048958016;3116.9220769480717;966.3187452845727;968.1045033344199;985.960561577536;991.7619771254919;992.3599278465349;11333.603323883706;11359.091272698164;11381.032612227971;11384.146189035773;11384.487698053608;4238.766867822299;4261.296886013835;4297.59172878576;4311.2239796836875;4314.029343397773;9762.853557196648;9763.853542196874;9795.265355098254;9796.65711700087;9805.901940980499;4832.057748738962;4832.44426890912;4839.733814640229;4854.975725121351;4872.731999739977;4403.075354175595;4445.799939002753;4453.22068637987;4461.375407442961;4465.196264672325;3483.3555792178527;3486.442169252907;3562.7327950403824;3735.5517337919623;3854.903627409281;1165.248414772467;1173.565780661161;1181.1023622047305;1189.5182451107316;1202.2425871700773;1124.291696231369;1152.3892337061204;1154.8267759836092;1361.2649169448584;1424.266502751084;7808.648610812527;7850.764477065697;7913.485623434458;7935.761927142195;7941.285284324438;1149.557420393138;1160.7678464307003;1169.473736818435;1171.5313874450117;1188.4830098907003;6277.905831412532;6307.432331090224;6341.651209183447;6356.936430635635;6365;9598.95200523993;9619.27855410847;9724.61101555944;9729.075737804897;9745.220382369393;9485.762855928519;9684.95157524208;9687.66093186735;9688.176504997013;9699.321047526606;7102.467314951399;7134.785956421316;7150.642467876585;7208.171060328129;7220.67506962188;7743.574103424366;7855.5286682799215;7893.250141236574;7946.364290856602;7950.801229969297;8590.527520986156;8740.781480462785;8784.604692788967;8791;8992.235659968976;8937.59780809878;8992.325575581988;9013.774655633399;9014.053524379846;9388.014258503032;7545.886811697719;7636;7637.5035622684345;7637.656305466378;7643.388528917784;7038.436925045881;7640.426967977312;7832.373410127062;7904.762857114296;8117.878231826646;7560.9621951889885;7565.697372105275;7609.429292803173;7617;7659.195784442776;7345.522541034816;7354.117505899327;7388.039554857834;7484.139323977813;7489.625518724151;7367.926320736724;7401.48189626721;7512.474126811071;7523.285287897641;7531.548107113591;6913.827154321182;6934.098567186234;6956.234814170539;6965.442764578923;6969.059177011039;6889.483288753263;6892.379685828299;6926.376626103674;6995.405390541658;7037.472189585904 06:18:37 INFO - 2016-01-25 06:18:37,945 DEBUG : BROWSER_OUTPUT: |4;prototype.html;354.5355584184718;354.60992907801415;359.3513707757497;360.67178867230825;365.71474250084924;6081;6106.389361063897;6109.694515274241;6115.449609535141;6149.569530132892;6006.369331220225;6008.699565021753;6019.277686677594;6022.8795424091495;6027.517798576115;4576.977115114437;4665.393498845146;4682.953170468303;4690.132325519773;4694.037722266944;4636.09596128755;4669.976650116745;4683.672142949995;4683.8360657377;4688.695234809744;4632.0967411354795;4643.303504474339;4645.651576131787;4646.303054541812;4650.395448591678;4415.8233670653135;4507.143642707892;4548.840790572314;4604.447466304032;4646.047560250141;4066.207089617526;4076.7553946763287;4082.2447847148374;4095.262852686515;4114.012636967136;5539.8892022159735;5661.46216109469;5725.770969161229;5739.827805165852;5765.394633563457;5320.840374788762;5414.810481633163;5428.864278393072;5438.782448702047;5445.074337362658;6373.521985851034;6375;6376.107344971708;6377.58545694533;6379.36206379363;4559.658025648089;4561.087782443525;4563.634909207255;4565.018521017964;4569.314602809572;6459.870802583969;6585.979173228109;6615.669216539202;6649.803035453617;6667.199936007662;4545.272756358967;4587.977060114678;4613.446386433649;4614.953850461452;4615.100055489214;4665.3934988451965;4674.579287864109;4676.298555216745;4676.789544470507;4679.695819771704;5273.789048438096;5373.892522149613;5378.91931621026;5379.246905433242;5380.91928621071;6424.00427933671;6427.132337134521;6428.550001499943;6432;6435.22777266731;1634.5995231168201;1645.2020769926576;1654.8179700232965;1659.278213976924;1660.0703605980689;1105.657246253664;1109.4730003248553;1113.5879724501985;1133.6032388664066;1133.6259034518755;6260.780872669526;6271.874562508816;6273.525721455454;6278.46633036197;6279.686015699197;6600;6627.768028119089;6643.069970204176;6649.268580456146;6655.168103987002;6115.082737589309;6276.623402595859;6277.623342599459;6278.843028924222;6317.14718513004;3589.174489867345;3605.837737301828;3608.530890984208;3610.6028336882923;3611.6207798180812;6788.321167883172;6793.966030169916;6806.353396427331;6811.897821532681;6814.8637027260165;6621.106150669598;6710.127683401224;6749.021391898147;6773.390394864486;6852.5203235774015;6830.248672646005;6848.657567121624;6851.246362899978;6851.828704282433;6866.485013623998;6522.510811689048;6631.867362652816;6670.39966403026;6673.466122710074;6679.532432729662;6574.0796288520605;6575.506836987341;6576.506761992774;6576.671166441754;6590.209174899042;6843.692033858389;6846.760363387258;6854.691538880663;6855;6861.519693621399;4637.0262244928945;4646.349511068385;4649.418822647169;4649.674522783373;4653.790579423866;6524.347565243438;6625.503087268377;6653.700583473658;6663.833404164935;6667.066610674607;6470.126532918184;6485.967570162119;6486.870262594627;6487.313298542507;6489.7404103835315;6367.52243581724;6471.352864713491;6476.579022363531;6482.805515834532;6484;6372.968135159294;6382.32985536512;6383.680815959091;6384.010478375859;6393.200849893763;6502.544821862613;6508.902366464602;6510.316416776171;6515.934840651723;6519.282878883224;6253.280872699515;6364.4908407326375;6368.52236082305;6374.840628984127;6381.521385895983 06:18:37 INFO - 2016-01-25 06:18:37,947 DEBUG : BROWSER_OUTPUT: |5;yui.html;846.8475674378609;878.7319867440428;927.6614035876903;941.4586612697698;946.7396465971859;12650.936745316272;13069.411876465558;13072.477100915963;13084.411201495932;13125;12548.623541293753;13299.401526931288;13312.534061307857;13324.733505329888;13341.399637016333;760.7185341423681;769.8768197088467;909.8089401225751;919.645936314517;924.9676261330854;921.0651189043126;929.1544694328163;929.962801487943;931.2456909902967;931.3434029009566;974.512743628186;977.3451787302524;979.1921664626676;979.8236317462854;979.9265055120859;792.809725665839;804.1034246814818;951.4861974533778;959.5729900194416;960.8991055939096;708.3766285668579;709.2092317066486;710.1229980973494;712.8895021271659;716.9318914703147;13237.735245295136;13313;13367.06430549862;13383;13392.598222053257;13009.934950325283;13038.674033149153;13148.53980110701;13192.802107968388;13243.139195952328;10781.081375431904;10854;10875.83686244707;11140.944295278552;11419.48612312448;3677.062349100962;3705.6294370562996;3715.7398982071268;3744.6817020553012;3768.2651882882847;45056.09887802258;45076.77461612704;45319.32021019654;45612.315815262795;47143.29285060727;10306.227032972558;10419.94790026045;10447.05976462122;10467.371957682411;10584.576616935236;18263.63472730538;18347.266109355478;18352.908235458737;18368.908155459136;19383.903080484506;7420.443466739908;7436.405087593088;7483.925160748323;7626.656800443993;7673.309402153833;4425.446819147606;4530.70550414222;4545.204589196944;4611.723296602215;4657;3215.42122417967;3241.38413701396;3241.9837900810817;3252.3495300939435;3257.8371081445835;565.2482198675751;565.3470241870646;568.556525909791;570.0309473894396;583.6498101139367;597.9760809567656;612.859042420237;628.4092952624518;634.9873002539923;651.7621068310033;7773.5724535149975;7811.68753249875;7926.128125906146;7962.920370796333;8119.309858661962;486.3555788580075;578.6643746626946;592.7125344208056;618.6411881108946;628.0735914526038;3914.373700207953;3966.464527288837;4015.738976966488;4029.7783621901076;4122.361034039729;57784;58136.127958080666;59114.70442647759;59574;59801.40198597958;46771.5322846774;47841.76079119582;50659.49340506621;50682.49317506778;51593.742031290356;46112.5388746115;46585.30122048172;46789;47945.04109917852;48794.512054879;8944.105589441004;8946.463212207289;9005;9050.637974480947;9151.908480915106;36049.197540123416;36331;37093.443598345504;37167;37478.81260593679;41999;46264.768676156404;46400.8399790008;46543.44011079423;47111.528884710715;9921.355111917703;10067.647632332833;10136;10604;10795.838062429228;12125.575604853788;12206.389680516117;12237.877621223673;12404.81392779091;12463.688407789878;10493.685189444328;10631.219337795674;10652.89347106519;10778.784424311312;10803.513841876977;11074.667759967213;11259.605913792979;11296.152788541056;11305.26515776472;11450.141239406912;9381.859272110787;10922.12622990143;11017.063549598053;11348.716282093013;11444.313341199555;9903.356281841658;10039.146672532917;10250.846237306298;10275.434851083262;10396.532156052845;9621.08599683029;9756;9932.503374831374;9957.950210249192;10017.14854237398 06:18:37 INFO - 2016-01-25 06:18:37,947 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:18:37 INFO - 2016-01-25 06:18:37,947 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:18:37 INFO - 2016-01-25 06:18:37,947 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,716 06:18:37 INFO - 2016-01-25 06:18:37,947 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:18:37 INFO - 2016-01-25 06:18:37,947 DEBUG : BROWSER_OUTPUT: __startTimestamp1453731517940__endTimestamp 06:18:37 INFO - 2016-01-25 06:18:37,947 DEBUG : BROWSER_OUTPUT: 06:18:37 INFO - 2016-01-25 06:18:37,947 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:18:37 INFO - 2016-01-25 06:18:37,947 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:18:37 INFO - 2016-01-25 06:18:37,947 DEBUG : BROWSER_OUTPUT: 06:18:37 INFO - 2016-01-25 06:18:37,947 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5456.98 Median:5672.77 stddev:583.47 (10.3%) stddev-sans-first:559.11 06:18:37 INFO - 2016-01-25 06:18:37,947 DEBUG : BROWSER_OUTPUT: Values: 3255.2 3322.9 3345.3 3348.7 3365.7 5429.9 5465.9 5478.7 5490.5 5503.6 5484.8 5512.6 5519.5 5520.5 5539.3 4873.9 4986.6 4994.2 5047.6 5088.6 5000.4 5060.0 5068.4 5080.0 5080.0 4906.6 4936.7 5005.1 5022.2 5075.7 4998.0 5035.3 5044.3 5045.0 5069.7 4977.5 4987.7 4993.5 5010.7 5048.1 5035.2 5117.1 5143.1 5264.1 5301.0 5806.6 5857.4 5858.3 5858.7 5859.4 5720.6 5856.8 5867.1 5868.9 5891.9 5365.2 5415.6 5452.1 5457.0 5488.6 5983.2 6003.0 6006.2 6009.3 6011.2 5659.5 5760.2 5816.1 5819.2 5821.5 5712.5 5796.2 5802.6 5803.5 5828.6 5862.6 5876.6 5909.5 5910.2 5914.9 5609.0 5715.8 5836.7 5908.9 5910.0 4576.9 4587.2 4588.6 4609.0 4610.6 4099.8 4111.5 4116.5 4117.4 4144.3 5352.4 5488.3 5513.5 5653.8 5679.6 5919.4 5922.5 5955.2 5961.5 5964.7 5645.2 5653.8 5654.9 5660.5 5660.6 5022.4 5110.6 5126.8 5180.7 5223.9 6051.0 6060.1 6065.8 6070.4 6070.6 5900.8 5903.9 5905.8 5906.9 5907.0 5839.7 5875.1 5949.1 5983.9 6013.5 5800.4 5807.4 5857.6 5864.8 5889.7 5611.6 5861.9 5904.5 5918.3 5924.6 5590.5 5675.4 5689.1 5691.1 5713.4 5775.7 5798.9 5801.7 5804.5 5809.2 5494.2 5548.9 5705.5 5751.6 5759.0 5682.1 5763.0 5765.0 5784.3 5801.0 5620.4 5669.4 5672.8 5673.7 5713.0 06:18:37 INFO - 2016-01-25 06:18:37,947 DEBUG : BROWSER_OUTPUT: 06:18:37 INFO - 2016-01-25 06:18:37,948 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49965.79 Median:33033.25 stddev:84677.82 (256.3%) stddev-sans-first:84834.28 06:18:37 INFO - 2016-01-25 06:18:37,948 DEBUG : BROWSER_OUTPUT: Values: 611.5 617.3 637.3 644.1 675.9 32207.0 32961.0 41566.2 42003.2 42136.0 46116.5 46519.5 46584.0 46613.3 46636.5 8046.7 8995.2 9148.9 9157.2 9157.9 8261.3 10849.8 11114.1 11124.7 11126.8 10787.8 10903.5 10905.7 10913.6 10921.2 10723.7 10794.0 10805.1 10837.1 10856.3 10516.2 10614.5 10637.8 10638.6 10642.8 43609.8 44087.1 44155.3 44177.0 44181.1 3826.5 3831.7 4157.5 4262.7 4348.1 31844.7 32256.7 32365.0 32517.8 32641.7 4301.5 4360.9 4369.4 4370.6 4411.0 295153.0 295320.0 295532.0 295603.0 296254.5 57567.0 65467.7 65727.7 65745.0 65866.7 51039.7 51266.2 51277.0 51300.7 75864.0 18115.6 18132.3 18204.7 18299.0 18357.4 14104.3 14179.9 14182.3 14186.9 14189.4 18885.6 19277.0 21628.7 22076.7 22239.8 7717.8 7983.7 7991.8 7998.2 8146.5 1020.2 1073.6 1082.7 1089.2 1126.8 30142.0 30374.7 30484.4 30654.7 30951.0 1110.9 1140.6 1146.7 1178.9 1202.1 13721.7 14262.6 14722.9 14744.8 15497.3 364907.0 365877.0 366222.0 366570.0 366744.0 55795.7 56021.0 56077.4 56107.7 56164.2 1380.4 1391.9 1448.9 1484.7 1505.9 26583.5 26926.0 27198.5 27319.6 29956.9 46374.8 46426.5 46512.1 46590.8 49275.0 186853.0 326466.0 327488.0 327562.0 328571.0 33105.5 33633.0 33734.0 33748.2 33750.2 43963.0 45416.5 47354.3 47684.3 48717.8 35205.3 38287.4 38802.2 39021.0 39932.4 38426.6 38981.0 39082.4 39821.8 40439.4 35124.0 35414.1 40294.8 40481.0 41118.8 29040.3 31313.8 32051.4 32105.0 32379.4 26314.5 27057.6 27103.2 27237.7 29204.3 06:18:37 INFO - 2016-01-25 06:18:37,948 DEBUG : BROWSER_OUTPUT: 06:18:37 INFO - 2016-01-25 06:18:37,948 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28065.72 Median:2072.99 stddev:83184.83 (4012.8%) stddev-sans-first:83392.22 06:18:37 INFO - 2016-01-25 06:18:37,949 DEBUG : BROWSER_OUTPUT: Values: 385.8 388.5 393.9 396.2 399.3 15048.8 15894.3 16778.6 18089.3 18100.9 17795.6 17914.6 18128.7 18308.9 18358.3 6046.3 6158.8 6162.5 6193.2 6196.1 4536.0 4664.6 6103.1 6738.6 6943.0 5469.1 6871.3 6886.5 6926.2 6929.1 5630.6 5672.6 5692.8 5698.8 5700.6 5459.3 5498.7 5501.2 5501.5 5602.0 14249.4 14385.1 14481.0 19599.8 22777.4 2321.6 2336.6 2344.8 2346.9 2362.6 10393.5 10547.9 10732.5 10743.1 12708.6 1985.2 2005.9 2031.2 2065.6 2080.4 64926.7 67003.7 67638.3 67663.7 69398.0 11248.6 11250.5 11258.3 11263.5 11353.9 14276.6 15047.7 15049.5 15065.4 15070.3 8294.2 8472.7 8630.1 8658.7 8688.7 8565.1 8577.8 8599.1 8632.9 8646.1 4564.2 4763.3 4825.0 4832.4 4854.2 1724.3 1916.6 1956.8 1958.1 1978.7 854.5 1000.2 1026.8 1061.4 1064.9 14397.5 16173.7 17315.1 17599.4 17963.6 984.9 992.8 996.1 1017.3 1031.3 9075.0 9555.3 9973.2 10762.7 10816.7 455990.0 456205.0 458962.0 477942.0 663602.0 45230.8 45302.5 75714.6 79932.0 80552.0 524.7 534.5 537.9 539.1 541.1 11128.2 11207.3 11316.2 11509.9 11562.4 37330.4 38699.6 38859.0 39323.2 39695.6 51538.5 51636.7 51864.7 51960.0 57425.4 10278.3 10335.1 10444.6 10533.5 10547.5 12342.8 12431.3 12502.6 12598.1 18401.7 15313.6 15591.5 15731.0 15837.6 16189.4 11865.5 15127.1 15264.0 15709.5 15715.8 15118.8 15356.5 15439.5 15677.5 15793.3 10164.7 10261.9 10288.5 10351.2 10427.6 14111.3 15039.8 15151.3 15338.4 15401.8 06:18:37 INFO - 2016-01-25 06:18:37,949 DEBUG : BROWSER_OUTPUT: 06:18:37 INFO - 2016-01-25 06:18:37,949 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5724.85 Median:6960.84 stddev:3013.10 (43.3%) stddev-sans-first:3005.49 06:18:37 INFO - 2016-01-25 06:18:37,950 DEBUG : BROWSER_OUTPUT: Values: 1585.2 1592.3 1661.6 1808.7 1845.9 7123.5 8085.6 8191.1 8202.3 8206.2 7871.7 8028.3 8030.0 8031.7 8032.3 2014.1 2042.0 2044.2 2191.8 2227.3 2022.0 2267.1 2344.3 2347.5 2347.9 2237.7 2276.9 2296.0 2329.7 2337.6 2296.6 2314.1 2337.3 2342.0 2342.5 2298.1 2315.6 2321.4 2322.3 2324.0 8051.2 8151.3 8153.3 8156.1 8158.4 4716.6 4860.8 4882.9 4914.4 4917.7 3000.2 3055.8 3056.7 3059.9 3116.9 966.3 968.1 986.0 991.8 992.4 11333.6 11359.1 11381.0 11384.1 11384.5 4238.8 4261.3 4297.6 4311.2 4314.0 9762.9 9763.9 9795.3 9796.7 9805.9 4832.1 4832.4 4839.7 4855.0 4872.7 4403.1 4445.8 4453.2 4461.4 4465.2 3483.4 3486.4 3562.7 3735.6 3854.9 1165.2 1173.6 1181.1 1189.5 1202.2 1124.3 1152.4 1154.8 1361.3 1424.3 7808.6 7850.8 7913.5 7935.8 7941.3 1149.6 1160.8 1169.5 1171.5 1188.5 6277.9 6307.4 6341.7 6356.9 6365.0 9599.0 9619.3 9724.6 9729.1 9745.2 9485.8 9685.0 9687.7 9688.2 9699.3 7102.5 7134.8 7150.6 7208.2 7220.7 7743.6 7855.5 7893.3 7946.4 7950.8 8590.5 8740.8 8784.6 8791.0 8992.2 8937.6 8992.3 9013.8 9014.1 9388.0 7545.9 7636.0 7637.5 7637.7 7643.4 7038.4 7640.4 7832.4 7904.8 8117.9 7561.0 7565.7 7609.4 7617.0 7659.2 7345.5 7354.1 7388.0 7484.1 7489.6 7367.9 7401.5 7512.5 7523.3 7531.5 6913.8 6934.1 6956.2 6965.4 6969.1 6889.5 6892.4 6926.4 6995.4 7037.5 06:18:37 INFO - 2016-01-25 06:18:37,951 DEBUG : BROWSER_OUTPUT: 06:18:37 INFO - 2016-01-25 06:18:37,951 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5395.57 Median:6201.43 stddev:1610.26 (26.0%) stddev-sans-first:1569.70 06:18:37 INFO - 2016-01-25 06:18:37,951 DEBUG : BROWSER_OUTPUT: Values: 354.5 354.6 359.4 360.7 365.7 6081.0 6106.4 6109.7 6115.4 6149.6 6006.4 6008.7 6019.3 6022.9 6027.5 4577.0 4665.4 4683.0 4690.1 4694.0 4636.1 4670.0 4683.7 4683.8 4688.7 4632.1 4643.3 4645.7 4646.3 4650.4 4415.8 4507.1 4548.8 4604.4 4646.0 4066.2 4076.8 4082.2 4095.3 4114.0 5539.9 5661.5 5725.8 5739.8 5765.4 5320.8 5414.8 5428.9 5438.8 5445.1 6373.5 6375.0 6376.1 6377.6 6379.4 4559.7 4561.1 4563.6 4565.0 4569.3 6459.9 6586.0 6615.7 6649.8 6667.2 4545.3 4588.0 4613.4 4615.0 4615.1 4665.4 4674.6 4676.3 4676.8 4679.7 5273.8 5373.9 5378.9 5379.2 5380.9 6424.0 6427.1 6428.6 6432.0 6435.2 1634.6 1645.2 1654.8 1659.3 1660.1 1105.7 1109.5 1113.6 1133.6 1133.6 6260.8 6271.9 6273.5 6278.5 6279.7 6600.0 6627.8 6643.1 6649.3 6655.2 6115.1 6276.6 6277.6 6278.8 6317.1 3589.2 3605.8 3608.5 3610.6 3611.6 6788.3 6794.0 6806.4 6811.9 6814.9 6621.1 6710.1 6749.0 6773.4 6852.5 6830.2 6848.7 6851.2 6851.8 6866.5 6522.5 6631.9 6670.4 6673.5 6679.5 6574.1 6575.5 6576.5 6576.7 6590.2 6843.7 6846.8 6854.7 6855.0 6861.5 4637.0 4646.3 4649.4 4649.7 4653.8 6524.3 6625.5 6653.7 6663.8 6667.1 6470.1 6486.0 6486.9 6487.3 6489.7 6367.5 6471.4 6476.6 6482.8 6484.0 6373.0 6382.3 6383.7 6384.0 6393.2 6502.5 6508.9 6510.3 6515.9 6519.3 6253.3 6364.5 6368.5 6374.8 6381.5 06:18:37 INFO - 2016-01-25 06:18:37,951 DEBUG : BROWSER_OUTPUT: 06:18:37 INFO - 2016-01-25 06:18:37,951 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13856.75 Median:25112.02 stddev:15963.95 (63.6%) stddev-sans-first:15978.83 06:18:37 INFO - 2016-01-25 06:18:37,951 DEBUG : BROWSER_OUTPUT: Values: 846.8 878.7 927.7 941.5 946.7 12650.9 13069.4 13072.5 13084.4 13125.0 12548.6 13299.4 13312.5 13324.7 13341.4 760.7 769.9 909.8 919.6 925.0 921.1 929.2 930.0 931.2 931.3 974.5 977.3 979.2 979.8 979.9 792.8 804.1 951.5 959.6 960.9 708.4 709.2 710.1 712.9 716.9 13237.7 13313.0 13367.1 13383.0 13392.6 13009.9 13038.7 13148.5 13192.8 13243.1 10781.1 10854.0 10875.8 11140.9 11419.5 3677.1 3705.6 3715.7 3744.7 3768.3 45056.1 45076.8 45319.3 45612.3 47143.3 10306.2 10419.9 10447.1 10467.4 10584.6 18263.6 18347.3 18352.9 18368.9 19383.9 7420.4 7436.4 7483.9 7626.7 7673.3 4425.4 4530.7 4545.2 4611.7 4657.0 3215.4 3241.4 3242.0 3252.3 3257.8 565.2 565.3 568.6 570.0 583.6 598.0 612.9 628.4 635.0 651.8 7773.6 7811.7 7926.1 7962.9 8119.3 486.4 578.7 592.7 618.6 628.1 3914.4 3966.5 4015.7 4029.8 4122.4 57784.0 58136.1 59114.7 59574.0 59801.4 46771.5 47841.8 50659.5 50682.5 51593.7 46112.5 46585.3 46789.0 47945.0 48794.5 8944.1 8946.5 9005.0 9050.6 9151.9 36049.2 36331.0 37093.4 37167.0 37478.8 41999.0 46264.8 46400.8 46543.4 47111.5 9921.4 10067.6 10136.0 10604.0 10795.8 12125.6 12206.4 12237.9 12404.8 12463.7 10493.7 10631.2 10652.9 10778.8 10803.5 11074.7 11259.6 11296.2 11305.3 11450.1 9381.9 10922.1 11017.1 11348.7 11444.3 9903.4 10039.1 10250.8 10275.4 10396.5 9621.1 9756.0 9932.5 9958.0 10017.1 06:18:37 INFO - 2016-01-25 06:18:37,951 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:18:37 INFO - 2016-01-25 06:18:37,951 DEBUG : BROWSER_OUTPUT: 06:18:38 INFO - 2016-01-25 06:18:38,621 INFO : Browser exited with error code: 0 06:18:38 INFO - 2016-01-25 06:18:38,642 INFO : Completed test dromaeo_css (00:18:30) 06:18:38 INFO - 2016-01-25 06:18:38,642 INFO : Starting test kraken 06:18:38 INFO - 2016-01-25 06:18:38,642 DEBUG : operating with platform_type : linux_ 06:18:38 INFO - 2016-01-25 06:18:38,642 INFO : Initialising browser for kraken test... 06:18:38 INFO - 2016-01-25 06:18:38,649 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpS3gHvg/profile http://localhost:48995/getInfo.html 06:18:42 INFO - 2016-01-25 06:18:42,827 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:18:42 INFO - 2016-01-25 06:18:42,827 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:18:42 INFO - 2016-01-25 06:18:42,827 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:18:42 INFO - 2016-01-25 06:18:42,827 DEBUG : BROWSER_OUTPUT: __metrics 06:18:42 INFO - 2016-01-25 06:18:42,997 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:18:43 INFO - 2016-01-25 06:18:43,685 INFO : Browser initialized. 06:18:43 INFO - 2016-01-25 06:18:43,686 INFO : Running cycle 1/1 for kraken test... 06:18:43 INFO - 2016-01-25 06:18:43,686 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpS3gHvg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:18:55 INFO - 2016-01-25 06:18:55,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 137486336 06:18:55 INFO - 2016-01-25 06:18:55,493 DEBUG : BROWSER_OUTPUT: 06:18:57 INFO - 2016-01-25 06:18:57,907 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48995/tests/kraken/driver.html?testName=audio-beat-detection) 06:18:58 INFO - 2016-01-25 06:18:58,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 169259008 06:18:58 INFO - 2016-01-25 06:18:58,488 DEBUG : BROWSER_OUTPUT: 06:19:01 INFO - 2016-01-25 06:19:01,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48995/tests/kraken/driver.html?testName=audio-dft) 06:19:01 INFO - 2016-01-25 06:19:01,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 167952384 06:19:01 INFO - 2016-01-25 06:19:01,601 DEBUG : BROWSER_OUTPUT: 06:19:04 INFO - 2016-01-25 06:19:04,369 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48995/tests/kraken/driver.html?testName=audio-fft) 06:19:04 INFO - 2016-01-25 06:19:04,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 165031936 06:19:04 INFO - 2016-01-25 06:19:04,937 DEBUG : BROWSER_OUTPUT: 06:19:06 INFO - 2016-01-25 06:19:06,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48995/tests/kraken/driver.html?testName=audio-oscillator) 06:19:07 INFO - 2016-01-25 06:19:07,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 165912576 06:19:07 INFO - 2016-01-25 06:19:07,502 DEBUG : BROWSER_OUTPUT: 06:19:09 INFO - 2016-01-25 06:19:09,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48995/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:19:10 INFO - 2016-01-25 06:19:10,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 163532800 06:19:10 INFO - 2016-01-25 06:19:10,207 DEBUG : BROWSER_OUTPUT: 06:19:13 INFO - 2016-01-25 06:19:13,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48995/tests/kraken/driver.html?testName=imaging-darkroom) 06:19:13 INFO - 2016-01-25 06:19:13,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 164347904 06:19:13 INFO - 2016-01-25 06:19:13,638 DEBUG : BROWSER_OUTPUT: 06:19:16 INFO - 2016-01-25 06:19:16,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48995/tests/kraken/driver.html?testName=imaging-desaturate) 06:19:17 INFO - 2016-01-25 06:19:17,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 164950016 06:19:17 INFO - 2016-01-25 06:19:17,559 DEBUG : BROWSER_OUTPUT: 06:19:20 INFO - 2016-01-25 06:19:20,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48995/tests/kraken/driver.html?testName=json-parse-financial) 06:19:20 INFO - 2016-01-25 06:19:20,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 164737024 06:19:20 INFO - 2016-01-25 06:19:20,829 DEBUG : BROWSER_OUTPUT: 06:19:22 INFO - 2016-01-25 06:19:22,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48995/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:19:22 INFO - 2016-01-25 06:19:22,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 170803200 06:19:22 INFO - 2016-01-25 06:19:22,930 DEBUG : BROWSER_OUTPUT: 06:19:24 INFO - 2016-01-25 06:19:24,721 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:19:25 INFO - 2016-01-25 06:19:25,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 169304064 06:19:25 INFO - 2016-01-25 06:19:25,316 DEBUG : BROWSER_OUTPUT: 06:19:27 INFO - 2016-01-25 06:19:27,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:19:27 INFO - 2016-01-25 06:19:27,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 174899200 06:19:27 INFO - 2016-01-25 06:19:27,873 DEBUG : BROWSER_OUTPUT: 06:19:30 INFO - 2016-01-25 06:19:30,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:19:30 INFO - 2016-01-25 06:19:30,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 181411840 06:19:30 INFO - 2016-01-25 06:19:30,818 DEBUG : BROWSER_OUTPUT: 06:19:33 INFO - 2016-01-25 06:19:33,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:19:33 INFO - 2016-01-25 06:19:33,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 179503104 06:19:33 INFO - 2016-01-25 06:19:33,862 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48995/tests/kraken/driver.html?testName=ai-astar) 06:19:35 INFO - 2016-01-25 06:19:35,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 238436352 06:19:35 INFO - 2016-01-25 06:19:35,781 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,782 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:19:35 INFO - 2016-01-25 06:19:35,782 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:19:35 INFO - 2016-01-25 06:19:35,782 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:19:35 INFO - 2016-01-25 06:19:35,782 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:19:35 INFO - 2016-01-25 06:19:35,782 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;109;103;108;109;109;99;109;109;108 06:19:35 INFO - 2016-01-25 06:19:35,782 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;143;122;154;164;122;145;155;121;158;122 06:19:35 INFO - 2016-01-25 06:19:35,782 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;159;161;160;160;158;158;161;159;158 06:19:35 INFO - 2016-01-25 06:19:35,783 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;71;70;154;72;70;73;73;146;73 06:19:35 INFO - 2016-01-25 06:19:35,783 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;137;92;92;93;145;93;93;132 06:19:35 INFO - 2016-01-25 06:19:35,783 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;109;109;110;110;109;110;109 06:19:35 INFO - 2016-01-25 06:19:35,783 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;146;145;146;145;145;146;146;145 06:19:35 INFO - 2016-01-25 06:19:35,783 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;95;95;96;96;95;95 06:19:35 INFO - 2016-01-25 06:19:35,783 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;57;58;56;56;55;56;56;55;56 06:19:35 INFO - 2016-01-25 06:19:35,783 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;65;65;66;66;66;66;65;66;68 06:19:35 INFO - 2016-01-25 06:19:35,783 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;83;80;79;79;79;80;82;81;79 06:19:35 INFO - 2016-01-25 06:19:35,784 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;115;116;111;108;119;109;117;109;118 06:19:35 INFO - 2016-01-25 06:19:35,784 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;149;141;143;155;134;132;141;142;134 06:19:35 INFO - 2016-01-25 06:19:35,784 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;63;64;66;65;65;64;70;65;66 06:19:35 INFO - 2016-01-25 06:19:35,784 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:19:35 INFO - 2016-01-25 06:19:35,784 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:19:35 INFO - 2016-01-25 06:19:35,784 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,941 06:19:35 INFO - 2016-01-25 06:19:35,784 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:19:35 INFO - 2016-01-25 06:19:35,785 DEBUG : BROWSER_OUTPUT: __startTimestamp1453731575780__endTimestamp 06:19:35 INFO - 2016-01-25 06:19:35,785 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,788 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:19:35 INFO - 2016-01-25 06:19:35,788 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:19:35 INFO - 2016-01-25 06:19:35,788 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,789 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.00 Median:109.00 stddev:3.37 (3.1%) stddev-sans-first:3.57 06:19:35 INFO - 2016-01-25 06:19:35,789 DEBUG : BROWSER_OUTPUT: Values: 107.0 109.0 103.0 108.0 109.0 109.0 99.0 109.0 109.0 108.0 06:19:35 INFO - 2016-01-25 06:19:35,789 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,789 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.60 Median:149.50 stddev:17.27 (11.6%) stddev-sans-first:18.30 06:19:35 INFO - 2016-01-25 06:19:35,789 DEBUG : BROWSER_OUTPUT: Values: 143.0 122.0 154.0 164.0 122.0 145.0 155.0 121.0 158.0 122.0 06:19:35 INFO - 2016-01-25 06:19:35,789 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,790 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.30 Median:159.50 stddev:1.16 (0.7%) stddev-sans-first:1.22 06:19:35 INFO - 2016-01-25 06:19:35,790 DEBUG : BROWSER_OUTPUT: Values: 159.0 159.0 161.0 160.0 160.0 158.0 158.0 161.0 159.0 158.0 06:19:35 INFO - 2016-01-25 06:19:35,790 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,790 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.90 Median:72.50 stddev:32.84 (45.3%) stddev-sans-first:34.60 06:19:35 INFO - 2016-01-25 06:19:35,790 DEBUG : BROWSER_OUTPUT: Values: 77.0 71.0 70.0 154.0 72.0 70.0 73.0 73.0 146.0 73.0 06:19:35 INFO - 2016-01-25 06:19:35,790 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,791 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.30 Median:93.00 stddev:22.10 (23.8%) stddev-sans-first:22.91 06:19:35 INFO - 2016-01-25 06:19:35,791 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 137.0 92.0 92.0 93.0 145.0 93.0 93.0 132.0 06:19:35 INFO - 2016-01-25 06:19:35,791 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,791 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:19:35 INFO - 2016-01-25 06:19:35,792 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 109.0 109.0 110.0 110.0 109.0 110.0 109.0 06:19:35 INFO - 2016-01-25 06:19:35,792 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,792 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:19:35 INFO - 2016-01-25 06:19:35,792 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 06:19:35 INFO - 2016-01-25 06:19:35,792 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,793 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:19:35 INFO - 2016-01-25 06:19:35,793 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 06:19:35 INFO - 2016-01-25 06:19:35,793 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,793 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 06:19:35 INFO - 2016-01-25 06:19:35,793 DEBUG : BROWSER_OUTPUT: Values: 56.0 57.0 58.0 56.0 56.0 55.0 56.0 56.0 55.0 56.0 06:19:35 INFO - 2016-01-25 06:19:35,793 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,793 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 06:19:35 INFO - 2016-01-25 06:19:35,793 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 65.0 66.0 66.0 66.0 66.0 65.0 66.0 68.0 06:19:35 INFO - 2016-01-25 06:19:35,793 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,793 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:1.73 (2.2%) stddev-sans-first:1.48 06:19:35 INFO - 2016-01-25 06:19:35,793 DEBUG : BROWSER_OUTPUT: Values: 77.0 83.0 80.0 79.0 79.0 79.0 80.0 82.0 81.0 79.0 06:19:35 INFO - 2016-01-25 06:19:35,794 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,794 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:113.60 Median:115.50 stddev:4.06 (3.5%) stddev-sans-first:4.30 06:19:35 INFO - 2016-01-25 06:19:35,794 DEBUG : BROWSER_OUTPUT: Values: 114.0 115.0 116.0 111.0 108.0 119.0 109.0 117.0 109.0 118.0 06:19:35 INFO - 2016-01-25 06:19:35,794 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,794 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.50 Median:141.50 stddev:7.38 (5.2%) stddev-sans-first:7.45 06:19:35 INFO - 2016-01-25 06:19:35,794 DEBUG : BROWSER_OUTPUT: Values: 134.0 149.0 141.0 143.0 155.0 134.0 132.0 141.0 142.0 134.0 06:19:35 INFO - 2016-01-25 06:19:35,794 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,794 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:2.07 (3.2%) stddev-sans-first:2.00 06:19:35 INFO - 2016-01-25 06:19:35,794 DEBUG : BROWSER_OUTPUT: Values: 68.0 63.0 64.0 66.0 65.0 65.0 64.0 70.0 65.0 66.0 06:19:35 INFO - 2016-01-25 06:19:35,794 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:19:35 INFO - 2016-01-25 06:19:35,794 DEBUG : BROWSER_OUTPUT: 06:19:36 INFO - 2016-01-25 06:19:36,601 INFO : Browser exited with error code: 0 06:19:36 INFO - 2016-01-25 06:19:36,652 INFO : Completed test kraken (00:00:58) 06:19:36 INFO - 2016-01-25 06:19:36,652 INFO : Starting test v8_7 06:19:36 INFO - 2016-01-25 06:19:36,652 DEBUG : operating with platform_type : linux_ 06:19:36 INFO - 2016-01-25 06:19:36,652 INFO : Initialising browser for v8_7 test... 06:19:36 INFO - 2016-01-25 06:19:36,658 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkN7DZO/profile http://localhost:48995/getInfo.html 06:19:40 INFO - 2016-01-25 06:19:40,417 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:19:40 INFO - 2016-01-25 06:19:40,417 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:19:40 INFO - 2016-01-25 06:19:40,417 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:19:40 INFO - 2016-01-25 06:19:40,417 DEBUG : BROWSER_OUTPUT: __metrics 06:19:40 INFO - 2016-01-25 06:19:40,607 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:19:41 INFO - 2016-01-25 06:19:41,580 INFO : Browser initialized. 06:19:41 INFO - 2016-01-25 06:19:41,580 INFO : Running cycle 1/1 for v8_7 test... 06:19:41 INFO - 2016-01-25 06:19:41,580 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkN7DZO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:19:53 INFO - 2016-01-25 06:19:53,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 136265728 06:19:53 INFO - 2016-01-25 06:19:53,420 DEBUG : BROWSER_OUTPUT: 06:20:14 INFO - 2016-01-25 06:20:14,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/v8_7/run.html (next: http://localhost:48995/tests/v8_7/run.html) 06:20:15 INFO - 2016-01-25 06:20:15,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 426614784 06:20:15 INFO - 2016-01-25 06:20:15,094 DEBUG : BROWSER_OUTPUT: 06:20:15 INFO - 2016-01-25 06:20:15,094 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:20:15 INFO - 2016-01-25 06:20:15,094 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:20:15 INFO - 2016-01-25 06:20:15,094 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:20:15 INFO - 2016-01-25 06:20:15,094 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:20:15 INFO - 2016-01-25 06:20:15,094 DEBUG : BROWSER_OUTPUT: |0;Richards;165.15276630883568 06:20:15 INFO - 2016-01-25 06:20:15,094 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.3402669440111 06:20:15 INFO - 2016-01-25 06:20:15,095 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 06:20:15 INFO - 2016-01-25 06:20:15,095 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5138.461538461538 06:20:15 INFO - 2016-01-25 06:20:15,095 DEBUG : BROWSER_OUTPUT: |4;RayTrace;944.2870632672333 06:20:15 INFO - 2016-01-25 06:20:15,095 DEBUG : BROWSER_OUTPUT: |5;Earley;559.9104143337066 06:20:15 INFO - 2016-01-25 06:20:15,095 DEBUG : BROWSER_OUTPUT: |6;Boyer;10934.782608695652 06:20:15 INFO - 2016-01-25 06:20:15,095 DEBUG : BROWSER_OUTPUT: |7;RegExp;24285.714285714286 06:20:15 INFO - 2016-01-25 06:20:15,095 DEBUG : BROWSER_OUTPUT: |8;Splay;528.5412262156448 06:20:15 INFO - 2016-01-25 06:20:15,095 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 06:20:15 INFO - 2016-01-25 06:20:15,096 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:20:15 INFO - 2016-01-25 06:20:15,096 DEBUG : BROWSER_OUTPUT: __startTimestamp1453731615092__endTimestamp 06:20:15 INFO - 2016-01-25 06:20:15,096 DEBUG : BROWSER_OUTPUT: 06:20:15 INFO - 2016-01-25 06:20:15,096 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:20:15 INFO - 2016-01-25 06:20:15,096 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:20:15 INFO - 2016-01-25 06:20:15,096 DEBUG : BROWSER_OUTPUT: 06:20:15 INFO - 2016-01-25 06:20:15,096 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.15 Median:165.15 stddev:0.00 (0.0%) 06:20:15 INFO - 2016-01-25 06:20:15,096 DEBUG : BROWSER_OUTPUT: Values: 165.2 06:20:15 INFO - 2016-01-25 06:20:15,097 DEBUG : BROWSER_OUTPUT: 06:20:15 INFO - 2016-01-25 06:20:15,097 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.34 Median:173.34 stddev:0.00 (0.0%) 06:20:15 INFO - 2016-01-25 06:20:15,097 DEBUG : BROWSER_OUTPUT: Values: 173.3 06:20:15 INFO - 2016-01-25 06:20:15,097 DEBUG : BROWSER_OUTPUT: 06:20:15 INFO - 2016-01-25 06:20:15,097 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 06:20:15 INFO - 2016-01-25 06:20:15,097 DEBUG : BROWSER_OUTPUT: Values: 278.6 06:20:15 INFO - 2016-01-25 06:20:15,098 DEBUG : BROWSER_OUTPUT: 06:20:15 INFO - 2016-01-25 06:20:15,098 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 06:20:15 INFO - 2016-01-25 06:20:15,098 DEBUG : BROWSER_OUTPUT: Values: 5138.5 06:20:15 INFO - 2016-01-25 06:20:15,098 DEBUG : BROWSER_OUTPUT: 06:20:15 INFO - 2016-01-25 06:20:15,098 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:944.29 Median:944.29 stddev:0.00 (0.0%) 06:20:15 INFO - 2016-01-25 06:20:15,098 DEBUG : BROWSER_OUTPUT: Values: 944.3 06:20:15 INFO - 2016-01-25 06:20:15,099 DEBUG : BROWSER_OUTPUT: 06:20:15 INFO - 2016-01-25 06:20:15,099 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:559.91 Median:559.91 stddev:0.00 (0.0%) 06:20:15 INFO - 2016-01-25 06:20:15,099 DEBUG : BROWSER_OUTPUT: Values: 559.9 06:20:15 INFO - 2016-01-25 06:20:15,099 DEBUG : BROWSER_OUTPUT: 06:20:15 INFO - 2016-01-25 06:20:15,099 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10934.78 Median:10934.78 stddev:0.00 (0.0%) 06:20:15 INFO - 2016-01-25 06:20:15,099 DEBUG : BROWSER_OUTPUT: Values: 10934.8 06:20:15 INFO - 2016-01-25 06:20:15,099 DEBUG : BROWSER_OUTPUT: 06:20:15 INFO - 2016-01-25 06:20:15,099 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24285.71 Median:24285.71 stddev:0.00 (0.0%) 06:20:15 INFO - 2016-01-25 06:20:15,100 DEBUG : BROWSER_OUTPUT: Values: 24285.7 06:20:15 INFO - 2016-01-25 06:20:15,100 DEBUG : BROWSER_OUTPUT: 06:20:15 INFO - 2016-01-25 06:20:15,100 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:528.54 Median:528.54 stddev:0.00 (0.0%) 06:20:15 INFO - 2016-01-25 06:20:15,100 DEBUG : BROWSER_OUTPUT: Values: 528.5 06:20:15 INFO - 2016-01-25 06:20:15,100 DEBUG : BROWSER_OUTPUT: 06:20:15 INFO - 2016-01-25 06:20:15,100 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 06:20:15 INFO - 2016-01-25 06:20:15,100 DEBUG : BROWSER_OUTPUT: Values: 4822.1 06:20:15 INFO - 2016-01-25 06:20:15,101 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:20:15 INFO - 2016-01-25 06:20:15,101 DEBUG : BROWSER_OUTPUT: 06:20:15 INFO - 2016-01-25 06:20:15,925 INFO : Browser exited with error code: 0 06:20:15 INFO - 2016-01-25 06:20:15,944 INFO : Completed test v8_7 (00:00:39) 06:20:16 INFO - 2016-01-25 06:20:16,097 INFO : Completed test suite (00:20:08) 06:20:16 INFO - 2016-01-25 06:20:16,098 DEBUG : Working with test: dromaeo_css 06:20:16 INFO - 2016-01-25 06:20:16,098 DEBUG : Generating results file: dromaeo_css 06:20:16 INFO - 2016-01-25 06:20:16,099 DEBUG : Working with test: kraken 06:20:16 INFO - 2016-01-25 06:20:16,099 DEBUG : Generating results file: kraken 06:20:16 INFO - 2016-01-25 06:20:16,099 INFO : javascript benchmark 06:20:16 INFO - 2016-01-25 06:20:16,099 DEBUG : Working with test: v8_7 06:20:16 INFO - 2016-01-25 06:20:16,100 DEBUG : Generating results file: v8_7 06:20:16 INFO - 2016-01-25 06:20:16,100 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:20:16 INFO - 2016-01-25 06:20:16,263 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 06:20:16 INFO - 2016-01-25 06:20:16,263 DEBUG : process_Request line: dromaeo_css 7246.15 graph.html#tests=[[72,52,35]] 06:20:16 INFO - 2016-01-25 06:20:16,263 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:20:16 INFO - 2016-01-25 06:20:16,315 DEBUG : process_Request line: kraken 1473.10 graph.html#tests=[[232,52,35]] 06:20:16 INFO - 2016-01-25 06:20:16,315 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:20:16 INFO - 2016-01-25 06:20:16,439 DEBUG : process_Request line: v8_7 23055.34 graph.html#tests=[[230,52,35]] 06:20:16 INFO - 2016-01-25 06:20:16,441 INFO : javascript benchmark 06:20:16 INFO - 2016-01-25 06:20:16,444 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3255.2024753935284, 3322.88369907053, 3345.297487527619, 3348.732101431884, 3365.74756893233, 5429.918551221735, 5465.945340546593, 5478.698671573067, 5490.533304669098, 5503.587230957674, 5484.8354549363585, 5512.614117011811, 5519.503244707976, 5520.475554822296, 5539.335279766424, 4873.8781530461665, 4986.626003049786, 4994.150994330972, 5047.64666473347, 5088.643794934356, 5000.399952005764, 5059.974700126494, 5068.4171320298265, 5080.034793389244, 5080.034793389263, 4906.607471402279, 4936.654434189608, 5005.0990821652085, 5022.246663000543, 5075.720835354073, 4998.025385049917, 5035.345405097314, 5044.319016932741, 5044.965782014679, 5069.721165335905, 4977.527134922177, 4987.650864439491, 4993.525615066563, 5010.674306170087, 5048.091343558158, 5035.169197082477, 5117.130087885032, 5143.12566863634, 5264.131418315973, 5301.0, 5806.59353845231, 5857.4435428634215, 5858.326292476378, 5858.677772722499, 5859.4433528815125, 5720.570957178228, 5856.76572937082, 5867.11993201019, 5868.853278668024, 5891.882162356729, 5365.195220716884, 5415.566754659618, 5452.100403433389, 5456.972715136439, 5488.643238189505, 5983.1623572699855, 6003.039513677878, 6006.189164462741, 6009.338972712998, 6011.158437818709, 5659.547236221092, 5760.193572899798, 5816.069428891357, 5819.156222347736, 5821.505172060422, 5712.457316554921, 5796.1595568642315, 5802.622829516068, 5803.47768700819, 5828.6211396259105, 5862.648241105548, 5876.559258055578, 5909.497692696169, 5910.231669882888, 5914.852128696817, 5609.046462101453, 5715.828525144252, 5836.737346819404, 5908.911366329508, 5909.970450147722, 4576.885577860514, 4587.2201725706045, 4588.587027167571, 4608.976955115203, 4610.631149508032, 4099.815508302134, 4111.527174374925, 4116.506019277646, 4117.3618089196225, 4144.316187828975, 5352.411234764173, 5488.259085023471, 5513.5037846594, 5653.80211692597, 5679.630823996427, 5919.4080591940465, 5922.49658779, 5955.196048533393, 5961.493273071751, 5964.7315870785915, 5645.2096706461125, 5653.830385088454, 5654.886902262014, 5660.518855897295, 5660.632058916157, 5022.397312322471, 5110.61670374716, 5126.820561280338, 5180.663256888365, 5223.947760522422, 6051.0, 6060.090986351995, 6065.75736970525, 6070.3929607038945, 6070.575059745864, 5900.793472228452, 5903.881922361528, 5905.793297234576, 5906.881862362815, 5907.0, 5839.737211825393, 5875.059990401515, 5949.1076338549565, 5983.850403739942, 6013.5189184865985, 5800.4489573490455, 5807.419258074159, 5857.560682948711, 5864.824055278348, 5889.676067816311, 5611.6352437091455, 5861.9413805861395, 5904.498117659875, 5918.319393269657, 5924.644521328734, 5590.496855283044, 5675.404082571271, 5689.089745640677, 5691.060974939089, 5713.400092990176, 5775.711214439345, 5798.884022319446, 5801.680907550125, 5804.535637148933, 5809.24479817621, 5494.230807686847, 5548.861278467909, 5705.486506214461, 5751.568632352507, 5759.0, 5682.147677848356, 5763.0, 5765.019946609003, 5784.305883294031, 5801.042827933513, 5620.437956204347, 5669.376368599534, 5672.773089076556, 5673.716314184192, 5713.028785106459], "unit": "ms", "name": "dojo.html", "value": 5420.679437762436}, {"lowerIsBetter": false, "replicates": [611.4771870051106, 617.287033476335, 637.2798737426708, 644.0853987337978, 675.9290274521176, 32207.0, 32961.0, 41566.16867662645, 42003.15993680125, 42136.0, 46116.538834611645, 46519.53480465194, 46584.0, 46613.30080048802, 46636.53363466365, 8046.678132874678, 8995.235404990584, 9148.8627670585, 9157.175854173123, 9157.908420915772, 8261.297789687884, 10849.837252441219, 11114.05530529906, 11124.666260012173, 11126.777464450706, 10787.78424431511, 10903.454827258645, 10905.672829815117, 10913.563457461692, 10921.235513514057, 10723.731906702316, 10794.02853743163, 10805.13558915285, 10837.133029357632, 10856.34861908284, 10516.158707303397, 10614.469276536141, 10637.787244255149, 10638.57445702171, 10642.787144257149, 43609.781951090044, 44087.11825763499, 44155.337669934976, 44177.0, 44181.11637767259, 3826.502554667903, 3831.65515103642, 4157.459530261077, 4262.744235345889, 4348.065165989327, 31844.681553184404, 32256.677433225603, 32365.0, 32517.837410812794, 32641.67358326434, 4301.526832048472, 4360.869173924787, 4369.410129632491, 4370.56517640053, 4411.044600117929, 295153.0, 295320.0, 295532.0, 295603.0, 296254.51872740715, 57567.0, 65467.67266163639, 65727.67136164289, 65745.0, 65866.67066664636, 51039.74480127576, 51266.23100653493, 51277.0, 51300.74349628302, 75864.0, 18115.63768724618, 18132.274709011494, 18204.726929096076, 18299.0, 18357.3574924877, 14104.294785260901, 14179.85820141806, 14182.290885455686, 14186.858131418554, 14189.432422702976, 18885.62228755417, 19277.0, 21628.675569866464, 22076.668849967264, 22239.777602224094, 7717.807054823675, 7983.72056978003, 7991.8012298155745, 7998.160193179632, 8146.470479418819, 1020.2246292817364, 1073.6027669762238, 1082.718493191776, 1089.1559041742555, 1126.796982610739, 30142.0, 30374.696253037186, 30484.39031219363, 30654.69345306563, 30951.0, 1110.938898360598, 1140.589387820384, 1146.7190538317998, 1178.8682864450052, 1202.0804084875078, 13721.656958575915, 14262.643433914234, 14722.852771472362, 14744.778828317583, 15497.302621382065, 364907.0, 365877.0, 366222.0, 366570.0, 366744.0, 55795.72102139463, 56021.0, 56077.43922560804, 56107.719461402434, 56164.157537636966, 1380.3719307714966, 1391.923444210578, 1448.9492867749577, 1484.7104814561058, 1505.902116362433, 26583.46833063289, 26926.0, 27198.456030879668, 27319.590206146528, 29956.850215749655, 46374.76812615915, 46426.53573464357, 46512.06975860396, 46590.767046164554, 49275.0, 186853.0, 326466.0, 327488.0, 327562.0, 328571.0, 33105.50341744828, 33633.0, 33734.0, 33748.15629609279, 33750.15624609405, 43963.0, 45416.54583454123, 47354.289685654054, 47684.284735729685, 48717.75641121772, 35205.29589408249, 38287.42568861525, 38802.223955521295, 39021.0, 39932.401013984236, 38426.61573384342, 38981.02547436337, 39082.413763792996, 39821.80089099536, 40439.39340909947, 35124.0, 35414.114647134025, 40294.79852600718, 40481.0, 41118.79440602778, 29040.273993149494, 31313.8434307827, 32051.35897282088, 32105.0, 32379.35241295114, 26314.473710526065, 27057.59413608837, 27103.1869043929, 27237.727622724313, 29204.26989325284], "unit": "ms", "name": "ext.html", "value": 20056.924042967705}, {"lowerIsBetter": false, "replicates": [385.7781775479098, 388.5104767992329, 393.9369700847865, 396.2036307022884, 399.3311203733745, 15048.804246267599, 15894.284757185926, 16778.580535486602, 18089.27642894284, 18100.90949545252, 17795.555111122227, 17914.64170716585, 18128.72806907894, 18308.908455457706, 18358.26566937321, 6046.30467496237, 6158.84602884927, 6162.537809664271, 6193.1948846649875, 6196.070589411579, 4536.047430039679, 4664.556867097637, 6103.115048317991, 6738.561993470434, 6943.027976083353, 5469.124940009599, 6871.312868713114, 6886.483513736464, 6926.203486599055, 6929.064576282188, 5630.605857589971, 5672.631278966875, 5692.829215123553, 5698.772049118051, 5700.629459085146, 5459.290292262021, 5498.697571633558, 5501.202325662796, 5501.504864562208, 5602.0, 14249.358778854976, 14385.136891786422, 14481.045058917121, 19599.804001960085, 22777.43056423586, 2321.593721098801, 2336.6144586143264, 2344.765523447659, 2346.9295921122393, 2362.598358279097, 10393.48032598367, 10547.894521054845, 10732.517036733365, 10743.086837618812, 12708.555200568027, 1985.205917632944, 2005.8696184748092, 2031.2179810772811, 2065.5868826234814, 2080.3966849613594, 64926.675366623334, 67003.66498167478, 67638.32361676419, 67663.66168169177, 69397.99999999949, 11248.550057997752, 11250.49372778227, 11258.268212566158, 11263.549458021587, 11353.886461135447, 14276.643083922985, 15047.699046019019, 15049.473268435551, 15065.397384104514, 15070.321835517429, 8294.170582941657, 8472.66109355619, 8630.093840146694, 8658.653653853775, 8688.695895643748, 8565.14348565151, 8577.785555361166, 8599.14008599135, 8632.870506942401, 8646.135386461303, 4564.2240819060835, 4763.285507173882, 4825.0, 4832.44426890905, 4854.150523658416, 1724.2992402978987, 1916.57835276239, 1956.814102660245, 1958.0601311370622, 1978.7427634407723, 854.4616891358529, 1000.1698590170141, 1026.7895081508273, 1061.4109169411051, 1064.882862885082, 14397.496087636882, 16173.67652646964, 17315.134243287786, 17599.384021559184, 17963.550911227325, 984.8571957066185, 992.7766252593109, 996.14829320931, 1017.308230403318, 1031.3141760729031, 9075.0, 9555.331126821056, 9973.202143828476, 10762.73093172677, 10816.729581760519, 455990.0, 456205.0, 458962.0, 477942.0, 663602.0, 45230.773846130556, 45302.54697452983, 75714.62142689251, 79932.0, 80552.0, 524.6537285391623, 534.4762133109497, 537.935447746273, 539.0620320642133, 541.1449909143544, 11128.165387596124, 11207.271527350696, 11316.15128865355, 11509.884901150881, 11562.364069976233, 37330.44004339883, 38699.6130038696, 38859.0, 39323.213535729694, 39695.603043970346, 51538.48461515337, 51636.741816290676, 51864.740676297886, 51960.0, 57425.42574574201, 10278.33190842593, 10335.121514671036, 10444.634437794944, 10533.473326333806, 10547.525361358605, 12342.81485777696, 12431.254124752544, 12502.562410315595, 12598.118131730691, 18401.72397414013, 15313.6171595711, 15591.532254032398, 15731.0, 15837.604059898134, 16189.433369831999, 11865.466054027416, 15127.092374457568, 15264.0, 15709.528714138594, 15715.764263536284, 15118.773218401513, 15356.539303820904, 15439.459618913284, 15677.451289204822, 15793.289301981667, 10164.695059148238, 10261.9486902565, 10288.537015834456, 10351.223658225814, 10427.582896684351, 14111.2944352784, 15039.774403384177, 15151.318190681666, 15338.38646454174, 15401.76897346563], "unit": "ms", "name": "jquery.html", "value": 9094.501660009975}, {"lowerIsBetter": false, "replicates": [1585.1598652714065, 1592.3312208872273, 1661.5929097371145, 1808.6925222712139, 1845.8800177988435, 7123.501354905159, 8085.636146373413, 8191.098979112293, 8202.261796438319, 8206.179382061791, 7871.685132594704, 8028.277455029046, 8030.0, 8031.678732850693, 8032.317253033484, 2014.0936578539643, 2042.0300357330223, 2044.1516770540209, 2191.7808219178073, 2227.2984010036866, 2022.0, 2267.059170444272, 2344.3201471573225, 2347.4835536182013, 2347.929562113139, 2237.742659594151, 2276.931692049241, 2295.9897645036212, 2329.7087864017, 2337.567550003246, 2296.59809533331, 2314.1206341590173, 2337.2520793346134, 2341.9648705269433, 2342.543204075206, 2298.10373954158, 2315.560043591729, 2321.419645088728, 2322.303309007308, 2324.0, 8051.154628763954, 8151.266386025227, 8153.30696890765, 8156.143604921516, 8158.388120890957, 4716.551927566876, 4860.781264843055, 4882.877928051792, 4914.3611330527165, 4917.704937703749, 3000.234940090285, 3055.847207639609, 3056.7401770849506, 3059.8776048958016, 3116.9220769480717, 966.3187452845727, 968.1045033344199, 985.960561577536, 991.7619771254919, 992.3599278465349, 11333.603323883706, 11359.091272698164, 11381.032612227971, 11384.146189035773, 11384.487698053608, 4238.766867822299, 4261.296886013835, 4297.59172878576, 4311.2239796836875, 4314.029343397773, 9762.853557196648, 9763.853542196874, 9795.265355098254, 9796.65711700087, 9805.901940980499, 4832.057748738962, 4832.44426890912, 4839.733814640229, 4854.975725121351, 4872.731999739977, 4403.075354175595, 4445.799939002753, 4453.22068637987, 4461.375407442961, 4465.196264672325, 3483.3555792178527, 3486.442169252907, 3562.7327950403824, 3735.5517337919623, 3854.903627409281, 1165.248414772467, 1173.565780661161, 1181.1023622047305, 1189.5182451107316, 1202.2425871700773, 1124.291696231369, 1152.3892337061204, 1154.8267759836092, 1361.2649169448584, 1424.266502751084, 7808.648610812527, 7850.764477065697, 7913.485623434458, 7935.761927142195, 7941.285284324438, 1149.557420393138, 1160.7678464307003, 1169.473736818435, 1171.5313874450117, 1188.4830098907003, 6277.905831412532, 6307.432331090224, 6341.651209183447, 6356.936430635635, 6365.0, 9598.95200523993, 9619.27855410847, 9724.61101555944, 9729.075737804897, 9745.220382369393, 9485.762855928519, 9684.95157524208, 9687.66093186735, 9688.176504997013, 9699.321047526606, 7102.467314951399, 7134.785956421316, 7150.642467876585, 7208.171060328129, 7220.67506962188, 7743.574103424366, 7855.5286682799215, 7893.250141236574, 7946.364290856602, 7950.801229969297, 8590.527520986156, 8740.781480462785, 8784.604692788967, 8791.0, 8992.235659968976, 8937.59780809878, 8992.325575581988, 9013.774655633399, 9014.053524379846, 9388.014258503032, 7545.886811697719, 7636.0, 7637.5035622684345, 7637.656305466378, 7643.388528917784, 7038.436925045881, 7640.426967977312, 7832.373410127062, 7904.762857114296, 8117.878231826646, 7560.9621951889885, 7565.697372105275, 7609.429292803173, 7617.0, 7659.195784442776, 7345.522541034816, 7354.117505899327, 7388.039554857834, 7484.139323977813, 7489.625518724151, 7367.926320736724, 7401.48189626721, 7512.474126811071, 7523.285287897641, 7531.548107113591, 6913.827154321182, 6934.098567186234, 6956.234814170539, 6965.442764578923, 6969.059177011039, 6889.483288753263, 6892.379685828299, 6926.376626103674, 6995.405390541658, 7037.472189585904], "unit": "ms", "name": "mootools.html", "value": 4666.448216467755}, {"lowerIsBetter": false, "replicates": [354.5355584184718, 354.60992907801415, 359.3513707757497, 360.67178867230825, 365.71474250084924, 6081.0, 6106.389361063897, 6109.694515274241, 6115.449609535141, 6149.569530132892, 6006.369331220225, 6008.699565021753, 6019.277686677594, 6022.8795424091495, 6027.517798576115, 4576.977115114437, 4665.393498845146, 4682.953170468303, 4690.132325519773, 4694.037722266944, 4636.09596128755, 4669.976650116745, 4683.672142949995, 4683.8360657377, 4688.695234809744, 4632.0967411354795, 4643.303504474339, 4645.651576131787, 4646.303054541812, 4650.395448591678, 4415.8233670653135, 4507.143642707892, 4548.840790572314, 4604.447466304032, 4646.047560250141, 4066.207089617526, 4076.7553946763287, 4082.2447847148374, 4095.262852686515, 4114.012636967136, 5539.8892022159735, 5661.46216109469, 5725.770969161229, 5739.827805165852, 5765.394633563457, 5320.840374788762, 5414.810481633163, 5428.864278393072, 5438.782448702047, 5445.074337362658, 6373.521985851034, 6375.0, 6376.107344971708, 6377.58545694533, 6379.36206379363, 4559.658025648089, 4561.087782443525, 4563.634909207255, 4565.018521017964, 4569.314602809572, 6459.870802583969, 6585.979173228109, 6615.669216539202, 6649.803035453617, 6667.199936007662, 4545.272756358967, 4587.977060114678, 4613.446386433649, 4614.953850461452, 4615.100055489214, 4665.3934988451965, 4674.579287864109, 4676.298555216745, 4676.789544470507, 4679.695819771704, 5273.789048438096, 5373.892522149613, 5378.91931621026, 5379.246905433242, 5380.91928621071, 6424.00427933671, 6427.132337134521, 6428.550001499943, 6432.0, 6435.22777266731, 1634.5995231168201, 1645.2020769926576, 1654.8179700232965, 1659.278213976924, 1660.0703605980689, 1105.657246253664, 1109.4730003248553, 1113.5879724501985, 1133.6032388664066, 1133.6259034518755, 6260.780872669526, 6271.874562508816, 6273.525721455454, 6278.46633036197, 6279.686015699197, 6600.0, 6627.768028119089, 6643.069970204176, 6649.268580456146, 6655.168103987002, 6115.082737589309, 6276.623402595859, 6277.623342599459, 6278.843028924222, 6317.14718513004, 3589.174489867345, 3605.837737301828, 3608.530890984208, 3610.6028336882923, 3611.6207798180812, 6788.321167883172, 6793.966030169916, 6806.353396427331, 6811.897821532681, 6814.8637027260165, 6621.106150669598, 6710.127683401224, 6749.021391898147, 6773.390394864486, 6852.5203235774015, 6830.248672646005, 6848.657567121624, 6851.246362899978, 6851.828704282433, 6866.485013623998, 6522.510811689048, 6631.867362652816, 6670.39966403026, 6673.466122710074, 6679.532432729662, 6574.0796288520605, 6575.506836987341, 6576.506761992774, 6576.671166441754, 6590.209174899042, 6843.692033858389, 6846.760363387258, 6854.691538880663, 6855.0, 6861.519693621399, 4637.0262244928945, 4646.349511068385, 4649.418822647169, 4649.674522783373, 4653.790579423866, 6524.347565243438, 6625.503087268377, 6653.700583473658, 6663.833404164935, 6667.066610674607, 6470.126532918184, 6485.967570162119, 6486.870262594627, 6487.313298542507, 6489.7404103835315, 6367.52243581724, 6471.352864713491, 6476.579022363531, 6482.805515834532, 6484.0, 6372.968135159294, 6382.32985536512, 6383.680815959091, 6384.010478375859, 6393.200849893763, 6502.544821862613, 6508.902366464602, 6510.316416776171, 6515.934840651723, 6519.282878883224, 6253.280872699515, 6364.4908407326375, 6368.52236082305, 6374.840628984127, 6381.521385895983], "unit": "ms", "name": "prototype.html", "value": 4878.922967052468}, {"lowerIsBetter": false, "replicates": [846.8475674378609, 878.7319867440428, 927.6614035876903, 941.4586612697698, 946.7396465971859, 12650.936745316272, 13069.411876465558, 13072.477100915963, 13084.411201495932, 13125.0, 12548.623541293753, 13299.401526931288, 13312.534061307857, 13324.733505329888, 13341.399637016333, 760.7185341423681, 769.8768197088467, 909.8089401225751, 919.645936314517, 924.9676261330854, 921.0651189043126, 929.1544694328163, 929.962801487943, 931.2456909902967, 931.3434029009566, 974.512743628186, 977.3451787302524, 979.1921664626676, 979.8236317462854, 979.9265055120859, 792.809725665839, 804.1034246814818, 951.4861974533778, 959.5729900194416, 960.8991055939096, 708.3766285668579, 709.2092317066486, 710.1229980973494, 712.8895021271659, 716.9318914703147, 13237.735245295136, 13313.0, 13367.06430549862, 13383.0, 13392.598222053257, 13009.934950325283, 13038.674033149153, 13148.53980110701, 13192.802107968388, 13243.139195952328, 10781.081375431904, 10854.0, 10875.83686244707, 11140.944295278552, 11419.48612312448, 3677.062349100962, 3705.6294370562996, 3715.7398982071268, 3744.6817020553012, 3768.2651882882847, 45056.09887802258, 45076.77461612704, 45319.32021019654, 45612.315815262795, 47143.29285060727, 10306.227032972558, 10419.94790026045, 10447.05976462122, 10467.371957682411, 10584.576616935236, 18263.63472730538, 18347.266109355478, 18352.908235458737, 18368.908155459136, 19383.903080484506, 7420.443466739908, 7436.405087593088, 7483.925160748323, 7626.656800443993, 7673.309402153833, 4425.446819147606, 4530.70550414222, 4545.204589196944, 4611.723296602215, 4657.0, 3215.42122417967, 3241.38413701396, 3241.9837900810817, 3252.3495300939435, 3257.8371081445835, 565.2482198675751, 565.3470241870646, 568.556525909791, 570.0309473894396, 583.6498101139367, 597.9760809567656, 612.859042420237, 628.4092952624518, 634.9873002539923, 651.7621068310033, 7773.5724535149975, 7811.68753249875, 7926.128125906146, 7962.920370796333, 8119.309858661962, 486.3555788580075, 578.6643746626946, 592.7125344208056, 618.6411881108946, 628.0735914526038, 3914.373700207953, 3966.464527288837, 4015.738976966488, 4029.7783621901076, 4122.361034039729, 57784.0, 58136.127958080666, 59114.70442647759, 59574.0, 59801.40198597958, 46771.5322846774, 47841.76079119582, 50659.49340506621, 50682.49317506778, 51593.742031290356, 46112.5388746115, 46585.30122048172, 46789.0, 47945.04109917852, 48794.512054879, 8944.105589441004, 8946.463212207289, 9005.0, 9050.637974480947, 9151.908480915106, 36049.197540123416, 36331.0, 37093.443598345504, 37167.0, 37478.81260593679, 41999.0, 46264.768676156404, 46400.8399790008, 46543.44011079423, 47111.528884710715, 9921.355111917703, 10067.647632332833, 10136.0, 10604.0, 10795.838062429228, 12125.575604853788, 12206.389680516117, 12237.877621223673, 12404.81392779091, 12463.688407789878, 10493.685189444328, 10631.219337795674, 10652.89347106519, 10778.784424311312, 10803.513841876977, 11074.667759967213, 11259.605913792979, 11296.152788541056, 11305.26515776472, 11450.141239406912, 9381.859272110787, 10922.12622990143, 11017.063549598053, 11348.716282093013, 11444.313341199555, 9903.356281841658, 10039.146672532917, 10250.846237306298, 10275.434851083262, 10396.532156052845, 9621.08599683029, 9756.0, 9932.503374831374, 9957.950210249192, 10017.14854237398], "unit": "ms", "name": "yui.html", "value": 6429.812455341175}], "name": "dromaeo_css", "value": 7246.153595016209}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 109.0, 103.0, 108.0, 109.0, 109.0, 99.0, 109.0, 109.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.0}, {"lowerIsBetter": true, "replicates": [143.0, 122.0, 154.0, 164.0, 122.0, 145.0, 155.0, 121.0, 158.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.6}, {"lowerIsBetter": true, "replicates": [159.0, 159.0, 161.0, 160.0, 160.0, 158.0, 158.0, 161.0, 159.0, 158.0], "unit": "ms", "name": "audio-dft", "value": 159.3}, {"lowerIsBetter": true, "replicates": [77.0, 71.0, 70.0, 154.0, 72.0, 70.0, 73.0, 73.0, 146.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 87.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 137.0, 92.0, 92.0, 93.0, 145.0, 93.0, 93.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 58.0, 56.0, 56.0, 55.0, 56.0, 56.0, 55.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.8}, {"lowerIsBetter": true, "replicates": [77.0, 83.0, 80.0, 79.0, 79.0, 79.0, 80.0, 82.0, 81.0, 79.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.9}, {"lowerIsBetter": true, "replicates": [114.0, 115.0, 116.0, 111.0, 108.0, 119.0, 109.0, 117.0, 109.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 113.6}, {"lowerIsBetter": true, "replicates": [134.0, 149.0, 141.0, 143.0, 155.0, 134.0, 132.0, 141.0, 142.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.5}, {"lowerIsBetter": true, "replicates": [68.0, 63.0, 64.0, 66.0, 65.0, 65.0, 64.0, 70.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1473.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.15276630883568], "unit": "score", "name": "Richards", "value": 213.75361000000004}, {"lowerIsBetter": false, "replicates": [173.3402669440111], "unit": "score", "name": "DeltaBlue", "value": 381.43474200000014}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [944.2870632672333], "unit": "score", "name": "RayTrace", "value": 783.6483509999999}, {"lowerIsBetter": false, "replicates": [559.9104143337066], "unit": "score", "name": "Earley", "value": 1190.3029180000005}, {"lowerIsBetter": false, "replicates": [10934.782608695652], "unit": "score", "name": "Boyer", "value": 60.94890258449304}, {"lowerIsBetter": false, "replicates": [24285.714285714286], "unit": "score", "name": "RegExp", "value": 37.511147058823504}, {"lowerIsBetter": false, "replicates": [528.5412262156448], "unit": "score", "name": "Splay", "value": 154.18097200000005}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23055.339610084488}]} 06:20:16 INFO - RETURN: dromaeo_css: 7246.15 06:20:16 INFO - RETURN: kraken: 1473.10 06:20:16 INFO - RETURN: v8_7: 23055.34 06:20:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23055.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1473.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7246.15"}}} 06:20:16 INFO - Return code: 0 06:20:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:20:16 INFO - # TBPL SUCCESS # 06:20:16 INFO - Running post-action listener: _resource_record_post_action 06:20:16 INFO - Running post-run listener: _resource_record_post_run 06:20:17 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 233472; Write bytes: 270659584; Read time: 76; Write time: 137924 06:20:17 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 6823936; Read time: 0; Write time: 1312 06:20:17 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 233472; Write bytes: 263835648; Read time: 76; Write time: 136612 06:20:17 INFO - Running post-run listener: _upload_blobber_files 06:20:17 INFO - Blob upload gear active. 06:20:17 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:20:17 INFO - Copying logs to upload dir... 06:20:17 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.114177 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-01-25 06:20:17.652110) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 06:20:17.655818) ========= 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=82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009933 build_url: 'https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/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-25 06:20:17.707808) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 06:20:17.708205) ========= 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=82e07478c745e68b1fe4678a000001bc-1453730033.746923-66781756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 06:20:17.758329) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 06:20:17.758685) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 06:20:17.759029) ========= ========= Total master_lag: 0.28 =========