builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1453460760.95 results: success (0) buildid: 20160122004004 builduid: a7f31d4d01a2481db48f56fa0acd340c revision: 41159a21b1aaee33952d73720715f45aeb6b04e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:00.954701) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:00.955150) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:00.955430) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004404 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:00.985284) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:00.985566) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:01.023849) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:01.024116) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:01.074585) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:01.074882) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:01.075236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:01.075511) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 03:06:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-01-22 03:06:01 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.215610 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:01.305282) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:01.305592) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020014 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:01.354643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:01.355010) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 41159a21b1aaee33952d73720715f45aeb6b04e3 --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 41159a21b1aaee33952d73720715f45aeb6b04e3 --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=516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 03:06:01,594 truncating revision to first 12 chars 2016-01-22 03:06:01,594 Setting DEBUG logging. 2016-01-22 03:06:01,594 attempt 1/10 2016-01-22 03:06:01,594 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/41159a21b1aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 03:06:01,834 unpacking tar archive at: mozilla-aurora-41159a21b1aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571057 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:01.938492) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:01.938811) ========= echo 41159a21b1aaee33952d73720715f45aeb6b04e3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'41159a21b1aaee33952d73720715f45aeb6b04e3'] 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=516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 41159a21b1aaee33952d73720715f45aeb6b04e3 program finished with exit code 0 elapsedTime=0.004026 script_repo_revision: '41159a21b1aaee33952d73720715f45aeb6b04e3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:01.989433) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:01.989871) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 03:06:02.000007) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-22 03:06:02.000326) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:06:02 INFO - MultiFileLogger online at 20160122 03:06:02 in /builds/slave/test-pgo 03:06:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:06:02 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:06:02 INFO - {'append_to_log': False, 03:06:02 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:06:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:06:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:06:02 INFO - 'branch': 'Mozilla-Aurora', 03:06:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:06:02 INFO - 'config_files': ('talos/linux_config.py',), 03:06:02 INFO - 'default_actions': ('clobber', 03:06:02 INFO - 'read-buildbot-config', 03:06:02 INFO - 'download-and-extract', 03:06:02 INFO - 'populate-webroot', 03:06:02 INFO - 'create-virtualenv', 03:06:02 INFO - 'install', 03:06:02 INFO - 'run-tests'), 03:06:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:06:02 INFO - 'download_minidump_stackwalk': True, 03:06:02 INFO - 'download_symbols': 'ondemand', 03:06:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:06:02 INFO - 'tooltool.py': '/tools/tooltool.py', 03:06:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:06:02 INFO - '/tools/misc-python/virtualenv.py')}, 03:06:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:06:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:06:02 INFO - 'installer_path': 'installer.exe', 03:06:02 INFO - 'log_level': 'info', 03:06:02 INFO - 'log_name': 'talos', 03:06:02 INFO - 'log_to_console': True, 03:06:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:06:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:06:02 INFO - 'opt_config_files': (), 03:06:02 INFO - 'pip_index': False, 03:06:02 INFO - 'sps_profile': False, 03:06:02 INFO - 'sps_profile_interval': 0, 03:06:02 INFO - 'suite': 'dromaeojs-e10s', 03:06:02 INFO - 'system_bits': '32', 03:06:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:06:02 INFO - 'title': 'talos-linux64-ix-061', 03:06:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:06:02 INFO - 'use_talos_json': True, 03:06:02 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:06:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:06:02 INFO - 'work_dir': 'build'} 03:06:02 INFO - ##### 03:06:02 INFO - ##### Running clobber step. 03:06:02 INFO - ##### 03:06:02 INFO - Running pre-action listener: _resource_record_pre_action 03:06:02 INFO - Running main action method: clobber 03:06:02 INFO - rmtree: /builds/slave/test-pgo/build 03:06:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:06:03 INFO - Running post-action listener: _resource_record_post_action 03:06:03 INFO - ##### 03:06:03 INFO - ##### Running read-buildbot-config step. 03:06:03 INFO - ##### 03:06:03 INFO - Running pre-action listener: _resource_record_pre_action 03:06:03 INFO - Running main action method: read_buildbot_config 03:06:03 INFO - Using buildbot properties: 03:06:03 INFO - { 03:06:03 INFO - "properties": { 03:06:03 INFO - "buildnumber": 11, 03:06:03 INFO - "product": "firefox", 03:06:03 INFO - "script_repo_revision": "production", 03:06:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:06:03 INFO - "repository": "", 03:06:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:06:03 INFO - "buildid": "20160122004004", 03:06:03 INFO - "slavename": "talos-linux64-ix-061", 03:06:03 INFO - "stage_platform": "linux64-pgo", 03:06:03 INFO - "basedir": "/builds/slave/test-pgo", 03:06:03 INFO - "nightly_build": "True", 03:06:03 INFO - "project": "", 03:06:03 INFO - "platform": "ubuntu64_hw", 03:06:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:06:03 INFO - "slavebuilddir": "test", 03:06:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:06:03 INFO - "branch": "mozilla-aurora", 03:06:03 INFO - "repo_path": "releases/mozilla-aurora", 03:06:03 INFO - "pgo_build": "True", 03:06:03 INFO - "builduid": "a7f31d4d01a2481db48f56fa0acd340c", 03:06:03 INFO - "revision": "41159a21b1aaee33952d73720715f45aeb6b04e3" 03:06:03 INFO - }, 03:06:03 INFO - "sourcestamp": { 03:06:03 INFO - "repository": "", 03:06:03 INFO - "hasPatch": false, 03:06:03 INFO - "project": "", 03:06:03 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:06:03 INFO - "changes": [ 03:06:03 INFO - { 03:06:03 INFO - "category": null, 03:06:03 INFO - "files": [ 03:06:03 INFO - { 03:06:03 INFO - "url": null, 03:06:03 INFO - "name": "https://queue.taskcluster.net/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 03:06:03 INFO - } 03:06:03 INFO - ], 03:06:03 INFO - "repository": "", 03:06:03 INFO - "rev": "41159a21b1aaee33952d73720715f45aeb6b04e3", 03:06:03 INFO - "who": "sendchange", 03:06:03 INFO - "when": 1453460644, 03:06:03 INFO - "number": 7499252, 03:06:03 INFO - "comments": "", 03:06:03 INFO - "project": "", 03:06:03 INFO - "at": "Fri 22 Jan 2016 03:04:04", 03:06:03 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:06:03 INFO - "revlink": "", 03:06:03 INFO - "properties": [ 03:06:03 INFO - [ 03:06:03 INFO - "buildid", 03:06:03 INFO - "20160122004004", 03:06:03 INFO - "Change" 03:06:03 INFO - ], 03:06:03 INFO - [ 03:06:03 INFO - "builduid", 03:06:03 INFO - "a7f31d4d01a2481db48f56fa0acd340c", 03:06:03 INFO - "Change" 03:06:03 INFO - ], 03:06:03 INFO - [ 03:06:03 INFO - "nightly_build", 03:06:03 INFO - "True", 03:06:03 INFO - "Change" 03:06:03 INFO - ], 03:06:03 INFO - [ 03:06:03 INFO - "pgo_build", 03:06:03 INFO - "True", 03:06:03 INFO - "Change" 03:06:03 INFO - ] 03:06:03 INFO - ], 03:06:03 INFO - "revision": "41159a21b1aaee33952d73720715f45aeb6b04e3" 03:06:03 INFO - } 03:06:03 INFO - ], 03:06:03 INFO - "revision": "41159a21b1aaee33952d73720715f45aeb6b04e3" 03:06:03 INFO - } 03:06:03 INFO - } 03:06:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 03:06:03 INFO - Running post-action listener: _resource_record_post_action 03:06:03 INFO - ##### 03:06:03 INFO - ##### Running download-and-extract step. 03:06:03 INFO - ##### 03:06:03 INFO - Running pre-action listener: _resource_record_pre_action 03:06:03 INFO - Running main action method: download_and_extract 03:06:03 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:03 INFO - https://queue.taskcluster.net/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:06:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/test_packages.json 03:06:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/test_packages.json 03:06:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:06:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:06:05 INFO - Downloaded 1302 bytes. 03:06:05 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:06:05 INFO - Using the following test package requirements: 03:06:05 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:06:05 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:06:05 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:06:05 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:06:05 INFO - u'jsshell-linux-x86_64.zip'], 03:06:05 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:06:05 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:06:05 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:06:05 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:06:05 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:06:05 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:06:05 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:06:05 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:06:05 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:06:05 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:06:05 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:06:05 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:06:05 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:05 INFO - https://queue.taskcluster.net/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:06:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:06:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:06:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:06:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:06:06 INFO - Downloaded 23159276 bytes. 03:06:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:06:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:06:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:06:07 INFO - Return code: 0 03:06:07 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:07 INFO - https://queue.taskcluster.net/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:06:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:06:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:06:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:06:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:06:15 INFO - Downloaded 23159276 bytes. 03:06:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:06:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:06:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:06:16 INFO - Return code: 0 03:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:16 INFO - https://queue.taskcluster.net/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:06:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:06:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:06:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:06:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:06:17 INFO - Downloaded 11132038 bytes. 03:06:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 03:06:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:06:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:06:17 INFO - Return code: 0 03:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:17 INFO - https://queue.taskcluster.net/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:06:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:06:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:06:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:06:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:06:19 INFO - Downloaded 58140595 bytes. 03:06:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:06:19 INFO - mkdir: /builds/slave/test-pgo/properties 03:06:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:06:19 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:06:19 INFO - Contents: 03:06:19 INFO - build_url:https://queue.taskcluster.net/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:06:19 INFO - Running post-action listener: _resource_record_post_action 03:06:19 INFO - Running post-action listener: set_extra_try_arguments 03:06:19 INFO - ##### 03:06:19 INFO - ##### Running populate-webroot step. 03:06:19 INFO - ##### 03:06:19 INFO - Running pre-action listener: _resource_record_pre_action 03:06:19 INFO - Running main action method: populate_webroot 03:06:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:06:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:06:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:06:19 INFO - '--tppagecycles', 03:06:19 INFO - '7'], 03:06:19 INFO - 'tests': ['tsvgm']}}, 03:06:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:06:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:06:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:06:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:06:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:06:19 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:06:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:19 INFO - 'talos_options': ['--e10s'], 03:06:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:19 INFO - 'tests': ['damp', 'tps']}, 03:06:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:19 INFO - 'talos_options': ['--e10s'], 03:06:19 INFO - 'tests': ['damp', 'tps']}, 03:06:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:06:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:06:19 INFO - 'other': {'tests': ['a11yr', 03:06:19 INFO - 'ts_paint', 03:06:19 INFO - 'tpaint', 03:06:19 INFO - 'sessionrestore', 03:06:19 INFO - 'sessionrestore_no_auto_restore']}, 03:06:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:06:19 INFO - 'tests': ['a11yr', 03:06:19 INFO - 'ts_paint', 03:06:19 INFO - 'tpaint', 03:06:19 INFO - 'sessionrestore', 03:06:19 INFO - 'sessionrestore_no_auto_restore']}, 03:06:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:06:19 INFO - 'tests': ['a11yr', 03:06:19 INFO - 'ts_paint', 03:06:19 INFO - 'tpaint', 03:06:19 INFO - 'sessionrestore', 03:06:19 INFO - 'sessionrestore_no_auto_restore']}, 03:06:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:06:19 INFO - 'tests': ['a11yr', 03:06:19 INFO - 'ts_paint', 03:06:19 INFO - 'tpaint', 03:06:19 INFO - 'sessionrestore', 03:06:19 INFO - 'sessionrestore_no_auto_restore']}, 03:06:19 INFO - 'other_l64': {'tests': ['a11yr', 03:06:19 INFO - 'ts_paint', 03:06:19 INFO - 'tpaint', 03:06:19 INFO - 'sessionrestore', 03:06:19 INFO - 'sessionrestore_no_auto_restore']}, 03:06:19 INFO - 'other_nol64': {'tests': ['a11yr', 03:06:19 INFO - 'ts_paint', 03:06:19 INFO - 'tpaint', 03:06:19 INFO - 'sessionrestore', 03:06:19 INFO - 'sessionrestore_no_auto_restore']}, 03:06:19 INFO - 'svgr': {'tests': ['tsvgx', 03:06:19 INFO - 'tsvgr_opacity', 03:06:19 INFO - 'tart', 03:06:19 INFO - 'tscrollx', 03:06:19 INFO - 'cart']}, 03:06:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:06:19 INFO - 'tests': ['tsvgx', 03:06:19 INFO - 'tsvgr_opacity', 03:06:19 INFO - 'tart', 03:06:19 INFO - 'tscrollx', 03:06:19 INFO - 'cart']}, 03:06:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:19 INFO - 'tests': ['tp5o']}, 03:06:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:19 INFO - 'talos_options': ['--e10s'], 03:06:19 INFO - 'tests': ['tp5o']}, 03:06:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:19 INFO - 'talos_options': ['--xperf_path', 03:06:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:19 INFO - 'tests': ['tp5n']}, 03:06:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:06:19 INFO - 'talos_options': ['--e10s', 03:06:19 INFO - '--xperf_path', 03:06:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:19 INFO - 'tests': ['tp5n']}}, 03:06:19 INFO - 'talos.zip': {'path': '', 03:06:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:06:19 INFO - Running post-action listener: _resource_record_post_action 03:06:19 INFO - ##### 03:06:19 INFO - ##### Running create-virtualenv step. 03:06:19 INFO - ##### 03:06:19 INFO - Running pre-action listener: _resource_record_pre_action 03:06:19 INFO - Running main action method: create_virtualenv 03:06:19 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:06:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:06:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:06:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:06:19 INFO - Using real prefix '/usr' 03:06:19 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:06:20 INFO - Installing distribute.............................................................................................................................................................................................done. 03:06:22 INFO - Installing pip.................done. 03:06:22 INFO - Return code: 0 03:06:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:06: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')]} 03:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06: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')]} 03:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:22 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 0x7f10c9ba2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6a50>, '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 0x1642550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16429e0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:06:22 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 03:06:22 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 03:06:22 INFO - Using env: {'DISPLAY': ':0', 03:06:22 INFO - 'HOME': '/home/cltbld', 03:06:22 INFO - 'LANG': 'en_US.UTF-8', 03:06:22 INFO - 'LANGUAGE': 'en_US:en', 03:06:22 INFO - 'LOGNAME': 'cltbld', 03:06:22 INFO - 'MAIL': '/var/mail/cltbld', 03:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:22 INFO - 'MOZ_NO_REMOTE': '1', 03:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:22 INFO - 'NO_EM_RESTART': '1', 03:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:22 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:22 INFO - 'SHELL': '/bin/bash', 03:06:22 INFO - 'SHLVL': '1', 03:06:22 INFO - 'TERM': 'linux', 03:06:22 INFO - 'TMOUT': '86400', 03:06:22 INFO - 'USER': 'cltbld', 03:06:22 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 03:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:22 INFO - '_': '/tools/buildbot/bin/python'} 03:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:06:22 INFO - Cleaning up... 03:06:22 INFO - Return code: 0 03:06:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:06: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')]} 03:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06: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')]} 03:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:22 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 0x7f10c9ba2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6a50>, '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 0x1642550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16429e0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:06:22 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 03:06:22 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 03:06:22 INFO - Using env: {'DISPLAY': ':0', 03:06:22 INFO - 'HOME': '/home/cltbld', 03:06:22 INFO - 'LANG': 'en_US.UTF-8', 03:06:22 INFO - 'LANGUAGE': 'en_US:en', 03:06:22 INFO - 'LOGNAME': 'cltbld', 03:06:22 INFO - 'MAIL': '/var/mail/cltbld', 03:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:22 INFO - 'MOZ_NO_REMOTE': '1', 03:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:22 INFO - 'NO_EM_RESTART': '1', 03:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:22 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:22 INFO - 'SHELL': '/bin/bash', 03:06:22 INFO - 'SHLVL': '1', 03:06:22 INFO - 'TERM': 'linux', 03:06:22 INFO - 'TMOUT': '86400', 03:06:22 INFO - 'USER': 'cltbld', 03:06:22 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 03:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:22 INFO - '_': '/tools/buildbot/bin/python'} 03:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:22 INFO - Downloading/unpacking psutil>=0.7.1 03:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:06:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:24 INFO - Installing collected packages: psutil 03:06:24 INFO - Running setup.py install for psutil 03:06:24 INFO - building 'psutil._psutil_linux' extension 03:06:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:06:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:06:24 INFO - building 'psutil._psutil_posix' extension 03:06:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:06:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:06:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:25 INFO - Successfully installed psutil 03:06:25 INFO - Cleaning up... 03:06:25 INFO - Return code: 0 03:06:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:25 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 0x7f10c9ba2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6a50>, '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 0x1642550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16429e0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:06:25 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 03:06:25 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 03:06:25 INFO - Using env: {'DISPLAY': ':0', 03:06:25 INFO - 'HOME': '/home/cltbld', 03:06:25 INFO - 'LANG': 'en_US.UTF-8', 03:06:25 INFO - 'LANGUAGE': 'en_US:en', 03:06:25 INFO - 'LOGNAME': 'cltbld', 03:06:25 INFO - 'MAIL': '/var/mail/cltbld', 03:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:25 INFO - 'MOZ_NO_REMOTE': '1', 03:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:25 INFO - 'NO_EM_RESTART': '1', 03:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:25 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:25 INFO - 'SHELL': '/bin/bash', 03:06:25 INFO - 'SHLVL': '1', 03:06:25 INFO - 'TERM': 'linux', 03:06:25 INFO - 'TMOUT': '86400', 03:06:25 INFO - 'USER': 'cltbld', 03:06:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 03:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:25 INFO - '_': '/tools/buildbot/bin/python'} 03:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:06:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:06:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:06:27 INFO - Installing collected packages: mozsystemmonitor 03:06:27 INFO - Running setup.py install for mozsystemmonitor 03:06:27 INFO - Successfully installed mozsystemmonitor 03:06:27 INFO - Cleaning up... 03:06:27 INFO - Return code: 0 03:06:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:27 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 0x7f10c9ba2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6a50>, '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 0x1642550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16429e0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:06:27 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 03:06:27 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 03:06:27 INFO - Using env: {'DISPLAY': ':0', 03:06:27 INFO - 'HOME': '/home/cltbld', 03:06:27 INFO - 'LANG': 'en_US.UTF-8', 03:06:27 INFO - 'LANGUAGE': 'en_US:en', 03:06:27 INFO - 'LOGNAME': 'cltbld', 03:06:27 INFO - 'MAIL': '/var/mail/cltbld', 03:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:27 INFO - 'MOZ_NO_REMOTE': '1', 03:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:27 INFO - 'NO_EM_RESTART': '1', 03:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:27 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:27 INFO - 'SHELL': '/bin/bash', 03:06:27 INFO - 'SHLVL': '1', 03:06:27 INFO - 'TERM': 'linux', 03:06:27 INFO - 'TMOUT': '86400', 03:06:27 INFO - 'USER': 'cltbld', 03:06:27 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 03:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:27 INFO - '_': '/tools/buildbot/bin/python'} 03:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:27 INFO - Downloading/unpacking blobuploader==1.2.4 03:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:29 INFO - Downloading blobuploader-1.2.4.tar.gz 03:06:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:06:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:06:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:30 INFO - Downloading docopt-0.6.1.tar.gz 03:06:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:06:30 INFO - Installing collected packages: blobuploader, requests, docopt 03:06:30 INFO - Running setup.py install for blobuploader 03:06:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:06:30 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:06:30 INFO - Running setup.py install for requests 03:06:30 INFO - Running setup.py install for docopt 03:06:30 INFO - Successfully installed blobuploader requests docopt 03:06:30 INFO - Cleaning up... 03:06:30 INFO - Return code: 0 03:06:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:30 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 0x7f10c9ba2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6a50>, '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 0x1642550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16429e0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:06:30 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 03:06:30 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 03:06:30 INFO - Using env: {'DISPLAY': ':0', 03:06:30 INFO - 'HOME': '/home/cltbld', 03:06:30 INFO - 'LANG': 'en_US.UTF-8', 03:06:30 INFO - 'LANGUAGE': 'en_US:en', 03:06:30 INFO - 'LOGNAME': 'cltbld', 03:06:30 INFO - 'MAIL': '/var/mail/cltbld', 03:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:30 INFO - 'MOZ_NO_REMOTE': '1', 03:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:30 INFO - 'NO_EM_RESTART': '1', 03:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:30 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:30 INFO - 'SHELL': '/bin/bash', 03:06:30 INFO - 'SHLVL': '1', 03:06:30 INFO - 'TERM': 'linux', 03:06:30 INFO - 'TMOUT': '86400', 03:06:30 INFO - 'USER': 'cltbld', 03:06:30 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 03:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:30 INFO - '_': '/tools/buildbot/bin/python'} 03:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:06:30 INFO - Running setup.py (path:/tmp/pip-neK88s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:06:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:06:30 INFO - Running setup.py (path:/tmp/pip-k3ioaq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:06:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:06:31 INFO - Running setup.py (path:/tmp/pip-GDu3AV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:06:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:06:31 INFO - Running setup.py (path:/tmp/pip-pJEiy3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:06:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:06:31 INFO - Running setup.py (path:/tmp/pip-TW9a0g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:06:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:06:31 INFO - Running setup.py (path:/tmp/pip-OuOytp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:06:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:06:31 INFO - Running setup.py (path:/tmp/pip-NiUgBy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:06:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:06:31 INFO - Running setup.py (path:/tmp/pip-oHgdnq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:06:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:06:31 INFO - Running setup.py (path:/tmp/pip-cq2RKH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:06:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:06:31 INFO - Running setup.py (path:/tmp/pip-Hc4m4Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:06:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:06:31 INFO - Running setup.py (path:/tmp/pip-xTQxkt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:06:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:06:31 INFO - Running setup.py (path:/tmp/pip-cpzkPj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:06:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:06:31 INFO - Running setup.py (path:/tmp/pip-BQ9vnr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:06:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:06:31 INFO - Running setup.py (path:/tmp/pip-E2YYqw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:06:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:06:31 INFO - Running setup.py (path:/tmp/pip-FDpeb8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:06:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:06:32 INFO - Running setup.py (path:/tmp/pip-v6FToI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:06:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:06:32 INFO - Running setup.py (path:/tmp/pip-JE4s9q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:06:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:06:32 INFO - Running setup.py install for manifestparser 03:06:32 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:06:32 INFO - Running setup.py install for mozcrash 03:06:32 INFO - Running setup.py install for mozdebug 03:06:32 INFO - Running setup.py install for mozdevice 03:06:32 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:06:32 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:06:32 INFO - Running setup.py install for mozfile 03:06:32 INFO - Running setup.py install for mozhttpd 03:06:32 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:06:32 INFO - Running setup.py install for mozinfo 03:06:32 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:06:32 INFO - Running setup.py install for mozInstall 03:06:32 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:06:33 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:06:33 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:06:33 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:06:33 INFO - Running setup.py install for mozleak 03:06:33 INFO - Running setup.py install for mozlog 03:06:33 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:06:33 INFO - Running setup.py install for moznetwork 03:06:33 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:06:33 INFO - Running setup.py install for mozprocess 03:06:33 INFO - Running setup.py install for mozprofile 03:06:33 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:06:33 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:06:33 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:06:33 INFO - Running setup.py install for mozrunner 03:06:33 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:06:33 INFO - Running setup.py install for mozscreenshot 03:06:33 INFO - Running setup.py install for moztest 03:06:33 INFO - Running setup.py install for mozversion 03:06:33 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:06:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:06:33 INFO - Cleaning up... 03:06:33 INFO - Return code: 0 03:06:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:33 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 0x7f10c9ba2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6a50>, '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 0x1642550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16429e0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:06:33 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 03:06:33 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 03:06:33 INFO - Using env: {'DISPLAY': ':0', 03:06:33 INFO - 'HOME': '/home/cltbld', 03:06:33 INFO - 'LANG': 'en_US.UTF-8', 03:06:33 INFO - 'LANGUAGE': 'en_US:en', 03:06:33 INFO - 'LOGNAME': 'cltbld', 03:06:33 INFO - 'MAIL': '/var/mail/cltbld', 03:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:33 INFO - 'MOZ_NO_REMOTE': '1', 03:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:33 INFO - 'NO_EM_RESTART': '1', 03:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:33 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:33 INFO - 'SHELL': '/bin/bash', 03:06:33 INFO - 'SHLVL': '1', 03:06:33 INFO - 'TERM': 'linux', 03:06:33 INFO - 'TMOUT': '86400', 03:06:33 INFO - 'USER': 'cltbld', 03:06:33 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 03:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:33 INFO - '_': '/tools/buildbot/bin/python'} 03:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:06:34 INFO - Running setup.py (path:/tmp/pip-2YXmyk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:06:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:06:34 INFO - Running setup.py (path:/tmp/pip-BtFsim-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:06:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:06:34 INFO - Running setup.py (path:/tmp/pip-LMZSLG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:06:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:06:34 INFO - Running setup.py (path:/tmp/pip-i6iJPq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:06:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:06:34 INFO - Running setup.py (path:/tmp/pip-YO8slo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:06:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:06:34 INFO - Running setup.py (path:/tmp/pip-TCPGnQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 03:06:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:06:34 INFO - Running setup.py (path:/tmp/pip-hEIKd2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:06:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:06:34 INFO - Running setup.py (path:/tmp/pip-Xc_jEV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:06:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:06:34 INFO - Running setup.py (path:/tmp/pip-Okh7jD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:06:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:06:34 INFO - Running setup.py (path:/tmp/pip-RZGXIS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:06:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:06:34 INFO - Running setup.py (path:/tmp/pip-CYtDgj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:06:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:06:34 INFO - Running setup.py (path:/tmp/pip-KW61TN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:06:35 INFO - Running setup.py (path:/tmp/pip-OL7bpf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 03:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:06:35 INFO - Running setup.py (path:/tmp/pip-ErOUhX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:06:35 INFO - Running setup.py (path:/tmp/pip-lU6Gtl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:06:35 INFO - Running setup.py (path:/tmp/pip-JvPqRK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:06:35 INFO - Running setup.py (path:/tmp/pip-xoyudU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 03:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:06:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:37 INFO - Downloading blessings-1.6.tar.gz 03:06:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:06:37 INFO - Installing collected packages: blessings 03:06:37 INFO - Running setup.py install for blessings 03:06:37 INFO - Successfully installed blessings 03:06:37 INFO - Cleaning up... 03:06:37 INFO - Return code: 0 03:06:37 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:06:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:06:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:06:37 INFO - Reading from file tmpfile_stdout 03:06:37 INFO - Current package versions: 03:06:37 INFO - argparse == 1.2.1 03:06:37 INFO - blessings == 1.6 03:06:37 INFO - blobuploader == 1.2.4 03:06:37 INFO - docopt == 0.6.1 03:06:37 INFO - manifestparser == 1.1 03:06:37 INFO - mozInstall == 1.12 03:06:37 INFO - mozcrash == 0.16 03:06:37 INFO - mozdebug == 0.1 03:06:37 INFO - mozdevice == 0.47 03:06:37 INFO - mozfile == 1.2 03:06:37 INFO - mozhttpd == 0.7 03:06:37 INFO - mozinfo == 0.9 03:06:37 INFO - mozleak == 0.1 03:06:37 INFO - mozlog == 3.1 03:06:37 INFO - moznetwork == 0.27 03:06:37 INFO - mozprocess == 0.22 03:06:37 INFO - mozprofile == 0.27 03:06:37 INFO - mozrunner == 6.11 03:06:37 INFO - mozscreenshot == 0.1 03:06:37 INFO - mozsystemmonitor == 0.0 03:06:37 INFO - moztest == 0.7 03:06:37 INFO - mozversion == 1.4 03:06:37 INFO - psutil == 3.1.1 03:06:37 INFO - requests == 1.2.3 03:06:37 INFO - wsgiref == 0.1.2 03:06:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:37 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 0x7f10c9ba2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6a50>, '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 0x1642550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16429e0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:06:37 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 03:06:37 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 03:06:37 INFO - Using env: {'DISPLAY': ':0', 03:06:37 INFO - 'HOME': '/home/cltbld', 03:06:37 INFO - 'LANG': 'en_US.UTF-8', 03:06:37 INFO - 'LANGUAGE': 'en_US:en', 03:06:37 INFO - 'LOGNAME': 'cltbld', 03:06:37 INFO - 'MAIL': '/var/mail/cltbld', 03:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:37 INFO - 'MOZ_NO_REMOTE': '1', 03:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:37 INFO - 'NO_EM_RESTART': '1', 03:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:37 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:37 INFO - 'SHELL': '/bin/bash', 03:06:37 INFO - 'SHLVL': '1', 03:06:37 INFO - 'TERM': 'linux', 03:06:37 INFO - 'TMOUT': '86400', 03:06:37 INFO - 'USER': 'cltbld', 03:06:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 03:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:37 INFO - '_': '/tools/buildbot/bin/python'} 03:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:06:37 INFO - Cleaning up... 03:06:37 INFO - Return code: 0 03:06:37 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:37 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 0x7f10c9ba2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6a50>, '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 0x1642550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16429e0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:06:37 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 03:06:37 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 03:06:37 INFO - Using env: {'DISPLAY': ':0', 03:06:37 INFO - 'HOME': '/home/cltbld', 03:06:37 INFO - 'LANG': 'en_US.UTF-8', 03:06:37 INFO - 'LANGUAGE': 'en_US:en', 03:06:37 INFO - 'LOGNAME': 'cltbld', 03:06:37 INFO - 'MAIL': '/var/mail/cltbld', 03:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:37 INFO - 'MOZ_NO_REMOTE': '1', 03:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:37 INFO - 'NO_EM_RESTART': '1', 03:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:37 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:37 INFO - 'SHELL': '/bin/bash', 03:06:37 INFO - 'SHLVL': '1', 03:06:37 INFO - 'TERM': 'linux', 03:06:37 INFO - 'TMOUT': '86400', 03:06:37 INFO - 'USER': 'cltbld', 03:06:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 03:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:37 INFO - '_': '/tools/buildbot/bin/python'} 03:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:38 INFO - Downloading/unpacking jsonschema 03:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:06:39 INFO - Downloading/unpacking functools32 (from jsonschema) 03:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:39 INFO - Downloading functools32-3.2.3-2.tar.gz 03:06:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:06:40 INFO - warning: no files found matching '*.txt' 03:06:40 INFO - no previously-included directories found matching 'build' 03:06:40 INFO - no previously-included directories found matching 'dist' 03:06:40 INFO - no previously-included directories found matching '.git*' 03:06:40 INFO - Installing collected packages: jsonschema, functools32 03:06:40 INFO - Running setup.py install for functools32 03:06:40 INFO - warning: no files found matching '*.txt' 03:06:40 INFO - no previously-included directories found matching 'build' 03:06:40 INFO - no previously-included directories found matching 'dist' 03:06:40 INFO - no previously-included directories found matching '.git*' 03:06:40 INFO - Successfully installed jsonschema functools32 03:06:40 INFO - Cleaning up... 03:06:40 INFO - Return code: 0 03:06:40 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:40 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 0x7f10c9ba2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6a50>, '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 0x1642550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16429e0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:06:40 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 03:06:40 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 03:06:40 INFO - Using env: {'DISPLAY': ':0', 03:06:40 INFO - 'HOME': '/home/cltbld', 03:06:40 INFO - 'LANG': 'en_US.UTF-8', 03:06:40 INFO - 'LANGUAGE': 'en_US:en', 03:06:40 INFO - 'LOGNAME': 'cltbld', 03:06:40 INFO - 'MAIL': '/var/mail/cltbld', 03:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:40 INFO - 'MOZ_NO_REMOTE': '1', 03:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:40 INFO - 'NO_EM_RESTART': '1', 03:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:40 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:40 INFO - 'SHELL': '/bin/bash', 03:06:40 INFO - 'SHLVL': '1', 03:06:40 INFO - 'TERM': 'linux', 03:06:40 INFO - 'TMOUT': '86400', 03:06:40 INFO - 'USER': 'cltbld', 03:06:40 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 03:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:40 INFO - '_': '/tools/buildbot/bin/python'} 03:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:40 INFO - Downloading/unpacking flake8 03:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:06:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:06:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:06:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:06:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:06:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:06:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:06:42 INFO - no previously-included directories found matching 'docs/_build' 03:06:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:06:42 INFO - Running setup.py install for pep8 03:06:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:06:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:06:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:06:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:06:43 INFO - no previously-included directories found matching 'docs/_build' 03:06:43 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:06:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:06:43 INFO - Cleaning up... 03:06:43 INFO - Return code: 0 03:06:43 INFO - Running post-action listener: _resource_record_post_action 03:06:43 INFO - Running post-action listener: _start_resource_monitoring 03:06:43 INFO - Starting resource monitoring. 03:06:43 INFO - ##### 03:06:43 INFO - ##### Running install step. 03:06:43 INFO - ##### 03:06:43 INFO - Running pre-action listener: _resource_record_pre_action 03:06:43 INFO - Running main action method: install 03:06:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:06:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:06:43 INFO - Reading from file tmpfile_stdout 03:06:43 INFO - Detecting whether we're running mozinstall >=1.0... 03:06:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:06:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:06:43 INFO - Reading from file tmpfile_stdout 03:06:43 INFO - Output received: 03:06:43 INFO - Usage: mozinstall [options] installer 03:06:43 INFO - Options: 03:06:43 INFO - -h, --help show this help message and exit 03:06:43 INFO - -d DEST, --destination=DEST 03:06:43 INFO - Directory to install application into. [default: 03:06:43 INFO - "/builds/slave/test-pgo"] 03:06:43 INFO - --app=APP Application being installed. [default: firefox] 03:06:43 INFO - mkdir: /builds/slave/test-pgo/build/application 03:06:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:06:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:06:58 INFO - Reading from file tmpfile_stdout 03:06:58 INFO - Output received: 03:06:58 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:06:58 INFO - Running post-action listener: _resource_record_post_action 03:06:58 INFO - ##### 03:06:58 INFO - ##### Running run-tests step. 03:06:58 INFO - ##### 03:06:58 INFO - Running pre-action listener: _resource_record_pre_action 03:06:58 INFO - Running main action method: run_tests 03:06:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:06:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:06:58 INFO - Python 2.7.3 03:06:58 INFO - Return code: 0 03:06:58 INFO - grabbing minidump binary from tooltool 03:06: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')]} 03:06:58 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 0x16d6a50>, '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 0x1642550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16429e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:06:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 03:06:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:06:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:06:58 INFO - Return code: 0 03:06:58 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:06:58 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:06:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:06:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:06:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:06:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:06:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:06:59 INFO - Return code: 0 03:06:59 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/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:06:59 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/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost 03:06:59 INFO - Using env: {'DISPLAY': ':0', 03:06:59 INFO - 'HOME': '/home/cltbld', 03:06:59 INFO - 'LANG': 'en_US.UTF-8', 03:06:59 INFO - 'LANGUAGE': 'en_US:en', 03:06:59 INFO - 'LOGNAME': 'cltbld', 03:06:59 INFO - 'MAIL': '/var/mail/cltbld', 03:06:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:06:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:59 INFO - 'MOZ_NO_REMOTE': '1', 03:06:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:59 INFO - 'NO_EM_RESTART': '1', 03:06:59 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:06:59 INFO - 'PWD': '/builds/slave/test-pgo', 03:06:59 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:06:59 INFO - 'SHELL': '/bin/bash', 03:06:59 INFO - 'SHLVL': '1', 03:06:59 INFO - 'TERM': 'linux', 03:06:59 INFO - 'TMOUT': '86400', 03:06:59 INFO - 'USER': 'cltbld', 03:06:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357', 03:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:59 INFO - '_': '/tools/buildbot/bin/python'} 03:06:59 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/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] with output_timeout 3600 03:06:59 INFO - mozversion INFO | application_buildid: 20160122004004 03:06:59 INFO - mozversion INFO | application_changeset: 41159a21b1aaee33952d73720715f45aeb6b04e3 03:06:59 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:06:59 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:06:59 INFO - mozversion INFO | application_name: Firefox 03:06:59 INFO - mozversion INFO | application_remotingname: firefox-dev 03:06:59 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:06:59 INFO - mozversion INFO | application_vendor: Mozilla 03:06:59 INFO - mozversion INFO | application_version: 45.0a2 03:06:59 INFO - mozversion INFO | platform_buildid: 20160122004004 03:06:59 INFO - mozversion INFO | platform_changeset: 41159a21b1aaee33952d73720715f45aeb6b04e3 03:06:59 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:06:59 INFO - mozversion INFO | platform_version: 45.0a2 03:06:59 INFO - 2016-01-22 03:06:59,383 DEBUG : using testdate: 1453460819 03:06:59 INFO - 2016-01-22 03:06:59,383 DEBUG : actual date: 1453460819 03:06:59 INFO - 2016-01-22 03:06:59,390 INFO : starting webserver on 'localhost:37518' 03:06:59 INFO - 2016-01-22 03:06:59,391 INFO : Starting test suite talos-linux64-ix-061.e 03:06:59 INFO - 2016-01-22 03:06:59,391 INFO : Starting test dromaeo_css 03:06:59 INFO - 2016-01-22 03:06:59,391 DEBUG : operating with platform_type : linux_ 03:06:59 INFO - 2016-01-22 03:06:59,392 INFO : Initialising browser for dromaeo_css test... 03:06:59 INFO - 2016-01-22 03:06:59,404 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHM2En0/profile http://localhost:37518/getInfo.html 03:07:03 INFO - 2016-01-22 03:07:03,223 DEBUG : BROWSER_OUTPUT: 03:07:03 INFO - 2016-01-22 03:07:03,224 DEBUG : BROWSER_OUTPUT: (process:27965): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:07:04 INFO - 2016-01-22 03:07:04,341 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:07:04 INFO - 2016-01-22 03:07:04,342 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:07:04 INFO - 2016-01-22 03:07:04,342 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:07:04 INFO - 2016-01-22 03:07:04,342 DEBUG : BROWSER_OUTPUT: __metrics 03:07:05 INFO - 2016-01-22 03:07:05,308 INFO : Browser initialized. 03:07:05 INFO - 2016-01-22 03:07:05,308 INFO : Running cycle 1/1 for dromaeo_css test... 03:07:05 INFO - 2016-01-22 03:07:05,308 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHM2En0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:07:06 INFO - 2016-01-22 03:07:06,632 DEBUG : BROWSER_OUTPUT: 03:07:06 INFO - 2016-01-22 03:07:06,633 DEBUG : BROWSER_OUTPUT: (process:28080): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:07:17 INFO - 2016-01-22 03:07:17,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 136687616 03:07:17 INFO - 2016-01-22 03:07:17,137 DEBUG : BROWSER_OUTPUT: 03:08:06 INFO - 2016-01-22 03:08:06,754 DEBUG : BROWSER_OUTPUT: 1453460886747 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:10:14 INFO - 2016-01-22 03:10:14,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37518/tests/dromaeo/cssquery-ext.html) 03:10:15 INFO - 2016-01-22 03:10:15,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 141692928 03:10:15 INFO - 2016-01-22 03:10:15,507 DEBUG : BROWSER_OUTPUT: 03:13:17 INFO - 2016-01-22 03:13:17,366 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/dromaeo/cssquery-ext.html (next: http://localhost:37518/tests/dromaeo/cssquery-jquery.html) 03:13:17 INFO - 2016-01-22 03:13:17,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 139509760 03:13:17 INFO - 2016-01-22 03:13:17,952 DEBUG : BROWSER_OUTPUT: 03:16:19 INFO - 2016-01-22 03:16:19,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37518/tests/dromaeo/cssquery-mootools.html) 03:16:20 INFO - 2016-01-22 03:16:20,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 139763712 03:16:20 INFO - 2016-01-22 03:16:20,103 DEBUG : BROWSER_OUTPUT: 03:19:21 INFO - 2016-01-22 03:19:21,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37518/tests/dromaeo/cssquery-prototype.html) 03:19:22 INFO - 2016-01-22 03:19:22,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 139878400 03:19:22 INFO - 2016-01-22 03:19:22,283 DEBUG : BROWSER_OUTPUT: 03:22:24 INFO - 2016-01-22 03:22:24,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37518/tests/dromaeo/cssquery-yui.html) 03:22:25 INFO - 2016-01-22 03:22:25,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 138838016 03:22:25 INFO - 2016-01-22 03:22:25,177 DEBUG : BROWSER_OUTPUT: 03:25:27 INFO - 2016-01-22 03:25:27,366 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/dromaeo/cssquery-yui.html (next: http://localhost:37518/tests/dromaeo/cssquery-dojo.html) 03:25:27 INFO - 2016-01-22 03:25:27,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 142639104 03:25:27 INFO - 2016-01-22 03:25:27,610 DEBUG : BROWSER_OUTPUT: 03:25:27 INFO - 2016-01-22 03:25:27,612 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:25:27 INFO - 2016-01-22 03:25:27,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:25:27 INFO - 2016-01-22 03:25:27,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:25:27 INFO - 2016-01-22 03:25:27,612 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:25:27 INFO - 2016-01-22 03:25:27,613 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3323.634400215976;3355.8993230203087;3373.7638365314438;3388.4917262410627;3401.4217583010886;5459.6997165156;5472.644278121919;5488.231647569343;5493.368262649797;5520.475554822296;5513.173024046385;5539.639923404976;5543.029969755286;5547.25112109865;5560.193771903072;5035.043341765062;5062.696238225718;5113.6931784092885;5141.82003629873;5145.022445735317;4902.19113846215;4993.950060499403;5049;5072.771725272371;5075.238714192882;4925.70445773253;4993.226049962262;4996.825111121111;4999.600031997432;5039;5041.647084704054;5105.566026887719;5125.743712814382;5135.075686376451;5153.8919132386345;4834.927476087862;4857.63567732418;4968.105740966625;5017.021680772251;5030.496950304941;5313.1764576490705;5330.280412144389;5358.812441564526;5368.4363141869935;5380.166074258496;5892.086726557391;5917.733701983378;5961.284645842483;5965.70171491428;5967.194428752106;5765.53875689948;5876.030454974924;5920.703964801785;5931.495822855062;6057.454829065361;5604.495595396393;5615.831525054255;5623.240862483553;5627.043402621564;5636.577256705764;6057.3639767824625;6069;6074.301455332693;6075.817725468155;6078.665673388006;5639.097744360883;5732.140178973187;5735.856603584861;5831.970840145772;5860.560457965669;5875.3243377012195;5906.409359064145;5946.910796337972;5950.018246989285;5955.076963070731;5669.06460434032;5874.060150375919;5892.086726557391;5894.2926848778425;5908.320543137508;5730.19777231188;5791.449812267828;5816.94183058164;5824.097264923944;5844.736986835603;4516;4537.636989040869;4546.02260513991;4548.5906268436;4572.268437050056;4044.1911617675996;4085.142120154801;4095.959040409558;4100.36444351126;4142.357934520154;5570.777168913279;5653.830385088371;5656.717164141776;5676.489115979582;5709.714514274269;6017.1275165100815;6058.485028772516;6062.363451837582;6074.42292982166;6077.301110372364;5525.834224973257;5610.803621873215;5619.690916999522;5690.317161940594;5735.483806457355;5181.896362072737;5220.955808838247;5225.320708307896;5229.320188375563;5242.082635538765;6121.663308517986;6136.815895523141;6138.07928810682;6141.662208578482;6153.815385538441;5778.27771528559;5787.363390027178;5861.6189947653265;5915.112733090071;6027.819165424957;5950.375210602998;5986.042233242661;5987.940120598738;6002;6047.48596369296;5780.190773291659;5828.912566311594;5831.475167234969;5838.978178818775;5845.766169353178;5790.073588225863;5819.098039803837;5857.531397488276;5857.799151174085;5916.230889984447;5787.8553036174435;5813.09896965971;5815.156802263733;5819;5829.562782791392;5615.887682246251;5802.883942321215;5803.506701930383;5808.680522571299;5832.475077243069;5640.097584386478;5679.00617391963;5725.942740572541;5733.885322293614;5760.596758226884;5769.711514424178;5800.4489573490455;5837.241158649348;5837.854053648693;5869.266341707286;5516.751746171512;5591.580631452576;5731.19763233156;5735.799247026334;5758.942410576008 03:25:27 INFO - 2016-01-22 03:25:27,617 DEBUG : BROWSER_OUTPUT: |1;ext.html;588.7792077970761;644.7324360390442;649.0912722188936;650.398381497115;655.118865126405;40996.38505422417;41468.37797433041;41587.58412415875;41619.79190104053;41863.953401164945;46164.538354616445;46578.76710616451;46659.76670116653;46722;46774.53225467744;9127;9335.113164249386;9342;9349.06509349063;9353.392029518094;9039.096090390974;9192.816143677122;9208.401453905508;9216.769580760467;9219.170274675278;9120.817583648322;9140.223081038086;9176.587053582605;9209.355345125843;9255.25957923368;9225.492597907147;9238.907610923872;9310.627574896997;9326.39378440406;9328.860067098998;9083.318751093695;9190.724278271662;9232.44605323676;9243;9253.259739220846;43653;43685;44255.11489770219;44325.33511997323;44362.556374436164;3753.7560058596105;3765.3975363941636;3842.8078596070086;3854.9542379625777;3933.8426462941447;31340;31551.36897262065;31946.20134496656;31959.360812783845;32830.17924551905;4162.125953549758;4175.874723758292;4252.298370768819;4261.4460120184485;4323.113761678848;307663;307771.9999999978;308177;308325;309776;45714.77142614266;45956.77021614937;46169.76915115403;46191.538084619395;46342.76828615835;43300.566994330286;43569;43569.12861742747;43640.781796090814;43708;15889.887707860338;15965.600859978362;16126.354945802037;16144.273507692182;16192.514224573282;12827.486900524062;12902.935485322701;12935.741285174245;13071.215727056408;13351.132176408502;15567.922160389353;15598.454054108279;15638.3744650215;15675;15681.68636627284;6170.167027451326;6239.816064377432;6294.905576416358;6309.621422714652;6365.649889256136;966.4974213408988;1018.9133923616575;1093.185576745314;1109.5561775289787;1144.0390072339108;28248.15255542337;28720;28975.420491590052;29455.705442945724;29486.852565737034;1084.3030657021736;1113.582406597526;1212.2302338015247;1216.1426194532833;1240.206267988488;15236.695266094615;15375;15554.766678499831;15804.446844360393;17724;195396;196264;196923;525535;891901;59856.401435985084;59912;60268;60802.783944320865;60916.695416522634;1482.8072350594568;1499.86501214889;1505.5633866178684;1508.1478964385306;1516.499555146799;30677.693223068378;31043;31462.791678032452;31527.84236078805;32039;50081.24878126904;50703;50881;50931.236031458815;50951.74524127356;334995;340245;340408;340941;341229;34818.82590587132;34907.4763878537;34950;35179.12052198613;35672.28655426929;45607.77196113998;45868.31197531973;46324.07351853012;46972.295415569475;47274;39792.40311395389;39839.2032159361;40821.79589102035;41095.38356924589;41471.7926410366;39158.80420597879;39450.60549394469;39997.80001099976;40096.79951600223;40199.79900100481;39601;39859.40210896897;42219.3667095;42355.3646695306;42825.143497130506;33021.33957320792;34827;35310.47034294539;35367;35768.463473047406;26787.464250715268;27387.726122738517;27535.586966195922;27716.168514944584;28340.85829570839 03:25:27 INFO - 2016-01-22 03:25:27,617 DEBUG : BROWSER_OUTPUT: |2;jquery.html;385.88230589670155;389.0875896023825;390.5625699216877;396.37175077502155;396.50634959475457;15502.922485387557;17183.398581049667;17520.123993800324;18336.633267334644;18477.53806154847;17860.28558857644;18585.907070464662;18838.34065807697;18879.339223127194;18966.431007069776;5208.140656791625;5306.548943339802;5355.08963476208;5366.356037275533;5367.704776237305;5311.840644780663;5324.680519168843;5478.58910581706;5514.200440936062;5526.226328314039;5441.863953401177;5461.42655021223;5493.176023596453;5886;6264.686765661721;6168.321484636686;6188.96905515474;6193.659348735818;6226.097215903691;6238.906416403757;5155.175171972466;5293.708846013467;5301.151815709506;5515.806946756885;5519.724013799294;12812.10315277931;13000.804987925094;13082.86917130826;13090.149140305944;13111.868881311255;2134.3810295014428;2208.5228632990115;2265.026038803314;2276.9658455123185;2325.4186453386656;10012.29913906027;10684.19868509857;10981.066609338215;11079.446027698663;14868;1984.1468168687459;1991.153759652142;1991.4523506035812;1992.2529051605648;2012.1951219512166;65286;67022.66488667525;68120.9999999995;68166.65916670434;68721.65639171822;11310.60412885545;11321.773564528663;11330.94334528322;11338.659840204808;11357.261777984404;14908;14935.626609334853;14943.925280373529;14967.101973881385;15018.474353397578;8481.491110533389;8483.660653573788;8492.575371231414;8494.193051660206;8521.44610600309;8329.125441828643;8332.16678332162;8338.416310858182;8343.374246931504;8402.873956890651;4692.788824502837;4817.662763606514;4824.0110777291275;4863.319135321058;4890.144224760653;2037.9184832606827;2043.5912817436572;2053.8973051347375;2067.142136013568;2076.584683063393;914.9176574108362;973.9853902191472;1014.5840205515703;1014.8122597319519;1061.1139698351808;16100.75848862268;16470.75293870593;16987.490375288762;17179;17390.3043878246;963.4989805301204;985.8816941966867;1018.8318927376899;1025.600015993763;1079.881213066562;9867.654632087842;10299.845502317472;10305.76330840304;10346.172306215636;10462.26764126519;467736;474926;479072;507181;633005;77017.61491192508;78019;79308;79891.60054199692;83409;533.4425525326044;547.384192783119;547.9205515200354;548.8435795798179;551.382451654142;10848.349099054081;10900.454977250947;11063.668089957315;11660.53357865676;11669.649910502698;37802;38632.80683596564;39203.60796392114;39827.40258896061;40846.1830763389;51512.22731658953;52432.47567524276;52581.21128183004;53221.733891330296;53233.46766532285;10184.490775461345;10233.795324093328;10368.22238332113;10373.948130259301;10457.738556536147;17683.292668293125;18208.635827283117;18341.633167336844;18495.722564161817;19547;16071.598210044842;16084.632806211603;16187.75718364249;16190.514284571482;16634.16829158513;14695.632609184855;14856.628584285047;15607.063576185465;15897.920510397375;16124.355025798837;15675.764863527284;15800.92099539495;15900.125493097528;16505.422310219084;16824.242909069366;10465.16278697687;10535;10670;10674.786504269716;10686.358818470917;12997.48010079624;15726;15802.446914357943;15949.920250399138;16204.351825927302 03:25:27 INFO - 2016-01-22 03:25:27,621 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1581.003967500474;1590.3638544582166;1871.7473141125945;1893.1764682363173;1902.9628852275512;7968.920310796891;8125.674973001072;8399.454035487697;8426.283765879907;8456.281216096631;8503.91496085039;8538.103499132594;8572.442791218566;8577.399582029246;8598.183172598609;2361.7638236176417;2388.641703744435;2398.5322862041908;2399.0763556030965;2404.711434627847;2355.0108954239176;2376.702912135983;2410.385351735305;2430.987845060781;2433.452473193535;2361.2680069178523;2383.30884043628;2385.654080158376;2430.3195105370523;2445.4131008557997;2342.9648555271683;2394.473215892501;2408.939776505593;2423;2423.7697418745192;2334.754850740682;2403.182917807954;2404.5671779079757;2405.7714517120844;2406.867622280774;8300.335973122135;8359.373047021498;8406.033306169807;8423.83152336956;8447.619857106445;4976.726280054596;5027.723475208862;5030.119729047438;5070.2394640803805;5080.466551012128;3176.698213669698;3194.1056504178637;3230.3216324571868;3243.870245190213;3274;1054.1250761867632;1060.2631171335925;1068.8076146293663;1083.5340803454512;2118.5127420693325;11374.772504549945;11405.08759299254;11423.543058277659;11457.197996140274;11506.194566380356;4309.784510774449;4383.211022016068;4405.317175837687;4438.977805111019;4453.487848897354;9360.297977651704;9381.249500039981;9446.574904129331;9459.810803784023;9479.715608531755;4941.160002799533;4954.653174277766;4960.677555958851;4973;4976.825811096666;4578.725276483422;4581.015081757439;4587.655925805578;4610.05493873755;4614.238650622609;3610.4764809102535;3626.165981824195;3658.231771328051;3693.242885208526;3697.8705745298785;1113.9331640101457;1124.145649306533;1124.454639499842;1133.4729350851894;1142.948567314473;1173.976520469603;1187.216437151476;1230.4954968462887;1473.3443617590283;1484.4359143525608;7765.572893490912;7914.683412663429;7964;7970.402219833536;7970.92392527013;1126.183516950221;1178.116412690482;1230.5077968812548;1238.888500034983;1241.2490443281865;6130.816075517741;6198.6280823150755;6255.311915689271;6306.590071645328;6316.557840951089;9999.100080992746;10204.642837500653;10253.025962533547;10258.640947566799;10447.111995480318;9927.950360248296;10047.145992590566;10120.987901209968;10192.694219173436;10309.896901030894;7863.724769633035;7998.600069996477;8007.599620018976;8010.959945200237;8081.272685458337;7532.849343012999;7670.194629564038;7712.113106992768;7715.768526944201;7749.92250077492;8863.202311791969;9001.684941027033;9052.185303322469;9067.09329067088;9140.954295228481;9132.543372831198;9196.58615362297;9295.674651387439;9417.199538039069;9468.573914173741;7060.3292687194635;7069.293070692889;7148.213696493278;7176.677049532888;7184.856302873809;7863.606819658879;7986.480878742863;8044.597770111354;8065.233802788725;8118.147594502729;7432.3682486987045;7567.129780075362;7631.3894888407685;7755.844883102419;7885.053793544811;7387.372073373824;7570.772876813704;7599.316061554487;7671.61641917913;7691.1539730628465;7572.545647260961;7619;7627.618619069135;7635;7679.040119985002;6859.211190713132;6920.273371295942;6951.096357473496;6960.269171736894;6966.860662786818;6999.720011199495;7017.824554386181;7056.435485161277;7065.470089743187;7077.186123595647 03:25:27 INFO - 2016-01-22 03:25:27,621 DEBUG : BROWSER_OUTPUT: |4;prototype.html;364.8230608155043;366.3314451126694;367.90618392309955;369.32229359126;378.03412281620456;6310.116583678288;6379.872402551952;6444.742210311588;6460.7092680829355;6496.707648155832;6351.618902865831;6376.39424254695;6392.16901802765;6396.360363963601;6427.614343139415;4861.368022157132;4892.217245240762;4894;4901.044296362211;4904.068227036852;4887.951120488785;4892.951070489303;4895.167821470341;4909.705417674951;4930.778114984834;4690.57784799368;4798.448178459487;4807.687500312469;4849.539293767087;4884.7069175849565;4864.708117512961;4877.292792545079;4891.437484689271;4906.754662266872;4920.778564964585;4328.437303150602;4333.155034768221;4347;4348.847790327355;4366.08312254427;6047.092936059582;6074.817755467343;6084.330723620398;6090.116933044728;6094.817155485298;5669.744861481243;5745.052066409037;5761.078227483625;5774.7112644368035;5780.9710951445395;6742.52802303839;6775.525713200029;6780.93219067808;6781.152355955505;6806.115205023365;4784.928226076611;4821.855344339676;4828.227483602642;4829.879253018667;4839.298301746262;6891.3797758202;6961.617111058889;7038.859222815566;7048.400885924702;7053.68258428372;4961.751912404366;4968.453470118284;4971.975140124277;4977.950220497749;4982.626303027288;5036.84889453317;5037.420696619863;5039.244113383022;5042.268871013755;5046.192609182586;5727.455891690282;5731.77072917087;5733.684647344436;5744.655320680772;5766.365699773021;6597.010448432773;6822.556533825285;6836.350546698056;6843.965780171166;6864.519483636197;1770.8848924820104;1771.8051014388407;1771.9988206663195;1774.5563609097726;1783.0549808601202;1232.4946771823509;1236.449779847977;1237.7833879071127;1250.1436515986397;1261.4701825233424;6614.636195009224;6628.4697224221945;6630.469562434993;6635.369639884203;6641.435477984425;7038.612876291751;7066.081409416743;7077.363037326562;7096.645167741593;7117.71529138839;6334.619922804646;6357.586756860789;6457.418832305115;6621.3047629998155;6629.270780214172;3839.347310957144;3868.8065596720053;3872.3997780344093;3875.4380614811257;3880.243352546283;7257.419406447471;7270.781876543606;7282.781516554512;7283.053203083565;7293;7136.892946605805;7227.49407541467;7277.2358902315555;7283.417326613858;7283.7450689225625;7249.477609701916;7285.052943117466;7296.635168241567;7312.341889229995;7323.157836848831;7011.193712723102;7048.224695283412;7076.823079423056;7080.114985626797;7088.822779430556;6974.302569742985;7011.894821577578;7019.227884932551;7024.754133605299;7027.15674119109;7231.855362892607;7239;7259.6007219603425;7288.271172882669;7309.122905251404;4856.1016212000895;4898.583620392306;4912.459629440687;4913.263010548446;4916.3362946001835;7105.46708996817;7120.964395178198;7124.3944264738075;7131.322524360177;7139.785806425815;6925.342092501204;6939.757108501179;6943.47923905699;6945.305469453015;6962.373386395248;6810.489213308922;6912.44700423975;6921.515493915377;6948.305169483011;6961.443084553122;6793.116894803644;6793.150856142982;6793.5244532882225;6795.150606174228;6802.829929251809;6913.654317284015;6930.757423490154;6930.930690693231;6933.583984960918;6944.201416837129;6661.233958094881;6771.864562708817;6802.795916122524;6810;6815.829604259933 03:25:27 INFO - 2016-01-22 03:25:27,624 DEBUG : BROWSER_OUTPUT: |5;yui.html;857.1086070486693;873.384264093814;904.7647611620981;945.0407836046414;974.8050389922017;13880.861191388083;13884.23636699981;13995.370208340637;14448.422063117476;14488.275586220687;13880.4447822087;14099.78850317246;14128.78806817896;14135.505257315996;14137.22245276512;917.499962520428;937.8358787212245;940.1773448232797;940.7648087978006;942.4627962061628;918.6692790595414;919.6275508419101;921.1249313152498;923.3813345058827;923.6628630549834;974.24009272767;975.7804493988831;977.5210147027976;978.4569563892037;979.2851218610418;951.6431338248157;957.8132264208448;958.6453012385392;959.6976952260051;967.7048500207434;720.495653042872;722.3462766196601;723.9601821899794;723.9674214660353;725.5392825555757;14312.499062532761;14323.212223327817;14397.424103035866;14417.855821441755;14442;12408.937955310166;12417.503299867994;12595.937020314932;12680.175788573713;13289.86710132896;10876.6193183239;11116.221864469491;11154.219204655677;11156.386398748065;11288.887111128948;3806.257779732953;3821.808909554511;3829.942550861739;3840.788756618385;3903.8243279052513;48334.51665483371;48463;48540.27189592159;48754.99999999964;49053.26420103701;10449.582016719398;10579.89420105789;10756.623518176826;10773.24587278883;10864.534238462298;18487.630247394976;18497.5375615608;18536.165872535767;18548.81451185498;18564;7117.466190035768;7463.776086717407;7482.738104166437;7501.987231723757;7664.961675191588;4234.13200293939;4322.69741118125;4354.934675979863;4425.09285596452;4530.637548996073;3224.629167645704;3282.2122690554575;3284.7700660953506;3285.42505061618;3470.9479357809655;641.9069234960905;649.2890285137767;649.5453182771984;649.7855707616475;658.4501940879419;599.7331187621554;706.1631966120163;717.4619035723208;734.4418242136015;777.5101685937823;8311.792205194797;8525.531095789791;8838.116188381238;9079.954600226956;9093.136152065543;578.9450002249864;613.6989582085918;728.1044315491974;732.3665029749228;732.4250463386217;4385.846495372647;4410.492793328808;4444.3333499974615;4500.414946057057;4589.678722489393;59180.40819591749;59463;59719.70140149271;60042;60288;53407.46592534103;53979.92040159175;54646.726766365915;54831.725841370535;55127.724361378736;47430.52569474261;47593;47759.52240477551;47866.5213347869;50274.245886311735;9173.082691730773;9221.262299015929;9365.157135857806;9439;9553.474558899326;34676.82661586676;35483.82258088693;36116.819415902755;36228.81885590555;36287.81856090703;41435.1712965745;41636.37545436881;44555;46594;47118.52881471279;11676.474558645052;11726.824097638713;11884.940575297069;12020.519179232733;12033.578824741093;13236.536721214712;13598.388072536562;13710.245936473191;14412.85587144157;15006.77489837675;12567.748645027232;12641.747165056831;12790.232586044494;13265;13380.19718816874;12839.807402889151;13358.198508089547;13486.595402137951;13671.794923075962;13794.793078104038;12485.375731213584;12666.050046246753;13015.934920325337;13330.800037999632;13372.531961381304;10613.469326533797;10951.56193752241;11460.14048946349;11498.137639677225;11523.884761152616;9725.027497250217;10000;10184;10359.378437293786;10603.41681207541 03:25:27 INFO - 2016-01-22 03:25:27,624 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:25:27 INFO - 2016-01-22 03:25:27,625 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:25:27 INFO - 2016-01-22 03:25:27,625 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,306 03:25:27 INFO - 2016-01-22 03:25:27,625 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:25:27 INFO - 2016-01-22 03:25:27,625 DEBUG : BROWSER_OUTPUT: __startTimestamp1453461927610__endTimestamp 03:25:27 INFO - 2016-01-22 03:25:27,625 DEBUG : BROWSER_OUTPUT: 03:25:27 INFO - 2016-01-22 03:25:27,625 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:25:27 INFO - 2016-01-22 03:25:27,625 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:25:27 INFO - 2016-01-22 03:25:27,625 DEBUG : BROWSER_OUTPUT: 03:25:27 INFO - 2016-01-22 03:25:27,625 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5498.73 Median:5730.20 stddev:595.19 (10.4%) stddev-sans-first:572.04 03:25:27 INFO - 2016-01-22 03:25:27,625 DEBUG : BROWSER_OUTPUT: Values: 3323.6 3355.9 3373.8 3388.5 3401.4 5459.7 5472.6 5488.2 5493.4 5520.5 5513.2 5539.6 5543.0 5547.3 5560.2 5035.0 5062.7 5113.7 5141.8 5145.0 4902.2 4994.0 5049.0 5072.8 5075.2 4925.7 4993.2 4996.8 4999.6 5039.0 5041.6 5105.6 5125.7 5135.1 5153.9 4834.9 4857.6 4968.1 5017.0 5030.5 5313.2 5330.3 5358.8 5368.4 5380.2 5892.1 5917.7 5961.3 5965.7 5967.2 5765.5 5876.0 5920.7 5931.5 6057.5 5604.5 5615.8 5623.2 5627.0 5636.6 6057.4 6069.0 6074.3 6075.8 6078.7 5639.1 5732.1 5735.9 5832.0 5860.6 5875.3 5906.4 5946.9 5950.0 5955.1 5669.1 5874.1 5892.1 5894.3 5908.3 5730.2 5791.4 5816.9 5824.1 5844.7 4516.0 4537.6 4546.0 4548.6 4572.3 4044.2 4085.1 4096.0 4100.4 4142.4 5570.8 5653.8 5656.7 5676.5 5709.7 6017.1 6058.5 6062.4 6074.4 6077.3 5525.8 5610.8 5619.7 5690.3 5735.5 5181.9 5221.0 5225.3 5229.3 5242.1 6121.7 6136.8 6138.1 6141.7 6153.8 5778.3 5787.4 5861.6 5915.1 6027.8 5950.4 5986.0 5987.9 6002.0 6047.5 5780.2 5828.9 5831.5 5839.0 5845.8 5790.1 5819.1 5857.5 5857.8 5916.2 5787.9 5813.1 5815.2 5819.0 5829.6 5615.9 5802.9 5803.5 5808.7 5832.5 5640.1 5679.0 5725.9 5733.9 5760.6 5769.7 5800.4 5837.2 5837.9 5869.3 5516.8 5591.6 5731.2 5735.8 5758.9 03:25:27 INFO - 2016-01-22 03:25:27,625 DEBUG : BROWSER_OUTPUT: 03:25:27 INFO - 2016-01-22 03:25:27,625 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51816.70 Median:40510.80 stddev:103271.07 (254.9%) stddev-sans-first:103489.14 03:25:27 INFO - 2016-01-22 03:25:27,626 DEBUG : BROWSER_OUTPUT: Values: 588.8 644.7 649.1 650.4 655.1 40996.4 41468.4 41587.6 41619.8 41864.0 46164.5 46578.8 46659.8 46722.0 46774.5 9127.0 9335.1 9342.0 9349.1 9353.4 9039.1 9192.8 9208.4 9216.8 9219.2 9120.8 9140.2 9176.6 9209.4 9255.3 9225.5 9238.9 9310.6 9326.4 9328.9 9083.3 9190.7 9232.4 9243.0 9253.3 43653.0 43685.0 44255.1 44325.3 44362.6 3753.8 3765.4 3842.8 3855.0 3933.8 31340.0 31551.4 31946.2 31959.4 32830.2 4162.1 4175.9 4252.3 4261.4 4323.1 307663.0 307772.0 308177.0 308325.0 309776.0 45714.8 45956.8 46169.8 46191.5 46342.8 43300.6 43569.0 43569.1 43640.8 43708.0 15889.9 15965.6 16126.4 16144.3 16192.5 12827.5 12902.9 12935.7 13071.2 13351.1 15567.9 15598.5 15638.4 15675.0 15681.7 6170.2 6239.8 6294.9 6309.6 6365.6 966.5 1018.9 1093.2 1109.6 1144.0 28248.2 28720.0 28975.4 29455.7 29486.9 1084.3 1113.6 1212.2 1216.1 1240.2 15236.7 15375.0 15554.8 15804.4 17724.0 195396.0 196264.0 196923.0 525535.0 891901.0 59856.4 59912.0 60268.0 60802.8 60916.7 1482.8 1499.9 1505.6 1508.1 1516.5 30677.7 31043.0 31462.8 31527.8 32039.0 50081.2 50703.0 50881.0 50931.2 50951.7 334995.0 340245.0 340408.0 340941.0 341229.0 34818.8 34907.5 34950.0 35179.1 35672.3 45607.8 45868.3 46324.1 46972.3 47274.0 39792.4 39839.2 40821.8 41095.4 41471.8 39158.8 39450.6 39997.8 40096.8 40199.8 39601.0 39859.4 42219.4 42355.4 42825.1 33021.3 34827.0 35310.5 35367.0 35768.5 26787.5 27387.7 27535.6 27716.2 28340.9 03:25:27 INFO - 2016-01-22 03:25:27,626 DEBUG : BROWSER_OUTPUT: 03:25:27 INFO - 2016-01-22 03:25:27,626 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28829.52 Median:2040.75 stddev:84454.54 (4138.4%) stddev-sans-first:84664.45 03:25:27 INFO - 2016-01-22 03:25:27,626 DEBUG : BROWSER_OUTPUT: Values: 385.9 389.1 390.6 396.4 396.5 15502.9 17183.4 17520.1 18336.6 18477.5 17860.3 18585.9 18838.3 18879.3 18966.4 5208.1 5306.5 5355.1 5366.4 5367.7 5311.8 5324.7 5478.6 5514.2 5526.2 5441.9 5461.4 5493.2 5886.0 6264.7 6168.3 6189.0 6193.7 6226.1 6238.9 5155.2 5293.7 5301.2 5515.8 5519.7 12812.1 13000.8 13082.9 13090.1 13111.9 2134.4 2208.5 2265.0 2277.0 2325.4 10012.3 10684.2 10981.1 11079.4 14868.0 1984.1 1991.2 1991.5 1992.3 2012.2 65286.0 67022.7 68121.0 68166.7 68721.7 11310.6 11321.8 11330.9 11338.7 11357.3 14908.0 14935.6 14943.9 14967.1 15018.5 8481.5 8483.7 8492.6 8494.2 8521.4 8329.1 8332.2 8338.4 8343.4 8402.9 4692.8 4817.7 4824.0 4863.3 4890.1 2037.9 2043.6 2053.9 2067.1 2076.6 914.9 974.0 1014.6 1014.8 1061.1 16100.8 16470.8 16987.5 17179.0 17390.3 963.5 985.9 1018.8 1025.6 1079.9 9867.7 10299.8 10305.8 10346.2 10462.3 467736.0 474926.0 479072.0 507181.0 633005.0 77017.6 78019.0 79308.0 79891.6 83409.0 533.4 547.4 547.9 548.8 551.4 10848.3 10900.5 11063.7 11660.5 11669.6 37802.0 38632.8 39203.6 39827.4 40846.2 51512.2 52432.5 52581.2 53221.7 53233.5 10184.5 10233.8 10368.2 10373.9 10457.7 17683.3 18208.6 18341.6 18495.7 19547.0 16071.6 16084.6 16187.8 16190.5 16634.2 14695.6 14856.6 15607.1 15897.9 16124.4 15675.8 15800.9 15900.1 16505.4 16824.2 10465.2 10535.0 10670.0 10674.8 10686.4 12997.5 15726.0 15802.4 15949.9 16204.4 03:25:27 INFO - 2016-01-22 03:25:27,626 DEBUG : BROWSER_OUTPUT: 03:25:27 INFO - 2016-01-22 03:25:27,627 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5864.16 Median:5050.18 stddev:3048.46 (60.4%) stddev-sans-first:3040.01 03:25:27 INFO - 2016-01-22 03:25:27,627 DEBUG : BROWSER_OUTPUT: Values: 1581.0 1590.4 1871.7 1893.2 1903.0 7968.9 8125.7 8399.5 8426.3 8456.3 8503.9 8538.1 8572.4 8577.4 8598.2 2361.8 2388.6 2398.5 2399.1 2404.7 2355.0 2376.7 2410.4 2431.0 2433.5 2361.3 2383.3 2385.7 2430.3 2445.4 2343.0 2394.5 2408.9 2423.0 2423.8 2334.8 2403.2 2404.6 2405.8 2406.9 8300.3 8359.4 8406.0 8423.8 8447.6 4976.7 5027.7 5030.1 5070.2 5080.5 3176.7 3194.1 3230.3 3243.9 3274.0 1054.1 1060.3 1068.8 1083.5 2118.5 11374.8 11405.1 11423.5 11457.2 11506.2 4309.8 4383.2 4405.3 4439.0 4453.5 9360.3 9381.2 9446.6 9459.8 9479.7 4941.2 4954.7 4960.7 4973.0 4976.8 4578.7 4581.0 4587.7 4610.1 4614.2 3610.5 3626.2 3658.2 3693.2 3697.9 1113.9 1124.1 1124.5 1133.5 1142.9 1174.0 1187.2 1230.5 1473.3 1484.4 7765.6 7914.7 7964.0 7970.4 7970.9 1126.2 1178.1 1230.5 1238.9 1241.2 6130.8 6198.6 6255.3 6306.6 6316.6 9999.1 10204.6 10253.0 10258.6 10447.1 9928.0 10047.1 10121.0 10192.7 10309.9 7863.7 7998.6 8007.6 8011.0 8081.3 7532.8 7670.2 7712.1 7715.8 7749.9 8863.2 9001.7 9052.2 9067.1 9141.0 9132.5 9196.6 9295.7 9417.2 9468.6 7060.3 7069.3 7148.2 7176.7 7184.9 7863.6 7986.5 8044.6 8065.2 8118.1 7432.4 7567.1 7631.4 7755.8 7885.1 7387.4 7570.8 7599.3 7671.6 7691.2 7572.5 7619.0 7627.6 7635.0 7679.0 6859.2 6920.3 6951.1 6960.3 6966.9 6999.7 7017.8 7056.4 7065.5 7077.2 03:25:27 INFO - 2016-01-22 03:25:27,627 DEBUG : BROWSER_OUTPUT: 03:25:27 INFO - 2016-01-22 03:25:27,628 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5738.42 Median:6459.06 stddev:1711.71 (26.5%) stddev-sans-first:1668.32 03:25:27 INFO - 2016-01-22 03:25:27,628 DEBUG : BROWSER_OUTPUT: Values: 364.8 366.3 367.9 369.3 378.0 6310.1 6379.9 6444.7 6460.7 6496.7 6351.6 6376.4 6392.2 6396.4 6427.6 4861.4 4892.2 4894.0 4901.0 4904.1 4888.0 4893.0 4895.2 4909.7 4930.8 4690.6 4798.4 4807.7 4849.5 4884.7 4864.7 4877.3 4891.4 4906.8 4920.8 4328.4 4333.2 4347.0 4348.8 4366.1 6047.1 6074.8 6084.3 6090.1 6094.8 5669.7 5745.1 5761.1 5774.7 5781.0 6742.5 6775.5 6780.9 6781.2 6806.1 4784.9 4821.9 4828.2 4829.9 4839.3 6891.4 6961.6 7038.9 7048.4 7053.7 4961.8 4968.5 4972.0 4978.0 4982.6 5036.8 5037.4 5039.2 5042.3 5046.2 5727.5 5731.8 5733.7 5744.7 5766.4 6597.0 6822.6 6836.4 6844.0 6864.5 1770.9 1771.8 1772.0 1774.6 1783.1 1232.5 1236.4 1237.8 1250.1 1261.5 6614.6 6628.5 6630.5 6635.4 6641.4 7038.6 7066.1 7077.4 7096.6 7117.7 6334.6 6357.6 6457.4 6621.3 6629.3 3839.3 3868.8 3872.4 3875.4 3880.2 7257.4 7270.8 7282.8 7283.1 7293.0 7136.9 7227.5 7277.2 7283.4 7283.7 7249.5 7285.1 7296.6 7312.3 7323.2 7011.2 7048.2 7076.8 7080.1 7088.8 6974.3 7011.9 7019.2 7024.8 7027.2 7231.9 7239.0 7259.6 7288.3 7309.1 4856.1 4898.6 4912.5 4913.3 4916.3 7105.5 7121.0 7124.4 7131.3 7139.8 6925.3 6939.8 6943.5 6945.3 6962.4 6810.5 6912.4 6921.5 6948.3 6961.4 6793.1 6793.2 6793.5 6795.2 6802.8 6913.7 6930.8 6930.9 6933.6 6944.2 6661.2 6771.9 6802.8 6810.0 6815.8 03:25:27 INFO - 2016-01-22 03:25:27,628 DEBUG : BROWSER_OUTPUT: 03:25:27 INFO - 2016-01-22 03:25:27,628 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14504.92 Median:4417.79 stddev:16381.51 (370.8%) stddev-sans-first:16395.41 03:25:27 INFO - 2016-01-22 03:25:27,628 DEBUG : BROWSER_OUTPUT: Values: 857.1 873.4 904.8 945.0 974.8 13880.9 13884.2 13995.4 14448.4 14488.3 13880.4 14099.8 14128.8 14135.5 14137.2 917.5 937.8 940.2 940.8 942.5 918.7 919.6 921.1 923.4 923.7 974.2 975.8 977.5 978.5 979.3 951.6 957.8 958.6 959.7 967.7 720.5 722.3 724.0 724.0 725.5 14312.5 14323.2 14397.4 14417.9 14442.0 12408.9 12417.5 12595.9 12680.2 13289.9 10876.6 11116.2 11154.2 11156.4 11288.9 3806.3 3821.8 3829.9 3840.8 3903.8 48334.5 48463.0 48540.3 48755.0 49053.3 10449.6 10579.9 10756.6 10773.2 10864.5 18487.6 18497.5 18536.2 18548.8 18564.0 7117.5 7463.8 7482.7 7502.0 7665.0 4234.1 4322.7 4354.9 4425.1 4530.6 3224.6 3282.2 3284.8 3285.4 3470.9 641.9 649.3 649.5 649.8 658.5 599.7 706.2 717.5 734.4 777.5 8311.8 8525.5 8838.1 9080.0 9093.1 578.9 613.7 728.1 732.4 732.4 4385.8 4410.5 4444.3 4500.4 4589.7 59180.4 59463.0 59719.7 60042.0 60288.0 53407.5 53979.9 54646.7 54831.7 55127.7 47430.5 47593.0 47759.5 47866.5 50274.2 9173.1 9221.3 9365.2 9439.0 9553.5 34676.8 35483.8 36116.8 36228.8 36287.8 41435.2 41636.4 44555.0 46594.0 47118.5 11676.5 11726.8 11884.9 12020.5 12033.6 13236.5 13598.4 13710.2 14412.9 15006.8 12567.7 12641.7 12790.2 13265.0 13380.2 12839.8 13358.2 13486.6 13671.8 13794.8 12485.4 12666.1 13015.9 13330.8 13372.5 10613.5 10951.6 11460.1 11498.1 11523.9 9725.0 10000.0 10184.0 10359.4 10603.4 03:25:27 INFO - 2016-01-22 03:25:27,628 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:25:27 INFO - 2016-01-22 03:25:27,628 DEBUG : BROWSER_OUTPUT: 03:25:28 INFO - 2016-01-22 03:25:28,268 INFO : Browser exited with error code: 0 03:25:28 INFO - 2016-01-22 03:25:28,289 INFO : Completed test dromaeo_css (00:18:28) 03:25:28 INFO - 2016-01-22 03:25:28,289 INFO : Starting test kraken 03:25:28 INFO - 2016-01-22 03:25:28,289 DEBUG : operating with platform_type : linux_ 03:25:28 INFO - 2016-01-22 03:25:28,289 INFO : Initialising browser for kraken test... 03:25:28 INFO - 2016-01-22 03:25:28,295 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp88DjIn/profile http://localhost:37518/getInfo.html 03:25:32 INFO - 2016-01-22 03:25:32,049 DEBUG : BROWSER_OUTPUT: 03:25:32 INFO - 2016-01-22 03:25:32,049 DEBUG : BROWSER_OUTPUT: (process:28342): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:25:33 INFO - 2016-01-22 03:25:33,058 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:25:33 INFO - 2016-01-22 03:25:33,058 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:25:33 INFO - 2016-01-22 03:25:33,058 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:25:33 INFO - 2016-01-22 03:25:33,058 DEBUG : BROWSER_OUTPUT: __metrics 03:25:34 INFO - 2016-01-22 03:25:34,040 INFO : Browser initialized. 03:25:34 INFO - 2016-01-22 03:25:34,040 INFO : Running cycle 1/1 for kraken test... 03:25:34 INFO - 2016-01-22 03:25:34,040 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp88DjIn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:25:35 INFO - 2016-01-22 03:25:35,294 DEBUG : BROWSER_OUTPUT: 03:25:35 INFO - 2016-01-22 03:25:35,294 DEBUG : BROWSER_OUTPUT: (process:28455): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:25:45 INFO - 2016-01-22 03:25:45,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 135979008 03:25:45 INFO - 2016-01-22 03:25:45,800 DEBUG : BROWSER_OUTPUT: 03:25:48 INFO - 2016-01-22 03:25:48,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37518/tests/kraken/driver.html?testName=audio-beat-detection) 03:25:48 INFO - 2016-01-22 03:25:48,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 138141696 03:25:48 INFO - 2016-01-22 03:25:48,858 DEBUG : BROWSER_OUTPUT: 03:25:51 INFO - 2016-01-22 03:25:51,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37518/tests/kraken/driver.html?testName=audio-dft) 03:25:52 INFO - 2016-01-22 03:25:52,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 137207808 03:25:52 INFO - 2016-01-22 03:25:52,085 DEBUG : BROWSER_OUTPUT: 03:25:54 INFO - 2016-01-22 03:25:54,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37518/tests/kraken/driver.html?testName=audio-fft) 03:25:55 INFO - 2016-01-22 03:25:55,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 138027008 03:25:55 INFO - 2016-01-22 03:25:55,470 DEBUG : BROWSER_OUTPUT: 03:25:57 INFO - 2016-01-22 03:25:57,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37518/tests/kraken/driver.html?testName=audio-oscillator) 03:25:58 INFO - 2016-01-22 03:25:58,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 138903552 03:25:58 INFO - 2016-01-22 03:25:58,081 DEBUG : BROWSER_OUTPUT: 03:26:00 INFO - 2016-01-22 03:26:00,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37518/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:26:00 INFO - 2016-01-22 03:26:00,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 138203136 03:26:00 INFO - 2016-01-22 03:26:00,846 DEBUG : BROWSER_OUTPUT: 03:26:03 INFO - 2016-01-22 03:26:03,812 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37518/tests/kraken/driver.html?testName=imaging-darkroom) 03:26:04 INFO - 2016-01-22 03:26:04,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 137265152 03:26:04 INFO - 2016-01-22 03:26:04,399 DEBUG : BROWSER_OUTPUT: 03:26:07 INFO - 2016-01-22 03:26:07,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37518/tests/kraken/driver.html?testName=imaging-desaturate) 03:26:08 INFO - 2016-01-22 03:26:08,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 136810496 03:26:08 INFO - 2016-01-22 03:26:08,331 DEBUG : BROWSER_OUTPUT: 03:26:11 INFO - 2016-01-22 03:26:11,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37518/tests/kraken/driver.html?testName=json-parse-financial) 03:26:11 INFO - 2016-01-22 03:26:11,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 137900032 03:26:11 INFO - 2016-01-22 03:26:11,681 DEBUG : BROWSER_OUTPUT: 03:26:13 INFO - 2016-01-22 03:26:13,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37518/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:26:13 INFO - 2016-01-22 03:26:13,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 138444800 03:26:13 INFO - 2016-01-22 03:26:13,810 DEBUG : BROWSER_OUTPUT: 03:26:15 INFO - 2016-01-22 03:26:15,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:26:16 INFO - 2016-01-22 03:26:16,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 137482240 03:26:16 INFO - 2016-01-22 03:26:16,189 DEBUG : BROWSER_OUTPUT: 03:26:18 INFO - 2016-01-22 03:26:18,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:26:18 INFO - 2016-01-22 03:26:18,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 137502720 03:26:18 INFO - 2016-01-22 03:26:18,801 DEBUG : BROWSER_OUTPUT: 03:26:21 INFO - 2016-01-22 03:26:21,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:26:21 INFO - 2016-01-22 03:26:21,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 138203136 03:26:21 INFO - 2016-01-22 03:26:21,794 DEBUG : BROWSER_OUTPUT: 03:26:24 INFO - 2016-01-22 03:26:24,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:26:24 INFO - 2016-01-22 03:26:24,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 139661312 03:26:24 INFO - 2016-01-22 03:26:24,891 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37518/tests/kraken/driver.html?testName=ai-astar) 03:26:26 INFO - 2016-01-22 03:26:26,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 139853824 03:26:26 INFO - 2016-01-22 03:26:26,790 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,794 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:26:26 INFO - 2016-01-22 03:26:26,794 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:26:26 INFO - 2016-01-22 03:26:26,794 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:26:26 INFO - 2016-01-22 03:26:26,794 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:26:26 INFO - 2016-01-22 03:26:26,795 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;105;111;110;111;120;111;111;111;110 03:26:26 INFO - 2016-01-22 03:26:26,795 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;163;133;151;172;123;148;147;129;173;122 03:26:26 INFO - 2016-01-22 03:26:26,795 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;161;161;159;162;162;161;162;162 03:26:26 INFO - 2016-01-22 03:26:26,795 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;73;73;164;75;72;71;74;165;71 03:26:26 INFO - 2016-01-22 03:26:26,795 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;138;92;93;93;144;92;94;136 03:26:26 INFO - 2016-01-22 03:26:26,795 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;111;109;110;111;109;111;110;109 03:26:26 INFO - 2016-01-22 03:26:26,795 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;147;146;146;146;146;147;146 03:26:26 INFO - 2016-01-22 03:26:26,795 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;95;95;96;96;98;95;96;96 03:26:26 INFO - 2016-01-22 03:26:26,795 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;61;62;60;60;59;59;59;58 03:26:26 INFO - 2016-01-22 03:26:26,796 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;69;64;65;66;65;65;69;65 03:26:26 INFO - 2016-01-22 03:26:26,796 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;82;83;89;82;81;82;83;82 03:26:26 INFO - 2016-01-22 03:26:26,796 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;108;120;125;119;114;124;118;119;118;116 03:26:26 INFO - 2016-01-22 03:26:26,796 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;155;145;142;144;147;135;148;145;143;148 03:26:26 INFO - 2016-01-22 03:26:26,796 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;67;66;66;65;66;64;63;64 03:26:26 INFO - 2016-01-22 03:26:26,796 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:26:26 INFO - 2016-01-22 03:26:26,796 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:26:26 INFO - 2016-01-22 03:26:26,796 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,724 03:26:26 INFO - 2016-01-22 03:26:26,796 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:26:26 INFO - 2016-01-22 03:26:26,796 DEBUG : BROWSER_OUTPUT: __startTimestamp1453461986792__endTimestamp 03:26:26 INFO - 2016-01-22 03:26:26,796 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,797 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:26:26 INFO - 2016-01-22 03:26:26,797 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:26:26 INFO - 2016-01-22 03:26:26,798 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,798 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:3.65 (3.3%) stddev-sans-first:3.86 03:26:26 INFO - 2016-01-22 03:26:26,798 DEBUG : BROWSER_OUTPUT: Values: 110.0 105.0 111.0 110.0 111.0 120.0 111.0 111.0 111.0 110.0 03:26:26 INFO - 2016-01-22 03:26:26,798 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,798 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.10 Median:149.50 stddev:19.11 (12.8%) stddev-sans-first:19.27 03:26:26 INFO - 2016-01-22 03:26:26,798 DEBUG : BROWSER_OUTPUT: Values: 163.0 133.0 151.0 172.0 123.0 148.0 147.0 129.0 173.0 122.0 03:26:26 INFO - 2016-01-22 03:26:26,798 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,798 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:0.97 03:26:26 INFO - 2016-01-22 03:26:26,798 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 161.0 161.0 159.0 162.0 162.0 161.0 162.0 162.0 03:26:26 INFO - 2016-01-22 03:26:26,799 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,799 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:91.60 Median:73.00 stddev:38.48 (52.7%) stddev-sans-first:40.50 03:26:26 INFO - 2016-01-22 03:26:26,799 DEBUG : BROWSER_OUTPUT: Values: 78.0 73.0 73.0 164.0 75.0 72.0 71.0 74.0 165.0 71.0 03:26:26 INFO - 2016-01-22 03:26:26,799 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,799 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:22.54 (24.2%) stddev-sans-first:23.35 03:26:26 INFO - 2016-01-22 03:26:26,799 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 138.0 92.0 93.0 93.0 144.0 92.0 94.0 136.0 03:26:26 INFO - 2016-01-22 03:26:26,799 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,799 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.88 (0.8%) stddev-sans-first:0.87 03:26:26 INFO - 2016-01-22 03:26:26,800 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 111.0 109.0 110.0 111.0 109.0 111.0 110.0 109.0 03:26:26 INFO - 2016-01-22 03:26:26,800 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,800 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 03:26:26 INFO - 2016-01-22 03:26:26,800 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 03:26:26 INFO - 2016-01-22 03:26:26,800 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,801 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 03:26:26 INFO - 2016-01-22 03:26:26,801 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 95.0 95.0 96.0 96.0 98.0 95.0 96.0 96.0 03:26:26 INFO - 2016-01-22 03:26:26,801 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,802 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.70 Median:60.00 stddev:1.16 (1.9%) stddev-sans-first:1.20 03:26:26 INFO - 2016-01-22 03:26:26,802 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 61.0 62.0 60.0 60.0 59.0 59.0 59.0 58.0 03:26:26 INFO - 2016-01-22 03:26:26,803 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,803 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:65.00 stddev:1.83 (2.8%) stddev-sans-first:1.83 03:26:26 INFO - 2016-01-22 03:26:26,803 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 69.0 64.0 65.0 66.0 65.0 65.0 69.0 65.0 03:26:26 INFO - 2016-01-22 03:26:26,803 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,803 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.00 stddev:2.25 (2.7%) stddev-sans-first:2.37 03:26:26 INFO - 2016-01-22 03:26:26,803 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 82.0 83.0 89.0 82.0 81.0 82.0 83.0 82.0 03:26:26 INFO - 2016-01-22 03:26:26,803 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,803 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:119.00 stddev:4.84 (4.1%) stddev-sans-first:3.49 03:26:26 INFO - 2016-01-22 03:26:26,804 DEBUG : BROWSER_OUTPUT: Values: 108.0 120.0 125.0 119.0 114.0 124.0 118.0 119.0 118.0 116.0 03:26:26 INFO - 2016-01-22 03:26:26,804 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,804 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:146.00 stddev:5.12 (3.5%) stddev-sans-first:4.01 03:26:26 INFO - 2016-01-22 03:26:26,804 DEBUG : BROWSER_OUTPUT: Values: 155.0 145.0 142.0 144.0 147.0 135.0 148.0 145.0 143.0 148.0 03:26:26 INFO - 2016-01-22 03:26:26,804 DEBUG : BROWSER_OUTPUT: 03:26:26 INFO - 2016-01-22 03:26:26,804 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:66.00 stddev:1.23 (1.9%) stddev-sans-first:1.27 03:26:26 INFO - 2016-01-22 03:26:26,804 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 67.0 66.0 66.0 65.0 66.0 64.0 63.0 64.0 03:26:26 INFO - 2016-01-22 03:26:26,804 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:26:26 INFO - 2016-01-22 03:26:26,804 DEBUG : BROWSER_OUTPUT: 03:26:27 INFO - 2016-01-22 03:26:27,640 INFO : Browser exited with error code: 0 03:26:27 INFO - 2016-01-22 03:26:27,688 INFO : Completed test kraken (00:00:59) 03:26:27 INFO - 2016-01-22 03:26:27,688 INFO : Starting test v8_7 03:26:27 INFO - 2016-01-22 03:26:27,688 DEBUG : operating with platform_type : linux_ 03:26:27 INFO - 2016-01-22 03:26:27,688 INFO : Initialising browser for v8_7 test... 03:26:27 INFO - 2016-01-22 03:26:27,694 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5MCjiY/profile http://localhost:37518/getInfo.html 03:26:31 INFO - 2016-01-22 03:26:31,397 DEBUG : BROWSER_OUTPUT: 03:26:31 INFO - 2016-01-22 03:26:31,398 DEBUG : BROWSER_OUTPUT: (process:28770): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:26:32 INFO - 2016-01-22 03:26:32,262 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:26:32 INFO - 2016-01-22 03:26:32,262 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:26:32 INFO - 2016-01-22 03:26:32,262 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:26:32 INFO - 2016-01-22 03:26:32,262 DEBUG : BROWSER_OUTPUT: __metrics 03:26:33 INFO - 2016-01-22 03:26:33,224 INFO : Browser initialized. 03:26:33 INFO - 2016-01-22 03:26:33,224 INFO : Running cycle 1/1 for v8_7 test... 03:26:33 INFO - 2016-01-22 03:26:33,224 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5MCjiY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:26:34 INFO - 2016-01-22 03:26:34,522 DEBUG : BROWSER_OUTPUT: 03:26:34 INFO - 2016-01-22 03:26:34,522 DEBUG : BROWSER_OUTPUT: (process:28885): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:26:45 INFO - 2016-01-22 03:26:45,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 136290304 03:26:45 INFO - 2016-01-22 03:26:45,022 DEBUG : BROWSER_OUTPUT: 03:27:06 INFO - 2016-01-22 03:27:06,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37518/tests/v8_7/run.html (next: http://localhost:37518/tests/v8_7/run.html) 03:27:06 INFO - 2016-01-22 03:27:06,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 136101888 03:27:06 INFO - 2016-01-22 03:27:06,677 DEBUG : BROWSER_OUTPUT: 03:27:06 INFO - 2016-01-22 03:27:06,677 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:27:06 INFO - 2016-01-22 03:27:06,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:27:06 INFO - 2016-01-22 03:27:06,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:27:06 INFO - 2016-01-22 03:27:06,678 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:27:06 INFO - 2016-01-22 03:27:06,678 DEBUG : BROWSER_OUTPUT: |0;Richards;165.78249336870027 03:27:06 INFO - 2016-01-22 03:27:06,678 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;171.64435290078956 03:27:06 INFO - 2016-01-22 03:27:06,678 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.01785714285717 03:27:06 INFO - 2016-01-22 03:27:06,678 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 03:27:06 INFO - 2016-01-22 03:27:06,678 DEBUG : BROWSER_OUTPUT: |4;RayTrace;912.4087591240876 03:27:06 INFO - 2016-01-22 03:27:06,679 DEBUG : BROWSER_OUTPUT: |5;Earley;549.7526113249038 03:27:06 INFO - 2016-01-22 03:27:06,679 DEBUG : BROWSER_OUTPUT: |6;Boyer;11010.869565217392 03:27:06 INFO - 2016-01-22 03:27:06,679 DEBUG : BROWSER_OUTPUT: |7;RegExp;23880.95238095238 03:27:06 INFO - 2016-01-22 03:27:06,679 DEBUG : BROWSER_OUTPUT: |8;Splay;519.2107995846313 03:27:06 INFO - 2016-01-22 03:27:06,679 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 03:27:06 INFO - 2016-01-22 03:27:06,680 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:27:06 INFO - 2016-01-22 03:27:06,680 DEBUG : BROWSER_OUTPUT: __startTimestamp1453462026675__endTimestamp 03:27:06 INFO - 2016-01-22 03:27:06,680 DEBUG : BROWSER_OUTPUT: 03:27:06 INFO - 2016-01-22 03:27:06,680 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:27:06 INFO - 2016-01-22 03:27:06,680 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:27:06 INFO - 2016-01-22 03:27:06,681 DEBUG : BROWSER_OUTPUT: 03:27:06 INFO - 2016-01-22 03:27:06,681 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.78 Median:165.78 stddev:0.00 (0.0%) 03:27:06 INFO - 2016-01-22 03:27:06,681 DEBUG : BROWSER_OUTPUT: Values: 165.8 03:27:06 INFO - 2016-01-22 03:27:06,681 DEBUG : BROWSER_OUTPUT: 03:27:06 INFO - 2016-01-22 03:27:06,681 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:171.64 Median:171.64 stddev:0.00 (0.0%) 03:27:06 INFO - 2016-01-22 03:27:06,681 DEBUG : BROWSER_OUTPUT: Values: 171.6 03:27:06 INFO - 2016-01-22 03:27:06,682 DEBUG : BROWSER_OUTPUT: 03:27:06 INFO - 2016-01-22 03:27:06,682 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 03:27:06 INFO - 2016-01-22 03:27:06,682 DEBUG : BROWSER_OUTPUT: Values: 279.0 03:27:06 INFO - 2016-01-22 03:27:06,682 DEBUG : BROWSER_OUTPUT: 03:27:06 INFO - 2016-01-22 03:27:06,683 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 03:27:06 INFO - 2016-01-22 03:27:06,683 DEBUG : BROWSER_OUTPUT: Values: 5202.1 03:27:06 INFO - 2016-01-22 03:27:06,683 DEBUG : BROWSER_OUTPUT: 03:27:06 INFO - 2016-01-22 03:27:06,683 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:912.41 Median:912.41 stddev:0.00 (0.0%) 03:27:06 INFO - 2016-01-22 03:27:06,683 DEBUG : BROWSER_OUTPUT: Values: 912.4 03:27:06 INFO - 2016-01-22 03:27:06,683 DEBUG : BROWSER_OUTPUT: 03:27:06 INFO - 2016-01-22 03:27:06,684 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:549.75 Median:549.75 stddev:0.00 (0.0%) 03:27:06 INFO - 2016-01-22 03:27:06,684 DEBUG : BROWSER_OUTPUT: Values: 549.8 03:27:06 INFO - 2016-01-22 03:27:06,684 DEBUG : BROWSER_OUTPUT: 03:27:06 INFO - 2016-01-22 03:27:06,684 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11010.87 Median:11010.87 stddev:0.00 (0.0%) 03:27:06 INFO - 2016-01-22 03:27:06,684 DEBUG : BROWSER_OUTPUT: Values: 11010.9 03:27:06 INFO - 2016-01-22 03:27:06,684 DEBUG : BROWSER_OUTPUT: 03:27:06 INFO - 2016-01-22 03:27:06,684 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23880.95 Median:23880.95 stddev:0.00 (0.0%) 03:27:06 INFO - 2016-01-22 03:27:06,684 DEBUG : BROWSER_OUTPUT: Values: 23881.0 03:27:06 INFO - 2016-01-22 03:27:06,684 DEBUG : BROWSER_OUTPUT: 03:27:06 INFO - 2016-01-22 03:27:06,685 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:519.21 Median:519.21 stddev:0.00 (0.0%) 03:27:06 INFO - 2016-01-22 03:27:06,685 DEBUG : BROWSER_OUTPUT: Values: 519.2 03:27:06 INFO - 2016-01-22 03:27:06,685 DEBUG : BROWSER_OUTPUT: 03:27:06 INFO - 2016-01-22 03:27:06,685 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 03:27:06 INFO - 2016-01-22 03:27:06,686 DEBUG : BROWSER_OUTPUT: Values: 4830.9 03:27:06 INFO - 2016-01-22 03:27:06,686 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:27:06 INFO - 2016-01-22 03:27:06,687 DEBUG : BROWSER_OUTPUT: 03:27:07 INFO - 2016-01-22 03:27:07,536 INFO : Browser exited with error code: 0 03:27:07 INFO - 2016-01-22 03:27:07,550 INFO : Completed test v8_7 (00:00:39) 03:27:07 INFO - 2016-01-22 03:27:07,740 INFO : Completed test suite (00:20:08) 03:27:07 INFO - 2016-01-22 03:27:07,740 DEBUG : Working with test: dromaeo_css 03:27:07 INFO - 2016-01-22 03:27:07,740 DEBUG : Generating results file: dromaeo_css 03:27:07 INFO - 2016-01-22 03:27:07,741 DEBUG : Working with test: kraken 03:27:07 INFO - 2016-01-22 03:27:07,741 DEBUG : Generating results file: kraken 03:27:07 INFO - 2016-01-22 03:27:07,741 INFO : javascript benchmark 03:27:07 INFO - 2016-01-22 03:27:07,742 DEBUG : Working with test: v8_7 03:27:07 INFO - 2016-01-22 03:27:07,742 DEBUG : Generating results file: v8_7 03:27:07 INFO - 2016-01-22 03:27:07,742 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:27:07 INFO - 2016-01-22 03:27:07,793 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 03:27:07 INFO - 2016-01-22 03:27:07,793 DEBUG : process_Request line: dromaeo_css 7418.29 graph.html#tests=[[72,52,43]] 03:27:07 INFO - 2016-01-22 03:27:07,793 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:27:07 INFO - 2016-01-22 03:27:07,821 DEBUG : process_Request line: kraken 1505.90 graph.html#tests=[[232,52,43]] 03:27:07 INFO - 2016-01-22 03:27:07,821 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:27:07 INFO - 2016-01-22 03:27:07,855 DEBUG : process_Request line: v8_7 23219.35 graph.html#tests=[[230,52,43]] 03:27:07 INFO - 2016-01-22 03:27:07,856 INFO : javascript benchmark 03:27:07 INFO - 2016-01-22 03:27:07,859 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3323.634400215976, 3355.8993230203087, 3373.7638365314438, 3388.4917262410627, 3401.4217583010886, 5459.6997165156, 5472.644278121919, 5488.231647569343, 5493.368262649797, 5520.475554822296, 5513.173024046385, 5539.639923404976, 5543.029969755286, 5547.25112109865, 5560.193771903072, 5035.043341765062, 5062.696238225718, 5113.6931784092885, 5141.82003629873, 5145.022445735317, 4902.19113846215, 4993.950060499403, 5049.0, 5072.771725272371, 5075.238714192882, 4925.70445773253, 4993.226049962262, 4996.825111121111, 4999.600031997432, 5039.0, 5041.647084704054, 5105.566026887719, 5125.743712814382, 5135.075686376451, 5153.8919132386345, 4834.927476087862, 4857.63567732418, 4968.105740966625, 5017.021680772251, 5030.496950304941, 5313.1764576490705, 5330.280412144389, 5358.812441564526, 5368.4363141869935, 5380.166074258496, 5892.086726557391, 5917.733701983378, 5961.284645842483, 5965.70171491428, 5967.194428752106, 5765.53875689948, 5876.030454974924, 5920.703964801785, 5931.495822855062, 6057.454829065361, 5604.495595396393, 5615.831525054255, 5623.240862483553, 5627.043402621564, 5636.577256705764, 6057.3639767824625, 6069.0, 6074.301455332693, 6075.817725468155, 6078.665673388006, 5639.097744360883, 5732.140178973187, 5735.856603584861, 5831.970840145772, 5860.560457965669, 5875.3243377012195, 5906.409359064145, 5946.910796337972, 5950.018246989285, 5955.076963070731, 5669.06460434032, 5874.060150375919, 5892.086726557391, 5894.2926848778425, 5908.320543137508, 5730.19777231188, 5791.449812267828, 5816.94183058164, 5824.097264923944, 5844.736986835603, 4516.0, 4537.636989040869, 4546.02260513991, 4548.5906268436, 4572.268437050056, 4044.1911617675996, 4085.142120154801, 4095.959040409558, 4100.36444351126, 4142.357934520154, 5570.777168913279, 5653.830385088371, 5656.717164141776, 5676.489115979582, 5709.714514274269, 6017.1275165100815, 6058.485028772516, 6062.363451837582, 6074.42292982166, 6077.301110372364, 5525.834224973257, 5610.803621873215, 5619.690916999522, 5690.317161940594, 5735.483806457355, 5181.896362072737, 5220.955808838247, 5225.320708307896, 5229.320188375563, 5242.082635538765, 6121.663308517986, 6136.815895523141, 6138.07928810682, 6141.662208578482, 6153.815385538441, 5778.27771528559, 5787.363390027178, 5861.6189947653265, 5915.112733090071, 6027.819165424957, 5950.375210602998, 5986.042233242661, 5987.940120598738, 6002.0, 6047.48596369296, 5780.190773291659, 5828.912566311594, 5831.475167234969, 5838.978178818775, 5845.766169353178, 5790.073588225863, 5819.098039803837, 5857.531397488276, 5857.799151174085, 5916.230889984447, 5787.8553036174435, 5813.09896965971, 5815.156802263733, 5819.0, 5829.562782791392, 5615.887682246251, 5802.883942321215, 5803.506701930383, 5808.680522571299, 5832.475077243069, 5640.097584386478, 5679.00617391963, 5725.942740572541, 5733.885322293614, 5760.596758226884, 5769.711514424178, 5800.4489573490455, 5837.241158649348, 5837.854053648693, 5869.266341707286, 5516.751746171512, 5591.580631452576, 5731.19763233156, 5735.799247026334, 5758.942410576008], "unit": "ms", "name": "dojo.html", "value": 5461.20352033438}, {"lowerIsBetter": false, "replicates": [588.7792077970761, 644.7324360390442, 649.0912722188936, 650.398381497115, 655.118865126405, 40996.38505422417, 41468.37797433041, 41587.58412415875, 41619.79190104053, 41863.953401164945, 46164.538354616445, 46578.76710616451, 46659.76670116653, 46722.0, 46774.53225467744, 9127.0, 9335.113164249386, 9342.0, 9349.06509349063, 9353.392029518094, 9039.096090390974, 9192.816143677122, 9208.401453905508, 9216.769580760467, 9219.170274675278, 9120.817583648322, 9140.223081038086, 9176.587053582605, 9209.355345125843, 9255.25957923368, 9225.492597907147, 9238.907610923872, 9310.627574896997, 9326.39378440406, 9328.860067098998, 9083.318751093695, 9190.724278271662, 9232.44605323676, 9243.0, 9253.259739220846, 43653.0, 43685.0, 44255.11489770219, 44325.33511997323, 44362.556374436164, 3753.7560058596105, 3765.3975363941636, 3842.8078596070086, 3854.9542379625777, 3933.8426462941447, 31340.0, 31551.36897262065, 31946.20134496656, 31959.360812783845, 32830.17924551905, 4162.125953549758, 4175.874723758292, 4252.298370768819, 4261.4460120184485, 4323.113761678848, 307663.0, 307771.9999999978, 308177.0, 308325.0, 309776.0, 45714.77142614266, 45956.77021614937, 46169.76915115403, 46191.538084619395, 46342.76828615835, 43300.566994330286, 43569.0, 43569.12861742747, 43640.781796090814, 43708.0, 15889.887707860338, 15965.600859978362, 16126.354945802037, 16144.273507692182, 16192.514224573282, 12827.486900524062, 12902.935485322701, 12935.741285174245, 13071.215727056408, 13351.132176408502, 15567.922160389353, 15598.454054108279, 15638.3744650215, 15675.0, 15681.68636627284, 6170.167027451326, 6239.816064377432, 6294.905576416358, 6309.621422714652, 6365.649889256136, 966.4974213408988, 1018.9133923616575, 1093.185576745314, 1109.5561775289787, 1144.0390072339108, 28248.15255542337, 28720.0, 28975.420491590052, 29455.705442945724, 29486.852565737034, 1084.3030657021736, 1113.582406597526, 1212.2302338015247, 1216.1426194532833, 1240.206267988488, 15236.695266094615, 15375.0, 15554.766678499831, 15804.446844360393, 17724.0, 195396.0, 196264.0, 196923.0, 525535.0, 891901.0, 59856.401435985084, 59912.0, 60268.0, 60802.783944320865, 60916.695416522634, 1482.8072350594568, 1499.86501214889, 1505.5633866178684, 1508.1478964385306, 1516.499555146799, 30677.693223068378, 31043.0, 31462.791678032452, 31527.84236078805, 32039.0, 50081.24878126904, 50703.0, 50881.0, 50931.236031458815, 50951.74524127356, 334995.0, 340245.0, 340408.0, 340941.0, 341229.0, 34818.82590587132, 34907.4763878537, 34950.0, 35179.12052198613, 35672.28655426929, 45607.77196113998, 45868.31197531973, 46324.07351853012, 46972.295415569475, 47274.0, 39792.40311395389, 39839.2032159361, 40821.79589102035, 41095.38356924589, 41471.7926410366, 39158.80420597879, 39450.60549394469, 39997.80001099976, 40096.79951600223, 40199.79900100481, 39601.0, 39859.40210896897, 42219.3667095, 42355.3646695306, 42825.143497130506, 33021.33957320792, 34827.0, 35310.47034294539, 35367.0, 35768.463473047406, 26787.464250715268, 27387.726122738517, 27535.586966195922, 27716.168514944584, 28340.85829570839], "unit": "ms", "name": "ext.html", "value": 19516.678825015915}, {"lowerIsBetter": false, "replicates": [385.88230589670155, 389.0875896023825, 390.5625699216877, 396.37175077502155, 396.50634959475457, 15502.922485387557, 17183.398581049667, 17520.123993800324, 18336.633267334644, 18477.53806154847, 17860.28558857644, 18585.907070464662, 18838.34065807697, 18879.339223127194, 18966.431007069776, 5208.140656791625, 5306.548943339802, 5355.08963476208, 5366.356037275533, 5367.704776237305, 5311.840644780663, 5324.680519168843, 5478.58910581706, 5514.200440936062, 5526.226328314039, 5441.863953401177, 5461.42655021223, 5493.176023596453, 5886.0, 6264.686765661721, 6168.321484636686, 6188.96905515474, 6193.659348735818, 6226.097215903691, 6238.906416403757, 5155.175171972466, 5293.708846013467, 5301.151815709506, 5515.806946756885, 5519.724013799294, 12812.10315277931, 13000.804987925094, 13082.86917130826, 13090.149140305944, 13111.868881311255, 2134.3810295014428, 2208.5228632990115, 2265.026038803314, 2276.9658455123185, 2325.4186453386656, 10012.29913906027, 10684.19868509857, 10981.066609338215, 11079.446027698663, 14868.0, 1984.1468168687459, 1991.153759652142, 1991.4523506035812, 1992.2529051605648, 2012.1951219512166, 65286.0, 67022.66488667525, 68120.9999999995, 68166.65916670434, 68721.65639171822, 11310.60412885545, 11321.773564528663, 11330.94334528322, 11338.659840204808, 11357.261777984404, 14908.0, 14935.626609334853, 14943.925280373529, 14967.101973881385, 15018.474353397578, 8481.491110533389, 8483.660653573788, 8492.575371231414, 8494.193051660206, 8521.44610600309, 8329.125441828643, 8332.16678332162, 8338.416310858182, 8343.374246931504, 8402.873956890651, 4692.788824502837, 4817.662763606514, 4824.0110777291275, 4863.319135321058, 4890.144224760653, 2037.9184832606827, 2043.5912817436572, 2053.8973051347375, 2067.142136013568, 2076.584683063393, 914.9176574108362, 973.9853902191472, 1014.5840205515703, 1014.8122597319519, 1061.1139698351808, 16100.75848862268, 16470.75293870593, 16987.490375288762, 17179.0, 17390.3043878246, 963.4989805301204, 985.8816941966867, 1018.8318927376899, 1025.600015993763, 1079.881213066562, 9867.654632087842, 10299.845502317472, 10305.76330840304, 10346.172306215636, 10462.26764126519, 467736.0, 474926.0, 479072.0, 507181.0, 633005.0, 77017.61491192508, 78019.0, 79308.0, 79891.60054199692, 83409.0, 533.4425525326044, 547.384192783119, 547.9205515200354, 548.8435795798179, 551.382451654142, 10848.349099054081, 10900.454977250947, 11063.668089957315, 11660.53357865676, 11669.649910502698, 37802.0, 38632.80683596564, 39203.60796392114, 39827.40258896061, 40846.1830763389, 51512.22731658953, 52432.47567524276, 52581.21128183004, 53221.733891330296, 53233.46766532285, 10184.490775461345, 10233.795324093328, 10368.22238332113, 10373.948130259301, 10457.738556536147, 17683.292668293125, 18208.635827283117, 18341.633167336844, 18495.722564161817, 19547.0, 16071.598210044842, 16084.632806211603, 16187.75718364249, 16190.514284571482, 16634.16829158513, 14695.632609184855, 14856.628584285047, 15607.063576185465, 15897.920510397375, 16124.355025798837, 15675.764863527284, 15800.92099539495, 15900.125493097528, 16505.422310219084, 16824.242909069366, 10465.16278697687, 10535.0, 10670.0, 10674.786504269716, 10686.358818470917, 12997.48010079624, 15726.0, 15802.446914357943, 15949.920250399138, 16204.351825927302], "unit": "ms", "name": "jquery.html", "value": 9160.441655975554}, {"lowerIsBetter": false, "replicates": [1581.003967500474, 1590.3638544582166, 1871.7473141125945, 1893.1764682363173, 1902.9628852275512, 7968.920310796891, 8125.674973001072, 8399.454035487697, 8426.283765879907, 8456.281216096631, 8503.91496085039, 8538.103499132594, 8572.442791218566, 8577.399582029246, 8598.183172598609, 2361.7638236176417, 2388.641703744435, 2398.5322862041908, 2399.0763556030965, 2404.711434627847, 2355.0108954239176, 2376.702912135983, 2410.385351735305, 2430.987845060781, 2433.452473193535, 2361.2680069178523, 2383.30884043628, 2385.654080158376, 2430.3195105370523, 2445.4131008557997, 2342.9648555271683, 2394.473215892501, 2408.939776505593, 2423.0, 2423.7697418745192, 2334.754850740682, 2403.182917807954, 2404.5671779079757, 2405.7714517120844, 2406.867622280774, 8300.335973122135, 8359.373047021498, 8406.033306169807, 8423.83152336956, 8447.619857106445, 4976.726280054596, 5027.723475208862, 5030.119729047438, 5070.2394640803805, 5080.466551012128, 3176.698213669698, 3194.1056504178637, 3230.3216324571868, 3243.870245190213, 3274.0, 1054.1250761867632, 1060.2631171335925, 1068.8076146293663, 1083.5340803454512, 2118.5127420693325, 11374.772504549945, 11405.08759299254, 11423.543058277659, 11457.197996140274, 11506.194566380356, 4309.784510774449, 4383.211022016068, 4405.317175837687, 4438.977805111019, 4453.487848897354, 9360.297977651704, 9381.249500039981, 9446.574904129331, 9459.810803784023, 9479.715608531755, 4941.160002799533, 4954.653174277766, 4960.677555958851, 4973.0, 4976.825811096666, 4578.725276483422, 4581.015081757439, 4587.655925805578, 4610.05493873755, 4614.238650622609, 3610.4764809102535, 3626.165981824195, 3658.231771328051, 3693.242885208526, 3697.8705745298785, 1113.9331640101457, 1124.145649306533, 1124.454639499842, 1133.4729350851894, 1142.948567314473, 1173.976520469603, 1187.216437151476, 1230.4954968462887, 1473.3443617590283, 1484.4359143525608, 7765.572893490912, 7914.683412663429, 7964.0, 7970.402219833536, 7970.92392527013, 1126.183516950221, 1178.116412690482, 1230.5077968812548, 1238.888500034983, 1241.2490443281865, 6130.816075517741, 6198.6280823150755, 6255.311915689271, 6306.590071645328, 6316.557840951089, 9999.100080992746, 10204.642837500653, 10253.025962533547, 10258.640947566799, 10447.111995480318, 9927.950360248296, 10047.145992590566, 10120.987901209968, 10192.694219173436, 10309.896901030894, 7863.724769633035, 7998.600069996477, 8007.599620018976, 8010.959945200237, 8081.272685458337, 7532.849343012999, 7670.194629564038, 7712.113106992768, 7715.768526944201, 7749.92250077492, 8863.202311791969, 9001.684941027033, 9052.185303322469, 9067.09329067088, 9140.954295228481, 9132.543372831198, 9196.58615362297, 9295.674651387439, 9417.199538039069, 9468.573914173741, 7060.3292687194635, 7069.293070692889, 7148.213696493278, 7176.677049532888, 7184.856302873809, 7863.606819658879, 7986.480878742863, 8044.597770111354, 8065.233802788725, 8118.147594502729, 7432.3682486987045, 7567.129780075362, 7631.3894888407685, 7755.844883102419, 7885.053793544811, 7387.372073373824, 7570.772876813704, 7599.316061554487, 7671.61641917913, 7691.1539730628465, 7572.545647260961, 7619.0, 7627.618619069135, 7635.0, 7679.040119985002, 6859.211190713132, 6920.273371295942, 6951.096357473496, 6960.269171736894, 6966.860662786818, 6999.720011199495, 7017.824554386181, 7056.435485161277, 7065.470089743187, 7077.186123595647], "unit": "ms", "name": "mootools.html", "value": 4821.904700064778}, {"lowerIsBetter": false, "replicates": [364.8230608155043, 366.3314451126694, 367.90618392309955, 369.32229359126, 378.03412281620456, 6310.116583678288, 6379.872402551952, 6444.742210311588, 6460.7092680829355, 6496.707648155832, 6351.618902865831, 6376.39424254695, 6392.16901802765, 6396.360363963601, 6427.614343139415, 4861.368022157132, 4892.217245240762, 4894.0, 4901.044296362211, 4904.068227036852, 4887.951120488785, 4892.951070489303, 4895.167821470341, 4909.705417674951, 4930.778114984834, 4690.57784799368, 4798.448178459487, 4807.687500312469, 4849.539293767087, 4884.7069175849565, 4864.708117512961, 4877.292792545079, 4891.437484689271, 4906.754662266872, 4920.778564964585, 4328.437303150602, 4333.155034768221, 4347.0, 4348.847790327355, 4366.08312254427, 6047.092936059582, 6074.817755467343, 6084.330723620398, 6090.116933044728, 6094.817155485298, 5669.744861481243, 5745.052066409037, 5761.078227483625, 5774.7112644368035, 5780.9710951445395, 6742.52802303839, 6775.525713200029, 6780.93219067808, 6781.152355955505, 6806.115205023365, 4784.928226076611, 4821.855344339676, 4828.227483602642, 4829.879253018667, 4839.298301746262, 6891.3797758202, 6961.617111058889, 7038.859222815566, 7048.400885924702, 7053.68258428372, 4961.751912404366, 4968.453470118284, 4971.975140124277, 4977.950220497749, 4982.626303027288, 5036.84889453317, 5037.420696619863, 5039.244113383022, 5042.268871013755, 5046.192609182586, 5727.455891690282, 5731.77072917087, 5733.684647344436, 5744.655320680772, 5766.365699773021, 6597.010448432773, 6822.556533825285, 6836.350546698056, 6843.965780171166, 6864.519483636197, 1770.8848924820104, 1771.8051014388407, 1771.9988206663195, 1774.5563609097726, 1783.0549808601202, 1232.4946771823509, 1236.449779847977, 1237.7833879071127, 1250.1436515986397, 1261.4701825233424, 6614.636195009224, 6628.4697224221945, 6630.469562434993, 6635.369639884203, 6641.435477984425, 7038.612876291751, 7066.081409416743, 7077.363037326562, 7096.645167741593, 7117.71529138839, 6334.619922804646, 6357.586756860789, 6457.418832305115, 6621.3047629998155, 6629.270780214172, 3839.347310957144, 3868.8065596720053, 3872.3997780344093, 3875.4380614811257, 3880.243352546283, 7257.419406447471, 7270.781876543606, 7282.781516554512, 7283.053203083565, 7293.0, 7136.892946605805, 7227.49407541467, 7277.2358902315555, 7283.417326613858, 7283.7450689225625, 7249.477609701916, 7285.052943117466, 7296.635168241567, 7312.341889229995, 7323.157836848831, 7011.193712723102, 7048.224695283412, 7076.823079423056, 7080.114985626797, 7088.822779430556, 6974.302569742985, 7011.894821577578, 7019.227884932551, 7024.754133605299, 7027.15674119109, 7231.855362892607, 7239.0, 7259.6007219603425, 7288.271172882669, 7309.122905251404, 4856.1016212000895, 4898.583620392306, 4912.459629440687, 4913.263010548446, 4916.3362946001835, 7105.46708996817, 7120.964395178198, 7124.3944264738075, 7131.322524360177, 7139.785806425815, 6925.342092501204, 6939.757108501179, 6943.47923905699, 6945.305469453015, 6962.373386395248, 6810.489213308922, 6912.44700423975, 6921.515493915377, 6948.305169483011, 6961.443084553122, 6793.116894803644, 6793.150856142982, 6793.5244532882225, 6795.150606174228, 6802.829929251809, 6913.654317284015, 6930.757423490154, 6930.930690693231, 6933.583984960918, 6944.201416837129, 6661.233958094881, 6771.864562708817, 6802.795916122524, 6810.0, 6815.829604259933], "unit": "ms", "name": "prototype.html", "value": 5189.853135775773}, {"lowerIsBetter": false, "replicates": [857.1086070486693, 873.384264093814, 904.7647611620981, 945.0407836046414, 974.8050389922017, 13880.861191388083, 13884.23636699981, 13995.370208340637, 14448.422063117476, 14488.275586220687, 13880.4447822087, 14099.78850317246, 14128.78806817896, 14135.505257315996, 14137.22245276512, 917.499962520428, 937.8358787212245, 940.1773448232797, 940.7648087978006, 942.4627962061628, 918.6692790595414, 919.6275508419101, 921.1249313152498, 923.3813345058827, 923.6628630549834, 974.24009272767, 975.7804493988831, 977.5210147027976, 978.4569563892037, 979.2851218610418, 951.6431338248157, 957.8132264208448, 958.6453012385392, 959.6976952260051, 967.7048500207434, 720.495653042872, 722.3462766196601, 723.9601821899794, 723.9674214660353, 725.5392825555757, 14312.499062532761, 14323.212223327817, 14397.424103035866, 14417.855821441755, 14442.0, 12408.937955310166, 12417.503299867994, 12595.937020314932, 12680.175788573713, 13289.86710132896, 10876.6193183239, 11116.221864469491, 11154.219204655677, 11156.386398748065, 11288.887111128948, 3806.257779732953, 3821.808909554511, 3829.942550861739, 3840.788756618385, 3903.8243279052513, 48334.51665483371, 48463.0, 48540.27189592159, 48754.99999999964, 49053.26420103701, 10449.582016719398, 10579.89420105789, 10756.623518176826, 10773.24587278883, 10864.534238462298, 18487.630247394976, 18497.5375615608, 18536.165872535767, 18548.81451185498, 18564.0, 7117.466190035768, 7463.776086717407, 7482.738104166437, 7501.987231723757, 7664.961675191588, 4234.13200293939, 4322.69741118125, 4354.934675979863, 4425.09285596452, 4530.637548996073, 3224.629167645704, 3282.2122690554575, 3284.7700660953506, 3285.42505061618, 3470.9479357809655, 641.9069234960905, 649.2890285137767, 649.5453182771984, 649.7855707616475, 658.4501940879419, 599.7331187621554, 706.1631966120163, 717.4619035723208, 734.4418242136015, 777.5101685937823, 8311.792205194797, 8525.531095789791, 8838.116188381238, 9079.954600226956, 9093.136152065543, 578.9450002249864, 613.6989582085918, 728.1044315491974, 732.3665029749228, 732.4250463386217, 4385.846495372647, 4410.492793328808, 4444.3333499974615, 4500.414946057057, 4589.678722489393, 59180.40819591749, 59463.0, 59719.70140149271, 60042.0, 60288.0, 53407.46592534103, 53979.92040159175, 54646.726766365915, 54831.725841370535, 55127.724361378736, 47430.52569474261, 47593.0, 47759.52240477551, 47866.5213347869, 50274.245886311735, 9173.082691730773, 9221.262299015929, 9365.157135857806, 9439.0, 9553.474558899326, 34676.82661586676, 35483.82258088693, 36116.819415902755, 36228.81885590555, 36287.81856090703, 41435.1712965745, 41636.37545436881, 44555.0, 46594.0, 47118.52881471279, 11676.474558645052, 11726.824097638713, 11884.940575297069, 12020.519179232733, 12033.578824741093, 13236.536721214712, 13598.388072536562, 13710.245936473191, 14412.85587144157, 15006.77489837675, 12567.748645027232, 12641.747165056831, 12790.232586044494, 13265.0, 13380.19718816874, 12839.807402889151, 13358.198508089547, 13486.595402137951, 13671.794923075962, 13794.793078104038, 12485.375731213584, 12666.050046246753, 13015.934920325337, 13330.800037999632, 13372.531961381304, 10613.469326533797, 10951.56193752241, 11460.14048946349, 11498.137639677225, 11523.884761152616, 9725.027497250217, 10000.0, 10184.0, 10359.378437293786, 10603.41681207541], "unit": "ms", "name": "yui.html", "value": 6820.316030011573}], "name": "dromaeo_css", "value": 7418.293920798711}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 111.0, 110.0, 111.0, 120.0, 111.0, 111.0, 111.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [163.0, 133.0, 151.0, 172.0, 123.0, 148.0, 147.0, 129.0, 173.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 161.0, 159.0, 162.0, 162.0, 161.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [78.0, 73.0, 73.0, 164.0, 75.0, 72.0, 71.0, 74.0, 165.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 91.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 138.0, 92.0, 93.0, 93.0, 144.0, 92.0, 94.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 111.0, 109.0, 110.0, 111.0, 109.0, 111.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 95.0, 95.0, 96.0, 96.0, 98.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 61.0, 62.0, 60.0, 60.0, 59.0, 59.0, 59.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 59.7}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 69.0, 64.0, 65.0, 66.0, 65.0, 65.0, 69.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.7}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 83.0, 89.0, 82.0, 81.0, 82.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [108.0, 120.0, 125.0, 119.0, 114.0, 124.0, 118.0, 119.0, 118.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.1}, {"lowerIsBetter": true, "replicates": [155.0, 145.0, 142.0, 144.0, 147.0, 135.0, 148.0, 145.0, 143.0, 148.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 67.0, 66.0, 66.0, 65.0, 66.0, 64.0, 63.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.2}], "name": "kraken", "value": 1505.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.78249336870027], "unit": "score", "name": "Richards", "value": 212.94166399999992}, {"lowerIsBetter": false, "replicates": [171.64435290078956], "unit": "score", "name": "DeltaBlue", "value": 385.20346799999993}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [912.4087591240876], "unit": "score", "name": "RayTrace", "value": 811.0279440000002}, {"lowerIsBetter": false, "replicates": [549.7526113249038], "unit": "score", "name": "Earley", "value": 1212.296197}, {"lowerIsBetter": false, "replicates": [11010.869565217392], "unit": "score", "name": "Boyer", "value": 60.527735439289266}, {"lowerIsBetter": false, "replicates": [23880.95238095238], "unit": "score", "name": "RegExp", "value": 38.146929212362885}, {"lowerIsBetter": false, "replicates": [519.2107995846313], "unit": "score", "name": "Splay", "value": 156.95166600000005}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23219.349536359336}]} 03:27:07 INFO - RETURN: dromaeo_css: 7418.29 03:27:07 INFO - RETURN: kraken: 1505.90 03:27:07 INFO - RETURN: v8_7: 23219.35 03:27:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23219.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1505.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7418.29"}}} 03:27:07 INFO - Return code: 0 03:27:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:27:07 INFO - # TBPL SUCCESS # 03:27:07 INFO - Running post-action listener: _resource_record_post_action 03:27:07 INFO - Running post-run listener: _resource_record_post_run 03:27:09 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 266240; Write bytes: 513998848; Read time: 36; Write time: 418652 03:27:09 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 237121536; Read time: 0; Write time: 228880 03:27:09 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 266240; Write bytes: 276590592; Read time: 36; Write time: 189756 03:27:09 INFO - Running post-run listener: _upload_blobber_files 03:27:09 INFO - Blob upload gear active. 03:27:09 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:27:09 INFO - Copying logs to upload dir... 03:27:09 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.900027 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-22 03:27:08.906038) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 03:27:08.911348) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009899 build_url: 'https://queue.taskcluster.net/v1/task/DHX1xJ27Qhaq0qIUO3hbuw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 03:27:08.961763) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 03:27:08.962095) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453460759.947121-370090357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 03:27:09.011818) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 03:27:09.012162) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 03:27:09.012452) ========= ========= Total master_lag: 0.26 =========