builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1453533132.56 results: success (0) buildid: 20160122210619 builduid: 94ce798601cf4b4e92139899d1c6bbe7 revision: d4a2eea9d7c3d7cef58f62aa560077837e30c0c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:12.562900) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:12.563356) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:12.563674) ========= 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=1861a34ebfea852630dec091000001fa-1453532333.581777-552667916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006461 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:12.595568) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:12.595896) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:12.696913) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:12.697222) ========= 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=1861a34ebfea852630dec091000001fa-1453532333.581777-552667916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:12.762568) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:12.762867) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:12.763478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:12.763846) ========= 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=1861a34ebfea852630dec091000001fa-1453532333.581777-552667916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 23:12:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-01-22 23:12:13 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168662 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:12.954586) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:12.954895) ========= 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=1861a34ebfea852630dec091000001fa-1453532333.581777-552667916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014625 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:13.007674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:13.008022) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d4a2eea9d7c3d7cef58f62aa560077837e30c0c4 --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 d4a2eea9d7c3d7cef58f62aa560077837e30c0c4 --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=1861a34ebfea852630dec091000001fa-1453532333.581777-552667916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 23:12:13,416 truncating revision to first 12 chars 2016-01-22 23:12:13,416 Setting DEBUG logging. 2016-01-22 23:12:13,416 attempt 1/10 2016-01-22 23:12:13,416 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d4a2eea9d7c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 23:12:13,770 unpacking tar archive at: mozilla-aurora-d4a2eea9d7c3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647134 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:13.671166) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:13.671522) ========= echo d4a2eea9d7c3d7cef58f62aa560077837e30c0c4 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd4a2eea9d7c3d7cef58f62aa560077837e30c0c4'] 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=1861a34ebfea852630dec091000001fa-1453532333.581777-552667916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d4a2eea9d7c3d7cef58f62aa560077837e30c0c4 program finished with exit code 0 elapsedTime=0.004651 script_repo_revision: 'd4a2eea9d7c3d7cef58f62aa560077837e30c0c4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:13.729962) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:13.730356) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 23:12:13.769579) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-22 23:12:13.769884) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1861a34ebfea852630dec091000001fa-1453532333.581777-552667916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:12:14 INFO - MultiFileLogger online at 20160122 23:12:14 in /builds/slave/test-pgo 23:12:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 23:12:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:12:14 INFO - {'append_to_log': False, 23:12:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:12:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:12:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:12:14 INFO - 'branch': 'Mozilla-Aurora', 23:12:14 INFO - 'buildbot_json_path': 'buildprops.json', 23:12:14 INFO - 'config_files': ('talos/linux_config.py',), 23:12:14 INFO - 'default_actions': ('clobber', 23:12:14 INFO - 'read-buildbot-config', 23:12:14 INFO - 'download-and-extract', 23:12:14 INFO - 'populate-webroot', 23:12:14 INFO - 'create-virtualenv', 23:12:14 INFO - 'install', 23:12:14 INFO - 'run-tests'), 23:12:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:12:14 INFO - 'download_minidump_stackwalk': True, 23:12:14 INFO - 'download_symbols': 'ondemand', 23:12:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:12:14 INFO - 'tooltool.py': '/tools/tooltool.py', 23:12:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:12:14 INFO - '/tools/misc-python/virtualenv.py')}, 23:12:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:12:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:12:14 INFO - 'installer_path': 'installer.exe', 23:12:14 INFO - 'log_level': 'info', 23:12:14 INFO - 'log_name': 'talos', 23:12:14 INFO - 'log_to_console': True, 23:12:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:12:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:12:14 INFO - 'opt_config_files': (), 23:12:14 INFO - 'pip_index': False, 23:12:14 INFO - 'sps_profile': False, 23:12:14 INFO - 'sps_profile_interval': 0, 23:12:14 INFO - 'suite': 'dromaeojs', 23:12:14 INFO - 'system_bits': '32', 23:12:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:12:14 INFO - 'title': 'talos-linux64-ix-069', 23:12:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:12:14 INFO - 'use_talos_json': True, 23:12:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:12:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:12:14 INFO - 'work_dir': 'build'} 23:12:14 INFO - ##### 23:12:14 INFO - ##### Running clobber step. 23:12:14 INFO - ##### 23:12:14 INFO - Running pre-action listener: _resource_record_pre_action 23:12:14 INFO - Running main action method: clobber 23:12:14 INFO - rmtree: /builds/slave/test-pgo/build 23:12:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:12:14 INFO - Running post-action listener: _resource_record_post_action 23:12:14 INFO - ##### 23:12:14 INFO - ##### Running read-buildbot-config step. 23:12:14 INFO - ##### 23:12:14 INFO - Running pre-action listener: _resource_record_pre_action 23:12:14 INFO - Running main action method: read_buildbot_config 23:12:14 INFO - Using buildbot properties: 23:12:14 INFO - { 23:12:14 INFO - "properties": { 23:12:14 INFO - "buildnumber": 107, 23:12:14 INFO - "product": "firefox", 23:12:14 INFO - "script_repo_revision": "production", 23:12:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 23:12:14 INFO - "repository": "", 23:12:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 23:12:14 INFO - "buildid": "20160122210619", 23:12:14 INFO - "slavename": "talos-linux64-ix-069", 23:12:14 INFO - "pgo_build": "True", 23:12:14 INFO - "basedir": "/builds/slave/test-pgo", 23:12:14 INFO - "project": "", 23:12:14 INFO - "platform": "ubuntu64_hw", 23:12:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:12:14 INFO - "slavebuilddir": "test", 23:12:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:12:14 INFO - "branch": "mozilla-aurora", 23:12:14 INFO - "repo_path": "releases/mozilla-aurora", 23:12:14 INFO - "stage_platform": "linux64-pgo", 23:12:14 INFO - "builduid": "94ce798601cf4b4e92139899d1c6bbe7", 23:12:14 INFO - "revision": "d4a2eea9d7c3d7cef58f62aa560077837e30c0c4" 23:12:14 INFO - }, 23:12:14 INFO - "sourcestamp": { 23:12:14 INFO - "repository": "", 23:12:14 INFO - "hasPatch": false, 23:12:14 INFO - "project": "", 23:12:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 23:12:14 INFO - "changes": [ 23:12:14 INFO - { 23:12:14 INFO - "category": null, 23:12:14 INFO - "files": [ 23:12:14 INFO - { 23:12:14 INFO - "url": null, 23:12:14 INFO - "name": "https://queue.taskcluster.net/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 23:12:14 INFO - } 23:12:14 INFO - ], 23:12:14 INFO - "repository": "", 23:12:14 INFO - "rev": "d4a2eea9d7c3d7cef58f62aa560077837e30c0c4", 23:12:14 INFO - "who": "ryanvm@gmail.com", 23:12:14 INFO - "when": 1453533113, 23:12:14 INFO - "number": 7504602, 23:12:14 INFO - "comments": "Bug 1220336 - Give HeapSnapshot.creationTime tests more slack for WinXP. r=jdescottes, a=test-only\n\nThese two tests have been intermittently failing on WinXP because the\n`Date.now()` timers only have a granularity of +/- 15 milliseconds on that\nplatform. This commit ensures that we have a range of at least 30 milliseconds\nbefore and after taking the snapshot to ensure that the snapshot's timestamp\nwill fit within the range.", 23:12:14 INFO - "project": "", 23:12:14 INFO - "at": "Fri 22 Jan 2016 23:11:53", 23:12:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 23:12:14 INFO - "revlink": "", 23:12:14 INFO - "properties": [ 23:12:14 INFO - [ 23:12:14 INFO - "buildid", 23:12:14 INFO - "20160122210619", 23:12:14 INFO - "Change" 23:12:14 INFO - ], 23:12:14 INFO - [ 23:12:14 INFO - "builduid", 23:12:14 INFO - "94ce798601cf4b4e92139899d1c6bbe7", 23:12:14 INFO - "Change" 23:12:14 INFO - ], 23:12:14 INFO - [ 23:12:14 INFO - "pgo_build", 23:12:14 INFO - "True", 23:12:14 INFO - "Change" 23:12:14 INFO - ] 23:12:14 INFO - ], 23:12:14 INFO - "revision": "d4a2eea9d7c3d7cef58f62aa560077837e30c0c4" 23:12:14 INFO - } 23:12:14 INFO - ], 23:12:14 INFO - "revision": "d4a2eea9d7c3d7cef58f62aa560077837e30c0c4" 23:12:14 INFO - } 23:12:14 INFO - } 23:12:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 23:12:14 INFO - Running post-action listener: _resource_record_post_action 23:12:14 INFO - ##### 23:12:14 INFO - ##### Running download-and-extract step. 23:12:14 INFO - ##### 23:12:14 INFO - Running pre-action listener: _resource_record_pre_action 23:12:14 INFO - Running main action method: download_and_extract 23:12:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:14 INFO - https://queue.taskcluster.net/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:12:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/test_packages.json 23:12:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/test_packages.json 23:12:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:12:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:12:21 INFO - Downloaded 1302 bytes. 23:12:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:12:21 INFO - Using the following test package requirements: 23:12:21 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 23:12:21 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 23:12:21 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:12:21 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 23:12:21 INFO - u'jsshell-linux-x86_64.zip'], 23:12:21 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 23:12:21 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:12:21 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 23:12:21 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 23:12:21 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:12:21 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 23:12:21 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:12:21 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 23:12:21 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:12:21 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 23:12:21 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 23:12:21 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:12:21 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:21 INFO - https://queue.taskcluster.net/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:12:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 23:12:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 23:12:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/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 23:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/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 23:12:25 INFO - Downloaded 23159152 bytes. 23:12:25 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 23:12:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 23:12:25 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 23:12:26 INFO - Return code: 0 23:12:26 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 23:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:26 INFO - https://queue.taskcluster.net/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:12:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 23:12:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 23:12:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/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 23:12:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/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 23:12:27 INFO - Downloaded 23159152 bytes. 23:12:27 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 23:12:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 23:12:27 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 23:12:29 INFO - Return code: 0 23:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:29 INFO - https://queue.taskcluster.net/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:12:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 23:12:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 23:12:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/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 23:12:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/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 23:12:30 INFO - Downloaded 11132038 bytes. 23:12:30 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 23:12:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 23:12:30 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 23:12:30 INFO - Return code: 0 23:12: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')]} 23:12:30 INFO - https://queue.taskcluster.net/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:12:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 23:12:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 23:12:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/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 23:12:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EoXF8QCbQC-BlpzBwYjZtA/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 23:12:31 INFO - Downloaded 58017554 bytes. 23:12:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 23:12:31 INFO - mkdir: /builds/slave/test-pgo/properties 23:12:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:12:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:12:31 INFO - Contents: 23:12:31 INFO - build_url:https://queue.taskcluster.net/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 23:12:31 INFO - Running post-action listener: _resource_record_post_action 23:12:31 INFO - Running post-action listener: set_extra_try_arguments 23:12:31 INFO - ##### 23:12:31 INFO - ##### Running populate-webroot step. 23:12:31 INFO - ##### 23:12:31 INFO - Running pre-action listener: _resource_record_pre_action 23:12:31 INFO - Running main action method: populate_webroot 23:12:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:12:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:12:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:12:31 INFO - '--tppagecycles', 23:12:31 INFO - '7'], 23:12:31 INFO - 'tests': ['tsvgm']}}, 23:12:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:12:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:12:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:12:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:12:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:12:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:12:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:12:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:31 INFO - 'talos_options': ['--e10s'], 23:12:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:12:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:31 INFO - 'tests': ['damp', 'tps']}, 23:12:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:31 INFO - 'talos_options': ['--e10s'], 23:12:31 INFO - 'tests': ['damp', 'tps']}, 23:12:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:12:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:12:31 INFO - 'other': {'tests': ['a11yr', 23:12:31 INFO - 'ts_paint', 23:12:31 INFO - 'tpaint', 23:12:31 INFO - 'sessionrestore', 23:12:31 INFO - 'sessionrestore_no_auto_restore']}, 23:12:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:12:31 INFO - 'tests': ['a11yr', 23:12:31 INFO - 'ts_paint', 23:12:31 INFO - 'tpaint', 23:12:31 INFO - 'sessionrestore', 23:12:31 INFO - 'sessionrestore_no_auto_restore']}, 23:12:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:12:31 INFO - 'tests': ['a11yr', 23:12:31 INFO - 'ts_paint', 23:12:31 INFO - 'tpaint', 23:12:31 INFO - 'sessionrestore', 23:12:31 INFO - 'sessionrestore_no_auto_restore']}, 23:12:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:12:31 INFO - 'tests': ['a11yr', 23:12:31 INFO - 'ts_paint', 23:12:31 INFO - 'tpaint', 23:12:31 INFO - 'sessionrestore', 23:12:31 INFO - 'sessionrestore_no_auto_restore']}, 23:12:31 INFO - 'other_l64': {'tests': ['a11yr', 23:12:31 INFO - 'ts_paint', 23:12:31 INFO - 'tpaint', 23:12:31 INFO - 'sessionrestore', 23:12:31 INFO - 'sessionrestore_no_auto_restore']}, 23:12:31 INFO - 'other_nol64': {'tests': ['a11yr', 23:12:31 INFO - 'ts_paint', 23:12:31 INFO - 'tpaint', 23:12:31 INFO - 'sessionrestore', 23:12:31 INFO - 'sessionrestore_no_auto_restore']}, 23:12:31 INFO - 'svgr': {'tests': ['tsvgx', 23:12:31 INFO - 'tsvgr_opacity', 23:12:31 INFO - 'tart', 23:12:31 INFO - 'tscrollx', 23:12:31 INFO - 'cart']}, 23:12:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:12:31 INFO - 'tests': ['tsvgx', 23:12:31 INFO - 'tsvgr_opacity', 23:12:31 INFO - 'tart', 23:12:31 INFO - 'tscrollx', 23:12:31 INFO - 'cart']}, 23:12:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:31 INFO - 'tests': ['tp5o']}, 23:12:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:31 INFO - 'talos_options': ['--e10s'], 23:12:31 INFO - 'tests': ['tp5o']}, 23:12:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:31 INFO - 'talos_options': ['--xperf_path', 23:12:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:12:31 INFO - 'tests': ['tp5n']}, 23:12:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:12:31 INFO - 'talos_options': ['--e10s', 23:12:31 INFO - '--xperf_path', 23:12:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:12:31 INFO - 'tests': ['tp5n']}}, 23:12:31 INFO - 'talos.zip': {'path': '', 23:12:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:12:31 INFO - Running post-action listener: _resource_record_post_action 23:12:31 INFO - ##### 23:12:31 INFO - ##### Running create-virtualenv step. 23:12:31 INFO - ##### 23:12:31 INFO - Running pre-action listener: _resource_record_pre_action 23:12:31 INFO - Running main action method: create_virtualenv 23:12:31 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:12:31 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 23:12:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:12:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:12:31 INFO - Using real prefix '/usr' 23:12:31 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:12:32 INFO - Installing distribute.............................................................................................................................................................................................done. 23:12:34 INFO - Installing pip.................done. 23:12:34 INFO - Return code: 0 23:12:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:12:34 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')]} 23:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:34 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')]} 23:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:34 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 0x7f117afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9350>, '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 0x1cca250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cca6e0>, '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': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', '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 23:12:34 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 23:12:34 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 23:12:34 INFO - Using env: {'DISPLAY': ':0', 23:12:34 INFO - 'HOME': '/home/cltbld', 23:12:34 INFO - 'LANG': 'en_US.UTF-8', 23:12:34 INFO - 'LANGUAGE': 'en_US:en', 23:12:34 INFO - 'LOGNAME': 'cltbld', 23:12:34 INFO - 'MAIL': '/var/mail/cltbld', 23:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:34 INFO - 'MOZ_NO_REMOTE': '1', 23:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:34 INFO - 'NO_EM_RESTART': '1', 23:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:12:34 INFO - 'PWD': '/builds/slave/test-pgo', 23:12:34 INFO - 'SHELL': '/bin/bash', 23:12:34 INFO - 'SHLVL': '1', 23:12:34 INFO - 'TERM': 'linux', 23:12:34 INFO - 'TMOUT': '86400', 23:12:34 INFO - 'USER': 'cltbld', 23:12:34 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', 23:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:34 INFO - '_': '/tools/buildbot/bin/python'} 23:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:34 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 23:12:34 INFO - Cleaning up... 23:12:34 INFO - Return code: 0 23:12:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:12:34 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')]} 23:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:34 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')]} 23:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:34 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 0x7f117afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9350>, '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 0x1cca250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cca6e0>, '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': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', '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 23:12:34 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 23:12:34 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 23:12:34 INFO - Using env: {'DISPLAY': ':0', 23:12:34 INFO - 'HOME': '/home/cltbld', 23:12:34 INFO - 'LANG': 'en_US.UTF-8', 23:12:34 INFO - 'LANGUAGE': 'en_US:en', 23:12:34 INFO - 'LOGNAME': 'cltbld', 23:12:34 INFO - 'MAIL': '/var/mail/cltbld', 23:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:34 INFO - 'MOZ_NO_REMOTE': '1', 23:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:34 INFO - 'NO_EM_RESTART': '1', 23:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:12:34 INFO - 'PWD': '/builds/slave/test-pgo', 23:12:34 INFO - 'SHELL': '/bin/bash', 23:12:34 INFO - 'SHLVL': '1', 23:12:34 INFO - 'TERM': 'linux', 23:12:34 INFO - 'TMOUT': '86400', 23:12:34 INFO - 'USER': 'cltbld', 23:12:34 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', 23:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:34 INFO - '_': '/tools/buildbot/bin/python'} 23:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:34 INFO - Downloading/unpacking psutil>=0.7.1 23:12:34 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 23:12:34 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 23:12:34 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 23:12:34 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 23:12:34 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 23:12:34 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 23:12:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:12:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:12:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:12:36 INFO - Installing collected packages: psutil 23:12:36 INFO - Running setup.py install for psutil 23:12:36 INFO - building 'psutil._psutil_linux' extension 23:12:36 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 23:12:36 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 23:12:36 INFO - building 'psutil._psutil_posix' extension 23:12:36 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 23:12:36 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 23:12:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:12:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:12:36 INFO - Successfully installed psutil 23:12:36 INFO - Cleaning up... 23:12:37 INFO - Return code: 0 23:12:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:12: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')]} 23:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12: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')]} 23:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12: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', '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 0x7f117afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9350>, '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 0x1cca250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cca6e0>, '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': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', '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 23:12: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 23:12: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 mozsystemmonitor==0.0.0 23:12:37 INFO - Using env: {'DISPLAY': ':0', 23:12:37 INFO - 'HOME': '/home/cltbld', 23:12:37 INFO - 'LANG': 'en_US.UTF-8', 23:12:37 INFO - 'LANGUAGE': 'en_US:en', 23:12:37 INFO - 'LOGNAME': 'cltbld', 23:12:37 INFO - 'MAIL': '/var/mail/cltbld', 23:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:37 INFO - 'MOZ_NO_REMOTE': '1', 23:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:37 INFO - 'NO_EM_RESTART': '1', 23:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:12:37 INFO - 'PWD': '/builds/slave/test-pgo', 23:12:37 INFO - 'SHELL': '/bin/bash', 23:12:37 INFO - 'SHLVL': '1', 23:12:37 INFO - 'TERM': 'linux', 23:12:37 INFO - 'TMOUT': '86400', 23:12:37 INFO - 'USER': 'cltbld', 23:12:37 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', 23:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:37 INFO - '_': '/tools/buildbot/bin/python'} 23:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:12:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:12:39 INFO - Installing collected packages: mozsystemmonitor 23:12:39 INFO - Running setup.py install for mozsystemmonitor 23:12:39 INFO - Successfully installed mozsystemmonitor 23:12:39 INFO - Cleaning up... 23:12:39 INFO - Return code: 0 23:12:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:39 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 0x7f117afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9350>, '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 0x1cca250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cca6e0>, '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': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', '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 23:12:39 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 23:12:39 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 23:12:39 INFO - Using env: {'DISPLAY': ':0', 23:12:39 INFO - 'HOME': '/home/cltbld', 23:12:39 INFO - 'LANG': 'en_US.UTF-8', 23:12:39 INFO - 'LANGUAGE': 'en_US:en', 23:12:39 INFO - 'LOGNAME': 'cltbld', 23:12:39 INFO - 'MAIL': '/var/mail/cltbld', 23:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:39 INFO - 'MOZ_NO_REMOTE': '1', 23:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:39 INFO - 'NO_EM_RESTART': '1', 23:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:12:39 INFO - 'PWD': '/builds/slave/test-pgo', 23:12:39 INFO - 'SHELL': '/bin/bash', 23:12:39 INFO - 'SHLVL': '1', 23:12:39 INFO - 'TERM': 'linux', 23:12:39 INFO - 'TMOUT': '86400', 23:12:39 INFO - 'USER': 'cltbld', 23:12:39 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', 23:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:39 INFO - '_': '/tools/buildbot/bin/python'} 23:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:39 INFO - Downloading/unpacking blobuploader==1.2.4 23:12: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 23:12: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 23:12: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 23:12: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 23:12: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 23:12: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 23:12:41 INFO - Downloading blobuploader-1.2.4.tar.gz 23:12:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:12:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:12:41 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 23:12:41 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 23:12:41 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 23:12:41 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 23:12:41 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 23:12:41 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 23:12:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:12:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:12:41 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 23:12:41 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 23:12:41 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 23:12:41 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 23:12:41 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 23:12:41 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 23:12:41 INFO - Downloading docopt-0.6.1.tar.gz 23:12:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:12:41 INFO - Installing collected packages: blobuploader, requests, docopt 23:12:41 INFO - Running setup.py install for blobuploader 23:12:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:12:41 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:12:41 INFO - Running setup.py install for requests 23:12:42 INFO - Running setup.py install for docopt 23:12:42 INFO - Successfully installed blobuploader requests docopt 23:12:42 INFO - Cleaning up... 23:12:42 INFO - Return code: 0 23:12:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:42 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 0x7f117afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9350>, '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 0x1cca250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cca6e0>, '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': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', '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 23:12:42 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 23:12:42 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 23:12:42 INFO - Using env: {'DISPLAY': ':0', 23:12:42 INFO - 'HOME': '/home/cltbld', 23:12:42 INFO - 'LANG': 'en_US.UTF-8', 23:12:42 INFO - 'LANGUAGE': 'en_US:en', 23:12:42 INFO - 'LOGNAME': 'cltbld', 23:12:42 INFO - 'MAIL': '/var/mail/cltbld', 23:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:42 INFO - 'MOZ_NO_REMOTE': '1', 23:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:42 INFO - 'NO_EM_RESTART': '1', 23:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:12:42 INFO - 'PWD': '/builds/slave/test-pgo', 23:12:42 INFO - 'SHELL': '/bin/bash', 23:12:42 INFO - 'SHLVL': '1', 23:12:42 INFO - 'TERM': 'linux', 23:12:42 INFO - 'TMOUT': '86400', 23:12:42 INFO - 'USER': 'cltbld', 23:12:42 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', 23:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:42 INFO - '_': '/tools/buildbot/bin/python'} 23:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:12:42 INFO - Running setup.py (path:/tmp/pip-ksn22m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:12:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:12:42 INFO - Running setup.py (path:/tmp/pip-p1NW9G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:12:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:12:42 INFO - Running setup.py (path:/tmp/pip-ltYCeW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:12:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:12:42 INFO - Running setup.py (path:/tmp/pip-9oc2Jy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:12:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:12:42 INFO - Running setup.py (path:/tmp/pip-lA4KKp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:12:43 INFO - Running setup.py (path:/tmp/pip-zf_vZ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:12:43 INFO - Running setup.py (path:/tmp/pip-yw7mKY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:12:43 INFO - Running setup.py (path:/tmp/pip-RGsGGM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:12:43 INFO - Running setup.py (path:/tmp/pip-iwu9xI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:12:43 INFO - Running setup.py (path:/tmp/pip-SVGgr0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:12:43 INFO - Running setup.py (path:/tmp/pip-2Rs6Q9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:12:43 INFO - Running setup.py (path:/tmp/pip-qHOqiO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:12:43 INFO - Running setup.py (path:/tmp/pip-T9eVEv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:12:43 INFO - Running setup.py (path:/tmp/pip-ryVIXQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:12:43 INFO - Running setup.py (path:/tmp/pip-pFdpEU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:12:43 INFO - Running setup.py (path:/tmp/pip-TKThBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:12:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:12:43 INFO - Running setup.py (path:/tmp/pip-r00Dha-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:12:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:12:43 INFO - Running setup.py install for manifestparser 23:12:44 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:12:44 INFO - Running setup.py install for mozcrash 23:12:44 INFO - Running setup.py install for mozdebug 23:12:44 INFO - Running setup.py install for mozdevice 23:12:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:12:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:12:44 INFO - Running setup.py install for mozfile 23:12:44 INFO - Running setup.py install for mozhttpd 23:12:44 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:12:44 INFO - Running setup.py install for mozinfo 23:12:44 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:12:44 INFO - Running setup.py install for mozInstall 23:12:44 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:12:44 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:12:44 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:12:44 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:12:44 INFO - Running setup.py install for mozleak 23:12:44 INFO - Running setup.py install for mozlog 23:12:44 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:12:44 INFO - Running setup.py install for moznetwork 23:12:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:12:45 INFO - Running setup.py install for mozprocess 23:12:45 INFO - Running setup.py install for mozprofile 23:12:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:12:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:12:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:12:45 INFO - Running setup.py install for mozrunner 23:12:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:12:45 INFO - Running setup.py install for mozscreenshot 23:12:45 INFO - Running setup.py install for moztest 23:12:45 INFO - Running setup.py install for mozversion 23:12:45 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:12:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:12:45 INFO - Cleaning up... 23:12:45 INFO - Return code: 0 23:12:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f117afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9350>, '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 0x1cca250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cca6e0>, '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': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', '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 23:12:45 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 23:12:45 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 23:12:45 INFO - Using env: {'DISPLAY': ':0', 23:12:45 INFO - 'HOME': '/home/cltbld', 23:12:45 INFO - 'LANG': 'en_US.UTF-8', 23:12:45 INFO - 'LANGUAGE': 'en_US:en', 23:12:45 INFO - 'LOGNAME': 'cltbld', 23:12:45 INFO - 'MAIL': '/var/mail/cltbld', 23:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:45 INFO - 'MOZ_NO_REMOTE': '1', 23:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:45 INFO - 'NO_EM_RESTART': '1', 23:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:12:45 INFO - 'PWD': '/builds/slave/test-pgo', 23:12:45 INFO - 'SHELL': '/bin/bash', 23:12:45 INFO - 'SHLVL': '1', 23:12:45 INFO - 'TERM': 'linux', 23:12:45 INFO - 'TMOUT': '86400', 23:12:45 INFO - 'USER': 'cltbld', 23:12:45 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', 23:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:45 INFO - '_': '/tools/buildbot/bin/python'} 23:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:12:45 INFO - Running setup.py (path:/tmp/pip-AO8zqB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:12:45 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)) 23:12:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:12:45 INFO - Running setup.py (path:/tmp/pip-xCwkEb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:12:46 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)) 23:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:12:46 INFO - Running setup.py (path:/tmp/pip-9jkIqu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:12:46 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)) 23:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:12:46 INFO - Running setup.py (path:/tmp/pip-RQgy55-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:12:46 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)) 23:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:12:46 INFO - Running setup.py (path:/tmp/pip-hxUXAv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:12:46 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)) 23:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:12:46 INFO - Running setup.py (path:/tmp/pip-y9mVVF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:12:46 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)) 23:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:12:46 INFO - Running setup.py (path:/tmp/pip-yqvxp8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:12:46 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)) 23:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:12:46 INFO - Running setup.py (path:/tmp/pip-Bmh7k5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:12:46 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)) 23:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:12:46 INFO - Running setup.py (path:/tmp/pip-XvQkyU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:12:46 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)) 23:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:12:46 INFO - Running setup.py (path:/tmp/pip-A9539I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:12:46 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)) 23:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:12:46 INFO - Running setup.py (path:/tmp/pip-_jYYq1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:12:46 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)) 23:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:12:46 INFO - Running setup.py (path:/tmp/pip-H_ylzB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:12:46 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)) 23:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:12:46 INFO - Running setup.py (path:/tmp/pip-AlYSxc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:12:46 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)) 23:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:12:46 INFO - Running setup.py (path:/tmp/pip-ah9CGn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:12:46 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)) 23:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:12:46 INFO - Running setup.py (path:/tmp/pip-u4uiVj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:12:46 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)) 23:12:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:12:47 INFO - Running setup.py (path:/tmp/pip-vPDkO9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:12:47 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)) 23:12:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:12:47 INFO - Running setup.py (path:/tmp/pip-9xV8rF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:12:47 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)) 23:12:47 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)) 23:12:47 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)) 23:12:47 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)) 23:12:47 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)) 23:12:47 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)) 23:12:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:12:47 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 23:12:47 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 23:12:47 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 23:12:47 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 23:12:47 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 23:12:47 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 23:12:48 INFO - Downloading blessings-1.6.tar.gz 23:12:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:12:48 INFO - Installing collected packages: blessings 23:12:48 INFO - Running setup.py install for blessings 23:12:49 INFO - Successfully installed blessings 23:12:49 INFO - Cleaning up... 23:12:49 INFO - Return code: 0 23:12:49 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:12:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:12:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:12:49 INFO - Reading from file tmpfile_stdout 23:12:49 INFO - Current package versions: 23:12:49 INFO - argparse == 1.2.1 23:12:49 INFO - blessings == 1.6 23:12:49 INFO - blobuploader == 1.2.4 23:12:49 INFO - docopt == 0.6.1 23:12:49 INFO - manifestparser == 1.1 23:12:49 INFO - mozInstall == 1.12 23:12:49 INFO - mozcrash == 0.16 23:12:49 INFO - mozdebug == 0.1 23:12:49 INFO - mozdevice == 0.47 23:12:49 INFO - mozfile == 1.2 23:12:49 INFO - mozhttpd == 0.7 23:12:49 INFO - mozinfo == 0.9 23:12:49 INFO - mozleak == 0.1 23:12:49 INFO - mozlog == 3.1 23:12:49 INFO - moznetwork == 0.27 23:12:49 INFO - mozprocess == 0.22 23:12:49 INFO - mozprofile == 0.27 23:12:49 INFO - mozrunner == 6.11 23:12:49 INFO - mozscreenshot == 0.1 23:12:49 INFO - mozsystemmonitor == 0.0 23:12:49 INFO - moztest == 0.7 23:12:49 INFO - mozversion == 1.4 23:12:49 INFO - psutil == 3.1.1 23:12:49 INFO - requests == 1.2.3 23:12:49 INFO - wsgiref == 0.1.2 23:12:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:49 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 0x7f117afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9350>, '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 0x1cca250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cca6e0>, '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': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', '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 23:12:49 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 23:12:49 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 23:12:49 INFO - Using env: {'DISPLAY': ':0', 23:12:49 INFO - 'HOME': '/home/cltbld', 23:12:49 INFO - 'LANG': 'en_US.UTF-8', 23:12:49 INFO - 'LANGUAGE': 'en_US:en', 23:12:49 INFO - 'LOGNAME': 'cltbld', 23:12:49 INFO - 'MAIL': '/var/mail/cltbld', 23:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:49 INFO - 'MOZ_NO_REMOTE': '1', 23:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:49 INFO - 'NO_EM_RESTART': '1', 23:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:12:49 INFO - 'PWD': '/builds/slave/test-pgo', 23:12:49 INFO - 'SHELL': '/bin/bash', 23:12:49 INFO - 'SHLVL': '1', 23:12:49 INFO - 'TERM': 'linux', 23:12:49 INFO - 'TMOUT': '86400', 23:12:49 INFO - 'USER': 'cltbld', 23:12:49 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', 23:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:49 INFO - '_': '/tools/buildbot/bin/python'} 23:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:49 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)) 23:12:49 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)) 23:12:49 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)) 23:12:49 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)) 23:12:49 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)) 23:12:49 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)) 23:12:49 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)) 23:12:49 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)) 23:12:49 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)) 23:12:49 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)) 23:12:49 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)) 23:12:49 INFO - Cleaning up... 23:12:49 INFO - Return code: 0 23:12:49 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:49 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 0x7f117afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9350>, '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 0x1cca250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cca6e0>, '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': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', '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 23:12:49 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 23:12:49 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 23:12:49 INFO - Using env: {'DISPLAY': ':0', 23:12:49 INFO - 'HOME': '/home/cltbld', 23:12:49 INFO - 'LANG': 'en_US.UTF-8', 23:12:49 INFO - 'LANGUAGE': 'en_US:en', 23:12:49 INFO - 'LOGNAME': 'cltbld', 23:12:49 INFO - 'MAIL': '/var/mail/cltbld', 23:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:49 INFO - 'MOZ_NO_REMOTE': '1', 23:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:49 INFO - 'NO_EM_RESTART': '1', 23:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:12:49 INFO - 'PWD': '/builds/slave/test-pgo', 23:12:49 INFO - 'SHELL': '/bin/bash', 23:12:49 INFO - 'SHLVL': '1', 23:12:49 INFO - 'TERM': 'linux', 23:12:49 INFO - 'TMOUT': '86400', 23:12:49 INFO - 'USER': 'cltbld', 23:12:49 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', 23:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:49 INFO - '_': '/tools/buildbot/bin/python'} 23:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:49 INFO - Downloading/unpacking jsonschema 23:12:49 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 23:12:49 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 23:12:49 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 23:12:49 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 23:12:49 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 23:12:49 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 23:12:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:12:51 INFO - Downloading/unpacking functools32 (from jsonschema) 23:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:51 INFO - Downloading functools32-3.2.3-2.tar.gz 23:12:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:12:51 INFO - warning: no files found matching '*.txt' 23:12:51 INFO - no previously-included directories found matching 'build' 23:12:51 INFO - no previously-included directories found matching 'dist' 23:12:51 INFO - no previously-included directories found matching '.git*' 23:12:51 INFO - Installing collected packages: jsonschema, functools32 23:12:51 INFO - Running setup.py install for functools32 23:12:51 INFO - warning: no files found matching '*.txt' 23:12:51 INFO - no previously-included directories found matching 'build' 23:12:51 INFO - no previously-included directories found matching 'dist' 23:12:51 INFO - no previously-included directories found matching '.git*' 23:12:51 INFO - Successfully installed jsonschema functools32 23:12:51 INFO - Cleaning up... 23:12:52 INFO - Return code: 0 23:12:52 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:52 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 0x7f117afd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9350>, '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 0x1cca250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cca6e0>, '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': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', '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 23:12:52 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 23:12:52 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 23:12:52 INFO - Using env: {'DISPLAY': ':0', 23:12:52 INFO - 'HOME': '/home/cltbld', 23:12:52 INFO - 'LANG': 'en_US.UTF-8', 23:12:52 INFO - 'LANGUAGE': 'en_US:en', 23:12:52 INFO - 'LOGNAME': 'cltbld', 23:12:52 INFO - 'MAIL': '/var/mail/cltbld', 23:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:52 INFO - 'MOZ_NO_REMOTE': '1', 23:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:12:52 INFO - 'NO_EM_RESTART': '1', 23:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:12:52 INFO - 'PWD': '/builds/slave/test-pgo', 23:12:52 INFO - 'SHELL': '/bin/bash', 23:12:52 INFO - 'SHLVL': '1', 23:12:52 INFO - 'TERM': 'linux', 23:12:52 INFO - 'TMOUT': '86400', 23:12:52 INFO - 'USER': 'cltbld', 23:12:52 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', 23:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:52 INFO - '_': '/tools/buildbot/bin/python'} 23:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:52 INFO - Downloading/unpacking flake8 23:12:52 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 23:12:52 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 23:12:52 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 23:12:52 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 23:12:52 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 23:12:52 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 23:12:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:12:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:12:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:12:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:12:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:12:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:12:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:12:54 INFO - no previously-included directories found matching 'docs/_build' 23:12:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:12:54 INFO - Running setup.py install for pep8 23:12:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:12:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:12:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:12:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:12:54 INFO - no previously-included directories found matching 'docs/_build' 23:12:54 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:12:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:12:54 INFO - Cleaning up... 23:12:54 INFO - Return code: 0 23:12:54 INFO - Running post-action listener: _resource_record_post_action 23:12:54 INFO - Running post-action listener: _start_resource_monitoring 23:12:54 INFO - Starting resource monitoring. 23:12:54 INFO - ##### 23:12:54 INFO - ##### Running install step. 23:12:54 INFO - ##### 23:12:54 INFO - Running pre-action listener: _resource_record_pre_action 23:12:54 INFO - Running main action method: install 23:12:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:12:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:12:55 INFO - Reading from file tmpfile_stdout 23:12:55 INFO - Detecting whether we're running mozinstall >=1.0... 23:12:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:12:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:12:55 INFO - Reading from file tmpfile_stdout 23:12:55 INFO - Output received: 23:12:55 INFO - Usage: mozinstall [options] installer 23:12:55 INFO - Options: 23:12:55 INFO - -h, --help show this help message and exit 23:12:55 INFO - -d DEST, --destination=DEST 23:12:55 INFO - Directory to install application into. [default: 23:12:55 INFO - "/builds/slave/test-pgo"] 23:12:55 INFO - --app=APP Application being installed. [default: firefox] 23:12:55 INFO - mkdir: /builds/slave/test-pgo/build/application 23:12:55 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'] 23:12:55 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 23:13:11 INFO - Reading from file tmpfile_stdout 23:13:11 INFO - Output received: 23:13:11 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:13:11 INFO - Running post-action listener: _resource_record_post_action 23:13:11 INFO - ##### 23:13:11 INFO - ##### Running run-tests step. 23:13:11 INFO - ##### 23:13:11 INFO - Running pre-action listener: _resource_record_pre_action 23:13:11 INFO - Running main action method: run_tests 23:13:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:13:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:13:11 INFO - Python 2.7.3 23:13:11 INFO - Return code: 0 23:13:11 INFO - grabbing minidump binary from tooltool 23:13:11 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')]} 23:13:11 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 0x1cc9350>, '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 0x1cca250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cca6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:13:11 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 23:13:11 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 23:13:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:13:11 INFO - Return code: 0 23:13:11 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:13:11 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:13:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:13:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:13:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:13:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:13:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:13:12 INFO - Return code: 0 23:13:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 23:13:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost 23:13:12 INFO - Using env: {'DISPLAY': ':0', 23:13:12 INFO - 'HOME': '/home/cltbld', 23:13:12 INFO - 'LANG': 'en_US.UTF-8', 23:13:12 INFO - 'LANGUAGE': 'en_US:en', 23:13:12 INFO - 'LOGNAME': 'cltbld', 23:13:12 INFO - 'MAIL': '/var/mail/cltbld', 23:13:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:13:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:12 INFO - 'MOZ_NO_REMOTE': '1', 23:13:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:12 INFO - 'NO_EM_RESTART': '1', 23:13:12 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:13:12 INFO - 'PWD': '/builds/slave/test-pgo', 23:13:12 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:13:12 INFO - 'SHELL': '/bin/bash', 23:13:12 INFO - 'SHLVL': '1', 23:13:12 INFO - 'TERM': 'linux', 23:13:12 INFO - 'TMOUT': '86400', 23:13:12 INFO - 'USER': 'cltbld', 23:13:12 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453532333.581777-552667916', 23:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:12 INFO - '_': '/tools/buildbot/bin/python'} 23:13:12 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost'] with output_timeout 3600 23:13:12 INFO - mozversion INFO | application_buildid: 20160122210619 23:13:12 INFO - mozversion INFO | application_changeset: d4a2eea9d7c3d7cef58f62aa560077837e30c0c4 23:13:12 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 23:13:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:13:12 INFO - mozversion INFO | application_name: Firefox 23:13:12 INFO - mozversion INFO | application_remotingname: firefox-dev 23:13:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:13:12 INFO - mozversion INFO | application_vendor: Mozilla 23:13:12 INFO - mozversion INFO | application_version: 45.0a2 23:13:12 INFO - mozversion INFO | platform_buildid: 20160122210619 23:13:12 INFO - mozversion INFO | platform_changeset: d4a2eea9d7c3d7cef58f62aa560077837e30c0c4 23:13:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:13:12 INFO - mozversion INFO | platform_version: 45.0a2 23:13:12 INFO - 2016-01-22 23:13:12,686 DEBUG : using testdate: 1453533192 23:13:12 INFO - 2016-01-22 23:13:12,686 DEBUG : actual date: 1453533192 23:13:12 INFO - 2016-01-22 23:13:12,695 INFO : starting webserver on 'localhost:45871' 23:13:12 INFO - 2016-01-22 23:13:12,696 INFO : Starting test suite talos-linux64-ix-069 23:13:12 INFO - 2016-01-22 23:13:12,697 INFO : Starting test dromaeo_css 23:13:12 INFO - 2016-01-22 23:13:12,697 DEBUG : operating with platform_type : linux_ 23:13:12 INFO - 2016-01-22 23:13:12,698 INFO : Initialising browser for dromaeo_css test... 23:13:12 INFO - 2016-01-22 23:13:12,714 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTV4D8_/profile http://localhost:45871/getInfo.html 23:13:17 INFO - 2016-01-22 23:13:17,349 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:13:17 INFO - 2016-01-22 23:13:17,349 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:13:17 INFO - 2016-01-22 23:13:17,349 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:13:17 INFO - 2016-01-22 23:13:17,349 DEBUG : BROWSER_OUTPUT: __metrics 23:13:17 INFO - 2016-01-22 23:13:17,539 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:13:18 INFO - 2016-01-22 23:13:18,634 INFO : Browser initialized. 23:13:18 INFO - 2016-01-22 23:13:18,635 INFO : Running cycle 1/1 for dromaeo_css test... 23:13:18 INFO - 2016-01-22 23:13:18,635 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTV4D8_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:13:30 INFO - 2016-01-22 23:13:30,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 137748480 23:13:30 INFO - 2016-01-22 23:13:30,425 DEBUG : BROWSER_OUTPUT: 23:14:21 INFO - 2016-01-22 23:14:21,148 DEBUG : BROWSER_OUTPUT: 1453533261147 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] 23:16:29 INFO - 2016-01-22 23:16:29,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45871/tests/dromaeo/cssquery-ext.html) 23:16:31 INFO - 2016-01-22 23:16:31,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 264179712 23:16:31 INFO - 2016-01-22 23:16:31,013 DEBUG : BROWSER_OUTPUT: 23:19:33 INFO - 2016-01-22 23:19:33,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/dromaeo/cssquery-ext.html (next: http://localhost:45871/tests/dromaeo/cssquery-jquery.html) 23:19:33 INFO - 2016-01-22 23:19:33,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 215699456 23:19:33 INFO - 2016-01-22 23:19:33,857 DEBUG : BROWSER_OUTPUT: 23:22:35 INFO - 2016-01-22 23:22:35,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45871/tests/dromaeo/cssquery-mootools.html) 23:22:36 INFO - 2016-01-22 23:22:36,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 209383424 23:22:36 INFO - 2016-01-22 23:22:36,269 DEBUG : BROWSER_OUTPUT: 23:25:38 INFO - 2016-01-22 23:25:38,053 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45871/tests/dromaeo/cssquery-prototype.html) 23:25:38 INFO - 2016-01-22 23:25:38,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 199688192 23:25:38 INFO - 2016-01-22 23:25:38,620 DEBUG : BROWSER_OUTPUT: 23:28:41 INFO - 2016-01-22 23:28:41,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45871/tests/dromaeo/cssquery-yui.html) 23:28:41 INFO - 2016-01-22 23:28:41,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 201101312 23:28:41 INFO - 2016-01-22 23:28:41,649 DEBUG : BROWSER_OUTPUT: 23:31:43 INFO - 2016-01-22 23:31:43,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/dromaeo/cssquery-yui.html (next: http://localhost:45871/tests/dromaeo/cssquery-dojo.html) 23:31:44 INFO - 2016-01-22 23:31:44,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 221061120 23:31:44 INFO - 2016-01-22 23:31:44,128 DEBUG : BROWSER_OUTPUT: 23:31:44 INFO - 2016-01-22 23:31:44,128 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:31:44 INFO - 2016-01-22 23:31:44,128 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:31:44 INFO - 2016-01-22 23:31:44,128 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:31:44 INFO - 2016-01-22 23:31:44,128 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:31:44 INFO - 2016-01-22 23:31:44,128 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3331.650176731443;3383.3064221834525;3394.4229480988247;3418.4872269159637;3425.0752296879837;5574.303212098488;5596.188552659862;5626.212330273765;5627.212190293362;5628.465295796903;5626.606137570372;5634.690092044936;5639.182318563806;5643.181738647893;5661.8584535386635;4863.781129849148;5083.949160508394;5117.641765076446;5172.353455818023;5218;5092.567131793802;5109.514596113363;5109.540141387274;5110.514501122406;5112.41207261166;5033.597312215033;5062.924056139161;5066.898662026757;5077.365329333833;5079.034983353151;5053.620978426596;5123.769430375623;5170.457102004273;5171.612129090333;5192.636515443921;5031.949680503221;5118.488151184889;5138.409082955433;5150.871228219287;5174.974125129388;5106.055379754757;5193.298904647862;5412.729363531807;5428.891422171574;5488.204210389471;5940.049592065248;6029.095635654643;6035.336113027563;6055.969720151371;6059.848503787441;6088.634681919055;6096.847578810521;6118.510519158456;6127.142200091991;6129.540284478682;5390.8921821563345;5492.313460817398;5656.095024796054;5680.0627896397045;5692.23154874095;6012.038073908241;6053.7881174159575;6054.182685337423;6060.060690592965;6073.1497590337385;5944.5838791284195;5967.820965370959;5969.910451343233;5973.462388385066;5976.491998180117;5728.684922329312;5846.386129456346;5889.411058894077;6064.272287325549;6066.969665151646;5932.288125424977;5935.198748168942;5935.406459354116;5935.7625694972585;6019.879602407927;5879.470847623649;5935.139404786368;5935.584509084322;5936.584439089309;5940.851478713067;4441.378207050951;4516.548345165457;4574.542545745466;4581.266997280486;4592.196365636;4120.237756015147;4134.586541345841;4134.689898257643;4140.296149654566;4163.97918010408;5639.210510528529;5641.069223578063;5652.491275785199;5653.971730141405;5682.7442765075675;5749.310082790092;5863.2670916135485;6039.969800150971;6113.693956142648;6122.520135281246;5629.183768353566;5636.408177141341;5636.492715655529;5646.632968857011;5648.435156484401;4993.825216117491;5211.374635043819;5216.843494695166;5217.634765566374;5221.843344699665;6066.181065556182;6094.238220222473;6211;6212.502999760009;6214.720337584729;6039.214902062704;6071.202002087907;6079.3312735598165;6083.66539840313;6116.29662588808;5980.43185897339;6044.788432404845;6176.4441200292185;6222.502199824094;6222.564420490703;5856.970715146397;5916.3492015877355;5922;5922.378150294157;5958.1658567801405;5950.077737950624;5995.760169593167;6000.729967151401;6002.159697642421;6055.394460553909;5718.1708652246025;5816.563757718103;5852.853678657897;5858.7070646468355;5862.149988251765;5937.703114844327;5940.079287710412;5944.970275148597;5948.524118070457;5960.880782384242;5850.12248162779;5852.122181672783;5853.795117170878;5858.209141765978;5859.648421094748;5679.488846003879;5786.826395208151;5850.912236316373;5862.325832529314;5950.7917222896995;5806.303243610793;5813.941860581509;5820.883582328245;5827.825165245049;5829.8251052468495 23:31:44 INFO - 2016-01-22 23:31:44,128 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.286479036414;611.5932904618429;613.2640831002798;615.2616859768278;623.1120653069376;34433.31133377331;42503.57496425039;43072.138557228915;43146.35280470795;43201.135977280515;46859;47485.28772068422;47548;47550.04899902009;47628.285575716305;8034.718784842532;8127.3904457165945;9194.264458843276;9399.248060155205;10477.528511217013;10641.095506881924;10698.732531686692;10732.517036733327;10779.892201077968;10788.622398216065;10798.946005269963;10881.564737410494;10929.56281748729;10935.28920620157;10939.726506837313;8436.57817109145;8653.17794809492;11086.556537738481;11354.091672666167;11366.37484938328;10752.086072683831;10887.401192934385;10891.83662245067;10895.128389728803;10899;41414;41920;41945.580544194476;41957;41996.79001605003;3445.2592692571216;3461.9480707789403;3473.548438702978;3987.1228329767405;4277.165072305896;32468.837655811807;32554.83722581372;32623.51064734031;32941.835290823394;33079.17302067443;3569.5716514018222;3599.784012959231;3629.4192929131214;3638.890833275006;3662.5971143174497;275141;276184;277369;277465;277825;60332.39667603355;61733.38266617366;61902.69048654818;67599;68311;81310;82368.58815705882;82859;82892.17107828966;83043.5847820757;17094.572635684206;17282.308707651806;17297;17317.047562383937;17321.7401738974;12922.353882306035;12946.546870859474;12978.286194259406;13051.086423950423;13056.281904495154;21923.890380548313;22433.887830560743;22442.438939026655;22467.55064898693;22496.550068998527;8358.791030224293;8473.957630211933;8488.533130677872;8576.528290944058;8606.13938606147;919.866619340192;996.3573495095623;998.031909048222;1051.2903789941759;1166.2652528906735;28044.43911121766;28146.71853281482;28363;28472.71527284742;28852.567211491845;1064.824303989833;1101.944902754859;1122.259308856151;1203.1157099531838;1231.8337024501757;14675.853241467663;15001.549953501195;15352;17076.40232591878;18181.909090454465;403882;409102;410104;410166;410732;59944.700276499214;60381.39618603846;60410;60417.395826041175;60602.39397606056;1278.6355888571713;1359.1912811876916;1359.503781119884;1426.785982102693;1453.4331610671848;30372.39255214839;30572;30728.231794205323;31458.213544661565;31919.36161276715;47085;47798.52201477941;47886.52113478821;48336;49066.75466622644;311251;312089;313705;314618;314742;34375.31249375048;34401.827990859885;34505.654943450245;35086.64913350936;35119.47320790241;46078.769606151756;46229;46775.53224467712;47084.29373559468;47326.05347893092;38791.224175516894;39687.80156099201;39737.60262397339;39918;40602.39096413615;37534;38824.223515530095;39154.6084539151;44811.55188448204;45280.77359613181;38649.80675096607;39049.6095039046;39161;39262.80368598139;39603;34418;34666.48000280048;35386.29227415386;35510.82244588761;35680.28639427249;26676;27172.475076505205;27251.454970900868;27272.454550908475;27670.44659106847 23:31:44 INFO - 2016-01-22 23:31:44,129 DEBUG : BROWSER_OUTPUT: |2;jquery.html;358.7201982453687;361.46683641628584;361.7377401383997;364.80847555033586;368.32964005509973;15280.617984550392;15638;17203.827961720395;17589.560260993483;18212.726809097872;18459.630807383845;18540.536486587807;18792.906035469805;18812;18899.433017009476;5466.01611709892;5589.916151257714;5605.663660180382;5606.719664016803;5606.831795046155;4149.83400663973;4256.7445953242905;5555.333359996806;6074.878502429949;6278.497720182398;6093;6165.63006219626;6186.041163619646;6231.813045608639;6235.282942461629;6058.182145410379;6092.66490343031;6108.3280839107665;6110.052941794029;6110.08348747687;5309.893802123975;5339.385970613391;5361.142217245222;5361.919571206435;5376.542993845528;22104.88947555268;22142.335729928127;22325.553488930294;22447.21434749776;22509.887450562805;2175.8585691929975;2186.606410846047;2290.6449500327476;2311.1217737259735;2331.5453486570127;14013.789793153112;14124.92937535316;14136.787948180785;14262.215578143301;14356.06685565435;1929.8263156315859;1977.2091163534558;1990.581977784667;2008.588239410932;2015.2946468735972;63728;64376;64810;66145;66407.66796166037;9916.206703463706;10024.097831195228;10105.39367637944;10132.54403551842;10205;13118;13220.33898305081;13245.867541324656;13247.536336228186;13254.469821207236;7840.960795196102;7914.406419518559;7938.126806051329;7943.086545047278;7991.320737737357;7913.287804097658;7923.643436045391;7929.365650748042;7967.641456134488;7968.163342849033;6193.1329613854095;6248.812535623939;6261.311255761862;6271.090691849657;6287.151234583364;1614.144503413193;1700.3113738935751;1737.9565510862076;1792.3905872003581;1805.1606003208572;404.9007993041724;845.6152450634946;925.5788616179622;966.3042609321277;1014.8832884218261;10016.399016058915;10354.741131471774;10711.46442677863;10942.890571094187;10962.945185274022;432.5998451432412;438.861758546057;443.1159836126947;443.28409618465946;446.7185673025973;6098.512119030467;6257.186565746424;6358.1416508771645;6386.744530218833;6396.136521569529;436241;636335;643144;657501;668646;82544.58727706323;83781;85110;85840.99999999875;87838.56080719555;1197.3713800254936;1198.9868561065884;1202.4048096192441;1210.4734440518228;1224.3388570172185;16004.279807408462;16125.838741612903;16135.112568808829;16346.67306653884;16517.091559964316;36035.63964360428;36481.27037459289;36890.26219475649;37787;37819.24361512809;49216.26175607297;49306.75346623244;49344;49689.50310496993;50962.74518627383;9393.812123757623;9535.189508891823;9802.607895684092;9808.362456440309;9840.96669849684;11414.828777568177;11544.191906566795;16972.321107155574;17842.821571784636;17926.462206133838;14955.252237388304;15077;15077.472288469851;15397;15422.845771542141;14850.331735072165;15051.548453545973;15170.848291517384;15603.375864965274;16013.439529616408;12301.138920275853;12904.548340808027;14613.92693036528;14777.630559236106;16336.754948676016;9562.95218523903;9762.951185244028;10023.198144148304;10236.948815256173;10248.743781405525;7689;13896.235707035805;15031.098134111988;15053.322600483223;15266.236688165325 23:31:44 INFO - 2016-01-22 23:31:44,130 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1532.2874863188615;1582.7704982777493;1667.9999999999984;1778.937737179199;1891.659501289768;6714.6306953117555;7387.556746595208;7726.922730772691;7729.381649468043;7741;7559.773206803791;7707.537547747125;7708.267714567121;7711.807204819882;7712.190220026887;1934.6130773845216;1982.851286153537;1985.7120717495955;2221.7444993825716;2264.0377839418265;2012.8289095426906;2227.9554408911813;2267.64851448025;2271.432141964509;2272.488690044743;2197.923072692456;2219.511707424364;2230.955380892381;2257.8306627002958;2261.852979556332;2217.2904670505445;2271.2618399020384;2286.565552545011;2294.621387471065;2295.2196253273883;2243.383069655841;2260.3106052653934;2262.0273282488524;2263.1626298269744;2264.286749673864;7698.1916898725385;7765.1070126935565;7768.184340644264;7770.3006729394065;7789.9221007789765;4516.932246016312;4558.8860278492975;4581.931271030937;4585.082983403299;4585.449746030465;3021.365513242222;3023.682513336112;3052.2064263291704;3062.8315442650646;3118.5789918360956;987.1707765476962;1007.184180813536;1013.4476710192963;1016.7763092119795;1018.4195008844962;10576.841347379795;10578.153747700166;10578.947105264502;10586.470676466146;10593.940605939499;3968.861089861841;3975.906625677904;4031.8185681644395;4033.193361327746;4054.493188351456;9108.407953483002;9138.634454621873;9141.588628511732;9147.908520914838;9187.770305742277;4623.768811559408;4635.2120139576355;4649.4420669519195;4649.837255696035;4672.322513235562;4235.216484950294;4255.3616957456625;4258.552851950562;4279.657627389802;4285.485741710952;3194.9361012779614;3285.720713739311;3571.94642080369;3649.1789347397153;3652.1782598915033;1080.935143891369;1094.141099237095;1095.5727266366123;1101.4602844606245;1110.2838669058413;1118.8825173356681;1131.5077941095649;1136.0740996088161;1346.3335648853683;1430.2634143416149;7296.379807716297;7346.926530734624;7369.299916507923;7371.963140184264;7398.3341499265325;1127.1321082766387;1129.8135807591655;1142.2289954280827;1143.7426579019655;1154.543955137716;5845.503132233723;5905.911411328833;5956.851078723066;5958.910616340759;5962.582619216613;8764.123587641185;8919.910800891908;8947.19475247231;8947.32895032875;9008.41445306066;8900.599473023729;8930.86603700945;9038.231750301167;9066.682666106655;9081.182693557612;7269.236730143364;7323.231060738653;7439.367653749492;7455.478116531791;7466.813329666693;7421.146568144733;7452.850942981218;7483.812904677427;7486.850262994819;7492.887606685795;8080.515169089874;8268.503889766633;8320.958395208227;8321.95839020801;8457.238848503664;8438.873416898874;8583.442076265272;8586.441881277697;8593.31253499731;8603.354748393771;6780.898286525608;7002.089728335284;7050.753223637148;7060.188078371053;7066.904629782392;6554.377334153248;6618.768343107968;7565.886511702439;7595.278448547379;7597.3162415382885;6908.896366554405;7081.929180708333;7119.6084215368655;7129.39400150993;7208.855822883408;6850.109485766819;7044.330788575077;7062.081929349357;7150.713971441084;7161.641917904188;7120.679569419285;7148.320909513588;7157.64211789398;7159.319864612853;7169.032180655545;6276.497880169667;6499;6499.38255865692;6550.213974323112;6572.671366431755;6628.900566491603;6675.03212034262;6677.131972843499;6680.198376194888;6681 23:31:44 INFO - 2016-01-22 23:31:44,131 DEBUG : BROWSER_OUTPUT: |4;prototype.html;325.1708144232208;327.19836400818;328.7928604978863;329.35775238285333;332.92009917619765;6003.429674180946;6094.908576371353;6104.6947652617355;6109.908351374733;6161.876762464748;5956.1065840124;6051.2133422655;6068.57519973602;6091.939080609192;6098.57309988301;4631.073785242948;4633.513481084488;4635.675502714811;4636.281376386649;4637.350770892078;4471.597556219939;4569.360289559448;4577.725336479805;4588.623412976111;4638.489766125724;4492.97753511232;4590.586847183753;4624.676272660915;4633.4208223972;4646.303054541812;4605.355250264965;4617.953820461786;4621.607163391082;4634.698744581625;4640.211164102094;4008.4588580541545;4022.1352409232154;4022.3363145081025;4038.374052021941;4040.5151381834366;5686.800961966312;5773.682447465388;5784.363719990798;5800;5809.796657116981;5343.438938911398;5355.812546560891;5357.517823395874;5359.678419294854;5362.91955620666;6199.070139479114;6425.582337148117;6432.581882177644;6433.356664333576;6451.451626611743;4335.263005289108;4336.1978034063795;4421.358902959085;4421.9336709949375;4435.334699795057;6694.531382803206;6694.631795251308;6698.296678848748;6707.195136583592;6707.832304192385;4502.594766471033;4518.751468669189;4522.276435770261;4528.071745292207;4529.320601909674;4526.411566496335;4564.748938808398;4573.359729637853;4623.653226008063;4646.6747327686735;5341.172118321666;5388.084025715638;5390.380106287827;5395.2986111806;5401.567874570103;6571.835704107436;6575.276719560845;6575.868482630321;6580.407763301326;6592.241892182365;1609.1712767924528;1635.7791698120602;1636.2963925511906;1637.3123288218976;1637.8780535333096;1059.957601695939;1077.8167711489066;1087.1194332590626;1088.3034857691084;1127.0138628699888;6196.3803619638575;6196.721147548281;6220.315765265817;6295.150154729145;6296.685165741695;6750.459963202932;6758.324167583301;6765.458763298924;6768.763093291711;6772.492063095287;6222.191115155001;6279.7488100476385;6282.937170628326;6283.717232724538;6286.119943207955;3665.7983810890655;3702.740808143404;3704.277665855186;3706.6664000240107;3707.647773461517;7052.0479735235085;7057.576545407292;7057.7176912922905;7058.823529411703;7061.046758687614;6894.689738961759;6961.860762784817;6962.443004559623;7005;7016.122984626922;7023.508354415244;7028;7036.120484939383;7040.190378106583;7041.295870412918;6596.637184954873;6685.364890335411;6739.224989126314;6824.215215250111;6846.383825455733;6698.899516507354;6708.228553716385;6739.730410783513;6750.594964302158;6752.189737231563;6973.058637083929;7015.929840701528;7022.789316320519;7037.7184912602925;7041.049458323061;4376.474823021258;4398.890027749332;4417.072414792801;4489.932651010172;4496.887577810581;6773.525853190229;6774.085498457645;6777.830554236183;6778.694958726771;6782.948642960349;6600.273969863407;6608.900866487103;6614.8346291343105;6617.503687223574;6621.768238111643;6505.967470162619;6542.934570654423;6584.176977877765;6585.045168450643;6586.80239592813;6470.320616335217;6472.061551075162;6473.126127972663;6475.676216189266;6476.5466417350335;6580.8354791130605;6588.110605068255;6605.768798092044;6608.570442921195;6609.537332386687;6370.1718776558755;6460.3862633049785;6489.415952564292;6507.511936604868;6513 23:31:44 INFO - 2016-01-22 23:31:44,131 DEBUG : BROWSER_OUTPUT: |5;yui.html;803.7789607857842;845.6701886264356;859.9871001934971;875.3128793896792;930.6789157740577;13893.444262229512;13905.860941390583;14128.505502307422;14942.701145977075;15033.473828416008;13025.413856376463;13049.80425293619;13092.934535327335;13112.147710398818;13121;769.1116760142031;780.785284046886;918.673870775875;935.3873213045432;936.6862101196108;908.736466424736;909.6225066597387;915.2220612479373;916.1891725822628;916.9541522923861;799.312591171592;804.5012092502657;979.1774909076374;986.4426598971594;989.7327721515187;952.7046615549202;962.1340793286029;963.4604621412032;964.0118878149917;964.1804466203741;710.2258538193342;710.5630037526936;710.8471678589128;711.1395211793736;711.1466240511407;13932.303384830719;14004.92997535016;14010.719785604333;14017.43930242789;14023.368948397347;12139;12152.392380381034;12289.385530723428;12540.498380064786;12598.118131730782;10661.520231589597;10689.412082335468;10775.730606734816;10875.782484350348;10878.673639790819;3763.153290509641;3834.559025712051;3836.1368692044066;3839.5968423315708;3850.403187505941;45155.548444515465;45348.31977520307;46513.76743116297;47341.28988065182;47455.76272118652;9990.950045249727;10047.296689231684;10205.62224099737;10729.356238625707;10737.087347575387;18745.0627468626;18762.906185468986;18769.624607508045;18804.341848035252;18832.905835470734;7416.25837416254;7492.1384040836;7631.1605723370385;7723.420743444264;7813.101493328227;4529.705569137996;4544.295634176708;4564.817407303671;4661.748704792498;4672.859814205579;3111.191090316534;3154.9842250788597;3156.2740569669104;3157.636871759731;3157.684231576824;598.2970010237952;612.4059662127729;615.2186722861941;618.13769791142;633.4963703855447;554.6450271826035;588.7350692188533;683.9281875403011;727.581640556682;730.0545793197822;9174.495402752913;9202.539873006323;9259.53702314895;9300.209482193954;9425.717228483156;594.5392320951297;623.982907860185;754.6113751418025;755.4560716284267;760.7945854619222;4149.019101575493;4269.893252668709;4293.0769884474985;4347.608715215646;4388.385626012361;59322.40677593255;59675.40324596786;60183.69908150431;60275;60543;50171.74914125406;52566.21150682743;52984.470155298724;53113.46886531085;53397.46602534003;46643.53356466392;47045.76477117593;47724.761376192895;47954.520454795005;48539.5146048535;9319.813603728024;9425.528723563657;9498;9522.714318570454;9579.664711735057;34956;36073.45889811603;36376.454353185254;36843.81578092092;37409;43306.56693433025;43310.13379732451;45155.77422112868;46944;47669.28496072492;9620.567074481805;11454.541818327174;11656.18406711522;12075.215111017756;12608.936955315532;13400.463981440633;13488.009436508555;13491.460341586619;13512.864871351161;13535.120217185851;11763.529458821551;12024.519019239133;12242.510299587917;12326.75346493083;12933.676658083623;11489.195756296978;11502.309861408343;12076.698082548006;12580.496780128693;13285.867141328463;10021.368665456388;11249.71875703114;12202.32887191213;12384.380780960735;12951.093423460266;10080.747981300527;10300.124489418484;11101;11102.000819926245;11102.722431939266;10193.949030254802;10579.418132002813;10832.566697332019;10841.295315804447;10995.505202265756 23:31:44 INFO - 2016-01-22 23:31:44,132 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:31:44 INFO - 2016-01-22 23:31:44,132 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:31:44 INFO - 2016-01-22 23:31:44,132 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1036 23:31:44 INFO - 2016-01-22 23:31:44,133 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:31:44 INFO - 2016-01-22 23:31:44,133 DEBUG : BROWSER_OUTPUT: __startTimestamp1453534304126__endTimestamp 23:31:44 INFO - 2016-01-22 23:31:44,133 DEBUG : BROWSER_OUTPUT: 23:31:44 INFO - 2016-01-22 23:31:44,133 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:31:44 INFO - 2016-01-22 23:31:44,133 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:31:44 INFO - 2016-01-22 23:31:44,133 DEBUG : BROWSER_OUTPUT: 23:31:44 INFO - 2016-01-22 23:31:44,133 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5566.74 Median:5816.56 stddev:614.93 (10.6%) stddev-sans-first:591.29 23:31:44 INFO - 2016-01-22 23:31:44,133 DEBUG : BROWSER_OUTPUT: Values: 3331.7 3383.3 3394.4 3418.5 3425.1 5574.3 5596.2 5626.2 5627.2 5628.5 5626.6 5634.7 5639.2 5643.2 5661.9 4863.8 5083.9 5117.6 5172.4 5218.0 5092.6 5109.5 5109.5 5110.5 5112.4 5033.6 5062.9 5066.9 5077.4 5079.0 5053.6 5123.8 5170.5 5171.6 5192.6 5031.9 5118.5 5138.4 5150.9 5175.0 5106.1 5193.3 5412.7 5428.9 5488.2 5940.0 6029.1 6035.3 6056.0 6059.8 6088.6 6096.8 6118.5 6127.1 6129.5 5390.9 5492.3 5656.1 5680.1 5692.2 6012.0 6053.8 6054.2 6060.1 6073.1 5944.6 5967.8 5969.9 5973.5 5976.5 5728.7 5846.4 5889.4 6064.3 6067.0 5932.3 5935.2 5935.4 5935.8 6019.9 5879.5 5935.1 5935.6 5936.6 5940.9 4441.4 4516.5 4574.5 4581.3 4592.2 4120.2 4134.6 4134.7 4140.3 4164.0 5639.2 5641.1 5652.5 5654.0 5682.7 5749.3 5863.3 6040.0 6113.7 6122.5 5629.2 5636.4 5636.5 5646.6 5648.4 4993.8 5211.4 5216.8 5217.6 5221.8 6066.2 6094.2 6211.0 6212.5 6214.7 6039.2 6071.2 6079.3 6083.7 6116.3 5980.4 6044.8 6176.4 6222.5 6222.6 5857.0 5916.3 5922.0 5922.4 5958.2 5950.1 5995.8 6000.7 6002.2 6055.4 5718.2 5816.6 5852.9 5858.7 5862.1 5937.7 5940.1 5945.0 5948.5 5960.9 5850.1 5852.1 5853.8 5858.2 5859.6 5679.5 5786.8 5850.9 5862.3 5950.8 5806.3 5813.9 5820.9 5827.8 5829.8 23:31:44 INFO - 2016-01-22 23:31:44,133 DEBUG : BROWSER_OUTPUT: 23:31:44 INFO - 2016-01-22 23:31:44,133 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52236.57 Median:35103.06 stddev:88613.03 (252.4%) stddev-sans-first:88776.69 23:31:44 INFO - 2016-01-22 23:31:44,133 DEBUG : BROWSER_OUTPUT: Values: 566.3 611.6 613.3 615.3 623.1 34433.3 42503.6 43072.1 43146.4 43201.1 46859.0 47485.3 47548.0 47550.0 47628.3 8034.7 8127.4 9194.3 9399.2 10477.5 10641.1 10698.7 10732.5 10779.9 10788.6 10798.9 10881.6 10929.6 10935.3 10939.7 8436.6 8653.2 11086.6 11354.1 11366.4 10752.1 10887.4 10891.8 10895.1 10899.0 41414.0 41920.0 41945.6 41957.0 41996.8 3445.3 3461.9 3473.5 3987.1 4277.2 32468.8 32554.8 32623.5 32941.8 33079.2 3569.6 3599.8 3629.4 3638.9 3662.6 275141.0 276184.0 277369.0 277465.0 277825.0 60332.4 61733.4 61902.7 67599.0 68311.0 81310.0 82368.6 82859.0 82892.2 83043.6 17094.6 17282.3 17297.0 17317.0 17321.7 12922.4 12946.5 12978.3 13051.1 13056.3 21923.9 22433.9 22442.4 22467.6 22496.6 8358.8 8474.0 8488.5 8576.5 8606.1 919.9 996.4 998.0 1051.3 1166.3 28044.4 28146.7 28363.0 28472.7 28852.6 1064.8 1101.9 1122.3 1203.1 1231.8 14675.9 15001.5 15352.0 17076.4 18181.9 403882.0 409102.0 410104.0 410166.0 410732.0 59944.7 60381.4 60410.0 60417.4 60602.4 1278.6 1359.2 1359.5 1426.8 1453.4 30372.4 30572.0 30728.2 31458.2 31919.4 47085.0 47798.5 47886.5 48336.0 49066.8 311251.0 312089.0 313705.0 314618.0 314742.0 34375.3 34401.8 34505.7 35086.6 35119.5 46078.8 46229.0 46775.5 47084.3 47326.1 38791.2 39687.8 39737.6 39918.0 40602.4 37534.0 38824.2 39154.6 44811.6 45280.8 38649.8 39049.6 39161.0 39262.8 39603.0 34418.0 34666.5 35386.3 35510.8 35680.3 26676.0 27172.5 27251.5 27272.5 27670.4 23:31:44 INFO - 2016-01-22 23:31:44,133 DEBUG : BROWSER_OUTPUT: 23:31:44 INFO - 2016-01-22 23:31:44,133 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31274.02 Median:363.27 stddev:100474.67 (27658.2%) stddev-sans-first:100729.71 23:31:44 INFO - 2016-01-22 23:31:44,134 DEBUG : BROWSER_OUTPUT: Values: 358.7 361.5 361.7 364.8 368.3 15280.6 15638.0 17203.8 17589.6 18212.7 18459.6 18540.5 18792.9 18812.0 18899.4 5466.0 5589.9 5605.7 5606.7 5606.8 4149.8 4256.7 5555.3 6074.9 6278.5 6093.0 6165.6 6186.0 6231.8 6235.3 6058.2 6092.7 6108.3 6110.1 6110.1 5309.9 5339.4 5361.1 5361.9 5376.5 22104.9 22142.3 22325.6 22447.2 22509.9 2175.9 2186.6 2290.6 2311.1 2331.5 14013.8 14124.9 14136.8 14262.2 14356.1 1929.8 1977.2 1990.6 2008.6 2015.3 63728.0 64376.0 64810.0 66145.0 66407.7 9916.2 10024.1 10105.4 10132.5 10205.0 13118.0 13220.3 13245.9 13247.5 13254.5 7841.0 7914.4 7938.1 7943.1 7991.3 7913.3 7923.6 7929.4 7967.6 7968.2 6193.1 6248.8 6261.3 6271.1 6287.2 1614.1 1700.3 1738.0 1792.4 1805.2 404.9 845.6 925.6 966.3 1014.9 10016.4 10354.7 10711.5 10942.9 10962.9 432.6 438.9 443.1 443.3 446.7 6098.5 6257.2 6358.1 6386.7 6396.1 436241.0 636335.0 643144.0 657501.0 668646.0 82544.6 83781.0 85110.0 85841.0 87838.6 1197.4 1199.0 1202.4 1210.5 1224.3 16004.3 16125.8 16135.1 16346.7 16517.1 36035.6 36481.3 36890.3 37787.0 37819.2 49216.3 49306.8 49344.0 49689.5 50962.7 9393.8 9535.2 9802.6 9808.4 9841.0 11414.8 11544.2 16972.3 17842.8 17926.5 14955.3 15077.0 15077.5 15397.0 15422.8 14850.3 15051.5 15170.8 15603.4 16013.4 12301.1 12904.5 14613.9 14777.6 16336.8 9563.0 9763.0 10023.2 10236.9 10248.7 7689.0 13896.2 15031.1 15053.3 15266.2 23:31:44 INFO - 2016-01-22 23:31:44,134 DEBUG : BROWSER_OUTPUT: 23:31:44 INFO - 2016-01-22 23:31:44,135 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5427.64 Median:6499.19 stddev:2803.23 (43.1%) stddev-sans-first:2795.81 23:31:44 INFO - 2016-01-22 23:31:44,135 DEBUG : BROWSER_OUTPUT: Values: 1532.3 1582.8 1668.0 1778.9 1891.7 6714.6 7387.6 7726.9 7729.4 7741.0 7559.8 7707.5 7708.3 7711.8 7712.2 1934.6 1982.9 1985.7 2221.7 2264.0 2012.8 2228.0 2267.6 2271.4 2272.5 2197.9 2219.5 2231.0 2257.8 2261.9 2217.3 2271.3 2286.6 2294.6 2295.2 2243.4 2260.3 2262.0 2263.2 2264.3 7698.2 7765.1 7768.2 7770.3 7789.9 4516.9 4558.9 4581.9 4585.1 4585.4 3021.4 3023.7 3052.2 3062.8 3118.6 987.2 1007.2 1013.4 1016.8 1018.4 10576.8 10578.2 10578.9 10586.5 10593.9 3968.9 3975.9 4031.8 4033.2 4054.5 9108.4 9138.6 9141.6 9147.9 9187.8 4623.8 4635.2 4649.4 4649.8 4672.3 4235.2 4255.4 4258.6 4279.7 4285.5 3194.9 3285.7 3571.9 3649.2 3652.2 1080.9 1094.1 1095.6 1101.5 1110.3 1118.9 1131.5 1136.1 1346.3 1430.3 7296.4 7346.9 7369.3 7372.0 7398.3 1127.1 1129.8 1142.2 1143.7 1154.5 5845.5 5905.9 5956.9 5958.9 5962.6 8764.1 8919.9 8947.2 8947.3 9008.4 8900.6 8930.9 9038.2 9066.7 9081.2 7269.2 7323.2 7439.4 7455.5 7466.8 7421.1 7452.9 7483.8 7486.9 7492.9 8080.5 8268.5 8321.0 8322.0 8457.2 8438.9 8583.4 8586.4 8593.3 8603.4 6780.9 7002.1 7050.8 7060.2 7066.9 6554.4 6618.8 7565.9 7595.3 7597.3 6908.9 7081.9 7119.6 7129.4 7208.9 6850.1 7044.3 7062.1 7150.7 7161.6 7120.7 7148.3 7157.6 7159.3 7169.0 6276.5 6499.0 6499.4 6550.2 6572.7 6628.9 6675.0 6677.1 6680.2 6681.0 23:31:44 INFO - 2016-01-22 23:31:44,135 DEBUG : BROWSER_OUTPUT: 23:31:44 INFO - 2016-01-22 23:31:44,135 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5438.02 Median:6196.55 stddev:1672.44 (27.0%) stddev-sans-first:1632.51 23:31:44 INFO - 2016-01-22 23:31:44,135 DEBUG : BROWSER_OUTPUT: Values: 325.2 327.2 328.8 329.4 332.9 6003.4 6094.9 6104.7 6109.9 6161.9 5956.1 6051.2 6068.6 6091.9 6098.6 4631.1 4633.5 4635.7 4636.3 4637.4 4471.6 4569.4 4577.7 4588.6 4638.5 4493.0 4590.6 4624.7 4633.4 4646.3 4605.4 4618.0 4621.6 4634.7 4640.2 4008.5 4022.1 4022.3 4038.4 4040.5 5686.8 5773.7 5784.4 5800.0 5809.8 5343.4 5355.8 5357.5 5359.7 5362.9 6199.1 6425.6 6432.6 6433.4 6451.5 4335.3 4336.2 4421.4 4421.9 4435.3 6694.5 6694.6 6698.3 6707.2 6707.8 4502.6 4518.8 4522.3 4528.1 4529.3 4526.4 4564.7 4573.4 4623.7 4646.7 5341.2 5388.1 5390.4 5395.3 5401.6 6571.8 6575.3 6575.9 6580.4 6592.2 1609.2 1635.8 1636.3 1637.3 1637.9 1060.0 1077.8 1087.1 1088.3 1127.0 6196.4 6196.7 6220.3 6295.2 6296.7 6750.5 6758.3 6765.5 6768.8 6772.5 6222.2 6279.7 6282.9 6283.7 6286.1 3665.8 3702.7 3704.3 3706.7 3707.6 7052.0 7057.6 7057.7 7058.8 7061.0 6894.7 6961.9 6962.4 7005.0 7016.1 7023.5 7028.0 7036.1 7040.2 7041.3 6596.6 6685.4 6739.2 6824.2 6846.4 6698.9 6708.2 6739.7 6750.6 6752.2 6973.1 7015.9 7022.8 7037.7 7041.0 4376.5 4398.9 4417.1 4489.9 4496.9 6773.5 6774.1 6777.8 6778.7 6782.9 6600.3 6608.9 6614.8 6617.5 6621.8 6506.0 6542.9 6584.2 6585.0 6586.8 6470.3 6472.1 6473.1 6475.7 6476.5 6580.8 6588.1 6605.8 6608.6 6609.5 6370.2 6460.4 6489.4 6507.5 6513.0 23:31:44 INFO - 2016-01-22 23:31:44,135 DEBUG : BROWSER_OUTPUT: 23:31:44 INFO - 2016-01-22 23:31:44,135 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14269.94 Median:45155.66 stddev:16203.89 (35.9%) stddev-sans-first:16217.79 23:31:44 INFO - 2016-01-22 23:31:44,137 DEBUG : BROWSER_OUTPUT: Values: 803.8 845.7 860.0 875.3 930.7 13893.4 13905.9 14128.5 14942.7 15033.5 13025.4 13049.8 13092.9 13112.1 13121.0 769.1 780.8 918.7 935.4 936.7 908.7 909.6 915.2 916.2 917.0 799.3 804.5 979.2 986.4 989.7 952.7 962.1 963.5 964.0 964.2 710.2 710.6 710.8 711.1 711.1 13932.3 14004.9 14010.7 14017.4 14023.4 12139.0 12152.4 12289.4 12540.5 12598.1 10661.5 10689.4 10775.7 10875.8 10878.7 3763.2 3834.6 3836.1 3839.6 3850.4 45155.5 45348.3 46513.8 47341.3 47455.8 9991.0 10047.3 10205.6 10729.4 10737.1 18745.1 18762.9 18769.6 18804.3 18832.9 7416.3 7492.1 7631.2 7723.4 7813.1 4529.7 4544.3 4564.8 4661.7 4672.9 3111.2 3155.0 3156.3 3157.6 3157.7 598.3 612.4 615.2 618.1 633.5 554.6 588.7 683.9 727.6 730.1 9174.5 9202.5 9259.5 9300.2 9425.7 594.5 624.0 754.6 755.5 760.8 4149.0 4269.9 4293.1 4347.6 4388.4 59322.4 59675.4 60183.7 60275.0 60543.0 50171.7 52566.2 52984.5 53113.5 53397.5 46643.5 47045.8 47724.8 47954.5 48539.5 9319.8 9425.5 9498.0 9522.7 9579.7 34956.0 36073.5 36376.5 36843.8 37409.0 43306.6 43310.1 45155.8 46944.0 47669.3 9620.6 11454.5 11656.2 12075.2 12608.9 13400.5 13488.0 13491.5 13512.9 13535.1 11763.5 12024.5 12242.5 12326.8 12933.7 11489.2 11502.3 12076.7 12580.5 13285.9 10021.4 11249.7 12202.3 12384.4 12951.1 10080.7 10300.1 11101.0 11102.0 11102.7 10193.9 10579.4 10832.6 10841.3 10995.5 23:31:44 INFO - 2016-01-22 23:31:44,137 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:31:44 INFO - 2016-01-22 23:31:44,137 DEBUG : BROWSER_OUTPUT: 23:31:44 INFO - 2016-01-22 23:31:44,829 INFO : Browser exited with error code: 0 23:31:44 INFO - 2016-01-22 23:31:44,850 INFO : Completed test dromaeo_css (00:18:32) 23:31:44 INFO - 2016-01-22 23:31:44,851 INFO : Starting test kraken 23:31:44 INFO - 2016-01-22 23:31:44,851 DEBUG : operating with platform_type : linux_ 23:31:44 INFO - 2016-01-22 23:31:44,851 INFO : Initialising browser for kraken test... 23:31:44 INFO - 2016-01-22 23:31:44,857 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp47L4e5/profile http://localhost:45871/getInfo.html 23:31:49 INFO - 2016-01-22 23:31:49,326 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:31:49 INFO - 2016-01-22 23:31:49,326 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:31:49 INFO - 2016-01-22 23:31:49,326 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:31:49 INFO - 2016-01-22 23:31:49,326 DEBUG : BROWSER_OUTPUT: __metrics 23:31:49 INFO - 2016-01-22 23:31:49,495 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:31:50 INFO - 2016-01-22 23:31:50,377 INFO : Browser initialized. 23:31:50 INFO - 2016-01-22 23:31:50,378 INFO : Running cycle 1/1 for kraken test... 23:31:50 INFO - 2016-01-22 23:31:50,378 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp47L4e5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:32:02 INFO - 2016-01-22 23:32:02,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 137170944 23:32:02 INFO - 2016-01-22 23:32:02,198 DEBUG : BROWSER_OUTPUT: 23:32:04 INFO - 2016-01-22 23:32:04,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45871/tests/kraken/driver.html?testName=audio-beat-detection) 23:32:05 INFO - 2016-01-22 23:32:05,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 169689088 23:32:05 INFO - 2016-01-22 23:32:05,206 DEBUG : BROWSER_OUTPUT: 23:32:07 INFO - 2016-01-22 23:32:07,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45871/tests/kraken/driver.html?testName=audio-dft) 23:32:08 INFO - 2016-01-22 23:32:08,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 168394752 23:32:08 INFO - 2016-01-22 23:32:08,303 DEBUG : BROWSER_OUTPUT: 23:32:11 INFO - 2016-01-22 23:32:11,062 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45871/tests/kraken/driver.html?testName=audio-fft) 23:32:11 INFO - 2016-01-22 23:32:11,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 165580800 23:32:11 INFO - 2016-01-22 23:32:11,622 DEBUG : BROWSER_OUTPUT: 23:32:13 INFO - 2016-01-22 23:32:13,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45871/tests/kraken/driver.html?testName=audio-oscillator) 23:32:14 INFO - 2016-01-22 23:32:14,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 166711296 23:32:14 INFO - 2016-01-22 23:32:14,162 DEBUG : BROWSER_OUTPUT: 23:32:16 INFO - 2016-01-22 23:32:16,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45871/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:32:16 INFO - 2016-01-22 23:32:16,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 164429824 23:32:16 INFO - 2016-01-22 23:32:16,905 DEBUG : BROWSER_OUTPUT: 23:32:19 INFO - 2016-01-22 23:32:19,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45871/tests/kraken/driver.html?testName=imaging-darkroom) 23:32:20 INFO - 2016-01-22 23:32:20,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 163479552 23:32:20 INFO - 2016-01-22 23:32:20,326 DEBUG : BROWSER_OUTPUT: 23:32:23 INFO - 2016-01-22 23:32:23,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45871/tests/kraken/driver.html?testName=imaging-desaturate) 23:32:24 INFO - 2016-01-22 23:32:24,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 166670336 23:32:24 INFO - 2016-01-22 23:32:24,216 DEBUG : BROWSER_OUTPUT: 23:32:26 INFO - 2016-01-22 23:32:26,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45871/tests/kraken/driver.html?testName=json-parse-financial) 23:32:27 INFO - 2016-01-22 23:32:27,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 163934208 23:32:27 INFO - 2016-01-22 23:32:27,522 DEBUG : BROWSER_OUTPUT: 23:32:29 INFO - 2016-01-22 23:32:29,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45871/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:32:29 INFO - 2016-01-22 23:32:29,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 171679744 23:32:29 INFO - 2016-01-22 23:32:29,602 DEBUG : BROWSER_OUTPUT: 23:32:31 INFO - 2016-01-22 23:32:31,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45871/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:32:31 INFO - 2016-01-22 23:32:31,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 168554496 23:32:31 INFO - 2016-01-22 23:32:31,940 DEBUG : BROWSER_OUTPUT: 23:32:33 INFO - 2016-01-22 23:32:33,937 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45871/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:32:34 INFO - 2016-01-22 23:32:34,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 178278400 23:32:34 INFO - 2016-01-22 23:32:34,511 DEBUG : BROWSER_OUTPUT: 23:32:36 INFO - 2016-01-22 23:32:36,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:32:37 INFO - 2016-01-22 23:32:37,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 183664640 23:32:37 INFO - 2016-01-22 23:32:37,441 DEBUG : BROWSER_OUTPUT: 23:32:39 INFO - 2016-01-22 23:32:39,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:32:40 INFO - 2016-01-22 23:32:40,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 182272000 23:32:40 INFO - 2016-01-22 23:32:40,518 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,147 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45871/tests/kraken/driver.html?testName=ai-astar) 23:32:42 INFO - 2016-01-22 23:32:42,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 240803840 23:32:42 INFO - 2016-01-22 23:32:42,397 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,401 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:32:42 INFO - 2016-01-22 23:32:42,401 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:32:42 INFO - 2016-01-22 23:32:42,401 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:32:42 INFO - 2016-01-22 23:32:42,401 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:32:42 INFO - 2016-01-22 23:32:42,401 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;108;102;108;110;110;98;107;107;110 23:32:42 INFO - 2016-01-22 23:32:42,402 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;120;145;153;123;144;150;122;162;120 23:32:42 INFO - 2016-01-22 23:32:42,402 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;160;160;159;159;159;160;160;160;161 23:32:42 INFO - 2016-01-22 23:32:42,402 DEBUG : BROWSER_OUTPUT: |3;audio-fft;79;70;71;150;72;72;71;72;149;70 23:32:42 INFO - 2016-01-22 23:32:42,402 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;132;92;92;92;138;91;92;136 23:32:42 INFO - 2016-01-22 23:32:42,402 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;109;109;110;109;109;109;109 23:32:42 INFO - 2016-01-22 23:32:42,402 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;146;146;145;146;145;146;145;145 23:32:42 INFO - 2016-01-22 23:32:42,402 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;96;96;96;95;95;95 23:32:42 INFO - 2016-01-22 23:32:42,402 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;54;56;55;57;56;57;54;52;55 23:32:42 INFO - 2016-01-22 23:32:42,403 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;64;64;64;64;64;65;64;64;64 23:32:42 INFO - 2016-01-22 23:32:42,403 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;79;80;81;80;81;80;80;80;81 23:32:42 INFO - 2016-01-22 23:32:42,403 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;118;118;110;112;113;116;118;118;122 23:32:42 INFO - 2016-01-22 23:32:42,403 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;143;142;142;142;137;148;143;141;140 23:32:42 INFO - 2016-01-22 23:32:42,403 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;63;64;64;63;64;65;63;63;63 23:32:42 INFO - 2016-01-22 23:32:42,403 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:32:42 INFO - 2016-01-22 23:32:42,403 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:32:42 INFO - 2016-01-22 23:32:42,404 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,917 23:32:42 INFO - 2016-01-22 23:32:42,404 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:32:42 INFO - 2016-01-22 23:32:42,404 DEBUG : BROWSER_OUTPUT: __startTimestamp1453534362399__endTimestamp 23:32:42 INFO - 2016-01-22 23:32:42,404 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,407 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:32:42 INFO - 2016-01-22 23:32:42,408 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:32:42 INFO - 2016-01-22 23:32:42,408 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,408 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.80 Median:109.00 stddev:3.88 (3.6%) stddev-sans-first:4.09 23:32:42 INFO - 2016-01-22 23:32:42,408 DEBUG : BROWSER_OUTPUT: Values: 108.0 108.0 102.0 108.0 110.0 110.0 98.0 107.0 107.0 110.0 23:32:42 INFO - 2016-01-22 23:32:42,409 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,409 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.20 Median:147.50 stddev:16.23 (11.0%) stddev-sans-first:16.42 23:32:42 INFO - 2016-01-22 23:32:42,409 DEBUG : BROWSER_OUTPUT: Values: 153.0 120.0 145.0 153.0 123.0 144.0 150.0 122.0 162.0 120.0 23:32:42 INFO - 2016-01-22 23:32:42,409 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,409 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 23:32:42 INFO - 2016-01-22 23:32:42,410 DEBUG : BROWSER_OUTPUT: Values: 159.0 160.0 160.0 159.0 159.0 159.0 160.0 160.0 160.0 161.0 23:32:42 INFO - 2016-01-22 23:32:42,410 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,410 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.60 Median:71.50 stddev:32.73 (45.8%) stddev-sans-first:34.56 23:32:42 INFO - 2016-01-22 23:32:42,410 DEBUG : BROWSER_OUTPUT: Values: 79.0 70.0 71.0 150.0 72.0 72.0 71.0 72.0 149.0 70.0 23:32:42 INFO - 2016-01-22 23:32:42,410 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,410 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.00 Median:92.00 stddev:20.99 (22.8%) stddev-sans-first:21.73 23:32:42 INFO - 2016-01-22 23:32:42,410 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 132.0 92.0 92.0 92.0 138.0 91.0 92.0 136.0 23:32:42 INFO - 2016-01-22 23:32:42,410 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,411 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 23:32:42 INFO - 2016-01-22 23:32:42,411 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 23:32:42 INFO - 2016-01-22 23:32:42,411 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,411 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:32:42 INFO - 2016-01-22 23:32:42,411 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 23:32:42 INFO - 2016-01-22 23:32:42,411 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,411 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:32:42 INFO - 2016-01-22 23:32:42,411 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 23:32:42 INFO - 2016-01-22 23:32:42,411 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,411 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:1.64 (2.9%) stddev-sans-first:1.62 23:32:42 INFO - 2016-01-22 23:32:42,412 DEBUG : BROWSER_OUTPUT: Values: 57.0 54.0 56.0 55.0 57.0 56.0 57.0 54.0 52.0 55.0 23:32:42 INFO - 2016-01-22 23:32:42,412 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,412 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 23:32:42 INFO - 2016-01-22 23:32:42,412 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 64.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 23:32:42 INFO - 2016-01-22 23:32:42,412 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,412 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.50 stddev:0.67 (0.8%) stddev-sans-first:0.67 23:32:42 INFO - 2016-01-22 23:32:42,412 DEBUG : BROWSER_OUTPUT: Values: 81.0 79.0 80.0 81.0 80.0 81.0 80.0 80.0 80.0 81.0 23:32:42 INFO - 2016-01-22 23:32:42,412 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,412 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.40 Median:118.00 stddev:3.66 (3.1%) stddev-sans-first:3.76 23:32:42 INFO - 2016-01-22 23:32:42,412 DEBUG : BROWSER_OUTPUT: Values: 119.0 118.0 118.0 110.0 112.0 113.0 116.0 118.0 118.0 122.0 23:32:42 INFO - 2016-01-22 23:32:42,412 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,413 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.40 Median:142.50 stddev:3.03 (2.1%) stddev-sans-first:2.92 23:32:42 INFO - 2016-01-22 23:32:42,413 DEBUG : BROWSER_OUTPUT: Values: 146.0 143.0 142.0 142.0 142.0 137.0 148.0 143.0 141.0 140.0 23:32:42 INFO - 2016-01-22 23:32:42,413 DEBUG : BROWSER_OUTPUT: 23:32:42 INFO - 2016-01-22 23:32:42,413 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.03 (1.6%) stddev-sans-first:0.73 23:32:42 INFO - 2016-01-22 23:32:42,413 DEBUG : BROWSER_OUTPUT: Values: 66.0 63.0 64.0 64.0 63.0 64.0 65.0 63.0 63.0 63.0 23:32:42 INFO - 2016-01-22 23:32:42,413 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:32:42 INFO - 2016-01-22 23:32:42,413 DEBUG : BROWSER_OUTPUT: 23:32:43 INFO - 2016-01-22 23:32:43,214 INFO : Browser exited with error code: 0 23:32:43 INFO - 2016-01-22 23:32:43,264 INFO : Completed test kraken (00:00:58) 23:32:43 INFO - 2016-01-22 23:32:43,264 INFO : Starting test v8_7 23:32:43 INFO - 2016-01-22 23:32:43,264 DEBUG : operating with platform_type : linux_ 23:32:43 INFO - 2016-01-22 23:32:43,264 INFO : Initialising browser for v8_7 test... 23:32:43 INFO - 2016-01-22 23:32:43,270 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp41zden/profile http://localhost:45871/getInfo.html 23:32:47 INFO - 2016-01-22 23:32:47,555 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:32:47 INFO - 2016-01-22 23:32:47,555 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:32:47 INFO - 2016-01-22 23:32:47,555 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:32:47 INFO - 2016-01-22 23:32:47,556 DEBUG : BROWSER_OUTPUT: __metrics 23:32:47 INFO - 2016-01-22 23:32:47,737 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:32:48 INFO - 2016-01-22 23:32:48,991 INFO : Browser initialized. 23:32:48 INFO - 2016-01-22 23:32:48,991 INFO : Running cycle 1/1 for v8_7 test... 23:32:48 INFO - 2016-01-22 23:32:48,991 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp41zden/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:33:00 INFO - 2016-01-22 23:33:00,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 137076736 23:33:00 INFO - 2016-01-22 23:33:00,646 DEBUG : BROWSER_OUTPUT: 23:33:21 INFO - 2016-01-22 23:33:21,998 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45871/tests/v8_7/run.html (next: http://localhost:45871/tests/v8_7/run.html) 23:33:22 INFO - 2016-01-22 23:33:22,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 425508864 23:33:22 INFO - 2016-01-22 23:33:22,249 DEBUG : BROWSER_OUTPUT: 23:33:22 INFO - 2016-01-22 23:33:22,249 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:33:22 INFO - 2016-01-22 23:33:22,249 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:33:22 INFO - 2016-01-22 23:33:22,249 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:33:22 INFO - 2016-01-22 23:33:22,249 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:33:22 INFO - 2016-01-22 23:33:22,249 DEBUG : BROWSER_OUTPUT: |0;Richards;165.0709805216243 23:33:22 INFO - 2016-01-22 23:33:22,249 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.37031900138697 23:33:22 INFO - 2016-01-22 23:33:22,250 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.473962684489 23:33:22 INFO - 2016-01-22 23:33:22,250 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5117.34693877551 23:33:22 INFO - 2016-01-22 23:33:22,250 DEBUG : BROWSER_OUTPUT: |4;RayTrace;958.7727708533077 23:33:22 INFO - 2016-01-22 23:33:22,250 DEBUG : BROWSER_OUTPUT: |5;Earley;556.7928730512249 23:33:22 INFO - 2016-01-22 23:33:22,250 DEBUG : BROWSER_OUTPUT: |6;Boyer;11000 23:33:22 INFO - 2016-01-22 23:33:22,250 DEBUG : BROWSER_OUTPUT: |7;RegExp;24414.634146341465 23:33:22 INFO - 2016-01-22 23:33:22,250 DEBUG : BROWSER_OUTPUT: |8;Splay;525.2100840336135 23:33:22 INFO - 2016-01-22 23:33:22,250 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 23:33:22 INFO - 2016-01-22 23:33:22,250 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:33:22 INFO - 2016-01-22 23:33:22,250 DEBUG : BROWSER_OUTPUT: __startTimestamp1453534402246__endTimestamp 23:33:22 INFO - 2016-01-22 23:33:22,251 DEBUG : BROWSER_OUTPUT: 23:33:22 INFO - 2016-01-22 23:33:22,251 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:33:22 INFO - 2016-01-22 23:33:22,251 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:33:22 INFO - 2016-01-22 23:33:22,251 DEBUG : BROWSER_OUTPUT: 23:33:22 INFO - 2016-01-22 23:33:22,251 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.07 Median:165.07 stddev:0.00 (0.0%) 23:33:22 INFO - 2016-01-22 23:33:22,251 DEBUG : BROWSER_OUTPUT: Values: 165.1 23:33:22 INFO - 2016-01-22 23:33:22,251 DEBUG : BROWSER_OUTPUT: 23:33:22 INFO - 2016-01-22 23:33:22,251 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.37 Median:173.37 stddev:0.00 (0.0%) 23:33:22 INFO - 2016-01-22 23:33:22,251 DEBUG : BROWSER_OUTPUT: Values: 173.4 23:33:22 INFO - 2016-01-22 23:33:22,252 DEBUG : BROWSER_OUTPUT: 23:33:22 INFO - 2016-01-22 23:33:22,252 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 23:33:22 INFO - 2016-01-22 23:33:22,252 DEBUG : BROWSER_OUTPUT: Values: 278.5 23:33:22 INFO - 2016-01-22 23:33:22,252 DEBUG : BROWSER_OUTPUT: 23:33:22 INFO - 2016-01-22 23:33:22,252 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5117.35 Median:5117.35 stddev:0.00 (0.0%) 23:33:22 INFO - 2016-01-22 23:33:22,252 DEBUG : BROWSER_OUTPUT: Values: 5117.3 23:33:22 INFO - 2016-01-22 23:33:22,252 DEBUG : BROWSER_OUTPUT: 23:33:22 INFO - 2016-01-22 23:33:22,252 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:958.77 Median:958.77 stddev:0.00 (0.0%) 23:33:22 INFO - 2016-01-22 23:33:22,252 DEBUG : BROWSER_OUTPUT: Values: 958.8 23:33:22 INFO - 2016-01-22 23:33:22,253 DEBUG : BROWSER_OUTPUT: 23:33:22 INFO - 2016-01-22 23:33:22,253 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:556.79 Median:556.79 stddev:0.00 (0.0%) 23:33:22 INFO - 2016-01-22 23:33:22,253 DEBUG : BROWSER_OUTPUT: Values: 556.8 23:33:22 INFO - 2016-01-22 23:33:22,253 DEBUG : BROWSER_OUTPUT: 23:33:22 INFO - 2016-01-22 23:33:22,253 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11000.00 Median:11000.00 stddev:0.00 (0.0%) 23:33:22 INFO - 2016-01-22 23:33:22,253 DEBUG : BROWSER_OUTPUT: Values: 11000.0 23:33:22 INFO - 2016-01-22 23:33:22,253 DEBUG : BROWSER_OUTPUT: 23:33:22 INFO - 2016-01-22 23:33:22,253 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24414.63 Median:24414.63 stddev:0.00 (0.0%) 23:33:22 INFO - 2016-01-22 23:33:22,253 DEBUG : BROWSER_OUTPUT: Values: 24414.6 23:33:22 INFO - 2016-01-22 23:33:22,253 DEBUG : BROWSER_OUTPUT: 23:33:22 INFO - 2016-01-22 23:33:22,254 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:525.21 Median:525.21 stddev:0.00 (0.0%) 23:33:22 INFO - 2016-01-22 23:33:22,254 DEBUG : BROWSER_OUTPUT: Values: 525.2 23:33:22 INFO - 2016-01-22 23:33:22,254 DEBUG : BROWSER_OUTPUT: 23:33:22 INFO - 2016-01-22 23:33:22,254 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 23:33:22 INFO - 2016-01-22 23:33:22,254 DEBUG : BROWSER_OUTPUT: Values: 4830.9 23:33:22 INFO - 2016-01-22 23:33:22,254 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:33:22 INFO - 2016-01-22 23:33:22,254 DEBUG : BROWSER_OUTPUT: 23:33:23 INFO - 2016-01-22 23:33:23,022 INFO : Browser exited with error code: 0 23:33:23 INFO - 2016-01-22 23:33:23,034 INFO : Completed test v8_7 (00:00:39) 23:33:23 INFO - 2016-01-22 23:33:23,276 INFO : Completed test suite (00:20:10) 23:33:23 INFO - 2016-01-22 23:33:23,276 DEBUG : Working with test: dromaeo_css 23:33:23 INFO - 2016-01-22 23:33:23,276 DEBUG : Generating results file: dromaeo_css 23:33:23 INFO - 2016-01-22 23:33:23,277 DEBUG : Working with test: kraken 23:33:23 INFO - 2016-01-22 23:33:23,277 DEBUG : Generating results file: kraken 23:33:23 INFO - 2016-01-22 23:33:23,278 INFO : javascript benchmark 23:33:23 INFO - 2016-01-22 23:33:23,278 DEBUG : Working with test: v8_7 23:33:23 INFO - 2016-01-22 23:33:23,278 DEBUG : Generating results file: v8_7 23:33:23 INFO - 2016-01-22 23:33:23,278 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:33:23 INFO - 2016-01-22 23:33:23,331 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 23:33:23 INFO - 2016-01-22 23:33:23,331 DEBUG : process_Request line: dromaeo_css 7259.37 graph.html#tests=[[72,52,35]] 23:33:23 INFO - 2016-01-22 23:33:23,332 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:33:23 INFO - 2016-01-22 23:33:23,367 DEBUG : process_Request line: kraken 1470.80 graph.html#tests=[[232,52,35]] 23:33:23 INFO - 2016-01-22 23:33:23,367 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:33:23 INFO - 2016-01-22 23:33:23,397 DEBUG : process_Request line: v8_7 23029.30 graph.html#tests=[[230,52,35]] 23:33:23 INFO - 2016-01-22 23:33:23,399 INFO : javascript benchmark 23:33:23 INFO - 2016-01-22 23:33:23,402 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3331.650176731443, 3383.3064221834525, 3394.4229480988247, 3418.4872269159637, 3425.0752296879837, 5574.303212098488, 5596.188552659862, 5626.212330273765, 5627.212190293362, 5628.465295796903, 5626.606137570372, 5634.690092044936, 5639.182318563806, 5643.181738647893, 5661.8584535386635, 4863.781129849148, 5083.949160508394, 5117.641765076446, 5172.353455818023, 5218.0, 5092.567131793802, 5109.514596113363, 5109.540141387274, 5110.514501122406, 5112.41207261166, 5033.597312215033, 5062.924056139161, 5066.898662026757, 5077.365329333833, 5079.034983353151, 5053.620978426596, 5123.769430375623, 5170.457102004273, 5171.612129090333, 5192.636515443921, 5031.949680503221, 5118.488151184889, 5138.409082955433, 5150.871228219287, 5174.974125129388, 5106.055379754757, 5193.298904647862, 5412.729363531807, 5428.891422171574, 5488.204210389471, 5940.049592065248, 6029.095635654643, 6035.336113027563, 6055.969720151371, 6059.848503787441, 6088.634681919055, 6096.847578810521, 6118.510519158456, 6127.142200091991, 6129.540284478682, 5390.8921821563345, 5492.313460817398, 5656.095024796054, 5680.0627896397045, 5692.23154874095, 6012.038073908241, 6053.7881174159575, 6054.182685337423, 6060.060690592965, 6073.1497590337385, 5944.5838791284195, 5967.820965370959, 5969.910451343233, 5973.462388385066, 5976.491998180117, 5728.684922329312, 5846.386129456346, 5889.411058894077, 6064.272287325549, 6066.969665151646, 5932.288125424977, 5935.198748168942, 5935.406459354116, 5935.7625694972585, 6019.879602407927, 5879.470847623649, 5935.139404786368, 5935.584509084322, 5936.584439089309, 5940.851478713067, 4441.378207050951, 4516.548345165457, 4574.542545745466, 4581.266997280486, 4592.196365636, 4120.237756015147, 4134.586541345841, 4134.689898257643, 4140.296149654566, 4163.97918010408, 5639.210510528529, 5641.069223578063, 5652.491275785199, 5653.971730141405, 5682.7442765075675, 5749.310082790092, 5863.2670916135485, 6039.969800150971, 6113.693956142648, 6122.520135281246, 5629.183768353566, 5636.408177141341, 5636.492715655529, 5646.632968857011, 5648.435156484401, 4993.825216117491, 5211.374635043819, 5216.843494695166, 5217.634765566374, 5221.843344699665, 6066.181065556182, 6094.238220222473, 6211.0, 6212.502999760009, 6214.720337584729, 6039.214902062704, 6071.202002087907, 6079.3312735598165, 6083.66539840313, 6116.29662588808, 5980.43185897339, 6044.788432404845, 6176.4441200292185, 6222.502199824094, 6222.564420490703, 5856.970715146397, 5916.3492015877355, 5922.0, 5922.378150294157, 5958.1658567801405, 5950.077737950624, 5995.760169593167, 6000.729967151401, 6002.159697642421, 6055.394460553909, 5718.1708652246025, 5816.563757718103, 5852.853678657897, 5858.7070646468355, 5862.149988251765, 5937.703114844327, 5940.079287710412, 5944.970275148597, 5948.524118070457, 5960.880782384242, 5850.12248162779, 5852.122181672783, 5853.795117170878, 5858.209141765978, 5859.648421094748, 5679.488846003879, 5786.826395208151, 5850.912236316373, 5862.325832529314, 5950.7917222896995, 5806.303243610793, 5813.941860581509, 5820.883582328245, 5827.825165245049, 5829.8251052468495], "unit": "ms", "name": "dojo.html", "value": 5527.362962219064}, {"lowerIsBetter": false, "replicates": [566.286479036414, 611.5932904618429, 613.2640831002798, 615.2616859768278, 623.1120653069376, 34433.31133377331, 42503.57496425039, 43072.138557228915, 43146.35280470795, 43201.135977280515, 46859.0, 47485.28772068422, 47548.0, 47550.04899902009, 47628.285575716305, 8034.718784842532, 8127.3904457165945, 9194.264458843276, 9399.248060155205, 10477.528511217013, 10641.095506881924, 10698.732531686692, 10732.517036733327, 10779.892201077968, 10788.622398216065, 10798.946005269963, 10881.564737410494, 10929.56281748729, 10935.28920620157, 10939.726506837313, 8436.57817109145, 8653.17794809492, 11086.556537738481, 11354.091672666167, 11366.37484938328, 10752.086072683831, 10887.401192934385, 10891.83662245067, 10895.128389728803, 10899.0, 41414.0, 41920.0, 41945.580544194476, 41957.0, 41996.79001605003, 3445.2592692571216, 3461.9480707789403, 3473.548438702978, 3987.1228329767405, 4277.165072305896, 32468.837655811807, 32554.83722581372, 32623.51064734031, 32941.835290823394, 33079.17302067443, 3569.5716514018222, 3599.784012959231, 3629.4192929131214, 3638.890833275006, 3662.5971143174497, 275141.0, 276184.0, 277369.0, 277465.0, 277825.0, 60332.39667603355, 61733.38266617366, 61902.69048654818, 67599.0, 68311.0, 81310.0, 82368.58815705882, 82859.0, 82892.17107828966, 83043.5847820757, 17094.572635684206, 17282.308707651806, 17297.0, 17317.047562383937, 17321.7401738974, 12922.353882306035, 12946.546870859474, 12978.286194259406, 13051.086423950423, 13056.281904495154, 21923.890380548313, 22433.887830560743, 22442.438939026655, 22467.55064898693, 22496.550068998527, 8358.791030224293, 8473.957630211933, 8488.533130677872, 8576.528290944058, 8606.13938606147, 919.866619340192, 996.3573495095623, 998.031909048222, 1051.2903789941759, 1166.2652528906735, 28044.43911121766, 28146.71853281482, 28363.0, 28472.71527284742, 28852.567211491845, 1064.824303989833, 1101.944902754859, 1122.259308856151, 1203.1157099531838, 1231.8337024501757, 14675.853241467663, 15001.549953501195, 15352.0, 17076.40232591878, 18181.909090454465, 403882.0, 409102.0, 410104.0, 410166.0, 410732.0, 59944.700276499214, 60381.39618603846, 60410.0, 60417.395826041175, 60602.39397606056, 1278.6355888571713, 1359.1912811876916, 1359.503781119884, 1426.785982102693, 1453.4331610671848, 30372.39255214839, 30572.0, 30728.231794205323, 31458.213544661565, 31919.36161276715, 47085.0, 47798.52201477941, 47886.52113478821, 48336.0, 49066.75466622644, 311251.0, 312089.0, 313705.0, 314618.0, 314742.0, 34375.31249375048, 34401.827990859885, 34505.654943450245, 35086.64913350936, 35119.47320790241, 46078.769606151756, 46229.0, 46775.53224467712, 47084.29373559468, 47326.05347893092, 38791.224175516894, 39687.80156099201, 39737.60262397339, 39918.0, 40602.39096413615, 37534.0, 38824.223515530095, 39154.6084539151, 44811.55188448204, 45280.77359613181, 38649.80675096607, 39049.6095039046, 39161.0, 39262.80368598139, 39603.0, 34418.0, 34666.48000280048, 35386.29227415386, 35510.82244588761, 35680.28639427249, 26676.0, 27172.475076505205, 27251.454970900868, 27272.454550908475, 27670.44659106847], "unit": "ms", "name": "ext.html", "value": 20377.418241858682}, {"lowerIsBetter": false, "replicates": [358.7201982453687, 361.46683641628584, 361.7377401383997, 364.80847555033586, 368.32964005509973, 15280.617984550392, 15638.0, 17203.827961720395, 17589.560260993483, 18212.726809097872, 18459.630807383845, 18540.536486587807, 18792.906035469805, 18812.0, 18899.433017009476, 5466.01611709892, 5589.916151257714, 5605.663660180382, 5606.719664016803, 5606.831795046155, 4149.83400663973, 4256.7445953242905, 5555.333359996806, 6074.878502429949, 6278.497720182398, 6093.0, 6165.63006219626, 6186.041163619646, 6231.813045608639, 6235.282942461629, 6058.182145410379, 6092.66490343031, 6108.3280839107665, 6110.052941794029, 6110.08348747687, 5309.893802123975, 5339.385970613391, 5361.142217245222, 5361.919571206435, 5376.542993845528, 22104.88947555268, 22142.335729928127, 22325.553488930294, 22447.21434749776, 22509.887450562805, 2175.8585691929975, 2186.606410846047, 2290.6449500327476, 2311.1217737259735, 2331.5453486570127, 14013.789793153112, 14124.92937535316, 14136.787948180785, 14262.215578143301, 14356.06685565435, 1929.8263156315859, 1977.2091163534558, 1990.581977784667, 2008.588239410932, 2015.2946468735972, 63728.0, 64376.0, 64810.0, 66145.0, 66407.66796166037, 9916.206703463706, 10024.097831195228, 10105.39367637944, 10132.54403551842, 10205.0, 13118.0, 13220.33898305081, 13245.867541324656, 13247.536336228186, 13254.469821207236, 7840.960795196102, 7914.406419518559, 7938.126806051329, 7943.086545047278, 7991.320737737357, 7913.287804097658, 7923.643436045391, 7929.365650748042, 7967.641456134488, 7968.163342849033, 6193.1329613854095, 6248.812535623939, 6261.311255761862, 6271.090691849657, 6287.151234583364, 1614.144503413193, 1700.3113738935751, 1737.9565510862076, 1792.3905872003581, 1805.1606003208572, 404.9007993041724, 845.6152450634946, 925.5788616179622, 966.3042609321277, 1014.8832884218261, 10016.399016058915, 10354.741131471774, 10711.46442677863, 10942.890571094187, 10962.945185274022, 432.5998451432412, 438.861758546057, 443.1159836126947, 443.28409618465946, 446.7185673025973, 6098.512119030467, 6257.186565746424, 6358.1416508771645, 6386.744530218833, 6396.136521569529, 436241.0, 636335.0, 643144.0, 657501.0, 668646.0, 82544.58727706323, 83781.0, 85110.0, 85840.99999999875, 87838.56080719555, 1197.3713800254936, 1198.9868561065884, 1202.4048096192441, 1210.4734440518228, 1224.3388570172185, 16004.279807408462, 16125.838741612903, 16135.112568808829, 16346.67306653884, 16517.091559964316, 36035.63964360428, 36481.27037459289, 36890.26219475649, 37787.0, 37819.24361512809, 49216.26175607297, 49306.75346623244, 49344.0, 49689.50310496993, 50962.74518627383, 9393.812123757623, 9535.189508891823, 9802.607895684092, 9808.362456440309, 9840.96669849684, 11414.828777568177, 11544.191906566795, 16972.321107155574, 17842.821571784636, 17926.462206133838, 14955.252237388304, 15077.0, 15077.472288469851, 15397.0, 15422.845771542141, 14850.331735072165, 15051.548453545973, 15170.848291517384, 15603.375864965274, 16013.439529616408, 12301.138920275853, 12904.548340808027, 14613.92693036528, 14777.630559236106, 16336.754948676016, 9562.95218523903, 9762.951185244028, 10023.198144148304, 10236.948815256173, 10248.743781405525, 7689.0, 13896.235707035805, 15031.098134111988, 15053.322600483223, 15266.236688165325], "unit": "ms", "name": "jquery.html", "value": 8925.866319546381}, {"lowerIsBetter": false, "replicates": [1532.2874863188615, 1582.7704982777493, 1667.9999999999984, 1778.937737179199, 1891.659501289768, 6714.6306953117555, 7387.556746595208, 7726.922730772691, 7729.381649468043, 7741.0, 7559.773206803791, 7707.537547747125, 7708.267714567121, 7711.807204819882, 7712.190220026887, 1934.6130773845216, 1982.851286153537, 1985.7120717495955, 2221.7444993825716, 2264.0377839418265, 2012.8289095426906, 2227.9554408911813, 2267.64851448025, 2271.432141964509, 2272.488690044743, 2197.923072692456, 2219.511707424364, 2230.955380892381, 2257.8306627002958, 2261.852979556332, 2217.2904670505445, 2271.2618399020384, 2286.565552545011, 2294.621387471065, 2295.2196253273883, 2243.383069655841, 2260.3106052653934, 2262.0273282488524, 2263.1626298269744, 2264.286749673864, 7698.1916898725385, 7765.1070126935565, 7768.184340644264, 7770.3006729394065, 7789.9221007789765, 4516.932246016312, 4558.8860278492975, 4581.931271030937, 4585.082983403299, 4585.449746030465, 3021.365513242222, 3023.682513336112, 3052.2064263291704, 3062.8315442650646, 3118.5789918360956, 987.1707765476962, 1007.184180813536, 1013.4476710192963, 1016.7763092119795, 1018.4195008844962, 10576.841347379795, 10578.153747700166, 10578.947105264502, 10586.470676466146, 10593.940605939499, 3968.861089861841, 3975.906625677904, 4031.8185681644395, 4033.193361327746, 4054.493188351456, 9108.407953483002, 9138.634454621873, 9141.588628511732, 9147.908520914838, 9187.770305742277, 4623.768811559408, 4635.2120139576355, 4649.4420669519195, 4649.837255696035, 4672.322513235562, 4235.216484950294, 4255.3616957456625, 4258.552851950562, 4279.657627389802, 4285.485741710952, 3194.9361012779614, 3285.720713739311, 3571.94642080369, 3649.1789347397153, 3652.1782598915033, 1080.935143891369, 1094.141099237095, 1095.5727266366123, 1101.4602844606245, 1110.2838669058413, 1118.8825173356681, 1131.5077941095649, 1136.0740996088161, 1346.3335648853683, 1430.2634143416149, 7296.379807716297, 7346.926530734624, 7369.299916507923, 7371.963140184264, 7398.3341499265325, 1127.1321082766387, 1129.8135807591655, 1142.2289954280827, 1143.7426579019655, 1154.543955137716, 5845.503132233723, 5905.911411328833, 5956.851078723066, 5958.910616340759, 5962.582619216613, 8764.123587641185, 8919.910800891908, 8947.19475247231, 8947.32895032875, 9008.41445306066, 8900.599473023729, 8930.86603700945, 9038.231750301167, 9066.682666106655, 9081.182693557612, 7269.236730143364, 7323.231060738653, 7439.367653749492, 7455.478116531791, 7466.813329666693, 7421.146568144733, 7452.850942981218, 7483.812904677427, 7486.850262994819, 7492.887606685795, 8080.515169089874, 8268.503889766633, 8320.958395208227, 8321.95839020801, 8457.238848503664, 8438.873416898874, 8583.442076265272, 8586.441881277697, 8593.31253499731, 8603.354748393771, 6780.898286525608, 7002.089728335284, 7050.753223637148, 7060.188078371053, 7066.904629782392, 6554.377334153248, 6618.768343107968, 7565.886511702439, 7595.278448547379, 7597.3162415382885, 6908.896366554405, 7081.929180708333, 7119.6084215368655, 7129.39400150993, 7208.855822883408, 6850.109485766819, 7044.330788575077, 7062.081929349357, 7150.713971441084, 7161.641917904188, 7120.679569419285, 7148.320909513588, 7157.64211789398, 7159.319864612853, 7169.032180655545, 6276.497880169667, 6499.0, 6499.38255865692, 6550.213974323112, 6572.671366431755, 6628.900566491603, 6675.03212034262, 6677.131972843499, 6680.198376194888, 6681.0], "unit": "ms", "name": "mootools.html", "value": 4463.4215287353945}, {"lowerIsBetter": false, "replicates": [325.1708144232208, 327.19836400818, 328.7928604978863, 329.35775238285333, 332.92009917619765, 6003.429674180946, 6094.908576371353, 6104.6947652617355, 6109.908351374733, 6161.876762464748, 5956.1065840124, 6051.2133422655, 6068.57519973602, 6091.939080609192, 6098.57309988301, 4631.073785242948, 4633.513481084488, 4635.675502714811, 4636.281376386649, 4637.350770892078, 4471.597556219939, 4569.360289559448, 4577.725336479805, 4588.623412976111, 4638.489766125724, 4492.97753511232, 4590.586847183753, 4624.676272660915, 4633.4208223972, 4646.303054541812, 4605.355250264965, 4617.953820461786, 4621.607163391082, 4634.698744581625, 4640.211164102094, 4008.4588580541545, 4022.1352409232154, 4022.3363145081025, 4038.374052021941, 4040.5151381834366, 5686.800961966312, 5773.682447465388, 5784.363719990798, 5800.0, 5809.796657116981, 5343.438938911398, 5355.812546560891, 5357.517823395874, 5359.678419294854, 5362.91955620666, 6199.070139479114, 6425.582337148117, 6432.581882177644, 6433.356664333576, 6451.451626611743, 4335.263005289108, 4336.1978034063795, 4421.358902959085, 4421.9336709949375, 4435.334699795057, 6694.531382803206, 6694.631795251308, 6698.296678848748, 6707.195136583592, 6707.832304192385, 4502.594766471033, 4518.751468669189, 4522.276435770261, 4528.071745292207, 4529.320601909674, 4526.411566496335, 4564.748938808398, 4573.359729637853, 4623.653226008063, 4646.6747327686735, 5341.172118321666, 5388.084025715638, 5390.380106287827, 5395.2986111806, 5401.567874570103, 6571.835704107436, 6575.276719560845, 6575.868482630321, 6580.407763301326, 6592.241892182365, 1609.1712767924528, 1635.7791698120602, 1636.2963925511906, 1637.3123288218976, 1637.8780535333096, 1059.957601695939, 1077.8167711489066, 1087.1194332590626, 1088.3034857691084, 1127.0138628699888, 6196.3803619638575, 6196.721147548281, 6220.315765265817, 6295.150154729145, 6296.685165741695, 6750.459963202932, 6758.324167583301, 6765.458763298924, 6768.763093291711, 6772.492063095287, 6222.191115155001, 6279.7488100476385, 6282.937170628326, 6283.717232724538, 6286.119943207955, 3665.7983810890655, 3702.740808143404, 3704.277665855186, 3706.6664000240107, 3707.647773461517, 7052.0479735235085, 7057.576545407292, 7057.7176912922905, 7058.823529411703, 7061.046758687614, 6894.689738961759, 6961.860762784817, 6962.443004559623, 7005.0, 7016.122984626922, 7023.508354415244, 7028.0, 7036.120484939383, 7040.190378106583, 7041.295870412918, 6596.637184954873, 6685.364890335411, 6739.224989126314, 6824.215215250111, 6846.383825455733, 6698.899516507354, 6708.228553716385, 6739.730410783513, 6750.594964302158, 6752.189737231563, 6973.058637083929, 7015.929840701528, 7022.789316320519, 7037.7184912602925, 7041.049458323061, 4376.474823021258, 4398.890027749332, 4417.072414792801, 4489.932651010172, 4496.887577810581, 6773.525853190229, 6774.085498457645, 6777.830554236183, 6778.694958726771, 6782.948642960349, 6600.273969863407, 6608.900866487103, 6614.8346291343105, 6617.503687223574, 6621.768238111643, 6505.967470162619, 6542.934570654423, 6584.176977877765, 6585.045168450643, 6586.80239592813, 6470.320616335217, 6472.061551075162, 6473.126127972663, 6475.676216189266, 6476.5466417350335, 6580.8354791130605, 6588.110605068255, 6605.768798092044, 6608.570442921195, 6609.537332386687, 6370.1718776558755, 6460.3862633049785, 6489.415952564292, 6507.511936604868, 6513.0], "unit": "ms", "name": "prototype.html", "value": 4888.912928374199}, {"lowerIsBetter": false, "replicates": [803.7789607857842, 845.6701886264356, 859.9871001934971, 875.3128793896792, 930.6789157740577, 13893.444262229512, 13905.860941390583, 14128.505502307422, 14942.701145977075, 15033.473828416008, 13025.413856376463, 13049.80425293619, 13092.934535327335, 13112.147710398818, 13121.0, 769.1116760142031, 780.785284046886, 918.673870775875, 935.3873213045432, 936.6862101196108, 908.736466424736, 909.6225066597387, 915.2220612479373, 916.1891725822628, 916.9541522923861, 799.312591171592, 804.5012092502657, 979.1774909076374, 986.4426598971594, 989.7327721515187, 952.7046615549202, 962.1340793286029, 963.4604621412032, 964.0118878149917, 964.1804466203741, 710.2258538193342, 710.5630037526936, 710.8471678589128, 711.1395211793736, 711.1466240511407, 13932.303384830719, 14004.92997535016, 14010.719785604333, 14017.43930242789, 14023.368948397347, 12139.0, 12152.392380381034, 12289.385530723428, 12540.498380064786, 12598.118131730782, 10661.520231589597, 10689.412082335468, 10775.730606734816, 10875.782484350348, 10878.673639790819, 3763.153290509641, 3834.559025712051, 3836.1368692044066, 3839.5968423315708, 3850.403187505941, 45155.548444515465, 45348.31977520307, 46513.76743116297, 47341.28988065182, 47455.76272118652, 9990.950045249727, 10047.296689231684, 10205.62224099737, 10729.356238625707, 10737.087347575387, 18745.0627468626, 18762.906185468986, 18769.624607508045, 18804.341848035252, 18832.905835470734, 7416.25837416254, 7492.1384040836, 7631.1605723370385, 7723.420743444264, 7813.101493328227, 4529.705569137996, 4544.295634176708, 4564.817407303671, 4661.748704792498, 4672.859814205579, 3111.191090316534, 3154.9842250788597, 3156.2740569669104, 3157.636871759731, 3157.684231576824, 598.2970010237952, 612.4059662127729, 615.2186722861941, 618.13769791142, 633.4963703855447, 554.6450271826035, 588.7350692188533, 683.9281875403011, 727.581640556682, 730.0545793197822, 9174.495402752913, 9202.539873006323, 9259.53702314895, 9300.209482193954, 9425.717228483156, 594.5392320951297, 623.982907860185, 754.6113751418025, 755.4560716284267, 760.7945854619222, 4149.019101575493, 4269.893252668709, 4293.0769884474985, 4347.608715215646, 4388.385626012361, 59322.40677593255, 59675.40324596786, 60183.69908150431, 60275.0, 60543.0, 50171.74914125406, 52566.21150682743, 52984.470155298724, 53113.46886531085, 53397.46602534003, 46643.53356466392, 47045.76477117593, 47724.761376192895, 47954.520454795005, 48539.5146048535, 9319.813603728024, 9425.528723563657, 9498.0, 9522.714318570454, 9579.664711735057, 34956.0, 36073.45889811603, 36376.454353185254, 36843.81578092092, 37409.0, 43306.56693433025, 43310.13379732451, 45155.77422112868, 46944.0, 47669.28496072492, 9620.567074481805, 11454.541818327174, 11656.18406711522, 12075.215111017756, 12608.936955315532, 13400.463981440633, 13488.009436508555, 13491.460341586619, 13512.864871351161, 13535.120217185851, 11763.529458821551, 12024.519019239133, 12242.510299587917, 12326.75346493083, 12933.676658083623, 11489.195756296978, 11502.309861408343, 12076.698082548006, 12580.496780128693, 13285.867141328463, 10021.368665456388, 11249.71875703114, 12202.32887191213, 12384.380780960735, 12951.093423460266, 10080.747981300527, 10300.124489418484, 11101.0, 11102.000819926245, 11102.722431939266, 10193.949030254802, 10579.418132002813, 10832.566697332019, 10841.295315804447, 10995.505202265756], "unit": "ms", "name": "yui.html", "value": 6670.427447704311}], "name": "dromaeo_css", "value": 7259.366146127669}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 108.0, 102.0, 108.0, 110.0, 110.0, 98.0, 107.0, 107.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 106.8}, {"lowerIsBetter": true, "replicates": [153.0, 120.0, 145.0, 153.0, 123.0, 144.0, 150.0, 122.0, 162.0, 120.0], "unit": "ms", "name": "audio-beat-detection", "value": 139.2}, {"lowerIsBetter": true, "replicates": [159.0, 160.0, 160.0, 159.0, 159.0, 159.0, 160.0, 160.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 159.7}, {"lowerIsBetter": true, "replicates": [79.0, 70.0, 71.0, 150.0, 72.0, 72.0, 71.0, 72.0, 149.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 87.6}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 132.0, 92.0, 92.0, 92.0, 138.0, 91.0, 92.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 105.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [57.0, 54.0, 56.0, 55.0, 57.0, 56.0, 57.0, 54.0, 52.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [81.0, 79.0, 80.0, 81.0, 80.0, 81.0, 80.0, 80.0, 80.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 80.3}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 118.0, 110.0, 112.0, 113.0, 116.0, 118.0, 118.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.4}, {"lowerIsBetter": true, "replicates": [146.0, 143.0, 142.0, 142.0, 142.0, 137.0, 148.0, 143.0, 141.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.4}, {"lowerIsBetter": true, "replicates": [66.0, 63.0, 64.0, 64.0, 63.0, 64.0, 65.0, 63.0, 63.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.8}], "name": "kraken", "value": 1470.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.0709805216243], "unit": "score", "name": "Richards", "value": 213.85951599999999}, {"lowerIsBetter": false, "replicates": [173.37031900138697], "unit": "score", "name": "DeltaBlue", "value": 381.368624}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5117.34693877551], "unit": "score", "name": "Decrypt", "value": 52.01542971086741}, {"lowerIsBetter": false, "replicates": [958.7727708533077], "unit": "score", "name": "RayTrace", "value": 771.8085270000001}, {"lowerIsBetter": false, "replicates": [556.7928730512249], "unit": "score", "name": "Earley", "value": 1196.967548}, {"lowerIsBetter": false, "replicates": [11000.0], "unit": "score", "name": "Boyer", "value": 60.58754545454549}, {"lowerIsBetter": false, "replicates": [24414.634146341465], "unit": "score", "name": "RegExp", "value": 37.31307192807194}, {"lowerIsBetter": false, "replicates": [525.2100840336135], "unit": "score", "name": "Splay", "value": 155.15886400000005}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23029.300008223156}]} 23:33:23 INFO - RETURN: dromaeo_css: 7259.37 23:33:23 INFO - RETURN: kraken: 1470.80 23:33:23 INFO - RETURN: v8_7: 23029.30 23:33:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23029.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1470.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7259.37"}}} 23:33:23 INFO - Return code: 0 23:33:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:33:23 INFO - # TBPL SUCCESS # 23:33:23 INFO - Running post-action listener: _resource_record_post_action 23:33:23 INFO - Running post-run listener: _resource_record_post_run 23:33:24 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 262144; Write bytes: 500813824; Read time: 16; Write time: 794228 23:33:24 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 237989888; Read time: 0; Write time: 531220 23:33:24 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 262144; Write bytes: 262823936; Read time: 16; Write time: 263008 23:33:24 INFO - Running post-run listener: _upload_blobber_files 23:33:24 INFO - Blob upload gear active. 23:33:24 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:33:24 INFO - Copying logs to upload dir... 23:33:24 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.524448 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-22 23:33:24.296040) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 23:33:24.299829) ========= 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=1861a34ebfea852630dec091000001fa-1453532333.581777-552667916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/EoXF8QCbQC-BlpzBwYjZtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010044 build_url: 'https://queue.taskcluster.net/v1/task/EoXF8QCbQC-BlpzBwYjZtA/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 23:33:24.351586) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 23:33:24.351959) ========= 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=1861a34ebfea852630dec091000001fa-1453532333.581777-552667916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 23:33:24.402192) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 23:33:24.402581) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 23:33:24.402900) ========= ========= Total master_lag: 0.31 =========