builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1453485537.65 results: success (0) buildid: 20160122072128 builduid: b5bac9d27c914ec0832868b7f26cf391 revision: 829ed713fa9a047575d96c6943d86031bd78ab9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:57.651452) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:57.651913) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:57.652197) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004970 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:57.673646) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:57.673967) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:57.687098) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:57.687419) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:57.736031) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:57.736336) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:57.736698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:57.736990) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 09:58:58-- 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% 64.4K=0.2s 2016-01-22 09:58:58 (64.4 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.348898 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:58.098471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:58.098882) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019698 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:58.149427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-22 09:58:58.149812) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 829ed713fa9a047575d96c6943d86031bd78ab9f --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 829ed713fa9a047575d96c6943d86031bd78ab9f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 09:58:58,560 truncating revision to first 12 chars 2016-01-22 09:58:58,560 Setting DEBUG logging. 2016-01-22 09:58:58,560 attempt 1/10 2016-01-22 09:58:58,560 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/829ed713fa9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 09:58:59,634 unpacking tar archive at: mozilla-aurora-829ed713fa9a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.415150 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-22 09:58:59.598967) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:59.599312) ========= echo 829ed713fa9a047575d96c6943d86031bd78ab9f in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'829ed713fa9a047575d96c6943d86031bd78ab9f'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 829ed713fa9a047575d96c6943d86031bd78ab9f program finished with exit code 0 elapsedTime=0.004687 script_repo_revision: '829ed713fa9a047575d96c6943d86031bd78ab9f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:59.655687) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:59.656000) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 09:58:59.666871) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-01-22 09:58:59.667269) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:59:00 INFO - MultiFileLogger online at 20160122 09:59:00 in /builds/slave/test-pgo 09:59:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:59:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:59:00 INFO - {'append_to_log': False, 09:59:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:59:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:59:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:59:00 INFO - 'branch': 'Mozilla-Aurora', 09:59:00 INFO - 'buildbot_json_path': 'buildprops.json', 09:59:00 INFO - 'config_files': ('talos/linux_config.py',), 09:59:00 INFO - 'default_actions': ('clobber', 09:59:00 INFO - 'read-buildbot-config', 09:59:00 INFO - 'download-and-extract', 09:59:00 INFO - 'populate-webroot', 09:59:00 INFO - 'create-virtualenv', 09:59:00 INFO - 'install', 09:59:00 INFO - 'run-tests'), 09:59:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:59:00 INFO - 'download_minidump_stackwalk': True, 09:59:00 INFO - 'download_symbols': 'ondemand', 09:59:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:59:00 INFO - 'tooltool.py': '/tools/tooltool.py', 09:59:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:59:00 INFO - '/tools/misc-python/virtualenv.py')}, 09:59:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:59:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:59:00 INFO - 'installer_path': 'installer.exe', 09:59:00 INFO - 'log_level': 'info', 09:59:00 INFO - 'log_name': 'talos', 09:59:00 INFO - 'log_to_console': True, 09:59:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:59:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:59:00 INFO - 'opt_config_files': (), 09:59:00 INFO - 'pip_index': False, 09:59:00 INFO - 'sps_profile': False, 09:59:00 INFO - 'sps_profile_interval': 0, 09:59:00 INFO - 'suite': 'dromaeojs-e10s', 09:59:00 INFO - 'system_bits': '32', 09:59:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:59:00 INFO - 'title': 'talos-linux64-ix-055', 09:59:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:59:00 INFO - 'use_talos_json': True, 09:59:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:59:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:59:00 INFO - 'work_dir': 'build'} 09:59:00 INFO - ##### 09:59:00 INFO - ##### Running clobber step. 09:59:00 INFO - ##### 09:59:00 INFO - Running pre-action listener: _resource_record_pre_action 09:59:00 INFO - Running main action method: clobber 09:59:00 INFO - rmtree: /builds/slave/test-pgo/build 09:59:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:59:01 INFO - Running post-action listener: _resource_record_post_action 09:59:01 INFO - ##### 09:59:01 INFO - ##### Running read-buildbot-config step. 09:59:01 INFO - ##### 09:59:01 INFO - Running pre-action listener: _resource_record_pre_action 09:59:01 INFO - Running main action method: read_buildbot_config 09:59:01 INFO - Using buildbot properties: 09:59:01 INFO - { 09:59:01 INFO - "properties": { 09:59:01 INFO - "buildnumber": 73, 09:59:01 INFO - "product": "firefox", 09:59:01 INFO - "script_repo_revision": "production", 09:59:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:59:01 INFO - "repository": "", 09:59:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:59:01 INFO - "buildid": "20160122072128", 09:59:01 INFO - "slavename": "talos-linux64-ix-055", 09:59:01 INFO - "pgo_build": "True", 09:59:01 INFO - "basedir": "/builds/slave/test-pgo", 09:59:01 INFO - "project": "", 09:59:01 INFO - "platform": "ubuntu64_hw", 09:59:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:59:01 INFO - "slavebuilddir": "test", 09:59:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:59:01 INFO - "branch": "mozilla-aurora", 09:59:01 INFO - "repo_path": "releases/mozilla-aurora", 09:59:01 INFO - "stage_platform": "linux64-pgo", 09:59:01 INFO - "builduid": "b5bac9d27c914ec0832868b7f26cf391", 09:59:01 INFO - "revision": "829ed713fa9a047575d96c6943d86031bd78ab9f" 09:59:01 INFO - }, 09:59:01 INFO - "sourcestamp": { 09:59:01 INFO - "repository": "", 09:59:01 INFO - "hasPatch": false, 09:59:01 INFO - "project": "", 09:59:01 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:59:01 INFO - "changes": [ 09:59:01 INFO - { 09:59:01 INFO - "category": null, 09:59:01 INFO - "files": [ 09:59:01 INFO - { 09:59:01 INFO - "url": null, 09:59:01 INFO - "name": "https://queue.taskcluster.net/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 09:59:01 INFO - } 09:59:01 INFO - ], 09:59:01 INFO - "repository": "", 09:59:01 INFO - "rev": "829ed713fa9a047575d96c6943d86031bd78ab9f", 09:59:01 INFO - "who": "cbook@mozilla.com", 09:59:01 INFO - "when": 1453485414, 09:59:01 INFO - "number": 7501782, 09:59:01 INFO - "comments": "Bug 1241294 - \"Update E10S_AUTOSTART_STATUS telemetry probe (and rename it to E10S_STATUS)\". r=felipc a=sylvestre", 09:59:01 INFO - "project": "", 09:59:01 INFO - "at": "Fri 22 Jan 2016 09:56:54", 09:59:01 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:59:01 INFO - "revlink": "", 09:59:01 INFO - "properties": [ 09:59:01 INFO - [ 09:59:01 INFO - "buildid", 09:59:01 INFO - "20160122072128", 09:59:01 INFO - "Change" 09:59:01 INFO - ], 09:59:01 INFO - [ 09:59:01 INFO - "builduid", 09:59:01 INFO - "b5bac9d27c914ec0832868b7f26cf391", 09:59:01 INFO - "Change" 09:59:01 INFO - ], 09:59:01 INFO - [ 09:59:01 INFO - "pgo_build", 09:59:01 INFO - "True", 09:59:01 INFO - "Change" 09:59:01 INFO - ] 09:59:01 INFO - ], 09:59:01 INFO - "revision": "829ed713fa9a047575d96c6943d86031bd78ab9f" 09:59:01 INFO - } 09:59:01 INFO - ], 09:59:01 INFO - "revision": "829ed713fa9a047575d96c6943d86031bd78ab9f" 09:59:01 INFO - } 09:59:01 INFO - } 09:59:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 09:59:01 INFO - Running post-action listener: _resource_record_post_action 09:59:01 INFO - ##### 09:59:01 INFO - ##### Running download-and-extract step. 09:59:01 INFO - ##### 09:59:01 INFO - Running pre-action listener: _resource_record_pre_action 09:59:01 INFO - Running main action method: download_and_extract 09:59:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:01 INFO - https://queue.taskcluster.net/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:59:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/test_packages.json 09:59:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/test_packages.json 09:59:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:59:01 INFO - Downloaded 1302 bytes. 09:59:01 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:59:01 INFO - Using the following test package requirements: 09:59:01 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:59:01 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:59:01 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:59:01 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:59:01 INFO - u'jsshell-linux-x86_64.zip'], 09:59:01 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:59:01 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:59:01 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:59:01 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:59:01 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:59:01 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:59:01 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:59:01 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:59:01 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:59:01 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:59:01 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:59:01 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:59:01 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:01 INFO - https://queue.taskcluster.net/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:59:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:59:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:59:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/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 09:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/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 09:59:03 INFO - Downloaded 23158751 bytes. 09:59:03 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 09:59:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:59:03 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 09:59:04 INFO - Return code: 0 09:59:04 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 09:59:04 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')]} 09:59:04 INFO - https://queue.taskcluster.net/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:59:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:59:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:59:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/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 09:59:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/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 09:59:05 INFO - Downloaded 23158751 bytes. 09:59:05 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 09:59:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:59:05 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 09:59:06 INFO - Return code: 0 09:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:06 INFO - https://queue.taskcluster.net/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:59:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:59:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:59:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/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 09:59:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/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 09:59:07 INFO - Downloaded 11132038 bytes. 09:59:07 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 09:59:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:59:07 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 09:59:07 INFO - Return code: 0 09:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:07 INFO - https://queue.taskcluster.net/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:59:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:59:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:59:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/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 09:59:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dspZIrreQbuDI2eT32GVtA/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 09:59:09 INFO - Downloaded 58011750 bytes. 09:59:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:59:09 INFO - mkdir: /builds/slave/test-pgo/properties 09:59:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:59:09 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:59:09 INFO - Contents: 09:59:09 INFO - build_url:https://queue.taskcluster.net/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:59:09 INFO - Running post-action listener: _resource_record_post_action 09:59:09 INFO - Running post-action listener: set_extra_try_arguments 09:59:09 INFO - ##### 09:59:09 INFO - ##### Running populate-webroot step. 09:59:09 INFO - ##### 09:59:09 INFO - Running pre-action listener: _resource_record_pre_action 09:59:09 INFO - Running main action method: populate_webroot 09:59:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:59:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:59:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:59:09 INFO - '--tppagecycles', 09:59:09 INFO - '7'], 09:59:09 INFO - 'tests': ['tsvgm']}}, 09:59:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:59:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:59:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:59:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:59:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:59:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:59:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:09 INFO - 'talos_options': ['--e10s'], 09:59:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:09 INFO - 'tests': ['damp', 'tps']}, 09:59:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:09 INFO - 'talos_options': ['--e10s'], 09:59:09 INFO - 'tests': ['damp', 'tps']}, 09:59:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:59:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:59:09 INFO - 'other': {'tests': ['a11yr', 09:59:09 INFO - 'ts_paint', 09:59:09 INFO - 'tpaint', 09:59:09 INFO - 'sessionrestore', 09:59:09 INFO - 'sessionrestore_no_auto_restore']}, 09:59:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:59:09 INFO - 'tests': ['a11yr', 09:59:09 INFO - 'ts_paint', 09:59:09 INFO - 'tpaint', 09:59:09 INFO - 'sessionrestore', 09:59:09 INFO - 'sessionrestore_no_auto_restore']}, 09:59:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:59:09 INFO - 'tests': ['a11yr', 09:59:09 INFO - 'ts_paint', 09:59:09 INFO - 'tpaint', 09:59:09 INFO - 'sessionrestore', 09:59:09 INFO - 'sessionrestore_no_auto_restore']}, 09:59:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:59:09 INFO - 'tests': ['a11yr', 09:59:09 INFO - 'ts_paint', 09:59:09 INFO - 'tpaint', 09:59:09 INFO - 'sessionrestore', 09:59:09 INFO - 'sessionrestore_no_auto_restore']}, 09:59:09 INFO - 'other_l64': {'tests': ['a11yr', 09:59:09 INFO - 'ts_paint', 09:59:09 INFO - 'tpaint', 09:59:09 INFO - 'sessionrestore', 09:59:09 INFO - 'sessionrestore_no_auto_restore']}, 09:59:09 INFO - 'other_nol64': {'tests': ['a11yr', 09:59:09 INFO - 'ts_paint', 09:59:09 INFO - 'tpaint', 09:59:09 INFO - 'sessionrestore', 09:59:09 INFO - 'sessionrestore_no_auto_restore']}, 09:59:09 INFO - 'svgr': {'tests': ['tsvgx', 09:59:09 INFO - 'tsvgr_opacity', 09:59:09 INFO - 'tart', 09:59:09 INFO - 'tscrollx', 09:59:09 INFO - 'cart']}, 09:59:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:59:09 INFO - 'tests': ['tsvgx', 09:59:09 INFO - 'tsvgr_opacity', 09:59:09 INFO - 'tart', 09:59:09 INFO - 'tscrollx', 09:59:09 INFO - 'cart']}, 09:59:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:09 INFO - 'tests': ['tp5o']}, 09:59:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:09 INFO - 'talos_options': ['--e10s'], 09:59:09 INFO - 'tests': ['tp5o']}, 09:59:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:09 INFO - 'talos_options': ['--xperf_path', 09:59:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:09 INFO - 'tests': ['tp5n']}, 09:59:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:09 INFO - 'talos_options': ['--e10s', 09:59:09 INFO - '--xperf_path', 09:59:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:09 INFO - 'tests': ['tp5n']}}, 09:59:09 INFO - 'talos.zip': {'path': '', 09:59:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:59:09 INFO - Running post-action listener: _resource_record_post_action 09:59:09 INFO - ##### 09:59:09 INFO - ##### Running create-virtualenv step. 09:59:09 INFO - ##### 09:59:09 INFO - Running pre-action listener: _resource_record_pre_action 09:59:09 INFO - Running main action method: create_virtualenv 09:59:09 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:59:09 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 09:59:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:59:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:59:09 INFO - Using real prefix '/usr' 09:59:09 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:59:09 INFO - Installing distribute.............................................................................................................................................................................................done. 09:59:11 INFO - Installing pip.................done. 09:59:12 INFO - Return code: 0 09:59:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:59:12 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')]} 09:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:12 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')]} 09:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:12 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 0x7fedd17c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2368a50>, '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 0x22d4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d49e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', '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 09:59:12 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 09:59:12 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 09:59:12 INFO - Using env: {'DISPLAY': ':0', 09:59:12 INFO - 'HOME': '/home/cltbld', 09:59:12 INFO - 'LANG': 'en_US.UTF-8', 09:59:12 INFO - 'LANGUAGE': 'en_US:en', 09:59:12 INFO - 'LOGNAME': 'cltbld', 09:59:12 INFO - 'MAIL': '/var/mail/cltbld', 09:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:12 INFO - 'MOZ_NO_REMOTE': '1', 09:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:12 INFO - 'NO_EM_RESTART': '1', 09:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:59:12 INFO - 'PWD': '/builds/slave/test-pgo', 09:59:12 INFO - 'SHELL': '/bin/bash', 09:59:12 INFO - 'SHLVL': '1', 09:59:12 INFO - 'TERM': 'linux', 09:59:12 INFO - 'TMOUT': '86400', 09:59:12 INFO - 'USER': 'cltbld', 09:59:12 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', 09:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:12 INFO - '_': '/tools/buildbot/bin/python'} 09:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:12 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 09:59:12 INFO - Cleaning up... 09:59:12 INFO - Return code: 0 09:59:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:59:12 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')]} 09:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:12 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')]} 09:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:12 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 0x7fedd17c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2368a50>, '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 0x22d4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d49e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', '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 09:59:12 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 09:59:12 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 09:59:12 INFO - Using env: {'DISPLAY': ':0', 09:59:12 INFO - 'HOME': '/home/cltbld', 09:59:12 INFO - 'LANG': 'en_US.UTF-8', 09:59:12 INFO - 'LANGUAGE': 'en_US:en', 09:59:12 INFO - 'LOGNAME': 'cltbld', 09:59:12 INFO - 'MAIL': '/var/mail/cltbld', 09:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:12 INFO - 'MOZ_NO_REMOTE': '1', 09:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:12 INFO - 'NO_EM_RESTART': '1', 09:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:59:12 INFO - 'PWD': '/builds/slave/test-pgo', 09:59:12 INFO - 'SHELL': '/bin/bash', 09:59:12 INFO - 'SHLVL': '1', 09:59:12 INFO - 'TERM': 'linux', 09:59:12 INFO - 'TMOUT': '86400', 09:59:12 INFO - 'USER': 'cltbld', 09:59:12 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', 09:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:12 INFO - '_': '/tools/buildbot/bin/python'} 09:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:12 INFO - Downloading/unpacking psutil>=0.7.1 09:59:12 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 09:59:12 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 09:59:12 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 09:59:12 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 09:59:12 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 09:59:12 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 09:59:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:59:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:14 INFO - Installing collected packages: psutil 09:59:14 INFO - Running setup.py install for psutil 09:59:14 INFO - building 'psutil._psutil_linux' extension 09:59:14 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 09:59:14 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 09:59:14 INFO - building 'psutil._psutil_posix' extension 09:59:14 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 09:59:14 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 09:59:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:14 INFO - Successfully installed psutil 09:59:14 INFO - Cleaning up... 09:59:14 INFO - Return code: 0 09:59:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:14 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 0x7fedd17c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2368a50>, '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 0x22d4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d49e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', '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 09:59:14 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 09:59:14 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 09:59:14 INFO - Using env: {'DISPLAY': ':0', 09:59:14 INFO - 'HOME': '/home/cltbld', 09:59:14 INFO - 'LANG': 'en_US.UTF-8', 09:59:14 INFO - 'LANGUAGE': 'en_US:en', 09:59:14 INFO - 'LOGNAME': 'cltbld', 09:59:14 INFO - 'MAIL': '/var/mail/cltbld', 09:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:14 INFO - 'MOZ_NO_REMOTE': '1', 09:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:14 INFO - 'NO_EM_RESTART': '1', 09:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:59:14 INFO - 'PWD': '/builds/slave/test-pgo', 09:59:14 INFO - 'SHELL': '/bin/bash', 09:59:14 INFO - 'SHLVL': '1', 09:59:14 INFO - 'TERM': 'linux', 09:59:14 INFO - 'TMOUT': '86400', 09:59:14 INFO - 'USER': 'cltbld', 09:59:14 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', 09:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:14 INFO - '_': '/tools/buildbot/bin/python'} 09:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:59:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:59:16 INFO - Installing collected packages: mozsystemmonitor 09:59:16 INFO - Running setup.py install for mozsystemmonitor 09:59:16 INFO - Successfully installed mozsystemmonitor 09:59:16 INFO - Cleaning up... 09:59:16 INFO - Return code: 0 09:59:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:16 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 0x7fedd17c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2368a50>, '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 0x22d4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d49e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', '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 09:59:16 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 09:59:16 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 09:59:17 INFO - Using env: {'DISPLAY': ':0', 09:59:17 INFO - 'HOME': '/home/cltbld', 09:59:17 INFO - 'LANG': 'en_US.UTF-8', 09:59:17 INFO - 'LANGUAGE': 'en_US:en', 09:59:17 INFO - 'LOGNAME': 'cltbld', 09:59:17 INFO - 'MAIL': '/var/mail/cltbld', 09:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:17 INFO - 'MOZ_NO_REMOTE': '1', 09:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:17 INFO - 'NO_EM_RESTART': '1', 09:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:59:17 INFO - 'PWD': '/builds/slave/test-pgo', 09:59:17 INFO - 'SHELL': '/bin/bash', 09:59:17 INFO - 'SHLVL': '1', 09:59:17 INFO - 'TERM': 'linux', 09:59:17 INFO - 'TMOUT': '86400', 09:59:17 INFO - 'USER': 'cltbld', 09:59:17 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', 09:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:17 INFO - '_': '/tools/buildbot/bin/python'} 09:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:17 INFO - Downloading/unpacking blobuploader==1.2.4 09:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:18 INFO - Downloading blobuploader-1.2.4.tar.gz 09:59:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:59:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:59:19 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 09:59:19 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 09:59:19 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 09:59:19 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 09:59:19 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 09:59:19 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 09:59:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:59:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:59:19 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 09:59:19 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 09:59:19 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 09:59:19 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 09:59:19 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 09:59:19 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 09:59:19 INFO - Downloading docopt-0.6.1.tar.gz 09:59:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:59:19 INFO - Installing collected packages: blobuploader, requests, docopt 09:59:19 INFO - Running setup.py install for blobuploader 09:59:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:59:19 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:59:19 INFO - Running setup.py install for requests 09:59:20 INFO - Running setup.py install for docopt 09:59:20 INFO - Successfully installed blobuploader requests docopt 09:59:20 INFO - Cleaning up... 09:59:20 INFO - Return code: 0 09:59:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:59:20 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')]} 09:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:20 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')]} 09:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:20 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 0x7fedd17c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2368a50>, '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 0x22d4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d49e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', '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 09:59:20 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 09:59:20 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 09:59:20 INFO - Using env: {'DISPLAY': ':0', 09:59:20 INFO - 'HOME': '/home/cltbld', 09:59:20 INFO - 'LANG': 'en_US.UTF-8', 09:59:20 INFO - 'LANGUAGE': 'en_US:en', 09:59:20 INFO - 'LOGNAME': 'cltbld', 09:59:20 INFO - 'MAIL': '/var/mail/cltbld', 09:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:20 INFO - 'MOZ_NO_REMOTE': '1', 09:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:20 INFO - 'NO_EM_RESTART': '1', 09:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:59:20 INFO - 'PWD': '/builds/slave/test-pgo', 09:59:20 INFO - 'SHELL': '/bin/bash', 09:59:20 INFO - 'SHLVL': '1', 09:59:20 INFO - 'TERM': 'linux', 09:59:20 INFO - 'TMOUT': '86400', 09:59:20 INFO - 'USER': 'cltbld', 09:59:20 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', 09:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:20 INFO - '_': '/tools/buildbot/bin/python'} 09:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:59:20 INFO - Running setup.py (path:/tmp/pip-0V8Fux-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:59:20 INFO - Running setup.py (path:/tmp/pip-Z9y9P_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:59:20 INFO - Running setup.py (path:/tmp/pip-M0vT9w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:59:20 INFO - Running setup.py (path:/tmp/pip-Fdox1b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:59:20 INFO - Running setup.py (path:/tmp/pip-hahCGM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:59:20 INFO - Running setup.py (path:/tmp/pip-Gm4ZkL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:59:20 INFO - Running setup.py (path:/tmp/pip-3G5y6K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:59:20 INFO - Running setup.py (path:/tmp/pip-wXs4OD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:59:21 INFO - Running setup.py (path:/tmp/pip-Denn47-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:59:21 INFO - Running setup.py (path:/tmp/pip-Lw3_gS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:59:21 INFO - Running setup.py (path:/tmp/pip-WPhMz9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:59:21 INFO - Running setup.py (path:/tmp/pip-6MzHAn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:59:21 INFO - Running setup.py (path:/tmp/pip-zrV0qa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:59:21 INFO - Running setup.py (path:/tmp/pip-FjiYK3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:59:21 INFO - Running setup.py (path:/tmp/pip-NGiPpS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:59:21 INFO - Running setup.py (path:/tmp/pip-bb7fXz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:59:21 INFO - Running setup.py (path:/tmp/pip-6fdWwW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:59:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:59:21 INFO - Running setup.py install for manifestparser 09:59:21 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:59:21 INFO - Running setup.py install for mozcrash 09:59:21 INFO - Running setup.py install for mozdebug 09:59:22 INFO - Running setup.py install for mozdevice 09:59:22 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:59:22 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:59:22 INFO - Running setup.py install for mozfile 09:59:22 INFO - Running setup.py install for mozhttpd 09:59:22 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:59:22 INFO - Running setup.py install for mozinfo 09:59:22 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:59:22 INFO - Running setup.py install for mozInstall 09:59:22 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:59:22 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:59:22 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:59:22 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:59:22 INFO - Running setup.py install for mozleak 09:59:22 INFO - Running setup.py install for mozlog 09:59:22 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:59:22 INFO - Running setup.py install for moznetwork 09:59:22 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:59:22 INFO - Running setup.py install for mozprocess 09:59:22 INFO - Running setup.py install for mozprofile 09:59:23 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:59:23 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:59:23 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:59:23 INFO - Running setup.py install for mozrunner 09:59:23 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:59:23 INFO - Running setup.py install for mozscreenshot 09:59:23 INFO - Running setup.py install for moztest 09:59:23 INFO - Running setup.py install for mozversion 09:59:23 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:59:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:59:23 INFO - Cleaning up... 09:59:23 INFO - Return code: 0 09:59:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:59:23 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')]} 09:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:23 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')]} 09:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:23 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 0x7fedd17c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2368a50>, '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 0x22d4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d49e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', '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 09:59:23 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 09:59:23 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 09:59:23 INFO - Using env: {'DISPLAY': ':0', 09:59:23 INFO - 'HOME': '/home/cltbld', 09:59:23 INFO - 'LANG': 'en_US.UTF-8', 09:59:23 INFO - 'LANGUAGE': 'en_US:en', 09:59:23 INFO - 'LOGNAME': 'cltbld', 09:59:23 INFO - 'MAIL': '/var/mail/cltbld', 09:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:23 INFO - 'MOZ_NO_REMOTE': '1', 09:59:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:23 INFO - 'NO_EM_RESTART': '1', 09:59:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:59:23 INFO - 'PWD': '/builds/slave/test-pgo', 09:59:23 INFO - 'SHELL': '/bin/bash', 09:59:23 INFO - 'SHLVL': '1', 09:59:23 INFO - 'TERM': 'linux', 09:59:23 INFO - 'TMOUT': '86400', 09:59:23 INFO - 'USER': 'cltbld', 09:59:23 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', 09:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:23 INFO - '_': '/tools/buildbot/bin/python'} 09:59:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:59:23 INFO - Running setup.py (path:/tmp/pip-bCrWr1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:59:23 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)) 09:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:59:23 INFO - Running setup.py (path:/tmp/pip-ePNrIj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:59:23 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)) 09:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:59:23 INFO - Running setup.py (path:/tmp/pip-p6jARu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:59:23 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)) 09:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:59:23 INFO - Running setup.py (path:/tmp/pip-loYQ8k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:59:24 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)) 09:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:59:24 INFO - Running setup.py (path:/tmp/pip-Q9vynJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:59:24 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)) 09:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:59:24 INFO - Running setup.py (path:/tmp/pip-CK84aH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:59:24 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)) 09:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:59:24 INFO - Running setup.py (path:/tmp/pip-ewG1lW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:59:24 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)) 09:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:59:24 INFO - Running setup.py (path:/tmp/pip-gocWuA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:59:24 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)) 09:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:59:24 INFO - Running setup.py (path:/tmp/pip-XwWpsn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:59:24 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)) 09:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:59:24 INFO - Running setup.py (path:/tmp/pip-xy4Rjh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:59:24 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)) 09:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:59:24 INFO - Running setup.py (path:/tmp/pip-cnuHv2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:59:24 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)) 09:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:59:24 INFO - Running setup.py (path:/tmp/pip-ovyYAg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:59:24 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)) 09:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:59:24 INFO - Running setup.py (path:/tmp/pip-Yo0XKp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:59:24 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)) 09:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:59:24 INFO - Running setup.py (path:/tmp/pip-U3jNRu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:59:24 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)) 09:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:59:24 INFO - Running setup.py (path:/tmp/pip-Q7Xjm4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:59:24 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)) 09:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:59:24 INFO - Running setup.py (path:/tmp/pip-QJ4NIp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:59:24 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)) 09:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:59:24 INFO - Running setup.py (path:/tmp/pip-qu6Lew-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:59:24 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)) 09:59:24 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)) 09:59:24 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)) 09:59:24 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)) 09:59:24 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)) 09:59:24 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)) 09:59:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:59:24 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 09:59:24 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 09:59:24 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 09:59:24 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 09:59:24 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 09:59:24 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 09:59:26 INFO - Downloading blessings-1.6.tar.gz 09:59:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:59:26 INFO - Installing collected packages: blessings 09:59:26 INFO - Running setup.py install for blessings 09:59:26 INFO - Successfully installed blessings 09:59:26 INFO - Cleaning up... 09:59:26 INFO - Return code: 0 09:59:26 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:59:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:59:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:59:27 INFO - Reading from file tmpfile_stdout 09:59:27 INFO - Current package versions: 09:59:27 INFO - argparse == 1.2.1 09:59:27 INFO - blessings == 1.6 09:59:27 INFO - blobuploader == 1.2.4 09:59:27 INFO - docopt == 0.6.1 09:59:27 INFO - manifestparser == 1.1 09:59:27 INFO - mozInstall == 1.12 09:59:27 INFO - mozcrash == 0.16 09:59:27 INFO - mozdebug == 0.1 09:59:27 INFO - mozdevice == 0.47 09:59:27 INFO - mozfile == 1.2 09:59:27 INFO - mozhttpd == 0.7 09:59:27 INFO - mozinfo == 0.9 09:59:27 INFO - mozleak == 0.1 09:59:27 INFO - mozlog == 3.1 09:59:27 INFO - moznetwork == 0.27 09:59:27 INFO - mozprocess == 0.22 09:59:27 INFO - mozprofile == 0.27 09:59:27 INFO - mozrunner == 6.11 09:59:27 INFO - mozscreenshot == 0.1 09:59:27 INFO - mozsystemmonitor == 0.0 09:59:27 INFO - moztest == 0.7 09:59:27 INFO - mozversion == 1.4 09:59:27 INFO - psutil == 3.1.1 09:59:27 INFO - requests == 1.2.3 09:59:27 INFO - wsgiref == 0.1.2 09:59:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:27 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 0x7fedd17c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2368a50>, '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 0x22d4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d49e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', '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 09:59:27 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 09:59:27 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 09:59:27 INFO - Using env: {'DISPLAY': ':0', 09:59:27 INFO - 'HOME': '/home/cltbld', 09:59:27 INFO - 'LANG': 'en_US.UTF-8', 09:59:27 INFO - 'LANGUAGE': 'en_US:en', 09:59:27 INFO - 'LOGNAME': 'cltbld', 09:59:27 INFO - 'MAIL': '/var/mail/cltbld', 09:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:27 INFO - 'MOZ_NO_REMOTE': '1', 09:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:27 INFO - 'NO_EM_RESTART': '1', 09:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:59:27 INFO - 'PWD': '/builds/slave/test-pgo', 09:59:27 INFO - 'SHELL': '/bin/bash', 09:59:27 INFO - 'SHLVL': '1', 09:59:27 INFO - 'TERM': 'linux', 09:59:27 INFO - 'TMOUT': '86400', 09:59:27 INFO - 'USER': 'cltbld', 09:59:27 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', 09:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:27 INFO - '_': '/tools/buildbot/bin/python'} 09:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:27 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)) 09:59:27 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)) 09:59:27 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)) 09:59:27 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)) 09:59:27 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)) 09:59:27 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)) 09:59:27 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)) 09:59:27 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)) 09:59:27 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)) 09:59:27 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)) 09:59:27 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)) 09:59:27 INFO - Cleaning up... 09:59:27 INFO - Return code: 0 09:59:27 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedd17c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2368a50>, '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 0x22d4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d49e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', '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 09:59:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:59:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:59:27 INFO - Using env: {'DISPLAY': ':0', 09:59:27 INFO - 'HOME': '/home/cltbld', 09:59:27 INFO - 'LANG': 'en_US.UTF-8', 09:59:27 INFO - 'LANGUAGE': 'en_US:en', 09:59:27 INFO - 'LOGNAME': 'cltbld', 09:59:27 INFO - 'MAIL': '/var/mail/cltbld', 09:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:27 INFO - 'MOZ_NO_REMOTE': '1', 09:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:27 INFO - 'NO_EM_RESTART': '1', 09:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:59:27 INFO - 'PWD': '/builds/slave/test-pgo', 09:59:27 INFO - 'SHELL': '/bin/bash', 09:59:27 INFO - 'SHLVL': '1', 09:59:27 INFO - 'TERM': 'linux', 09:59:27 INFO - 'TMOUT': '86400', 09:59:27 INFO - 'USER': 'cltbld', 09:59:27 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', 09:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:27 INFO - '_': '/tools/buildbot/bin/python'} 09:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:27 INFO - Downloading/unpacking jsonschema 09:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:59:29 INFO - Downloading/unpacking functools32 (from jsonschema) 09:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:29 INFO - Downloading functools32-3.2.3-2.tar.gz 09:59:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:59:29 INFO - warning: no files found matching '*.txt' 09:59:29 INFO - no previously-included directories found matching 'build' 09:59:29 INFO - no previously-included directories found matching 'dist' 09:59:29 INFO - no previously-included directories found matching '.git*' 09:59:29 INFO - Installing collected packages: jsonschema, functools32 09:59:29 INFO - Running setup.py install for functools32 09:59:29 INFO - warning: no files found matching '*.txt' 09:59:29 INFO - no previously-included directories found matching 'build' 09:59:29 INFO - no previously-included directories found matching 'dist' 09:59:29 INFO - no previously-included directories found matching '.git*' 09:59:29 INFO - Successfully installed jsonschema functools32 09:59:29 INFO - Cleaning up... 09:59:29 INFO - Return code: 0 09:59:29 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedd17c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2368a50>, '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 0x22d4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d49e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', '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 09:59:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:59:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:59:29 INFO - Using env: {'DISPLAY': ':0', 09:59:29 INFO - 'HOME': '/home/cltbld', 09:59:29 INFO - 'LANG': 'en_US.UTF-8', 09:59:29 INFO - 'LANGUAGE': 'en_US:en', 09:59:29 INFO - 'LOGNAME': 'cltbld', 09:59:29 INFO - 'MAIL': '/var/mail/cltbld', 09:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:29 INFO - 'MOZ_NO_REMOTE': '1', 09:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:29 INFO - 'NO_EM_RESTART': '1', 09:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:59:29 INFO - 'PWD': '/builds/slave/test-pgo', 09:59:29 INFO - 'SHELL': '/bin/bash', 09:59:29 INFO - 'SHLVL': '1', 09:59:29 INFO - 'TERM': 'linux', 09:59:29 INFO - 'TMOUT': '86400', 09:59:29 INFO - 'USER': 'cltbld', 09:59:29 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', 09:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:29 INFO - '_': '/tools/buildbot/bin/python'} 09:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:30 INFO - Downloading/unpacking flake8 09:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:59:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:59:31 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 09:59:31 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 09:59:31 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 09:59:31 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 09:59:31 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 09:59:31 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 09:59:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:59:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:59:31 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 09:59:31 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 09:59:31 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 09:59:31 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 09:59:31 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 09:59:31 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 09:59:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:59:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:59:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:59:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:59:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:59:32 INFO - no previously-included directories found matching 'docs/_build' 09:59:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:59:32 INFO - Running setup.py install for pep8 09:59:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:59:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:59:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:59:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:59:32 INFO - no previously-included directories found matching 'docs/_build' 09:59:32 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:59:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:59:32 INFO - Cleaning up... 09:59:32 INFO - Return code: 0 09:59:32 INFO - Running post-action listener: _resource_record_post_action 09:59:32 INFO - Running post-action listener: _start_resource_monitoring 09:59:32 INFO - Starting resource monitoring. 09:59:32 INFO - ##### 09:59:32 INFO - ##### Running install step. 09:59:32 INFO - ##### 09:59:32 INFO - Running pre-action listener: _resource_record_pre_action 09:59:32 INFO - Running main action method: install 09:59:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:59:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:59:32 INFO - Reading from file tmpfile_stdout 09:59:32 INFO - Detecting whether we're running mozinstall >=1.0... 09:59:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:59:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:59:33 INFO - Reading from file tmpfile_stdout 09:59:33 INFO - Output received: 09:59:33 INFO - Usage: mozinstall [options] installer 09:59:33 INFO - Options: 09:59:33 INFO - -h, --help show this help message and exit 09:59:33 INFO - -d DEST, --destination=DEST 09:59:33 INFO - Directory to install application into. [default: 09:59:33 INFO - "/builds/slave/test-pgo"] 09:59:33 INFO - --app=APP Application being installed. [default: firefox] 09:59:33 INFO - mkdir: /builds/slave/test-pgo/build/application 09:59:33 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'] 09:59:33 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 09:59:47 INFO - Reading from file tmpfile_stdout 09:59:47 INFO - Output received: 09:59:47 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:59:47 INFO - Running post-action listener: _resource_record_post_action 09:59:47 INFO - ##### 09:59:47 INFO - ##### Running run-tests step. 09:59:47 INFO - ##### 09:59:47 INFO - Running pre-action listener: _resource_record_pre_action 09:59:47 INFO - Running main action method: run_tests 09:59:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:59:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:59:47 INFO - Python 2.7.3 09:59:47 INFO - Return code: 0 09:59:47 INFO - grabbing minidump binary from tooltool 09:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:47 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 0x2368a50>, '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 0x22d4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d49e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:59:47 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 09:59:47 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 09:59:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:59:47 INFO - Return code: 0 09:59:47 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:59:47 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:59:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:59:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:59:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:59:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:59:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:59:48 INFO - Return code: 0 09:59:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:59:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost 09:59:48 INFO - Using env: {'DISPLAY': ':0', 09:59:48 INFO - 'HOME': '/home/cltbld', 09:59:48 INFO - 'LANG': 'en_US.UTF-8', 09:59:48 INFO - 'LANGUAGE': 'en_US:en', 09:59:48 INFO - 'LOGNAME': 'cltbld', 09:59:48 INFO - 'MAIL': '/var/mail/cltbld', 09:59:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:59:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:48 INFO - 'MOZ_NO_REMOTE': '1', 09:59:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:48 INFO - 'NO_EM_RESTART': '1', 09:59:48 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:59:48 INFO - 'PWD': '/builds/slave/test-pgo', 09:59:48 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:59:48 INFO - 'SHELL': '/bin/bash', 09:59:48 INFO - 'SHLVL': '1', 09:59:48 INFO - 'TERM': 'linux', 09:59:48 INFO - 'TMOUT': '86400', 09:59:48 INFO - 'USER': 'cltbld', 09:59:48 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310', 09:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:48 INFO - '_': '/tools/buildbot/bin/python'} 09:59:48 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] with output_timeout 3600 09:59:48 INFO - mozversion INFO | application_buildid: 20160122072128 09:59:48 INFO - mozversion INFO | application_changeset: 829ed713fa9a047575d96c6943d86031bd78ab9f 09:59:48 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 09:59:48 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:59:48 INFO - mozversion INFO | application_name: Firefox 09:59:48 INFO - mozversion INFO | application_remotingname: firefox-dev 09:59:48 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:59:48 INFO - mozversion INFO | application_vendor: Mozilla 09:59:48 INFO - mozversion INFO | application_version: 45.0a2 09:59:48 INFO - mozversion INFO | platform_buildid: 20160122072128 09:59:48 INFO - mozversion INFO | platform_changeset: 829ed713fa9a047575d96c6943d86031bd78ab9f 09:59:48 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:59:48 INFO - mozversion INFO | platform_version: 45.0a2 09:59:48 INFO - 2016-01-22 09:59:48,944 DEBUG : using testdate: 1453485588 09:59:48 INFO - 2016-01-22 09:59:48,944 DEBUG : actual date: 1453485588 09:59:48 INFO - 2016-01-22 09:59:48,991 INFO : starting webserver on 'localhost:54280' 09:59:48 INFO - 2016-01-22 09:59:48,992 INFO : Starting test suite talos-linux64-ix-055.e 09:59:48 INFO - 2016-01-22 09:59:48,992 INFO : Starting test dromaeo_css 09:59:48 INFO - 2016-01-22 09:59:48,992 DEBUG : operating with platform_type : linux_ 09:59:48 INFO - 2016-01-22 09:59:48,993 INFO : Initialising browser for dromaeo_css test... 09:59:49 INFO - 2016-01-22 09:59:49,007 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJOp27O/profile http://localhost:54280/getInfo.html 09:59:52 INFO - 2016-01-22 09:59:52,304 DEBUG : BROWSER_OUTPUT: 09:59:52 INFO - 2016-01-22 09:59:52,304 DEBUG : BROWSER_OUTPUT: (process:18666): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:59:53 INFO - 2016-01-22 09:59:53,227 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:59:53 INFO - 2016-01-22 09:59:53,227 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:59:53 INFO - 2016-01-22 09:59:53,227 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:59:53 INFO - 2016-01-22 09:59:53,227 DEBUG : BROWSER_OUTPUT: __metrics 09:59:54 INFO - 2016-01-22 09:59:54,197 INFO : Browser initialized. 09:59:54 INFO - 2016-01-22 09:59:54,198 INFO : Running cycle 1/1 for dromaeo_css test... 09:59:54 INFO - 2016-01-22 09:59:54,198 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJOp27O/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:59:55 INFO - 2016-01-22 09:59:55,500 DEBUG : BROWSER_OUTPUT: 09:59:55 INFO - 2016-01-22 09:59:55,500 DEBUG : BROWSER_OUTPUT: (process:18784): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:00:06 INFO - 2016-01-22 10:00:06,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 135475200 10:00:06 INFO - 2016-01-22 10:00:06,007 DEBUG : BROWSER_OUTPUT: 10:00:55 INFO - 2016-01-22 10:00:55,617 DEBUG : BROWSER_OUTPUT: 1453485655613 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] 10:03:03 INFO - 2016-01-22 10:03:03,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54280/tests/dromaeo/cssquery-ext.html) 10:03:04 INFO - 2016-01-22 10:03:04,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 141135872 10:03:04 INFO - 2016-01-22 10:03:04,466 DEBUG : BROWSER_OUTPUT: 10:06:06 INFO - 2016-01-22 10:06:06,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/dromaeo/cssquery-ext.html (next: http://localhost:54280/tests/dromaeo/cssquery-jquery.html) 10:06:06 INFO - 2016-01-22 10:06:06,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 138956800 10:06:06 INFO - 2016-01-22 10:06:06,828 DEBUG : BROWSER_OUTPUT: 10:09:08 INFO - 2016-01-22 10:09:08,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54280/tests/dromaeo/cssquery-mootools.html) 10:09:09 INFO - 2016-01-22 10:09:09,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 139882496 10:09:09 INFO - 2016-01-22 10:09:09,040 DEBUG : BROWSER_OUTPUT: 10:12:10 INFO - 2016-01-22 10:12:10,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54280/tests/dromaeo/cssquery-prototype.html) 10:12:11 INFO - 2016-01-22 10:12:11,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 140001280 10:12:11 INFO - 2016-01-22 10:12:11,207 DEBUG : BROWSER_OUTPUT: 10:15:13 INFO - 2016-01-22 10:15:13,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54280/tests/dromaeo/cssquery-yui.html) 10:15:13 INFO - 2016-01-22 10:15:13,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 138657792 10:15:13 INFO - 2016-01-22 10:15:13,991 DEBUG : BROWSER_OUTPUT: 10:18:15 INFO - 2016-01-22 10:18:15,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/dromaeo/cssquery-yui.html (next: http://localhost:54280/tests/dromaeo/cssquery-dojo.html) 10:18:16 INFO - 2016-01-22 10:18:16,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 142024704 10:18:16 INFO - 2016-01-22 10:18:16,213 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2016-01-22 10:18:16,213 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:18:16 INFO - 2016-01-22 10:18:16,213 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:18:16 INFO - 2016-01-22 10:18:16,214 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:18:16 INFO - 2016-01-22 10:18:16,214 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:18:16 INFO - 2016-01-22 10:18:16,215 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3317.9004629861106;3338.9666103338973;3342.9331413371747;3365.579302587176;3375.071855239809;5428.972855135724;5462.69955152467;5471.50756431921;5477.397486276506;5481.616286859921;5385.976664433755;5472.50747432731;5485.890282194364;5486.588505862066;5487.917681234785;4925.162722337212;4994.650374473788;5021.899562008776;5087.923681144785;5106.821261255838;4893.461719210902;4967.726775027372;5063.01271252106;5063.518965698253;5106.310648062501;4998.350214472113;5065.189569668853;5071.264666623338;5071.797128114871;5072;5100;5132.640715149941;5148.613853960968;5160.458151894072;5160.690358578459;4855.5387238212315;4927.975360123177;4942.950570494285;4962.776675049631;5069.188929771219;5260.92108618371;5307.177387504904;5307.575393968512;5353.464653534655;5366.168243922199;5905.4094590541035;5909.674967876765;5935.139404786281;5943.3165186003735;5966.850828729273;5764.308283006024;5853.09277062056;5880.441358070976;5885.941140588582;5937.198478205431;5489;5578.107502799533;5578.135389014668;5585.329760428734;5621.353544342372;5961.791337303173;5975.910361344583;5994.400559944058;6000.459958603747;6008.489278411296;5609.1305847593685;5717.685527295956;5796.3913789052385;5821.854453638608;5855.473007429352;5957.523398128226;5972.552058595623;5989.760409583568;6013.789517366871;6015.639061656227;5929.940700593025;5961.642301461926;5977.940220597825;5986.161937328778;5992.490638295793;5671.404502527258;5735.3977832327;5781.046127389018;5869.64782113066;5984.910226346608;4537.319402089713;4556.589906908394;4559;4565.474970378449;4583.152116858392;4101.056756945919;4110.794460277034;4113.938290925638;4119.773412462283;4134.090500089976;5447.727613619303;5547.278853749068;5570.97214513933;5632.8028519002455;5701.828945131652;5964.463198312173;5973.074173503114;6015.007523758618;6018.247719035121;6020.217371741645;5438.129899216106;5681.829545113653;5691.573132015115;5692.9146062809095;5706.172604972338;5033.798648054037;5071.644984851025;5086.109930762102;5089.592832573385;5139.229115632685;6066.059760737093;6097.786577469856;6102.237220347457;6110.144579758838;6115.052166914135;5767.048437007847;5811.186433899342;5970.611910225822;5972.223610930551;5980.820575382745;6082.2093127893095;6153.538484613582;6183.474404675473;6192.783252586138;6197.628142311476;5865.736041878211;5902.203202567598;5905.35041145465;5921.111833225051;5933.228680271537;5718.1708652246025;5847.38602446737;5866.853328666817;6009.819705408845;6021.217241758543;5846.883062338644;5912.73392697321;5925.792597259076;5937.228160339128;5946.43508866657;5913.172155898092;5920.230370052038;5933.614315069507;5946.643201407929;5953.732082056231;5550.666959982414;5641.971790141187;5653.462921022497;5767.68277744728;5841.386654401396;5758.1362795581;5790.334111577223;5821.476067153976;5840.153177789111;5851.64890106595;5683.147527870852;5688.5733569981585;5701.372848986525;5729.885402291848;5730.484256416942 10:18:16 INFO - 2016-01-22 10:18:16,215 DEBUG : BROWSER_OUTPUT: |1;ext.html;570.8829689913568;597.3488897102158;602.075813626084;611.8898598252314;671.3085521912429;28680.42639147216;29490;41090.79454602727;41166;41635.58364416355;44654.10691786162;44900.77549612247;45253.77373113138;45304.546954530444;45342.546574534244;9088.95455522723;9300.674476393327;9314.115159059878;9323.860142097874;9328.253739700807;8974.775630609254;9076.909230907673;9098.363114581982;9104.089591040876;9107.36248462608;9142.542872856364;9146.542672866364;9213.03263157369;9235.492047937361;9242.30682698797;9141.085891410872;9213.032631573655;9215.354925155276;9244.352895297332;9247.398919070272;9057.728268151966;9226.123518265822;9255.398399104037;9264.58309376073;9269.814603707955;42057;42074.78962605167;42419.363709544385;42599.57400425987;42844;3391.6099648540485;3470.340635279289;4026.8187931543152;4184.849166479243;4316.978415107905;31759.682403176135;31860.362792744014;32188.517172242435;32302.353952921047;32420.513692294633;4078.2455245779624;4127.607877251657;4167.249895018896;4180.289350810339;4237.216115018731;279629;280202;280596;281227;480307.9999999965;64761.08575114131;64889;65029.34970650328;65370;65422.67288663622;69464.6526767373;69697.65151174313;69750.65124674344;69912.65043674748;69932.65033674799;17638.559036024202;17816.643667126584;17895;17904.820951790574;17936.91031544834;12910;13205.273709946045;13213.801792973112;13230.867691322963;13334.19994800315;21918;22191;22194.334169974925;22244.77755222427;22261.888690556443;8037.557934313669;8270.710525131592;8344.039150799557;8371.58142092893;8377.874331885027;1068.3643232276784;1082.7401423658266;1175;1190.7916114679897;1198.4726720243066;28634.284142896176;29324;29372.559411608843;29794.55308170379;33061;1072.3137192196843;1072.5120070367964;1080.8432777247256;1083.8590983172137;1165.6969188011008;14481.131132131895;14698.485553005594;14753.598408151209;14803.92598037003;14946.626334341729;402537;753877;769073;819222.7116593256;842868;59382.70308648429;60201.69899150476;60466;60481.69759151176;60483.69758151181;1450.8186476690414;1454.6363409147714;1462.393106860641;1478.4086365453904;1479.859413355751;30186;30362.240943976576;30800.333803571993;31515.896943606862;31530.211744705648;48740.512594875014;49659;49763.253551197486;49779.253311201086;49913.500864990885;305540;308347;308832;309479;309530;33725.49411758777;33835.15412114717;34089;34198;34204.31591368109;44574.77712611416;44652;45885.77057114693;52651.73674131605;54419;38972.6102738969;39199.608003919595;39406.40890386589;39432.40851387289;39456.40815387714;38423.23153536858;38763.612363876004;38796.2240755189;38832.6116738829;39057.609423906535;37852.81073594614;38404.80797595994;38531.42202866903;38595.22809543737;38624.613753863225;36633.45049824201;38264.23471530498;38276.80861595674;39455.60544394519;39462.80268598639;26563;27257.31856703598;27336.72663273342;27371.178864634094;27454.725452745217 10:18:16 INFO - 2016-01-22 10:18:16,218 DEBUG : BROWSER_OUTPUT: |2;jquery.html;367.69297636473544;368.25061000863246;369.9482072509851;370.86092715231786;372.2313422781956;15641.217939103028;17506.474805755817;17841.553961150978;18749.062546872654;19212.807871921275;17198.74201886973;17382.913085434557;17438.38965636203;17750.28998840048;17898.64202715945;5511.145772405273;5690.9146362804595;5692;5694.402087780765;5701.885962280752;5140.8971820563565;5234.031704134728;5252.501012403815;5272.894542109156;5645.576581756364;5199.740012999354;5206.427292997767;5227.4511176326505;5236.581073514109;5481.479259470364;5510.669359838423;5545.00189965806;5550.91673624896;5551.333839939233;5562.193481945115;5311.362636483608;5340.25236466895;5345.278387417727;5364.785408583652;5521.834344969658;11960.70098247542;12240.081993850497;12260.570880019157;12315.630531084082;21505.784942150534;2074.5539708962647;2110.1453911166004;2120.5122821751083;2192.1450634252656;2367.91712290069;8606.44058136219;8622.180892815173;8774.64901403943;8900.465972041633;8922.866157007586;1866.150901339887;1913.272956276606;1913.9808601913942;1970.931017414398;2013.4362378534033;61128;63199;63280.68359658172;63973;64175.67912160456;10619.84070238947;10644.308119972176;10663.946680266548;10682.893171068345;10789.352638841538;13643.113197642122;13722.245276509688;13771.862281377058;13776.93111534436;13825.032247742562;7794.181610930884;7819.3744500439825;7826.334761545332;8041.517508949481;8192.590370481452;7526.661300241502;7532.510386824948;7603.695852165852;7636.160022397532;7668.233176682287;4477.1493416250805;4554.407926969539;4589.426321709786;4602.286645569942;4610.74640894754;1769.5222289981632;1773.3970450047045;1779.1371184975276;1888.7261347104593;1898.3450709505198;909.8089401225684;917.7246825952187;1008.0675375277839;1008.5511947183579;1013.366645846346;15977.840221597868;16595.751063734053;16746.6650666986;16827.495175144766;17600.20799064045;870.9825803483894;927.8840144981878;1022.1567207054061;1041.5677493839971;1094.141099237095;9230.215431688383;9428.38715483505;9507.952460237793;9564.426134431957;9702.951485242529;644291;645615;652370;660685;672332;86320.56839715887;88222.55888720516;88326.55836720775;88525.55737221273;88788.5560572193;1223.253815172744;1230.975380492403;1294.2752058847075;1314.3493970484672;1333;15019;15044.473443429428;15073.924630377216;15269.160196189316;15423.922880385526;32823.507647385784;32925.50611740874;33877;34090.82954585211;34465.48301775425;47967;48783.26825097697;49549.75225123851;50181.74909125431;54138.72930635322;9156.175944165057;9485.146336829719;9530;9559.996200398858;9580.904190958001;11012.339259644446;17490.562735931704;17816.732749008515;17819.554511137325;17920.193591288684;14889.329980150702;15032.323545440262;15103.697926041637;15138.394464221308;15354.769678454608;14836.698012968845;14919.627009324853;15457.768133478232;15688.372465101269;16140.67718645644;15149;15361.462348817739;15519.146446945526;15544.06735595868;15596.688066238385;9102.362834601514;9264.72205833826;9437.575309111244;9458.385204961656;13794.172349659053;16519.256633451285;16613.58466038359;16846;17004.914975425043;17073.14634268257 10:18:16 INFO - 2016-01-22 10:18:16,218 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1530.63264816444;1546.7061258360911;1721.8278172182775;1796.2635319518995;1833.8355144483248;7787.338076263517;8076.555789431579;8079.91920080799;8168.999999999993;8439.32485401168;7990.081140668824;8048.758537243877;8074.111847696749;8095.91904080959;8133.308668763162;2249.2914731859496;2272.4432514034083;2274.7725227477285;2286.7713228677167;2292.610256256432;2264.230161745006;2265.8074063704603;2266.150193677371;2282.189822612965;2295.345826439465;2254.49273913369;2270.0238897274166;2314.9884250578725;2315.2475445480204;2316.3051084674617;2246.8876556172127;2255.537614788964;2278.715160604924;2290.3586995641163;2292.6904867842795;2277.0436416705024;2306.054517647773;2314.4908120213527;2316.0388438797877;2322.3729593009793;8021.919780802175;8242.052164001097;8242.381821363362;8249.257566819015;8262.586870656443;4808.302796094582;4871.4397844248015;4891.070696567676;4915.631327650405;4932.556069953685;3035.301880567482;3038.346755447589;3058.541218817173;3096.055703010581;3120.7659425543175;939.8073394954018;981.5828272983953;993.0169132558715;1001.8397056471002;1044.9634262800841;11499.080073594092;11573.421328933604;11579;11581.594644187497;11582.073434125334;4077.2864748668862;4116.073883376276;4120.134771697977;4163.250614889349;4287.699861009762;9121.543922803834;9142.908570914338;9144.542772861463;9145.679901203426;9150.22223111043;4927.630427717864;4936.777844996984;4936.876578085505;4950.183219768698;4952.8761780955765;4455.131249406335;4460.933086003713;4462.174497717932;4475.910481790411;4511.954880451219;3547.52108465359;3553;3557.0573797943566;3589.2642008388216;3592.407252803258;1015.9796804063877;1025.707673313102;1030.258214085857;1048.6801525534634;1050.1231471721046;1041.3907863899703;1048.4705223862054;1102.2780079048237;1210.4976434779644;1332.4803326702595;7515.135759387631;7565.773026809205;7590.051243594551;7617.923820761832;7645.4648174628355;1118.9384583847805;1119.3567416705027;1139.4815359011795;1176.847009888709;1183.1185766603935;5985.371535988658;6000.579959402888;6046.909296360558;6047.183630209865;6063.969680151571;9976.950115249378;10100.797984040424;10197.847032294521;10206.132478739242;10320.638777642747;9974.301798874154;10029.04724051214;10047;10097.596096156218;10124.443155626364;7926.405519586054;7963.960180199062;7983.441159118922;8008.599570021592;8021.077576078709;7334.376577990931;7383.630818459163;7388.815279617837;7390.889136663062;7415.406767458699;8827.16141966512;9017.188453039258;9078.137576930181;9136.49749263797;9160;8304.086550479322;8516.190961858614;9198.310126740387;9243.306751993761;9257.768555786159;7367.373773229336;7463.477556570988;7463.701451941862;7470.813229669302;7496.287852653989;7625.847483050419;7859.764207073797;7966.28303452692;7978.521288722695;8004.799880003046;6997.4052205561065;7461.291177338144;7469.7385591504035;7536.472446928662;7601.847963040819;7251.927480725336;7345.412367010733;7362.3373896349585;7459.328660420588;7492.7752167435065;7256;7283.781486555412;7300.707971681286;7309.342159205697;7335.1197856257595;6329.5252856036905;6548.3124271952665;6554.180727409074;6557.704903279268;6602.240742314503;6574.145361103026;6577;6604.603723776589;6618.63597502142;6621.106150669598 10:18:16 INFO - 2016-01-22 10:18:16,219 DEBUG : BROWSER_OUTPUT: |4;prototype.html;341.07228338918145;346.82138698570225;352.79890462436424;352.9805860677662;354.4169840612193;6346.2067241594805;6354.396332348431;6504.1869766279215;6541.443977261938;6542.051402546628;6270.49836013119;6378.521610879179;6385.425311721944;6392.6484043377595;6398.2322121345505;4738.2418812989845;4760.928586071212;4779.426468823746;4788.11419887322;4824.396950381202;4822.9035419291595;4835.371401717789;4846.0550192712435;4853.563179313861;4858.757062146896;4737.786799594027;4806.182948898678;4810.4948980357085;4827.927581086286;4830.203016502291;4800.4719480857075;4820.132376172305;4837.153498137829;4837.612990960714;4849.612031037508;4162.771047592381;4195.91608167838;4206.348016057516;4221.07136429988;4224.1129362833535;6021.6989150542295;6077.483413909823;6091.9390806091815;6119.571629985903;6123.84690382744;5597.748101335409;5614.578906582023;5617.101263797773;5624.29696287964;5639.210510528529;6763.086983257295;6763.966180169117;6764.0530325754435;6773.6613169341335;6777.390034896834;4648.5119062498625;4650.348951146842;4656.371389862393;4660.37084993525;4668.066386722669;6958;7001.404880585156;7065.43476521877;7071.1868135164605;7076.469264805109;4788.473267940523;4792.137415265216;4794.5924596408995;4796.896713755786;4804.759762011886;4838.467768545457;4868.683535570177;4872.220444728827;4876.512348765095;4877.073356062408;5501.477359650827;5614.326280846324;5617.691026993554;5639.379668236491;5646.378898321182;6818.045473633695;6848.520603557703;6855.6572171391235;6859.622720750307;6874.243833178346;1670.9331626735038;1680.7226807576858;1687.7552754850724;1689.81412044675;1695.3218712515093;1152.2683096233952;1164.598213616301;1165.1028707894873;1165.889240522149;1176.335370515656;6523.902141467882;6538.117354157223;6546.803595892131;6555.049517819984;6570.211574611078;7007.754728584577;7008.26413226614;7011.088558487364;7021.648917554102;7037.683304251321;6425.903611445832;6516.380943810331;6530.608163510205;6546.149000629887;6557.377049180321;3795.6394142556965;3823.923521529554;3825.6748176405317;3827.3493506103473;3828.0429892526868;7236.384907282834;7257.92742072583;7262.31008054234;7268.055152830098;7269.273072692688;7067;7166.6025125100105;7174.1032370953635;7198.676059577227;7229.024081749002;7210.351068403869;7224.638768061576;7242;7256.528325658815;7268.491205615662;6997.05539752127;7018.508704390643;7021.087258656342;7033.824154396181;7036.542624729376;6877.3810357068105;6924.203716572659;6933.89599156003;7050.929490705027;7131.679074441767;7454.105507339154;7457.92542074594;7460.626968651437;7462.843259294818;7467.477276590586;4732.077244937204;4734.07685501324;4742.051589682008;4747.525247475225;4751.83368582098;7067.787966361017;7067.929320706727;7139.393151581966;7192.31672991065;7213.747518836815;6962.268961758942;6969.616671083139;6988.05661235747;7011.929880701127;7013.824654383681;6965.547239429421;6968.7212511501;6975.372216500539;6981.930180698331;6986.825329366807;6683.164604424447;6834.9316506836285;6852;6889.965550172217;6901.378875901193;7008.7546935857;7013.964930175316;7021.859562808818;7023.157221133497;7065.964670176616;6627.271000189879;6789.864202716017;6817.420519255918;6840.55536390153;6844.8288792778585 10:18:16 INFO - 2016-01-22 10:18:16,220 DEBUG : BROWSER_OUTPUT: |5;yui.html;737.7233537423466;848.7750746052295;851.1488511488516;925.3846192282133;951.5455180719309;13168.407421666025;13507.932460337684;13575.592732218025;13577.389017494212;13582.185068895873;13973.301334933263;14100.64748381291;14116.435342586285;14122.43510259591;14148.080374775633;904.8280826642949;916.079340263038;921.8110287391103;947.5641205045687;949.5537097564134;929.0987741890356;931.3666706639483;934.0239449775002;937.1331518345503;945.9905400945971;953.3040880157489;972.9221662267001;975.4488713876673;975.8877729061143;984.8916619171886;966.830804609194;969.2294625772528;970.2238209432426;972.6449845806266;973.5862258540163;711.9750808721722;717.4296434334716;718.6334969165711;720.3588805962697;723.8624661314334;14797.556073317817;14797.92601036988;14807.851921480755;14830.555083347517;14867.70264594702;13250.337483125804;13344;13402.664933376744;13488;13805.240711760849;10956.28784129037;11021.228514004022;11062.668119956414;11152.553897844076;11344.092472602171;3760.172761992357;3789.0906182516273;3791.6966642668795;3796.6962642988497;3815.065308999313;49678.7516062421;49979;50056.49943500591;50181.24728129081;50325.24512132321;10400.635977740743;10412.68761937143;10450.581976720998;10518.368897866;10661.253712240068;19942.90028549848;20047.198112075646;20168.29410970609;20398.388048358574;20457.79542204559;8615.22462978335;8717.259032982267;8762.430442021248;8769.254613357809;8782.121787821294;4896.317083467838;4978.178600530872;4988.226824842155;4994.750262486861;5007.073691367109;3104.472239719253;3153.542736303269;3156.447621666199;3160.5891234139413;3166.509191075387;564.9180868774005;571.223136534313;571.8170185540587;571.911353740171;576.968266745333;690.7237105157876;712.1098626716604;721.5201890742702;730.302561054192;737.2701025984237;8562.52906090171;8794.956025219833;8892.110788921185;8904.055075808796;8984.8652270216;553.2144355015806;665.2216906219735;717.2934659360526;733.2008111158863;752.6199269368933;4057.269691455507;4102.159057393227;4178.35235538492;4304.203722311382;4339.414179085846;62193.68903155455;62747.37252627507;62782;62793.68603157046;63828.36171638317;54894;55207.44792552023;55520.72239638857;56025.7198714012;56529.43470565242;51053.74473127611;51227;51368.74315628398;51976.48023519792;52173;8511.489310641382;8873.822523549365;8942.329325300758;9045.547722613712;9105.362624616213;35139.82430087833;35965.640343597275;36318.818405907805;36717.26565468729;38287;46137;46882;46914;46983.53016469928;47368.52631473641;10301.9484902575;10594.417307048187;10627.09669678055;10731.624393146203;10857.131429485464;11952.521899123938;11965.401729913643;12066.818997714865;12115.515379384726;12144.089193310361;10426.843597346198;10600.204984626029;10972.561097556327;11083;11626.82559761621;10935.398553079338;11008;11022.118230541377;11177.88822111801;11354.432278386214;10842.783144337227;11252.437378130897;11308.264962777394;11557.190996630155;11737.765244695229;10051.99480051989;10058.698239052841;10099.596016159272;10122.544485498023;10276.17790576737;9377.156055954996;9738.367006144577;9759.707208783748;9912.950435247778;9933.403995760278 10:18:16 INFO - 2016-01-22 10:18:16,220 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:18:16 INFO - 2016-01-22 10:18:16,220 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:18:16 INFO - 2016-01-22 10:18:16,220 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,296 10:18:16 INFO - 2016-01-22 10:18:16,220 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:18:16 INFO - 2016-01-22 10:18:16,220 DEBUG : BROWSER_OUTPUT: __startTimestamp1453486696211__endTimestamp 10:18:16 INFO - 2016-01-22 10:18:16,220 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2016-01-22 10:18:16,220 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:18:16 INFO - 2016-01-22 10:18:16,220 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:18:16 INFO - 2016-01-22 10:18:16,220 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2016-01-22 10:18:16,221 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5505.13 Median:5706.17 stddev:607.24 (10.6%) stddev-sans-first:584.36 10:18:16 INFO - 2016-01-22 10:18:16,221 DEBUG : BROWSER_OUTPUT: Values: 3317.9 3339.0 3342.9 3365.6 3375.1 5429.0 5462.7 5471.5 5477.4 5481.6 5386.0 5472.5 5485.9 5486.6 5487.9 4925.2 4994.7 5021.9 5087.9 5106.8 4893.5 4967.7 5063.0 5063.5 5106.3 4998.4 5065.2 5071.3 5071.8 5072.0 5100.0 5132.6 5148.6 5160.5 5160.7 4855.5 4928.0 4943.0 4962.8 5069.2 5260.9 5307.2 5307.6 5353.5 5366.2 5905.4 5909.7 5935.1 5943.3 5966.9 5764.3 5853.1 5880.4 5885.9 5937.2 5489.0 5578.1 5578.1 5585.3 5621.4 5961.8 5975.9 5994.4 6000.5 6008.5 5609.1 5717.7 5796.4 5821.9 5855.5 5957.5 5972.6 5989.8 6013.8 6015.6 5929.9 5961.6 5977.9 5986.2 5992.5 5671.4 5735.4 5781.0 5869.6 5984.9 4537.3 4556.6 4559.0 4565.5 4583.2 4101.1 4110.8 4113.9 4119.8 4134.1 5447.7 5547.3 5571.0 5632.8 5701.8 5964.5 5973.1 6015.0 6018.2 6020.2 5438.1 5681.8 5691.6 5692.9 5706.2 5033.8 5071.6 5086.1 5089.6 5139.2 6066.1 6097.8 6102.2 6110.1 6115.1 5767.0 5811.2 5970.6 5972.2 5980.8 6082.2 6153.5 6183.5 6192.8 6197.6 5865.7 5902.2 5905.4 5921.1 5933.2 5718.2 5847.4 5866.9 6009.8 6021.2 5846.9 5912.7 5925.8 5937.2 5946.4 5913.2 5920.2 5933.6 5946.6 5953.7 5550.7 5642.0 5653.5 5767.7 5841.4 5758.1 5790.3 5821.5 5840.2 5851.6 5683.1 5688.6 5701.4 5729.9 5730.5 10:18:16 INFO - 2016-01-22 10:18:16,221 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2016-01-22 10:18:16,221 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:61301.23 Median:39456.01 stddev:134203.21 (340.1%) stddev-sans-first:134502.22 10:18:16 INFO - 2016-01-22 10:18:16,222 DEBUG : BROWSER_OUTPUT: Values: 570.9 597.3 602.1 611.9 671.3 28680.4 29490.0 41090.8 41166.0 41635.6 44654.1 44900.8 45253.8 45304.5 45342.5 9089.0 9300.7 9314.1 9323.9 9328.3 8974.8 9076.9 9098.4 9104.1 9107.4 9142.5 9146.5 9213.0 9235.5 9242.3 9141.1 9213.0 9215.4 9244.4 9247.4 9057.7 9226.1 9255.4 9264.6 9269.8 42057.0 42074.8 42419.4 42599.6 42844.0 3391.6 3470.3 4026.8 4184.8 4317.0 31759.7 31860.4 32188.5 32302.4 32420.5 4078.2 4127.6 4167.2 4180.3 4237.2 279629.0 280202.0 280596.0 281227.0 480308.0 64761.1 64889.0 65029.3 65370.0 65422.7 69464.7 69697.7 69750.7 69912.7 69932.7 17638.6 17816.6 17895.0 17904.8 17936.9 12910.0 13205.3 13213.8 13230.9 13334.2 21918.0 22191.0 22194.3 22244.8 22261.9 8037.6 8270.7 8344.0 8371.6 8377.9 1068.4 1082.7 1175.0 1190.8 1198.5 28634.3 29324.0 29372.6 29794.6 33061.0 1072.3 1072.5 1080.8 1083.9 1165.7 14481.1 14698.5 14753.6 14803.9 14946.6 402537.0 753877.0 769073.0 819222.7 842868.0 59382.7 60201.7 60466.0 60481.7 60483.7 1450.8 1454.6 1462.4 1478.4 1479.9 30186.0 30362.2 30800.3 31515.9 31530.2 48740.5 49659.0 49763.3 49779.3 49913.5 305540.0 308347.0 308832.0 309479.0 309530.0 33725.5 33835.2 34089.0 34198.0 34204.3 44574.8 44652.0 45885.8 52651.7 54419.0 38972.6 39199.6 39406.4 39432.4 39456.4 38423.2 38763.6 38796.2 38832.6 39057.6 37852.8 38404.8 38531.4 38595.2 38624.6 36633.5 38264.2 38276.8 39455.6 39462.8 26563.0 27257.3 27336.7 27371.2 27454.7 10:18:16 INFO - 2016-01-22 10:18:16,222 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2016-01-22 10:18:16,222 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32489.52 Median:34278.16 stddev:107040.17 (312.3%) stddev-sans-first:107313.27 10:18:16 INFO - 2016-01-22 10:18:16,222 DEBUG : BROWSER_OUTPUT: Values: 367.7 368.3 369.9 370.9 372.2 15641.2 17506.5 17841.6 18749.1 19212.8 17198.7 17382.9 17438.4 17750.3 17898.6 5511.1 5690.9 5692.0 5694.4 5701.9 5140.9 5234.0 5252.5 5272.9 5645.6 5199.7 5206.4 5227.5 5236.6 5481.5 5510.7 5545.0 5550.9 5551.3 5562.2 5311.4 5340.3 5345.3 5364.8 5521.8 11960.7 12240.1 12260.6 12315.6 21505.8 2074.6 2110.1 2120.5 2192.1 2367.9 8606.4 8622.2 8774.6 8900.5 8922.9 1866.2 1913.3 1914.0 1970.9 2013.4 61128.0 63199.0 63280.7 63973.0 64175.7 10619.8 10644.3 10663.9 10682.9 10789.4 13643.1 13722.2 13771.9 13776.9 13825.0 7794.2 7819.4 7826.3 8041.5 8192.6 7526.7 7532.5 7603.7 7636.2 7668.2 4477.1 4554.4 4589.4 4602.3 4610.7 1769.5 1773.4 1779.1 1888.7 1898.3 909.8 917.7 1008.1 1008.6 1013.4 15977.8 16595.8 16746.7 16827.5 17600.2 871.0 927.9 1022.2 1041.6 1094.1 9230.2 9428.4 9508.0 9564.4 9703.0 644291.0 645615.0 652370.0 660685.0 672332.0 86320.6 88222.6 88326.6 88525.6 88788.6 1223.3 1231.0 1294.3 1314.3 1333.0 15019.0 15044.5 15073.9 15269.2 15423.9 32823.5 32925.5 33877.0 34090.8 34465.5 47967.0 48783.3 49549.8 50181.7 54138.7 9156.2 9485.1 9530.0 9560.0 9580.9 11012.3 17490.6 17816.7 17819.6 17920.2 14889.3 15032.3 15103.7 15138.4 15354.8 14836.7 14919.6 15457.8 15688.4 16140.7 15149.0 15361.5 15519.1 15544.1 15596.7 9102.4 9264.7 9437.6 9458.4 13794.2 16519.3 16613.6 16846.0 17004.9 17073.1 10:18:16 INFO - 2016-01-22 10:18:16,222 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2016-01-22 10:18:16,222 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5702.70 Median:5992.98 stddev:3037.77 (50.7%) stddev-sans-first:3030.11 10:18:16 INFO - 2016-01-22 10:18:16,222 DEBUG : BROWSER_OUTPUT: Values: 1530.6 1546.7 1721.8 1796.3 1833.8 7787.3 8076.6 8079.9 8169.0 8439.3 7990.1 8048.8 8074.1 8095.9 8133.3 2249.3 2272.4 2274.8 2286.8 2292.6 2264.2 2265.8 2266.2 2282.2 2295.3 2254.5 2270.0 2315.0 2315.2 2316.3 2246.9 2255.5 2278.7 2290.4 2292.7 2277.0 2306.1 2314.5 2316.0 2322.4 8021.9 8242.1 8242.4 8249.3 8262.6 4808.3 4871.4 4891.1 4915.6 4932.6 3035.3 3038.3 3058.5 3096.1 3120.8 939.8 981.6 993.0 1001.8 1045.0 11499.1 11573.4 11579.0 11581.6 11582.1 4077.3 4116.1 4120.1 4163.3 4287.7 9121.5 9142.9 9144.5 9145.7 9150.2 4927.6 4936.8 4936.9 4950.2 4952.9 4455.1 4460.9 4462.2 4475.9 4512.0 3547.5 3553.0 3557.1 3589.3 3592.4 1016.0 1025.7 1030.3 1048.7 1050.1 1041.4 1048.5 1102.3 1210.5 1332.5 7515.1 7565.8 7590.1 7617.9 7645.5 1118.9 1119.4 1139.5 1176.8 1183.1 5985.4 6000.6 6046.9 6047.2 6064.0 9977.0 10100.8 10197.8 10206.1 10320.6 9974.3 10029.0 10047.0 10097.6 10124.4 7926.4 7964.0 7983.4 8008.6 8021.1 7334.4 7383.6 7388.8 7390.9 7415.4 8827.2 9017.2 9078.1 9136.5 9160.0 8304.1 8516.2 9198.3 9243.3 9257.8 7367.4 7463.5 7463.7 7470.8 7496.3 7625.8 7859.8 7966.3 7978.5 8004.8 6997.4 7461.3 7469.7 7536.5 7601.8 7251.9 7345.4 7362.3 7459.3 7492.8 7256.0 7283.8 7300.7 7309.3 7335.1 6329.5 6548.3 6554.2 6557.7 6602.2 6574.1 6577.0 6604.6 6618.6 6621.1 10:18:16 INFO - 2016-01-22 10:18:16,222 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2016-01-22 10:18:16,224 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5702.12 Median:6527.26 stddev:1747.93 (26.8%) stddev-sans-first:1705.89 10:18:16 INFO - 2016-01-22 10:18:16,224 DEBUG : BROWSER_OUTPUT: Values: 341.1 346.8 352.8 353.0 354.4 6346.2 6354.4 6504.2 6541.4 6542.1 6270.5 6378.5 6385.4 6392.6 6398.2 4738.2 4760.9 4779.4 4788.1 4824.4 4822.9 4835.4 4846.1 4853.6 4858.8 4737.8 4806.2 4810.5 4827.9 4830.2 4800.5 4820.1 4837.2 4837.6 4849.6 4162.8 4195.9 4206.3 4221.1 4224.1 6021.7 6077.5 6091.9 6119.6 6123.8 5597.7 5614.6 5617.1 5624.3 5639.2 6763.1 6764.0 6764.1 6773.7 6777.4 4648.5 4650.3 4656.4 4660.4 4668.1 6958.0 7001.4 7065.4 7071.2 7076.5 4788.5 4792.1 4794.6 4796.9 4804.8 4838.5 4868.7 4872.2 4876.5 4877.1 5501.5 5614.3 5617.7 5639.4 5646.4 6818.0 6848.5 6855.7 6859.6 6874.2 1670.9 1680.7 1687.8 1689.8 1695.3 1152.3 1164.6 1165.1 1165.9 1176.3 6523.9 6538.1 6546.8 6555.0 6570.2 7007.8 7008.3 7011.1 7021.6 7037.7 6425.9 6516.4 6530.6 6546.1 6557.4 3795.6 3823.9 3825.7 3827.3 3828.0 7236.4 7257.9 7262.3 7268.1 7269.3 7067.0 7166.6 7174.1 7198.7 7229.0 7210.4 7224.6 7242.0 7256.5 7268.5 6997.1 7018.5 7021.1 7033.8 7036.5 6877.4 6924.2 6933.9 7050.9 7131.7 7454.1 7457.9 7460.6 7462.8 7467.5 4732.1 4734.1 4742.1 4747.5 4751.8 7067.8 7067.9 7139.4 7192.3 7213.7 6962.3 6969.6 6988.1 7011.9 7013.8 6965.5 6968.7 6975.4 6981.9 6986.8 6683.2 6834.9 6852.0 6890.0 6901.4 7008.8 7014.0 7021.9 7023.2 7066.0 6627.3 6789.9 6817.4 6840.6 6844.8 10:18:16 INFO - 2016-01-22 10:18:16,224 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2016-01-22 10:18:16,224 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14637.34 Median:27287.53 stddev:17193.24 (63.0%) stddev-sans-first:17209.79 10:18:16 INFO - 2016-01-22 10:18:16,224 DEBUG : BROWSER_OUTPUT: Values: 737.7 848.8 851.1 925.4 951.5 13168.4 13507.9 13575.6 13577.4 13582.2 13973.3 14100.6 14116.4 14122.4 14148.1 904.8 916.1 921.8 947.6 949.6 929.1 931.4 934.0 937.1 946.0 953.3 972.9 975.4 975.9 984.9 966.8 969.2 970.2 972.6 973.6 712.0 717.4 718.6 720.4 723.9 14797.6 14797.9 14807.9 14830.6 14867.7 13250.3 13344.0 13402.7 13488.0 13805.2 10956.3 11021.2 11062.7 11152.6 11344.1 3760.2 3789.1 3791.7 3796.7 3815.1 49678.8 49979.0 50056.5 50181.2 50325.2 10400.6 10412.7 10450.6 10518.4 10661.3 19942.9 20047.2 20168.3 20398.4 20457.8 8615.2 8717.3 8762.4 8769.3 8782.1 4896.3 4978.2 4988.2 4994.8 5007.1 3104.5 3153.5 3156.4 3160.6 3166.5 564.9 571.2 571.8 571.9 577.0 690.7 712.1 721.5 730.3 737.3 8562.5 8795.0 8892.1 8904.1 8984.9 553.2 665.2 717.3 733.2 752.6 4057.3 4102.2 4178.4 4304.2 4339.4 62193.7 62747.4 62782.0 62793.7 63828.4 54894.0 55207.4 55520.7 56025.7 56529.4 51053.7 51227.0 51368.7 51976.5 52173.0 8511.5 8873.8 8942.3 9045.5 9105.4 35139.8 35965.6 36318.8 36717.3 38287.0 46137.0 46882.0 46914.0 46983.5 47368.5 10301.9 10594.4 10627.1 10731.6 10857.1 11952.5 11965.4 12066.8 12115.5 12144.1 10426.8 10600.2 10972.6 11083.0 11626.8 10935.4 11008.0 11022.1 11177.9 11354.4 10842.8 11252.4 11308.3 11557.2 11737.8 10052.0 10058.7 10099.6 10122.5 10276.2 9377.2 9738.4 9759.7 9913.0 9933.4 10:18:16 INFO - 2016-01-22 10:18:16,224 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:18:16 INFO - 2016-01-22 10:18:16,224 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2016-01-22 10:18:16,845 INFO : Browser exited with error code: 0 10:18:16 INFO - 2016-01-22 10:18:16,862 INFO : Completed test dromaeo_css (00:18:27) 10:18:16 INFO - 2016-01-22 10:18:16,862 INFO : Starting test kraken 10:18:16 INFO - 2016-01-22 10:18:16,862 DEBUG : operating with platform_type : linux_ 10:18:16 INFO - 2016-01-22 10:18:16,862 INFO : Initialising browser for kraken test... 10:18:16 INFO - 2016-01-22 10:18:16,868 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5i9kUQ/profile http://localhost:54280/getInfo.html 10:18:20 INFO - 2016-01-22 10:18:20,122 DEBUG : BROWSER_OUTPUT: 10:18:20 INFO - 2016-01-22 10:18:20,122 DEBUG : BROWSER_OUTPUT: (process:19049): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:18:20 INFO - 2016-01-22 10:18:20,932 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:18:20 INFO - 2016-01-22 10:18:20,932 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:18:20 INFO - 2016-01-22 10:18:20,932 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:18:20 INFO - 2016-01-22 10:18:20,932 DEBUG : BROWSER_OUTPUT: __metrics 10:18:21 INFO - 2016-01-22 10:18:21,821 INFO : Browser initialized. 10:18:21 INFO - 2016-01-22 10:18:21,822 INFO : Running cycle 1/1 for kraken test... 10:18:21 INFO - 2016-01-22 10:18:21,822 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5i9kUQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:18:23 INFO - 2016-01-22 10:18:23,098 DEBUG : BROWSER_OUTPUT: 10:18:23 INFO - 2016-01-22 10:18:23,098 DEBUG : BROWSER_OUTPUT: (process:19162): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:18:33 INFO - 2016-01-22 10:18:33,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 136118272 10:18:33 INFO - 2016-01-22 10:18:33,603 DEBUG : BROWSER_OUTPUT: 10:18:36 INFO - 2016-01-22 10:18:36,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54280/tests/kraken/driver.html?testName=audio-beat-detection) 10:18:36 INFO - 2016-01-22 10:18:36,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 138874880 10:18:36 INFO - 2016-01-22 10:18:36,652 DEBUG : BROWSER_OUTPUT: 10:18:39 INFO - 2016-01-22 10:18:39,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54280/tests/kraken/driver.html?testName=audio-dft) 10:18:39 INFO - 2016-01-22 10:18:39,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 139272192 10:18:39 INFO - 2016-01-22 10:18:39,847 DEBUG : BROWSER_OUTPUT: 10:18:42 INFO - 2016-01-22 10:18:42,652 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54280/tests/kraken/driver.html?testName=audio-fft) 10:18:43 INFO - 2016-01-22 10:18:43,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 138088448 10:18:43 INFO - 2016-01-22 10:18:43,234 DEBUG : BROWSER_OUTPUT: 10:18:45 INFO - 2016-01-22 10:18:45,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54280/tests/kraken/driver.html?testName=audio-oscillator) 10:18:45 INFO - 2016-01-22 10:18:45,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 138260480 10:18:45 INFO - 2016-01-22 10:18:45,841 DEBUG : BROWSER_OUTPUT: 10:18:48 INFO - 2016-01-22 10:18:48,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:18:48 INFO - 2016-01-22 10:18:48,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 139239424 10:18:48 INFO - 2016-01-22 10:18:48,607 DEBUG : BROWSER_OUTPUT: 10:18:51 INFO - 2016-01-22 10:18:51,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54280/tests/kraken/driver.html?testName=imaging-darkroom) 10:18:52 INFO - 2016-01-22 10:18:52,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 138002432 10:18:52 INFO - 2016-01-22 10:18:52,133 DEBUG : BROWSER_OUTPUT: 10:18:55 INFO - 2016-01-22 10:18:55,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54280/tests/kraken/driver.html?testName=imaging-desaturate) 10:18:56 INFO - 2016-01-22 10:18:56,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 139444224 10:18:56 INFO - 2016-01-22 10:18:56,102 DEBUG : BROWSER_OUTPUT: 10:18:58 INFO - 2016-01-22 10:18:58,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54280/tests/kraken/driver.html?testName=json-parse-financial) 10:18:59 INFO - 2016-01-22 10:18:59,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 138121216 10:18:59 INFO - 2016-01-22 10:18:59,461 DEBUG : BROWSER_OUTPUT: 10:19:01 INFO - 2016-01-22 10:19:01,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:19:01 INFO - 2016-01-22 10:19:01,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 138088448 10:19:01 INFO - 2016-01-22 10:19:01,636 DEBUG : BROWSER_OUTPUT: 10:19:03 INFO - 2016-01-22 10:19:03,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54280/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:19:04 INFO - 2016-01-22 10:19:04,073 DEBUG : BROWSER_OUTPUT: RSS: Main: 138088448 10:19:04 INFO - 2016-01-22 10:19:04,073 DEBUG : BROWSER_OUTPUT: 10:19:06 INFO - 2016-01-22 10:19:06,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:19:06 INFO - 2016-01-22 10:19:06,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 138346496 10:19:06 INFO - 2016-01-22 10:19:06,732 DEBUG : BROWSER_OUTPUT: 10:19:09 INFO - 2016-01-22 10:19:09,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:19:09 INFO - 2016-01-22 10:19:09,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 138932224 10:19:09 INFO - 2016-01-22 10:19:09,747 DEBUG : BROWSER_OUTPUT: 10:19:12 INFO - 2016-01-22 10:19:12,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:19:12 INFO - 2016-01-22 10:19:12,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 139153408 10:19:12 INFO - 2016-01-22 10:19:12,868 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54280/tests/kraken/driver.html?testName=ai-astar) 10:19:14 INFO - 2016-01-22 10:19:14,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 140464128 10:19:14 INFO - 2016-01-22 10:19:14,788 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,788 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:19:14 INFO - 2016-01-22 10:19:14,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:19:14 INFO - 2016-01-22 10:19:14,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:19:14 INFO - 2016-01-22 10:19:14,789 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:19:14 INFO - 2016-01-22 10:19:14,789 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;105;111;112;112;121;110;110;112;110 10:19:14 INFO - 2016-01-22 10:19:14,789 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;129;149;163;127;148;149;140;154;123 10:19:14 INFO - 2016-01-22 10:19:14,789 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;166;162;163;162;161;159;162;163 10:19:14 INFO - 2016-01-22 10:19:14,789 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;73;164;70;73;72;73;157;72 10:19:14 INFO - 2016-01-22 10:19:14,789 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;94;138;91;92;93;146;93;93;132 10:19:14 INFO - 2016-01-22 10:19:14,790 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;109;110;110;110;110;109 10:19:14 INFO - 2016-01-22 10:19:14,790 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;147;146;147;147;146;148;146;147 10:19:14 INFO - 2016-01-22 10:19:14,790 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;95;96;97;96;96;96 10:19:14 INFO - 2016-01-22 10:19:14,790 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;63;74;60;61;61;61;61;60;60 10:19:14 INFO - 2016-01-22 10:19:14,790 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;70;69;74;67;69;70;70;69 10:19:14 INFO - 2016-01-22 10:19:14,790 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;84;81;90;82;82;82;85;90;83 10:19:14 INFO - 2016-01-22 10:19:14,790 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;122;117;122;124;128;123;115;116;122 10:19:14 INFO - 2016-01-22 10:19:14,790 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;157;150;145;146;145;149;156;141;147 10:19:14 INFO - 2016-01-22 10:19:14,790 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;65;67;65;76;66;66;64;65;66 10:19:14 INFO - 2016-01-22 10:19:14,791 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:19:14 INFO - 2016-01-22 10:19:14,791 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:19:14 INFO - 2016-01-22 10:19:14,791 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,689 10:19:14 INFO - 2016-01-22 10:19:14,791 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:19:14 INFO - 2016-01-22 10:19:14,791 DEBUG : BROWSER_OUTPUT: __startTimestamp1453486754787__endTimestamp 10:19:14 INFO - 2016-01-22 10:19:14,791 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,792 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:19:14 INFO - 2016-01-22 10:19:14,792 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:19:14 INFO - 2016-01-22 10:19:14,792 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,792 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:3.95 (3.5%) stddev-sans-first:4.19 10:19:14 INFO - 2016-01-22 10:19:14,793 DEBUG : BROWSER_OUTPUT: Values: 112.0 105.0 111.0 112.0 112.0 121.0 110.0 110.0 112.0 110.0 10:19:14 INFO - 2016-01-22 10:19:14,793 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,793 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.20 Median:149.00 stddev:13.03 (8.7%) stddev-sans-first:13.58 10:19:14 INFO - 2016-01-22 10:19:14,793 DEBUG : BROWSER_OUTPUT: Values: 150.0 129.0 149.0 163.0 127.0 148.0 149.0 140.0 154.0 123.0 10:19:14 INFO - 2016-01-22 10:19:14,793 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,793 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.79 (1.1%) stddev-sans-first:1.86 10:19:14 INFO - 2016-01-22 10:19:14,793 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 166.0 162.0 163.0 162.0 161.0 159.0 162.0 163.0 10:19:14 INFO - 2016-01-22 10:19:14,793 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,793 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.90 Median:72.50 stddev:37.26 (51.4%) stddev-sans-first:39.01 10:19:14 INFO - 2016-01-22 10:19:14,794 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 164.0 70.0 73.0 72.0 73.0 157.0 72.0 10:19:14 INFO - 2016-01-22 10:19:14,794 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,794 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:92.50 stddev:22.53 (24.4%) stddev-sans-first:23.28 10:19:14 INFO - 2016-01-22 10:19:14,794 DEBUG : BROWSER_OUTPUT: Values: 92.0 94.0 138.0 91.0 92.0 93.0 146.0 93.0 93.0 132.0 10:19:14 INFO - 2016-01-22 10:19:14,794 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,794 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:19:14 INFO - 2016-01-22 10:19:14,794 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 109.0 110.0 110.0 110.0 110.0 109.0 10:19:14 INFO - 2016-01-22 10:19:14,794 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,795 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 10:19:14 INFO - 2016-01-22 10:19:14,795 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 146.0 147.0 147.0 146.0 148.0 146.0 147.0 10:19:14 INFO - 2016-01-22 10:19:14,795 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,795 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 10:19:14 INFO - 2016-01-22 10:19:14,795 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 95.0 96.0 97.0 96.0 96.0 96.0 10:19:14 INFO - 2016-01-22 10:19:14,796 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,796 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.00 Median:61.00 stddev:4.35 (7.1%) stddev-sans-first:4.47 10:19:14 INFO - 2016-01-22 10:19:14,796 DEBUG : BROWSER_OUTPUT: Values: 59.0 63.0 74.0 60.0 61.0 61.0 61.0 61.0 60.0 60.0 10:19:14 INFO - 2016-01-22 10:19:14,796 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,796 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.50 stddev:1.78 (2.6%) stddev-sans-first:1.87 10:19:14 INFO - 2016-01-22 10:19:14,796 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 70.0 69.0 74.0 67.0 69.0 70.0 70.0 69.0 10:19:14 INFO - 2016-01-22 10:19:14,796 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,796 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:3.51 (4.2%) stddev-sans-first:3.43 10:19:14 INFO - 2016-01-22 10:19:14,796 DEBUG : BROWSER_OUTPUT: Values: 80.0 84.0 81.0 90.0 82.0 82.0 82.0 85.0 90.0 83.0 10:19:14 INFO - 2016-01-22 10:19:14,797 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,797 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:122.00 stddev:4.40 (3.6%) stddev-sans-first:4.21 10:19:14 INFO - 2016-01-22 10:19:14,797 DEBUG : BROWSER_OUTPUT: Values: 115.0 122.0 117.0 122.0 124.0 128.0 123.0 115.0 116.0 122.0 10:19:14 INFO - 2016-01-22 10:19:14,797 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,797 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:148.00 stddev:6.13 (4.1%) stddev-sans-first:5.25 10:19:14 INFO - 2016-01-22 10:19:14,797 DEBUG : BROWSER_OUTPUT: Values: 137.0 157.0 150.0 145.0 146.0 145.0 149.0 156.0 141.0 147.0 10:19:14 INFO - 2016-01-22 10:19:14,797 DEBUG : BROWSER_OUTPUT: 10:19:14 INFO - 2016-01-22 10:19:14,797 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:66.00 stddev:3.67 (5.6%) stddev-sans-first:3.61 10:19:14 INFO - 2016-01-22 10:19:14,797 DEBUG : BROWSER_OUTPUT: Values: 71.0 65.0 67.0 65.0 76.0 66.0 66.0 64.0 65.0 66.0 10:19:14 INFO - 2016-01-22 10:19:14,797 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:19:14 INFO - 2016-01-22 10:19:14,797 DEBUG : BROWSER_OUTPUT: 10:19:15 INFO - 2016-01-22 10:19:15,569 INFO : Browser exited with error code: 0 10:19:15 INFO - 2016-01-22 10:19:15,620 INFO : Completed test kraken (00:00:58) 10:19:15 INFO - 2016-01-22 10:19:15,620 INFO : Starting test v8_7 10:19:15 INFO - 2016-01-22 10:19:15,620 DEBUG : operating with platform_type : linux_ 10:19:15 INFO - 2016-01-22 10:19:15,620 INFO : Initialising browser for v8_7 test... 10:19:15 INFO - 2016-01-22 10:19:15,626 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTtGCsG/profile http://localhost:54280/getInfo.html 10:19:18 INFO - 2016-01-22 10:19:18,949 DEBUG : BROWSER_OUTPUT: 10:19:18 INFO - 2016-01-22 10:19:18,949 DEBUG : BROWSER_OUTPUT: (process:19469): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:19:19 INFO - 2016-01-22 10:19:19,662 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:19:19 INFO - 2016-01-22 10:19:19,662 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:19:19 INFO - 2016-01-22 10:19:19,662 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:19:19 INFO - 2016-01-22 10:19:19,662 DEBUG : BROWSER_OUTPUT: __metrics 10:19:20 INFO - 2016-01-22 10:19:20,569 INFO : Browser initialized. 10:19:20 INFO - 2016-01-22 10:19:20,570 INFO : Running cycle 1/1 for v8_7 test... 10:19:20 INFO - 2016-01-22 10:19:20,570 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTtGCsG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:19:21 INFO - 2016-01-22 10:19:21,834 DEBUG : BROWSER_OUTPUT: 10:19:21 INFO - 2016-01-22 10:19:21,834 DEBUG : BROWSER_OUTPUT: (process:19582): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:19:32 INFO - 2016-01-22 10:19:32,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 136065024 10:19:32 INFO - 2016-01-22 10:19:32,340 DEBUG : BROWSER_OUTPUT: 10:19:53 INFO - 2016-01-22 10:19:53,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54280/tests/v8_7/run.html (next: http://localhost:54280/tests/v8_7/run.html) 10:19:53 INFO - 2016-01-22 10:19:53,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 136298496 10:19:53 INFO - 2016-01-22 10:19:53,916 DEBUG : BROWSER_OUTPUT: 10:19:53 INFO - 2016-01-22 10:19:53,918 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:19:53 INFO - 2016-01-22 10:19:53,918 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:19:53 INFO - 2016-01-22 10:19:53,918 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:19:53 INFO - 2016-01-22 10:19:53,918 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:19:53 INFO - 2016-01-22 10:19:53,918 DEBUG : BROWSER_OUTPUT: |0;Richards;165.97510373443984 10:19:53 INFO - 2016-01-22 10:19:53,918 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.47613465081227 10:19:53 INFO - 2016-01-22 10:19:53,919 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.3296089385475 10:19:53 INFO - 2016-01-22 10:19:53,919 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5117.34693877551 10:19:53 INFO - 2016-01-22 10:19:53,919 DEBUG : BROWSER_OUTPUT: |4;RayTrace;920.8103130755064 10:19:53 INFO - 2016-01-22 10:19:53,919 DEBUG : BROWSER_OUTPUT: |5;Earley;551.8763796909492 10:19:53 INFO - 2016-01-22 10:19:53,919 DEBUG : BROWSER_OUTPUT: |6;Boyer;11000 10:19:53 INFO - 2016-01-22 10:19:53,919 DEBUG : BROWSER_OUTPUT: |7;RegExp;24000 10:19:53 INFO - 2016-01-22 10:19:53,920 DEBUG : BROWSER_OUTPUT: |8;Splay;521.376433785193 10:19:53 INFO - 2016-01-22 10:19:53,920 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 10:19:53 INFO - 2016-01-22 10:19:53,920 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:19:53 INFO - 2016-01-22 10:19:53,920 DEBUG : BROWSER_OUTPUT: __startTimestamp1453486793916__endTimestamp 10:19:53 INFO - 2016-01-22 10:19:53,920 DEBUG : BROWSER_OUTPUT: 10:19:53 INFO - 2016-01-22 10:19:53,921 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:19:53 INFO - 2016-01-22 10:19:53,921 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:19:53 INFO - 2016-01-22 10:19:53,921 DEBUG : BROWSER_OUTPUT: 10:19:53 INFO - 2016-01-22 10:19:53,921 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.98 Median:165.98 stddev:0.00 (0.0%) 10:19:53 INFO - 2016-01-22 10:19:53,921 DEBUG : BROWSER_OUTPUT: Values: 166.0 10:19:53 INFO - 2016-01-22 10:19:53,921 DEBUG : BROWSER_OUTPUT: 10:19:53 INFO - 2016-01-22 10:19:53,921 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.48 Median:167.48 stddev:0.00 (0.0%) 10:19:53 INFO - 2016-01-22 10:19:53,921 DEBUG : BROWSER_OUTPUT: Values: 167.5 10:19:53 INFO - 2016-01-22 10:19:53,921 DEBUG : BROWSER_OUTPUT: 10:19:53 INFO - 2016-01-22 10:19:53,921 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 10:19:53 INFO - 2016-01-22 10:19:53,922 DEBUG : BROWSER_OUTPUT: Values: 279.3 10:19:53 INFO - 2016-01-22 10:19:53,922 DEBUG : BROWSER_OUTPUT: 10:19:53 INFO - 2016-01-22 10:19:53,922 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5117.35 Median:5117.35 stddev:0.00 (0.0%) 10:19:53 INFO - 2016-01-22 10:19:53,922 DEBUG : BROWSER_OUTPUT: Values: 5117.3 10:19:53 INFO - 2016-01-22 10:19:53,922 DEBUG : BROWSER_OUTPUT: 10:19:53 INFO - 2016-01-22 10:19:53,922 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:920.81 Median:920.81 stddev:0.00 (0.0%) 10:19:53 INFO - 2016-01-22 10:19:53,922 DEBUG : BROWSER_OUTPUT: Values: 920.8 10:19:53 INFO - 2016-01-22 10:19:53,922 DEBUG : BROWSER_OUTPUT: 10:19:53 INFO - 2016-01-22 10:19:53,923 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:551.88 Median:551.88 stddev:0.00 (0.0%) 10:19:53 INFO - 2016-01-22 10:19:53,923 DEBUG : BROWSER_OUTPUT: Values: 551.9 10:19:53 INFO - 2016-01-22 10:19:53,923 DEBUG : BROWSER_OUTPUT: 10:19:53 INFO - 2016-01-22 10:19:53,923 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11000.00 Median:11000.00 stddev:0.00 (0.0%) 10:19:53 INFO - 2016-01-22 10:19:53,923 DEBUG : BROWSER_OUTPUT: Values: 11000.0 10:19:53 INFO - 2016-01-22 10:19:53,923 DEBUG : BROWSER_OUTPUT: 10:19:53 INFO - 2016-01-22 10:19:53,923 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24000.00 Median:24000.00 stddev:0.00 (0.0%) 10:19:53 INFO - 2016-01-22 10:19:53,923 DEBUG : BROWSER_OUTPUT: Values: 24000.0 10:19:53 INFO - 2016-01-22 10:19:53,923 DEBUG : BROWSER_OUTPUT: 10:19:53 INFO - 2016-01-22 10:19:53,923 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:521.38 Median:521.38 stddev:0.00 (0.0%) 10:19:53 INFO - 2016-01-22 10:19:53,923 DEBUG : BROWSER_OUTPUT: Values: 521.4 10:19:53 INFO - 2016-01-22 10:19:53,924 DEBUG : BROWSER_OUTPUT: 10:19:53 INFO - 2016-01-22 10:19:53,924 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 10:19:53 INFO - 2016-01-22 10:19:53,924 DEBUG : BROWSER_OUTPUT: Values: 4830.9 10:19:53 INFO - 2016-01-22 10:19:53,924 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:19:53 INFO - 2016-01-22 10:19:53,924 DEBUG : BROWSER_OUTPUT: 10:19:54 INFO - 2016-01-22 10:19:54,721 INFO : Browser exited with error code: 0 10:19:54 INFO - 2016-01-22 10:19:54,740 INFO : Completed test v8_7 (00:00:39) 10:19:54 INFO - 2016-01-22 10:19:54,983 INFO : Completed test suite (00:20:05) 10:19:54 INFO - 2016-01-22 10:19:54,984 DEBUG : Working with test: dromaeo_css 10:19:54 INFO - 2016-01-22 10:19:54,984 DEBUG : Generating results file: dromaeo_css 10:19:54 INFO - 2016-01-22 10:19:54,985 DEBUG : Working with test: kraken 10:19:54 INFO - 2016-01-22 10:19:54,985 DEBUG : Generating results file: kraken 10:19:54 INFO - 2016-01-22 10:19:54,985 INFO : javascript benchmark 10:19:54 INFO - 2016-01-22 10:19:54,985 DEBUG : Working with test: v8_7 10:19:54 INFO - 2016-01-22 10:19:54,986 DEBUG : Generating results file: v8_7 10:19:54 INFO - 2016-01-22 10:19:54,986 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:19:55 INFO - 2016-01-22 10:19:55,041 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 10:19:55 INFO - 2016-01-22 10:19:55,041 DEBUG : process_Request line: dromaeo_css 7386.52 graph.html#tests=[[72,52,43]] 10:19:55 INFO - 2016-01-22 10:19:55,041 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:19:55 INFO - 2016-01-22 10:19:55,069 DEBUG : process_Request line: kraken 1515.60 graph.html#tests=[[232,52,43]] 10:19:55 INFO - 2016-01-22 10:19:55,069 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:19:55 INFO - 2016-01-22 10:19:55,099 DEBUG : process_Request line: v8_7 23259.82 graph.html#tests=[[230,52,43]] 10:19:55 INFO - 2016-01-22 10:19:55,101 INFO : javascript benchmark 10:19:55 INFO - 2016-01-22 10:19:55,104 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3317.9004629861106, 3338.9666103338973, 3342.9331413371747, 3365.579302587176, 3375.071855239809, 5428.972855135724, 5462.69955152467, 5471.50756431921, 5477.397486276506, 5481.616286859921, 5385.976664433755, 5472.50747432731, 5485.890282194364, 5486.588505862066, 5487.917681234785, 4925.162722337212, 4994.650374473788, 5021.899562008776, 5087.923681144785, 5106.821261255838, 4893.461719210902, 4967.726775027372, 5063.01271252106, 5063.518965698253, 5106.310648062501, 4998.350214472113, 5065.189569668853, 5071.264666623338, 5071.797128114871, 5072.0, 5100.0, 5132.640715149941, 5148.613853960968, 5160.458151894072, 5160.690358578459, 4855.5387238212315, 4927.975360123177, 4942.950570494285, 4962.776675049631, 5069.188929771219, 5260.92108618371, 5307.177387504904, 5307.575393968512, 5353.464653534655, 5366.168243922199, 5905.4094590541035, 5909.674967876765, 5935.139404786281, 5943.3165186003735, 5966.850828729273, 5764.308283006024, 5853.09277062056, 5880.441358070976, 5885.941140588582, 5937.198478205431, 5489.0, 5578.107502799533, 5578.135389014668, 5585.329760428734, 5621.353544342372, 5961.791337303173, 5975.910361344583, 5994.400559944058, 6000.459958603747, 6008.489278411296, 5609.1305847593685, 5717.685527295956, 5796.3913789052385, 5821.854453638608, 5855.473007429352, 5957.523398128226, 5972.552058595623, 5989.760409583568, 6013.789517366871, 6015.639061656227, 5929.940700593025, 5961.642301461926, 5977.940220597825, 5986.161937328778, 5992.490638295793, 5671.404502527258, 5735.3977832327, 5781.046127389018, 5869.64782113066, 5984.910226346608, 4537.319402089713, 4556.589906908394, 4559.0, 4565.474970378449, 4583.152116858392, 4101.056756945919, 4110.794460277034, 4113.938290925638, 4119.773412462283, 4134.090500089976, 5447.727613619303, 5547.278853749068, 5570.97214513933, 5632.8028519002455, 5701.828945131652, 5964.463198312173, 5973.074173503114, 6015.007523758618, 6018.247719035121, 6020.217371741645, 5438.129899216106, 5681.829545113653, 5691.573132015115, 5692.9146062809095, 5706.172604972338, 5033.798648054037, 5071.644984851025, 5086.109930762102, 5089.592832573385, 5139.229115632685, 6066.059760737093, 6097.786577469856, 6102.237220347457, 6110.144579758838, 6115.052166914135, 5767.048437007847, 5811.186433899342, 5970.611910225822, 5972.223610930551, 5980.820575382745, 6082.2093127893095, 6153.538484613582, 6183.474404675473, 6192.783252586138, 6197.628142311476, 5865.736041878211, 5902.203202567598, 5905.35041145465, 5921.111833225051, 5933.228680271537, 5718.1708652246025, 5847.38602446737, 5866.853328666817, 6009.819705408845, 6021.217241758543, 5846.883062338644, 5912.73392697321, 5925.792597259076, 5937.228160339128, 5946.43508866657, 5913.172155898092, 5920.230370052038, 5933.614315069507, 5946.643201407929, 5953.732082056231, 5550.666959982414, 5641.971790141187, 5653.462921022497, 5767.68277744728, 5841.386654401396, 5758.1362795581, 5790.334111577223, 5821.476067153976, 5840.153177789111, 5851.64890106595, 5683.147527870852, 5688.5733569981585, 5701.372848986525, 5729.885402291848, 5730.484256416942], "unit": "ms", "name": "dojo.html", "value": 5466.299238878598}, {"lowerIsBetter": false, "replicates": [570.8829689913568, 597.3488897102158, 602.075813626084, 611.8898598252314, 671.3085521912429, 28680.42639147216, 29490.0, 41090.79454602727, 41166.0, 41635.58364416355, 44654.10691786162, 44900.77549612247, 45253.77373113138, 45304.546954530444, 45342.546574534244, 9088.95455522723, 9300.674476393327, 9314.115159059878, 9323.860142097874, 9328.253739700807, 8974.775630609254, 9076.909230907673, 9098.363114581982, 9104.089591040876, 9107.36248462608, 9142.542872856364, 9146.542672866364, 9213.03263157369, 9235.492047937361, 9242.30682698797, 9141.085891410872, 9213.032631573655, 9215.354925155276, 9244.352895297332, 9247.398919070272, 9057.728268151966, 9226.123518265822, 9255.398399104037, 9264.58309376073, 9269.814603707955, 42057.0, 42074.78962605167, 42419.363709544385, 42599.57400425987, 42844.0, 3391.6099648540485, 3470.340635279289, 4026.8187931543152, 4184.849166479243, 4316.978415107905, 31759.682403176135, 31860.362792744014, 32188.517172242435, 32302.353952921047, 32420.513692294633, 4078.2455245779624, 4127.607877251657, 4167.249895018896, 4180.289350810339, 4237.216115018731, 279629.0, 280202.0, 280596.0, 281227.0, 480307.9999999965, 64761.08575114131, 64889.0, 65029.34970650328, 65370.0, 65422.67288663622, 69464.6526767373, 69697.65151174313, 69750.65124674344, 69912.65043674748, 69932.65033674799, 17638.559036024202, 17816.643667126584, 17895.0, 17904.820951790574, 17936.91031544834, 12910.0, 13205.273709946045, 13213.801792973112, 13230.867691322963, 13334.19994800315, 21918.0, 22191.0, 22194.334169974925, 22244.77755222427, 22261.888690556443, 8037.557934313669, 8270.710525131592, 8344.039150799557, 8371.58142092893, 8377.874331885027, 1068.3643232276784, 1082.7401423658266, 1175.0, 1190.7916114679897, 1198.4726720243066, 28634.284142896176, 29324.0, 29372.559411608843, 29794.55308170379, 33061.0, 1072.3137192196843, 1072.5120070367964, 1080.8432777247256, 1083.8590983172137, 1165.6969188011008, 14481.131132131895, 14698.485553005594, 14753.598408151209, 14803.92598037003, 14946.626334341729, 402537.0, 753877.0, 769073.0, 819222.7116593256, 842868.0, 59382.70308648429, 60201.69899150476, 60466.0, 60481.69759151176, 60483.69758151181, 1450.8186476690414, 1454.6363409147714, 1462.393106860641, 1478.4086365453904, 1479.859413355751, 30186.0, 30362.240943976576, 30800.333803571993, 31515.896943606862, 31530.211744705648, 48740.512594875014, 49659.0, 49763.253551197486, 49779.253311201086, 49913.500864990885, 305540.0, 308347.0, 308832.0, 309479.0, 309530.0, 33725.49411758777, 33835.15412114717, 34089.0, 34198.0, 34204.31591368109, 44574.77712611416, 44652.0, 45885.77057114693, 52651.73674131605, 54419.0, 38972.6102738969, 39199.608003919595, 39406.40890386589, 39432.40851387289, 39456.40815387714, 38423.23153536858, 38763.612363876004, 38796.2240755189, 38832.6116738829, 39057.609423906535, 37852.81073594614, 38404.80797595994, 38531.42202866903, 38595.22809543737, 38624.613753863225, 36633.45049824201, 38264.23471530498, 38276.80861595674, 39455.60544394519, 39462.80268598639, 26563.0, 27257.31856703598, 27336.72663273342, 27371.178864634094, 27454.725452745217], "unit": "ms", "name": "ext.html", "value": 20445.260504578746}, {"lowerIsBetter": false, "replicates": [367.69297636473544, 368.25061000863246, 369.9482072509851, 370.86092715231786, 372.2313422781956, 15641.217939103028, 17506.474805755817, 17841.553961150978, 18749.062546872654, 19212.807871921275, 17198.74201886973, 17382.913085434557, 17438.38965636203, 17750.28998840048, 17898.64202715945, 5511.145772405273, 5690.9146362804595, 5692.0, 5694.402087780765, 5701.885962280752, 5140.8971820563565, 5234.031704134728, 5252.501012403815, 5272.894542109156, 5645.576581756364, 5199.740012999354, 5206.427292997767, 5227.4511176326505, 5236.581073514109, 5481.479259470364, 5510.669359838423, 5545.00189965806, 5550.91673624896, 5551.333839939233, 5562.193481945115, 5311.362636483608, 5340.25236466895, 5345.278387417727, 5364.785408583652, 5521.834344969658, 11960.70098247542, 12240.081993850497, 12260.570880019157, 12315.630531084082, 21505.784942150534, 2074.5539708962647, 2110.1453911166004, 2120.5122821751083, 2192.1450634252656, 2367.91712290069, 8606.44058136219, 8622.180892815173, 8774.64901403943, 8900.465972041633, 8922.866157007586, 1866.150901339887, 1913.272956276606, 1913.9808601913942, 1970.931017414398, 2013.4362378534033, 61128.0, 63199.0, 63280.68359658172, 63973.0, 64175.67912160456, 10619.84070238947, 10644.308119972176, 10663.946680266548, 10682.893171068345, 10789.352638841538, 13643.113197642122, 13722.245276509688, 13771.862281377058, 13776.93111534436, 13825.032247742562, 7794.181610930884, 7819.3744500439825, 7826.334761545332, 8041.517508949481, 8192.590370481452, 7526.661300241502, 7532.510386824948, 7603.695852165852, 7636.160022397532, 7668.233176682287, 4477.1493416250805, 4554.407926969539, 4589.426321709786, 4602.286645569942, 4610.74640894754, 1769.5222289981632, 1773.3970450047045, 1779.1371184975276, 1888.7261347104593, 1898.3450709505198, 909.8089401225684, 917.7246825952187, 1008.0675375277839, 1008.5511947183579, 1013.366645846346, 15977.840221597868, 16595.751063734053, 16746.6650666986, 16827.495175144766, 17600.20799064045, 870.9825803483894, 927.8840144981878, 1022.1567207054061, 1041.5677493839971, 1094.141099237095, 9230.215431688383, 9428.38715483505, 9507.952460237793, 9564.426134431957, 9702.951485242529, 644291.0, 645615.0, 652370.0, 660685.0, 672332.0, 86320.56839715887, 88222.55888720516, 88326.55836720775, 88525.55737221273, 88788.5560572193, 1223.253815172744, 1230.975380492403, 1294.2752058847075, 1314.3493970484672, 1333.0, 15019.0, 15044.473443429428, 15073.924630377216, 15269.160196189316, 15423.922880385526, 32823.507647385784, 32925.50611740874, 33877.0, 34090.82954585211, 34465.48301775425, 47967.0, 48783.26825097697, 49549.75225123851, 50181.74909125431, 54138.72930635322, 9156.175944165057, 9485.146336829719, 9530.0, 9559.996200398858, 9580.904190958001, 11012.339259644446, 17490.562735931704, 17816.732749008515, 17819.554511137325, 17920.193591288684, 14889.329980150702, 15032.323545440262, 15103.697926041637, 15138.394464221308, 15354.769678454608, 14836.698012968845, 14919.627009324853, 15457.768133478232, 15688.372465101269, 16140.67718645644, 15149.0, 15361.462348817739, 15519.146446945526, 15544.06735595868, 15596.688066238385, 9102.362834601514, 9264.72205833826, 9437.575309111244, 9458.385204961656, 13794.172349659053, 16519.256633451285, 16613.58466038359, 16846.0, 17004.914975425043, 17073.14634268257], "unit": "ms", "name": "jquery.html", "value": 9121.155173257886}, {"lowerIsBetter": false, "replicates": [1530.63264816444, 1546.7061258360911, 1721.8278172182775, 1796.2635319518995, 1833.8355144483248, 7787.338076263517, 8076.555789431579, 8079.91920080799, 8168.999999999993, 8439.32485401168, 7990.081140668824, 8048.758537243877, 8074.111847696749, 8095.91904080959, 8133.308668763162, 2249.2914731859496, 2272.4432514034083, 2274.7725227477285, 2286.7713228677167, 2292.610256256432, 2264.230161745006, 2265.8074063704603, 2266.150193677371, 2282.189822612965, 2295.345826439465, 2254.49273913369, 2270.0238897274166, 2314.9884250578725, 2315.2475445480204, 2316.3051084674617, 2246.8876556172127, 2255.537614788964, 2278.715160604924, 2290.3586995641163, 2292.6904867842795, 2277.0436416705024, 2306.054517647773, 2314.4908120213527, 2316.0388438797877, 2322.3729593009793, 8021.919780802175, 8242.052164001097, 8242.381821363362, 8249.257566819015, 8262.586870656443, 4808.302796094582, 4871.4397844248015, 4891.070696567676, 4915.631327650405, 4932.556069953685, 3035.301880567482, 3038.346755447589, 3058.541218817173, 3096.055703010581, 3120.7659425543175, 939.8073394954018, 981.5828272983953, 993.0169132558715, 1001.8397056471002, 1044.9634262800841, 11499.080073594092, 11573.421328933604, 11579.0, 11581.594644187497, 11582.073434125334, 4077.2864748668862, 4116.073883376276, 4120.134771697977, 4163.250614889349, 4287.699861009762, 9121.543922803834, 9142.908570914338, 9144.542772861463, 9145.679901203426, 9150.22223111043, 4927.630427717864, 4936.777844996984, 4936.876578085505, 4950.183219768698, 4952.8761780955765, 4455.131249406335, 4460.933086003713, 4462.174497717932, 4475.910481790411, 4511.954880451219, 3547.52108465359, 3553.0, 3557.0573797943566, 3589.2642008388216, 3592.407252803258, 1015.9796804063877, 1025.707673313102, 1030.258214085857, 1048.6801525534634, 1050.1231471721046, 1041.3907863899703, 1048.4705223862054, 1102.2780079048237, 1210.4976434779644, 1332.4803326702595, 7515.135759387631, 7565.773026809205, 7590.051243594551, 7617.923820761832, 7645.4648174628355, 1118.9384583847805, 1119.3567416705027, 1139.4815359011795, 1176.847009888709, 1183.1185766603935, 5985.371535988658, 6000.579959402888, 6046.909296360558, 6047.183630209865, 6063.969680151571, 9976.950115249378, 10100.797984040424, 10197.847032294521, 10206.132478739242, 10320.638777642747, 9974.301798874154, 10029.04724051214, 10047.0, 10097.596096156218, 10124.443155626364, 7926.405519586054, 7963.960180199062, 7983.441159118922, 8008.599570021592, 8021.077576078709, 7334.376577990931, 7383.630818459163, 7388.815279617837, 7390.889136663062, 7415.406767458699, 8827.16141966512, 9017.188453039258, 9078.137576930181, 9136.49749263797, 9160.0, 8304.086550479322, 8516.190961858614, 9198.310126740387, 9243.306751993761, 9257.768555786159, 7367.373773229336, 7463.477556570988, 7463.701451941862, 7470.813229669302, 7496.287852653989, 7625.847483050419, 7859.764207073797, 7966.28303452692, 7978.521288722695, 8004.799880003046, 6997.4052205561065, 7461.291177338144, 7469.7385591504035, 7536.472446928662, 7601.847963040819, 7251.927480725336, 7345.412367010733, 7362.3373896349585, 7459.328660420588, 7492.7752167435065, 7256.0, 7283.781486555412, 7300.707971681286, 7309.342159205697, 7335.1197856257595, 6329.5252856036905, 6548.3124271952665, 6554.180727409074, 6557.704903279268, 6602.240742314503, 6574.145361103026, 6577.0, 6604.603723776589, 6618.63597502142, 6621.106150669598], "unit": "ms", "name": "mootools.html", "value": 4626.077894165075}, {"lowerIsBetter": false, "replicates": [341.07228338918145, 346.82138698570225, 352.79890462436424, 352.9805860677662, 354.4169840612193, 6346.2067241594805, 6354.396332348431, 6504.1869766279215, 6541.443977261938, 6542.051402546628, 6270.49836013119, 6378.521610879179, 6385.425311721944, 6392.6484043377595, 6398.2322121345505, 4738.2418812989845, 4760.928586071212, 4779.426468823746, 4788.11419887322, 4824.396950381202, 4822.9035419291595, 4835.371401717789, 4846.0550192712435, 4853.563179313861, 4858.757062146896, 4737.786799594027, 4806.182948898678, 4810.4948980357085, 4827.927581086286, 4830.203016502291, 4800.4719480857075, 4820.132376172305, 4837.153498137829, 4837.612990960714, 4849.612031037508, 4162.771047592381, 4195.91608167838, 4206.348016057516, 4221.07136429988, 4224.1129362833535, 6021.6989150542295, 6077.483413909823, 6091.9390806091815, 6119.571629985903, 6123.84690382744, 5597.748101335409, 5614.578906582023, 5617.101263797773, 5624.29696287964, 5639.210510528529, 6763.086983257295, 6763.966180169117, 6764.0530325754435, 6773.6613169341335, 6777.390034896834, 4648.5119062498625, 4650.348951146842, 4656.371389862393, 4660.37084993525, 4668.066386722669, 6958.0, 7001.404880585156, 7065.43476521877, 7071.1868135164605, 7076.469264805109, 4788.473267940523, 4792.137415265216, 4794.5924596408995, 4796.896713755786, 4804.759762011886, 4838.467768545457, 4868.683535570177, 4872.220444728827, 4876.512348765095, 4877.073356062408, 5501.477359650827, 5614.326280846324, 5617.691026993554, 5639.379668236491, 5646.378898321182, 6818.045473633695, 6848.520603557703, 6855.6572171391235, 6859.622720750307, 6874.243833178346, 1670.9331626735038, 1680.7226807576858, 1687.7552754850724, 1689.81412044675, 1695.3218712515093, 1152.2683096233952, 1164.598213616301, 1165.1028707894873, 1165.889240522149, 1176.335370515656, 6523.902141467882, 6538.117354157223, 6546.803595892131, 6555.049517819984, 6570.211574611078, 7007.754728584577, 7008.26413226614, 7011.088558487364, 7021.648917554102, 7037.683304251321, 6425.903611445832, 6516.380943810331, 6530.608163510205, 6546.149000629887, 6557.377049180321, 3795.6394142556965, 3823.923521529554, 3825.6748176405317, 3827.3493506103473, 3828.0429892526868, 7236.384907282834, 7257.92742072583, 7262.31008054234, 7268.055152830098, 7269.273072692688, 7067.0, 7166.6025125100105, 7174.1032370953635, 7198.676059577227, 7229.024081749002, 7210.351068403869, 7224.638768061576, 7242.0, 7256.528325658815, 7268.491205615662, 6997.05539752127, 7018.508704390643, 7021.087258656342, 7033.824154396181, 7036.542624729376, 6877.3810357068105, 6924.203716572659, 6933.89599156003, 7050.929490705027, 7131.679074441767, 7454.105507339154, 7457.92542074594, 7460.626968651437, 7462.843259294818, 7467.477276590586, 4732.077244937204, 4734.07685501324, 4742.051589682008, 4747.525247475225, 4751.83368582098, 7067.787966361017, 7067.929320706727, 7139.393151581966, 7192.31672991065, 7213.747518836815, 6962.268961758942, 6969.616671083139, 6988.05661235747, 7011.929880701127, 7013.824654383681, 6965.547239429421, 6968.7212511501, 6975.372216500539, 6981.930180698331, 6986.825329366807, 6683.164604424447, 6834.9316506836285, 6852.0, 6889.965550172217, 6901.378875901193, 7008.7546935857, 7013.964930175316, 7021.859562808818, 7023.157221133497, 7065.964670176616, 6627.271000189879, 6789.864202716017, 6817.420519255918, 6840.55536390153, 6844.8288792778585], "unit": "ms", "name": "prototype.html", "value": 5130.105625723479}, {"lowerIsBetter": false, "replicates": [737.7233537423466, 848.7750746052295, 851.1488511488516, 925.3846192282133, 951.5455180719309, 13168.407421666025, 13507.932460337684, 13575.592732218025, 13577.389017494212, 13582.185068895873, 13973.301334933263, 14100.64748381291, 14116.435342586285, 14122.43510259591, 14148.080374775633, 904.8280826642949, 916.079340263038, 921.8110287391103, 947.5641205045687, 949.5537097564134, 929.0987741890356, 931.3666706639483, 934.0239449775002, 937.1331518345503, 945.9905400945971, 953.3040880157489, 972.9221662267001, 975.4488713876673, 975.8877729061143, 984.8916619171886, 966.830804609194, 969.2294625772528, 970.2238209432426, 972.6449845806266, 973.5862258540163, 711.9750808721722, 717.4296434334716, 718.6334969165711, 720.3588805962697, 723.8624661314334, 14797.556073317817, 14797.92601036988, 14807.851921480755, 14830.555083347517, 14867.70264594702, 13250.337483125804, 13344.0, 13402.664933376744, 13488.0, 13805.240711760849, 10956.28784129037, 11021.228514004022, 11062.668119956414, 11152.553897844076, 11344.092472602171, 3760.172761992357, 3789.0906182516273, 3791.6966642668795, 3796.6962642988497, 3815.065308999313, 49678.7516062421, 49979.0, 50056.49943500591, 50181.24728129081, 50325.24512132321, 10400.635977740743, 10412.68761937143, 10450.581976720998, 10518.368897866, 10661.253712240068, 19942.90028549848, 20047.198112075646, 20168.29410970609, 20398.388048358574, 20457.79542204559, 8615.22462978335, 8717.259032982267, 8762.430442021248, 8769.254613357809, 8782.121787821294, 4896.317083467838, 4978.178600530872, 4988.226824842155, 4994.750262486861, 5007.073691367109, 3104.472239719253, 3153.542736303269, 3156.447621666199, 3160.5891234139413, 3166.509191075387, 564.9180868774005, 571.223136534313, 571.8170185540587, 571.911353740171, 576.968266745333, 690.7237105157876, 712.1098626716604, 721.5201890742702, 730.302561054192, 737.2701025984237, 8562.52906090171, 8794.956025219833, 8892.110788921185, 8904.055075808796, 8984.8652270216, 553.2144355015806, 665.2216906219735, 717.2934659360526, 733.2008111158863, 752.6199269368933, 4057.269691455507, 4102.159057393227, 4178.35235538492, 4304.203722311382, 4339.414179085846, 62193.68903155455, 62747.37252627507, 62782.0, 62793.68603157046, 63828.36171638317, 54894.0, 55207.44792552023, 55520.72239638857, 56025.7198714012, 56529.43470565242, 51053.74473127611, 51227.0, 51368.74315628398, 51976.48023519792, 52173.0, 8511.489310641382, 8873.822523549365, 8942.329325300758, 9045.547722613712, 9105.362624616213, 35139.82430087833, 35965.640343597275, 36318.818405907805, 36717.26565468729, 38287.0, 46137.0, 46882.0, 46914.0, 46983.53016469928, 47368.52631473641, 10301.9484902575, 10594.417307048187, 10627.09669678055, 10731.624393146203, 10857.131429485464, 11952.521899123938, 11965.401729913643, 12066.818997714865, 12115.515379384726, 12144.089193310361, 10426.843597346198, 10600.204984626029, 10972.561097556327, 11083.0, 11626.82559761621, 10935.398553079338, 11008.0, 11022.118230541377, 11177.88822111801, 11354.432278386214, 10842.783144337227, 11252.437378130897, 11308.264962777394, 11557.190996630155, 11737.765244695229, 10051.99480051989, 10058.698239052841, 10099.596016159272, 10122.544485498023, 10276.17790576737, 9377.156055954996, 9738.367006144577, 9759.707208783748, 9912.950435247778, 9933.403995760278], "unit": "ms", "name": "yui.html", "value": 6713.100507143562}], "name": "dromaeo_css", "value": 7386.5136941560595}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 111.0, 112.0, 112.0, 121.0, 110.0, 110.0, 112.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [150.0, 129.0, 149.0, 163.0, 127.0, 148.0, 149.0, 140.0, 154.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.2}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 166.0, 162.0, 163.0, 162.0, 161.0, 159.0, 162.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 164.0, 70.0, 73.0, 72.0, 73.0, 157.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 89.9}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 138.0, 91.0, 92.0, 93.0, 146.0, 93.0, 93.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 148.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [59.0, 63.0, 74.0, 60.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 62.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 69.0, 74.0, 67.0, 69.0, 70.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [80.0, 84.0, 81.0, 90.0, 82.0, 82.0, 82.0, 85.0, 90.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [115.0, 122.0, 117.0, 122.0, 124.0, 128.0, 123.0, 115.0, 116.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [137.0, 157.0, 150.0, 145.0, 146.0, 145.0, 149.0, 156.0, 141.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.3}, {"lowerIsBetter": true, "replicates": [71.0, 65.0, 67.0, 65.0, 76.0, 66.0, 66.0, 64.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1515.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.97510373443984], "unit": "score", "name": "Richards", "value": 212.69455}, {"lowerIsBetter": false, "replicates": [167.47613465081227], "unit": "score", "name": "DeltaBlue", "value": 394.79057799999987}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5117.34693877551], "unit": "score", "name": "Decrypt", "value": 52.01542971086741}, {"lowerIsBetter": false, "replicates": [920.8103130755064], "unit": "score", "name": "RayTrace", "value": 803.6280540000001}, {"lowerIsBetter": false, "replicates": [551.8763796909492], "unit": "score", "name": "Earley", "value": 1207.6309559999997}, {"lowerIsBetter": false, "replicates": [11000.0], "unit": "score", "name": "Boyer", "value": 60.58754545454549}, {"lowerIsBetter": false, "replicates": [24000.0], "unit": "score", "name": "RegExp", "value": 37.95770833333335}, {"lowerIsBetter": false, "replicates": [521.376433785193], "unit": "score", "name": "Splay", "value": 156.29973800000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23259.82406831479}]} 10:19:55 INFO - RETURN: dromaeo_css: 7386.52 10:19:55 INFO - RETURN: kraken: 1515.60 10:19:55 INFO - RETURN: v8_7: 23259.82 10:19:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23259.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1515.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7386.52"}}} 10:19:55 INFO - Return code: 0 10:19:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:19:55 INFO - # TBPL SUCCESS # 10:19:55 INFO - Running post-action listener: _resource_record_post_action 10:19:55 INFO - Running post-run listener: _resource_record_post_run 10:19:56 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 0; Write bytes: 503562240; Read time: 0; Write time: 390224 10:19:56 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237350912; Read time: 0; Write time: 251712 10:19:56 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 0; Write bytes: 259444736; Read time: 0; Write time: 136416 10:19:56 INFO - Running post-run listener: _upload_blobber_files 10:19:56 INFO - Blob upload gear active. 10:19:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:19:56 INFO - Copying logs to upload dir... 10:19:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.314720 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-01-22 10:19:55.992544) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 10:19:55.995620) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/dspZIrreQbuDI2eT32GVtA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009998 build_url: 'https://queue.taskcluster.net/v1/task/dspZIrreQbuDI2eT32GVtA/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 10:19:56.046513) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:19:56.046844) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1453485537.269720-1758602310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:19:56.096276) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 10:19:56.096597) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 10:19:56.096904) ========= ========= Total master_lag: 0.29 =========