builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1453730355.72 results: success (0) buildid: 20160125032007 builduid: 6b155104e8bd444aa46ec60f987516d6 revision: c07136d9322ae89f391372e736bb34787e70328d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:15.721983) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:15.722516) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:15.722883) ========= 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=62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006662 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:15.748751) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:15.749099) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:15.765014) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:15.765331) ========= 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=62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:15.816510) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:15.817211) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:15.817893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:15.818254) ========= 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=62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 05:59:16-- 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% 228M=0s 2016-01-25 05:59:16 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.387842 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:16.221893) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:16.222273) ========= 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=62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015949 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:16.274822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:16.275461) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c07136d9322ae89f391372e736bb34787e70328d --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c07136d9322ae89f391372e736bb34787e70328d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 05:59:17,048 truncating revision to first 12 chars 2016-01-25 05:59:17,048 Setting DEBUG logging. 2016-01-25 05:59:17,048 attempt 1/10 2016-01-25 05:59:17,048 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c07136d9322a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 05:59:17,359 unpacking tar archive at: mozilla-aurora-c07136d9322a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622183 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:16.915244) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:16.915689) ========= echo c07136d9322ae89f391372e736bb34787e70328d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c07136d9322ae89f391372e736bb34787e70328d'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c07136d9322ae89f391372e736bb34787e70328d program finished with exit code 0 elapsedTime=0.004635 script_repo_revision: 'c07136d9322ae89f391372e736bb34787e70328d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:16.969681) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:16.970468) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 05:59:16.984000) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-25 05:59:16.984728) ========= /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=62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:59:17 INFO - MultiFileLogger online at 20160125 05:59:17 in /builds/slave/test-pgo 05:59:17 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 05:59:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:59:17 INFO - {'append_to_log': False, 05:59:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:59:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:59:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:59:17 INFO - 'branch': 'Mozilla-Aurora', 05:59:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:59:17 INFO - 'config_files': ('talos/linux_config.py',), 05:59:17 INFO - 'default_actions': ('clobber', 05:59:17 INFO - 'read-buildbot-config', 05:59:17 INFO - 'download-and-extract', 05:59:17 INFO - 'populate-webroot', 05:59:17 INFO - 'create-virtualenv', 05:59:17 INFO - 'install', 05:59:17 INFO - 'run-tests'), 05:59:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:59:17 INFO - 'download_minidump_stackwalk': True, 05:59:17 INFO - 'download_symbols': 'ondemand', 05:59:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:59:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:59:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:59:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:59:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:59:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:59:17 INFO - 'installer_path': 'installer.exe', 05:59:17 INFO - 'log_level': 'info', 05:59:17 INFO - 'log_name': 'talos', 05:59:17 INFO - 'log_to_console': True, 05:59:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:59:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:59:17 INFO - 'opt_config_files': (), 05:59:17 INFO - 'pip_index': False, 05:59:17 INFO - 'sps_profile': False, 05:59:17 INFO - 'sps_profile_interval': 0, 05:59:17 INFO - 'suite': 'dromaeojs-e10s', 05:59:17 INFO - 'system_bits': '32', 05:59:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:59:17 INFO - 'title': 'talos-linux64-ix-018', 05:59:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:59:17 INFO - 'use_talos_json': True, 05:59:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:59:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:59:17 INFO - 'work_dir': 'build'} 05:59:17 INFO - ##### 05:59:17 INFO - ##### Running clobber step. 05:59:17 INFO - ##### 05:59:17 INFO - Running pre-action listener: _resource_record_pre_action 05:59:17 INFO - Running main action method: clobber 05:59:17 INFO - rmtree: /builds/slave/test-pgo/build 05:59:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:59:18 INFO - Running post-action listener: _resource_record_post_action 05:59:18 INFO - ##### 05:59:18 INFO - ##### Running read-buildbot-config step. 05:59:18 INFO - ##### 05:59:18 INFO - Running pre-action listener: _resource_record_pre_action 05:59:18 INFO - Running main action method: read_buildbot_config 05:59:18 INFO - Using buildbot properties: 05:59:18 INFO - { 05:59:18 INFO - "properties": { 05:59:18 INFO - "buildnumber": 14, 05:59:18 INFO - "product": "firefox", 05:59:18 INFO - "script_repo_revision": "production", 05:59:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:59:18 INFO - "repository": "", 05:59:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:59:18 INFO - "buildid": "20160125032007", 05:59:18 INFO - "slavename": "talos-linux64-ix-018", 05:59:18 INFO - "pgo_build": "True", 05:59:18 INFO - "basedir": "/builds/slave/test-pgo", 05:59:18 INFO - "project": "", 05:59:18 INFO - "platform": "ubuntu64_hw", 05:59:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:59:18 INFO - "slavebuilddir": "test", 05:59:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:59:18 INFO - "branch": "mozilla-aurora", 05:59:18 INFO - "repo_path": "releases/mozilla-aurora", 05:59:18 INFO - "stage_platform": "linux64-pgo", 05:59:18 INFO - "builduid": "6b155104e8bd444aa46ec60f987516d6", 05:59:18 INFO - "revision": "c07136d9322ae89f391372e736bb34787e70328d" 05:59:18 INFO - }, 05:59:18 INFO - "sourcestamp": { 05:59:18 INFO - "repository": "", 05:59:18 INFO - "hasPatch": false, 05:59:18 INFO - "project": "", 05:59:18 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 05:59:18 INFO - "changes": [ 05:59:18 INFO - { 05:59:18 INFO - "category": null, 05:59:18 INFO - "files": [ 05:59:18 INFO - { 05:59:18 INFO - "url": null, 05:59:18 INFO - "name": "https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 05:59:18 INFO - } 05:59:18 INFO - ], 05:59:18 INFO - "repository": "", 05:59:18 INFO - "rev": "c07136d9322ae89f391372e736bb34787e70328d", 05:59:18 INFO - "who": "cbook@mozilla.com", 05:59:18 INFO - "when": 1453730294, 05:59:18 INFO - "number": 7510929, 05:59:18 INFO - "comments": "Bug 1240607 - Force CreateWindow hooks to be detours. r=jmathies, a=sylvestre", 05:59:18 INFO - "project": "", 05:59:18 INFO - "at": "Mon 25 Jan 2016 05:58:14", 05:59:18 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 05:59:18 INFO - "revlink": "", 05:59:18 INFO - "properties": [ 05:59:18 INFO - [ 05:59:18 INFO - "buildid", 05:59:18 INFO - "20160125032007", 05:59:18 INFO - "Change" 05:59:18 INFO - ], 05:59:18 INFO - [ 05:59:18 INFO - "builduid", 05:59:18 INFO - "6b155104e8bd444aa46ec60f987516d6", 05:59:18 INFO - "Change" 05:59:18 INFO - ], 05:59:18 INFO - [ 05:59:18 INFO - "pgo_build", 05:59:18 INFO - "True", 05:59:18 INFO - "Change" 05:59:18 INFO - ] 05:59:18 INFO - ], 05:59:18 INFO - "revision": "c07136d9322ae89f391372e736bb34787e70328d" 05:59:18 INFO - } 05:59:18 INFO - ], 05:59:18 INFO - "revision": "c07136d9322ae89f391372e736bb34787e70328d" 05:59:18 INFO - } 05:59:18 INFO - } 05:59:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 05:59:18 INFO - Running post-action listener: _resource_record_post_action 05:59:18 INFO - ##### 05:59:18 INFO - ##### Running download-and-extract step. 05:59:18 INFO - ##### 05:59:18 INFO - Running pre-action listener: _resource_record_pre_action 05:59:18 INFO - Running main action method: download_and_extract 05:59:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:18 INFO - https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:59:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/test_packages.json 05:59:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/test_packages.json 05:59:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:59:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:59:20 INFO - Downloaded 1302 bytes. 05:59:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:59:20 INFO - Using the following test package requirements: 05:59:20 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 05:59:20 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:59:20 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:20 INFO - u'jsshell-linux-x86_64.zip'], 05:59:20 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:59:20 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 05:59:20 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:59:20 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:59:20 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:59:20 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 05:59:20 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:59:20 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05: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')]} 05:59:20 INFO - https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:59:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:59:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:59:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:59:28 INFO - Downloaded 21579566 bytes. 05:59:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:59:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:59:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:59:29 INFO - Return code: 0 05:59:29 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:29 INFO - https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:59:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:59:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:59:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:59:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:59:34 INFO - Downloaded 21579566 bytes. 05:59:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:59:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:59:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:59:35 INFO - Return code: 0 05:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:35 INFO - https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 05:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 05:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 05:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:59:36 INFO - Downloaded 11132038 bytes. 05:59:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:59:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 05:59:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:59:36 INFO - Return code: 0 05:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:36 INFO - https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:59:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:59:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:59:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:59:38 INFO - Downloaded 58068148 bytes. 05:59:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:59:38 INFO - mkdir: /builds/slave/test-pgo/properties 05:59:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:59:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:59:38 INFO - Contents: 05:59:38 INFO - build_url:https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:59:38 INFO - Running post-action listener: _resource_record_post_action 05:59:38 INFO - Running post-action listener: set_extra_try_arguments 05:59:38 INFO - ##### 05:59:38 INFO - ##### Running populate-webroot step. 05:59:38 INFO - ##### 05:59:38 INFO - Running pre-action listener: _resource_record_pre_action 05:59:38 INFO - Running main action method: populate_webroot 05:59:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:59:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:59:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:59:38 INFO - '--tppagecycles', 05:59:38 INFO - '7'], 05:59:38 INFO - 'tests': ['tsvgm']}}, 05:59:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:59:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:59:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:59:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:59:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:59:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:59:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'talos_options': ['--e10s'], 05:59:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'tests': ['damp', 'tps']}, 05:59:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'talos_options': ['--e10s'], 05:59:38 INFO - 'tests': ['damp', 'tps']}, 05:59:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:59:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:59:38 INFO - 'other': {'tests': ['a11yr', 05:59:38 INFO - 'ts_paint', 05:59:38 INFO - 'tpaint', 05:59:38 INFO - 'sessionrestore', 05:59:38 INFO - 'sessionrestore_no_auto_restore']}, 05:59:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:59:38 INFO - 'tests': ['a11yr', 05:59:38 INFO - 'ts_paint', 05:59:38 INFO - 'tpaint', 05:59:38 INFO - 'sessionrestore', 05:59:38 INFO - 'sessionrestore_no_auto_restore']}, 05:59:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:59:38 INFO - 'tests': ['a11yr', 05:59:38 INFO - 'ts_paint', 05:59:38 INFO - 'tpaint', 05:59:38 INFO - 'sessionrestore', 05:59:38 INFO - 'sessionrestore_no_auto_restore']}, 05:59:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:59:38 INFO - 'tests': ['a11yr', 05:59:38 INFO - 'ts_paint', 05:59:38 INFO - 'tpaint', 05:59:38 INFO - 'sessionrestore', 05:59:38 INFO - 'sessionrestore_no_auto_restore']}, 05:59:38 INFO - 'other_l64': {'tests': ['a11yr', 05:59:38 INFO - 'ts_paint', 05:59:38 INFO - 'tpaint', 05:59:38 INFO - 'sessionrestore', 05:59:38 INFO - 'sessionrestore_no_auto_restore']}, 05:59:38 INFO - 'other_nol64': {'tests': ['a11yr', 05:59:38 INFO - 'ts_paint', 05:59:38 INFO - 'tpaint', 05:59:38 INFO - 'sessionrestore', 05:59:38 INFO - 'sessionrestore_no_auto_restore']}, 05:59:38 INFO - 'svgr': {'tests': ['tsvgx', 05:59:38 INFO - 'tsvgr_opacity', 05:59:38 INFO - 'tart', 05:59:38 INFO - 'tscrollx', 05:59:38 INFO - 'cart']}, 05:59:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:59:38 INFO - 'tests': ['tsvgx', 05:59:38 INFO - 'tsvgr_opacity', 05:59:38 INFO - 'tart', 05:59:38 INFO - 'tscrollx', 05:59:38 INFO - 'cart']}, 05:59:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'tests': ['tp5o']}, 05:59:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'talos_options': ['--e10s'], 05:59:38 INFO - 'tests': ['tp5o']}, 05:59:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'talos_options': ['--xperf_path', 05:59:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:38 INFO - 'tests': ['tp5n']}, 05:59:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'talos_options': ['--e10s', 05:59:38 INFO - '--xperf_path', 05:59:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:38 INFO - 'tests': ['tp5n']}}, 05:59:38 INFO - 'talos.zip': {'path': '', 05:59:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:59:38 INFO - Running post-action listener: _resource_record_post_action 05:59:38 INFO - ##### 05:59:38 INFO - ##### Running create-virtualenv step. 05:59:38 INFO - ##### 05:59:38 INFO - Running pre-action listener: _resource_record_pre_action 05:59:38 INFO - Running main action method: create_virtualenv 05:59:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:59:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:59:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:59:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:59:38 INFO - Using real prefix '/usr' 05:59:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:59:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:59:40 INFO - Installing pip.................done. 05:59:40 INFO - Return code: 0 05:59:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f845c114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c09450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ba50>, '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 0x2c07550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c079e0>, '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': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:59:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:59:40 INFO - Using env: {'DISPLAY': ':0', 05:59:40 INFO - 'HOME': '/home/cltbld', 05:59:40 INFO - 'LANG': 'en_US.UTF-8', 05:59:40 INFO - 'LANGUAGE': 'en_US:en', 05:59:40 INFO - 'LOGNAME': 'cltbld', 05:59:40 INFO - 'MAIL': '/var/mail/cltbld', 05:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:40 INFO - 'MOZ_NO_REMOTE': '1', 05:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:40 INFO - 'NO_EM_RESTART': '1', 05:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:40 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:40 INFO - 'SHELL': '/bin/bash', 05:59:40 INFO - 'SHLVL': '1', 05:59:40 INFO - 'TERM': 'linux', 05:59:40 INFO - 'TMOUT': '86400', 05:59:40 INFO - 'USER': 'cltbld', 05:59:40 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 05:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:40 INFO - '_': '/tools/buildbot/bin/python'} 05:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:59:41 INFO - Cleaning up... 05:59:41 INFO - Return code: 0 05:59:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f845c114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c09450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ba50>, '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 0x2c07550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c079e0>, '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': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:59:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:59:41 INFO - Using env: {'DISPLAY': ':0', 05:59:41 INFO - 'HOME': '/home/cltbld', 05:59:41 INFO - 'LANG': 'en_US.UTF-8', 05:59:41 INFO - 'LANGUAGE': 'en_US:en', 05:59:41 INFO - 'LOGNAME': 'cltbld', 05:59:41 INFO - 'MAIL': '/var/mail/cltbld', 05:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:41 INFO - 'MOZ_NO_REMOTE': '1', 05:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:41 INFO - 'NO_EM_RESTART': '1', 05:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:41 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:41 INFO - 'SHELL': '/bin/bash', 05:59:41 INFO - 'SHLVL': '1', 05:59:41 INFO - 'TERM': 'linux', 05:59:41 INFO - 'TMOUT': '86400', 05:59:41 INFO - 'USER': 'cltbld', 05:59:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 05:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:41 INFO - '_': '/tools/buildbot/bin/python'} 05:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:41 INFO - Downloading/unpacking psutil>=0.7.1 05:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:59:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:43 INFO - Installing collected packages: psutil 05:59:43 INFO - Running setup.py install for psutil 05:59:43 INFO - building 'psutil._psutil_linux' extension 05:59:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:59:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:59:43 INFO - building 'psutil._psutil_posix' extension 05:59:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:59:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:59:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:43 INFO - Successfully installed psutil 05:59:43 INFO - Cleaning up... 05:59:43 INFO - Return code: 0 05:59:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:43 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 0x7f845c114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c09450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ba50>, '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 0x2c07550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c079e0>, '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': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:59:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:59:43 INFO - Using env: {'DISPLAY': ':0', 05:59:43 INFO - 'HOME': '/home/cltbld', 05:59:43 INFO - 'LANG': 'en_US.UTF-8', 05:59:43 INFO - 'LANGUAGE': 'en_US:en', 05:59:43 INFO - 'LOGNAME': 'cltbld', 05:59:43 INFO - 'MAIL': '/var/mail/cltbld', 05:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:43 INFO - 'MOZ_NO_REMOTE': '1', 05:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:43 INFO - 'NO_EM_RESTART': '1', 05:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:43 INFO - 'SHELL': '/bin/bash', 05:59:43 INFO - 'SHLVL': '1', 05:59:43 INFO - 'TERM': 'linux', 05:59:43 INFO - 'TMOUT': '86400', 05:59:43 INFO - 'USER': 'cltbld', 05:59:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 05:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:43 INFO - '_': '/tools/buildbot/bin/python'} 05:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:59:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:59:45 INFO - Installing collected packages: mozsystemmonitor 05:59:45 INFO - Running setup.py install for mozsystemmonitor 05:59:45 INFO - Successfully installed mozsystemmonitor 05:59:45 INFO - Cleaning up... 05:59:45 INFO - Return code: 0 05:59:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x7f845c114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c09450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ba50>, '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 0x2c07550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c079e0>, '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': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:59:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:59:45 INFO - Using env: {'DISPLAY': ':0', 05:59:45 INFO - 'HOME': '/home/cltbld', 05:59:45 INFO - 'LANG': 'en_US.UTF-8', 05:59:45 INFO - 'LANGUAGE': 'en_US:en', 05:59:45 INFO - 'LOGNAME': 'cltbld', 05:59:45 INFO - 'MAIL': '/var/mail/cltbld', 05:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:45 INFO - 'MOZ_NO_REMOTE': '1', 05:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:45 INFO - 'NO_EM_RESTART': '1', 05:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:45 INFO - 'SHELL': '/bin/bash', 05:59:45 INFO - 'SHLVL': '1', 05:59:45 INFO - 'TERM': 'linux', 05:59:45 INFO - 'TMOUT': '86400', 05:59:45 INFO - 'USER': 'cltbld', 05:59:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 05:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:45 INFO - '_': '/tools/buildbot/bin/python'} 05:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:46 INFO - Downloading/unpacking blobuploader==1.2.4 05:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:59:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:59:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:59:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:48 INFO - Downloading docopt-0.6.1.tar.gz 05:59:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:59:48 INFO - Installing collected packages: blobuploader, requests, docopt 05:59:48 INFO - Running setup.py install for blobuploader 05:59:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:59:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:59:48 INFO - Running setup.py install for requests 05:59:48 INFO - Running setup.py install for docopt 05:59:49 INFO - Successfully installed blobuploader requests docopt 05:59:49 INFO - Cleaning up... 05:59:49 INFO - Return code: 0 05:59:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:49 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 0x7f845c114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c09450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ba50>, '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 0x2c07550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c079e0>, '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': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:59:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:59:49 INFO - Using env: {'DISPLAY': ':0', 05:59:49 INFO - 'HOME': '/home/cltbld', 05:59:49 INFO - 'LANG': 'en_US.UTF-8', 05:59:49 INFO - 'LANGUAGE': 'en_US:en', 05:59:49 INFO - 'LOGNAME': 'cltbld', 05:59:49 INFO - 'MAIL': '/var/mail/cltbld', 05:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:49 INFO - 'MOZ_NO_REMOTE': '1', 05:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:49 INFO - 'NO_EM_RESTART': '1', 05:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:49 INFO - 'SHELL': '/bin/bash', 05:59:49 INFO - 'SHLVL': '1', 05:59:49 INFO - 'TERM': 'linux', 05:59:49 INFO - 'TMOUT': '86400', 05:59:49 INFO - 'USER': 'cltbld', 05:59:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 05:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:49 INFO - '_': '/tools/buildbot/bin/python'} 05:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:59:49 INFO - Running setup.py (path:/tmp/pip-iOCOXs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:59:49 INFO - Running setup.py (path:/tmp/pip-sIblFA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:59:49 INFO - Running setup.py (path:/tmp/pip-V0ymme-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:59:49 INFO - Running setup.py (path:/tmp/pip-9WRvYR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:59:49 INFO - Running setup.py (path:/tmp/pip-R7m7hB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:59:49 INFO - Running setup.py (path:/tmp/pip-N5SBIl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:59:49 INFO - Running setup.py (path:/tmp/pip-4wQdOL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:59:49 INFO - Running setup.py (path:/tmp/pip-vAvWaC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:59:49 INFO - Running setup.py (path:/tmp/pip-6vqM7e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:59:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:59:49 INFO - Running setup.py (path:/tmp/pip-OYnRgr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:59:50 INFO - Running setup.py (path:/tmp/pip-rWoUv1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:59:50 INFO - Running setup.py (path:/tmp/pip-NQhWph-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:59:50 INFO - Running setup.py (path:/tmp/pip-SX49Fd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:59:50 INFO - Running setup.py (path:/tmp/pip-zfdii8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:59:50 INFO - Running setup.py (path:/tmp/pip-px03T7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:59:50 INFO - Running setup.py (path:/tmp/pip-eLh12I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:59:50 INFO - Running setup.py (path:/tmp/pip-fRI5__-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:59:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:59:50 INFO - Running setup.py install for manifestparser 05:59:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:59:50 INFO - Running setup.py install for mozcrash 05:59:50 INFO - Running setup.py install for mozdebug 05:59:50 INFO - Running setup.py install for mozdevice 05:59:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:59:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:59:50 INFO - Running setup.py install for mozfile 05:59:51 INFO - Running setup.py install for mozhttpd 05:59:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:59:51 INFO - Running setup.py install for mozinfo 05:59:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:59:51 INFO - Running setup.py install for mozInstall 05:59:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:59:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:59:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:59:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:59:51 INFO - Running setup.py install for mozleak 05:59:51 INFO - Running setup.py install for mozlog 05:59:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:59:51 INFO - Running setup.py install for moznetwork 05:59:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:59:51 INFO - Running setup.py install for mozprocess 05:59:51 INFO - Running setup.py install for mozprofile 05:59:51 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:59:51 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:59:51 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:59:51 INFO - Running setup.py install for mozrunner 05:59:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:59:52 INFO - Running setup.py install for mozscreenshot 05:59:52 INFO - Running setup.py install for moztest 05:59:52 INFO - Running setup.py install for mozversion 05:59:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:59:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:59:52 INFO - Cleaning up... 05:59:52 INFO - Return code: 0 05:59:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:52 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 0x7f845c114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c09450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ba50>, '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 0x2c07550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c079e0>, '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': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:59:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:59:52 INFO - Using env: {'DISPLAY': ':0', 05:59:52 INFO - 'HOME': '/home/cltbld', 05:59:52 INFO - 'LANG': 'en_US.UTF-8', 05:59:52 INFO - 'LANGUAGE': 'en_US:en', 05:59:52 INFO - 'LOGNAME': 'cltbld', 05:59:52 INFO - 'MAIL': '/var/mail/cltbld', 05:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:52 INFO - 'MOZ_NO_REMOTE': '1', 05:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:52 INFO - 'NO_EM_RESTART': '1', 05:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:52 INFO - 'SHELL': '/bin/bash', 05:59:52 INFO - 'SHLVL': '1', 05:59:52 INFO - 'TERM': 'linux', 05:59:52 INFO - 'TMOUT': '86400', 05:59:52 INFO - 'USER': 'cltbld', 05:59:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 05:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:52 INFO - '_': '/tools/buildbot/bin/python'} 05:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:59:52 INFO - Running setup.py (path:/tmp/pip-0NfqQh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:59:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:59:52 INFO - Running setup.py (path:/tmp/pip-khILnm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:59:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:59:52 INFO - Running setup.py (path:/tmp/pip-nNZYOe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:59:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:59:52 INFO - Running setup.py (path:/tmp/pip-tg0Yrd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:59:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:59:52 INFO - Running setup.py (path:/tmp/pip-71QaET-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:59:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:59:52 INFO - Running setup.py (path:/tmp/pip-ywAY0A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:59:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:59:52 INFO - Running setup.py (path:/tmp/pip-R6Ik9w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:59:53 INFO - Running setup.py (path:/tmp/pip-_UCFqO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:59:53 INFO - Running setup.py (path:/tmp/pip-5g6i2U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:59:53 INFO - Running setup.py (path:/tmp/pip-JFemXC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:59:53 INFO - Running setup.py (path:/tmp/pip-LHtQzC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:59:53 INFO - Running setup.py (path:/tmp/pip-srZn1f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:59:53 INFO - Running setup.py (path:/tmp/pip-5DaXl5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:59:53 INFO - Running setup.py (path:/tmp/pip-mVjy52-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:59:53 INFO - Running setup.py (path:/tmp/pip-Va03BC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:59:53 INFO - Running setup.py (path:/tmp/pip-dIHuPW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:59:53 INFO - Running setup.py (path:/tmp/pip-43GjN7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:59:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:55 INFO - Downloading blessings-1.6.tar.gz 05:59:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:59:55 INFO - Installing collected packages: blessings 05:59:55 INFO - Running setup.py install for blessings 05:59:55 INFO - Successfully installed blessings 05:59:55 INFO - Cleaning up... 05:59:55 INFO - Return code: 0 05:59:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:59:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:59:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:59:55 INFO - Reading from file tmpfile_stdout 05:59:55 INFO - Current package versions: 05:59:55 INFO - argparse == 1.2.1 05:59:55 INFO - blessings == 1.6 05:59:55 INFO - blobuploader == 1.2.4 05:59:55 INFO - docopt == 0.6.1 05:59:55 INFO - manifestparser == 1.1 05:59:55 INFO - mozInstall == 1.12 05:59:55 INFO - mozcrash == 0.16 05:59:55 INFO - mozdebug == 0.1 05:59:55 INFO - mozdevice == 0.47 05:59:55 INFO - mozfile == 1.2 05:59:55 INFO - mozhttpd == 0.7 05:59:55 INFO - mozinfo == 0.9 05:59:55 INFO - mozleak == 0.1 05:59:55 INFO - mozlog == 3.1 05:59:55 INFO - moznetwork == 0.27 05:59:55 INFO - mozprocess == 0.22 05:59:55 INFO - mozprofile == 0.27 05:59:55 INFO - mozrunner == 6.11 05:59:55 INFO - mozscreenshot == 0.1 05:59:55 INFO - mozsystemmonitor == 0.0 05:59:55 INFO - moztest == 0.7 05:59:55 INFO - mozversion == 1.4 05:59:55 INFO - psutil == 3.1.1 05:59:55 INFO - requests == 1.2.3 05:59:55 INFO - wsgiref == 0.1.2 05:59:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f845c114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c09450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ba50>, '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 0x2c07550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c079e0>, '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': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:59:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:59:55 INFO - Using env: {'DISPLAY': ':0', 05:59:55 INFO - 'HOME': '/home/cltbld', 05:59:55 INFO - 'LANG': 'en_US.UTF-8', 05:59:55 INFO - 'LANGUAGE': 'en_US:en', 05:59:55 INFO - 'LOGNAME': 'cltbld', 05:59:55 INFO - 'MAIL': '/var/mail/cltbld', 05:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:55 INFO - 'MOZ_NO_REMOTE': '1', 05:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:55 INFO - 'NO_EM_RESTART': '1', 05:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:55 INFO - 'SHELL': '/bin/bash', 05:59:55 INFO - 'SHLVL': '1', 05:59:55 INFO - 'TERM': 'linux', 05:59:55 INFO - 'TMOUT': '86400', 05:59:55 INFO - 'USER': 'cltbld', 05:59:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 05:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:55 INFO - '_': '/tools/buildbot/bin/python'} 05:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:59:56 INFO - Cleaning up... 05:59:56 INFO - Return code: 0 05:59:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:56 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 0x7f845c114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c09450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ba50>, '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 0x2c07550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c079e0>, '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': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:59:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:59:56 INFO - Using env: {'DISPLAY': ':0', 05:59:56 INFO - 'HOME': '/home/cltbld', 05:59:56 INFO - 'LANG': 'en_US.UTF-8', 05:59:56 INFO - 'LANGUAGE': 'en_US:en', 05:59:56 INFO - 'LOGNAME': 'cltbld', 05:59:56 INFO - 'MAIL': '/var/mail/cltbld', 05:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:56 INFO - 'MOZ_NO_REMOTE': '1', 05:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:56 INFO - 'NO_EM_RESTART': '1', 05:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:56 INFO - 'SHELL': '/bin/bash', 05:59:56 INFO - 'SHLVL': '1', 05:59:56 INFO - 'TERM': 'linux', 05:59:56 INFO - 'TMOUT': '86400', 05:59:56 INFO - 'USER': 'cltbld', 05:59:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 05:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:56 INFO - '_': '/tools/buildbot/bin/python'} 05:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:56 INFO - Downloading/unpacking jsonschema 05:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:59:58 INFO - Downloading/unpacking functools32 (from jsonschema) 05:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:59:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:59:58 INFO - warning: no files found matching '*.txt' 05:59:58 INFO - no previously-included directories found matching 'build' 05:59:58 INFO - no previously-included directories found matching 'dist' 05:59:58 INFO - no previously-included directories found matching '.git*' 05:59:58 INFO - Installing collected packages: jsonschema, functools32 05:59:58 INFO - Running setup.py install for functools32 05:59:58 INFO - warning: no files found matching '*.txt' 05:59:58 INFO - no previously-included directories found matching 'build' 05:59:58 INFO - no previously-included directories found matching 'dist' 05:59:58 INFO - no previously-included directories found matching '.git*' 05:59:58 INFO - Successfully installed jsonschema functools32 05:59:58 INFO - Cleaning up... 05:59:58 INFO - Return code: 0 05:59:58 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:58 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 0x7f845c114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c09450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9ba50>, '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 0x2c07550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c079e0>, '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': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:59:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:59:58 INFO - Using env: {'DISPLAY': ':0', 05:59:58 INFO - 'HOME': '/home/cltbld', 05:59:58 INFO - 'LANG': 'en_US.UTF-8', 05:59:58 INFO - 'LANGUAGE': 'en_US:en', 05:59:58 INFO - 'LOGNAME': 'cltbld', 05:59:58 INFO - 'MAIL': '/var/mail/cltbld', 05:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:58 INFO - 'MOZ_NO_REMOTE': '1', 05:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:58 INFO - 'NO_EM_RESTART': '1', 05:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:58 INFO - 'SHELL': '/bin/bash', 05:59:58 INFO - 'SHLVL': '1', 05:59:58 INFO - 'TERM': 'linux', 05:59:58 INFO - 'TMOUT': '86400', 05:59:58 INFO - 'USER': 'cltbld', 05:59:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 05:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:58 INFO - '_': '/tools/buildbot/bin/python'} 05:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:58 INFO - Downloading/unpacking flake8 05:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:58 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 06:00:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:00:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:00:00 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 06:00:00 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 06:00:00 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 06:00:00 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 06:00:00 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 06:00:00 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 06:00:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:00:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:00:00 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 06:00:00 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 06:00:00 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 06:00:00 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 06:00:00 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 06:00:00 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 06:00:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:00:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:00:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:00:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:00:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:00:01 INFO - no previously-included directories found matching 'docs/_build' 06:00:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:00:01 INFO - Running setup.py install for pep8 06:00:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:00:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:00:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:00:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:00:01 INFO - no previously-included directories found matching 'docs/_build' 06:00:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:00:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:00:01 INFO - Cleaning up... 06:00:01 INFO - Return code: 0 06:00:01 INFO - Running post-action listener: _resource_record_post_action 06:00:01 INFO - Running post-action listener: _start_resource_monitoring 06:00:01 INFO - Starting resource monitoring. 06:00:01 INFO - ##### 06:00:01 INFO - ##### Running install step. 06:00:01 INFO - ##### 06:00:01 INFO - Running pre-action listener: _resource_record_pre_action 06:00:01 INFO - Running main action method: install 06:00:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:00:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:00:01 INFO - Reading from file tmpfile_stdout 06:00:01 INFO - Detecting whether we're running mozinstall >=1.0... 06:00:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:00:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:00:01 INFO - Reading from file tmpfile_stdout 06:00:01 INFO - Output received: 06:00:01 INFO - Usage: mozinstall [options] installer 06:00:01 INFO - Options: 06:00:01 INFO - -h, --help show this help message and exit 06:00:01 INFO - -d DEST, --destination=DEST 06:00:01 INFO - Directory to install application into. [default: 06:00:01 INFO - "/builds/slave/test-pgo"] 06:00:01 INFO - --app=APP Application being installed. [default: firefox] 06:00:01 INFO - mkdir: /builds/slave/test-pgo/build/application 06:00:01 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'] 06:00:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:00:16 INFO - Reading from file tmpfile_stdout 06:00:16 INFO - Output received: 06:00:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:00:16 INFO - Running post-action listener: _resource_record_post_action 06:00:16 INFO - ##### 06:00:16 INFO - ##### Running run-tests step. 06:00:16 INFO - ##### 06:00:16 INFO - Running pre-action listener: _resource_record_pre_action 06:00:16 INFO - Running main action method: run_tests 06:00:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:00:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:00:16 INFO - Python 2.7.3 06:00:16 INFO - Return code: 0 06:00:16 INFO - grabbing minidump binary from tooltool 06:00: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')]} 06:00:16 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 0x2c9ba50>, '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 0x2c07550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c079e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:00:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 06:00:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:00:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:00:16 INFO - Return code: 0 06:00:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:00:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:00:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:00:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:00:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:00:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:00:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:00:17 INFO - Return code: 0 06:00:17 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/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:00:17 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/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost 06:00:17 INFO - Using env: {'DISPLAY': ':0', 06:00:17 INFO - 'HOME': '/home/cltbld', 06:00:17 INFO - 'LANG': 'en_US.UTF-8', 06:00:17 INFO - 'LANGUAGE': 'en_US:en', 06:00:17 INFO - 'LOGNAME': 'cltbld', 06:00:17 INFO - 'MAIL': '/var/mail/cltbld', 06:00:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:00:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:17 INFO - 'MOZ_NO_REMOTE': '1', 06:00:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:17 INFO - 'NO_EM_RESTART': '1', 06:00:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:17 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:00:17 INFO - 'SHELL': '/bin/bash', 06:00:17 INFO - 'SHLVL': '1', 06:00:17 INFO - 'TERM': 'linux', 06:00:17 INFO - 'TMOUT': '86400', 06:00:17 INFO - 'USER': 'cltbld', 06:00:17 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655', 06:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:17 INFO - '_': '/tools/buildbot/bin/python'} 06:00:17 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/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] with output_timeout 3600 06:00:17 INFO - mozversion INFO | application_buildid: 20160125032007 06:00:17 INFO - mozversion INFO | application_changeset: c07136d9322ae89f391372e736bb34787e70328d 06:00:17 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 06:00:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:00:17 INFO - mozversion INFO | application_name: Firefox 06:00:17 INFO - mozversion INFO | application_remotingname: firefox-dev 06:00:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:00:17 INFO - mozversion INFO | application_vendor: Mozilla 06:00:17 INFO - mozversion INFO | application_version: 45.0a2 06:00:17 INFO - mozversion INFO | platform_buildid: 20160125032007 06:00:17 INFO - mozversion INFO | platform_changeset: c07136d9322ae89f391372e736bb34787e70328d 06:00:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:00:17 INFO - mozversion INFO | platform_version: 45.0a2 06:00:17 INFO - 2016-01-25 06:00:17,783 DEBUG : using testdate: 1453730417 06:00:17 INFO - 2016-01-25 06:00:17,783 DEBUG : actual date: 1453730417 06:00:17 INFO - 2016-01-25 06:00:17,871 INFO : starting webserver on 'localhost:44059' 06:00:17 INFO - 2016-01-25 06:00:17,872 INFO : Starting test suite talos-linux64-ix-018.e 06:00:17 INFO - 2016-01-25 06:00:17,872 INFO : Starting test dromaeo_css 06:00:17 INFO - 2016-01-25 06:00:17,872 DEBUG : operating with platform_type : linux_ 06:00:17 INFO - 2016-01-25 06:00:17,873 INFO : Initialising browser for dromaeo_css test... 06:00:17 INFO - 2016-01-25 06:00:17,889 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpabES7B/profile http://localhost:44059/getInfo.html 06:00:21 INFO - 2016-01-25 06:00:21,269 DEBUG : BROWSER_OUTPUT: 06:00:21 INFO - 2016-01-25 06:00:21,270 DEBUG : BROWSER_OUTPUT: (process:24290): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:00:22 INFO - 2016-01-25 06:00:22,017 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:00:22 INFO - 2016-01-25 06:00:22,018 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:00:22 INFO - 2016-01-25 06:00:22,018 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:00:22 INFO - 2016-01-25 06:00:22,018 DEBUG : BROWSER_OUTPUT: __metrics 06:00:22 INFO - 2016-01-25 06:00:22,946 INFO : Browser initialized. 06:00:22 INFO - 2016-01-25 06:00:22,947 INFO : Running cycle 1/1 for dromaeo_css test... 06:00:22 INFO - 2016-01-25 06:00:22,947 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpabES7B/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:00:24 INFO - 2016-01-25 06:00:24,209 DEBUG : BROWSER_OUTPUT: 06:00:24 INFO - 2016-01-25 06:00:24,210 DEBUG : BROWSER_OUTPUT: (process:24404): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:00:34 INFO - 2016-01-25 06:00:34,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 138043392 06:00:34 INFO - 2016-01-25 06:00:34,714 DEBUG : BROWSER_OUTPUT: 06:01:24 INFO - 2016-01-25 06:01:24,336 DEBUG : BROWSER_OUTPUT: 1453730484329 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:03:32 INFO - 2016-01-25 06:03:32,233 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44059/tests/dromaeo/cssquery-ext.html) 06:03:33 INFO - 2016-01-25 06:03:33,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 142094336 06:03:33 INFO - 2016-01-25 06:03:33,218 DEBUG : BROWSER_OUTPUT: 06:06:35 INFO - 2016-01-25 06:06:35,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/dromaeo/cssquery-ext.html (next: http://localhost:44059/tests/dromaeo/cssquery-jquery.html) 06:06:35 INFO - 2016-01-25 06:06:35,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 139268096 06:06:35 INFO - 2016-01-25 06:06:35,593 DEBUG : BROWSER_OUTPUT: 06:09:37 INFO - 2016-01-25 06:09:37,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44059/tests/dromaeo/cssquery-mootools.html) 06:09:37 INFO - 2016-01-25 06:09:37,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 137900032 06:09:37 INFO - 2016-01-25 06:09:37,785 DEBUG : BROWSER_OUTPUT: 06:12:39 INFO - 2016-01-25 06:12:39,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44059/tests/dromaeo/cssquery-prototype.html) 06:12:40 INFO - 2016-01-25 06:12:40,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 139091968 06:12:40 INFO - 2016-01-25 06:12:40,002 DEBUG : BROWSER_OUTPUT: 06:15:42 INFO - 2016-01-25 06:15:42,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44059/tests/dromaeo/cssquery-yui.html) 06:15:42 INFO - 2016-01-25 06:15:42,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 140189696 06:15:42 INFO - 2016-01-25 06:15:42,862 DEBUG : BROWSER_OUTPUT: 06:18:44 INFO - 2016-01-25 06:18:44,721 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/dromaeo/cssquery-yui.html (next: http://localhost:44059/tests/dromaeo/cssquery-dojo.html) 06:18:44 INFO - 2016-01-25 06:18:44,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 141123584 06:18:44 INFO - 2016-01-25 06:18:44,972 DEBUG : BROWSER_OUTPUT: 06:18:44 INFO - 2016-01-25 06:18:44,974 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:18:44 INFO - 2016-01-25 06:18:44,974 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:18:44 INFO - 2016-01-25 06:18:44,974 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:18:44 INFO - 2016-01-25 06:18:44,974 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:18:44 INFO - 2016-01-25 06:18:44,974 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3361.3949489091965;3414.6073201581794;3428.2457859270953;3435.450327947528;3458.948115778262;5590.217369568264;5634.295713035871;5662.207290979266;5663.377028526858;5679.716014199289;5616.831495055155;5675.233843431136;5675.716214189284;5688.971555142219;5703.287089113861;5115.974420127904;5173;5212.035773381936;5222.216667499867;5255.237990491377;5025.3718285214345;5039.84880453587;5127.512886275797;5144.974275128619;5241;5137.2037334213255;5142.51146141116;5176.55999240065;5194.63637545372;5196.1166601677805;5121.103806833789;5146.562542183919;5190.299309593194;5195.506426889439;5211.244369566411;4891.951080489185;4911.533404326583;4970.204767237225;4997.5002499749735;5109.718965456898;5418.512333889929;5430.782768689248;5477.424870388591;5488.929658716552;5517.862053448655;6032.728527216286;6036.426539478743;6044.365341639153;6105.389461053859;6120.20437343147;5834.854128646775;5946.970265148647;5956.22569066023;6073.453389194994;6116.082587611894;5511.889762204773;5523.28197334344;5537.723113844291;5549.472800083986;5606.131049687305;5982.132590774313;5987.520998320124;5997.070454079538;6015.488683461867;6036.8188954331445;5782.421757824268;5782.710864456761;5858.355580886185;5930.199423077829;5970.940290597126;5942.821715348547;5962.135490353961;5972.552058595623;5973.701314934236;5985.760569577168;5841.415858414124;5891.204687367151;5924.407559244041;5930.140129681258;5963.880722385528;5896.911546326808;5897.882042359129;5939.22790037301;5941;5966.940330596725;4584.724916505021;4653.371794807726;4686.437627484655;4687.179743544866;4712.787924543404;4074.5110586729784;4160.667146628262;4164.354525048622;4194.601512856274;4237.0466645005245;5638.971805140948;5709.05800542914;5711.971845067845;5730.169125476783;5762.222100016528;6133.754649814046;6152.323244443197;6156.168917196122;6160.1375807387;6161.476274516716;5468;5618.831435056954;5691.743871525791;5767.711614419262;5789.8552536186935;5171.32772739549;5194.194899790538;5268.420473747885;5355.357357117171;5360.249565060894;6237.625742455467;6261.686915654199;6265.091561723616;6267.1539342189135;6291.433770960635;6153.077038444269;6162.537809664203;6168.414000669929;6171.5988460751705;6173.506119510518;6032.92131924139;6048.183495228088;6117.827404800828;6164.137020817179;6230.190075290183;5917.911231331447;5939.762409503572;5955.106733989936;5984.640921544721;6001.189839371629;5915.674637894957;6003.099535069775;6031.336552979256;6041.818745437644;6046.5767396281835;5757.107648314518;5791;5828.737706803119;5848.239728835224;5868.2958045033165;5826.796062137974;5913.083472061838;5916.763329466773;5928.79249226275;5955.91066134017;5702.657840529581;5743.540516758733;5754.424557544212;5863.941360586339;5881.3236477803885;5851.61964472308;5859.179714839841;5916.408359164049;5918;5922.466977971831;5753.8561535961935;5859.296884373903;5861.238039054895;5884.293884733859;5889.469947704556 06:18:44 INFO - 2016-01-25 06:18:44,975 DEBUG : BROWSER_OUTPUT: |1;ext.html;601.6841158391846;635.6091004032521;642.3319747462639;650.80150554081;693.3447891742302;32664.510032349503;41341;41608.37587436191;42057.15885682288;42074.368884466756;46004.309935351;46763;46854.53145468544;46896.531034689644;46897.53102468974;9062.682806101804;9254.352195346328;9264.397814142092;9289.767755806126;9303.348765586377;9074.682386116487;9186.494742789177;9196.356255062148;9199.172074513292;9219.124183202584;9101.863472047924;9142.954285228565;9209.033051529594;9213.907860921405;9218.76953076175;9043.412178208428;9125.269978401746;9140;9165.17513423795;9176.95411522938;8986.730398088068;9126.224270936978;9127.497987610679;9144.725658230263;9164.26685865136;42539.361909571075;42729.78635106805;42878.78560607208;43028.78485607552;43129.568704313184;3701;3812.8093595320124;3851.826667799956;3903.6486716195677;4160.583941605845;30274.84862575695;30944.0716778497;31167.376652466824;31512;31607.209819754462;3615.0781550704664;3631.927361452756;3654.780713157219;3669.8165091745304;3722.683571896392;280571;281227;282470;283436;283741;46140.30789538159;46184;46192;46248.537514625095;46321.30518042232;43693;43795;43844.56155438405;44085.77957110194;44208;16134.354625814836;16369.918150409172;16374.83625163757;16377.590560236089;16413.91793041051;13028.80456793149;13342.399592018382;13385.598432047054;13498.392572334269;14037.78943315851;15584.45454409113;15767.369305227663;15786.9210653946;15833.445829395916;15871.365145394286;6215.844603884939;6229.4393504584805;6305.180326557518;6347.52393570484;6366.331535188739;1027.5170669785189;1047.1151876664208;1099.2250463423268;1122.226881527185;1174.9353785541878;30607.387852243275;33625.49561756576;35013.649863501545;35055.29889402249;35198.64801352005;1110.3559935237543;1165.6328256599145;1174.541928647828;1195.3067221011793;1245.4582256718356;15630.765538516931;15692.293846776922;15894.12582307961;15928.523297312044;16157.272922718506;407828;507501;510383;514525;566942;61118.38881611216;61655.38344616586;61793.38206617876;61802.381976180564;61846.69076654588;1516.673915108257;1545.1424459425127;1553.0448774003905;1558.3143416896755;1563.9452619158276;32015.67984320127;32269.10716780834;32473.35053298968;32551.348973019933;33324.66675333313;52072.73963630309;52260.21609675782;52554.47445525496;52606.47393526016;52698.73650631875;319932;322350;322683;323680;323990;35779.28441431209;36068.819655901556;36095.81952090223;36220.4566931491;36497.817510912275;47538.76230618825;48485.75757121192;48690;48923.26615100847;49097.263541046195;40269.79865100656;40417.79791101025;40629;40846.1830763389;41251.1749765009;35902.281954361286;37729.81135094307;37962.43056354102;39753.2049359017;40711.79644101761;39339;39990.40062395935;40181.598184017785;40573.79713101416;40594;34095;34117.829410852784;34596.654033459345;34714.65285347114;40036.799816000734;27282.863585681946;27831.02591409291;27998;28021;28064.29839254035 06:18:44 INFO - 2016-01-25 06:18:44,977 DEBUG : BROWSER_OUTPUT: |2;jquery.html;384.6384398665255;386.3534786711032;392.3780807420239;392.4113829256116;396.071213005502;16143.192840357993;16786;17703.1148442578;18872.150753216105;18883.905580472077;11888;12522.248665080102;13359.799603005962;18470.261189552435;18491.90754046231;4961.007798440309;5256.159014557672;5398.73006349681;5599.552035837143;5788.6816225107605;5763.1355296705415;5826.067829147337;5827.504662103726;5830.300363956331;5839.649621022731;5255.86860328491;5409.702466364349;5432.348118225818;5736.856578585548;5762.4525670061485;5397.865053373677;5408.702521361323;5416.458354164592;5440.483154100354;5642.266505354319;5575.637583557096;5584.748686309085;5602.1596760485845;5614.129809879475;5614.27014488118;13673.794893076612;16513.504594862054;22482.32553023412;22598.322050338516;22768.430789230235;2185.67214917762;2190.375742913262;2258.4128126687015;2320.071971211512;2328.55757406094;10586.682399528027;11103.55585776568;11326.263792853439;13306.933465332708;14406.279686015761;1896.7723873135174;1976.2984140630012;2003.5091402606308;2007.2773801431474;2044.2742826296599;56998.43001570014;57269;60857.39142608562;63485.682571587306;64458;10887.782244355069;10922.126229901589;10940.070094041936;11036.558537658564;11076.335419874833;14149.29253537319;14220.928895355664;14228.857711422754;14254.429822806971;14273.429062837578;8549.316054715608;8637.740867773977;8661.566921653892;8749.825003499895;8754.781130471662;8435.620397082146;8524.914750852537;8582.527960962207;8628.568571571397;8680.045195028542;4826.806927722922;4894.583960363409;4910.435299940481;4937.333459982857;4960.801567937314;1998.700194970737;2020.2625741861987;2026.4832467720637;2044.2129780034793;2050.846186536016;964.7539877331236;1011.4184344002228;1051.1223128687632;1104.5802595013843;1105.795427845851;17428.738568921475;17558.29766809339;17563.824361756473;17678.93926364422;18234.726479102825;988.8121256961155;994.3288280410694;1016.5323950982483;1017.9921877341378;1075.7902209069157;10047.196224302039;10302.381857088598;10325.9483702581;10337.948310258551;10354.53404596795;555833;567071;568184;575535;577391;73006.63496682483;83375;87128.12871871327;88471;89627.55186224157;1209.7580483903255;1213.5873802907054;1231.5197073141483;1258.1633213912828;1278.1755767529892;15350.692986140439;15432.691346173238;15466.767998480256;15480.767788482957;15615.843841561438;36546.26907461783;36916.261674766894;37218.44172337363;37269.6273037277;37502.2499550002;49127.26309105438;50896.74551627218;51493.227601586754;51664.225036625234;51806;9914.30599858032;10026.398416095057;10120.898791011996;10207.387556746618;10210.846837297595;12076.577319793765;17909.552261193574;18172;18179.818201818343;18185.909070454563;15028.849711502746;15215.695686085995;15348.386064557739;15464.226788660748;15667.529974100795;14405.85594144087;14511.564653060424;14865.331060102106;15018.324175412352;15206.619834504227;15063.623409414853;15201.467948621745;15421.228938552804;15736.449224277096;15759.68480630404;9690.224782017563;9771.12059914611;10116.84824727615;10224.948875255575;10326.122279606318;14619.707605848036;14779.704405912036;14841;14849.40602375893;14979.686274117968 06:18:44 INFO - 2016-01-25 06:18:44,978 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1576.7556028815538;1577.18774830962;1811.8097599752025;1821.581036361636;1849.3712137873124;7896.091949425818;8094.554799486026;8254.834903301931;8255.83488330233;8267;8260.66957321708;8262.173782621734;8331.208535189162;8346.290565301957;8363.4563753356;2331.6502524621274;2361.504084142332;2377.9643305350432;2379.1078345620394;2382.249591378719;2326.9185578504757;2349.5300939812105;2359.6460530920413;2360.398098484884;2365.089440565386;2254.3124347074217;2292.277932451281;2317.1079134533243;2338.871362075085;2361.244401791427;2253.6281513550243;2296.850704704197;2297.173017713622;2298.4139044543704;2301.390131615123;2324.0587562037404;2339.9649005264932;2348.377679914824;2348.5889969255313;2349.682792822964;8113.188681131898;8149.551774652392;8200.917990820075;8206.425550211488;8210.630521626541;4616.699914505546;4674.7428891410955;4683.461401938786;4705.388299521074;4735.952640473585;2921.5179495383236;2983.5077212260167;3014.8492575371365;3020.2147441665325;3025.198322444554;898.2050884966851;900.5452246615483;907.9409838360551;914.3782228084899;916.6562539047857;11050.723731906766;11072.446377681164;11122.388268645222;11125.499352529074;11129.499172537255;4116.732412393245;4349.760763157993;4475.48531918827;4496.527864574238;4521.231390663529;9175.449473031505;9237.769055773526;9246.768830779285;9246.90753092474;9256.07439256069;4854.951450485521;4885.998370334073;4894.926576101361;4898.90202195954;4904.926426103611;4419.315006174048;4423.137488189836;4453.888652783707;4467.15124126415;4476.664250181184;3705.3886108792285;3741.2330472253125;3778.981105094457;3782.470454136423;3803.6576708096404;1177.0995188680495;1194.7610477904454;1202.22456515547;1202.446874437751;1205.7226837827172;1001.3241062283075;1002.0580654185043;1188.3167178872184;1310.102579732886;1398.119184913498;7622.466427350032;7660;7669.463137580427;7674.769756907302;7677.654505547152;675.8780424495314;683.8871586188322;695.1484431571386;695.544418405945;824.579464473123;6033.456988871023;6038.30559485656;6043;6053.909191362045;6082.239720034996;9286;9564.76088097803;9915.256355773347;9921.702348929544;9950.1542368898;9657.46883921377;9659.613615455444;9710.70867873965;9730.17293530058;9780.413175209367;7188.065551478275;7295.01517295169;7339.339459448675;7352.742654007191;7653.081630204411;7597.468177227541;7653.158152603321;7658.425618078555;7668.309852113337;7735.690572377267;8120.83758324842;8625.482471051757;8716.171963663443;8728.869066963875;8761.561921904007;8631.44633965867;8770.780730481789;8906.242969347679;8912.598933047899;9010.81978360416;7334.779956601311;7425;7429.07136607924;7466.887996679946;7482;7619.885701714368;7843.647035883285;7955.960220198862;8032.116467188488;8035.276825085771;7280.199178090512;7334.743283985035;7466.589337586485;7474.065741782278;7502.737404190827;7193.5324203926575;7240.348368646847;7287.234840341688;7387.963060184665;7403.037605111301;7301.08736407949;7405.96297018533;7412.925870741439;7445;7511.9624401877645;6662;6671.166104236971;6711.765088221889;6723.361280678328;6726.8654626908165;6868.519203655696;6960.582365058112;6963;6965.233824279224;6988.161420629557 06:18:44 INFO - 2016-01-25 06:18:44,980 DEBUG : BROWSER_OUTPUT: |4;prototype.html;359.42312588295783;363.5800650248963;367.15371069684375;368.0577721034153;368.3664097751866;6212.378762123785;6393.073004414368;6423.1328770615955;6474.125992990951;6477.935220647792;6145.324014358417;6344.841378965528;6381.553291269602;6384.553081284312;6385.712642931067;4879.902401951958;4914.287428322891;4919.335889654886;4922.926156107644;4925.38432695913;4919.942212424328;4930;4930.433000204968;4931.26031095335;4935.679180853251;4703.882402939937;4799.400074990626;4817.060673168733;4836.758162091899;4867.221244600864;4788.329633851264;4795;4796.592289655384;4816;4835.347228124228;4111.1366613011305;4224.746515209097;4234.809433575497;4237.4491316129015;4240.703150779446;6006.609570377956;6027.336992930774;6057.606255593372;6081.148639190517;6111.816645500642;5631.267935168402;5649.774009039675;5651.7739290428335;5664.773409063632;5665.433456654343;6535.967320163416;6726.697298621574;6744.089547911019;6757.324267573253;6767.120274364351;4640.350350950869;4645.047765208158;4711.269753188261;4718.693284936468;4721.480637129913;6952.93047069533;7022.4382049436435;7022.964885175593;7029.261927497641;7030.4727145463785;4769.952300476951;4771.212749896297;4774.116788394158;4778.235482322812;4783.736894470768;4784.258439941815;4816.253480710496;4862.246351815475;4870.975645121752;4899.118158731462;5631.943680563224;5637.238972738628;5645.5483561314995;5648.915266271009;5664.26364572603;6680.365365290289;6733.629650369178;6785.592864428051;6801.693923773442;6806.727730890808;1695.9491215263563;1730.5068055604092;1732.1079643983358;1733.410640382251;1735.1064201936013;1131.9943400282946;1154.3650991954391;1154.468944285638;1159.3565571108115;1163.3950345820126;6522.608643481406;6569.080328753978;6586.868262634721;6592.670366481657;6592.76925307612;6994.370506654425;6994.510384273154;6998.125234345707;7001.824954376181;7003.474739394565;6419.51853610981;6556.639384833785;6564.081028655992;6569.178852643419;6571.704273307712;3753.0992561784974;3757.3800322946954;3803;3806.238752249561;3811.618838116166;7297.343239108506;7297.562146271134;7330.340269375782;7331.413486921034;7338.559686418832;7251.093613298338;7251.202367739545;7269.818254543678;7272.8181795454475;7274.854502910018;7150.284971502808;7178.892316615255;7260.382867456326;7269.6728647211;7289.599072051088;7078.115235595551;7093.3970612498515;7106.253843346374;7118.110236220473;7122.964385178041;7004.544704594185;7008.299170082951;7009.107540964013;7018.543794653331;7023.438124950094;7142.821434463463;7264.600446975467;7280.089988751406;7283.543291341859;7309.817254568678;4805.663603547718;4831.661783675249;4849.4908034657265;4850.442199147144;4869.099216644932;7036.577805331696;7037.753678621224;7044.189918159273;7070.505064645631;7071.7878463646175;6774.830629234309;6896.689648965909;6901.620410877249;6901.827454313481;6907.585544867123;6885;6886.10480637514;6888;6892.241853396223;6892.517523773287;6655.695192499656;6694.631795251308;6696.531242813151;6740.730370785113;6745.460363171032;6840.521163518506;6926.099607051253;6929.757458488929;6935.861282774417;6951.860962780817;6692.564983276072;6703.564268322543;6735.6968936397;6736.93263067363;6745.291744366771 06:18:44 INFO - 2016-01-25 06:18:44,981 DEBUG : BROWSER_OUTPUT: |5;yui.html;852.5779739029182;930.7440453875183;931.9068093190682;945.7210123013713;947.9857802132965;11767.941160294196;12150.392480375967;12196.329201893892;12208.694782630439;12255.26468411896;13093.803592946113;13183.604491865235;13190.472381104744;13199.868001319985;13203.669908252274;759.0511860174781;771.4715419937361;912.6668765900432;925.1442415765424;926.3885835348638;930.7998780262242;931.1433481197281;932.0958670090035;932.5849996751448;934.8036912248436;948.2935213266127;948.3266880514843;950.9239260859149;952.6046690623383;953.4422362917702;942.1473566422399;946.4368700623119;947.1759569174793;948.7485816258697;952.476138124029;696.9930300696979;697.1425147069083;702.3362922038675;702.8945658151267;703.5356664601338;13397.397117129753;13601.659958501117;13607.727845443036;13624.727505449835;13645.454181832714;13221.206727596278;13336.933315333361;13354.666133346647;13419.46322147113;13443.932780336036;10005.79988400228;10160.136388406994;10674.146068314516;10758.569657213702;10839.512221950032;3818.274527839729;3907.531096268466;3929.135590170187;3930.272899513599;3931.5871833457363;50431.24353134669;50792.238116427914;50841.49158508442;50974.235386469234;51710;10788.46057697112;10919.836202456969;10944.890551094546;10996.780064398827;11227.831582526269;19922.402327930184;20001;20048.69926951097;20058.097385617682;20081.799182008286;6905.551139175937;7080.539764915264;7557.35762460186;7650.273224043707;7900.604969751489;4401.493828209733;4495.887602809956;4510.391097201901;4550.931736023962;4605.240135377625;3074.1853408846673;3095.3190298134373;3096.845157742149;3105.782595218313;3117.2830249042845;604.4801470735164;617.6633734614646;621.3631028196135;633.0504243634548;635.8760041791807;624.1667374055686;634.6160572853357;649.7628365646505;649.8440374310131;662.6421732264523;8336.749897503085;8369.707060252862;8441.11368306319;8499.872501912476;8608.354373422018;491.5698763581866;569.1917477182411;598.949089327412;639.1212083385345;648.0344287012317;3681.7606855554304;3688.372976593932;3797.6582107610448;3895.824687889052;3901.8752117335425;59580.404195958356;59629.403705963254;59730.41617502964;63901.44394224272;64839.35160648428;47855.5214447858;48208.5179148211;48580;49954.50045499499;50020.99999999927;48747.26879096816;50226.74886625543;50341.74829125831;51018;51407.485925141016;8546.658133674831;8595.785105372415;8685.261752751087;9017.774555636162;9116.726498205064;35618.821905890305;35994.10014749652;36452;36766;36800.89597312085;45144;45256.77371613121;50503.747481262355;51428.48571514237;51612.48387516227;10506.737331566466;10823.56705731762;10981.286216396229;11102.888971110186;11153.996140347408;12033.578824741093;12080.637580872588;12151.878481215428;12268.509259629514;12324;11025.338479691245;11425.542978281108;11452.427378630868;11468.197226194086;11484.138689598147;11158.163137764863;11234.719132021764;11492.310461372344;11565.669947956092;11831;10763.031327180592;11278.323300601991;11338.319700817978;11518.82721759191;11754.11844111678;9384.812303754023;9584.829054539043;9695.22438204956;9720.222382209266;9847.261455391017;9268.351215414856;9390.295727820305;9423.481708506099;9710.368826026286;9853.852192217266 06:18:44 INFO - 2016-01-25 06:18:44,981 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:18:44 INFO - 2016-01-25 06:18:44,983 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:18:44 INFO - 2016-01-25 06:18:44,983 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,296 06:18:44 INFO - 2016-01-25 06:18:44,983 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:18:44 INFO - 2016-01-25 06:18:44,983 DEBUG : BROWSER_OUTPUT: __startTimestamp1453731524972__endTimestamp 06:18:44 INFO - 2016-01-25 06:18:44,983 DEBUG : BROWSER_OUTPUT: 06:18:44 INFO - 2016-01-25 06:18:44,983 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:18:44 INFO - 2016-01-25 06:18:44,984 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:18:44 INFO - 2016-01-25 06:18:44,984 DEBUG : BROWSER_OUTPUT: 06:18:44 INFO - 2016-01-25 06:18:44,984 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5591.38 Median:5791.00 stddev:604.29 (10.4%) stddev-sans-first:580.27 06:18:44 INFO - 2016-01-25 06:18:44,984 DEBUG : BROWSER_OUTPUT: Values: 3361.4 3414.6 3428.2 3435.5 3458.9 5590.2 5634.3 5662.2 5663.4 5679.7 5616.8 5675.2 5675.7 5689.0 5703.3 5116.0 5173.0 5212.0 5222.2 5255.2 5025.4 5039.8 5127.5 5145.0 5241.0 5137.2 5142.5 5176.6 5194.6 5196.1 5121.1 5146.6 5190.3 5195.5 5211.2 4892.0 4911.5 4970.2 4997.5 5109.7 5418.5 5430.8 5477.4 5488.9 5517.9 6032.7 6036.4 6044.4 6105.4 6120.2 5834.9 5947.0 5956.2 6073.5 6116.1 5511.9 5523.3 5537.7 5549.5 5606.1 5982.1 5987.5 5997.1 6015.5 6036.8 5782.4 5782.7 5858.4 5930.2 5970.9 5942.8 5962.1 5972.6 5973.7 5985.8 5841.4 5891.2 5924.4 5930.1 5963.9 5896.9 5897.9 5939.2 5941.0 5966.9 4584.7 4653.4 4686.4 4687.2 4712.8 4074.5 4160.7 4164.4 4194.6 4237.0 5639.0 5709.1 5712.0 5730.2 5762.2 6133.8 6152.3 6156.2 6160.1 6161.5 5468.0 5618.8 5691.7 5767.7 5789.9 5171.3 5194.2 5268.4 5355.4 5360.2 6237.6 6261.7 6265.1 6267.2 6291.4 6153.1 6162.5 6168.4 6171.6 6173.5 6032.9 6048.2 6117.8 6164.1 6230.2 5917.9 5939.8 5955.1 5984.6 6001.2 5915.7 6003.1 6031.3 6041.8 6046.6 5757.1 5791.0 5828.7 5848.2 5868.3 5826.8 5913.1 5916.8 5928.8 5955.9 5702.7 5743.5 5754.4 5863.9 5881.3 5851.6 5859.2 5916.4 5918.0 5922.5 5753.9 5859.3 5861.2 5884.3 5889.5 06:18:44 INFO - 2016-01-25 06:18:44,984 DEBUG : BROWSER_OUTPUT: 06:18:44 INFO - 2016-01-25 06:18:44,984 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:53619.75 Median:40109.20 stddev:101059.67 (252.0%) stddev-sans-first:101264.77 06:18:44 INFO - 2016-01-25 06:18:44,986 DEBUG : BROWSER_OUTPUT: Values: 601.7 635.6 642.3 650.8 693.3 32664.5 41341.0 41608.4 42057.2 42074.4 46004.3 46763.0 46854.5 46896.5 46897.5 9062.7 9254.4 9264.4 9289.8 9303.3 9074.7 9186.5 9196.4 9199.2 9219.1 9101.9 9143.0 9209.0 9213.9 9218.8 9043.4 9125.3 9140.0 9165.2 9177.0 8986.7 9126.2 9127.5 9144.7 9164.3 42539.4 42729.8 42878.8 43028.8 43129.6 3701.0 3812.8 3851.8 3903.6 4160.6 30274.8 30944.1 31167.4 31512.0 31607.2 3615.1 3631.9 3654.8 3669.8 3722.7 280571.0 281227.0 282470.0 283436.0 283741.0 46140.3 46184.0 46192.0 46248.5 46321.3 43693.0 43795.0 43844.6 44085.8 44208.0 16134.4 16369.9 16374.8 16377.6 16413.9 13028.8 13342.4 13385.6 13498.4 14037.8 15584.5 15767.4 15786.9 15833.4 15871.4 6215.8 6229.4 6305.2 6347.5 6366.3 1027.5 1047.1 1099.2 1122.2 1174.9 30607.4 33625.5 35013.6 35055.3 35198.6 1110.4 1165.6 1174.5 1195.3 1245.5 15630.8 15692.3 15894.1 15928.5 16157.3 407828.0 507501.0 510383.0 514525.0 566942.0 61118.4 61655.4 61793.4 61802.4 61846.7 1516.7 1545.1 1553.0 1558.3 1563.9 32015.7 32269.1 32473.4 32551.3 33324.7 52072.7 52260.2 52554.5 52606.5 52698.7 319932.0 322350.0 322683.0 323680.0 323990.0 35779.3 36068.8 36095.8 36220.5 36497.8 47538.8 48485.8 48690.0 48923.3 49097.3 40269.8 40417.8 40629.0 40846.2 41251.2 35902.3 37729.8 37962.4 39753.2 40711.8 39339.0 39990.4 40181.6 40573.8 40594.0 34095.0 34117.8 34596.7 34714.7 40036.8 27282.9 27831.0 27998.0 28021.0 28064.3 06:18:44 INFO - 2016-01-25 06:18:44,986 DEBUG : BROWSER_OUTPUT: 06:18:44 INFO - 2016-01-25 06:18:44,986 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30338.05 Median:2013.77 stddev:92918.85 (4614.2%) stddev-sans-first:93152.29 06:18:44 INFO - 2016-01-25 06:18:44,987 DEBUG : BROWSER_OUTPUT: Values: 384.6 386.4 392.4 392.4 396.1 16143.2 16786.0 17703.1 18872.2 18883.9 11888.0 12522.2 13359.8 18470.3 18491.9 4961.0 5256.2 5398.7 5599.6 5788.7 5763.1 5826.1 5827.5 5830.3 5839.6 5255.9 5409.7 5432.3 5736.9 5762.5 5397.9 5408.7 5416.5 5440.5 5642.3 5575.6 5584.7 5602.2 5614.1 5614.3 13673.8 16513.5 22482.3 22598.3 22768.4 2185.7 2190.4 2258.4 2320.1 2328.6 10586.7 11103.6 11326.3 13306.9 14406.3 1896.8 1976.3 2003.5 2007.3 2044.3 56998.4 57269.0 60857.4 63485.7 64458.0 10887.8 10922.1 10940.1 11036.6 11076.3 14149.3 14220.9 14228.9 14254.4 14273.4 8549.3 8637.7 8661.6 8749.8 8754.8 8435.6 8524.9 8582.5 8628.6 8680.0 4826.8 4894.6 4910.4 4937.3 4960.8 1998.7 2020.3 2026.5 2044.2 2050.8 964.8 1011.4 1051.1 1104.6 1105.8 17428.7 17558.3 17563.8 17678.9 18234.7 988.8 994.3 1016.5 1018.0 1075.8 10047.2 10302.4 10325.9 10337.9 10354.5 555833.0 567071.0 568184.0 575535.0 577391.0 73006.6 83375.0 87128.1 88471.0 89627.6 1209.8 1213.6 1231.5 1258.2 1278.2 15350.7 15432.7 15466.8 15480.8 15615.8 36546.3 36916.3 37218.4 37269.6 37502.2 49127.3 50896.7 51493.2 51664.2 51806.0 9914.3 10026.4 10120.9 10207.4 10210.8 12076.6 17909.6 18172.0 18179.8 18185.9 15028.8 15215.7 15348.4 15464.2 15667.5 14405.9 14511.6 14865.3 15018.3 15206.6 15063.6 15201.5 15421.2 15736.4 15759.7 9690.2 9771.1 10116.8 10224.9 10326.1 14619.7 14779.7 14841.0 14849.4 14979.7 06:18:44 INFO - 2016-01-25 06:18:44,987 DEBUG : BROWSER_OUTPUT: 06:18:44 INFO - 2016-01-25 06:18:44,987 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5673.48 Median:6961.79 stddev:2980.02 (42.8%) stddev-sans-first:2972.47 06:18:44 INFO - 2016-01-25 06:18:44,988 DEBUG : BROWSER_OUTPUT: Values: 1576.8 1577.2 1811.8 1821.6 1849.4 7896.1 8094.6 8254.8 8255.8 8267.0 8260.7 8262.2 8331.2 8346.3 8363.5 2331.7 2361.5 2378.0 2379.1 2382.2 2326.9 2349.5 2359.6 2360.4 2365.1 2254.3 2292.3 2317.1 2338.9 2361.2 2253.6 2296.9 2297.2 2298.4 2301.4 2324.1 2340.0 2348.4 2348.6 2349.7 8113.2 8149.6 8200.9 8206.4 8210.6 4616.7 4674.7 4683.5 4705.4 4736.0 2921.5 2983.5 3014.8 3020.2 3025.2 898.2 900.5 907.9 914.4 916.7 11050.7 11072.4 11122.4 11125.5 11129.5 4116.7 4349.8 4475.5 4496.5 4521.2 9175.4 9237.8 9246.8 9246.9 9256.1 4855.0 4886.0 4894.9 4898.9 4904.9 4419.3 4423.1 4453.9 4467.2 4476.7 3705.4 3741.2 3779.0 3782.5 3803.7 1177.1 1194.8 1202.2 1202.4 1205.7 1001.3 1002.1 1188.3 1310.1 1398.1 7622.5 7660.0 7669.5 7674.8 7677.7 675.9 683.9 695.1 695.5 824.6 6033.5 6038.3 6043.0 6053.9 6082.2 9286.0 9564.8 9915.3 9921.7 9950.2 9657.5 9659.6 9710.7 9730.2 9780.4 7188.1 7295.0 7339.3 7352.7 7653.1 7597.5 7653.2 7658.4 7668.3 7735.7 8120.8 8625.5 8716.2 8728.9 8761.6 8631.4 8770.8 8906.2 8912.6 9010.8 7334.8 7425.0 7429.1 7466.9 7482.0 7619.9 7843.6 7956.0 8032.1 8035.3 7280.2 7334.7 7466.6 7474.1 7502.7 7193.5 7240.3 7287.2 7388.0 7403.0 7301.1 7406.0 7412.9 7445.0 7512.0 6662.0 6671.2 6711.8 6723.4 6726.9 6868.5 6960.6 6963.0 6965.2 6988.2 06:18:44 INFO - 2016-01-25 06:18:44,988 DEBUG : BROWSER_OUTPUT: 06:18:44 INFO - 2016-01-25 06:18:44,989 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5690.52 Median:6500.27 stddev:1726.72 (26.6%) stddev-sans-first:1684.56 06:18:44 INFO - 2016-01-25 06:18:44,989 DEBUG : BROWSER_OUTPUT: Values: 359.4 363.6 367.2 368.1 368.4 6212.4 6393.1 6423.1 6474.1 6477.9 6145.3 6344.8 6381.6 6384.6 6385.7 4879.9 4914.3 4919.3 4922.9 4925.4 4919.9 4930.0 4930.4 4931.3 4935.7 4703.9 4799.4 4817.1 4836.8 4867.2 4788.3 4795.0 4796.6 4816.0 4835.3 4111.1 4224.7 4234.8 4237.4 4240.7 6006.6 6027.3 6057.6 6081.1 6111.8 5631.3 5649.8 5651.8 5664.8 5665.4 6536.0 6726.7 6744.1 6757.3 6767.1 4640.4 4645.0 4711.3 4718.7 4721.5 6952.9 7022.4 7023.0 7029.3 7030.5 4770.0 4771.2 4774.1 4778.2 4783.7 4784.3 4816.3 4862.2 4871.0 4899.1 5631.9 5637.2 5645.5 5648.9 5664.3 6680.4 6733.6 6785.6 6801.7 6806.7 1695.9 1730.5 1732.1 1733.4 1735.1 1132.0 1154.4 1154.5 1159.4 1163.4 6522.6 6569.1 6586.9 6592.7 6592.8 6994.4 6994.5 6998.1 7001.8 7003.5 6419.5 6556.6 6564.1 6569.2 6571.7 3753.1 3757.4 3803.0 3806.2 3811.6 7297.3 7297.6 7330.3 7331.4 7338.6 7251.1 7251.2 7269.8 7272.8 7274.9 7150.3 7178.9 7260.4 7269.7 7289.6 7078.1 7093.4 7106.3 7118.1 7123.0 7004.5 7008.3 7009.1 7018.5 7023.4 7142.8 7264.6 7280.1 7283.5 7309.8 4805.7 4831.7 4849.5 4850.4 4869.1 7036.6 7037.8 7044.2 7070.5 7071.8 6774.8 6896.7 6901.6 6901.8 6907.6 6885.0 6886.1 6888.0 6892.2 6892.5 6655.7 6694.6 6696.5 6740.7 6745.5 6840.5 6926.1 6929.8 6935.9 6951.9 6692.6 6703.6 6735.7 6736.9 6745.3 06:18:44 INFO - 2016-01-25 06:18:44,989 DEBUG : BROWSER_OUTPUT: 06:18:44 INFO - 2016-01-25 06:18:44,989 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14281.57 Median:24619.42 stddev:16803.99 (68.3%) stddev-sans-first:16820.87 06:18:44 INFO - 2016-01-25 06:18:44,989 DEBUG : BROWSER_OUTPUT: Values: 852.6 930.7 931.9 945.7 948.0 11767.9 12150.4 12196.3 12208.7 12255.3 13093.8 13183.6 13190.5 13199.9 13203.7 759.1 771.5 912.7 925.1 926.4 930.8 931.1 932.1 932.6 934.8 948.3 948.3 950.9 952.6 953.4 942.1 946.4 947.2 948.7 952.5 697.0 697.1 702.3 702.9 703.5 13397.4 13601.7 13607.7 13624.7 13645.5 13221.2 13336.9 13354.7 13419.5 13443.9 10005.8 10160.1 10674.1 10758.6 10839.5 3818.3 3907.5 3929.1 3930.3 3931.6 50431.2 50792.2 50841.5 50974.2 51710.0 10788.5 10919.8 10944.9 10996.8 11227.8 19922.4 20001.0 20048.7 20058.1 20081.8 6905.6 7080.5 7557.4 7650.3 7900.6 4401.5 4495.9 4510.4 4550.9 4605.2 3074.2 3095.3 3096.8 3105.8 3117.3 604.5 617.7 621.4 633.1 635.9 624.2 634.6 649.8 649.8 662.6 8336.7 8369.7 8441.1 8499.9 8608.4 491.6 569.2 598.9 639.1 648.0 3681.8 3688.4 3797.7 3895.8 3901.9 59580.4 59629.4 59730.4 63901.4 64839.4 47855.5 48208.5 48580.0 49954.5 50021.0 48747.3 50226.7 50341.7 51018.0 51407.5 8546.7 8595.8 8685.3 9017.8 9116.7 35618.8 35994.1 36452.0 36766.0 36800.9 45144.0 45256.8 50503.7 51428.5 51612.5 10506.7 10823.6 10981.3 11102.9 11154.0 12033.6 12080.6 12151.9 12268.5 12324.0 11025.3 11425.5 11452.4 11468.2 11484.1 11158.2 11234.7 11492.3 11565.7 11831.0 10763.0 11278.3 11338.3 11518.8 11754.1 9384.8 9584.8 9695.2 9720.2 9847.3 9268.4 9390.3 9423.5 9710.4 9853.9 06:18:44 INFO - 2016-01-25 06:18:44,989 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:18:44 INFO - 2016-01-25 06:18:44,989 DEBUG : BROWSER_OUTPUT: 06:18:45 INFO - 2016-01-25 06:18:45,575 INFO : Browser exited with error code: 0 06:18:45 INFO - 2016-01-25 06:18:45,596 INFO : Completed test dromaeo_css (00:18:27) 06:18:45 INFO - 2016-01-25 06:18:45,596 INFO : Starting test kraken 06:18:45 INFO - 2016-01-25 06:18:45,596 DEBUG : operating with platform_type : linux_ 06:18:45 INFO - 2016-01-25 06:18:45,596 INFO : Initialising browser for kraken test... 06:18:45 INFO - 2016-01-25 06:18:45,602 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppfR17Z/profile http://localhost:44059/getInfo.html 06:18:49 INFO - 2016-01-25 06:18:49,016 DEBUG : BROWSER_OUTPUT: 06:18:49 INFO - 2016-01-25 06:18:49,017 DEBUG : BROWSER_OUTPUT: (process:24667): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:18:49 INFO - 2016-01-25 06:18:49,819 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:18:49 INFO - 2016-01-25 06:18:49,820 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:18:49 INFO - 2016-01-25 06:18:49,820 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:18:49 INFO - 2016-01-25 06:18:49,820 DEBUG : BROWSER_OUTPUT: __metrics 06:18:50 INFO - 2016-01-25 06:18:50,770 INFO : Browser initialized. 06:18:50 INFO - 2016-01-25 06:18:50,771 INFO : Running cycle 1/1 for kraken test... 06:18:50 INFO - 2016-01-25 06:18:50,771 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppfR17Z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:18:52 INFO - 2016-01-25 06:18:52,087 DEBUG : BROWSER_OUTPUT: 06:18:52 INFO - 2016-01-25 06:18:52,087 DEBUG : BROWSER_OUTPUT: (process:24778): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:19:02 INFO - 2016-01-25 06:19:02,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 136093696 06:19:02 INFO - 2016-01-25 06:19:02,597 DEBUG : BROWSER_OUTPUT: 06:19:05 INFO - 2016-01-25 06:19:05,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44059/tests/kraken/driver.html?testName=audio-beat-detection) 06:19:05 INFO - 2016-01-25 06:19:05,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 138633216 06:19:05 INFO - 2016-01-25 06:19:05,644 DEBUG : BROWSER_OUTPUT: 06:19:08 INFO - 2016-01-25 06:19:08,269 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44059/tests/kraken/driver.html?testName=audio-dft) 06:19:08 INFO - 2016-01-25 06:19:08,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 138600448 06:19:08 INFO - 2016-01-25 06:19:08,856 DEBUG : BROWSER_OUTPUT: 06:19:11 INFO - 2016-01-25 06:19:11,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44059/tests/kraken/driver.html?testName=audio-fft) 06:19:12 INFO - 2016-01-25 06:19:12,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 139198464 06:19:12 INFO - 2016-01-25 06:19:12,269 DEBUG : BROWSER_OUTPUT: 06:19:14 INFO - 2016-01-25 06:19:14,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44059/tests/kraken/driver.html?testName=audio-oscillator) 06:19:14 INFO - 2016-01-25 06:19:14,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 137912320 06:19:14 INFO - 2016-01-25 06:19:14,868 DEBUG : BROWSER_OUTPUT: 06:19:17 INFO - 2016-01-25 06:19:17,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44059/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:19:17 INFO - 2016-01-25 06:19:17,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 138493952 06:19:17 INFO - 2016-01-25 06:19:17,648 DEBUG : BROWSER_OUTPUT: 06:19:20 INFO - 2016-01-25 06:19:20,585 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44059/tests/kraken/driver.html?testName=imaging-darkroom) 06:19:21 INFO - 2016-01-25 06:19:21,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 138797056 06:19:21 INFO - 2016-01-25 06:19:21,172 DEBUG : BROWSER_OUTPUT: 06:19:24 INFO - 2016-01-25 06:19:24,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44059/tests/kraken/driver.html?testName=imaging-desaturate) 06:19:25 INFO - 2016-01-25 06:19:25,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 139624448 06:19:25 INFO - 2016-01-25 06:19:25,101 DEBUG : BROWSER_OUTPUT: 06:19:27 INFO - 2016-01-25 06:19:27,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44059/tests/kraken/driver.html?testName=json-parse-financial) 06:19:28 INFO - 2016-01-25 06:19:28,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 139128832 06:19:28 INFO - 2016-01-25 06:19:28,526 DEBUG : BROWSER_OUTPUT: 06:19:30 INFO - 2016-01-25 06:19:30,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44059/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:19:30 INFO - 2016-01-25 06:19:30,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 137986048 06:19:30 INFO - 2016-01-25 06:19:30,708 DEBUG : BROWSER_OUTPUT: 06:19:32 INFO - 2016-01-25 06:19:32,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44059/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:19:33 INFO - 2016-01-25 06:19:33,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 137691136 06:19:33 INFO - 2016-01-25 06:19:33,087 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2016-01-25 06:19:35,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44059/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:19:35 INFO - 2016-01-25 06:19:35,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 138686464 06:19:35 INFO - 2016-01-25 06:19:35,710 DEBUG : BROWSER_OUTPUT: 06:19:38 INFO - 2016-01-25 06:19:38,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:19:38 INFO - 2016-01-25 06:19:38,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 137940992 06:19:38 INFO - 2016-01-25 06:19:38,686 DEBUG : BROWSER_OUTPUT: 06:19:41 INFO - 2016-01-25 06:19:41,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:19:41 INFO - 2016-01-25 06:19:41,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 138194944 06:19:41 INFO - 2016-01-25 06:19:41,769 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44059/tests/kraken/driver.html?testName=ai-astar) 06:19:43 INFO - 2016-01-25 06:19:43,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 139501568 06:19:43 INFO - 2016-01-25 06:19:43,656 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,657 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:19:43 INFO - 2016-01-25 06:19:43,658 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:19:43 INFO - 2016-01-25 06:19:43,658 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:19:43 INFO - 2016-01-25 06:19:43,658 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:19:43 INFO - 2016-01-25 06:19:43,658 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;106;111;110;110;121;110;111;110;111 06:19:43 INFO - 2016-01-25 06:19:43,658 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;123;155;158;130;152;151;125;163;123 06:19:43 INFO - 2016-01-25 06:19:43,658 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;160;161;160;162;161;161;160;165;163 06:19:43 INFO - 2016-01-25 06:19:43,658 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;73;155;71;72;71;72;168;70 06:19:43 INFO - 2016-01-25 06:19:43,659 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;147;92;93;93;142;92;92;139 06:19:43 INFO - 2016-01-25 06:19:43,659 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;109;109;110 06:19:43 INFO - 2016-01-25 06:19:43,659 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;153;148;147;146;146;146;147 06:19:43 INFO - 2016-01-25 06:19:43,659 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;97;96;96;97;96;96;97 06:19:43 INFO - 2016-01-25 06:19:43,659 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;60;60;62;62;69;62;62;61;58 06:19:43 INFO - 2016-01-25 06:19:43,659 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;66;66;66;66;66;65;65;66;66 06:19:43 INFO - 2016-01-25 06:19:43,659 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;80;82;82;82;90;80;84;82;82 06:19:43 INFO - 2016-01-25 06:19:43,659 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;109;118;119;114;120;122;127;114;122 06:19:43 INFO - 2016-01-25 06:19:43,660 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;150;147;143;146;134;147;142;137;146 06:19:43 INFO - 2016-01-25 06:19:43,660 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;65;65;69;65;66;65;64;64;65 06:19:43 INFO - 2016-01-25 06:19:43,660 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:19:43 INFO - 2016-01-25 06:19:43,660 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:19:43 INFO - 2016-01-25 06:19:43,660 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,715 06:19:43 INFO - 2016-01-25 06:19:43,660 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:19:43 INFO - 2016-01-25 06:19:43,660 DEBUG : BROWSER_OUTPUT: __startTimestamp1453731583656__endTimestamp 06:19:43 INFO - 2016-01-25 06:19:43,661 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,664 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:19:43 INFO - 2016-01-25 06:19:43,664 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:19:43 INFO - 2016-01-25 06:19:43,664 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,665 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:3.78 (3.4%) stddev-sans-first:4.01 06:19:43 INFO - 2016-01-25 06:19:43,665 DEBUG : BROWSER_OUTPUT: Values: 111.0 106.0 111.0 110.0 110.0 121.0 110.0 111.0 110.0 111.0 06:19:43 INFO - 2016-01-25 06:19:43,665 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,665 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.30 Median:152.50 stddev:16.01 (10.5%) stddev-sans-first:16.59 06:19:43 INFO - 2016-01-25 06:19:43,665 DEBUG : BROWSER_OUTPUT: Values: 153.0 123.0 155.0 158.0 130.0 152.0 151.0 125.0 163.0 123.0 06:19:43 INFO - 2016-01-25 06:19:43,665 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,666 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.77 (1.1%) stddev-sans-first:1.67 06:19:43 INFO - 2016-01-25 06:19:43,666 DEBUG : BROWSER_OUTPUT: Values: 164.0 160.0 161.0 160.0 162.0 161.0 161.0 160.0 165.0 163.0 06:19:43 INFO - 2016-01-25 06:19:43,666 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,666 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.80 Median:72.00 stddev:37.93 (52.7%) stddev-sans-first:39.74 06:19:43 INFO - 2016-01-25 06:19:43,666 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 73.0 155.0 71.0 72.0 71.0 72.0 168.0 70.0 06:19:43 INFO - 2016-01-25 06:19:43,666 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,666 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.50 Median:92.00 stddev:24.35 (26.5%) stddev-sans-first:25.17 06:19:43 INFO - 2016-01-25 06:19:43,666 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 147.0 92.0 93.0 93.0 142.0 92.0 92.0 139.0 06:19:43 INFO - 2016-01-25 06:19:43,666 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,668 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:19:43 INFO - 2016-01-25 06:19:43,668 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0 110.0 06:19:43 INFO - 2016-01-25 06:19:43,668 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,668 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:2.11 (1.4%) stddev-sans-first:2.24 06:19:43 INFO - 2016-01-25 06:19:43,668 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 153.0 148.0 147.0 146.0 146.0 146.0 147.0 06:19:43 INFO - 2016-01-25 06:19:43,668 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,668 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:19:43 INFO - 2016-01-25 06:19:43,668 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 97.0 06:19:43 INFO - 2016-01-25 06:19:43,668 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,668 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.70 Median:62.00 stddev:2.87 (4.6%) stddev-sans-first:3.03 06:19:43 INFO - 2016-01-25 06:19:43,668 DEBUG : BROWSER_OUTPUT: Values: 61.0 60.0 60.0 62.0 62.0 69.0 62.0 62.0 61.0 58.0 06:19:43 INFO - 2016-01-25 06:19:43,668 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,668 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 06:19:43 INFO - 2016-01-25 06:19:43,668 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 66.0 66.0 66.0 66.0 65.0 65.0 66.0 66.0 06:19:43 INFO - 2016-01-25 06:19:43,668 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,669 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.00 stddev:2.88 (3.5%) stddev-sans-first:3.00 06:19:43 INFO - 2016-01-25 06:19:43,669 DEBUG : BROWSER_OUTPUT: Values: 81.0 80.0 82.0 82.0 82.0 90.0 80.0 84.0 82.0 82.0 06:19:43 INFO - 2016-01-25 06:19:43,669 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,669 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:119.50 stddev:5.06 (4.2%) stddev-sans-first:5.36 06:19:43 INFO - 2016-01-25 06:19:43,669 DEBUG : BROWSER_OUTPUT: Values: 119.0 109.0 118.0 119.0 114.0 120.0 122.0 127.0 114.0 122.0 06:19:43 INFO - 2016-01-25 06:19:43,669 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,669 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:146.00 stddev:5.43 (3.7%) stddev-sans-first:5.17 06:19:43 INFO - 2016-01-25 06:19:43,669 DEBUG : BROWSER_OUTPUT: Values: 136.0 150.0 147.0 143.0 146.0 134.0 147.0 142.0 137.0 146.0 06:19:43 INFO - 2016-01-25 06:19:43,669 DEBUG : BROWSER_OUTPUT: 06:19:43 INFO - 2016-01-25 06:19:43,669 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.00 stddev:1.65 (2.5%) stddev-sans-first:1.50 06:19:43 INFO - 2016-01-25 06:19:43,669 DEBUG : BROWSER_OUTPUT: Values: 68.0 65.0 65.0 69.0 65.0 66.0 65.0 64.0 64.0 65.0 06:19:43 INFO - 2016-01-25 06:19:43,669 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:19:43 INFO - 2016-01-25 06:19:43,669 DEBUG : BROWSER_OUTPUT: 06:19:44 INFO - 2016-01-25 06:19:44,483 INFO : Browser exited with error code: 0 06:19:44 INFO - 2016-01-25 06:19:44,536 INFO : Completed test kraken (00:00:58) 06:19:44 INFO - 2016-01-25 06:19:44,536 INFO : Starting test v8_7 06:19:44 INFO - 2016-01-25 06:19:44,537 DEBUG : operating with platform_type : linux_ 06:19:44 INFO - 2016-01-25 06:19:44,537 INFO : Initialising browser for v8_7 test... 06:19:44 INFO - 2016-01-25 06:19:44,543 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDw0lxh/profile http://localhost:44059/getInfo.html 06:19:48 INFO - 2016-01-25 06:19:48,074 DEBUG : BROWSER_OUTPUT: 06:19:48 INFO - 2016-01-25 06:19:48,074 DEBUG : BROWSER_OUTPUT: (process:25086): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:19:48 INFO - 2016-01-25 06:19:48,882 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:19:48 INFO - 2016-01-25 06:19:48,882 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:19:48 INFO - 2016-01-25 06:19:48,882 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:19:48 INFO - 2016-01-25 06:19:48,882 DEBUG : BROWSER_OUTPUT: __metrics 06:19:49 INFO - 2016-01-25 06:19:49,786 INFO : Browser initialized. 06:19:49 INFO - 2016-01-25 06:19:49,787 INFO : Running cycle 1/1 for v8_7 test... 06:19:49 INFO - 2016-01-25 06:19:49,787 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDw0lxh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:19:51 INFO - 2016-01-25 06:19:51,078 DEBUG : BROWSER_OUTPUT: 06:19:51 INFO - 2016-01-25 06:19:51,080 DEBUG : BROWSER_OUTPUT: (process:25201): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:20:01 INFO - 2016-01-25 06:20:01,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 135921664 06:20:01 INFO - 2016-01-25 06:20:01,588 DEBUG : BROWSER_OUTPUT: 06:20:22 INFO - 2016-01-25 06:20:22,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44059/tests/v8_7/run.html (next: http://localhost:44059/tests/v8_7/run.html) 06:20:23 INFO - 2016-01-25 06:20:23,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 136351744 06:20:23 INFO - 2016-01-25 06:20:23,182 DEBUG : BROWSER_OUTPUT: 06:20:23 INFO - 2016-01-25 06:20:23,183 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:20:23 INFO - 2016-01-25 06:20:23,184 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:20:23 INFO - 2016-01-25 06:20:23,184 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:20:23 INFO - 2016-01-25 06:20:23,184 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:20:23 INFO - 2016-01-25 06:20:23,184 DEBUG : BROWSER_OUTPUT: |0;Richards;165.371258475277 06:20:23 INFO - 2016-01-25 06:20:23,184 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;172.95053614666205 06:20:23 INFO - 2016-01-25 06:20:23,184 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.77777777777777 06:20:23 INFO - 2016-01-25 06:20:23,184 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 06:20:23 INFO - 2016-01-25 06:20:23,185 DEBUG : BROWSER_OUTPUT: |4;RayTrace;932.8358208955224 06:20:23 INFO - 2016-01-25 06:20:23,185 DEBUG : BROWSER_OUTPUT: |5;Earley;550.9641873278237 06:20:23 INFO - 2016-01-25 06:20:23,185 DEBUG : BROWSER_OUTPUT: |6;Boyer;10978.260869565218 06:20:23 INFO - 2016-01-25 06:20:23,185 DEBUG : BROWSER_OUTPUT: |7;RegExp;24166.666666666668 06:20:23 INFO - 2016-01-25 06:20:23,185 DEBUG : BROWSER_OUTPUT: |8;Splay;516.5289256198347 06:20:23 INFO - 2016-01-25 06:20:23,186 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 06:20:23 INFO - 2016-01-25 06:20:23,186 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:20:23 INFO - 2016-01-25 06:20:23,186 DEBUG : BROWSER_OUTPUT: __startTimestamp1453731623182__endTimestamp 06:20:23 INFO - 2016-01-25 06:20:23,186 DEBUG : BROWSER_OUTPUT: 06:20:23 INFO - 2016-01-25 06:20:23,186 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:20:23 INFO - 2016-01-25 06:20:23,187 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:20:23 INFO - 2016-01-25 06:20:23,187 DEBUG : BROWSER_OUTPUT: 06:20:23 INFO - 2016-01-25 06:20:23,187 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.37 Median:165.37 stddev:0.00 (0.0%) 06:20:23 INFO - 2016-01-25 06:20:23,187 DEBUG : BROWSER_OUTPUT: Values: 165.4 06:20:23 INFO - 2016-01-25 06:20:23,187 DEBUG : BROWSER_OUTPUT: 06:20:23 INFO - 2016-01-25 06:20:23,187 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:172.95 Median:172.95 stddev:0.00 (0.0%) 06:20:23 INFO - 2016-01-25 06:20:23,188 DEBUG : BROWSER_OUTPUT: Values: 173.0 06:20:23 INFO - 2016-01-25 06:20:23,188 DEBUG : BROWSER_OUTPUT: 06:20:23 INFO - 2016-01-25 06:20:23,188 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.78 Median:277.78 stddev:0.00 (0.0%) 06:20:23 INFO - 2016-01-25 06:20:23,188 DEBUG : BROWSER_OUTPUT: Values: 277.8 06:20:23 INFO - 2016-01-25 06:20:23,188 DEBUG : BROWSER_OUTPUT: 06:20:23 INFO - 2016-01-25 06:20:23,188 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 06:20:23 INFO - 2016-01-25 06:20:23,189 DEBUG : BROWSER_OUTPUT: Values: 5128.2 06:20:23 INFO - 2016-01-25 06:20:23,189 DEBUG : BROWSER_OUTPUT: 06:20:23 INFO - 2016-01-25 06:20:23,189 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:932.84 Median:932.84 stddev:0.00 (0.0%) 06:20:23 INFO - 2016-01-25 06:20:23,189 DEBUG : BROWSER_OUTPUT: Values: 932.8 06:20:23 INFO - 2016-01-25 06:20:23,190 DEBUG : BROWSER_OUTPUT: 06:20:23 INFO - 2016-01-25 06:20:23,190 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:550.96 Median:550.96 stddev:0.00 (0.0%) 06:20:23 INFO - 2016-01-25 06:20:23,190 DEBUG : BROWSER_OUTPUT: Values: 551.0 06:20:23 INFO - 2016-01-25 06:20:23,190 DEBUG : BROWSER_OUTPUT: 06:20:23 INFO - 2016-01-25 06:20:23,190 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10978.26 Median:10978.26 stddev:0.00 (0.0%) 06:20:23 INFO - 2016-01-25 06:20:23,190 DEBUG : BROWSER_OUTPUT: Values: 10978.3 06:20:23 INFO - 2016-01-25 06:20:23,191 DEBUG : BROWSER_OUTPUT: 06:20:23 INFO - 2016-01-25 06:20:23,192 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24166.67 Median:24166.67 stddev:0.00 (0.0%) 06:20:23 INFO - 2016-01-25 06:20:23,192 DEBUG : BROWSER_OUTPUT: Values: 24166.7 06:20:23 INFO - 2016-01-25 06:20:23,192 DEBUG : BROWSER_OUTPUT: 06:20:23 INFO - 2016-01-25 06:20:23,192 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:516.53 Median:516.53 stddev:0.00 (0.0%) 06:20:23 INFO - 2016-01-25 06:20:23,192 DEBUG : BROWSER_OUTPUT: Values: 516.5 06:20:23 INFO - 2016-01-25 06:20:23,193 DEBUG : BROWSER_OUTPUT: 06:20:23 INFO - 2016-01-25 06:20:23,193 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 06:20:23 INFO - 2016-01-25 06:20:23,193 DEBUG : BROWSER_OUTPUT: Values: 4840.6 06:20:23 INFO - 2016-01-25 06:20:23,193 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:20:23 INFO - 2016-01-25 06:20:23,193 DEBUG : BROWSER_OUTPUT: 06:20:23 INFO - 2016-01-25 06:20:23,994 INFO : Browser exited with error code: 0 06:20:24 INFO - 2016-01-25 06:20:24,011 INFO : Completed test v8_7 (00:00:39) 06:20:24 INFO - 2016-01-25 06:20:24,234 INFO : Completed test suite (00:20:06) 06:20:24 INFO - 2016-01-25 06:20:24,234 DEBUG : Working with test: dromaeo_css 06:20:24 INFO - 2016-01-25 06:20:24,234 DEBUG : Generating results file: dromaeo_css 06:20:24 INFO - 2016-01-25 06:20:24,236 DEBUG : Working with test: kraken 06:20:24 INFO - 2016-01-25 06:20:24,236 DEBUG : Generating results file: kraken 06:20:24 INFO - 2016-01-25 06:20:24,236 INFO : javascript benchmark 06:20:24 INFO - 2016-01-25 06:20:24,236 DEBUG : Working with test: v8_7 06:20:24 INFO - 2016-01-25 06:20:24,236 DEBUG : Generating results file: v8_7 06:20:24 INFO - 2016-01-25 06:20:24,237 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:20:24 INFO - 2016-01-25 06:20:24,392 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 06:20:24 INFO - 2016-01-25 06:20:24,393 DEBUG : process_Request line: dromaeo_css 7352.96 graph.html#tests=[[72,52,43]] 06:20:24 INFO - 2016-01-25 06:20:24,393 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:20:24 INFO - 2016-01-25 06:20:24,519 DEBUG : process_Request line: kraken 1503.60 graph.html#tests=[[232,52,43]] 06:20:24 INFO - 2016-01-25 06:20:24,519 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:20:24 INFO - 2016-01-25 06:20:24,632 DEBUG : process_Request line: v8_7 23181.05 graph.html#tests=[[230,52,43]] 06:20:24 INFO - 2016-01-25 06:20:24,633 INFO : javascript benchmark 06:20:24 INFO - 2016-01-25 06:20:24,637 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3361.3949489091965, 3414.6073201581794, 3428.2457859270953, 3435.450327947528, 3458.948115778262, 5590.217369568264, 5634.295713035871, 5662.207290979266, 5663.377028526858, 5679.716014199289, 5616.831495055155, 5675.233843431136, 5675.716214189284, 5688.971555142219, 5703.287089113861, 5115.974420127904, 5173.0, 5212.035773381936, 5222.216667499867, 5255.237990491377, 5025.3718285214345, 5039.84880453587, 5127.512886275797, 5144.974275128619, 5241.0, 5137.2037334213255, 5142.51146141116, 5176.55999240065, 5194.63637545372, 5196.1166601677805, 5121.103806833789, 5146.562542183919, 5190.299309593194, 5195.506426889439, 5211.244369566411, 4891.951080489185, 4911.533404326583, 4970.204767237225, 4997.5002499749735, 5109.718965456898, 5418.512333889929, 5430.782768689248, 5477.424870388591, 5488.929658716552, 5517.862053448655, 6032.728527216286, 6036.426539478743, 6044.365341639153, 6105.389461053859, 6120.20437343147, 5834.854128646775, 5946.970265148647, 5956.22569066023, 6073.453389194994, 6116.082587611894, 5511.889762204773, 5523.28197334344, 5537.723113844291, 5549.472800083986, 5606.131049687305, 5982.132590774313, 5987.520998320124, 5997.070454079538, 6015.488683461867, 6036.8188954331445, 5782.421757824268, 5782.710864456761, 5858.355580886185, 5930.199423077829, 5970.940290597126, 5942.821715348547, 5962.135490353961, 5972.552058595623, 5973.701314934236, 5985.760569577168, 5841.415858414124, 5891.204687367151, 5924.407559244041, 5930.140129681258, 5963.880722385528, 5896.911546326808, 5897.882042359129, 5939.22790037301, 5941.0, 5966.940330596725, 4584.724916505021, 4653.371794807726, 4686.437627484655, 4687.179743544866, 4712.787924543404, 4074.5110586729784, 4160.667146628262, 4164.354525048622, 4194.601512856274, 4237.0466645005245, 5638.971805140948, 5709.05800542914, 5711.971845067845, 5730.169125476783, 5762.222100016528, 6133.754649814046, 6152.323244443197, 6156.168917196122, 6160.1375807387, 6161.476274516716, 5468.0, 5618.831435056954, 5691.743871525791, 5767.711614419262, 5789.8552536186935, 5171.32772739549, 5194.194899790538, 5268.420473747885, 5355.357357117171, 5360.249565060894, 6237.625742455467, 6261.686915654199, 6265.091561723616, 6267.1539342189135, 6291.433770960635, 6153.077038444269, 6162.537809664203, 6168.414000669929, 6171.5988460751705, 6173.506119510518, 6032.92131924139, 6048.183495228088, 6117.827404800828, 6164.137020817179, 6230.190075290183, 5917.911231331447, 5939.762409503572, 5955.106733989936, 5984.640921544721, 6001.189839371629, 5915.674637894957, 6003.099535069775, 6031.336552979256, 6041.818745437644, 6046.5767396281835, 5757.107648314518, 5791.0, 5828.737706803119, 5848.239728835224, 5868.2958045033165, 5826.796062137974, 5913.083472061838, 5916.763329466773, 5928.79249226275, 5955.91066134017, 5702.657840529581, 5743.540516758733, 5754.424557544212, 5863.941360586339, 5881.3236477803885, 5851.61964472308, 5859.179714839841, 5916.408359164049, 5918.0, 5922.466977971831, 5753.8561535961935, 5859.296884373903, 5861.238039054895, 5884.293884733859, 5889.469947704556], "unit": "ms", "name": "dojo.html", "value": 5553.354611027412}, {"lowerIsBetter": false, "replicates": [601.6841158391846, 635.6091004032521, 642.3319747462639, 650.80150554081, 693.3447891742302, 32664.510032349503, 41341.0, 41608.37587436191, 42057.15885682288, 42074.368884466756, 46004.309935351, 46763.0, 46854.53145468544, 46896.531034689644, 46897.53102468974, 9062.682806101804, 9254.352195346328, 9264.397814142092, 9289.767755806126, 9303.348765586377, 9074.682386116487, 9186.494742789177, 9196.356255062148, 9199.172074513292, 9219.124183202584, 9101.863472047924, 9142.954285228565, 9209.033051529594, 9213.907860921405, 9218.76953076175, 9043.412178208428, 9125.269978401746, 9140.0, 9165.17513423795, 9176.95411522938, 8986.730398088068, 9126.224270936978, 9127.497987610679, 9144.725658230263, 9164.26685865136, 42539.361909571075, 42729.78635106805, 42878.78560607208, 43028.78485607552, 43129.568704313184, 3701.0, 3812.8093595320124, 3851.826667799956, 3903.6486716195677, 4160.583941605845, 30274.84862575695, 30944.0716778497, 31167.376652466824, 31512.0, 31607.209819754462, 3615.0781550704664, 3631.927361452756, 3654.780713157219, 3669.8165091745304, 3722.683571896392, 280571.0, 281227.0, 282470.0, 283436.0, 283741.0, 46140.30789538159, 46184.0, 46192.0, 46248.537514625095, 46321.30518042232, 43693.0, 43795.0, 43844.56155438405, 44085.77957110194, 44208.0, 16134.354625814836, 16369.918150409172, 16374.83625163757, 16377.590560236089, 16413.91793041051, 13028.80456793149, 13342.399592018382, 13385.598432047054, 13498.392572334269, 14037.78943315851, 15584.45454409113, 15767.369305227663, 15786.9210653946, 15833.445829395916, 15871.365145394286, 6215.844603884939, 6229.4393504584805, 6305.180326557518, 6347.52393570484, 6366.331535188739, 1027.5170669785189, 1047.1151876664208, 1099.2250463423268, 1122.226881527185, 1174.9353785541878, 30607.387852243275, 33625.49561756576, 35013.649863501545, 35055.29889402249, 35198.64801352005, 1110.3559935237543, 1165.6328256599145, 1174.541928647828, 1195.3067221011793, 1245.4582256718356, 15630.765538516931, 15692.293846776922, 15894.12582307961, 15928.523297312044, 16157.272922718506, 407828.0, 507501.0, 510383.0, 514525.0, 566942.0, 61118.38881611216, 61655.38344616586, 61793.38206617876, 61802.381976180564, 61846.69076654588, 1516.673915108257, 1545.1424459425127, 1553.0448774003905, 1558.3143416896755, 1563.9452619158276, 32015.67984320127, 32269.10716780834, 32473.35053298968, 32551.348973019933, 33324.66675333313, 52072.73963630309, 52260.21609675782, 52554.47445525496, 52606.47393526016, 52698.73650631875, 319932.0, 322350.0, 322683.0, 323680.0, 323990.0, 35779.28441431209, 36068.819655901556, 36095.81952090223, 36220.4566931491, 36497.817510912275, 47538.76230618825, 48485.75757121192, 48690.0, 48923.26615100847, 49097.263541046195, 40269.79865100656, 40417.79791101025, 40629.0, 40846.1830763389, 41251.1749765009, 35902.281954361286, 37729.81135094307, 37962.43056354102, 39753.2049359017, 40711.79644101761, 39339.0, 39990.40062395935, 40181.598184017785, 40573.79713101416, 40594.0, 34095.0, 34117.829410852784, 34596.654033459345, 34714.65285347114, 40036.799816000734, 27282.863585681946, 27831.02591409291, 27998.0, 28021.0, 28064.29839254035], "unit": "ms", "name": "ext.html", "value": 19654.64951144174}, {"lowerIsBetter": false, "replicates": [384.6384398665255, 386.3534786711032, 392.3780807420239, 392.4113829256116, 396.071213005502, 16143.192840357993, 16786.0, 17703.1148442578, 18872.150753216105, 18883.905580472077, 11888.0, 12522.248665080102, 13359.799603005962, 18470.261189552435, 18491.90754046231, 4961.007798440309, 5256.159014557672, 5398.73006349681, 5599.552035837143, 5788.6816225107605, 5763.1355296705415, 5826.067829147337, 5827.504662103726, 5830.300363956331, 5839.649621022731, 5255.86860328491, 5409.702466364349, 5432.348118225818, 5736.856578585548, 5762.4525670061485, 5397.865053373677, 5408.702521361323, 5416.458354164592, 5440.483154100354, 5642.266505354319, 5575.637583557096, 5584.748686309085, 5602.1596760485845, 5614.129809879475, 5614.27014488118, 13673.794893076612, 16513.504594862054, 22482.32553023412, 22598.322050338516, 22768.430789230235, 2185.67214917762, 2190.375742913262, 2258.4128126687015, 2320.071971211512, 2328.55757406094, 10586.682399528027, 11103.55585776568, 11326.263792853439, 13306.933465332708, 14406.279686015761, 1896.7723873135174, 1976.2984140630012, 2003.5091402606308, 2007.2773801431474, 2044.2742826296599, 56998.43001570014, 57269.0, 60857.39142608562, 63485.682571587306, 64458.0, 10887.782244355069, 10922.126229901589, 10940.070094041936, 11036.558537658564, 11076.335419874833, 14149.29253537319, 14220.928895355664, 14228.857711422754, 14254.429822806971, 14273.429062837578, 8549.316054715608, 8637.740867773977, 8661.566921653892, 8749.825003499895, 8754.781130471662, 8435.620397082146, 8524.914750852537, 8582.527960962207, 8628.568571571397, 8680.045195028542, 4826.806927722922, 4894.583960363409, 4910.435299940481, 4937.333459982857, 4960.801567937314, 1998.700194970737, 2020.2625741861987, 2026.4832467720637, 2044.2129780034793, 2050.846186536016, 964.7539877331236, 1011.4184344002228, 1051.1223128687632, 1104.5802595013843, 1105.795427845851, 17428.738568921475, 17558.29766809339, 17563.824361756473, 17678.93926364422, 18234.726479102825, 988.8121256961155, 994.3288280410694, 1016.5323950982483, 1017.9921877341378, 1075.7902209069157, 10047.196224302039, 10302.381857088598, 10325.9483702581, 10337.948310258551, 10354.53404596795, 555833.0, 567071.0, 568184.0, 575535.0, 577391.0, 73006.63496682483, 83375.0, 87128.12871871327, 88471.0, 89627.55186224157, 1209.7580483903255, 1213.5873802907054, 1231.5197073141483, 1258.1633213912828, 1278.1755767529892, 15350.692986140439, 15432.691346173238, 15466.767998480256, 15480.767788482957, 15615.843841561438, 36546.26907461783, 36916.261674766894, 37218.44172337363, 37269.6273037277, 37502.2499550002, 49127.26309105438, 50896.74551627218, 51493.227601586754, 51664.225036625234, 51806.0, 9914.30599858032, 10026.398416095057, 10120.898791011996, 10207.387556746618, 10210.846837297595, 12076.577319793765, 17909.552261193574, 18172.0, 18179.818201818343, 18185.909070454563, 15028.849711502746, 15215.695686085995, 15348.386064557739, 15464.226788660748, 15667.529974100795, 14405.85594144087, 14511.564653060424, 14865.331060102106, 15018.324175412352, 15206.619834504227, 15063.623409414853, 15201.467948621745, 15421.228938552804, 15736.449224277096, 15759.68480630404, 9690.224782017563, 9771.12059914611, 10116.84824727615, 10224.948875255575, 10326.122279606318, 14619.707605848036, 14779.704405912036, 14841.0, 14849.40602375893, 14979.686274117968], "unit": "ms", "name": "jquery.html", "value": 9434.417747814541}, {"lowerIsBetter": false, "replicates": [1576.7556028815538, 1577.18774830962, 1811.8097599752025, 1821.581036361636, 1849.3712137873124, 7896.091949425818, 8094.554799486026, 8254.834903301931, 8255.83488330233, 8267.0, 8260.66957321708, 8262.173782621734, 8331.208535189162, 8346.290565301957, 8363.4563753356, 2331.6502524621274, 2361.504084142332, 2377.9643305350432, 2379.1078345620394, 2382.249591378719, 2326.9185578504757, 2349.5300939812105, 2359.6460530920413, 2360.398098484884, 2365.089440565386, 2254.3124347074217, 2292.277932451281, 2317.1079134533243, 2338.871362075085, 2361.244401791427, 2253.6281513550243, 2296.850704704197, 2297.173017713622, 2298.4139044543704, 2301.390131615123, 2324.0587562037404, 2339.9649005264932, 2348.377679914824, 2348.5889969255313, 2349.682792822964, 8113.188681131898, 8149.551774652392, 8200.917990820075, 8206.425550211488, 8210.630521626541, 4616.699914505546, 4674.7428891410955, 4683.461401938786, 4705.388299521074, 4735.952640473585, 2921.5179495383236, 2983.5077212260167, 3014.8492575371365, 3020.2147441665325, 3025.198322444554, 898.2050884966851, 900.5452246615483, 907.9409838360551, 914.3782228084899, 916.6562539047857, 11050.723731906766, 11072.446377681164, 11122.388268645222, 11125.499352529074, 11129.499172537255, 4116.732412393245, 4349.760763157993, 4475.48531918827, 4496.527864574238, 4521.231390663529, 9175.449473031505, 9237.769055773526, 9246.768830779285, 9246.90753092474, 9256.07439256069, 4854.951450485521, 4885.998370334073, 4894.926576101361, 4898.90202195954, 4904.926426103611, 4419.315006174048, 4423.137488189836, 4453.888652783707, 4467.15124126415, 4476.664250181184, 3705.3886108792285, 3741.2330472253125, 3778.981105094457, 3782.470454136423, 3803.6576708096404, 1177.0995188680495, 1194.7610477904454, 1202.22456515547, 1202.446874437751, 1205.7226837827172, 1001.3241062283075, 1002.0580654185043, 1188.3167178872184, 1310.102579732886, 1398.119184913498, 7622.466427350032, 7660.0, 7669.463137580427, 7674.769756907302, 7677.654505547152, 675.8780424495314, 683.8871586188322, 695.1484431571386, 695.544418405945, 824.579464473123, 6033.456988871023, 6038.30559485656, 6043.0, 6053.909191362045, 6082.239720034996, 9286.0, 9564.76088097803, 9915.256355773347, 9921.702348929544, 9950.1542368898, 9657.46883921377, 9659.613615455444, 9710.70867873965, 9730.17293530058, 9780.413175209367, 7188.065551478275, 7295.01517295169, 7339.339459448675, 7352.742654007191, 7653.081630204411, 7597.468177227541, 7653.158152603321, 7658.425618078555, 7668.309852113337, 7735.690572377267, 8120.83758324842, 8625.482471051757, 8716.171963663443, 8728.869066963875, 8761.561921904007, 8631.44633965867, 8770.780730481789, 8906.242969347679, 8912.598933047899, 9010.81978360416, 7334.779956601311, 7425.0, 7429.07136607924, 7466.887996679946, 7482.0, 7619.885701714368, 7843.647035883285, 7955.960220198862, 8032.116467188488, 8035.276825085771, 7280.199178090512, 7334.743283985035, 7466.589337586485, 7474.065741782278, 7502.737404190827, 7193.5324203926575, 7240.348368646847, 7287.234840341688, 7387.963060184665, 7403.037605111301, 7301.08736407949, 7405.96297018533, 7412.925870741439, 7445.0, 7511.9624401877645, 6662.0, 6671.166104236971, 6711.765088221889, 6723.361280678328, 6726.8654626908165, 6868.519203655696, 6960.582365058112, 6963.0, 6965.233824279224, 6988.161420629557], "unit": "ms", "name": "mootools.html", "value": 4585.356431952234}, {"lowerIsBetter": false, "replicates": [359.42312588295783, 363.5800650248963, 367.15371069684375, 368.0577721034153, 368.3664097751866, 6212.378762123785, 6393.073004414368, 6423.1328770615955, 6474.125992990951, 6477.935220647792, 6145.324014358417, 6344.841378965528, 6381.553291269602, 6384.553081284312, 6385.712642931067, 4879.902401951958, 4914.287428322891, 4919.335889654886, 4922.926156107644, 4925.38432695913, 4919.942212424328, 4930.0, 4930.433000204968, 4931.26031095335, 4935.679180853251, 4703.882402939937, 4799.400074990626, 4817.060673168733, 4836.758162091899, 4867.221244600864, 4788.329633851264, 4795.0, 4796.592289655384, 4816.0, 4835.347228124228, 4111.1366613011305, 4224.746515209097, 4234.809433575497, 4237.4491316129015, 4240.703150779446, 6006.609570377956, 6027.336992930774, 6057.606255593372, 6081.148639190517, 6111.816645500642, 5631.267935168402, 5649.774009039675, 5651.7739290428335, 5664.773409063632, 5665.433456654343, 6535.967320163416, 6726.697298621574, 6744.089547911019, 6757.324267573253, 6767.120274364351, 4640.350350950869, 4645.047765208158, 4711.269753188261, 4718.693284936468, 4721.480637129913, 6952.93047069533, 7022.4382049436435, 7022.964885175593, 7029.261927497641, 7030.4727145463785, 4769.952300476951, 4771.212749896297, 4774.116788394158, 4778.235482322812, 4783.736894470768, 4784.258439941815, 4816.253480710496, 4862.246351815475, 4870.975645121752, 4899.118158731462, 5631.943680563224, 5637.238972738628, 5645.5483561314995, 5648.915266271009, 5664.26364572603, 6680.365365290289, 6733.629650369178, 6785.592864428051, 6801.693923773442, 6806.727730890808, 1695.9491215263563, 1730.5068055604092, 1732.1079643983358, 1733.410640382251, 1735.1064201936013, 1131.9943400282946, 1154.3650991954391, 1154.468944285638, 1159.3565571108115, 1163.3950345820126, 6522.608643481406, 6569.080328753978, 6586.868262634721, 6592.670366481657, 6592.76925307612, 6994.370506654425, 6994.510384273154, 6998.125234345707, 7001.824954376181, 7003.474739394565, 6419.51853610981, 6556.639384833785, 6564.081028655992, 6569.178852643419, 6571.704273307712, 3753.0992561784974, 3757.3800322946954, 3803.0, 3806.238752249561, 3811.618838116166, 7297.343239108506, 7297.562146271134, 7330.340269375782, 7331.413486921034, 7338.559686418832, 7251.093613298338, 7251.202367739545, 7269.818254543678, 7272.8181795454475, 7274.854502910018, 7150.284971502808, 7178.892316615255, 7260.382867456326, 7269.6728647211, 7289.599072051088, 7078.115235595551, 7093.3970612498515, 7106.253843346374, 7118.110236220473, 7122.964385178041, 7004.544704594185, 7008.299170082951, 7009.107540964013, 7018.543794653331, 7023.438124950094, 7142.821434463463, 7264.600446975467, 7280.089988751406, 7283.543291341859, 7309.817254568678, 4805.663603547718, 4831.661783675249, 4849.4908034657265, 4850.442199147144, 4869.099216644932, 7036.577805331696, 7037.753678621224, 7044.189918159273, 7070.505064645631, 7071.7878463646175, 6774.830629234309, 6896.689648965909, 6901.620410877249, 6901.827454313481, 6907.585544867123, 6885.0, 6886.10480637514, 6888.0, 6892.241853396223, 6892.517523773287, 6655.695192499656, 6694.631795251308, 6696.531242813151, 6740.730370785113, 6745.460363171032, 6840.521163518506, 6926.099607051253, 6929.757458488929, 6935.861282774417, 6951.860962780817, 6692.564983276072, 6703.564268322543, 6735.6968936397, 6736.93263067363, 6745.291744366771], "unit": "ms", "name": "prototype.html", "value": 5131.02330837811}, {"lowerIsBetter": false, "replicates": [852.5779739029182, 930.7440453875183, 931.9068093190682, 945.7210123013713, 947.9857802132965, 11767.941160294196, 12150.392480375967, 12196.329201893892, 12208.694782630439, 12255.26468411896, 13093.803592946113, 13183.604491865235, 13190.472381104744, 13199.868001319985, 13203.669908252274, 759.0511860174781, 771.4715419937361, 912.6668765900432, 925.1442415765424, 926.3885835348638, 930.7998780262242, 931.1433481197281, 932.0958670090035, 932.5849996751448, 934.8036912248436, 948.2935213266127, 948.3266880514843, 950.9239260859149, 952.6046690623383, 953.4422362917702, 942.1473566422399, 946.4368700623119, 947.1759569174793, 948.7485816258697, 952.476138124029, 696.9930300696979, 697.1425147069083, 702.3362922038675, 702.8945658151267, 703.5356664601338, 13397.397117129753, 13601.659958501117, 13607.727845443036, 13624.727505449835, 13645.454181832714, 13221.206727596278, 13336.933315333361, 13354.666133346647, 13419.46322147113, 13443.932780336036, 10005.79988400228, 10160.136388406994, 10674.146068314516, 10758.569657213702, 10839.512221950032, 3818.274527839729, 3907.531096268466, 3929.135590170187, 3930.272899513599, 3931.5871833457363, 50431.24353134669, 50792.238116427914, 50841.49158508442, 50974.235386469234, 51710.0, 10788.46057697112, 10919.836202456969, 10944.890551094546, 10996.780064398827, 11227.831582526269, 19922.402327930184, 20001.0, 20048.69926951097, 20058.097385617682, 20081.799182008286, 6905.551139175937, 7080.539764915264, 7557.35762460186, 7650.273224043707, 7900.604969751489, 4401.493828209733, 4495.887602809956, 4510.391097201901, 4550.931736023962, 4605.240135377625, 3074.1853408846673, 3095.3190298134373, 3096.845157742149, 3105.782595218313, 3117.2830249042845, 604.4801470735164, 617.6633734614646, 621.3631028196135, 633.0504243634548, 635.8760041791807, 624.1667374055686, 634.6160572853357, 649.7628365646505, 649.8440374310131, 662.6421732264523, 8336.749897503085, 8369.707060252862, 8441.11368306319, 8499.872501912476, 8608.354373422018, 491.5698763581866, 569.1917477182411, 598.949089327412, 639.1212083385345, 648.0344287012317, 3681.7606855554304, 3688.372976593932, 3797.6582107610448, 3895.824687889052, 3901.8752117335425, 59580.404195958356, 59629.403705963254, 59730.41617502964, 63901.44394224272, 64839.35160648428, 47855.5214447858, 48208.5179148211, 48580.0, 49954.50045499499, 50020.99999999927, 48747.26879096816, 50226.74886625543, 50341.74829125831, 51018.0, 51407.485925141016, 8546.658133674831, 8595.785105372415, 8685.261752751087, 9017.774555636162, 9116.726498205064, 35618.821905890305, 35994.10014749652, 36452.0, 36766.0, 36800.89597312085, 45144.0, 45256.77371613121, 50503.747481262355, 51428.48571514237, 51612.48387516227, 10506.737331566466, 10823.56705731762, 10981.286216396229, 11102.888971110186, 11153.996140347408, 12033.578824741093, 12080.637580872588, 12151.878481215428, 12268.509259629514, 12324.0, 11025.338479691245, 11425.542978281108, 11452.427378630868, 11468.197226194086, 11484.138689598147, 11158.163137764863, 11234.719132021764, 11492.310461372344, 11565.669947956092, 11831.0, 10763.031327180592, 11278.323300601991, 11338.319700817978, 11518.82721759191, 11754.11844111678, 9384.812303754023, 9584.829054539043, 9695.22438204956, 9720.222382209266, 9847.261455391017, 9268.351215414856, 9390.295727820305, 9423.481708506099, 9710.368826026286, 9853.852192217266], "unit": "ms", "name": "yui.html", "value": 6522.61931939632}], "name": "dromaeo_css", "value": 7352.958841677937}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 110.0, 110.0, 121.0, 110.0, 111.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [153.0, 123.0, 155.0, 158.0, 130.0, 152.0, 151.0, 125.0, 163.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [164.0, 160.0, 161.0, 160.0, 162.0, 161.0, 161.0, 160.0, 165.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 155.0, 71.0, 72.0, 71.0, 72.0, 168.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 89.8}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 147.0, 92.0, 93.0, 93.0, 142.0, 92.0, 92.0, 139.0], "unit": "ms", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 153.0, 148.0, 147.0, 146.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 60.0, 62.0, 62.0, 69.0, 62.0, 62.0, 61.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 61.7}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.7}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 82.0, 82.0, 82.0, 90.0, 80.0, 84.0, 82.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [119.0, 109.0, 118.0, 119.0, 114.0, 120.0, 122.0, 127.0, 114.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [136.0, 150.0, 147.0, 143.0, 146.0, 134.0, 147.0, 142.0, 137.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 65.0, 69.0, 65.0, 66.0, 65.0, 64.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1503.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.371258475277], "unit": "score", "name": "Richards", "value": 213.47119400000008}, {"lowerIsBetter": false, "replicates": [172.95053614666205], "unit": "score", "name": "DeltaBlue", "value": 382.29427599999997}, {"lowerIsBetter": false, "replicates": [277.77777777777777], "unit": "score", "name": "Encrypt", "value": 958.2516000000002}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [932.8358208955224], "unit": "score", "name": "RayTrace", "value": 793.2682079999998}, {"lowerIsBetter": false, "replicates": [550.9641873278237], "unit": "score", "name": "Earley", "value": 1209.6303449999996}, {"lowerIsBetter": false, "replicates": [10978.260869565218], "unit": "score", "name": "Boyer", "value": 60.70752079207921}, {"lowerIsBetter": false, "replicates": [24166.666666666668], "unit": "score", "name": "RegExp", "value": 37.69593103448274}, {"lowerIsBetter": false, "replicates": [516.5289256198347], "unit": "score", "name": "Splay", "value": 157.76657600000004}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23181.04664389539}]} 06:20:24 INFO - RETURN: dromaeo_css: 7352.96 06:20:24 INFO - RETURN: kraken: 1503.60 06:20:24 INFO - RETURN: v8_7: 23181.05 06:20:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23181.05"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1503.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7352.96"}}} 06:20:24 INFO - Return code: 0 06:20:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:20:24 INFO - # TBPL SUCCESS # 06:20:24 INFO - Running post-action listener: _resource_record_post_action 06:20:24 INFO - Running post-run listener: _resource_record_post_run 06:20:25 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 0; Write bytes: 500555776; Read time: 0; Write time: 434504 06:20:25 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 234852352; Read time: 0; Write time: 245068 06:20:25 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 0; Write bytes: 265326592; Read time: 0; Write time: 189424 06:20:25 INFO - Running post-run listener: _upload_blobber_files 06:20:25 INFO - Blob upload gear active. 06:20:25 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:20:25 INFO - Copying logs to upload dir... 06:20:25 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.168585 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-25 06:20:25.179153) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 06:20:25.182401) ========= 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=62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009923 build_url: 'https://queue.taskcluster.net/v1/task/0Rrg3fwsQZKBehJqNlbgpg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 06:20:25.233401) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 06:20:25.233800) ========= 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=62c568580acbfdaac3eec7be000001dc-1453730144.688510-842707655 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 06:20:25.288501) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 06:20:25.288917) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 06:20:25.289262) ========= ========= Total master_lag: 0.30 =========