builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1453693572.57 results: success (0) buildid: 20160124172707 builduid: f3a52615c80b4c99a0538cb0cb35429e revision: 4128f782d6449f625dd8e33e84e9b1ef7af98b16 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:12.573099) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:12.573539) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:12.573835) ========= 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=232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005603 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.57 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:13.150799) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:13.151066) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:13.227936) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:13.228200) ========= 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=232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.038566 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:13.277419) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:13.277685) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:13.278098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:13.278423) ========= 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=232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-24 19:46:13-- 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% 35.6M=0s 2016-01-24 19:46:13 (35.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.202456 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:13.496284) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:13.496608) ========= 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=232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.105643 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:13.619341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:13.619690) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4128f782d6449f625dd8e33e84e9b1ef7af98b16 --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 4128f782d6449f625dd8e33e84e9b1ef7af98b16 --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=232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-24 19:46:13,806 truncating revision to first 12 chars 2016-01-24 19:46:13,806 Setting DEBUG logging. 2016-01-24 19:46:13,806 attempt 1/10 2016-01-24 19:46:13,806 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4128f782d644?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-24 19:46:14,060 unpacking tar archive at: mozilla-aurora-4128f782d644/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532274 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:14.165750) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:14.166125) ========= echo 4128f782d6449f625dd8e33e84e9b1ef7af98b16 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4128f782d6449f625dd8e33e84e9b1ef7af98b16'] 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=232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4128f782d6449f625dd8e33e84e9b1ef7af98b16 program finished with exit code 0 elapsedTime=0.003312 script_repo_revision: '4128f782d6449f625dd8e33e84e9b1ef7af98b16' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:14.213975) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:14.214339) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 19:46:14.225595) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-24 19:46:14.225874) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:46:14 INFO - MultiFileLogger online at 20160124 19:46:14 in /builds/slave/test-pgo 19:46:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:46:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:46:14 INFO - {'append_to_log': False, 19:46:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:46:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:46:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:46:14 INFO - 'branch': 'Mozilla-Aurora', 19:46:14 INFO - 'buildbot_json_path': 'buildprops.json', 19:46:14 INFO - 'config_files': ('talos/linux_config.py',), 19:46:14 INFO - 'default_actions': ('clobber', 19:46:14 INFO - 'read-buildbot-config', 19:46:14 INFO - 'download-and-extract', 19:46:14 INFO - 'populate-webroot', 19:46:14 INFO - 'create-virtualenv', 19:46:14 INFO - 'install', 19:46:14 INFO - 'run-tests'), 19:46:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:46:14 INFO - 'download_minidump_stackwalk': True, 19:46:14 INFO - 'download_symbols': 'ondemand', 19:46:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:46:14 INFO - 'tooltool.py': '/tools/tooltool.py', 19:46:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:46:14 INFO - '/tools/misc-python/virtualenv.py')}, 19:46:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:46:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:46:14 INFO - 'installer_path': 'installer.exe', 19:46:14 INFO - 'log_level': 'info', 19:46:14 INFO - 'log_name': 'talos', 19:46:14 INFO - 'log_to_console': True, 19:46:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:46:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:46:14 INFO - 'opt_config_files': (), 19:46:14 INFO - 'pip_index': False, 19:46:14 INFO - 'sps_profile': False, 19:46:14 INFO - 'sps_profile_interval': 0, 19:46:14 INFO - 'suite': 'dromaeojs-e10s', 19:46:14 INFO - 'system_bits': '32', 19:46:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:46:14 INFO - 'title': 'talos-linux64-ix-025', 19:46:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:46:14 INFO - 'use_talos_json': True, 19:46:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:46:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:46:14 INFO - 'work_dir': 'build'} 19:46:14 INFO - ##### 19:46:14 INFO - ##### Running clobber step. 19:46:14 INFO - ##### 19:46:14 INFO - Running pre-action listener: _resource_record_pre_action 19:46:14 INFO - Running main action method: clobber 19:46:14 INFO - rmtree: /builds/slave/test-pgo/build 19:46:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:46:19 INFO - Running post-action listener: _resource_record_post_action 19:46:19 INFO - ##### 19:46:19 INFO - ##### Running read-buildbot-config step. 19:46:19 INFO - ##### 19:46:19 INFO - Running pre-action listener: _resource_record_pre_action 19:46:19 INFO - Running main action method: read_buildbot_config 19:46:19 INFO - Using buildbot properties: 19:46:19 INFO - { 19:46:19 INFO - "properties": { 19:46:19 INFO - "buildnumber": 80, 19:46:19 INFO - "product": "firefox", 19:46:19 INFO - "script_repo_revision": "production", 19:46:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:46:19 INFO - "repository": "", 19:46:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 19:46:19 INFO - "buildid": "20160124172707", 19:46:19 INFO - "slavename": "talos-linux64-ix-025", 19:46:19 INFO - "pgo_build": "True", 19:46:19 INFO - "basedir": "/builds/slave/test-pgo", 19:46:19 INFO - "project": "", 19:46:19 INFO - "platform": "ubuntu64_hw", 19:46:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:46:19 INFO - "slavebuilddir": "test", 19:46:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:46:19 INFO - "branch": "mozilla-aurora", 19:46:19 INFO - "repo_path": "releases/mozilla-aurora", 19:46:19 INFO - "stage_platform": "linux64-pgo", 19:46:19 INFO - "builduid": "f3a52615c80b4c99a0538cb0cb35429e", 19:46:19 INFO - "revision": "4128f782d6449f625dd8e33e84e9b1ef7af98b16" 19:46:19 INFO - }, 19:46:19 INFO - "sourcestamp": { 19:46:19 INFO - "repository": "", 19:46:19 INFO - "hasPatch": false, 19:46:19 INFO - "project": "", 19:46:19 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 19:46:19 INFO - "changes": [ 19:46:19 INFO - { 19:46:19 INFO - "category": null, 19:46:19 INFO - "files": [ 19:46:19 INFO - { 19:46:19 INFO - "url": null, 19:46:19 INFO - "name": "https://queue.taskcluster.net/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 19:46:19 INFO - } 19:46:19 INFO - ], 19:46:19 INFO - "repository": "", 19:46:19 INFO - "rev": "4128f782d6449f625dd8e33e84e9b1ef7af98b16", 19:46:19 INFO - "who": "wmccloskey@mozilla.com", 19:46:19 INFO - "when": 1453693520, 19:46:19 INFO - "number": 7508955, 19:46:19 INFO - "comments": "Bug 1240985 - Make sure to queue mDequeueOneTasks after cancellation (r=dvander,a=sylvestre)", 19:46:19 INFO - "project": "", 19:46:19 INFO - "at": "Sun 24 Jan 2016 19:45:20", 19:46:19 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 19:46:19 INFO - "revlink": "", 19:46:19 INFO - "properties": [ 19:46:19 INFO - [ 19:46:19 INFO - "buildid", 19:46:19 INFO - "20160124172707", 19:46:19 INFO - "Change" 19:46:19 INFO - ], 19:46:19 INFO - [ 19:46:19 INFO - "builduid", 19:46:19 INFO - "f3a52615c80b4c99a0538cb0cb35429e", 19:46:19 INFO - "Change" 19:46:19 INFO - ], 19:46:19 INFO - [ 19:46:19 INFO - "pgo_build", 19:46:19 INFO - "True", 19:46:19 INFO - "Change" 19:46:19 INFO - ] 19:46:19 INFO - ], 19:46:19 INFO - "revision": "4128f782d6449f625dd8e33e84e9b1ef7af98b16" 19:46:19 INFO - } 19:46:19 INFO - ], 19:46:19 INFO - "revision": "4128f782d6449f625dd8e33e84e9b1ef7af98b16" 19:46:19 INFO - } 19:46:19 INFO - } 19:46:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 19:46:19 INFO - Running post-action listener: _resource_record_post_action 19:46:19 INFO - ##### 19:46:19 INFO - ##### Running download-and-extract step. 19:46:19 INFO - ##### 19:46:19 INFO - Running pre-action listener: _resource_record_pre_action 19:46:19 INFO - Running main action method: download_and_extract 19:46:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:46:19 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')]} 19:46:19 INFO - https://queue.taskcluster.net/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:46:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/test_packages.json 19:46:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/test_packages.json 19:46:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:46:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:46:22 INFO - Downloaded 1302 bytes. 19:46:22 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:46:22 INFO - Using the following test package requirements: 19:46:22 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 19:46:22 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:46:22 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:46:22 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:46:22 INFO - u'jsshell-linux-x86_64.zip'], 19:46:22 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:46:22 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:46:22 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 19:46:22 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:46:22 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:46:22 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:46:22 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:46:22 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:46:22 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:46:22 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 19:46:22 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:46:22 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:46:22 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:46:22 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')]} 19:46:22 INFO - https://queue.taskcluster.net/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:46:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:46:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:46:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/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 19:46:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/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 19:46:31 INFO - Downloaded 23158923 bytes. 19:46:31 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 19:46:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:46:31 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 19:46:32 INFO - Return code: 0 19:46:32 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 19:46: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')]} 19:46:32 INFO - https://queue.taskcluster.net/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:46:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:46:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:46:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/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 19:46:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/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 19:46:34 INFO - Downloaded 23158923 bytes. 19:46:34 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 19:46:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:46:34 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 19:46:35 INFO - Return code: 0 19:46: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')]} 19:46:35 INFO - https://queue.taskcluster.net/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:46:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 19:46:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 19:46:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/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 19:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/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 19:46:36 INFO - Downloaded 11132038 bytes. 19:46:36 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 19:46:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 19:46:36 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 19:46:36 INFO - Return code: 0 19:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:36 INFO - https://queue.taskcluster.net/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:46:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 19:46:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 19:46:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/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 19:46:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hB2rnSxvSjG3WKkEsZgAQA/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 19:46:38 INFO - Downloaded 58023813 bytes. 19:46:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 19:46:38 INFO - mkdir: /builds/slave/test-pgo/properties 19:46:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:46:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:46:38 INFO - Contents: 19:46:38 INFO - build_url:https://queue.taskcluster.net/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 19:46:38 INFO - Running post-action listener: _resource_record_post_action 19:46:38 INFO - Running post-action listener: set_extra_try_arguments 19:46:38 INFO - ##### 19:46:38 INFO - ##### Running populate-webroot step. 19:46:38 INFO - ##### 19:46:38 INFO - Running pre-action listener: _resource_record_pre_action 19:46:38 INFO - Running main action method: populate_webroot 19:46:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:46:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:46:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:46:38 INFO - '--tppagecycles', 19:46:38 INFO - '7'], 19:46:38 INFO - 'tests': ['tsvgm']}}, 19:46:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:46:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:46:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:46:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:46:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:46:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:46:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:46:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:38 INFO - 'talos_options': ['--e10s'], 19:46:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:46:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:38 INFO - 'tests': ['damp', 'tps']}, 19:46:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:38 INFO - 'talos_options': ['--e10s'], 19:46:38 INFO - 'tests': ['damp', 'tps']}, 19:46:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:46:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:46:38 INFO - 'other': {'tests': ['a11yr', 19:46:38 INFO - 'ts_paint', 19:46:38 INFO - 'tpaint', 19:46:38 INFO - 'sessionrestore', 19:46:38 INFO - 'sessionrestore_no_auto_restore']}, 19:46:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:46:38 INFO - 'tests': ['a11yr', 19:46:38 INFO - 'ts_paint', 19:46:38 INFO - 'tpaint', 19:46:38 INFO - 'sessionrestore', 19:46:38 INFO - 'sessionrestore_no_auto_restore']}, 19:46:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:46:38 INFO - 'tests': ['a11yr', 19:46:38 INFO - 'ts_paint', 19:46:38 INFO - 'tpaint', 19:46:38 INFO - 'sessionrestore', 19:46:38 INFO - 'sessionrestore_no_auto_restore']}, 19:46:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:46:38 INFO - 'tests': ['a11yr', 19:46:38 INFO - 'ts_paint', 19:46:38 INFO - 'tpaint', 19:46:38 INFO - 'sessionrestore', 19:46:38 INFO - 'sessionrestore_no_auto_restore']}, 19:46:38 INFO - 'other_l64': {'tests': ['a11yr', 19:46:38 INFO - 'ts_paint', 19:46:38 INFO - 'tpaint', 19:46:38 INFO - 'sessionrestore', 19:46:38 INFO - 'sessionrestore_no_auto_restore']}, 19:46:38 INFO - 'other_nol64': {'tests': ['a11yr', 19:46:38 INFO - 'ts_paint', 19:46:38 INFO - 'tpaint', 19:46:38 INFO - 'sessionrestore', 19:46:38 INFO - 'sessionrestore_no_auto_restore']}, 19:46:38 INFO - 'svgr': {'tests': ['tsvgx', 19:46:38 INFO - 'tsvgr_opacity', 19:46:38 INFO - 'tart', 19:46:38 INFO - 'tscrollx', 19:46:38 INFO - 'cart']}, 19:46:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:46:38 INFO - 'tests': ['tsvgx', 19:46:38 INFO - 'tsvgr_opacity', 19:46:38 INFO - 'tart', 19:46:38 INFO - 'tscrollx', 19:46:38 INFO - 'cart']}, 19:46:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:38 INFO - 'tests': ['tp5o']}, 19:46:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:38 INFO - 'talos_options': ['--e10s'], 19:46:38 INFO - 'tests': ['tp5o']}, 19:46:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:38 INFO - 'talos_options': ['--xperf_path', 19:46:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:46:38 INFO - 'tests': ['tp5n']}, 19:46:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:38 INFO - 'talos_options': ['--e10s', 19:46:38 INFO - '--xperf_path', 19:46:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:46:38 INFO - 'tests': ['tp5n']}}, 19:46:38 INFO - 'talos.zip': {'path': '', 19:46:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:46:38 INFO - Running post-action listener: _resource_record_post_action 19:46:38 INFO - ##### 19:46:38 INFO - ##### Running create-virtualenv step. 19:46:38 INFO - ##### 19:46:38 INFO - Running pre-action listener: _resource_record_pre_action 19:46:38 INFO - Running main action method: create_virtualenv 19:46:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:46:38 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 19:46:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:46:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:46:38 INFO - Using real prefix '/usr' 19:46:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:46:39 INFO - Installing distribute.............................................................................................................................................................................................done. 19:46:41 INFO - Installing pip.................done. 19:46:41 INFO - Return code: 0 19:46:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:46:41 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')]} 19:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:41 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')]} 19:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:41 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 0x7f2c53093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda1a50>, '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 0xd0d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0d9e0>, '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': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', '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 19:46:41 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 19:46:41 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 19:46:41 INFO - Using env: {'DISPLAY': ':0', 19:46:41 INFO - 'HOME': '/home/cltbld', 19:46:41 INFO - 'LANG': 'en_US.UTF-8', 19:46:41 INFO - 'LANGUAGE': 'en_US:en', 19:46:41 INFO - 'LOGNAME': 'cltbld', 19:46:41 INFO - 'MAIL': '/var/mail/cltbld', 19:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:41 INFO - 'MOZ_NO_REMOTE': '1', 19:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:41 INFO - 'NO_EM_RESTART': '1', 19:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:41 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:41 INFO - 'SHELL': '/bin/bash', 19:46:41 INFO - 'SHLVL': '1', 19:46:41 INFO - 'TERM': 'linux', 19:46:41 INFO - 'TMOUT': '86400', 19:46:41 INFO - 'USER': 'cltbld', 19:46:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', 19:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:41 INFO - '_': '/tools/buildbot/bin/python'} 19:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:42 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 19:46:42 INFO - Cleaning up... 19:46:42 INFO - Return code: 0 19:46:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:46: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')]} 19:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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')]} 19:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:42 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 0x7f2c53093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda1a50>, '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 0xd0d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0d9e0>, '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': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', '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 19:46:42 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 19:46:42 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 19:46:42 INFO - Using env: {'DISPLAY': ':0', 19:46:42 INFO - 'HOME': '/home/cltbld', 19:46:42 INFO - 'LANG': 'en_US.UTF-8', 19:46:42 INFO - 'LANGUAGE': 'en_US:en', 19:46:42 INFO - 'LOGNAME': 'cltbld', 19:46:42 INFO - 'MAIL': '/var/mail/cltbld', 19:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:42 INFO - 'MOZ_NO_REMOTE': '1', 19:46:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:42 INFO - 'NO_EM_RESTART': '1', 19:46:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:42 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:42 INFO - 'SHELL': '/bin/bash', 19:46:42 INFO - 'SHLVL': '1', 19:46:42 INFO - 'TERM': 'linux', 19:46:42 INFO - 'TMOUT': '86400', 19:46:42 INFO - 'USER': 'cltbld', 19:46:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', 19:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:42 INFO - '_': '/tools/buildbot/bin/python'} 19:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:42 INFO - Downloading/unpacking psutil>=0.7.1 19:46:42 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 19:46:42 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 19:46:42 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 19:46:42 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 19:46:42 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 19:46:42 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 19:46:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:46:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:46:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:46:44 INFO - Installing collected packages: psutil 19:46:44 INFO - Running setup.py install for psutil 19:46:44 INFO - building 'psutil._psutil_linux' extension 19:46:44 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 19:46:45 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 19:46:45 INFO - building 'psutil._psutil_posix' extension 19:46:45 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 19:46:45 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 19:46:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:46:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:46:45 INFO - Successfully installed psutil 19:46:45 INFO - Cleaning up... 19:46:46 INFO - Return code: 0 19:46:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:46: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')]} 19:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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')]} 19:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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', '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 0x7f2c53093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda1a50>, '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 0xd0d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0d9e0>, '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': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', '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 19:46: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:46: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 mozsystemmonitor==0.0.0 19:46:46 INFO - Using env: {'DISPLAY': ':0', 19:46:46 INFO - 'HOME': '/home/cltbld', 19:46:46 INFO - 'LANG': 'en_US.UTF-8', 19:46:46 INFO - 'LANGUAGE': 'en_US:en', 19:46:46 INFO - 'LOGNAME': 'cltbld', 19:46:46 INFO - 'MAIL': '/var/mail/cltbld', 19:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:46 INFO - 'MOZ_NO_REMOTE': '1', 19:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:46 INFO - 'NO_EM_RESTART': '1', 19:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:46 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:46 INFO - 'SHELL': '/bin/bash', 19:46:46 INFO - 'SHLVL': '1', 19:46:46 INFO - 'TERM': 'linux', 19:46:46 INFO - 'TMOUT': '86400', 19:46:46 INFO - 'USER': 'cltbld', 19:46:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', 19:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:46 INFO - '_': '/tools/buildbot/bin/python'} 19:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:46:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:46:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:46:48 INFO - Installing collected packages: mozsystemmonitor 19:46:48 INFO - Running setup.py install for mozsystemmonitor 19:46:48 INFO - Successfully installed mozsystemmonitor 19:46:48 INFO - Cleaning up... 19:46:48 INFO - Return code: 0 19:46:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:46: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')]} 19:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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')]} 19:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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', '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 0x7f2c53093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda1a50>, '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 0xd0d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0d9e0>, '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': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', '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 19:46: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:46: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 blobuploader==1.2.4 19:46:48 INFO - Using env: {'DISPLAY': ':0', 19:46:48 INFO - 'HOME': '/home/cltbld', 19:46:48 INFO - 'LANG': 'en_US.UTF-8', 19:46:48 INFO - 'LANGUAGE': 'en_US:en', 19:46:48 INFO - 'LOGNAME': 'cltbld', 19:46:48 INFO - 'MAIL': '/var/mail/cltbld', 19:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:48 INFO - 'MOZ_NO_REMOTE': '1', 19:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:48 INFO - 'NO_EM_RESTART': '1', 19:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:48 INFO - 'SHELL': '/bin/bash', 19:46:48 INFO - 'SHLVL': '1', 19:46:48 INFO - 'TERM': 'linux', 19:46:48 INFO - 'TMOUT': '86400', 19:46:48 INFO - 'USER': 'cltbld', 19:46:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', 19:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:48 INFO - '_': '/tools/buildbot/bin/python'} 19:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:48 INFO - Downloading/unpacking blobuploader==1.2.4 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46:50 INFO - Downloading blobuploader-1.2.4.tar.gz 19:46:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:46:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:46:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46:51 INFO - Downloading docopt-0.6.1.tar.gz 19:46:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:46:51 INFO - Installing collected packages: blobuploader, requests, docopt 19:46:51 INFO - Running setup.py install for blobuploader 19:46:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:46:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:46:51 INFO - Running setup.py install for requests 19:46:51 INFO - Running setup.py install for docopt 19:46:51 INFO - Successfully installed blobuploader requests docopt 19:46:51 INFO - Cleaning up... 19:46:51 INFO - Return code: 0 19:46:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:51 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 0x7f2c53093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda1a50>, '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 0xd0d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0d9e0>, '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': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', '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 19:46:51 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 19:46:51 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 19:46:51 INFO - Using env: {'DISPLAY': ':0', 19:46:51 INFO - 'HOME': '/home/cltbld', 19:46:51 INFO - 'LANG': 'en_US.UTF-8', 19:46:51 INFO - 'LANGUAGE': 'en_US:en', 19:46:51 INFO - 'LOGNAME': 'cltbld', 19:46:51 INFO - 'MAIL': '/var/mail/cltbld', 19:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:51 INFO - 'MOZ_NO_REMOTE': '1', 19:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:51 INFO - 'NO_EM_RESTART': '1', 19:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:51 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:51 INFO - 'SHELL': '/bin/bash', 19:46:51 INFO - 'SHLVL': '1', 19:46:51 INFO - 'TERM': 'linux', 19:46:51 INFO - 'TMOUT': '86400', 19:46:51 INFO - 'USER': 'cltbld', 19:46:51 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', 19:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:51 INFO - '_': '/tools/buildbot/bin/python'} 19:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:46:52 INFO - Running setup.py (path:/tmp/pip-VFlsEB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:46:52 INFO - Running setup.py (path:/tmp/pip-6BMZ39-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:46:52 INFO - Running setup.py (path:/tmp/pip-SQMg4_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:46:52 INFO - Running setup.py (path:/tmp/pip-5NrrI6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:46:52 INFO - Running setup.py (path:/tmp/pip-NihOYW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:46:52 INFO - Running setup.py (path:/tmp/pip-kXbAkj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:46:52 INFO - Running setup.py (path:/tmp/pip-MXojmd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:46:52 INFO - Running setup.py (path:/tmp/pip-tnhoBT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:46:52 INFO - Running setup.py (path:/tmp/pip-0goeBm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:46:52 INFO - Running setup.py (path:/tmp/pip-nMcZdM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:46:52 INFO - Running setup.py (path:/tmp/pip-Pm7xI9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:46:52 INFO - Running setup.py (path:/tmp/pip-blwpMX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:46:52 INFO - Running setup.py (path:/tmp/pip-N_t47u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:46:53 INFO - Running setup.py (path:/tmp/pip-Uiy_cn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:46:53 INFO - Running setup.py (path:/tmp/pip-koBssj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:46:53 INFO - Running setup.py (path:/tmp/pip-Zg0S5N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:46:53 INFO - Running setup.py (path:/tmp/pip-_XCfKP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:46:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:46:53 INFO - Running setup.py install for manifestparser 19:46:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:46:53 INFO - Running setup.py install for mozcrash 19:46:53 INFO - Running setup.py install for mozdebug 19:46:53 INFO - Running setup.py install for mozdevice 19:46:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:46:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:46:53 INFO - Running setup.py install for mozfile 19:46:53 INFO - Running setup.py install for mozhttpd 19:46:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:46:53 INFO - Running setup.py install for mozinfo 19:46:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:46:54 INFO - Running setup.py install for mozInstall 19:46:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:46:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:46:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:46:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:46:54 INFO - Running setup.py install for mozleak 19:46:54 INFO - Running setup.py install for mozlog 19:46:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:46:54 INFO - Running setup.py install for moznetwork 19:46:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:46:54 INFO - Running setup.py install for mozprocess 19:46:54 INFO - Running setup.py install for mozprofile 19:46:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:46:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:46:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:46:54 INFO - Running setup.py install for mozrunner 19:46:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:46:54 INFO - Running setup.py install for mozscreenshot 19:46:54 INFO - Running setup.py install for moztest 19:46:54 INFO - Running setup.py install for mozversion 19:46:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:46:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:46:55 INFO - Cleaning up... 19:46:55 INFO - Return code: 0 19:46:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:55 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 0x7f2c53093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda1a50>, '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 0xd0d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0d9e0>, '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': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', '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 19:46:55 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 19:46:55 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 19:46:55 INFO - Using env: {'DISPLAY': ':0', 19:46:55 INFO - 'HOME': '/home/cltbld', 19:46:55 INFO - 'LANG': 'en_US.UTF-8', 19:46:55 INFO - 'LANGUAGE': 'en_US:en', 19:46:55 INFO - 'LOGNAME': 'cltbld', 19:46:55 INFO - 'MAIL': '/var/mail/cltbld', 19:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:55 INFO - 'MOZ_NO_REMOTE': '1', 19:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:55 INFO - 'NO_EM_RESTART': '1', 19:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:55 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:55 INFO - 'SHELL': '/bin/bash', 19:46:55 INFO - 'SHLVL': '1', 19:46:55 INFO - 'TERM': 'linux', 19:46:55 INFO - 'TMOUT': '86400', 19:46:55 INFO - 'USER': 'cltbld', 19:46:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', 19:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:55 INFO - '_': '/tools/buildbot/bin/python'} 19:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:46:55 INFO - Running setup.py (path:/tmp/pip-B1gb4q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:46:55 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)) 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:46:55 INFO - Running setup.py (path:/tmp/pip-tlBXJ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:46:55 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)) 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:46:55 INFO - Running setup.py (path:/tmp/pip-faXM0T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:46:55 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)) 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:46:55 INFO - Running setup.py (path:/tmp/pip-KFq5lG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:46:55 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)) 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:46:55 INFO - Running setup.py (path:/tmp/pip-nesAFb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:46:55 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)) 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:46:55 INFO - Running setup.py (path:/tmp/pip-1OkiQR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:46:55 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)) 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:46:55 INFO - Running setup.py (path:/tmp/pip-alI9us-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:46:55 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)) 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:46:55 INFO - Running setup.py (path:/tmp/pip-hT_C2U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:46:55 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)) 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:46:55 INFO - Running setup.py (path:/tmp/pip-hCBBOz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:46:55 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)) 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:46:55 INFO - Running setup.py (path:/tmp/pip-LY_4_J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:46:56 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)) 19:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:46:56 INFO - Running setup.py (path:/tmp/pip-mGZ8zC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:46:56 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)) 19:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:46:56 INFO - Running setup.py (path:/tmp/pip-lVNO1h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:46:56 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)) 19:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:46:56 INFO - Running setup.py (path:/tmp/pip-t5S1Sv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:46:56 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)) 19:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:46:56 INFO - Running setup.py (path:/tmp/pip-6TTGEJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:46:56 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)) 19:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:46:56 INFO - Running setup.py (path:/tmp/pip-Fa2gP1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:46:56 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)) 19:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:46:56 INFO - Running setup.py (path:/tmp/pip-mgT1Y3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:46:56 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)) 19:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:46:56 INFO - Running setup.py (path:/tmp/pip-c3kaBP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:46:56 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)) 19:46:56 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)) 19:46:56 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)) 19:46:56 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)) 19:46:56 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)) 19:46:56 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)) 19:46:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:58 INFO - Downloading blessings-1.6.tar.gz 19:46:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:46:58 INFO - Installing collected packages: blessings 19:46:58 INFO - Running setup.py install for blessings 19:46:58 INFO - Successfully installed blessings 19:46:58 INFO - Cleaning up... 19:46:58 INFO - Return code: 0 19:46:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:46:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:46:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:46:58 INFO - Reading from file tmpfile_stdout 19:46:58 INFO - Current package versions: 19:46:58 INFO - argparse == 1.2.1 19:46:58 INFO - blessings == 1.6 19:46:58 INFO - blobuploader == 1.2.4 19:46:58 INFO - docopt == 0.6.1 19:46:58 INFO - manifestparser == 1.1 19:46:58 INFO - mozInstall == 1.12 19:46:58 INFO - mozcrash == 0.16 19:46:58 INFO - mozdebug == 0.1 19:46:58 INFO - mozdevice == 0.47 19:46:58 INFO - mozfile == 1.2 19:46:58 INFO - mozhttpd == 0.7 19:46:58 INFO - mozinfo == 0.9 19:46:58 INFO - mozleak == 0.1 19:46:58 INFO - mozlog == 3.1 19:46:58 INFO - moznetwork == 0.27 19:46:58 INFO - mozprocess == 0.22 19:46:58 INFO - mozprofile == 0.27 19:46:58 INFO - mozrunner == 6.11 19:46:58 INFO - mozscreenshot == 0.1 19:46:58 INFO - mozsystemmonitor == 0.0 19:46:58 INFO - moztest == 0.7 19:46:58 INFO - mozversion == 1.4 19:46:58 INFO - psutil == 3.1.1 19:46:58 INFO - requests == 1.2.3 19:46:58 INFO - wsgiref == 0.1.2 19:46:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:46:58 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')]} 19:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:58 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')]} 19:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:58 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 0x7f2c53093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda1a50>, '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 0xd0d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0d9e0>, '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': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', '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 19:46:58 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 19:46:58 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 19:46:58 INFO - Using env: {'DISPLAY': ':0', 19:46:58 INFO - 'HOME': '/home/cltbld', 19:46:58 INFO - 'LANG': 'en_US.UTF-8', 19:46:58 INFO - 'LANGUAGE': 'en_US:en', 19:46:58 INFO - 'LOGNAME': 'cltbld', 19:46:58 INFO - 'MAIL': '/var/mail/cltbld', 19:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:58 INFO - 'MOZ_NO_REMOTE': '1', 19:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:58 INFO - 'NO_EM_RESTART': '1', 19:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:58 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:58 INFO - 'SHELL': '/bin/bash', 19:46:58 INFO - 'SHLVL': '1', 19:46:58 INFO - 'TERM': 'linux', 19:46:58 INFO - 'TMOUT': '86400', 19:46:58 INFO - 'USER': 'cltbld', 19:46:58 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', 19:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:58 INFO - '_': '/tools/buildbot/bin/python'} 19:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:59 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)) 19:46:59 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)) 19:46:59 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)) 19:46:59 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)) 19:46:59 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)) 19:46:59 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)) 19:46:59 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)) 19:46:59 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)) 19:46:59 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)) 19:46:59 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)) 19:46:59 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)) 19:46:59 INFO - Cleaning up... 19:46:59 INFO - Return code: 0 19:46:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:59 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 0x7f2c53093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda1a50>, '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 0xd0d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0d9e0>, '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': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', '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 19:46:59 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 19:46:59 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 19:46:59 INFO - Using env: {'DISPLAY': ':0', 19:46:59 INFO - 'HOME': '/home/cltbld', 19:46:59 INFO - 'LANG': 'en_US.UTF-8', 19:46:59 INFO - 'LANGUAGE': 'en_US:en', 19:46:59 INFO - 'LOGNAME': 'cltbld', 19:46:59 INFO - 'MAIL': '/var/mail/cltbld', 19:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:59 INFO - 'MOZ_NO_REMOTE': '1', 19:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:59 INFO - 'NO_EM_RESTART': '1', 19:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:59 INFO - 'SHELL': '/bin/bash', 19:46:59 INFO - 'SHLVL': '1', 19:46:59 INFO - 'TERM': 'linux', 19:46:59 INFO - 'TMOUT': '86400', 19:46:59 INFO - 'USER': 'cltbld', 19:46:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', 19:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:59 INFO - '_': '/tools/buildbot/bin/python'} 19:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:59 INFO - Downloading/unpacking jsonschema 19:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:47:01 INFO - Downloading/unpacking functools32 (from jsonschema) 19:47:01 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 19:47:01 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 19:47:01 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 19:47:01 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 19:47:01 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 19:47:01 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 19:47:01 INFO - Downloading functools32-3.2.3-2.tar.gz 19:47:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:47:01 INFO - warning: no files found matching '*.txt' 19:47:01 INFO - no previously-included directories found matching 'build' 19:47:01 INFO - no previously-included directories found matching 'dist' 19:47:01 INFO - no previously-included directories found matching '.git*' 19:47:01 INFO - Installing collected packages: jsonschema, functools32 19:47:01 INFO - Running setup.py install for functools32 19:47:01 INFO - warning: no files found matching '*.txt' 19:47:01 INFO - no previously-included directories found matching 'build' 19:47:01 INFO - no previously-included directories found matching 'dist' 19:47:01 INFO - no previously-included directories found matching '.git*' 19:47:01 INFO - Successfully installed jsonschema functools32 19:47:01 INFO - Cleaning up... 19:47:01 INFO - Return code: 0 19:47:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:47:01 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')]} 19:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:01 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')]} 19:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:01 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 0x7f2c53093f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda1a50>, '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 0xd0d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0d9e0>, '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': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', '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 19:47:01 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 19:47:01 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 19:47:01 INFO - Using env: {'DISPLAY': ':0', 19:47:01 INFO - 'HOME': '/home/cltbld', 19:47:01 INFO - 'LANG': 'en_US.UTF-8', 19:47:01 INFO - 'LANGUAGE': 'en_US:en', 19:47:01 INFO - 'LOGNAME': 'cltbld', 19:47:01 INFO - 'MAIL': '/var/mail/cltbld', 19:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:01 INFO - 'MOZ_NO_REMOTE': '1', 19:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:01 INFO - 'NO_EM_RESTART': '1', 19:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:01 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:01 INFO - 'SHELL': '/bin/bash', 19:47:01 INFO - 'SHLVL': '1', 19:47:01 INFO - 'TERM': 'linux', 19:47:01 INFO - 'TMOUT': '86400', 19:47:01 INFO - 'USER': 'cltbld', 19:47:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', 19:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:01 INFO - '_': '/tools/buildbot/bin/python'} 19:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:01 INFO - Downloading/unpacking flake8 19:47:01 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 19:47:01 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 19:47:01 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 19:47:01 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 19:47:01 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 19:47:01 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 19:47:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:47:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:47:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:47:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:47:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:47:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:47:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:47:04 INFO - no previously-included directories found matching 'docs/_build' 19:47:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:47:04 INFO - Running setup.py install for pep8 19:47:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:47:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:47:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:47:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:47:04 INFO - no previously-included directories found matching 'docs/_build' 19:47:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:47:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:47:04 INFO - Cleaning up... 19:47:04 INFO - Return code: 0 19:47:04 INFO - Running post-action listener: _resource_record_post_action 19:47:04 INFO - Running post-action listener: _start_resource_monitoring 19:47:04 INFO - Starting resource monitoring. 19:47:04 INFO - ##### 19:47:04 INFO - ##### Running install step. 19:47:04 INFO - ##### 19:47:04 INFO - Running pre-action listener: _resource_record_pre_action 19:47:04 INFO - Running main action method: install 19:47:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:47:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:47:04 INFO - Reading from file tmpfile_stdout 19:47:04 INFO - Detecting whether we're running mozinstall >=1.0... 19:47:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:47:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:47:04 INFO - Reading from file tmpfile_stdout 19:47:04 INFO - Output received: 19:47:04 INFO - Usage: mozinstall [options] installer 19:47:04 INFO - Options: 19:47:04 INFO - -h, --help show this help message and exit 19:47:04 INFO - -d DEST, --destination=DEST 19:47:04 INFO - Directory to install application into. [default: 19:47:04 INFO - "/builds/slave/test-pgo"] 19:47:04 INFO - --app=APP Application being installed. [default: firefox] 19:47:04 INFO - mkdir: /builds/slave/test-pgo/build/application 19:47:04 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'] 19:47:04 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 19:47:19 INFO - Reading from file tmpfile_stdout 19:47:19 INFO - Output received: 19:47:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:47:19 INFO - Running post-action listener: _resource_record_post_action 19:47:19 INFO - ##### 19:47:19 INFO - ##### Running run-tests step. 19:47:19 INFO - ##### 19:47:19 INFO - Running pre-action listener: _resource_record_pre_action 19:47:19 INFO - Running main action method: run_tests 19:47:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:47:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:47:19 INFO - Python 2.7.3 19:47:19 INFO - Return code: 0 19:47:19 INFO - grabbing minidump binary from tooltool 19:47:19 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')]} 19:47:19 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 0xda1a50>, '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 0xd0d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd0d9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:47:19 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 19:47:19 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 19:47:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:47:19 INFO - Return code: 0 19:47:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:47:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:47:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:47:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:47:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:47:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:47:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:47:20 INFO - Return code: 0 19:47:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 19:47:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost 19:47:20 INFO - Using env: {'DISPLAY': ':0', 19:47:20 INFO - 'HOME': '/home/cltbld', 19:47:20 INFO - 'LANG': 'en_US.UTF-8', 19:47:20 INFO - 'LANGUAGE': 'en_US:en', 19:47:20 INFO - 'LOGNAME': 'cltbld', 19:47:20 INFO - 'MAIL': '/var/mail/cltbld', 19:47:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:47:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:20 INFO - 'MOZ_NO_REMOTE': '1', 19:47:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:47:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:20 INFO - 'NO_EM_RESTART': '1', 19:47:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:20 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:47:20 INFO - 'SHELL': '/bin/bash', 19:47:20 INFO - 'SHLVL': '1', 19:47:20 INFO - 'TERM': 'linux', 19:47:20 INFO - 'TMOUT': '86400', 19:47:20 INFO - 'USER': 'cltbld', 19:47:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123', 19:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:20 INFO - '_': '/tools/buildbot/bin/python'} 19:47:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] with output_timeout 3600 19:47:20 INFO - mozversion INFO | application_buildid: 20160124172707 19:47:20 INFO - mozversion INFO | application_changeset: 4128f782d6449f625dd8e33e84e9b1ef7af98b16 19:47:20 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 19:47:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:47:20 INFO - mozversion INFO | application_name: Firefox 19:47:20 INFO - mozversion INFO | application_remotingname: firefox-dev 19:47:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:47:20 INFO - mozversion INFO | application_vendor: Mozilla 19:47:20 INFO - mozversion INFO | application_version: 45.0a2 19:47:20 INFO - mozversion INFO | platform_buildid: 20160124172707 19:47:20 INFO - mozversion INFO | platform_changeset: 4128f782d6449f625dd8e33e84e9b1ef7af98b16 19:47:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:47:20 INFO - mozversion INFO | platform_version: 45.0a2 19:47:20 INFO - 2016-01-24 19:47:20,697 DEBUG : using testdate: 1453693640 19:47:20 INFO - 2016-01-24 19:47:20,698 DEBUG : actual date: 1453693640 19:47:20 INFO - 2016-01-24 19:47:20,707 INFO : starting webserver on 'localhost:55059' 19:47:20 INFO - 2016-01-24 19:47:20,708 INFO : Starting test suite talos-linux64-ix-025.e 19:47:20 INFO - 2016-01-24 19:47:20,708 INFO : Starting test dromaeo_css 19:47:20 INFO - 2016-01-24 19:47:20,708 DEBUG : operating with platform_type : linux_ 19:47:20 INFO - 2016-01-24 19:47:20,708 INFO : Initialising browser for dromaeo_css test... 19:47:20 INFO - 2016-01-24 19:47:20,896 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdlt8sK/profile http://localhost:55059/getInfo.html 19:47:25 INFO - 2016-01-24 19:47:25,902 DEBUG : BROWSER_OUTPUT: 19:47:25 INFO - 2016-01-24 19:47:25,902 DEBUG : BROWSER_OUTPUT: (process:3419): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:47:27 INFO - 2016-01-24 19:47:27,275 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:47:27 INFO - 2016-01-24 19:47:27,275 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:47:27 INFO - 2016-01-24 19:47:27,275 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:47:27 INFO - 2016-01-24 19:47:27,275 DEBUG : BROWSER_OUTPUT: __metrics 19:47:28 INFO - 2016-01-24 19:47:28,278 INFO : Browser initialized. 19:47:28 INFO - 2016-01-24 19:47:28,278 INFO : Running cycle 1/1 for dromaeo_css test... 19:47:28 INFO - 2016-01-24 19:47:28,278 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdlt8sK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:47:29 INFO - 2016-01-24 19:47:29,501 DEBUG : BROWSER_OUTPUT: 19:47:29 INFO - 2016-01-24 19:47:29,501 DEBUG : BROWSER_OUTPUT: (process:3535): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:47:40 INFO - 2016-01-24 19:47:40,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 136228864 19:47:40 INFO - 2016-01-24 19:47:40,006 DEBUG : BROWSER_OUTPUT: 19:48:29 INFO - 2016-01-24 19:48:29,595 DEBUG : BROWSER_OUTPUT: 1453693709593 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] 19:50:37 INFO - 2016-01-24 19:50:37,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55059/tests/dromaeo/cssquery-ext.html) 19:50:39 INFO - 2016-01-24 19:50:39,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 141406208 19:50:39 INFO - 2016-01-24 19:50:39,051 DEBUG : BROWSER_OUTPUT: 19:53:40 INFO - 2016-01-24 19:53:40,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/dromaeo/cssquery-ext.html (next: http://localhost:55059/tests/dromaeo/cssquery-jquery.html) 19:53:41 INFO - 2016-01-24 19:53:41,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 139874304 19:53:41 INFO - 2016-01-24 19:53:41,389 DEBUG : BROWSER_OUTPUT: 19:56:42 INFO - 2016-01-24 19:56:42,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55059/tests/dromaeo/cssquery-mootools.html) 19:56:43 INFO - 2016-01-24 19:56:43,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 138735616 19:56:43 INFO - 2016-01-24 19:56:43,545 DEBUG : BROWSER_OUTPUT: 19:59:45 INFO - 2016-01-24 19:59:45,077 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55059/tests/dromaeo/cssquery-prototype.html) 19:59:45 INFO - 2016-01-24 19:59:45,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 139632640 19:59:45 INFO - 2016-01-24 19:59:45,680 DEBUG : BROWSER_OUTPUT: 20:02:47 INFO - 2016-01-24 20:02:47,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55059/tests/dromaeo/cssquery-yui.html) 20:02:48 INFO - 2016-01-24 20:02:48,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 140001280 20:02:48 INFO - 2016-01-24 20:02:48,540 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2016-01-24 20:05:50,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/dromaeo/cssquery-yui.html (next: http://localhost:55059/tests/dromaeo/cssquery-dojo.html) 20:05:50 INFO - 2016-01-24 20:05:50,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 141631488 20:05:50 INFO - 2016-01-24 20:05:50,929 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2016-01-24 20:05:50,929 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:05:50 INFO - 2016-01-24 20:05:50,929 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:05:50 INFO - 2016-01-24 20:05:50,929 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:05:50 INFO - 2016-01-24 20:05:50,930 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:05:50 INFO - 2016-01-24 20:05:50,930 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3369.8315084245783;3374.6119196292425;3394.1684287349603;3406.761526693131;3414.5902491701;5595.664260144389;5603.3836278009385;5607.971960140204;5608.719564021803;5630.77476900924;5570.359408668004;5582;5617.9438205617935;5637.295338082739;5654.971725141369;5076.238564215379;5096.923546146811;5132;5175.8188463403785;5179.637425380225;4950.801967921278;5072.518110779489;5074.416442109149;5131.923021154667;5197.558207552363;5168.819091331804;5192.221166824987;5235.450277720842;5242.030224408478;5246.396664383607;5245.554127899114;5257.684538927639;5269.288646032813;5282.81510147143;5300.284461597674;4970.826021089245;4996.225585034325;5014.473480284591;5166.483351664841;5175.275461435402;5455.5908306877145;5458.4814442627885;5489.258950041733;5492.945070549284;5518;6083.422074902877;6115.419035191694;6149.446549810538;6163.9383606164265;6183.288921773964;5972.104184372379;6042.788502402394;6095.695215239265;6119.143319935212;6160;5670.404607516234;5714.342850572196;5716.57125715573;5717.199592057115;5747.137929310595;6125.479334256549;6139.508839292846;6159.599626024294;6171.043488259327;6171.537134714914;5753.309602847685;5808.680522571215;5961.374055724086;5999.850003749854;6131.908021379683;6036.63780173191;6058;6058.818235452855;6086.147939288503;6095.055266433621;5922.822315330547;6048.183495228088;6066.575339726177;6074.362191969868;6081.118237855575;5864.091065884794;5874.794382196603;5984.162217289583;5984.491318237999;6002.4897883679505;4649.04694537619;4666.929996050062;4676.438827340673;4681.227597446383;4694.788734506956;4042.211768705133;4172.08214192877;4186.853460128881;4190.958090419118;4199.97900010498;5636.971815140898;5653.491185793298;5674.631148975303;5685;5787.681677507693;5889;6135.447809697149;6176.042713379344;6181.474574661204;6186.072089186568;5417;5683.715814209356;5684.403137670485;5732.34078081026;5752.137179423036;5215.504527069922;5235.397929238186;5313.30926979498;5319.388270348882;5352.330958630171;6227.159333489921;6256.937430625727;6261;6262.248530176408;6280.5603607747935;5951.077582974646;6079.422454866781;6174.938250617526;6180.443760061616;6184.536159787944;6098.993666045053;6154.59995100335;6172.876542469216;6192.164057852313;6201;6018.157457955977;6044.002739547926;6048.153258543895;6054.212952316171;6079.574429789872;5926.7925622603;6001.669908154919;6020.789272375621;6084.939150608438;6090.116933044772;6001.06983417571;6013.849653758691;6037.486813620892;6068.4841788448475;6076.179715738319;6040.577159598786;6045.002574575145;6057.030875059969;6069.848253793691;6072.301685306246;5568.331800184003;5703.372629010722;5775.711214439345;5900.734466948912;5934.851628709317;5935.673537955454;5952.315483719428;5967.880642387215;5986.820395388146;6073.605215660968;5941.702914854326;5962.046072628532;5972.402759724167;5984.461398474158;5995.070764031408 20:05:50 INFO - 2016-01-24 20:05:50,930 DEBUG : BROWSER_OUTPUT: |1;ext.html;589.1692713274284;632.5287660692784;638.9361063893609;644.8001119652911;657.5627207906742;32680;38359.80820095899;38894;38903.22193556127;39090.80454597727;44228;44314;44445.7777711111;44737;44900.55099449005;9128.771780705485;9230.261579073658;9277.536123193813;9279.814403711922;9295.72112836616;8989.775255618597;9110.954445227764;9111.179993800557;9120.680776172836;9124.680636177734;9113.498757568332;9210.309226807984;9230.53847307632;9248.398854074498;9250.306227032966;9108.681196158135;9148.085191480799;9162.358634895594;9173.266138708887;9212.263018958502;8978.955105224497;9088.18206361424;9128.680496182602;9132.269418446509;9164.175224229852;41982;42511;42525;42596;42634;3310.2386451116136;3361.7478689098416;3444.9311013779834;3562.4300111981956;3845.2693988142164;32029.83985080083;32507.34985300281;32543.349133017444;32666;33028;4070.8564141393967;4088.284550203732;4163.958360416417;4168.416421700964;4266.5946735060115;279047;279726.6013669939;283312;283558;283692;44597.55402445934;45085.323720144224;45174.77412612916;45286;45353.77323113429;42874.57125428706;42899;43166;43353;43363.56636433595;15145.394184232728;15158.090514569161;15247.847521524865;15323.540293791204;15344.462943796914;12557.560485382968;12643.3046182459;12716.237025778482;12730.745385092432;13131.868681313255;15339.309731062129;15399.769003464957;15411.152386618844;15423.922880385526;15478.071315721092;6197;6272.498200143978;6317.924938414697;6352.777652782131;6371.139896114058;1002.9398236105711;1018.1396719771781;1065.9040686338267;1098.8462114779609;1144.713821544614;29009.709902901122;29336.85331573371;29788;30010.549841752392;30019.249518762204;1112.282577737371;1149.620625193684;1174.48322737995;1182.5092586576475;1182.9053675705923;15996.920015399848;16245.106519141324;16370;16495;16603.169841507875;299656;299823;301430;302302;546903;57325.426745732846;58082.7095864518;58227.41772582305;58250.4174958245;58269.70865145732;1473.5579326202096;1477.6527516033723;1484.1169504145016;1498.250874562697;1510.0486693383098;31142;31226.843865780527;31583.36833263368;31743;32097.679023209468;48753;49084;49176.75411622919;49271.26093108678;49292.2606160915;304482;307132;307153;307241;308487;34630.480542791374;34960.125996850285;35067.12332191614;35069;35192.824035879654;45080;45959.77020114878;46552.7672361636;46612.53387466082;46677.29984050174;39095;39268.01829954274;40007.39988900227;40414.1917161661;41649.583504165785;38367.42448863325;38606;38874.61125388823;38880;39046.4143037849;38394;39024;39140.804295978334;44052.33921491244;44559.55440445684;33844.661553384154;33989.32021359608;34069.829650851585;38450.230995379374;39116.60883391243;27964.720352797027;28126.900567304023;28274.71725282721;28331;28572.142835714963 20:05:50 INFO - 2016-01-24 20:05:50,931 DEBUG : BROWSER_OUTPUT: |2;jquery.html;389.7973054011914;392.34478421036874;393.5867339293744;393.95863434339395;394.300117291807;14958.551243462687;17556.82443175568;19135.138918748657;19229.23083076677;19306.806931930678;17486.21312040958;18057.638847223046;18263;18593.907030464863;18812;5516.724163791824;5572.359178694462;5599.63602365847;5643.927653745775;5655.5475561954945;5306.787728490855;5470.234167216593;5478.561715062785;5584.720763961785;5596.300462442195;5313.256144139824;5430.945690543103;5448.863778405552;5473.67157970521;5497.065498865202;5376.1398176291605;5402.621816472849;5412.83761487156;5444.537214336786;5494.450554944514;5451.155070964007;5491.862703432406;5494.780208791643;5496.0931446311315;5497.038018346773;13439.126456780277;13494.865051349558;14121.082129661641;14174.50389236382;14241.71516569673;2200.1309482754223;2219.378573999267;2256.041182497432;2275.340151356105;2313.421644588853;9837.852432213522;10211.693649190536;10429.165666746641;10551.261411701184;10898.782024359547;1973.3192048743304;1973.4375702924597;1997.9100940457715;2013.8489613278916;2039.3881835449306;64226;66736.3326366735;67371.32628673749;67493.3250667492;68749;11121.555137794398;11155.888441115485;11177.217594768288;11214.887851121548;11309.943450282695;14627;14770;14786.852131478763;14816.333265002886;14857.628559285888;8117.756467305991;8145.959270203611;8152.94011778465;8198.42611017235;8278.172182781795;7545.170031296553;7921.960390198012;8059.838803223903;8110.188981101961;8128.0246370435925;4697;4819.49395313487;4832.057748739033;4852.927206091911;4887.04702583;1890.1305399516377;1909.627622613605;1975.2790231565375;1998.4803950972562;2000.21991423345;934.313279739391;983.4738414947968;1011.1354791653177;1012.4532752313668;1054.46222426563;17117.315307387566;17381.913090434467;17450.12749362552;17898.731519027224;18344.724829127576;989.5250279865704;1035.7669524357111;1048.66442738323;1059.6450189186555;1069.3316677076828;10359.32664376813;10507.632232871812;10550.944905509388;10565.154787616972;10578.629747958785;569666;569744;573175;587046;593296;80766.59616701878;82366;83319.5834020826;83917.58041209755;84104.57947710344;1090.6946055104584;1099.8515200447998;1107.3300653104754;1123.9831402528969;1131.937743424103;16347.591310216863;16412.917935410245;16441.342346306013;16572.419965301156;16682.833171668615;36809.263814724094;37041;37070.44394334033;37759.81120094382;38499.037524061;49270;49717.50282497273;50206.995860081865;51578.74210628923;54657;10357.74105647365;10370.896291036994;10417.322874013165;10474.423906685206;10710.732231693959;17699.734503982192;18180.09099545044;18274.177662004975;18553.16510757046;19134.808651913303;15458.149801761012;15494.457693980656;15598;15600.219989000732;15903.204839757735;14936.925315373353;14973.775393368891;15102.697946040798;15426.9228653856;15821.446249381217;15364.84635153679;15787.605309866885;15907.681846363239;16070.116143612213;16270.51188464348;9847.60609575609;10014.449205293487;10485.528151233366;10523.158147348347;10553.577856885639;15539.300731467338;15725.213739313218;16152.838471615134;16420.917895410446;16495.91752041232 20:05:50 INFO - 2016-01-24 20:05:50,932 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1555.5722176401496;1654.8262432444592;1716.4593153156754;1896.3647178195304;1944.270898413096;7472.290132437423;7617.809554761134;8280.958595207023;8411.285040771541;8493.108223636515;7930.167332430098;8190.262876341143;8275.710350137746;8287.792805179859;8300.875486867702;2387.4031492126924;2418.8790560471994;2423.6243382275775;2430.5260474207535;2446.7675570820743;2449.6570480132796;2459.348272707734;2501.5997440409537;2502.1617758050984;2504.26124293333;2393.868337241451;2400.867952262625;2431.416460049584;2437.6587277781036;2457.594496908008;2432.3067925641194;2442.3771938155833;2451.681281433402;2463.051725085846;2469.345623409798;2470.295965649781;2478.4051827561434;2489.950200995988;2506.949861002788;2509.774120329179;8353.83292334156;8414.410991230616;8449.070602233749;8456.49261044333;8478.576071196478;4939.6789208701675;5087.364079490064;5125.743712814382;5126.897462050775;5145.76844042019;3221;3239.1254361322544;3272.7709060365783;3419.81191034493;3433.484977253407;1020.1849458088923;1096.1942971915635;1101.8402331661864;1103.3600511703194;1107.634480621393;11553.306801591847;11627.069834413227;11634.243774154653;11655.067594592498;11667.06663466929;4564;4571.085782843378;4608.870826647493;4629.375034370384;4645.5354464553275;9944.055314745088;9980.850287245697;10006.79986400268;10019.749506262402;10026.498675066217;5123.436421993578;5125.026245013435;5160.561352285098;5166.276721259027;5181.637285390062;4592.104539614743;4636.5131661175765;4652.418447694038;4671.135839869635;4712.787924543404;3941.8620348288246;3973.7417067890497;3991.6806655467494;3992.1017771001293;4033.5361433434946;1205.584073494643;1209.1173443386376;1212.1636071110904;1215.2769102384068;1225.601679454163;1275.101053757099;1296.3194322980323;1307.1242267680486;1400.2578633324354;1410.9365078571489;7947.9205207948335;7999.680012799423;8125.3499720022255;8147.75556733299;8159.67361305553;1084.7233955341496;1140.7319279969201;1186.661801386618;1200.783858905388;1209.9697507562205;6247.406496382836;6335.65153916539;6346.2067241594805;6422.903656445157;6425.389587989227;9811.264155188246;10057.14514266281;10110.090091891765;10157.492125393701;10192.388456692473;9702.223822094216;9840.901590984142;9899.059589339002;9991.850122248172;10042.447665378328;8001.8799718004275;8026.5986700664735;8038.638261278256;8058.758237252891;8107.351411887035;7619.9238007619215;7636.80907977305;7717;7742.845143097219;7766.805829854299;8946.194842464209;9021.368504204642;9060.773480663036;9093.4998575079;9263.861042084509;9187.6924307248;9338.673146439842;9364.157225849705;9365.438073715326;9457;7197.064381630355;7222.96388518054;7270.2366251544945;7526.32263096324;7559.3196612305155;7732.265434783687;7805.024371953506;7806.687732490636;7821.882671760042;7830.765077047698;7370.6314684266645;7534.284242996907;7537.9623101884135;7549.886751698619;7602.923970760443;7381.372583330262;7496.962515187389;7533.1336896257635;7573.431992600466;7614.390848731978;7472.364848987897;7554.886676699744;7564.016677831846;7587.393008559192;7598.354139898171;6779.186497620317;6822.624755638488;6836.145481814773;6860.416864566568;7015.719371225094;6637.303083176197;6654.700538475683;6687.598744075371;6690.431313338421;6733.696983635846 20:05:50 INFO - 2016-01-24 20:05:50,932 DEBUG : BROWSER_OUTPUT: |4;prototype.html;364.84494090011736;373.98090204193556;376.9283836071145;377.66010590468574;379.2907263417408;6223.4398904098625;6319.968400157998;6332.240131184259;6335.493160547157;6380.776672816452;6220.564560480768;6315.873682526347;6334.081558174062;6336.65148416838;6350.237971443434;4898.240772680231;4900.289458028584;4915.6313276504225;4916.901661966758;4924;4921.655484116113;4922.26166075088;4924.556789888909;4928.507149285061;4935.23503856901;4667.789949452283;4822;4855.878603034917;4857.101436234308;4865.318855360252;4850.636202284825;4861.173600487908;4864.537868902448;4867.075255701406;4875.658703890729;4159.91680166398;4244.469441319835;4249.68127390447;4261.637760790337;4275.0594869128745;5955.225820643289;5990.490808281302;6008.429199226067;6010;6042.214512113397;5619;5653.077953495831;5669.348024977139;5686.914696279559;5688.715564221772;6534.346565343475;6737.764178253738;6747.561408508432;6749.696263668097;6776.186857577073;4732.929006064912;4734.668573199878;4735.052989402134;4736.123817093814;4739.644526660514;6971.8605627887155;7001.82495437613;7048.083749112634;7058.7529436469995;7065.328793764585;4842.854714358575;4849.393825771778;4853.490383509751;4856.854294371175;4859.0039041997015;4837.032593481247;4890.095332363524;4914.92627610579;4916.287138364989;4918.1884988977135;5619.157126430986;5623.0721930880945;5653.547716182696;5655.6606603603095;5661.094224924075;6756.527043107034;6759.391654750998;6784.59292442455;6802.55783374089;6803.047573339736;1705.249690136336;1712.9286032358568;1734.4363081998401;1734.878558500918;1735.4186347573452;1149.3219000789575;1154.8267759835924;1174.8061569841052;1175.0658226709616;1179.8938095571439;6417.262014868256;6443.130177426081;6465.676716164173;6466.06242094903;6466.708998095097;7006.859862802716;7034.151168776653;7038.331358520933;7042.929570704227;7062.011318415426;6319.33646967071;6391.744330226832;6420.133282006869;6458.515611329169;6460.192475940507;3761.247750449921;3815.141593141521;3833.674137698271;3838.500994870649;3843.1929294847837;7211.206767255598;7261.237570055174;7283.672234749449;7298.854022919512;7299.5255308404785;7219;7232.855342893218;7267.30960558746;7270.527415717961;7284.417246620258;7101.2898710128575;7223.494355395177;7241.131064272321;7251.56490610565;7256.89114663291;7107.466939979418;7109.928900710926;7115.146182458138;7118.537295075804;7137.10786151731;6968.163820341591;6995.440364770704;6995.615241161785;7010.68451919675;7016.964915175596;7037.648117594203;7244.529105608119;7258.963705181441;7264.673089711081;7264.818379540554;4829.323894654681;4842.443119041355;4878.658493905393;4883.658143930033;4895.485973972682;7080.893786593102;7086.50394472382;7089.113860767404;7104;7109.28907109285;6710.530262881552;6834.726610935507;6835.179778426621;6870.965645171742;6935.549189302679;6843;6907.274736152632;6912.4815638828295;6912.55068420551;6938.375546200866;6655.667216639052;6780.627065511444;6800.217974932946;6809.319068093151;6809.8638027238185;6935.965320173367;6947.40947019509;6952.860942781015;6953.061336719478;6954.165500140016;6736.124303840469;6770.729170833111;6775.085363476065;6788.25329213796;6790.558613690095 20:05:50 INFO - 2016-01-24 20:05:50,933 DEBUG : BROWSER_OUTPUT: |5;yui.html;746.4886552711397;783.6238605469374;790.4111436979451;881.6473410635747;898.4160295807724;13973.23147226902;14166.362513686883;14180.290985450712;14211.573652790406;14256.144631322128;12822.551210707627;12878.098533102686;12949.158304710187;12981.74036519269;12992.15550989185;743.49813875634;756.3986630628636;890.5725251879102;902.0438335364502;909.8180363927208;890.2922176869405;892.5448021509045;900.4597241654988;900.9414388064788;901.7384958362068;936.0826390137669;943;943.1841457139559;943.9433633981948;947.1901524196782;934.6261495401826;934.8410770169088;935.0742764662934;937.9729196529789;938.061938061938;697.5396238482577;697.9685914133876;699.6152116336045;700.6776882633994;701.1376007510739;13242.801357979639;13296.401661925236;13326.466941322335;13344.933275333562;13350.26573538455;13189.208647481182;13393.330333483287;13533.796993045014;13645.590632281048;13751.724965500734;10877.945610271978;10935.507902144423;10936.518539936456;11004.284721493077;11343.886561134366;3790.9431358529646;3874.4769456123345;3893.824777885002;3901.6683581895572;3904.375299951994;50013.24980125301;50539.24191137136;51278.7436062821;51417.742911285575;51786.22320665193;9782.217422606174;9822.214222862154;10002.749931251778;10006.599736010623;10098.343607665478;19366.128524216445;19572.902135489232;19817.504562385766;19971;20009.899950500156;7780.2380155045275;7819.960900195462;7836.725714599962;7890.763277101696;8053.355731541463;4517.11916176349;4568.862934111982;4575.748333841604;4635.536446355338;4731;3219.4365985952363;3257.2345498807763;3262.8042317461027;3271.247613049012;3272;580.2282963658324;587.6532845621018;605.1074664869283;605.6487237402296;607.4229481992126;620.6896551724138;625.3402660193449;700.7617410080597;701.2216439751871;728.4536597551836;8399.328053755686;9332.440053596805;9748.635191073256;9882.160016398686;9951.55218015191;612.1796792298342;668.6355936014884;671.3119052970744;715.5563550598662;730.6237287796789;3912.56961734209;4059.7361171523758;4110.34234522475;4289.077848262638;4448.154850578379;61277;62034.37965620286;62207.37792622016;62891.685541572915;64188;54128.72935635297;54464;55189.72405137949;55592.72203638956;56179.157312640345;48114.759426203345;49222;49408.50591494111;49655.75172124116;50248;9176.770580735269;9401.52992350366;9431.952840235756;9566.378185417925;9600.951995239979;35503.28993420169;36624.81687591545;36794.26411471809;37048.07379815418;37412.625873742;44138.779306104545;44149.77925110354;50686.746566266935;51523.22715159201;52004;12041.698957526132;12151.392430378623;12191.756164876475;12229.3273869938;12273.263604183778;13057.542985995824;13413.128146670435;13658;13670.17978921268;13933.094348867291;11511.30932144074;11864;12033.518659253532;12296.75406491883;12599.43302551369;11385.430728463378;11875.168738188244;11894.226875253082;11940.402979851146;12053.216540924812;12064.215825971283;12065.879341206826;12284.0786940978;12325.383730813603;12341.444634991627;10193.745156370853;10449.895501045195;10518.316309439862;10616.681499555025;10644.89355106439;9923.55344009507;10407.739806504898;10455.68632941013;10526.631567895087;10571.471426428801 20:05:50 INFO - 2016-01-24 20:05:50,934 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:05:50 INFO - 2016-01-24 20:05:50,934 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:05:50 INFO - 2016-01-24 20:05:50,934 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,310 20:05:50 INFO - 2016-01-24 20:05:50,934 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:05:50 INFO - 2016-01-24 20:05:50,934 DEBUG : BROWSER_OUTPUT: __startTimestamp1453694750927__endTimestamp 20:05:50 INFO - 2016-01-24 20:05:50,934 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2016-01-24 20:05:50,934 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:05:50 INFO - 2016-01-24 20:05:50,934 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:05:50 INFO - 2016-01-24 20:05:50,934 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2016-01-24 20:05:50,934 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5634.55 Median:5889.00 stddev:627.06 (10.6%) stddev-sans-first:603.29 20:05:50 INFO - 2016-01-24 20:05:50,934 DEBUG : BROWSER_OUTPUT: Values: 3369.8 3374.6 3394.2 3406.8 3414.6 5595.7 5603.4 5608.0 5608.7 5630.8 5570.4 5582.0 5617.9 5637.3 5655.0 5076.2 5096.9 5132.0 5175.8 5179.6 4950.8 5072.5 5074.4 5131.9 5197.6 5168.8 5192.2 5235.5 5242.0 5246.4 5245.6 5257.7 5269.3 5282.8 5300.3 4970.8 4996.2 5014.5 5166.5 5175.3 5455.6 5458.5 5489.3 5492.9 5518.0 6083.4 6115.4 6149.4 6163.9 6183.3 5972.1 6042.8 6095.7 6119.1 6160.0 5670.4 5714.3 5716.6 5717.2 5747.1 6125.5 6139.5 6159.6 6171.0 6171.5 5753.3 5808.7 5961.4 5999.9 6131.9 6036.6 6058.0 6058.8 6086.1 6095.1 5922.8 6048.2 6066.6 6074.4 6081.1 5864.1 5874.8 5984.2 5984.5 6002.5 4649.0 4666.9 4676.4 4681.2 4694.8 4042.2 4172.1 4186.9 4191.0 4200.0 5637.0 5653.5 5674.6 5685.0 5787.7 5889.0 6135.4 6176.0 6181.5 6186.1 5417.0 5683.7 5684.4 5732.3 5752.1 5215.5 5235.4 5313.3 5319.4 5352.3 6227.2 6256.9 6261.0 6262.2 6280.6 5951.1 6079.4 6174.9 6180.4 6184.5 6099.0 6154.6 6172.9 6192.2 6201.0 6018.2 6044.0 6048.2 6054.2 6079.6 5926.8 6001.7 6020.8 6084.9 6090.1 6001.1 6013.8 6037.5 6068.5 6076.2 6040.6 6045.0 6057.0 6069.8 6072.3 5568.3 5703.4 5775.7 5900.7 5934.9 5935.7 5952.3 5967.9 5986.8 6073.6 5941.7 5962.0 5972.4 5984.5 5995.1 20:05:50 INFO - 2016-01-24 20:05:50,934 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2016-01-24 20:05:50,935 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48375.55 Median:38898.61 stddev:83742.40 (215.3%) stddev-sans-first:83900.46 20:05:50 INFO - 2016-01-24 20:05:50,936 DEBUG : BROWSER_OUTPUT: Values: 589.2 632.5 638.9 644.8 657.6 32680.0 38359.8 38894.0 38903.2 39090.8 44228.0 44314.0 44445.8 44737.0 44900.6 9128.8 9230.3 9277.5 9279.8 9295.7 8989.8 9111.0 9111.2 9120.7 9124.7 9113.5 9210.3 9230.5 9248.4 9250.3 9108.7 9148.1 9162.4 9173.3 9212.3 8979.0 9088.2 9128.7 9132.3 9164.2 41982.0 42511.0 42525.0 42596.0 42634.0 3310.2 3361.7 3444.9 3562.4 3845.3 32029.8 32507.3 32543.3 32666.0 33028.0 4070.9 4088.3 4164.0 4168.4 4266.6 279047.0 279726.6 283312.0 283558.0 283692.0 44597.6 45085.3 45174.8 45286.0 45353.8 42874.6 42899.0 43166.0 43353.0 43363.6 15145.4 15158.1 15247.8 15323.5 15344.5 12557.6 12643.3 12716.2 12730.7 13131.9 15339.3 15399.8 15411.2 15423.9 15478.1 6197.0 6272.5 6317.9 6352.8 6371.1 1002.9 1018.1 1065.9 1098.8 1144.7 29009.7 29336.9 29788.0 30010.5 30019.2 1112.3 1149.6 1174.5 1182.5 1182.9 15996.9 16245.1 16370.0 16495.0 16603.2 299656.0 299823.0 301430.0 302302.0 546903.0 57325.4 58082.7 58227.4 58250.4 58269.7 1473.6 1477.7 1484.1 1498.3 1510.0 31142.0 31226.8 31583.4 31743.0 32097.7 48753.0 49084.0 49176.8 49271.3 49292.3 304482.0 307132.0 307153.0 307241.0 308487.0 34630.5 34960.1 35067.1 35069.0 35192.8 45080.0 45959.8 46552.8 46612.5 46677.3 39095.0 39268.0 40007.4 40414.2 41649.6 38367.4 38606.0 38874.6 38880.0 39046.4 38394.0 39024.0 39140.8 44052.3 44559.6 33844.7 33989.3 34069.8 38450.2 39116.6 27964.7 28126.9 28274.7 28331.0 28572.1 20:05:50 INFO - 2016-01-24 20:05:50,936 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2016-01-24 20:05:50,936 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30781.85 Median:19268.02 stddev:94539.99 (490.7%) stddev-sans-first:94777.66 20:05:50 INFO - 2016-01-24 20:05:50,936 DEBUG : BROWSER_OUTPUT: Values: 389.8 392.3 393.6 394.0 394.3 14958.6 17556.8 19135.1 19229.2 19306.8 17486.2 18057.6 18263.0 18593.9 18812.0 5516.7 5572.4 5599.6 5643.9 5655.5 5306.8 5470.2 5478.6 5584.7 5596.3 5313.3 5430.9 5448.9 5473.7 5497.1 5376.1 5402.6 5412.8 5444.5 5494.5 5451.2 5491.9 5494.8 5496.1 5497.0 13439.1 13494.9 14121.1 14174.5 14241.7 2200.1 2219.4 2256.0 2275.3 2313.4 9837.9 10211.7 10429.2 10551.3 10898.8 1973.3 1973.4 1997.9 2013.8 2039.4 64226.0 66736.3 67371.3 67493.3 68749.0 11121.6 11155.9 11177.2 11214.9 11309.9 14627.0 14770.0 14786.9 14816.3 14857.6 8117.8 8146.0 8152.9 8198.4 8278.2 7545.2 7922.0 8059.8 8110.2 8128.0 4697.0 4819.5 4832.1 4852.9 4887.0 1890.1 1909.6 1975.3 1998.5 2000.2 934.3 983.5 1011.1 1012.5 1054.5 17117.3 17381.9 17450.1 17898.7 18344.7 989.5 1035.8 1048.7 1059.6 1069.3 10359.3 10507.6 10550.9 10565.2 10578.6 569666.0 569744.0 573175.0 587046.0 593296.0 80766.6 82366.0 83319.6 83917.6 84104.6 1090.7 1099.9 1107.3 1124.0 1131.9 16347.6 16412.9 16441.3 16572.4 16682.8 36809.3 37041.0 37070.4 37759.8 38499.0 49270.0 49717.5 50207.0 51578.7 54657.0 10357.7 10370.9 10417.3 10474.4 10710.7 17699.7 18180.1 18274.2 18553.2 19134.8 15458.1 15494.5 15598.0 15600.2 15903.2 14936.9 14973.8 15102.7 15426.9 15821.4 15364.8 15787.6 15907.7 16070.1 16270.5 9847.6 10014.4 10485.5 10523.2 10553.6 15539.3 15725.2 16152.8 16420.9 16495.9 20:05:50 INFO - 2016-01-24 20:05:50,937 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2016-01-24 20:05:50,938 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5882.72 Median:5163.42 stddev:3032.73 (58.7%) stddev-sans-first:3023.80 20:05:50 INFO - 2016-01-24 20:05:50,938 DEBUG : BROWSER_OUTPUT: Values: 1555.6 1654.8 1716.5 1896.4 1944.3 7472.3 7617.8 8281.0 8411.3 8493.1 7930.2 8190.3 8275.7 8287.8 8300.9 2387.4 2418.9 2423.6 2430.5 2446.8 2449.7 2459.3 2501.6 2502.2 2504.3 2393.9 2400.9 2431.4 2437.7 2457.6 2432.3 2442.4 2451.7 2463.1 2469.3 2470.3 2478.4 2490.0 2506.9 2509.8 8353.8 8414.4 8449.1 8456.5 8478.6 4939.7 5087.4 5125.7 5126.9 5145.8 3221.0 3239.1 3272.8 3419.8 3433.5 1020.2 1096.2 1101.8 1103.4 1107.6 11553.3 11627.1 11634.2 11655.1 11667.1 4564.0 4571.1 4608.9 4629.4 4645.5 9944.1 9980.9 10006.8 10019.7 10026.5 5123.4 5125.0 5160.6 5166.3 5181.6 4592.1 4636.5 4652.4 4671.1 4712.8 3941.9 3973.7 3991.7 3992.1 4033.5 1205.6 1209.1 1212.2 1215.3 1225.6 1275.1 1296.3 1307.1 1400.3 1410.9 7947.9 7999.7 8125.3 8147.8 8159.7 1084.7 1140.7 1186.7 1200.8 1210.0 6247.4 6335.7 6346.2 6422.9 6425.4 9811.3 10057.1 10110.1 10157.5 10192.4 9702.2 9840.9 9899.1 9991.9 10042.4 8001.9 8026.6 8038.6 8058.8 8107.4 7619.9 7636.8 7717.0 7742.8 7766.8 8946.2 9021.4 9060.8 9093.5 9263.9 9187.7 9338.7 9364.2 9365.4 9457.0 7197.1 7223.0 7270.2 7526.3 7559.3 7732.3 7805.0 7806.7 7821.9 7830.8 7370.6 7534.3 7538.0 7549.9 7602.9 7381.4 7497.0 7533.1 7573.4 7614.4 7472.4 7554.9 7564.0 7587.4 7598.4 6779.2 6822.6 6836.1 6860.4 7015.7 6637.3 6654.7 6687.6 6690.4 6733.7 20:05:50 INFO - 2016-01-24 20:05:50,938 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2016-01-24 20:05:50,939 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5692.71 Median:6386.26 stddev:1716.73 (26.9%) stddev-sans-first:1674.32 20:05:50 INFO - 2016-01-24 20:05:50,939 DEBUG : BROWSER_OUTPUT: Values: 364.8 374.0 376.9 377.7 379.3 6223.4 6320.0 6332.2 6335.5 6380.8 6220.6 6315.9 6334.1 6336.7 6350.2 4898.2 4900.3 4915.6 4916.9 4924.0 4921.7 4922.3 4924.6 4928.5 4935.2 4667.8 4822.0 4855.9 4857.1 4865.3 4850.6 4861.2 4864.5 4867.1 4875.7 4159.9 4244.5 4249.7 4261.6 4275.1 5955.2 5990.5 6008.4 6010.0 6042.2 5619.0 5653.1 5669.3 5686.9 5688.7 6534.3 6737.8 6747.6 6749.7 6776.2 4732.9 4734.7 4735.1 4736.1 4739.6 6971.9 7001.8 7048.1 7058.8 7065.3 4842.9 4849.4 4853.5 4856.9 4859.0 4837.0 4890.1 4914.9 4916.3 4918.2 5619.2 5623.1 5653.5 5655.7 5661.1 6756.5 6759.4 6784.6 6802.6 6803.0 1705.2 1712.9 1734.4 1734.9 1735.4 1149.3 1154.8 1174.8 1175.1 1179.9 6417.3 6443.1 6465.7 6466.1 6466.7 7006.9 7034.2 7038.3 7042.9 7062.0 6319.3 6391.7 6420.1 6458.5 6460.2 3761.2 3815.1 3833.7 3838.5 3843.2 7211.2 7261.2 7283.7 7298.9 7299.5 7219.0 7232.9 7267.3 7270.5 7284.4 7101.3 7223.5 7241.1 7251.6 7256.9 7107.5 7109.9 7115.1 7118.5 7137.1 6968.2 6995.4 6995.6 7010.7 7017.0 7037.6 7244.5 7259.0 7264.7 7264.8 4829.3 4842.4 4878.7 4883.7 4895.5 7080.9 7086.5 7089.1 7104.0 7109.3 6710.5 6834.7 6835.2 6871.0 6935.5 6843.0 6907.3 6912.5 6912.6 6938.4 6655.7 6780.6 6800.2 6809.3 6809.9 6936.0 6947.4 6952.9 6953.1 6954.2 6736.1 6770.7 6775.1 6788.3 6790.6 20:05:50 INFO - 2016-01-24 20:05:50,939 DEBUG : BROWSER_OUTPUT: 20:05:50 INFO - 2016-01-24 20:05:50,939 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14727.93 Median:4572.31 stddev:17140.65 (374.9%) stddev-sans-first:17156.58 20:05:50 INFO - 2016-01-24 20:05:50,939 DEBUG : BROWSER_OUTPUT: Values: 746.5 783.6 790.4 881.6 898.4 13973.2 14166.4 14180.3 14211.6 14256.1 12822.6 12878.1 12949.2 12981.7 12992.2 743.5 756.4 890.6 902.0 909.8 890.3 892.5 900.5 900.9 901.7 936.1 943.0 943.2 943.9 947.2 934.6 934.8 935.1 938.0 938.1 697.5 698.0 699.6 700.7 701.1 13242.8 13296.4 13326.5 13344.9 13350.3 13189.2 13393.3 13533.8 13645.6 13751.7 10877.9 10935.5 10936.5 11004.3 11343.9 3790.9 3874.5 3893.8 3901.7 3904.4 50013.2 50539.2 51278.7 51417.7 51786.2 9782.2 9822.2 10002.7 10006.6 10098.3 19366.1 19572.9 19817.5 19971.0 20009.9 7780.2 7820.0 7836.7 7890.8 8053.4 4517.1 4568.9 4575.7 4635.5 4731.0 3219.4 3257.2 3262.8 3271.2 3272.0 580.2 587.7 605.1 605.6 607.4 620.7 625.3 700.8 701.2 728.5 8399.3 9332.4 9748.6 9882.2 9951.6 612.2 668.6 671.3 715.6 730.6 3912.6 4059.7 4110.3 4289.1 4448.2 61277.0 62034.4 62207.4 62891.7 64188.0 54128.7 54464.0 55189.7 55592.7 56179.2 48114.8 49222.0 49408.5 49655.8 50248.0 9176.8 9401.5 9432.0 9566.4 9601.0 35503.3 36624.8 36794.3 37048.1 37412.6 44138.8 44149.8 50686.7 51523.2 52004.0 12041.7 12151.4 12191.8 12229.3 12273.3 13057.5 13413.1 13658.0 13670.2 13933.1 11511.3 11864.0 12033.5 12296.8 12599.4 11385.4 11875.2 11894.2 11940.4 12053.2 12064.2 12065.9 12284.1 12325.4 12341.4 10193.7 10449.9 10518.3 10616.7 10644.9 9923.6 10407.7 10455.7 10526.6 10571.5 20:05:50 INFO - 2016-01-24 20:05:50,939 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:05:50 INFO - 2016-01-24 20:05:50,940 DEBUG : BROWSER_OUTPUT: 20:05:51 INFO - 2016-01-24 20:05:51,598 INFO : Browser exited with error code: 0 20:05:51 INFO - 2016-01-24 20:05:51,614 INFO : Completed test dromaeo_css (00:18:30) 20:05:51 INFO - 2016-01-24 20:05:51,614 INFO : Starting test kraken 20:05:51 INFO - 2016-01-24 20:05:51,614 DEBUG : operating with platform_type : linux_ 20:05:51 INFO - 2016-01-24 20:05:51,614 INFO : Initialising browser for kraken test... 20:05:51 INFO - 2016-01-24 20:05:51,620 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0clMf2/profile http://localhost:55059/getInfo.html 20:05:55 INFO - 2016-01-24 20:05:55,428 DEBUG : BROWSER_OUTPUT: 20:05:55 INFO - 2016-01-24 20:05:55,429 DEBUG : BROWSER_OUTPUT: (process:3800): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:05:56 INFO - 2016-01-24 20:05:56,293 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:05:56 INFO - 2016-01-24 20:05:56,293 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:05:56 INFO - 2016-01-24 20:05:56,293 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:05:56 INFO - 2016-01-24 20:05:56,293 DEBUG : BROWSER_OUTPUT: __metrics 20:05:57 INFO - 2016-01-24 20:05:57,149 INFO : Browser initialized. 20:05:57 INFO - 2016-01-24 20:05:57,150 INFO : Running cycle 1/1 for kraken test... 20:05:57 INFO - 2016-01-24 20:05:57,150 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0clMf2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:05:58 INFO - 2016-01-24 20:05:58,381 DEBUG : BROWSER_OUTPUT: 20:05:58 INFO - 2016-01-24 20:05:58,382 DEBUG : BROWSER_OUTPUT: (process:3912): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:06:08 INFO - 2016-01-24 20:06:08,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 136335360 20:06:08 INFO - 2016-01-24 20:06:08,888 DEBUG : BROWSER_OUTPUT: 20:06:11 INFO - 2016-01-24 20:06:11,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55059/tests/kraken/driver.html?testName=audio-beat-detection) 20:06:11 INFO - 2016-01-24 20:06:11,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 138969088 20:06:11 INFO - 2016-01-24 20:06:11,965 DEBUG : BROWSER_OUTPUT: 20:06:14 INFO - 2016-01-24 20:06:14,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55059/tests/kraken/driver.html?testName=audio-dft) 20:06:15 INFO - 2016-01-24 20:06:15,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 137588736 20:06:15 INFO - 2016-01-24 20:06:15,149 DEBUG : BROWSER_OUTPUT: 20:06:17 INFO - 2016-01-24 20:06:17,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55059/tests/kraken/driver.html?testName=audio-fft) 20:06:18 INFO - 2016-01-24 20:06:18,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 138231808 20:06:18 INFO - 2016-01-24 20:06:18,538 DEBUG : BROWSER_OUTPUT: 20:06:20 INFO - 2016-01-24 20:06:20,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55059/tests/kraken/driver.html?testName=audio-oscillator) 20:06:21 INFO - 2016-01-24 20:06:21,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 139415552 20:06:21 INFO - 2016-01-24 20:06:21,132 DEBUG : BROWSER_OUTPUT: 20:06:23 INFO - 2016-01-24 20:06:23,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55059/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:06:23 INFO - 2016-01-24 20:06:23,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 138256384 20:06:23 INFO - 2016-01-24 20:06:23,917 DEBUG : BROWSER_OUTPUT: 20:06:26 INFO - 2016-01-24 20:06:26,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55059/tests/kraken/driver.html?testName=imaging-darkroom) 20:06:27 INFO - 2016-01-24 20:06:27,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 139472896 20:06:27 INFO - 2016-01-24 20:06:27,444 DEBUG : BROWSER_OUTPUT: 20:06:30 INFO - 2016-01-24 20:06:30,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55059/tests/kraken/driver.html?testName=imaging-desaturate) 20:06:31 INFO - 2016-01-24 20:06:31,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 139436032 20:06:31 INFO - 2016-01-24 20:06:31,374 DEBUG : BROWSER_OUTPUT: 20:06:34 INFO - 2016-01-24 20:06:34,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55059/tests/kraken/driver.html?testName=json-parse-financial) 20:06:34 INFO - 2016-01-24 20:06:34,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 138137600 20:06:34 INFO - 2016-01-24 20:06:34,702 DEBUG : BROWSER_OUTPUT: 20:06:36 INFO - 2016-01-24 20:06:36,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55059/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:06:36 INFO - 2016-01-24 20:06:36,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 138149888 20:06:36 INFO - 2016-01-24 20:06:36,857 DEBUG : BROWSER_OUTPUT: 20:06:38 INFO - 2016-01-24 20:06:38,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55059/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:06:39 INFO - 2016-01-24 20:06:39,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 138350592 20:06:39 INFO - 2016-01-24 20:06:39,249 DEBUG : BROWSER_OUTPUT: 20:06:41 INFO - 2016-01-24 20:06:41,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55059/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:06:41 INFO - 2016-01-24 20:06:41,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 138891264 20:06:41 INFO - 2016-01-24 20:06:41,868 DEBUG : BROWSER_OUTPUT: 20:06:44 INFO - 2016-01-24 20:06:44,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:06:44 INFO - 2016-01-24 20:06:44,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 138588160 20:06:44 INFO - 2016-01-24 20:06:44,856 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2016-01-24 20:06:47,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:06:47 INFO - 2016-01-24 20:06:47,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 138461184 20:06:47 INFO - 2016-01-24 20:06:47,948 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55059/tests/kraken/driver.html?testName=ai-astar) 20:06:49 INFO - 2016-01-24 20:06:49,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 139968512 20:06:49 INFO - 2016-01-24 20:06:49,872 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,876 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:06:49 INFO - 2016-01-24 20:06:49,876 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:06:49 INFO - 2016-01-24 20:06:49,876 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:06:49 INFO - 2016-01-24 20:06:49,877 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:06:49 INFO - 2016-01-24 20:06:49,877 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;103;108;109;108;120;109;110;109;110 20:06:49 INFO - 2016-01-24 20:06:49,877 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;133;143;162;124;144;153;125;164;126 20:06:49 INFO - 2016-01-24 20:06:49,877 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;161;160;165;162;160;162;164;164 20:06:49 INFO - 2016-01-24 20:06:49,877 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;71;71;147;72;71;73;72;154;70 20:06:49 INFO - 2016-01-24 20:06:49,877 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;135;92;93;93;136;91;93;142 20:06:49 INFO - 2016-01-24 20:06:49,878 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;111;109;110;109;109;110;109 20:06:49 INFO - 2016-01-24 20:06:49,878 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;146;146;147;146;146;147;146;148 20:06:49 INFO - 2016-01-24 20:06:49,878 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;95;95;97;95;96;96 20:06:49 INFO - 2016-01-24 20:06:49,878 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;64;63;65;62;63;64;68;60;60 20:06:49 INFO - 2016-01-24 20:06:49,878 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;65;67;67;67;66;67;67;67;66 20:06:49 INFO - 2016-01-24 20:06:49,878 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;80;82;81;81;84;85;90;81;82 20:06:49 INFO - 2016-01-24 20:06:49,878 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;111;123;112;118;113;123;124;118;120 20:06:49 INFO - 2016-01-24 20:06:49,878 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;146;144;145;147;146;148;147;157;148 20:06:49 INFO - 2016-01-24 20:06:49,878 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;66;66;65;66;70;65;66;66;66 20:06:49 INFO - 2016-01-24 20:06:49,878 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:06:49 INFO - 2016-01-24 20:06:49,879 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:06:49 INFO - 2016-01-24 20:06:49,879 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,721 20:06:49 INFO - 2016-01-24 20:06:49,879 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:06:49 INFO - 2016-01-24 20:06:49,879 DEBUG : BROWSER_OUTPUT: __startTimestamp1453694809874__endTimestamp 20:06:49 INFO - 2016-01-24 20:06:49,879 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,882 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:06:49 INFO - 2016-01-24 20:06:49,883 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:06:49 INFO - 2016-01-24 20:06:49,883 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,883 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.50 Median:109.00 stddev:4.20 (3.9%) stddev-sans-first:4.45 20:06:49 INFO - 2016-01-24 20:06:49,883 DEBUG : BROWSER_OUTPUT: Values: 109.0 103.0 108.0 109.0 108.0 120.0 109.0 110.0 109.0 110.0 20:06:49 INFO - 2016-01-24 20:06:49,883 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,883 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.10 Median:148.50 stddev:15.54 (10.5%) stddev-sans-first:15.65 20:06:49 INFO - 2016-01-24 20:06:49,883 DEBUG : BROWSER_OUTPUT: Values: 157.0 133.0 143.0 162.0 124.0 144.0 153.0 125.0 164.0 126.0 20:06:49 INFO - 2016-01-24 20:06:49,884 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,884 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.83 (1.1%) stddev-sans-first:1.94 20:06:49 INFO - 2016-01-24 20:06:49,884 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 161.0 160.0 165.0 162.0 160.0 162.0 164.0 164.0 20:06:49 INFO - 2016-01-24 20:06:49,884 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,884 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.90 Median:71.50 stddev:33.11 (46.3%) stddev-sans-first:34.92 20:06:49 INFO - 2016-01-24 20:06:49,884 DEBUG : BROWSER_OUTPUT: Values: 78.0 71.0 71.0 147.0 72.0 71.0 73.0 72.0 154.0 70.0 20:06:49 INFO - 2016-01-24 20:06:49,884 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,884 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:92.50 stddev:21.93 (23.7%) stddev-sans-first:22.67 20:06:49 INFO - 2016-01-24 20:06:49,885 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 135.0 92.0 93.0 93.0 136.0 91.0 93.0 142.0 20:06:49 INFO - 2016-01-24 20:06:49,885 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,885 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 20:06:49 INFO - 2016-01-24 20:06:49,885 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 111.0 109.0 110.0 109.0 109.0 110.0 109.0 20:06:49 INFO - 2016-01-24 20:06:49,885 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,885 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 20:06:49 INFO - 2016-01-24 20:06:49,885 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 148.0 20:06:49 INFO - 2016-01-24 20:06:49,886 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,886 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 20:06:49 INFO - 2016-01-24 20:06:49,886 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 95.0 95.0 97.0 95.0 96.0 96.0 20:06:49 INFO - 2016-01-24 20:06:49,886 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,886 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.50 stddev:2.56 (4.0%) stddev-sans-first:2.49 20:06:49 INFO - 2016-01-24 20:06:49,886 DEBUG : BROWSER_OUTPUT: Values: 60.0 64.0 63.0 65.0 62.0 63.0 64.0 68.0 60.0 60.0 20:06:49 INFO - 2016-01-24 20:06:49,886 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,886 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 20:06:49 INFO - 2016-01-24 20:06:49,887 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 67.0 67.0 67.0 66.0 67.0 67.0 67.0 66.0 20:06:49 INFO - 2016-01-24 20:06:49,887 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,887 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.00 stddev:2.94 (3.6%) stddev-sans-first:3.10 20:06:49 INFO - 2016-01-24 20:06:49,887 DEBUG : BROWSER_OUTPUT: Values: 82.0 80.0 82.0 81.0 81.0 84.0 85.0 90.0 81.0 82.0 20:06:49 INFO - 2016-01-24 20:06:49,887 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,887 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:119.00 stddev:4.72 (4.0%) stddev-sans-first:5.00 20:06:49 INFO - 2016-01-24 20:06:49,887 DEBUG : BROWSER_OUTPUT: Values: 117.0 111.0 123.0 112.0 118.0 113.0 123.0 124.0 118.0 120.0 20:06:49 INFO - 2016-01-24 20:06:49,888 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,888 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:147.00 stddev:4.29 (2.9%) stddev-sans-first:3.78 20:06:49 INFO - 2016-01-24 20:06:49,888 DEBUG : BROWSER_OUTPUT: Values: 140.0 146.0 144.0 145.0 147.0 146.0 148.0 147.0 157.0 148.0 20:06:49 INFO - 2016-01-24 20:06:49,888 DEBUG : BROWSER_OUTPUT: 20:06:49 INFO - 2016-01-24 20:06:49,888 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.45 (2.2%) stddev-sans-first:1.48 20:06:49 INFO - 2016-01-24 20:06:49,888 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 66.0 65.0 66.0 70.0 65.0 66.0 66.0 66.0 20:06:49 INFO - 2016-01-24 20:06:49,888 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:06:49 INFO - 2016-01-24 20:06:49,889 DEBUG : BROWSER_OUTPUT: 20:06:50 INFO - 2016-01-24 20:06:50,754 INFO : Browser exited with error code: 0 20:06:50 INFO - 2016-01-24 20:06:50,802 INFO : Completed test kraken (00:00:59) 20:06:50 INFO - 2016-01-24 20:06:50,802 INFO : Starting test v8_7 20:06:50 INFO - 2016-01-24 20:06:50,802 DEBUG : operating with platform_type : linux_ 20:06:50 INFO - 2016-01-24 20:06:50,802 INFO : Initialising browser for v8_7 test... 20:06:50 INFO - 2016-01-24 20:06:50,808 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXafjmh/profile http://localhost:55059/getInfo.html 20:06:54 INFO - 2016-01-24 20:06:54,643 DEBUG : BROWSER_OUTPUT: 20:06:54 INFO - 2016-01-24 20:06:54,643 DEBUG : BROWSER_OUTPUT: (process:4220): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:06:55 INFO - 2016-01-24 20:06:55,612 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:06:55 INFO - 2016-01-24 20:06:55,612 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:06:55 INFO - 2016-01-24 20:06:55,612 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:06:55 INFO - 2016-01-24 20:06:55,612 DEBUG : BROWSER_OUTPUT: __metrics 20:06:56 INFO - 2016-01-24 20:06:56,621 INFO : Browser initialized. 20:06:56 INFO - 2016-01-24 20:06:56,622 INFO : Running cycle 1/1 for v8_7 test... 20:06:56 INFO - 2016-01-24 20:06:56,622 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXafjmh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:06:57 INFO - 2016-01-24 20:06:57,900 DEBUG : BROWSER_OUTPUT: 20:06:57 INFO - 2016-01-24 20:06:57,900 DEBUG : BROWSER_OUTPUT: (process:4331): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:07:08 INFO - 2016-01-24 20:07:08,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 136495104 20:07:08 INFO - 2016-01-24 20:07:08,402 DEBUG : BROWSER_OUTPUT: 20:07:29 INFO - 2016-01-24 20:07:29,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55059/tests/v8_7/run.html (next: http://localhost:55059/tests/v8_7/run.html) 20:07:30 INFO - 2016-01-24 20:07:30,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 136814592 20:07:30 INFO - 2016-01-24 20:07:30,023 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-24 20:07:30,024 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:07:30 INFO - 2016-01-24 20:07:30,024 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:07:30 INFO - 2016-01-24 20:07:30,025 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:07:30 INFO - 2016-01-24 20:07:30,025 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:07:30 INFO - 2016-01-24 20:07:30,025 DEBUG : BROWSER_OUTPUT: |0;Richards;166.08536787908986 20:07:30 INFO - 2016-01-24 20:07:30,025 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.40038148083926 20:07:30 INFO - 2016-01-24 20:07:30,025 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 20:07:30 INFO - 2016-01-24 20:07:30,025 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5246.073298429319 20:07:30 INFO - 2016-01-24 20:07:30,025 DEBUG : BROWSER_OUTPUT: |4;RayTrace;924.2144177449168 20:07:30 INFO - 2016-01-24 20:07:30,025 DEBUG : BROWSER_OUTPUT: |5;Earley;547.0459518599563 20:07:30 INFO - 2016-01-24 20:07:30,025 DEBUG : BROWSER_OUTPUT: |6;Boyer;10923.91304347826 20:07:30 INFO - 2016-01-24 20:07:30,025 DEBUG : BROWSER_OUTPUT: |7;RegExp;24238.095238095237 20:07:30 INFO - 2016-01-24 20:07:30,026 DEBUG : BROWSER_OUTPUT: |8;Splay;525.4860746190226 20:07:30 INFO - 2016-01-24 20:07:30,026 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 20:07:30 INFO - 2016-01-24 20:07:30,026 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:07:30 INFO - 2016-01-24 20:07:30,026 DEBUG : BROWSER_OUTPUT: __startTimestamp1453694850023__endTimestamp 20:07:30 INFO - 2016-01-24 20:07:30,026 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-24 20:07:30,028 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:07:30 INFO - 2016-01-24 20:07:30,028 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:07:30 INFO - 2016-01-24 20:07:30,028 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-24 20:07:30,028 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.09 Median:166.09 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-24 20:07:30,029 DEBUG : BROWSER_OUTPUT: Values: 166.1 20:07:30 INFO - 2016-01-24 20:07:30,029 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-24 20:07:30,029 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.40 Median:173.40 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-24 20:07:30,029 DEBUG : BROWSER_OUTPUT: Values: 173.4 20:07:30 INFO - 2016-01-24 20:07:30,029 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-24 20:07:30,029 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-24 20:07:30,029 DEBUG : BROWSER_OUTPUT: Values: 278.1 20:07:30 INFO - 2016-01-24 20:07:30,029 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-24 20:07:30,029 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-24 20:07:30,030 DEBUG : BROWSER_OUTPUT: Values: 5246.1 20:07:30 INFO - 2016-01-24 20:07:30,030 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-24 20:07:30,030 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:924.21 Median:924.21 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-24 20:07:30,030 DEBUG : BROWSER_OUTPUT: Values: 924.2 20:07:30 INFO - 2016-01-24 20:07:30,030 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-24 20:07:30,030 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:547.05 Median:547.05 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-24 20:07:30,030 DEBUG : BROWSER_OUTPUT: Values: 547.0 20:07:30 INFO - 2016-01-24 20:07:30,030 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-24 20:07:30,030 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10923.91 Median:10923.91 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-24 20:07:30,030 DEBUG : BROWSER_OUTPUT: Values: 10923.9 20:07:30 INFO - 2016-01-24 20:07:30,030 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-24 20:07:30,030 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24238.10 Median:24238.10 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-24 20:07:30,030 DEBUG : BROWSER_OUTPUT: Values: 24238.1 20:07:30 INFO - 2016-01-24 20:07:30,030 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-24 20:07:30,031 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:525.49 Median:525.49 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-24 20:07:30,031 DEBUG : BROWSER_OUTPUT: Values: 525.5 20:07:30 INFO - 2016-01-24 20:07:30,031 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-24 20:07:30,031 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-24 20:07:30,031 DEBUG : BROWSER_OUTPUT: Values: 4840.6 20:07:30 INFO - 2016-01-24 20:07:30,031 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:07:30 INFO - 2016-01-24 20:07:30,031 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-24 20:07:30,818 INFO : Browser exited with error code: 0 20:07:30 INFO - 2016-01-24 20:07:30,837 INFO : Completed test v8_7 (00:00:40) 20:07:31 INFO - 2016-01-24 20:07:31,078 INFO : Completed test suite (00:20:10) 20:07:31 INFO - 2016-01-24 20:07:31,078 DEBUG : Working with test: dromaeo_css 20:07:31 INFO - 2016-01-24 20:07:31,078 DEBUG : Generating results file: dromaeo_css 20:07:31 INFO - 2016-01-24 20:07:31,079 DEBUG : Working with test: kraken 20:07:31 INFO - 2016-01-24 20:07:31,079 DEBUG : Generating results file: kraken 20:07:31 INFO - 2016-01-24 20:07:31,079 INFO : javascript benchmark 20:07:31 INFO - 2016-01-24 20:07:31,080 DEBUG : Working with test: v8_7 20:07:31 INFO - 2016-01-24 20:07:31,080 DEBUG : Generating results file: v8_7 20:07:31 INFO - 2016-01-24 20:07:31,080 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:07:31 INFO - 2016-01-24 20:07:31,231 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 20:07:31 INFO - 2016-01-24 20:07:31,231 DEBUG : process_Request line: dromaeo_css 7429.29 graph.html#tests=[[72,52,43]] 20:07:31 INFO - 2016-01-24 20:07:31,231 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:07:31 INFO - 2016-01-24 20:07:31,267 DEBUG : process_Request line: kraken 1503.40 graph.html#tests=[[232,52,43]] 20:07:31 INFO - 2016-01-24 20:07:31,267 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:07:31 INFO - 2016-01-24 20:07:31,300 DEBUG : process_Request line: v8_7 23113.74 graph.html#tests=[[230,52,43]] 20:07:31 INFO - 2016-01-24 20:07:31,302 INFO : javascript benchmark 20:07:31 INFO - 2016-01-24 20:07:31,305 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3369.8315084245783, 3374.6119196292425, 3394.1684287349603, 3406.761526693131, 3414.5902491701, 5595.664260144389, 5603.3836278009385, 5607.971960140204, 5608.719564021803, 5630.77476900924, 5570.359408668004, 5582.0, 5617.9438205617935, 5637.295338082739, 5654.971725141369, 5076.238564215379, 5096.923546146811, 5132.0, 5175.8188463403785, 5179.637425380225, 4950.801967921278, 5072.518110779489, 5074.416442109149, 5131.923021154667, 5197.558207552363, 5168.819091331804, 5192.221166824987, 5235.450277720842, 5242.030224408478, 5246.396664383607, 5245.554127899114, 5257.684538927639, 5269.288646032813, 5282.81510147143, 5300.284461597674, 4970.826021089245, 4996.225585034325, 5014.473480284591, 5166.483351664841, 5175.275461435402, 5455.5908306877145, 5458.4814442627885, 5489.258950041733, 5492.945070549284, 5518.0, 6083.422074902877, 6115.419035191694, 6149.446549810538, 6163.9383606164265, 6183.288921773964, 5972.104184372379, 6042.788502402394, 6095.695215239265, 6119.143319935212, 6160.0, 5670.404607516234, 5714.342850572196, 5716.57125715573, 5717.199592057115, 5747.137929310595, 6125.479334256549, 6139.508839292846, 6159.599626024294, 6171.043488259327, 6171.537134714914, 5753.309602847685, 5808.680522571215, 5961.374055724086, 5999.850003749854, 6131.908021379683, 6036.63780173191, 6058.0, 6058.818235452855, 6086.147939288503, 6095.055266433621, 5922.822315330547, 6048.183495228088, 6066.575339726177, 6074.362191969868, 6081.118237855575, 5864.091065884794, 5874.794382196603, 5984.162217289583, 5984.491318237999, 6002.4897883679505, 4649.04694537619, 4666.929996050062, 4676.438827340673, 4681.227597446383, 4694.788734506956, 4042.211768705133, 4172.08214192877, 4186.853460128881, 4190.958090419118, 4199.97900010498, 5636.971815140898, 5653.491185793298, 5674.631148975303, 5685.0, 5787.681677507693, 5889.0, 6135.447809697149, 6176.042713379344, 6181.474574661204, 6186.072089186568, 5417.0, 5683.715814209356, 5684.403137670485, 5732.34078081026, 5752.137179423036, 5215.504527069922, 5235.397929238186, 5313.30926979498, 5319.388270348882, 5352.330958630171, 6227.159333489921, 6256.937430625727, 6261.0, 6262.248530176408, 6280.5603607747935, 5951.077582974646, 6079.422454866781, 6174.938250617526, 6180.443760061616, 6184.536159787944, 6098.993666045053, 6154.59995100335, 6172.876542469216, 6192.164057852313, 6201.0, 6018.157457955977, 6044.002739547926, 6048.153258543895, 6054.212952316171, 6079.574429789872, 5926.7925622603, 6001.669908154919, 6020.789272375621, 6084.939150608438, 6090.116933044772, 6001.06983417571, 6013.849653758691, 6037.486813620892, 6068.4841788448475, 6076.179715738319, 6040.577159598786, 6045.002574575145, 6057.030875059969, 6069.848253793691, 6072.301685306246, 5568.331800184003, 5703.372629010722, 5775.711214439345, 5900.734466948912, 5934.851628709317, 5935.673537955454, 5952.315483719428, 5967.880642387215, 5986.820395388146, 6073.605215660968, 5941.702914854326, 5962.046072628532, 5972.402759724167, 5984.461398474158, 5995.070764031408], "unit": "ms", "name": "dojo.html", "value": 5593.822348682633}, {"lowerIsBetter": false, "replicates": [589.1692713274284, 632.5287660692784, 638.9361063893609, 644.8001119652911, 657.5627207906742, 32680.0, 38359.80820095899, 38894.0, 38903.22193556127, 39090.80454597727, 44228.0, 44314.0, 44445.7777711111, 44737.0, 44900.55099449005, 9128.771780705485, 9230.261579073658, 9277.536123193813, 9279.814403711922, 9295.72112836616, 8989.775255618597, 9110.954445227764, 9111.179993800557, 9120.680776172836, 9124.680636177734, 9113.498757568332, 9210.309226807984, 9230.53847307632, 9248.398854074498, 9250.306227032966, 9108.681196158135, 9148.085191480799, 9162.358634895594, 9173.266138708887, 9212.263018958502, 8978.955105224497, 9088.18206361424, 9128.680496182602, 9132.269418446509, 9164.175224229852, 41982.0, 42511.0, 42525.0, 42596.0, 42634.0, 3310.2386451116136, 3361.7478689098416, 3444.9311013779834, 3562.4300111981956, 3845.2693988142164, 32029.83985080083, 32507.34985300281, 32543.349133017444, 32666.0, 33028.0, 4070.8564141393967, 4088.284550203732, 4163.958360416417, 4168.416421700964, 4266.5946735060115, 279047.0, 279726.6013669939, 283312.0, 283558.0, 283692.0, 44597.55402445934, 45085.323720144224, 45174.77412612916, 45286.0, 45353.77323113429, 42874.57125428706, 42899.0, 43166.0, 43353.0, 43363.56636433595, 15145.394184232728, 15158.090514569161, 15247.847521524865, 15323.540293791204, 15344.462943796914, 12557.560485382968, 12643.3046182459, 12716.237025778482, 12730.745385092432, 13131.868681313255, 15339.309731062129, 15399.769003464957, 15411.152386618844, 15423.922880385526, 15478.071315721092, 6197.0, 6272.498200143978, 6317.924938414697, 6352.777652782131, 6371.139896114058, 1002.9398236105711, 1018.1396719771781, 1065.9040686338267, 1098.8462114779609, 1144.713821544614, 29009.709902901122, 29336.85331573371, 29788.0, 30010.549841752392, 30019.249518762204, 1112.282577737371, 1149.620625193684, 1174.48322737995, 1182.5092586576475, 1182.9053675705923, 15996.920015399848, 16245.106519141324, 16370.0, 16495.0, 16603.169841507875, 299656.0, 299823.0, 301430.0, 302302.0, 546903.0, 57325.426745732846, 58082.7095864518, 58227.41772582305, 58250.4174958245, 58269.70865145732, 1473.5579326202096, 1477.6527516033723, 1484.1169504145016, 1498.250874562697, 1510.0486693383098, 31142.0, 31226.843865780527, 31583.36833263368, 31743.0, 32097.679023209468, 48753.0, 49084.0, 49176.75411622919, 49271.26093108678, 49292.2606160915, 304482.0, 307132.0, 307153.0, 307241.0, 308487.0, 34630.480542791374, 34960.125996850285, 35067.12332191614, 35069.0, 35192.824035879654, 45080.0, 45959.77020114878, 46552.7672361636, 46612.53387466082, 46677.29984050174, 39095.0, 39268.01829954274, 40007.39988900227, 40414.1917161661, 41649.583504165785, 38367.42448863325, 38606.0, 38874.61125388823, 38880.0, 39046.4143037849, 38394.0, 39024.0, 39140.804295978334, 44052.33921491244, 44559.55440445684, 33844.661553384154, 33989.32021359608, 34069.829650851585, 38450.230995379374, 39116.60883391243, 27964.720352797027, 28126.900567304023, 28274.71725282721, 28331.0, 28572.142835714963], "unit": "ms", "name": "ext.html", "value": 19089.87635539035}, {"lowerIsBetter": false, "replicates": [389.7973054011914, 392.34478421036874, 393.5867339293744, 393.95863434339395, 394.300117291807, 14958.551243462687, 17556.82443175568, 19135.138918748657, 19229.23083076677, 19306.806931930678, 17486.21312040958, 18057.638847223046, 18263.0, 18593.907030464863, 18812.0, 5516.724163791824, 5572.359178694462, 5599.63602365847, 5643.927653745775, 5655.5475561954945, 5306.787728490855, 5470.234167216593, 5478.561715062785, 5584.720763961785, 5596.300462442195, 5313.256144139824, 5430.945690543103, 5448.863778405552, 5473.67157970521, 5497.065498865202, 5376.1398176291605, 5402.621816472849, 5412.83761487156, 5444.537214336786, 5494.450554944514, 5451.155070964007, 5491.862703432406, 5494.780208791643, 5496.0931446311315, 5497.038018346773, 13439.126456780277, 13494.865051349558, 14121.082129661641, 14174.50389236382, 14241.71516569673, 2200.1309482754223, 2219.378573999267, 2256.041182497432, 2275.340151356105, 2313.421644588853, 9837.852432213522, 10211.693649190536, 10429.165666746641, 10551.261411701184, 10898.782024359547, 1973.3192048743304, 1973.4375702924597, 1997.9100940457715, 2013.8489613278916, 2039.3881835449306, 64226.0, 66736.3326366735, 67371.32628673749, 67493.3250667492, 68749.0, 11121.555137794398, 11155.888441115485, 11177.217594768288, 11214.887851121548, 11309.943450282695, 14627.0, 14770.0, 14786.852131478763, 14816.333265002886, 14857.628559285888, 8117.756467305991, 8145.959270203611, 8152.94011778465, 8198.42611017235, 8278.172182781795, 7545.170031296553, 7921.960390198012, 8059.838803223903, 8110.188981101961, 8128.0246370435925, 4697.0, 4819.49395313487, 4832.057748739033, 4852.927206091911, 4887.04702583, 1890.1305399516377, 1909.627622613605, 1975.2790231565375, 1998.4803950972562, 2000.21991423345, 934.313279739391, 983.4738414947968, 1011.1354791653177, 1012.4532752313668, 1054.46222426563, 17117.315307387566, 17381.913090434467, 17450.12749362552, 17898.731519027224, 18344.724829127576, 989.5250279865704, 1035.7669524357111, 1048.66442738323, 1059.6450189186555, 1069.3316677076828, 10359.32664376813, 10507.632232871812, 10550.944905509388, 10565.154787616972, 10578.629747958785, 569666.0, 569744.0, 573175.0, 587046.0, 593296.0, 80766.59616701878, 82366.0, 83319.5834020826, 83917.58041209755, 84104.57947710344, 1090.6946055104584, 1099.8515200447998, 1107.3300653104754, 1123.9831402528969, 1131.937743424103, 16347.591310216863, 16412.917935410245, 16441.342346306013, 16572.419965301156, 16682.833171668615, 36809.263814724094, 37041.0, 37070.44394334033, 37759.81120094382, 38499.037524061, 49270.0, 49717.50282497273, 50206.995860081865, 51578.74210628923, 54657.0, 10357.74105647365, 10370.896291036994, 10417.322874013165, 10474.423906685206, 10710.732231693959, 17699.734503982192, 18180.09099545044, 18274.177662004975, 18553.16510757046, 19134.808651913303, 15458.149801761012, 15494.457693980656, 15598.0, 15600.219989000732, 15903.204839757735, 14936.925315373353, 14973.775393368891, 15102.697946040798, 15426.9228653856, 15821.446249381217, 15364.84635153679, 15787.605309866885, 15907.681846363239, 16070.116143612213, 16270.51188464348, 9847.60609575609, 10014.449205293487, 10485.528151233366, 10523.158147348347, 10553.577856885639, 15539.300731467338, 15725.213739313218, 16152.838471615134, 16420.917895410446, 16495.91752041232], "unit": "ms", "name": "jquery.html", "value": 9406.95514737781}, {"lowerIsBetter": false, "replicates": [1555.5722176401496, 1654.8262432444592, 1716.4593153156754, 1896.3647178195304, 1944.270898413096, 7472.290132437423, 7617.809554761134, 8280.958595207023, 8411.285040771541, 8493.108223636515, 7930.167332430098, 8190.262876341143, 8275.710350137746, 8287.792805179859, 8300.875486867702, 2387.4031492126924, 2418.8790560471994, 2423.6243382275775, 2430.5260474207535, 2446.7675570820743, 2449.6570480132796, 2459.348272707734, 2501.5997440409537, 2502.1617758050984, 2504.26124293333, 2393.868337241451, 2400.867952262625, 2431.416460049584, 2437.6587277781036, 2457.594496908008, 2432.3067925641194, 2442.3771938155833, 2451.681281433402, 2463.051725085846, 2469.345623409798, 2470.295965649781, 2478.4051827561434, 2489.950200995988, 2506.949861002788, 2509.774120329179, 8353.83292334156, 8414.410991230616, 8449.070602233749, 8456.49261044333, 8478.576071196478, 4939.6789208701675, 5087.364079490064, 5125.743712814382, 5126.897462050775, 5145.76844042019, 3221.0, 3239.1254361322544, 3272.7709060365783, 3419.81191034493, 3433.484977253407, 1020.1849458088923, 1096.1942971915635, 1101.8402331661864, 1103.3600511703194, 1107.634480621393, 11553.306801591847, 11627.069834413227, 11634.243774154653, 11655.067594592498, 11667.06663466929, 4564.0, 4571.085782843378, 4608.870826647493, 4629.375034370384, 4645.5354464553275, 9944.055314745088, 9980.850287245697, 10006.79986400268, 10019.749506262402, 10026.498675066217, 5123.436421993578, 5125.026245013435, 5160.561352285098, 5166.276721259027, 5181.637285390062, 4592.104539614743, 4636.5131661175765, 4652.418447694038, 4671.135839869635, 4712.787924543404, 3941.8620348288246, 3973.7417067890497, 3991.6806655467494, 3992.1017771001293, 4033.5361433434946, 1205.584073494643, 1209.1173443386376, 1212.1636071110904, 1215.2769102384068, 1225.601679454163, 1275.101053757099, 1296.3194322980323, 1307.1242267680486, 1400.2578633324354, 1410.9365078571489, 7947.9205207948335, 7999.680012799423, 8125.3499720022255, 8147.75556733299, 8159.67361305553, 1084.7233955341496, 1140.7319279969201, 1186.661801386618, 1200.783858905388, 1209.9697507562205, 6247.406496382836, 6335.65153916539, 6346.2067241594805, 6422.903656445157, 6425.389587989227, 9811.264155188246, 10057.14514266281, 10110.090091891765, 10157.492125393701, 10192.388456692473, 9702.223822094216, 9840.901590984142, 9899.059589339002, 9991.850122248172, 10042.447665378328, 8001.8799718004275, 8026.5986700664735, 8038.638261278256, 8058.758237252891, 8107.351411887035, 7619.9238007619215, 7636.80907977305, 7717.0, 7742.845143097219, 7766.805829854299, 8946.194842464209, 9021.368504204642, 9060.773480663036, 9093.4998575079, 9263.861042084509, 9187.6924307248, 9338.673146439842, 9364.157225849705, 9365.438073715326, 9457.0, 7197.064381630355, 7222.96388518054, 7270.2366251544945, 7526.32263096324, 7559.3196612305155, 7732.265434783687, 7805.024371953506, 7806.687732490636, 7821.882671760042, 7830.765077047698, 7370.6314684266645, 7534.284242996907, 7537.9623101884135, 7549.886751698619, 7602.923970760443, 7381.372583330262, 7496.962515187389, 7533.1336896257635, 7573.431992600466, 7614.390848731978, 7472.364848987897, 7554.886676699744, 7564.016677831846, 7587.393008559192, 7598.354139898171, 6779.186497620317, 6822.624755638488, 6836.145481814773, 6860.416864566568, 7015.719371225094, 6637.303083176197, 6654.700538475683, 6687.598744075371, 6690.431313338421, 6733.696983635846], "unit": "ms", "name": "mootools.html", "value": 4844.143419854802}, {"lowerIsBetter": false, "replicates": [364.84494090011736, 373.98090204193556, 376.9283836071145, 377.66010590468574, 379.2907263417408, 6223.4398904098625, 6319.968400157998, 6332.240131184259, 6335.493160547157, 6380.776672816452, 6220.564560480768, 6315.873682526347, 6334.081558174062, 6336.65148416838, 6350.237971443434, 4898.240772680231, 4900.289458028584, 4915.6313276504225, 4916.901661966758, 4924.0, 4921.655484116113, 4922.26166075088, 4924.556789888909, 4928.507149285061, 4935.23503856901, 4667.789949452283, 4822.0, 4855.878603034917, 4857.101436234308, 4865.318855360252, 4850.636202284825, 4861.173600487908, 4864.537868902448, 4867.075255701406, 4875.658703890729, 4159.91680166398, 4244.469441319835, 4249.68127390447, 4261.637760790337, 4275.0594869128745, 5955.225820643289, 5990.490808281302, 6008.429199226067, 6010.0, 6042.214512113397, 5619.0, 5653.077953495831, 5669.348024977139, 5686.914696279559, 5688.715564221772, 6534.346565343475, 6737.764178253738, 6747.561408508432, 6749.696263668097, 6776.186857577073, 4732.929006064912, 4734.668573199878, 4735.052989402134, 4736.123817093814, 4739.644526660514, 6971.8605627887155, 7001.82495437613, 7048.083749112634, 7058.7529436469995, 7065.328793764585, 4842.854714358575, 4849.393825771778, 4853.490383509751, 4856.854294371175, 4859.0039041997015, 4837.032593481247, 4890.095332363524, 4914.92627610579, 4916.287138364989, 4918.1884988977135, 5619.157126430986, 5623.0721930880945, 5653.547716182696, 5655.6606603603095, 5661.094224924075, 6756.527043107034, 6759.391654750998, 6784.59292442455, 6802.55783374089, 6803.047573339736, 1705.249690136336, 1712.9286032358568, 1734.4363081998401, 1734.878558500918, 1735.4186347573452, 1149.3219000789575, 1154.8267759835924, 1174.8061569841052, 1175.0658226709616, 1179.8938095571439, 6417.262014868256, 6443.130177426081, 6465.676716164173, 6466.06242094903, 6466.708998095097, 7006.859862802716, 7034.151168776653, 7038.331358520933, 7042.929570704227, 7062.011318415426, 6319.33646967071, 6391.744330226832, 6420.133282006869, 6458.515611329169, 6460.192475940507, 3761.247750449921, 3815.141593141521, 3833.674137698271, 3838.500994870649, 3843.1929294847837, 7211.206767255598, 7261.237570055174, 7283.672234749449, 7298.854022919512, 7299.5255308404785, 7219.0, 7232.855342893218, 7267.30960558746, 7270.527415717961, 7284.417246620258, 7101.2898710128575, 7223.494355395177, 7241.131064272321, 7251.56490610565, 7256.89114663291, 7107.466939979418, 7109.928900710926, 7115.146182458138, 7118.537295075804, 7137.10786151731, 6968.163820341591, 6995.440364770704, 6995.615241161785, 7010.68451919675, 7016.964915175596, 7037.648117594203, 7244.529105608119, 7258.963705181441, 7264.673089711081, 7264.818379540554, 4829.323894654681, 4842.443119041355, 4878.658493905393, 4883.658143930033, 4895.485973972682, 7080.893786593102, 7086.50394472382, 7089.113860767404, 7104.0, 7109.28907109285, 6710.530262881552, 6834.726610935507, 6835.179778426621, 6870.965645171742, 6935.549189302679, 6843.0, 6907.274736152632, 6912.4815638828295, 6912.55068420551, 6938.375546200866, 6655.667216639052, 6780.627065511444, 6800.217974932946, 6809.319068093151, 6809.8638027238185, 6935.965320173367, 6947.40947019509, 6952.860942781015, 6953.061336719478, 6954.165500140016, 6736.124303840469, 6770.729170833111, 6775.085363476065, 6788.25329213796, 6790.558613690095], "unit": "ms", "name": "prototype.html", "value": 5140.151181354122}, {"lowerIsBetter": false, "replicates": [746.4886552711397, 783.6238605469374, 790.4111436979451, 881.6473410635747, 898.4160295807724, 13973.23147226902, 14166.362513686883, 14180.290985450712, 14211.573652790406, 14256.144631322128, 12822.551210707627, 12878.098533102686, 12949.158304710187, 12981.74036519269, 12992.15550989185, 743.49813875634, 756.3986630628636, 890.5725251879102, 902.0438335364502, 909.8180363927208, 890.2922176869405, 892.5448021509045, 900.4597241654988, 900.9414388064788, 901.7384958362068, 936.0826390137669, 943.0, 943.1841457139559, 943.9433633981948, 947.1901524196782, 934.6261495401826, 934.8410770169088, 935.0742764662934, 937.9729196529789, 938.061938061938, 697.5396238482577, 697.9685914133876, 699.6152116336045, 700.6776882633994, 701.1376007510739, 13242.801357979639, 13296.401661925236, 13326.466941322335, 13344.933275333562, 13350.26573538455, 13189.208647481182, 13393.330333483287, 13533.796993045014, 13645.590632281048, 13751.724965500734, 10877.945610271978, 10935.507902144423, 10936.518539936456, 11004.284721493077, 11343.886561134366, 3790.9431358529646, 3874.4769456123345, 3893.824777885002, 3901.6683581895572, 3904.375299951994, 50013.24980125301, 50539.24191137136, 51278.7436062821, 51417.742911285575, 51786.22320665193, 9782.217422606174, 9822.214222862154, 10002.749931251778, 10006.599736010623, 10098.343607665478, 19366.128524216445, 19572.902135489232, 19817.504562385766, 19971.0, 20009.899950500156, 7780.2380155045275, 7819.960900195462, 7836.725714599962, 7890.763277101696, 8053.355731541463, 4517.11916176349, 4568.862934111982, 4575.748333841604, 4635.536446355338, 4731.0, 3219.4365985952363, 3257.2345498807763, 3262.8042317461027, 3271.247613049012, 3272.0, 580.2282963658324, 587.6532845621018, 605.1074664869283, 605.6487237402296, 607.4229481992126, 620.6896551724138, 625.3402660193449, 700.7617410080597, 701.2216439751871, 728.4536597551836, 8399.328053755686, 9332.440053596805, 9748.635191073256, 9882.160016398686, 9951.55218015191, 612.1796792298342, 668.6355936014884, 671.3119052970744, 715.5563550598662, 730.6237287796789, 3912.56961734209, 4059.7361171523758, 4110.34234522475, 4289.077848262638, 4448.154850578379, 61277.0, 62034.37965620286, 62207.37792622016, 62891.685541572915, 64188.0, 54128.72935635297, 54464.0, 55189.72405137949, 55592.72203638956, 56179.157312640345, 48114.759426203345, 49222.0, 49408.50591494111, 49655.75172124116, 50248.0, 9176.770580735269, 9401.52992350366, 9431.952840235756, 9566.378185417925, 9600.951995239979, 35503.28993420169, 36624.81687591545, 36794.26411471809, 37048.07379815418, 37412.625873742, 44138.779306104545, 44149.77925110354, 50686.746566266935, 51523.22715159201, 52004.0, 12041.698957526132, 12151.392430378623, 12191.756164876475, 12229.3273869938, 12273.263604183778, 13057.542985995824, 13413.128146670435, 13658.0, 13670.17978921268, 13933.094348867291, 11511.30932144074, 11864.0, 12033.518659253532, 12296.75406491883, 12599.43302551369, 11385.430728463378, 11875.168738188244, 11894.226875253082, 11940.402979851146, 12053.216540924812, 12064.215825971283, 12065.879341206826, 12284.0786940978, 12325.383730813603, 12341.444634991627, 10193.745156370853, 10449.895501045195, 10518.316309439862, 10616.681499555025, 10644.89355106439, 9923.55344009507, 10407.739806504898, 10455.68632941013, 10526.631567895087, 10571.471426428801], "unit": "ms", "name": "yui.html", "value": 6721.979733122368}], "name": "dromaeo_css", "value": 7429.294653653989}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 103.0, 108.0, 109.0, 108.0, 120.0, 109.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [157.0, 133.0, 143.0, 162.0, 124.0, 144.0, 153.0, 125.0, 164.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 160.0, 165.0, 162.0, 160.0, 162.0, 164.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [78.0, 71.0, 71.0, 147.0, 72.0, 71.0, 73.0, 72.0, 154.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 87.9}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 135.0, 92.0, 93.0, 93.0, 136.0, 91.0, 93.0, 142.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 111.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 97.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [60.0, 64.0, 63.0, 65.0, 62.0, 63.0, 64.0, 68.0, 60.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 62.9}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 82.0, 81.0, 81.0, 84.0, 85.0, 90.0, 81.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [117.0, 111.0, 123.0, 112.0, 118.0, 113.0, 123.0, 124.0, 118.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.9}, {"lowerIsBetter": true, "replicates": [140.0, 146.0, 144.0, 145.0, 147.0, 146.0, 148.0, 147.0, 157.0, 148.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 70.0, 65.0, 66.0, 66.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1503.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.08536787908986], "unit": "score", "name": "Richards", "value": 212.55334200000007}, {"lowerIsBetter": false, "replicates": [173.40038148083926], "unit": "score", "name": "DeltaBlue", "value": 381.302506}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [924.2144177449168], "unit": "score", "name": "RayTrace", "value": 800.6680980000003}, {"lowerIsBetter": false, "replicates": [547.0459518599563], "unit": "score", "name": "Earley", "value": 1218.294364}, {"lowerIsBetter": false, "replicates": [10923.91304347826], "unit": "score", "name": "Boyer", "value": 61.0095482587065}, {"lowerIsBetter": false, "replicates": [24238.095238095237], "unit": "score", "name": "RegExp", "value": 37.5848428290766}, {"lowerIsBetter": false, "replicates": [525.4860746190226], "unit": "score", "name": "Splay", "value": 155.077373}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23113.74333784594}]} 20:07:31 INFO - RETURN: dromaeo_css: 7429.29 20:07:31 INFO - RETURN: kraken: 1503.40 20:07:31 INFO - RETURN: v8_7: 23113.74 20:07:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23113.74"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1503.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7429.29"}}} 20:07:31 INFO - Return code: 0 20:07:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:07:31 INFO - # TBPL SUCCESS # 20:07:31 INFO - Running post-action listener: _resource_record_post_action 20:07:31 INFO - Running post-run listener: _resource_record_post_run 20:07:32 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 8040448; Write bytes: 409174016; Read time: 1356; Write time: 366140 20:07:32 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 12369920; Read time: 0; Write time: 18180 20:07:32 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 6279168; Write bytes: 396804096; Read time: 1300; Write time: 347960 20:07:32 INFO - Running post-run listener: _upload_blobber_files 20:07:32 INFO - Blob upload gear active. 20:07:32 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:07:32 INFO - Copying logs to upload dir... 20:07:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1278.175457 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-24 20:07:32.479593) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-24 20:07:32.482614) ========= 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=232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009888 build_url: 'https://queue.taskcluster.net/v1/task/hB2rnSxvSjG3WKkEsZgAQA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-24 20:07:32.505103) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 20:07:32.505432) ========= 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=232498196343f89f466a4a9a000001c8-1453687185.55491-1000783123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 20:07:32.555193) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 20:07:32.555512) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 20:07:32.555836) ========= ========= Total master_lag: 0.81 =========