builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1457371985.13 results: success (0) buildid: 20160307063917 builduid: 312d26195a5943de90ca150fc9705a8a revision: be593a64d7c6a826260514fe758ef32a6ee580f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.131493) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.131968) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.132260) ========= 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=32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006232 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.154750) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.155122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.168076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.168391) ========= 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=32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.217813) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.218130) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.218517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.218800) ========= 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=32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-07 09:33:05-- 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% 22.2M=0.001s 2016-03-07 09:33:05 (22.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151066 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.382048) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.382373) ========= 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=32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022794 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.432743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.433123) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev be593a64d7c6a826260514fe758ef32a6ee580f7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev be593a64d7c6a826260514fe758ef32a6ee580f7 --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=32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-07 09:33:05,942 truncating revision to first 12 chars 2016-03-07 09:33:05,942 Setting DEBUG logging. 2016-03-07 09:33:05,942 attempt 1/10 2016-03-07 09:33:05,942 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/be593a64d7c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 09:33:06,211 unpacking tar archive at: mozilla-central-be593a64d7c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.522926 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.968947) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:05.969321) ========= echo be593a64d7c6a826260514fe758ef32a6ee580f7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'be593a64d7c6a826260514fe758ef32a6ee580f7'] 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=32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False be593a64d7c6a826260514fe758ef32a6ee580f7 program finished with exit code 0 elapsedTime=0.003969 script_repo_revision: 'be593a64d7c6a826260514fe758ef32a6ee580f7' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:06.017656) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:06.017976) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 09:33:06.027680) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-03-07 09:33:06.027989) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:33:06 INFO - MultiFileLogger online at 20160307 09:33:06 in /builds/slave/test-pgo 09:33:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:33:06 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:33:06 INFO - {'append_to_log': False, 09:33:06 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:33:06 INFO - 'blob_upload_branch': 'Firefox', 09:33:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:33:06 INFO - 'branch': 'Firefox', 09:33:06 INFO - 'buildbot_json_path': 'buildprops.json', 09:33:06 INFO - 'config_files': ('talos/linux_config.py',), 09:33:06 INFO - 'default_actions': ('clobber', 09:33:06 INFO - 'read-buildbot-config', 09:33:06 INFO - 'download-and-extract', 09:33:06 INFO - 'populate-webroot', 09:33:06 INFO - 'create-virtualenv', 09:33:06 INFO - 'install', 09:33:06 INFO - 'run-tests'), 09:33:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:33:06 INFO - 'download_minidump_stackwalk': True, 09:33:06 INFO - 'download_symbols': 'ondemand', 09:33:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:33:06 INFO - 'tooltool.py': '/tools/tooltool.py', 09:33:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:33:06 INFO - '/tools/misc-python/virtualenv.py')}, 09:33:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:33:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:33:06 INFO - 'installer_path': 'installer.exe', 09:33:06 INFO - 'log_level': 'info', 09:33:06 INFO - 'log_name': 'talos', 09:33:06 INFO - 'log_to_console': True, 09:33:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:33:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:33:06 INFO - 'opt_config_files': (), 09:33:06 INFO - 'pip_index': False, 09:33:06 INFO - 'sps_profile': False, 09:33:06 INFO - 'sps_profile_interval': 0, 09:33:06 INFO - 'suite': 'dromaeojs-e10s', 09:33:06 INFO - 'system_bits': '32', 09:33:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:33:06 INFO - 'title': 'talos-linux64-ix-008', 09:33:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:33:06 INFO - 'use_talos_json': True, 09:33:06 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:33:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:33:06 INFO - 'work_dir': 'build'} 09:33:06 INFO - ##### 09:33:06 INFO - ##### Running clobber step. 09:33:06 INFO - ##### 09:33:06 INFO - Running pre-action listener: _resource_record_pre_action 09:33:06 INFO - Running main action method: clobber 09:33:06 INFO - rmtree: /builds/slave/test-pgo/build 09:33:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:33:07 INFO - Running post-action listener: _resource_record_post_action 09:33:07 INFO - ##### 09:33:07 INFO - ##### Running read-buildbot-config step. 09:33:07 INFO - ##### 09:33:07 INFO - Running pre-action listener: _resource_record_pre_action 09:33:07 INFO - Running main action method: read_buildbot_config 09:33:07 INFO - Using buildbot properties: 09:33:07 INFO - { 09:33:07 INFO - "project": "", 09:33:07 INFO - "product": "firefox", 09:33:07 INFO - "script_repo_revision": "production", 09:33:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:33:07 INFO - "repository": "", 09:33:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 09:33:07 INFO - "buildid": "20160307063917", 09:33:07 INFO - "stage_platform": "linux64-pgo", 09:33:07 INFO - "basedir": "/builds/slave/test-pgo", 09:33:07 INFO - "nightly_build": "True", 09:33:07 INFO - "buildnumber": 374, 09:33:07 INFO - "slavename": "talos-linux64-ix-008", 09:33:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:33:07 INFO - "platform": "ubuntu64_hw", 09:33:07 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:33:07 INFO - "branch": "mozilla-central", 09:33:07 INFO - "repo_path": "mozilla-central", 09:33:07 INFO - "revision": "be593a64d7c6a826260514fe758ef32a6ee580f7", 09:33:07 INFO - "pgo_build": "True", 09:33:07 INFO - "builduid": "312d26195a5943de90ca150fc9705a8a", 09:33:07 INFO - "slavebuilddir": "test" 09:33:07 INFO - } 09:33:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:33:07 INFO - Running post-action listener: _resource_record_post_action 09:33:07 INFO - ##### 09:33:07 INFO - ##### Running download-and-extract step. 09:33:07 INFO - ##### 09:33:07 INFO - Running pre-action listener: _resource_record_pre_action 09:33:07 INFO - Running main action method: download_and_extract 09:33:07 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:07 INFO - https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:33:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:33:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:33:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:33:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:33:08 INFO - Downloaded 1448 bytes. 09:33:08 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:33:08 INFO - Using the following test package requirements: 09:33:08 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:33:08 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:33:08 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:33:08 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:08 INFO - u'jsshell-linux-x86_64.zip'], 09:33:08 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:33:08 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:33:08 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:33:08 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:33:08 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:33:08 INFO - u'webapprt': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:33:08 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:33:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:08 INFO - https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:33:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:33:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:33:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:33:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:33:09 INFO - Downloaded 23405878 bytes. 09:33:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:33:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:33:10 INFO - Return code: 0 09:33:10 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:10 INFO - https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:33:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:33:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:33:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:33:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:33:11 INFO - Downloaded 23405878 bytes. 09:33:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:33:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:33:13 INFO - Return code: 0 09:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:13 INFO - https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:33:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:33:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:33:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:33:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:33:14 INFO - Downloaded 10845161 bytes. 09:33:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:33:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 09:33:15 INFO - Return code: 0 09:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:15 INFO - https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:33:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:33:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:33:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:33:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:33:16 INFO - Downloaded 56178532 bytes. 09:33:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:33:16 INFO - mkdir: /builds/slave/test-pgo/properties 09:33:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:33:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:33:16 INFO - Contents: 09:33:16 INFO - build_url:https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:33:17 INFO - Running post-action listener: _resource_record_post_action 09:33:17 INFO - Running post-action listener: set_extra_try_arguments 09:33:17 INFO - ##### 09:33:17 INFO - ##### Running populate-webroot step. 09:33:17 INFO - ##### 09:33:17 INFO - Running pre-action listener: _resource_record_pre_action 09:33:17 INFO - Running main action method: populate_webroot 09:33:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:33:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:33:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:33:17 INFO - '--tppagecycles', 09:33:17 INFO - '7'], 09:33:17 INFO - 'tests': ['tsvgm']}}, 09:33:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:33:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:33:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:33:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:33:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:33:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:33:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'talos_options': ['--e10s'], 09:33:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'tests': ['damp', 'tps']}, 09:33:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'talos_options': ['--e10s'], 09:33:17 INFO - 'tests': ['damp', 'tps']}, 09:33:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:33:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:33:17 INFO - 'other': {'tests': ['a11yr', 09:33:17 INFO - 'ts_paint', 09:33:17 INFO - 'tpaint', 09:33:17 INFO - 'sessionrestore', 09:33:17 INFO - 'sessionrestore_no_auto_restore', 09:33:17 INFO - 'tabpaint']}, 09:33:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:33:17 INFO - 'tests': ['a11yr', 09:33:17 INFO - 'ts_paint', 09:33:17 INFO - 'tpaint', 09:33:17 INFO - 'sessionrestore', 09:33:17 INFO - 'sessionrestore_no_auto_restore', 09:33:17 INFO - 'tabpaint']}, 09:33:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:33:17 INFO - 'tests': ['a11yr', 09:33:17 INFO - 'ts_paint', 09:33:17 INFO - 'tpaint', 09:33:17 INFO - 'sessionrestore', 09:33:17 INFO - 'sessionrestore_no_auto_restore', 09:33:17 INFO - 'tabpaint']}, 09:33:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:33:17 INFO - 'tests': ['a11yr', 09:33:17 INFO - 'ts_paint', 09:33:17 INFO - 'tpaint', 09:33:17 INFO - 'sessionrestore', 09:33:17 INFO - 'sessionrestore_no_auto_restore', 09:33:17 INFO - 'tabpaint']}, 09:33:17 INFO - 'other_l64': {'tests': ['a11yr', 09:33:17 INFO - 'ts_paint', 09:33:17 INFO - 'tpaint', 09:33:17 INFO - 'sessionrestore', 09:33:17 INFO - 'sessionrestore_no_auto_restore', 09:33:17 INFO - 'tabpaint']}, 09:33:17 INFO - 'other_nol64': {'tests': ['a11yr', 09:33:17 INFO - 'ts_paint', 09:33:17 INFO - 'tpaint', 09:33:17 INFO - 'sessionrestore', 09:33:17 INFO - 'sessionrestore_no_auto_restore', 09:33:17 INFO - 'tabpaint']}, 09:33:17 INFO - 'svgr': {'tests': ['tsvgx', 09:33:17 INFO - 'tsvgr_opacity', 09:33:17 INFO - 'tart', 09:33:17 INFO - 'tscrollx', 09:33:17 INFO - 'cart']}, 09:33:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:33:17 INFO - 'tests': ['tsvgx', 09:33:17 INFO - 'tsvgr_opacity', 09:33:17 INFO - 'tart', 09:33:17 INFO - 'tscrollx', 09:33:17 INFO - 'cart']}, 09:33:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'tests': ['tp5o']}, 09:33:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'talos_options': ['--e10s'], 09:33:17 INFO - 'tests': ['tp5o']}, 09:33:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'talos_options': ['--xperf_path', 09:33:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:17 INFO - 'tests': ['tp5n']}, 09:33:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'talos_options': ['--e10s', 09:33:17 INFO - '--xperf_path', 09:33:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:17 INFO - 'tests': ['tp5n']}}, 09:33:17 INFO - 'talos.zip': {'path': '', 09:33:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:33:17 INFO - Running post-action listener: _resource_record_post_action 09:33:17 INFO - ##### 09:33:17 INFO - ##### Running create-virtualenv step. 09:33:17 INFO - ##### 09:33:17 INFO - Running pre-action listener: _resource_record_pre_action 09:33:17 INFO - Running main action method: create_virtualenv 09:33:17 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:33:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 09:33:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:33:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:33:17 INFO - Using real prefix '/usr' 09:33:17 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:33:17 INFO - Installing distribute.............................................................................................................................................................................................done. 09:33:19 INFO - Installing pip.................done. 09:33:19 INFO - Return code: 0 09:33:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:19 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 0x7f46a115cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0920>, '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 0x27e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1cb0>, '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': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:33:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:33:19 INFO - Using env: {'DISPLAY': ':0', 09:33:19 INFO - 'HOME': '/home/cltbld', 09:33:19 INFO - 'LANG': 'en_US.UTF-8', 09:33:19 INFO - 'LANGUAGE': 'en_US:en', 09:33:19 INFO - 'LOGNAME': 'cltbld', 09:33:19 INFO - 'MAIL': '/var/mail/cltbld', 09:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:19 INFO - 'MOZ_NO_REMOTE': '1', 09:33:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:19 INFO - 'NO_EM_RESTART': '1', 09:33:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:33:19 INFO - 'PWD': '/builds/slave/test-pgo', 09:33:19 INFO - 'SHELL': '/bin/bash', 09:33:19 INFO - 'SHLVL': '1', 09:33:19 INFO - 'TERM': 'linux', 09:33:19 INFO - 'TMOUT': '86400', 09:33:19 INFO - 'USER': 'cltbld', 09:33:19 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 09:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:19 INFO - '_': '/tools/buildbot/bin/python'} 09:33:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:33:19 INFO - Cleaning up... 09:33:19 INFO - Return code: 0 09:33:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:19 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 0x7f46a115cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0920>, '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 0x27e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1cb0>, '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': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:33:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:33:19 INFO - Using env: {'DISPLAY': ':0', 09:33:19 INFO - 'HOME': '/home/cltbld', 09:33:19 INFO - 'LANG': 'en_US.UTF-8', 09:33:19 INFO - 'LANGUAGE': 'en_US:en', 09:33:19 INFO - 'LOGNAME': 'cltbld', 09:33:19 INFO - 'MAIL': '/var/mail/cltbld', 09:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:19 INFO - 'MOZ_NO_REMOTE': '1', 09:33:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:19 INFO - 'NO_EM_RESTART': '1', 09:33:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:33:19 INFO - 'PWD': '/builds/slave/test-pgo', 09:33:19 INFO - 'SHELL': '/bin/bash', 09:33:19 INFO - 'SHLVL': '1', 09:33:19 INFO - 'TERM': 'linux', 09:33:19 INFO - 'TMOUT': '86400', 09:33:19 INFO - 'USER': 'cltbld', 09:33:19 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 09:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:19 INFO - '_': '/tools/buildbot/bin/python'} 09:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:20 INFO - Downloading/unpacking psutil>=0.7.1 09:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:33:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:22 INFO - Installing collected packages: psutil 09:33:22 INFO - Running setup.py install for psutil 09:33:22 INFO - building 'psutil._psutil_linux' extension 09:33:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:33:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:33:22 INFO - building 'psutil._psutil_posix' extension 09:33:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:33:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:33:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:22 INFO - Successfully installed psutil 09:33:22 INFO - Cleaning up... 09:33:22 INFO - Return code: 0 09:33:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f46a115cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0920>, '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 0x27e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1cb0>, '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': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:33:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:33:22 INFO - Using env: {'DISPLAY': ':0', 09:33:22 INFO - 'HOME': '/home/cltbld', 09:33:22 INFO - 'LANG': 'en_US.UTF-8', 09:33:22 INFO - 'LANGUAGE': 'en_US:en', 09:33:22 INFO - 'LOGNAME': 'cltbld', 09:33:22 INFO - 'MAIL': '/var/mail/cltbld', 09:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:22 INFO - 'MOZ_NO_REMOTE': '1', 09:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:22 INFO - 'NO_EM_RESTART': '1', 09:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:33:22 INFO - 'PWD': '/builds/slave/test-pgo', 09:33:22 INFO - 'SHELL': '/bin/bash', 09:33:22 INFO - 'SHLVL': '1', 09:33:22 INFO - 'TERM': 'linux', 09:33:22 INFO - 'TMOUT': '86400', 09:33:22 INFO - 'USER': 'cltbld', 09:33:22 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 09:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:22 INFO - '_': '/tools/buildbot/bin/python'} 09:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:33:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:33:24 INFO - Installing collected packages: mozsystemmonitor 09:33:24 INFO - Running setup.py install for mozsystemmonitor 09:33:24 INFO - Successfully installed mozsystemmonitor 09:33:24 INFO - Cleaning up... 09:33:24 INFO - Return code: 0 09:33:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:24 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 0x7f46a115cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0920>, '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 0x27e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1cb0>, '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': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:33:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:33:24 INFO - Using env: {'DISPLAY': ':0', 09:33:24 INFO - 'HOME': '/home/cltbld', 09:33:24 INFO - 'LANG': 'en_US.UTF-8', 09:33:24 INFO - 'LANGUAGE': 'en_US:en', 09:33:24 INFO - 'LOGNAME': 'cltbld', 09:33:24 INFO - 'MAIL': '/var/mail/cltbld', 09:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:24 INFO - 'MOZ_NO_REMOTE': '1', 09:33:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:24 INFO - 'NO_EM_RESTART': '1', 09:33:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:33:24 INFO - 'PWD': '/builds/slave/test-pgo', 09:33:24 INFO - 'SHELL': '/bin/bash', 09:33:24 INFO - 'SHLVL': '1', 09:33:24 INFO - 'TERM': 'linux', 09:33:25 INFO - 'TMOUT': '86400', 09:33:25 INFO - 'USER': 'cltbld', 09:33:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 09:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:25 INFO - '_': '/tools/buildbot/bin/python'} 09:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:25 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:27 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:33:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:27 INFO - Downloading docopt-0.6.1.tar.gz 09:33:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:27 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:27 INFO - Running setup.py install for blobuploader 09:33:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:27 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:33:27 INFO - Running setup.py install for requests 09:33:28 INFO - Running setup.py install for docopt 09:33:28 INFO - Successfully installed blobuploader requests docopt 09:33:28 INFO - Cleaning up... 09:33:28 INFO - Return code: 0 09:33:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:28 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 0x7f46a115cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0920>, '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 0x27e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1cb0>, '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': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:33:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:33:28 INFO - Using env: {'DISPLAY': ':0', 09:33:28 INFO - 'HOME': '/home/cltbld', 09:33:28 INFO - 'LANG': 'en_US.UTF-8', 09:33:28 INFO - 'LANGUAGE': 'en_US:en', 09:33:28 INFO - 'LOGNAME': 'cltbld', 09:33:28 INFO - 'MAIL': '/var/mail/cltbld', 09:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:28 INFO - 'MOZ_NO_REMOTE': '1', 09:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:28 INFO - 'NO_EM_RESTART': '1', 09:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:33:28 INFO - 'PWD': '/builds/slave/test-pgo', 09:33:28 INFO - 'SHELL': '/bin/bash', 09:33:28 INFO - 'SHLVL': '1', 09:33:28 INFO - 'TERM': 'linux', 09:33:28 INFO - 'TMOUT': '86400', 09:33:28 INFO - 'USER': 'cltbld', 09:33:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 09:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:28 INFO - '_': '/tools/buildbot/bin/python'} 09:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:33:28 INFO - Running setup.py (path:/tmp/pip-p1xF8o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:33:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:33:28 INFO - Running setup.py (path:/tmp/pip-EtoJsw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:33:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:33:28 INFO - Running setup.py (path:/tmp/pip-P_9qPk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:33:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:33:28 INFO - Running setup.py (path:/tmp/pip-2sASfd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:33:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:33:28 INFO - Running setup.py (path:/tmp/pip-HG0069-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:33:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:33:28 INFO - Running setup.py (path:/tmp/pip-jxXQHI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:33:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:33:29 INFO - Running setup.py (path:/tmp/pip-nyI08B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:33:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:33:29 INFO - Running setup.py (path:/tmp/pip-0QLEnE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:33:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:33:29 INFO - Running setup.py (path:/tmp/pip-a0D_7x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:33:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:33:29 INFO - Running setup.py (path:/tmp/pip-tYPyCN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:33:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:33:29 INFO - Running setup.py (path:/tmp/pip-fOXKsH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:33:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:33:29 INFO - Running setup.py (path:/tmp/pip-H8WNmU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:33:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:33:29 INFO - Running setup.py (path:/tmp/pip-8f7OGA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:33:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:33:29 INFO - Running setup.py (path:/tmp/pip-47j6KI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:33:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:33:29 INFO - Running setup.py (path:/tmp/pip-qM8Znz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:33:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:33:29 INFO - Running setup.py (path:/tmp/pip-CGEPYa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:33:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:33:29 INFO - Running setup.py (path:/tmp/pip-MKo46C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:33:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:29 INFO - Running setup.py install for manifestparser 09:33:29 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:33:29 INFO - Running setup.py install for mozcrash 09:33:29 INFO - Running setup.py install for mozdebug 09:33:30 INFO - Running setup.py install for mozdevice 09:33:30 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:33:30 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:33:30 INFO - Running setup.py install for mozfile 09:33:30 INFO - Running setup.py install for mozhttpd 09:33:30 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:33:30 INFO - Running setup.py install for mozinfo 09:33:30 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:33:30 INFO - Running setup.py install for mozInstall 09:33:30 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:33:30 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:33:30 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:33:30 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:33:30 INFO - Running setup.py install for mozleak 09:33:30 INFO - Running setup.py install for mozlog 09:33:30 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:33:30 INFO - Running setup.py install for moznetwork 09:33:30 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:33:30 INFO - Running setup.py install for mozprocess 09:33:31 INFO - Running setup.py install for mozprofile 09:33:31 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:33:31 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:33:31 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:33:31 INFO - Running setup.py install for mozrunner 09:33:31 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:33:31 INFO - Running setup.py install for mozscreenshot 09:33:31 INFO - Running setup.py install for moztest 09:33:31 INFO - Running setup.py install for mozversion 09:33:31 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:33:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:31 INFO - Cleaning up... 09:33:31 INFO - Return code: 0 09:33:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:31 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 0x7f46a115cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0920>, '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 0x27e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1cb0>, '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': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:33:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:33:31 INFO - Using env: {'DISPLAY': ':0', 09:33:31 INFO - 'HOME': '/home/cltbld', 09:33:31 INFO - 'LANG': 'en_US.UTF-8', 09:33:31 INFO - 'LANGUAGE': 'en_US:en', 09:33:31 INFO - 'LOGNAME': 'cltbld', 09:33:31 INFO - 'MAIL': '/var/mail/cltbld', 09:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:31 INFO - 'MOZ_NO_REMOTE': '1', 09:33:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:31 INFO - 'NO_EM_RESTART': '1', 09:33:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:33:31 INFO - 'PWD': '/builds/slave/test-pgo', 09:33:31 INFO - 'SHELL': '/bin/bash', 09:33:31 INFO - 'SHLVL': '1', 09:33:31 INFO - 'TERM': 'linux', 09:33:31 INFO - 'TMOUT': '86400', 09:33:31 INFO - 'USER': 'cltbld', 09:33:31 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 09:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:31 INFO - '_': '/tools/buildbot/bin/python'} 09:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:33:31 INFO - Running setup.py (path:/tmp/pip-2jNCiD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:33:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 09:33:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:33:31 INFO - Running setup.py (path:/tmp/pip-NgXAOg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:33:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:33:31 INFO - Running setup.py (path:/tmp/pip-86rjTq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:33:32 INFO - Running setup.py (path:/tmp/pip-KkAnWD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:33:32 INFO - Running setup.py (path:/tmp/pip-ybA3xv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:33:32 INFO - Running setup.py (path:/tmp/pip-eJ_3fZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 09:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:33:32 INFO - Running setup.py (path:/tmp/pip-8VaOO7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 09:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:33:32 INFO - Running setup.py (path:/tmp/pip-Vh0GzF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 09:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:33:32 INFO - Running setup.py (path:/tmp/pip-OdLRQG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 09:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:33:32 INFO - Running setup.py (path:/tmp/pip-kY2rqm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:33:32 INFO - Running setup.py (path:/tmp/pip-3GyJiU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 09:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:33:32 INFO - Running setup.py (path:/tmp/pip-QF_0ct-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 09:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:33:32 INFO - Running setup.py (path:/tmp/pip-hcjF9f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 09:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:33:32 INFO - Running setup.py (path:/tmp/pip-qHLvGW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 09:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:33:32 INFO - Running setup.py (path:/tmp/pip-6XWBAM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 09:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:33:32 INFO - Running setup.py (path:/tmp/pip-27bADB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 09:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:33:32 INFO - Running setup.py (path:/tmp/pip-XgOvbo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 09:33:33 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:33 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:33:33 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:33 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:34 INFO - Downloading blessings-1.6.tar.gz 09:33:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:34 INFO - Installing collected packages: blessings 09:33:34 INFO - Running setup.py install for blessings 09:33:34 INFO - Successfully installed blessings 09:33:34 INFO - Cleaning up... 09:33:35 INFO - Return code: 0 09:33:35 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:33:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:33:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:33:35 INFO - Reading from file tmpfile_stdout 09:33:35 INFO - Current package versions: 09:33:35 INFO - argparse == 1.2.1 09:33:35 INFO - blessings == 1.6 09:33:35 INFO - blobuploader == 1.2.4 09:33:35 INFO - docopt == 0.6.1 09:33:35 INFO - manifestparser == 1.1 09:33:35 INFO - mozInstall == 1.12 09:33:35 INFO - mozcrash == 0.17 09:33:35 INFO - mozdebug == 0.1 09:33:35 INFO - mozdevice == 0.48 09:33:35 INFO - mozfile == 1.2 09:33:35 INFO - mozhttpd == 0.7 09:33:35 INFO - mozinfo == 0.9 09:33:35 INFO - mozleak == 0.1 09:33:35 INFO - mozlog == 3.1 09:33:35 INFO - moznetwork == 0.27 09:33:35 INFO - mozprocess == 0.22 09:33:35 INFO - mozprofile == 0.28 09:33:35 INFO - mozrunner == 6.11 09:33:35 INFO - mozscreenshot == 0.1 09:33:35 INFO - mozsystemmonitor == 0.0 09:33:35 INFO - moztest == 0.7 09:33:35 INFO - mozversion == 1.4 09:33:35 INFO - psutil == 3.1.1 09:33:35 INFO - requests == 1.2.3 09:33:35 INFO - wsgiref == 0.1.2 09:33:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:33: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')]} 09:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:35 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 0x7f46a115cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0920>, '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 0x27e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1cb0>, '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': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 09:33:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:33:35 INFO - Using env: {'DISPLAY': ':0', 09:33:35 INFO - 'HOME': '/home/cltbld', 09:33:35 INFO - 'LANG': 'en_US.UTF-8', 09:33:35 INFO - 'LANGUAGE': 'en_US:en', 09:33:35 INFO - 'LOGNAME': 'cltbld', 09:33:35 INFO - 'MAIL': '/var/mail/cltbld', 09:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:35 INFO - 'MOZ_NO_REMOTE': '1', 09:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:35 INFO - 'NO_EM_RESTART': '1', 09:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:33:35 INFO - 'PWD': '/builds/slave/test-pgo', 09:33:35 INFO - 'SHELL': '/bin/bash', 09:33:35 INFO - 'SHLVL': '1', 09:33:35 INFO - 'TERM': 'linux', 09:33:35 INFO - 'TMOUT': '86400', 09:33:35 INFO - 'USER': 'cltbld', 09:33:35 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 09:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:35 INFO - '_': '/tools/buildbot/bin/python'} 09:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 09:33:35 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 2)) 09:33:35 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 3)) 09:33:35 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 4)) 09:33:35 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 5)) 09:33:35 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 6)) 09:33:35 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 7)) 09:33:35 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 8)) 09:33:35 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 9)) 09:33:35 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:33:35 INFO - Cleaning up... 09:33:35 INFO - Return code: 0 09:33:35 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:33: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')]} 09:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:35 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 0x7f46a115cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0920>, '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 0x27e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1cb0>, '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': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:33:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:33:35 INFO - Using env: {'DISPLAY': ':0', 09:33:35 INFO - 'HOME': '/home/cltbld', 09:33:35 INFO - 'LANG': 'en_US.UTF-8', 09:33:35 INFO - 'LANGUAGE': 'en_US:en', 09:33:35 INFO - 'LOGNAME': 'cltbld', 09:33:35 INFO - 'MAIL': '/var/mail/cltbld', 09:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:35 INFO - 'MOZ_NO_REMOTE': '1', 09:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:35 INFO - 'NO_EM_RESTART': '1', 09:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:33:35 INFO - 'PWD': '/builds/slave/test-pgo', 09:33:35 INFO - 'SHELL': '/bin/bash', 09:33:35 INFO - 'SHLVL': '1', 09:33:35 INFO - 'TERM': 'linux', 09:33:35 INFO - 'TMOUT': '86400', 09:33:35 INFO - 'USER': 'cltbld', 09:33:35 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 09:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:35 INFO - '_': '/tools/buildbot/bin/python'} 09:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:35 INFO - Downloading/unpacking jsonschema 09:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:33:37 INFO - Downloading/unpacking functools32 (from jsonschema) 09:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:37 INFO - Downloading functools32-3.2.3-2.tar.gz 09:33:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:33:37 INFO - warning: no files found matching '*.txt' 09:33:37 INFO - no previously-included directories found matching 'build' 09:33:37 INFO - no previously-included directories found matching 'dist' 09:33:37 INFO - no previously-included directories found matching '.git*' 09:33:37 INFO - Installing collected packages: jsonschema, functools32 09:33:37 INFO - Running setup.py install for functools32 09:33:37 INFO - warning: no files found matching '*.txt' 09:33:37 INFO - no previously-included directories found matching 'build' 09:33:37 INFO - no previously-included directories found matching 'dist' 09:33:37 INFO - no previously-included directories found matching '.git*' 09:33:37 INFO - Successfully installed jsonschema functools32 09:33:37 INFO - Cleaning up... 09:33:38 INFO - Return code: 0 09:33:38 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:38 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 0x7f46a115cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0920>, '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 0x27e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1cb0>, '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': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:33:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:33:38 INFO - Using env: {'DISPLAY': ':0', 09:33:38 INFO - 'HOME': '/home/cltbld', 09:33:38 INFO - 'LANG': 'en_US.UTF-8', 09:33:38 INFO - 'LANGUAGE': 'en_US:en', 09:33:38 INFO - 'LOGNAME': 'cltbld', 09:33:38 INFO - 'MAIL': '/var/mail/cltbld', 09:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:38 INFO - 'MOZ_NO_REMOTE': '1', 09:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:38 INFO - 'NO_EM_RESTART': '1', 09:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:33:38 INFO - 'PWD': '/builds/slave/test-pgo', 09:33:38 INFO - 'SHELL': '/bin/bash', 09:33:38 INFO - 'SHLVL': '1', 09:33:38 INFO - 'TERM': 'linux', 09:33:38 INFO - 'TMOUT': '86400', 09:33:38 INFO - 'USER': 'cltbld', 09:33:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 09:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:38 INFO - '_': '/tools/buildbot/bin/python'} 09:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:38 INFO - Downloading/unpacking flake8 09:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:33:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:33:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:33:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:33:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:33:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:33:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:33:40 INFO - no previously-included directories found matching 'docs/_build' 09:33:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:33:40 INFO - Running setup.py install for pep8 09:33:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:33:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:33:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:33:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:33:40 INFO - no previously-included directories found matching 'docs/_build' 09:33:40 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:33:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:33:40 INFO - Cleaning up... 09:33:40 INFO - Return code: 0 09:33:40 INFO - Running post-action listener: _resource_record_post_action 09:33:40 INFO - Running post-action listener: _start_resource_monitoring 09:33:40 INFO - Starting resource monitoring. 09:33:40 INFO - ##### 09:33:40 INFO - ##### Running install step. 09:33:40 INFO - ##### 09:33:40 INFO - Running pre-action listener: _resource_record_pre_action 09:33:40 INFO - Running main action method: install 09:33:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:33:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:33:41 INFO - Reading from file tmpfile_stdout 09:33:41 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:33:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:33:41 INFO - Reading from file tmpfile_stdout 09:33:41 INFO - Output received: 09:33:41 INFO - Usage: mozinstall [options] installer 09:33:41 INFO - Options: 09:33:41 INFO - -h, --help show this help message and exit 09:33:41 INFO - -d DEST, --destination=DEST 09:33:41 INFO - Directory to install application into. [default: 09:33:41 INFO - "/builds/slave/test-pgo"] 09:33:41 INFO - --app=APP Application being installed. [default: firefox] 09:33:41 INFO - mkdir: /builds/slave/test-pgo/build/application 09:33:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:33:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:33:57 INFO - Reading from file tmpfile_stdout 09:33:57 INFO - Output received: 09:33:57 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:33:57 INFO - Running post-action listener: _resource_record_post_action 09:33:57 INFO - ##### 09:33:57 INFO - ##### Running run-tests step. 09:33:57 INFO - ##### 09:33:57 INFO - Running pre-action listener: _resource_record_pre_action 09:33:57 INFO - Running main action method: run_tests 09:33:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:33:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:33:57 INFO - Python 2.7.3 09:33:57 INFO - Return code: 0 09:33:57 INFO - grabbing minidump binary from tooltool 09:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:57 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 0x27e0920>, '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 0x27e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e1cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:33:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 09:33:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:33:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:33:57 INFO - Return code: 0 09:33:57 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:33:57 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:33:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:33:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:33:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:33:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:33:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:33:58 INFO - Return code: 0 09:33:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 09:33:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:33:58 INFO - Using env: {'DISPLAY': ':0', 09:33:58 INFO - 'HOME': '/home/cltbld', 09:33:58 INFO - 'LANG': 'en_US.UTF-8', 09:33:58 INFO - 'LANGUAGE': 'en_US:en', 09:33:58 INFO - 'LOGNAME': 'cltbld', 09:33:58 INFO - 'MAIL': '/var/mail/cltbld', 09:33:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:33:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:58 INFO - 'MOZ_NO_REMOTE': '1', 09:33:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:58 INFO - 'NO_EM_RESTART': '1', 09:33:58 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:33:58 INFO - 'PWD': '/builds/slave/test-pgo', 09:33:58 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:33:58 INFO - 'SHELL': '/bin/bash', 09:33:58 INFO - 'SHLVL': '1', 09:33:58 INFO - 'TERM': 'linux', 09:33:58 INFO - 'TMOUT': '86400', 09:33:58 INFO - 'USER': 'cltbld', 09:33:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613', 09:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:58 INFO - '_': '/tools/buildbot/bin/python'} 09:33:58 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:33:58 INFO - mozversion application_buildid: 20160307063917 09:33:58 INFO - mozversion application_changeset: be593a64d7c6a826260514fe758ef32a6ee580f7 09:33:58 INFO - mozversion application_display_name: Nightly 09:33:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:33:58 INFO - mozversion application_name: Firefox 09:33:58 INFO - mozversion application_remotingname: firefox 09:33:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:33:58 INFO - mozversion application_vendor: Mozilla 09:33:58 INFO - mozversion application_version: 48.0a1 09:33:58 INFO - mozversion platform_buildid: 20160307063917 09:33:58 INFO - mozversion platform_changeset: be593a64d7c6a826260514fe758ef32a6ee580f7 09:33:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:33:58 INFO - mozversion platform_version: 48.0a1 09:33:58 INFO - using testdate: 1457372038 09:33:58 INFO - actual date: 1457372038 09:33:58 INFO - starting webserver on 'localhost:59980' 09:33:58 INFO - SUITE-START | Running 2 tests 09:33:58 INFO - TEST-START | dromaeo_css 09:33:58 INFO - operating with platform_type : linux_ 09:33:58 INFO - Initialising browser for dromaeo_css test... 09:33:58 INFO - TEST-INFO | started process 19981 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg4G2iy/profile http://localhost:59980/getInfo.html) 09:34:02 INFO - PROCESS | 19981 | 09:34:02 INFO - PROCESS | 19981 | (process:20062): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:34:03 INFO - PROCESS | 19981 | __metrics Screen width/height:1600/1200 09:34:03 INFO - PROCESS | 19981 | colorDepth:24 09:34:03 INFO - PROCESS | 19981 | Browser inner width/height: 1024/697 09:34:03 INFO - PROCESS | 19981 | __metrics 09:34:03 ERROR - PROCESS | 19981 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:34:04 INFO - TEST-INFO | 19981: exit 0 09:34:04 INFO - Browser initialized. 09:34:04 INFO - Running cycle 1/1 for dromaeo_css test... 09:34:04 INFO - TEST-INFO | started process 20113 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg4G2iy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:06 INFO - PROCESS | 20113 | 09:34:06 INFO - PROCESS | 20113 | (process:20176): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:34:16 INFO - PROCESS | 20113 | RSS: Main: 165347328 09:34:16 INFO - PROCESS | 20113 | 09:35:06 INFO - PROCESS | 20113 | 1457372106238 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] 09:37:15 INFO - PROCESS | 20113 | Cycle 1(1): loaded http://localhost:59980/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59980/tests/dromaeo/cssquery-ext.html) 09:37:16 INFO - PROCESS | 20113 | RSS: Main: 170029056 09:37:16 INFO - PROCESS | 20113 | 09:40:18 INFO - PROCESS | 20113 | Cycle 1(1): loaded http://localhost:59980/tests/dromaeo/cssquery-ext.html (next: http://localhost:59980/tests/dromaeo/cssquery-jquery.html) 09:40:19 INFO - PROCESS | 20113 | RSS: Main: 168738816 09:40:19 INFO - PROCESS | 20113 | 09:43:20 INFO - PROCESS | 20113 | Cycle 1(1): loaded http://localhost:59980/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59980/tests/dromaeo/cssquery-mootools.html) 09:43:21 INFO - PROCESS | 20113 | RSS: Main: 169648128 09:43:21 INFO - PROCESS | 20113 | 09:46:23 INFO - PROCESS | 20113 | Cycle 1(1): loaded http://localhost:59980/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59980/tests/dromaeo/cssquery-prototype.html) 09:46:23 INFO - PROCESS | 20113 | RSS: Main: 167706624 09:46:23 INFO - PROCESS | 20113 | 09:49:26 INFO - PROCESS | 20113 | Cycle 1(1): loaded http://localhost:59980/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59980/tests/dromaeo/cssquery-yui.html) 09:49:26 INFO - PROCESS | 20113 | RSS: Main: 168099840 09:49:26 INFO - PROCESS | 20113 | 09:52:29 INFO - PROCESS | 20113 | Cycle 1(1): loaded http://localhost:59980/tests/dromaeo/cssquery-yui.html (next: http://localhost:59980/tests/dromaeo/cssquery-dojo.html) 09:52:29 INFO - PROCESS | 20113 | RSS: Main: 171679744 09:52:29 INFO - PROCESS | 20113 | 09:52:29 INFO - PROCESS | 20113 | __start_tp_report 09:52:29 INFO - PROCESS | 20113 | _x_x_mozilla_page_load 09:52:29 INFO - PROCESS | 20113 | _x_x_mozilla_page_load_details 09:52:29 INFO - PROCESS | 20113 | |i|pagename|runs| 09:52:29 INFO - PROCESS | 20113 | |0;dojo.html;3166.746660267178;3214.0357892632205;3217.51737239414;3258.413485572599;3265.8530366133523;5260.8158714445;5277.947220527798;5283.313169287992;5320.547753440953;5365.409804921455;5296.920546191801;5342.305500284967;5415.810446634368;5422.783088676458;5456.236126942231;4876.512348765122;4912.312276281324;4945.752712364385;4948.752562371885;5085;4869.342638743778;4880.829170979016;4925.926111108336;4934.753262336887;4951.925721114186;4824.252240902666;4867.82962596311;4904.705717656952;4915.385576802882;4929.186684197103;4847.466778654345;4848.903021939542;4854.2961270615915;4863.148948933957;4906.582940450066;4774.427068751772;4803.303520989437;4822.987172693738;4824.517548245182;4860.513948605147;5118.513741194581;5128.435872054071;5224.425313215544;5261.552768014685;5297.284866543006;5736.455036771542;5746.367899531048;5747.683877386742;5765.04876695349;5783;5742.511886489611;5790.507806836424;5800.709964501758;5805.82582522525;5814.476697097281;5306.230596563515;5403.83788486346;5447.972760136174;5464.28964234647;5486.1222204447095;5793.246877905845;5809.8547536311935;5812.389699081536;5816.476517113396;5826.592138550261;5545.362283337387;5597.104463285936;5604.831855044274;5613.46672066153;5617.157426385993;5672.773089076473;5750.6262092963825;5782.3639399666;5826.825195244065;5861.120831875252;5678.375378708339;5698.202251684767;5699.173619825102;5709.885802283931;5719.742611582489;5618.831435056954;5656.858578535487;5692.6299790513485;5709.200711900337;5714.314282286152;4363.716358436692;4392.407025051577;4414.558544145624;4415.779211039435;4433.600975912119;3913.2369188008065;3922.8626998054933;3932.587078356731;3934.016495876031;3957.3470377387407;5296.708681022504;5426.158945363475;5429.538489228381;5434.429384914606;5445.128779395278;5635.971820140955;5678.4605462480995;5681.034224181816;5704.600677952587;5755.482006619424;5348.732563371816;5407.324084489439;5409.215663728737;5414;5421.132618780976;4719.85840424781;4790.784414701347;4848.684835485682;4858.82994095205;4904.337914381585;5977.0735535991125;5986.2517185351835;5994.250718660168;6005.189299444606;6038.788642397495;5668.886622267449;5688.715564221855;5688.800891968761;5696.658200507817;5699.772009119589;5974.342822289632;5981.730822112929;6038.4867286279405;6107.5226075721885;6113.23584551931;5762.913556296743;5772.913406298825;5774.249347584787;5778.768849245983;5798.623089499169;5744.310682718101;5748.669104770161;5813.447722466359;5825.94174058254;5826.184334193132;5578.246936663661;5589.944100558942;5642.125470552071;5661.631993920382;5682.460166284196;5490.203920431435;5493.176023596492;5496.450354964471;5514.862128446821;5583.74873130702;5469.75386107634;5510.641808282448;5516.227728118147;5522.6134170607675;5527.419620939904;5504.119340905436;5621.297337832771;5622.803201888078;5677.489025987681;5722.742476588647;5536.557075434036;5559.138333558305;5568.136938774496;5592.7762889483965;5605.663660180402 09:52:29 INFO - PROCESS | 20113 | |1;ext.html;557.6291765975625;557.6486813307616;564.7599770097708;578.965262084275;597.1430996519991;35250.471242931344;36296.27407451856;36349.818250908706;36448.81775591119;36457.088572785695;39278.41082383759;40054.39918401226;40072.39891401631;40099.19801603966;40131.398029029515;8497.49015059097;8719.651213951434;8744.562771861381;8756.4308319959;8760;8533.530655813927;8609.741707748777;8612.44975904337;8628.180322869317;8634.654613815439;8631.69789057383;8633.784155396103;8662.696805611804;8678.132186781302;8689.913100868973;8581.656733730642;8620.612072456754;8639.092895246034;8654.697085602005;8657.653693852239;8686;8753.343499237519;8786.297096232285;8800.823983520359;8813.911860881373;38158.42762358567;38343.616563834286;38356;38558.61441385606;38568;3011.1719277198945;3320.2197483591335;3854.2676891390824;3917.823697933571;4123.237201117803;30218.54672179919;30711.77152913881;31084.222894427596;31312.843435782674;31428.52857207144;3588.7129029677562;3633.242030884048;3648.6898613617873;3773.716971227169;3799.914340069918;266924;267296;267336;267624;268584;61474;61893.38106618876;61963.38036619666;62017.37982620116;62225.37774622286;56182.71908640431;65773.67113164403;65836.34163658302;65900;66046.66976665086;12949.805752913713;13024.739505209844;13092.149010314299;13179.14335568185;13286.402111904987;9242.491662958468;9242.72271831846;9267.25861931044;9274.675386361445;9325.487098209527;19464.416067517996;19765.802341976683;19836.20655173777;19949.900250498944;20002.59994800096;7842.411819113475;8162.14297498766;8174.3460523158;8245.464044837066;8297.751067467985;891.1355984694835;935.5228833294932;974.2352253480983;1002.0780881588955;1017.7404761785697;28961.42077158445;29086.70913290882;29208.853955730086;29248.561271580944;29664.258393540335;990.841465365538;1013.5641674080069;1020.4999550220487;1031.6234574380296;1032.5147180825;13301.866981330257;13889.374978126009;13942.930285348508;14005.229712365917;14030.579082627537;319932;325241;325421;326700;328418;54779;55006.44993550093;55028.72485637626;55234.723826381414;55471.99999999919;1220.5300959130798;1240.8821161989597;1266.9303188324545;1275.579058910576;1288.2013151845915;25612.487750245262;26685;26892.193234203005;26911.86544067267;27104.45791084128;50831.49168508268;52268;52270.73864630653;52283.47716522786;52483.47516524786;239043;242650;243385;244234;244532;32994.01017969465;33202.833985829915;33297;33305;33460.66539334576;44835.55164448444;45456.31815522704;45958;46334.7683261595;46616;38152;38187.61812381841;38475.807620961714;38703.61296387113;38721.80639096787;37889.2422151561;37998.43002354912;38359.2328153441;38671.22657546889;39006.219875602896;31651.36697265996;34548.309033819685;34849.47725784065;36189.81905090563;36384.454233187054;29648.703512964596;30557;30683.2329191772;30745.846270768503;30846.69153308438;23433.765662343158;23955.28134155978;24009;24331.39171520726;25718.485630287665 09:52:29 INFO - PROCESS | 20113 | |2;jquery.html;343.5675418040275;352.7671736653809;358.8905383857923;365.5083912138177;367.9025058359535;16709.58226044348;17072.231749571267;17677.82322176778;17721.113944302797;17721.379751708693;16125.596860078504;16344;17020.063896485688;17052.14739263035;17128.229229684664;5194.142966410538;5226.1396900882355;5290.1800220965815;5368.221607866876;5391.676499410029;5317.388500322454;5358.169483730028;5359.356877174725;5359.892802143955;5398.811041613544;5172.069027575035;5350.598705097113;5359.464053594629;5362.27609272749;5415.729213539327;5261.210818377255;5272.340957380327;5276.050310944029;5278.604104692164;5334.333208348957;4736.834210802605;4742.976285118587;4749.335093086971;4753.976230118862;4780.880477988043;19746.30887918916;19942.10260538279;20242.595148096956;20309.89845050765;20321.89839050795;1992.9900350498299;2023.676211806104;2026.5845501672122;2043.9284625038201;2095.8742475451522;6556.541042127053;8271.917280827174;11620.477078531487;11787.351695656735;11797.056235501139;1800.4418630224673;1831.2217307644198;1864.794872564017;1899.2403038784596;1952.180084364556;45970.77014614906;47027;50513.74743126298;61456.385436145516;62063.069053964224;10067.647632332979;10377.84433233502;10571.735706607396;10591.523381447852;10644.627438039632;13982.580522584136;13989.790153147711;14075;14098.083624564371;14102.365393557315;6841.17905851301;6897.241303456616;6939.201991771011;6948.33990770876;6956.234814170437;6555.967220163869;6581.3747693969;6614.404703576702;6624.304448032984;6675.532712710064;4448.088141930896;4578.221702310615;4603.838865639686;4604.309353596987;4715.363425937455;1877.3147801052517;1895.365052707331;1908.2367053178561;1916.1281616864294;1953.372713700071;846.8391005708895;875.7287420315063;884.5002573546054;919.117647058831;1006.5470538257667;15140.545783626509;15448.150351730763;16173.514794556182;16719.582010449594;17009.489715308562;835.4820011592851;836.2640876029055;880.2605811118691;894.8612964990436;904.0959040959041;7429.851402972018;9568.665096721581;9601.004339183637;9637;9671.129598336043;383484;389864;393329;402073;409656;65040;74760.62619686975;75534.24465755382;77866;78056.60971695105;1001.5042553935702;1019.6635110413397;1040.0327695243345;1045.8640376750973;1048.0201012053753;15167.848321516643;15197.772033419287;15482.225888705294;15549.378024878879;15790.289436975134;35385.29229415449;35448.46827297541;36033.45949810807;36088.4586731194;36497;50043.49956500388;50995.745021274655;51761.48238517567;52312.47687523076;53168.734156330516;7952.36381089523;8017.679292828455;8168.795780105307;8289.212524810133;8352.081271060057;9463.384879983054;12492.687682808002;12588.30764307972;12864.742705146033;12956.676083097998;10717.303375280582;11101.777964440827;11106.278091924;11233.157513186707;11521.88478115208;10808.405537695187;10856.674299771019;10986.780264394507;11001;11113.888861111285;10623.628173013907;11249.550017999189;11250.887491124984;11629.651110466699;11674.94162529182;7663.425243106678;7847.665896797444;8080.2727754502375;8179.10029896699;8392.28665563434;11025.393603351893;11119.221654484109;11229.66311010671;11248.325100493996;11336.94331528337 09:52:29 INFO - PROCESS | 20113 | |3;mootools.html;1514.5077849698848;1523.5048609202013;1733.8959662420257;1806.728990651403;1879.6616609010382;7108.893366599492;7741.264579864911;7742.5354478731315;7769.922300776991;7795.688172473101;7872.5276483411035;7914.762557123281;7944.841103177933;7977.800554986114;8009.519428834274;2339.637356209786;2360.9847765460845;2361.244401791427;2364.467994701187;2367.585672507313;2294.5410917816503;2309.307207837642;2329.231353653299;2338.859668419892;2351.059576169537;2328.2433209206993;2341.7658234176615;2358.7995020423286;2374.608189648706;2383.8569685818907;2286.691296674944;2292.7019487466605;2294.0479700924097;2313.6298192289237;2345.566070277004;2319.988400058006;2327.883605819702;2333.824963127772;2338.1933233034574;2344.120954642009;8136;8201.384896132755;8202.712905048355;8208.138145494697;8247.134050924686;4808.687435316693;4883.755812209411;4997.100521906055;5008.424031236382;5024.19612861944;3053.1756425765143;3194.7763656544053;3206.0542140068737;3230.9030729078167;3239.4492936200904;998.5306905754284;1021.9080282774512;1021.9795604087876;1034.400047972182;1038.84687996324;11400.201985860993;11431.199816012882;11435.485403156794;11447.771044579145;11484.598039068593;4035.1324465239527;4105.261053010427;4178.22702799983;4183.037901282662;4204.432401625802;9532.571034303473;9545.188658963927;9584.712458626253;9670.323077384657;9704.126628603459;4755.262934245197;4763.857084287477;4764.285357196448;4784.4497882743235;4796.784144713496;3991.501062367204;4313.654907607384;4357.716748411406;4375.956240437618;4427.933580996288;3686.4470329450796;3756.586775454698;3768.9057773555883;3794.1273507093524;3798.867039653599;1177.2289150606366;1205.2406983600276;1205.6081773423673;1210.3403645013489;1224.1736827641307;1287.9742405151844;1294.9287789171497;1308.2019967819622;1308.8691130887025;1318.3935389720837;7460.85078298431;7505.437092218105;7600.695972161162;7637.961810191025;7647.732329368446;502.2867528110019;511.7569154651585;518.2381898609038;520.9973950130301;524.910765169922;5778.3354914184565;5831.241938547962;5834.27071616048;5886.735096920649;5887.793927212527;9380.624775009059;9967.40195588267;10001.549930253155;10004.49977501122;10034.899651003396;9755.268354873413;9800.901990979999;9877.259205559612;9952.552135153936;9997.200223982209;7234.385077268385;7437.665305061285;7448.962755186298;7478.551286922802;7492.51298665585;7282.198958114497;7282.344588987016;7298.124225093023;7304.013958115586;7373.705051797868;8436.32509399259;8463.53450560225;8490;8605.784855378666;8643.91356086431;8685.609147588248;8714;8794.956025219833;8796.824063518567;9048.773780655272;6704.7988560343265;6840.555363901331;6890.586564806128;7266.527675701062;7419.851602967802;7359.889601656087;7377.926220737724;7378.667959941708;7379;7385.372243359375;6631.6684165792485;6713;6844.349786770249;6896.137982752156;6897.862042759217;6700.530962832555;6721.395074443323;6789.422899053636;6823.522353435212;6857.348551887562;6769.120014398097;6778.288279730557;6786.76246331376;6804.319568043354;7195.604241766544;6663.067170596218;6730.663466826737;6749.932500675127;6763.256041835296;6769.526133170631;6726.7981960541265;6761.290064543152;6762.256151823394;6778.830529236809;6793.864122717617 09:52:29 INFO - PROCESS | 20113 | |4;prototype.html;341.1641478377975;341.2816022273117;343.4916323840716;349.8967804497673;353.6622525488159;6223.626582405053;6253.812385628438;6276.592021518598;6295.968520157404;6337.556371054028;6198.566100372976;6206.1931948846695;6209.410106039931;6212.844678883019;6224.906626400608;4470.798814053359;4661.324108004337;4763.595094416962;4783.521647835223;4801.231802911535;4730.337752714623;4735.573798358147;4751.239801631739;4763.095011947719;4765.809367625291;4682.227432473638;4706.435227772672;4726.26742854858;4735.0529894021165;4737.431508219019;4721.150192965265;4730.834420795273;4752.833650822239;4756.595689366373;4759.309900064472;4228.1966426378885;4236.322188449864;4238.237117318881;4248.490181178247;4250.319948808206;5721.799737009184;5915;5990.760369585211;5992.550558708114;5997.940020599782;5472.5621950243885;5496.1755736639425;5503.559715222773;5507.531859791922;5508.394076651605;6615.206175258952;6659.101021362103;6662.600243985328;6665.600063996176;6669.966650166767;4518.43519560055;4519.412476378083;4526.434195725535;4529.592336689714;4542.273236282212;6835.316468353125;6843.62360070196;6854.794356169273;6902.480594582941;6909.550879192836;4537.397735744689;4562.931556026662;4612.423447069116;4613.077384523109;4630.351750754897;4633.814647414133;4671.85984420468;4673.906521869543;4674.929876051862;4685.8594242172785;5420;5422.349318081855;5429.375621803543;5430.728463576885;5453.809116680897;6612.504062195355;6658.86682266352;6666.433353165035;6679.499037572202;6682.565633233824;1605.566497045791;1632.6734653069434;1633.338497908349;1637.8280280570607;1644.4655486966783;1044.6343779677052;1059.390850261103;1080.9891901081046;1083.3824719909576;1090.231386872253;6329.784575398574;6330.145430366933;6358.109864618957;6359.682015899279;6361.300256971729;6772.390484856288;6818.147731533559;6825.419839313714;6825.624590647462;6826.692798824065;6125.081237814364;6195.504359651217;6205.906911396332;6207.596506227171;6282.277538083087;3665.7433979621705;3672.889813305605;3691.8523259069875;3702.7963462009848;3712.331780279522;7294.671739771723;7300.342969132804;7302.744403945836;7333.266673332624;7349.30181632744;7009.1589009319205;7017.508774385846;7033.261507541737;7049.189343225492;7060.7881763547175;7114.14630244374;7254.165770936304;7297.598632075287;7321.414286857039;7323.890141647879;6809.591424514545;6829.52193346461;6853.897191542231;6861.828454288483;6864.38220560152;6799.796006119825;6805;6806.455483561204;6825.863482730417;6840.589564626139;7254.637268136677;7280.3083707047745;7309.853802923805;7330.96334518324;7349.889751653623;4468.888277792951;4558.931616025829;4655.138799322136;4667.463241727245;4673.3457315976475;6776.661166941534;6824.658767061528;6872.553284036521;6875.3812156906115;6877.552959057845;6613.14029176204;6622.337766223339;6628.370304821035;6637.402633762985;6671.66641667905;6625.734970601122;6636.203655561363;6638;6648.468122550088;6652.7006284716335;6370.426661600478;6489.805305840832;6500;6516.110328005015;6521.315261897622;6600.60396376219;6610;6616.966915165393;6639.03733958583;6655.2346480153465;6429.22849258092;6460.644664543495;6461.127747753993;6484.870302593828;6503.414692677682 09:52:29 INFO - PROCESS | 20113 | |5;yui.html;743.8214828441172;758.2190343945731;767.6545554500473;782.5070205770364;795.6817273090763;13022.283774392405;13184.274864882416;13250.602481925534;13251.801222981663;13256.33718314084;12825.743485130291;12910.93544532276;12911.870881291185;12931;12949.41727622257;822.5517093184214;833.4582521361103;854.2952064546743;856.0797143071193;858.2061593026457;833.3291700181352;835.0897521701345;838.4633834346023;840.9915900841005;841.4320333774708;887.49856331173;890.692711014699;895.011012830819;895.5566994337812;896.1486587741672;872.677109469494;876.8816209811657;881.5856547422766;883.8630012348096;887.8535041718109;646.1245013007355;646.7445359083183;647.9028145778171;651.7490766055103;652.4258652385918;14212.50256241037;14240.359183836752;14291.071080379743;14317.212553309564;14525.128492290496;12627.810582841264;13036.41336139876;13090.149140305944;13184.934075329658;13409.530666426726;10408.843867341995;10465.790684186273;10505.107065899409;10646.988536089058;11095.72260693481;3544.113971507123;3570.9644203181047;3613.8012409317475;3632.745707800455;3660.853565857389;44747.77626111881;48821;49662.751686241696;50302.24546631803;51898.48101518974;10011.295049583869;10213.642522511676;10284.28010039305;10383;10465.895341046644;18431.26274948987;18591.34930277434;18600.720989185174;18648.160832762558;18688.439346819618;7904.604769761604;7925.722599708983;8084.797880052928;8097.635606397726;8187.26314631686;4381.16757816014;4383.430154079949;4406.581374769392;4514.277715565494;4662.160811054043;3171.127939816569;3182.9363412732077;3210.775245732823;3212.951805722916;3222.8388580571345;590.403692270801;595.8748662780778;598.5660396212711;599.7031469422664;601.167383174298;402.8529586700833;545.8140148704414;594.8869714754182;605.9697015149225;607.1166452811149;7730.265624765639;7983.920160798434;8087.393445491612;8134.422422263527;8356.122607126286;503.189864318447;537.8467136866053;550.2159422822542;631.2805977840777;647.8283254937445;3702.740808143404;3908.5733707197237;3926.469926559935;3939.2515422070287;3993.520777506718;58920;61151.69424152851;61303.386966129765;61354;61533;52440;53373.73313133487;53483.46516534863;53780;53828.46171538313;47838.521614784106;48254.517454825705;48996;49053.754731226116;49440.25839612409;7650.196729343339;7777.144514103557;7790.688372465264;7913.44605877583;8101.635426405708;35394;35929.82035089808;36265.093372664836;36384.454233187054;36736.81631591932;41552.1689566213;41642.79178604088;44853.10293794171;45123.0975380484;45738.77130614326;10115.696529103845;10207.336523125972;10236.948815255875;10335.534900929626;10352.068313851489;11291;11407.714807129889;11514.94242528782;11770.058395328182;11857.525698971944;10140.54367553447;10179.694609161737;10259.640912568024;10338.534765935401;10525.9473702631;10627.628033018807;10663.520141593492;10921.034213841585;10951;11141.777164456504;10092.192624589869;10258.692239232834;10276.845847312146;10518.158547316043;10518.474076296308;7844.2155784423385;8086.838263234585;8090.595470226347;8320.583970801557;8602.354823388396;8145.755627331189;8308.335333173452;8560.101189375026;8661.566921654017;8676.219140277406 09:52:29 INFO - PROCESS | 20113 | __end_tp_report 09:52:29 INFO - PROCESS | 20113 | __start_cc_report 09:52:29 INFO - PROCESS | 20113 | _x_x_mozilla_cycle_collect,336 09:52:29 INFO - PROCESS | 20113 | __end_cc_report 09:52:29 INFO - PROCESS | 20113 | __startTimestamp1457373149306__endTimestamp 09:52:29 INFO - PROCESS | 20113 | 09:52:29 INFO - PROCESS | 20113 | ------- Summary: start ------- 09:52:29 INFO - PROCESS | 20113 | Number of tests: 6 09:52:29 INFO - PROCESS | 20113 | 09:52:29 INFO - PROCESS | 20113 | [#0] dojo.html Cycles:165 Average:5330.48 Median:5516.23 stddev:596.71 (10.8%) stddev-sans-first:573.89 09:52:29 INFO - PROCESS | 20113 | Values: 3166.7 3214.0 3217.5 3258.4 3265.9 5260.8 5277.9 5283.3 5320.5 5365.4 5296.9 5342.3 5415.8 5422.8 5456.2 4876.5 4912.3 4945.8 4948.8 5085.0 4869.3 4880.8 4925.9 4934.8 4951.9 4824.3 4867.8 4904.7 4915.4 4929.2 4847.5 4848.9 4854.3 4863.1 4906.6 4774.4 4803.3 4823.0 4824.5 4860.5 5118.5 5128.4 5224.4 5261.6 5297.3 5736.5 5746.4 5747.7 5765.0 5783.0 5742.5 5790.5 5800.7 5805.8 5814.5 5306.2 5403.8 5448.0 5464.3 5486.1 5793.2 5809.9 5812.4 5816.5 5826.6 5545.4 5597.1 5604.8 5613.5 5617.2 5672.8 5750.6 5782.4 5826.8 5861.1 5678.4 5698.2 5699.2 5709.9 5719.7 5618.8 5656.9 5692.6 5709.2 5714.3 4363.7 4392.4 4414.6 4415.8 4433.6 3913.2 3922.9 3932.6 3934.0 3957.3 5296.7 5426.2 5429.5 5434.4 5445.1 5636.0 5678.5 5681.0 5704.6 5755.5 5348.7 5407.3 5409.2 5414.0 5421.1 4719.9 4790.8 4848.7 4858.8 4904.3 5977.1 5986.3 5994.3 6005.2 6038.8 5668.9 5688.7 5688.8 5696.7 5699.8 5974.3 5981.7 6038.5 6107.5 6113.2 5762.9 5772.9 5774.2 5778.8 5798.6 5744.3 5748.7 5813.4 5825.9 5826.2 5578.2 5589.9 5642.1 5661.6 5682.5 5490.2 5493.2 5496.5 5514.9 5583.7 5469.8 5510.6 5516.2 5522.6 5527.4 5504.1 5621.3 5622.8 5677.5 5722.7 5536.6 5559.1 5568.1 5592.8 5605.7 09:52:29 INFO - PROCESS | 20113 | 09:52:29 INFO - PROCESS | 20113 | [#1] ext.html Cycles:180 Average:45385.20 Median:38155.21 stddev:73401.43 (192.4%) stddev-sans-first:73530.17 09:52:29 INFO - PROCESS | 20113 | Values: 557.6 557.6 564.8 579.0 597.1 35250.5 36296.3 36349.8 36448.8 36457.1 39278.4 40054.4 40072.4 40099.2 40131.4 8497.5 8719.7 8744.6 8756.4 8760.0 8533.5 8609.7 8612.4 8628.2 8634.7 8631.7 8633.8 8662.7 8678.1 8689.9 8581.7 8620.6 8639.1 8654.7 8657.7 8686.0 8753.3 8786.3 8800.8 8813.9 38158.4 38343.6 38356.0 38558.6 38568.0 3011.2 3320.2 3854.3 3917.8 4123.2 30218.5 30711.8 31084.2 31312.8 31428.5 3588.7 3633.2 3648.7 3773.7 3799.9 266924.0 267296.0 267336.0 267624.0 268584.0 61474.0 61893.4 61963.4 62017.4 62225.4 56182.7 65773.7 65836.3 65900.0 66046.7 12949.8 13024.7 13092.1 13179.1 13286.4 9242.5 9242.7 9267.3 9274.7 9325.5 19464.4 19765.8 19836.2 19949.9 20002.6 7842.4 8162.1 8174.3 8245.5 8297.8 891.1 935.5 974.2 1002.1 1017.7 28961.4 29086.7 29208.9 29248.6 29664.3 990.8 1013.6 1020.5 1031.6 1032.5 13301.9 13889.4 13942.9 14005.2 14030.6 319932.0 325241.0 325421.0 326700.0 328418.0 54779.0 55006.4 55028.7 55234.7 55472.0 1220.5 1240.9 1266.9 1275.6 1288.2 25612.5 26685.0 26892.2 26911.9 27104.5 50831.5 52268.0 52270.7 52283.5 52483.5 239043.0 242650.0 243385.0 244234.0 244532.0 32994.0 33202.8 33297.0 33305.0 33460.7 44835.6 45456.3 45958.0 46334.8 46616.0 38152.0 38187.6 38475.8 38703.6 38721.8 37889.2 37998.4 38359.2 38671.2 39006.2 31651.4 34548.3 34849.5 36189.8 36384.5 29648.7 30557.0 30683.2 30745.8 30846.7 23433.8 23955.3 24009.0 24331.4 25718.5 09:52:29 INFO - PROCESS | 20113 | 09:52:29 INFO - PROCESS | 20113 | [#2] jquery.html Cycles:180 Average:24063.51 Median:18431.25 stddev:64991.87 (352.6%) stddev-sans-first:65149.78 09:52:29 INFO - PROCESS | 20113 | Values: 343.6 352.8 358.9 365.5 367.9 16709.6 17072.2 17677.8 17721.1 17721.4 16125.6 16344.0 17020.1 17052.1 17128.2 5194.1 5226.1 5290.2 5368.2 5391.7 5317.4 5358.2 5359.4 5359.9 5398.8 5172.1 5350.6 5359.5 5362.3 5415.7 5261.2 5272.3 5276.1 5278.6 5334.3 4736.8 4743.0 4749.3 4754.0 4780.9 19746.3 19942.1 20242.6 20309.9 20321.9 1993.0 2023.7 2026.6 2043.9 2095.9 6556.5 8271.9 11620.5 11787.4 11797.1 1800.4 1831.2 1864.8 1899.2 1952.2 45970.8 47027.0 50513.7 61456.4 62063.1 10067.6 10377.8 10571.7 10591.5 10644.6 13982.6 13989.8 14075.0 14098.1 14102.4 6841.2 6897.2 6939.2 6948.3 6956.2 6556.0 6581.4 6614.4 6624.3 6675.5 4448.1 4578.2 4603.8 4604.3 4715.4 1877.3 1895.4 1908.2 1916.1 1953.4 846.8 875.7 884.5 919.1 1006.5 15140.5 15448.2 16173.5 16719.6 17009.5 835.5 836.3 880.3 894.9 904.1 7429.9 9568.7 9601.0 9637.0 9671.1 383484.0 389864.0 393329.0 402073.0 409656.0 65040.0 74760.6 75534.2 77866.0 78056.6 1001.5 1019.7 1040.0 1045.9 1048.0 15167.8 15197.8 15482.2 15549.4 15790.3 35385.3 35448.5 36033.5 36088.5 36497.0 50043.5 50995.7 51761.5 52312.5 53168.7 7952.4 8017.7 8168.8 8289.2 8352.1 9463.4 12492.7 12588.3 12864.7 12956.7 10717.3 11101.8 11106.3 11233.2 11521.9 10808.4 10856.7 10986.8 11001.0 11113.9 10623.6 11249.6 11250.9 11629.7 11674.9 7663.4 7847.7 8080.3 8179.1 8392.3 11025.4 11119.2 11229.7 11248.3 11336.9 09:52:29 INFO - PROCESS | 20113 | 09:52:29 INFO - PROCESS | 20113 | [#3] mootools.html Cycles:180 Average:5580.89 Median:5887.26 stddev:2952.41 (50.1%) stddev-sans-first:2944.87 09:52:29 INFO - PROCESS | 20113 | Values: 1514.5 1523.5 1733.9 1806.7 1879.7 7108.9 7741.3 7742.5 7769.9 7795.7 7872.5 7914.8 7944.8 7977.8 8009.5 2339.6 2361.0 2361.2 2364.5 2367.6 2294.5 2309.3 2329.2 2338.9 2351.1 2328.2 2341.8 2358.8 2374.6 2383.9 2286.7 2292.7 2294.0 2313.6 2345.6 2320.0 2327.9 2333.8 2338.2 2344.1 8136.0 8201.4 8202.7 8208.1 8247.1 4808.7 4883.8 4997.1 5008.4 5024.2 3053.2 3194.8 3206.1 3230.9 3239.4 998.5 1021.9 1022.0 1034.4 1038.8 11400.2 11431.2 11435.5 11447.8 11484.6 4035.1 4105.3 4178.2 4183.0 4204.4 9532.6 9545.2 9584.7 9670.3 9704.1 4755.3 4763.9 4764.3 4784.4 4796.8 3991.5 4313.7 4357.7 4376.0 4427.9 3686.4 3756.6 3768.9 3794.1 3798.9 1177.2 1205.2 1205.6 1210.3 1224.2 1288.0 1294.9 1308.2 1308.9 1318.4 7460.9 7505.4 7600.7 7638.0 7647.7 502.3 511.8 518.2 521.0 524.9 5778.3 5831.2 5834.3 5886.7 5887.8 9380.6 9967.4 10001.5 10004.5 10034.9 9755.3 9800.9 9877.3 9952.6 9997.2 7234.4 7437.7 7449.0 7478.6 7492.5 7282.2 7282.3 7298.1 7304.0 7373.7 8436.3 8463.5 8490.0 8605.8 8643.9 8685.6 8714.0 8795.0 8796.8 9048.8 6704.8 6840.6 6890.6 7266.5 7419.9 7359.9 7377.9 7378.7 7379.0 7385.4 6631.7 6713.0 6844.3 6896.1 6897.9 6700.5 6721.4 6789.4 6823.5 6857.3 6769.1 6778.3 6786.8 6804.3 7195.6 6663.1 6730.7 6749.9 6763.3 6769.5 6726.8 6761.3 6762.3 6778.8 6793.9 09:52:29 INFO - PROCESS | 20113 | 09:52:29 INFO - PROCESS | 20113 | [#4] prototype.html Cycles:180 Average:5539.82 Median:6265.20 stddev:1700.86 (27.1%) stddev-sans-first:1660.27 09:52:29 INFO - PROCESS | 20113 | Values: 341.2 341.3 343.5 349.9 353.7 6223.6 6253.8 6276.6 6296.0 6337.6 6198.6 6206.2 6209.4 6212.8 6224.9 4470.8 4661.3 4763.6 4783.5 4801.2 4730.3 4735.6 4751.2 4763.1 4765.8 4682.2 4706.4 4726.3 4735.1 4737.4 4721.2 4730.8 4752.8 4756.6 4759.3 4228.2 4236.3 4238.2 4248.5 4250.3 5721.8 5915.0 5990.8 5992.6 5997.9 5472.6 5496.2 5503.6 5507.5 5508.4 6615.2 6659.1 6662.6 6665.6 6670.0 4518.4 4519.4 4526.4 4529.6 4542.3 6835.3 6843.6 6854.8 6902.5 6909.6 4537.4 4562.9 4612.4 4613.1 4630.4 4633.8 4671.9 4673.9 4674.9 4685.9 5420.0 5422.3 5429.4 5430.7 5453.8 6612.5 6658.9 6666.4 6679.5 6682.6 1605.6 1632.7 1633.3 1637.8 1644.5 1044.6 1059.4 1081.0 1083.4 1090.2 6329.8 6330.1 6358.1 6359.7 6361.3 6772.4 6818.1 6825.4 6825.6 6826.7 6125.1 6195.5 6205.9 6207.6 6282.3 3665.7 3672.9 3691.9 3702.8 3712.3 7294.7 7300.3 7302.7 7333.3 7349.3 7009.2 7017.5 7033.3 7049.2 7060.8 7114.1 7254.2 7297.6 7321.4 7323.9 6809.6 6829.5 6853.9 6861.8 6864.4 6799.8 6805.0 6806.5 6825.9 6840.6 7254.6 7280.3 7309.9 7331.0 7349.9 4468.9 4558.9 4655.1 4667.5 4673.3 6776.7 6824.7 6872.6 6875.4 6877.6 6613.1 6622.3 6628.4 6637.4 6671.7 6625.7 6636.2 6638.0 6648.5 6652.7 6370.4 6489.8 6500.0 6516.1 6521.3 6600.6 6610.0 6617.0 6639.0 6655.2 6429.2 6460.6 6461.1 6484.9 6503.4 09:52:29 INFO - PROCESS | 20113 | 09:52:29 INFO - PROCESS | 20113 | [#5] yui.html Cycles:180 Average:13905.70 Median:25200.47 stddev:16588.78 (65.8%) stddev-sans-first:16605.87 09:52:29 INFO - PROCESS | 20113 | Values: 743.8 758.2 767.7 782.5 795.7 13022.3 13184.3 13250.6 13251.8 13256.3 12825.7 12910.9 12911.9 12931.0 12949.4 822.6 833.5 854.3 856.1 858.2 833.3 835.1 838.5 841.0 841.4 887.5 890.7 895.0 895.6 896.1 872.7 876.9 881.6 883.9 887.9 646.1 646.7 647.9 651.7 652.4 14212.5 14240.4 14291.1 14317.2 14525.1 12627.8 13036.4 13090.1 13184.9 13409.5 10408.8 10465.8 10505.1 10647.0 11095.7 3544.1 3571.0 3613.8 3632.7 3660.9 44747.8 48821.0 49662.8 50302.2 51898.5 10011.3 10213.6 10284.3 10383.0 10465.9 18431.3 18591.3 18600.7 18648.2 18688.4 7904.6 7925.7 8084.8 8097.6 8187.3 4381.2 4383.4 4406.6 4514.3 4662.2 3171.1 3182.9 3210.8 3213.0 3222.8 590.4 595.9 598.6 599.7 601.2 402.9 545.8 594.9 606.0 607.1 7730.3 7983.9 8087.4 8134.4 8356.1 503.2 537.8 550.2 631.3 647.8 3702.7 3908.6 3926.5 3939.3 3993.5 58920.0 61151.7 61303.4 61354.0 61533.0 52440.0 53373.7 53483.5 53780.0 53828.5 47838.5 48254.5 48996.0 49053.8 49440.3 7650.2 7777.1 7790.7 7913.4 8101.6 35394.0 35929.8 36265.1 36384.5 36736.8 41552.2 41642.8 44853.1 45123.1 45738.8 10115.7 10207.3 10236.9 10335.5 10352.1 11291.0 11407.7 11514.9 11770.1 11857.5 10140.5 10179.7 10259.6 10338.5 10525.9 10627.6 10663.5 10921.0 10951.0 11141.8 10092.2 10258.7 10276.8 10518.2 10518.5 7844.2 8086.8 8090.6 8320.6 8602.4 8145.8 8308.3 8560.1 8661.6 8676.2 09:52:29 INFO - PROCESS | 20113 | -------- Summary: end -------- 09:52:29 INFO - PROCESS | 20113 | 09:52:30 INFO - TEST-INFO | 20113: exit 0 09:52:30 INFO - TEST-OK | dromaeo_css | took 1111398ms 09:52:30 INFO - TEST-START | kraken 09:52:30 INFO - operating with platform_type : linux_ 09:52:30 INFO - Initialising browser for kraken test... 09:52:30 INFO - TEST-INFO | started process 20352 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ1sd9w/profile http://localhost:59980/getInfo.html) 09:52:33 INFO - PROCESS | 20352 | 09:52:33 INFO - PROCESS | 20352 | (process:20421): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:52:34 INFO - PROCESS | 20352 | __metrics Screen width/height:1600/1200 09:52:34 INFO - PROCESS | 20352 | colorDepth:24 09:52:34 INFO - PROCESS | 20352 | Browser inner width/height: 1024/697 09:52:34 INFO - PROCESS | 20352 | __metrics 09:52:35 ERROR - PROCESS | 20352 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:52:35 INFO - TEST-INFO | 20352: exit 0 09:52:35 INFO - Browser initialized. 09:52:35 INFO - Running cycle 1/1 for kraken test... 09:52:35 INFO - TEST-INFO | started process 20472 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ1sd9w/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:37 INFO - PROCESS | 20472 | 09:52:37 INFO - PROCESS | 20472 | (process:20536): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:52:47 INFO - PROCESS | 20472 | RSS: Main: 165679104 09:52:47 INFO - PROCESS | 20472 | 09:52:50 INFO - PROCESS | 20472 | Cycle 1(1): loaded http://localhost:59980/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59980/tests/kraken/driver.html?testName=audio-beat-detection) 09:52:50 INFO - PROCESS | 20472 | RSS: Main: 169525248 09:52:50 INFO - PROCESS | 20472 | 09:52:53 INFO - PROCESS | 20472 | Cycle 1(1): loaded http://localhost:59980/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59980/tests/kraken/driver.html?testName=audio-dft) 09:52:54 INFO - PROCESS | 20472 | RSS: Main: 171761664 09:52:54 INFO - PROCESS | 20472 | 09:52:56 INFO - PROCESS | 20472 | Cycle 1(1): loaded http://localhost:59980/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59980/tests/kraken/driver.html?testName=audio-fft) 09:52:57 INFO - PROCESS | 20472 | RSS: Main: 165359616 09:52:57 INFO - PROCESS | 20472 | 09:52:59 INFO - PROCESS | 20472 | Cycle 1(1): loaded http://localhost:59980/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59980/tests/kraken/driver.html?testName=audio-oscillator) 09:53:00 INFO - PROCESS | 20472 | RSS: Main: 164884480 09:53:00 INFO - PROCESS | 20472 | 09:53:02 INFO - PROCESS | 20472 | Cycle 1(1): loaded http://localhost:59980/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59980/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:53:03 INFO - PROCESS | 20472 | RSS: Main: 166449152 09:53:03 INFO - PROCESS | 20472 | 09:53:06 INFO - PROCESS | 20472 | Cycle 1(1): loaded http://localhost:59980/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59980/tests/kraken/driver.html?testName=imaging-darkroom) 09:53:06 INFO - PROCESS | 20472 | RSS: Main: 166772736 09:53:06 INFO - PROCESS | 20472 | 09:53:10 INFO - PROCESS | 20472 | Cycle 1(1): loaded http://localhost:59980/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59980/tests/kraken/driver.html?testName=imaging-desaturate) 09:53:10 INFO - PROCESS | 20472 | RSS: Main: 167424000 09:53:10 INFO - PROCESS | 20472 | 09:53:13 INFO - PROCESS | 20472 | Cycle 1(1): loaded http://localhost:59980/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59980/tests/kraken/driver.html?testName=json-parse-financial) 09:53:14 INFO - PROCESS | 20472 | RSS: Main: 170622976 09:53:14 INFO - PROCESS | 20472 | 09:53:15 INFO - PROCESS | 20472 | Cycle 1(1): loaded http://localhost:59980/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59980/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:53:16 INFO - PROCESS | 20472 | RSS: Main: 169582592 09:53:16 INFO - PROCESS | 20472 | 09:53:18 INFO - PROCESS | 20472 | Cycle 1(1): loaded http://localhost:59980/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59980/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:53:18 INFO - PROCESS | 20472 | RSS: Main: 169750528 09:53:18 INFO - PROCESS | 20472 | 09:53:20 INFO - PROCESS | 20472 | Cycle 1(1): loaded http://localhost:59980/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59980/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:53:21 INFO - PROCESS | 20472 | RSS: Main: 170160128 09:53:21 INFO - PROCESS | 20472 | 09:53:23 INFO - PROCESS | 20472 | Cycle 1(1): loaded http://localhost:59980/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59980/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:53:24 INFO - PROCESS | 20472 | RSS: Main: 170102784 09:53:24 INFO - PROCESS | 20472 | 09:53:27 INFO - PROCESS | 20472 | Cycle 1(1): loaded http://localhost:59980/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59980/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:53:27 INFO - PROCESS | 20472 | RSS: Main: 169611264 09:53:27 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | Cycle 1(1): loaded http://localhost:59980/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59980/tests/kraken/driver.html?testName=ai-astar) 09:53:29 INFO - PROCESS | 20472 | RSS: Main: 171491328 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | __start_tp_report 09:53:29 INFO - PROCESS | 20472 | _x_x_mozilla_page_load 09:53:29 INFO - PROCESS | 20472 | _x_x_mozilla_page_load_details 09:53:29 INFO - PROCESS | 20472 | |i|pagename|runs| 09:53:29 INFO - PROCESS | 20472 | |0;ai-astar;113;107;111;111;112;122;111;110;111;111 09:53:29 INFO - PROCESS | 20472 | |1;audio-beat-detection;149;135;160;171;131;153;160;127;176;129 09:53:29 INFO - PROCESS | 20472 | |2;audio-dft;164;163;163;161;163;161;162;167;167;164 09:53:29 INFO - PROCESS | 20472 | |3;audio-fft;75;76;83;75;72;73;75;76;136;73 09:53:29 INFO - PROCESS | 20472 | |4;audio-oscillator;94;94;145;95;94;93;152;94;94;153 09:53:29 INFO - PROCESS | 20472 | |5;imaging-gaussian-blur;118;117;117;118;118;118;118;117;117;117 09:53:29 INFO - PROCESS | 20472 | |6;imaging-darkroom;146;146;147;146;146;147;146;146;147;146 09:53:29 INFO - PROCESS | 20472 | |7;imaging-desaturate;96;96;96;97;96;97;96;96;97;96 09:53:29 INFO - PROCESS | 20472 | |8;json-parse-financial;59;57;58;57;64;58;58;61;58;55 09:53:29 INFO - PROCESS | 20472 | |9;json-stringify-tinderbox;68;69;68;71;69;69;68;67;69;68 09:53:29 INFO - PROCESS | 20472 | |10;stanford-crypto-aes;80;82;81;82;83;83;83;81;82;89 09:53:29 INFO - PROCESS | 20472 | |11;stanford-crypto-ccm;120;114;114;125;120;116;117;116;124;115 09:53:29 INFO - PROCESS | 20472 | |12;stanford-crypto-pbkdf2;152;154;160;150;150;137;152;145;151;139 09:53:29 INFO - PROCESS | 20472 | |13;stanford-crypto-sha256-iterative;77;68;67;68;67;68;70;72;69;69 09:53:29 INFO - PROCESS | 20472 | __end_tp_report 09:53:29 INFO - PROCESS | 20472 | __start_cc_report 09:53:29 INFO - PROCESS | 20472 | _x_x_mozilla_cycle_collect,843 09:53:29 INFO - PROCESS | 20472 | __end_cc_report 09:53:29 INFO - PROCESS | 20472 | __startTimestamp1457373209710__endTimestamp 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | ------- Summary: start ------- 09:53:29 INFO - PROCESS | 20472 | Number of tests: 14 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.00 stddev:3.87 (3.5%) stddev-sans-first:4.09 09:53:29 INFO - PROCESS | 20472 | Values: 113.0 107.0 111.0 111.0 112.0 122.0 111.0 110.0 111.0 111.0 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:156.50 stddev:17.87 (11.4%) stddev-sans-first:18.96 09:53:29 INFO - PROCESS | 20472 | Values: 149.0 135.0 160.0 171.0 131.0 153.0 160.0 127.0 176.0 129.0 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:2.12 (1.3%) stddev-sans-first:2.24 09:53:29 INFO - PROCESS | 20472 | Values: 164.0 163.0 163.0 161.0 163.0 161.0 162.0 167.0 167.0 164.0 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:19.42 (25.9%) stddev-sans-first:20.46 09:53:29 INFO - PROCESS | 20472 | Values: 75.0 76.0 83.0 75.0 72.0 73.0 75.0 76.0 136.0 73.0 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:94.00 stddev:27.13 (28.9%) stddev-sans-first:28.09 09:53:29 INFO - PROCESS | 20472 | Values: 94.0 94.0 145.0 95.0 94.0 93.0 152.0 94.0 94.0 153.0 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:53:29 INFO - PROCESS | 20472 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 117.0 117.0 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:53:29 INFO - PROCESS | 20472 | Values: 146.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:53:29 INFO - PROCESS | 20472 | Values: 96.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 97.0 96.0 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.00 stddev:2.46 (4.2%) stddev-sans-first:2.60 09:53:29 INFO - PROCESS | 20472 | Values: 59.0 57.0 58.0 57.0 64.0 58.0 58.0 61.0 58.0 55.0 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:1.07 (1.6%) stddev-sans-first:1.12 09:53:29 INFO - PROCESS | 20472 | Values: 68.0 69.0 68.0 71.0 69.0 69.0 68.0 67.0 69.0 68.0 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.50 stddev:2.46 (3.0%) stddev-sans-first:2.42 09:53:29 INFO - PROCESS | 20472 | Values: 80.0 82.0 81.0 82.0 83.0 83.0 83.0 81.0 82.0 89.0 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:118.50 stddev:3.98 (3.4%) stddev-sans-first:4.17 09:53:29 INFO - PROCESS | 20472 | Values: 120.0 114.0 114.0 125.0 120.0 116.0 117.0 116.0 124.0 115.0 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:151.50 stddev:6.91 (4.6%) stddev-sans-first:7.25 09:53:29 INFO - PROCESS | 20472 | Values: 152.0 154.0 160.0 150.0 150.0 137.0 152.0 145.0 151.0 139.0 09:53:29 INFO - PROCESS | 20472 | 09:53:29 INFO - PROCESS | 20472 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.00 stddev:3.03 (4.4%) stddev-sans-first:1.58 09:53:29 INFO - PROCESS | 20472 | Values: 77.0 68.0 67.0 68.0 67.0 68.0 70.0 72.0 69.0 69.0 09:53:29 INFO - PROCESS | 20472 | -------- Summary: end -------- 09:53:29 INFO - PROCESS | 20472 | 09:53:30 INFO - TEST-INFO | 20472: exit 0 09:53:30 INFO - TEST-OK | kraken | took 60594ms 09:53:30 INFO - SUITE-END | took 1171s 09:53:30 INFO - Completed test suite (00:19:32) 09:53:30 INFO - javascript benchmark 09:53:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3166.746660267178, 3214.0357892632205, 3217.51737239414, 3258.413485572599, 3265.8530366133523, 5260.8158714445, 5277.947220527798, 5283.313169287992, 5320.547753440953, 5365.409804921455, 5296.920546191801, 5342.305500284967, 5415.810446634368, 5422.783088676458, 5456.236126942231, 4876.512348765122, 4912.312276281324, 4945.752712364385, 4948.752562371885, 5085.0, 4869.342638743778, 4880.829170979016, 4925.926111108336, 4934.753262336887, 4951.925721114186, 4824.252240902666, 4867.82962596311, 4904.705717656952, 4915.385576802882, 4929.186684197103, 4847.466778654345, 4848.903021939542, 4854.2961270615915, 4863.148948933957, 4906.582940450066, 4774.427068751772, 4803.303520989437, 4822.987172693738, 4824.517548245182, 4860.513948605147, 5118.513741194581, 5128.435872054071, 5224.425313215544, 5261.552768014685, 5297.284866543006, 5736.455036771542, 5746.367899531048, 5747.683877386742, 5765.04876695349, 5783.0, 5742.511886489611, 5790.507806836424, 5800.709964501758, 5805.82582522525, 5814.476697097281, 5306.230596563515, 5403.83788486346, 5447.972760136174, 5464.28964234647, 5486.1222204447095, 5793.246877905845, 5809.8547536311935, 5812.389699081536, 5816.476517113396, 5826.592138550261, 5545.362283337387, 5597.104463285936, 5604.831855044274, 5613.46672066153, 5617.157426385993, 5672.773089076473, 5750.6262092963825, 5782.3639399666, 5826.825195244065, 5861.120831875252, 5678.375378708339, 5698.202251684767, 5699.173619825102, 5709.885802283931, 5719.742611582489, 5618.831435056954, 5656.858578535487, 5692.6299790513485, 5709.200711900337, 5714.314282286152, 4363.716358436692, 4392.407025051577, 4414.558544145624, 4415.779211039435, 4433.600975912119, 3913.2369188008065, 3922.8626998054933, 3932.587078356731, 3934.016495876031, 3957.3470377387407, 5296.708681022504, 5426.158945363475, 5429.538489228381, 5434.429384914606, 5445.128779395278, 5635.971820140955, 5678.4605462480995, 5681.034224181816, 5704.600677952587, 5755.482006619424, 5348.732563371816, 5407.324084489439, 5409.215663728737, 5414.0, 5421.132618780976, 4719.85840424781, 4790.784414701347, 4848.684835485682, 4858.82994095205, 4904.337914381585, 5977.0735535991125, 5986.2517185351835, 5994.250718660168, 6005.189299444606, 6038.788642397495, 5668.886622267449, 5688.715564221855, 5688.800891968761, 5696.658200507817, 5699.772009119589, 5974.342822289632, 5981.730822112929, 6038.4867286279405, 6107.5226075721885, 6113.23584551931, 5762.913556296743, 5772.913406298825, 5774.249347584787, 5778.768849245983, 5798.623089499169, 5744.310682718101, 5748.669104770161, 5813.447722466359, 5825.94174058254, 5826.184334193132, 5578.246936663661, 5589.944100558942, 5642.125470552071, 5661.631993920382, 5682.460166284196, 5490.203920431435, 5493.176023596492, 5496.450354964471, 5514.862128446821, 5583.74873130702, 5469.75386107634, 5510.641808282448, 5516.227728118147, 5522.6134170607675, 5527.419620939904, 5504.119340905436, 5621.297337832771, 5622.803201888078, 5677.489025987681, 5722.742476588647, 5536.557075434036, 5559.138333558305, 5568.136938774496, 5592.7762889483965, 5605.663660180402], "unit": "score", "name": "dojo.html", "value": 5291.558085410329}, {"lowerIsBetter": false, "replicates": [557.6291765975625, 557.6486813307616, 564.7599770097708, 578.965262084275, 597.1430996519991, 35250.471242931344, 36296.27407451856, 36349.818250908706, 36448.81775591119, 36457.088572785695, 39278.41082383759, 40054.39918401226, 40072.39891401631, 40099.19801603966, 40131.398029029515, 8497.49015059097, 8719.651213951434, 8744.562771861381, 8756.4308319959, 8760.0, 8533.530655813927, 8609.741707748777, 8612.44975904337, 8628.180322869317, 8634.654613815439, 8631.69789057383, 8633.784155396103, 8662.696805611804, 8678.132186781302, 8689.913100868973, 8581.656733730642, 8620.612072456754, 8639.092895246034, 8654.697085602005, 8657.653693852239, 8686.0, 8753.343499237519, 8786.297096232285, 8800.823983520359, 8813.911860881373, 38158.42762358567, 38343.616563834286, 38356.0, 38558.61441385606, 38568.0, 3011.1719277198945, 3320.2197483591335, 3854.2676891390824, 3917.823697933571, 4123.237201117803, 30218.54672179919, 30711.77152913881, 31084.222894427596, 31312.843435782674, 31428.52857207144, 3588.7129029677562, 3633.242030884048, 3648.6898613617873, 3773.716971227169, 3799.914340069918, 266924.0, 267296.0, 267336.0, 267624.0, 268584.0, 61474.0, 61893.38106618876, 61963.38036619666, 62017.37982620116, 62225.37774622286, 56182.71908640431, 65773.67113164403, 65836.34163658302, 65900.0, 66046.66976665086, 12949.805752913713, 13024.739505209844, 13092.149010314299, 13179.14335568185, 13286.402111904987, 9242.491662958468, 9242.72271831846, 9267.25861931044, 9274.675386361445, 9325.487098209527, 19464.416067517996, 19765.802341976683, 19836.20655173777, 19949.900250498944, 20002.59994800096, 7842.411819113475, 8162.14297498766, 8174.3460523158, 8245.464044837066, 8297.751067467985, 891.1355984694835, 935.5228833294932, 974.2352253480983, 1002.0780881588955, 1017.7404761785697, 28961.42077158445, 29086.70913290882, 29208.853955730086, 29248.561271580944, 29664.258393540335, 990.841465365538, 1013.5641674080069, 1020.4999550220487, 1031.6234574380296, 1032.5147180825, 13301.866981330257, 13889.374978126009, 13942.930285348508, 14005.229712365917, 14030.579082627537, 319932.0, 325241.0, 325421.0, 326700.0, 328418.0, 54779.0, 55006.44993550093, 55028.72485637626, 55234.723826381414, 55471.99999999919, 1220.5300959130798, 1240.8821161989597, 1266.9303188324545, 1275.579058910576, 1288.2013151845915, 25612.487750245262, 26685.0, 26892.193234203005, 26911.86544067267, 27104.45791084128, 50831.49168508268, 52268.0, 52270.73864630653, 52283.47716522786, 52483.47516524786, 239043.0, 242650.0, 243385.0, 244234.0, 244532.0, 32994.01017969465, 33202.833985829915, 33297.0, 33305.0, 33460.66539334576, 44835.55164448444, 45456.31815522704, 45958.0, 46334.7683261595, 46616.0, 38152.0, 38187.61812381841, 38475.807620961714, 38703.61296387113, 38721.80639096787, 37889.2422151561, 37998.43002354912, 38359.2328153441, 38671.22657546889, 39006.219875602896, 31651.36697265996, 34548.309033819685, 34849.47725784065, 36189.81905090563, 36384.454233187054, 29648.703512964596, 30557.0, 30683.2329191772, 30745.846270768503, 30846.69153308438, 23433.765662343158, 23955.28134155978, 24009.0, 24331.39171520726, 25718.485630287665], "unit": "score", "name": "ext.html", "value": 18209.437300863887}, {"lowerIsBetter": false, "replicates": [343.5675418040275, 352.7671736653809, 358.8905383857923, 365.5083912138177, 367.9025058359535, 16709.58226044348, 17072.231749571267, 17677.82322176778, 17721.113944302797, 17721.379751708693, 16125.596860078504, 16344.0, 17020.063896485688, 17052.14739263035, 17128.229229684664, 5194.142966410538, 5226.1396900882355, 5290.1800220965815, 5368.221607866876, 5391.676499410029, 5317.388500322454, 5358.169483730028, 5359.356877174725, 5359.892802143955, 5398.811041613544, 5172.069027575035, 5350.598705097113, 5359.464053594629, 5362.27609272749, 5415.729213539327, 5261.210818377255, 5272.340957380327, 5276.050310944029, 5278.604104692164, 5334.333208348957, 4736.834210802605, 4742.976285118587, 4749.335093086971, 4753.976230118862, 4780.880477988043, 19746.30887918916, 19942.10260538279, 20242.595148096956, 20309.89845050765, 20321.89839050795, 1992.9900350498299, 2023.676211806104, 2026.5845501672122, 2043.9284625038201, 2095.8742475451522, 6556.541042127053, 8271.917280827174, 11620.477078531487, 11787.351695656735, 11797.056235501139, 1800.4418630224673, 1831.2217307644198, 1864.794872564017, 1899.2403038784596, 1952.180084364556, 45970.77014614906, 47027.0, 50513.74743126298, 61456.385436145516, 62063.069053964224, 10067.647632332979, 10377.84433233502, 10571.735706607396, 10591.523381447852, 10644.627438039632, 13982.580522584136, 13989.790153147711, 14075.0, 14098.083624564371, 14102.365393557315, 6841.17905851301, 6897.241303456616, 6939.201991771011, 6948.33990770876, 6956.234814170437, 6555.967220163869, 6581.3747693969, 6614.404703576702, 6624.304448032984, 6675.532712710064, 4448.088141930896, 4578.221702310615, 4603.838865639686, 4604.309353596987, 4715.363425937455, 1877.3147801052517, 1895.365052707331, 1908.2367053178561, 1916.1281616864294, 1953.372713700071, 846.8391005708895, 875.7287420315063, 884.5002573546054, 919.117647058831, 1006.5470538257667, 15140.545783626509, 15448.150351730763, 16173.514794556182, 16719.582010449594, 17009.489715308562, 835.4820011592851, 836.2640876029055, 880.2605811118691, 894.8612964990436, 904.0959040959041, 7429.851402972018, 9568.665096721581, 9601.004339183637, 9637.0, 9671.129598336043, 383484.0, 389864.0, 393329.0, 402073.0, 409656.0, 65040.0, 74760.62619686975, 75534.24465755382, 77866.0, 78056.60971695105, 1001.5042553935702, 1019.6635110413397, 1040.0327695243345, 1045.8640376750973, 1048.0201012053753, 15167.848321516643, 15197.772033419287, 15482.225888705294, 15549.378024878879, 15790.289436975134, 35385.29229415449, 35448.46827297541, 36033.45949810807, 36088.4586731194, 36497.0, 50043.49956500388, 50995.745021274655, 51761.48238517567, 52312.47687523076, 53168.734156330516, 7952.36381089523, 8017.679292828455, 8168.795780105307, 8289.212524810133, 8352.081271060057, 9463.384879983054, 12492.687682808002, 12588.30764307972, 12864.742705146033, 12956.676083097998, 10717.303375280582, 11101.777964440827, 11106.278091924, 11233.157513186707, 11521.88478115208, 10808.405537695187, 10856.674299771019, 10986.780264394507, 11001.0, 11113.888861111285, 10623.628173013907, 11249.550017999189, 11250.887491124984, 11629.651110466699, 11674.94162529182, 7663.425243106678, 7847.665896797444, 8080.2727754502375, 8179.10029896699, 8392.28665563434, 11025.393603351893, 11119.221654484109, 11229.66311010671, 11248.325100493996, 11336.94331528337], "unit": "score", "name": "jquery.html", "value": 8292.093938569978}, {"lowerIsBetter": false, "replicates": [1514.5077849698848, 1523.5048609202013, 1733.8959662420257, 1806.728990651403, 1879.6616609010382, 7108.893366599492, 7741.264579864911, 7742.5354478731315, 7769.922300776991, 7795.688172473101, 7872.5276483411035, 7914.762557123281, 7944.841103177933, 7977.800554986114, 8009.519428834274, 2339.637356209786, 2360.9847765460845, 2361.244401791427, 2364.467994701187, 2367.585672507313, 2294.5410917816503, 2309.307207837642, 2329.231353653299, 2338.859668419892, 2351.059576169537, 2328.2433209206993, 2341.7658234176615, 2358.7995020423286, 2374.608189648706, 2383.8569685818907, 2286.691296674944, 2292.7019487466605, 2294.0479700924097, 2313.6298192289237, 2345.566070277004, 2319.988400058006, 2327.883605819702, 2333.824963127772, 2338.1933233034574, 2344.120954642009, 8136.0, 8201.384896132755, 8202.712905048355, 8208.138145494697, 8247.134050924686, 4808.687435316693, 4883.755812209411, 4997.100521906055, 5008.424031236382, 5024.19612861944, 3053.1756425765143, 3194.7763656544053, 3206.0542140068737, 3230.9030729078167, 3239.4492936200904, 998.5306905754284, 1021.9080282774512, 1021.9795604087876, 1034.400047972182, 1038.84687996324, 11400.201985860993, 11431.199816012882, 11435.485403156794, 11447.771044579145, 11484.598039068593, 4035.1324465239527, 4105.261053010427, 4178.22702799983, 4183.037901282662, 4204.432401625802, 9532.571034303473, 9545.188658963927, 9584.712458626253, 9670.323077384657, 9704.126628603459, 4755.262934245197, 4763.857084287477, 4764.285357196448, 4784.4497882743235, 4796.784144713496, 3991.501062367204, 4313.654907607384, 4357.716748411406, 4375.956240437618, 4427.933580996288, 3686.4470329450796, 3756.586775454698, 3768.9057773555883, 3794.1273507093524, 3798.867039653599, 1177.2289150606366, 1205.2406983600276, 1205.6081773423673, 1210.3403645013489, 1224.1736827641307, 1287.9742405151844, 1294.9287789171497, 1308.2019967819622, 1308.8691130887025, 1318.3935389720837, 7460.85078298431, 7505.437092218105, 7600.695972161162, 7637.961810191025, 7647.732329368446, 502.2867528110019, 511.7569154651585, 518.2381898609038, 520.9973950130301, 524.910765169922, 5778.3354914184565, 5831.241938547962, 5834.27071616048, 5886.735096920649, 5887.793927212527, 9380.624775009059, 9967.40195588267, 10001.549930253155, 10004.49977501122, 10034.899651003396, 9755.268354873413, 9800.901990979999, 9877.259205559612, 9952.552135153936, 9997.200223982209, 7234.385077268385, 7437.665305061285, 7448.962755186298, 7478.551286922802, 7492.51298665585, 7282.198958114497, 7282.344588987016, 7298.124225093023, 7304.013958115586, 7373.705051797868, 8436.32509399259, 8463.53450560225, 8490.0, 8605.784855378666, 8643.91356086431, 8685.609147588248, 8714.0, 8794.956025219833, 8796.824063518567, 9048.773780655272, 6704.7988560343265, 6840.555363901331, 6890.586564806128, 7266.527675701062, 7419.851602967802, 7359.889601656087, 7377.926220737724, 7378.667959941708, 7379.0, 7385.372243359375, 6631.6684165792485, 6713.0, 6844.349786770249, 6896.137982752156, 6897.862042759217, 6700.530962832555, 6721.395074443323, 6789.422899053636, 6823.522353435212, 6857.348551887562, 6769.120014398097, 6778.288279730557, 6786.76246331376, 6804.319568043354, 7195.604241766544, 6663.067170596218, 6730.663466826737, 6749.932500675127, 6763.256041835296, 6769.526133170631, 6726.7981960541265, 6761.290064543152, 6762.256151823394, 6778.830529236809, 6793.864122717617], "unit": "score", "name": "mootools.html", "value": 4509.0697061665915}, {"lowerIsBetter": false, "replicates": [341.1641478377975, 341.2816022273117, 343.4916323840716, 349.8967804497673, 353.6622525488159, 6223.626582405053, 6253.812385628438, 6276.592021518598, 6295.968520157404, 6337.556371054028, 6198.566100372976, 6206.1931948846695, 6209.410106039931, 6212.844678883019, 6224.906626400608, 4470.798814053359, 4661.324108004337, 4763.595094416962, 4783.521647835223, 4801.231802911535, 4730.337752714623, 4735.573798358147, 4751.239801631739, 4763.095011947719, 4765.809367625291, 4682.227432473638, 4706.435227772672, 4726.26742854858, 4735.0529894021165, 4737.431508219019, 4721.150192965265, 4730.834420795273, 4752.833650822239, 4756.595689366373, 4759.309900064472, 4228.1966426378885, 4236.322188449864, 4238.237117318881, 4248.490181178247, 4250.319948808206, 5721.799737009184, 5915.0, 5990.760369585211, 5992.550558708114, 5997.940020599782, 5472.5621950243885, 5496.1755736639425, 5503.559715222773, 5507.531859791922, 5508.394076651605, 6615.206175258952, 6659.101021362103, 6662.600243985328, 6665.600063996176, 6669.966650166767, 4518.43519560055, 4519.412476378083, 4526.434195725535, 4529.592336689714, 4542.273236282212, 6835.316468353125, 6843.62360070196, 6854.794356169273, 6902.480594582941, 6909.550879192836, 4537.397735744689, 4562.931556026662, 4612.423447069116, 4613.077384523109, 4630.351750754897, 4633.814647414133, 4671.85984420468, 4673.906521869543, 4674.929876051862, 4685.8594242172785, 5420.0, 5422.349318081855, 5429.375621803543, 5430.728463576885, 5453.809116680897, 6612.504062195355, 6658.86682266352, 6666.433353165035, 6679.499037572202, 6682.565633233824, 1605.566497045791, 1632.6734653069434, 1633.338497908349, 1637.8280280570607, 1644.4655486966783, 1044.6343779677052, 1059.390850261103, 1080.9891901081046, 1083.3824719909576, 1090.231386872253, 6329.784575398574, 6330.145430366933, 6358.109864618957, 6359.682015899279, 6361.300256971729, 6772.390484856288, 6818.147731533559, 6825.419839313714, 6825.624590647462, 6826.692798824065, 6125.081237814364, 6195.504359651217, 6205.906911396332, 6207.596506227171, 6282.277538083087, 3665.7433979621705, 3672.889813305605, 3691.8523259069875, 3702.7963462009848, 3712.331780279522, 7294.671739771723, 7300.342969132804, 7302.744403945836, 7333.266673332624, 7349.30181632744, 7009.1589009319205, 7017.508774385846, 7033.261507541737, 7049.189343225492, 7060.7881763547175, 7114.14630244374, 7254.165770936304, 7297.598632075287, 7321.414286857039, 7323.890141647879, 6809.591424514545, 6829.52193346461, 6853.897191542231, 6861.828454288483, 6864.38220560152, 6799.796006119825, 6805.0, 6806.455483561204, 6825.863482730417, 6840.589564626139, 7254.637268136677, 7280.3083707047745, 7309.853802923805, 7330.96334518324, 7349.889751653623, 4468.888277792951, 4558.931616025829, 4655.138799322136, 4667.463241727245, 4673.3457315976475, 6776.661166941534, 6824.658767061528, 6872.553284036521, 6875.3812156906115, 6877.552959057845, 6613.14029176204, 6622.337766223339, 6628.370304821035, 6637.402633762985, 6671.66641667905, 6625.734970601122, 6636.203655561363, 6638.0, 6648.468122550088, 6652.7006284716335, 6370.426661600478, 6489.805305840832, 6500.0, 6516.110328005015, 6521.315261897622, 6600.60396376219, 6610.0, 6616.966915165393, 6639.03733958583, 6655.2346480153465, 6429.22849258092, 6460.644664543495, 6461.127747753993, 6484.870302593828, 6503.414692677682], "unit": "score", "name": "prototype.html", "value": 4981.149709552327}, {"lowerIsBetter": false, "replicates": [743.8214828441172, 758.2190343945731, 767.6545554500473, 782.5070205770364, 795.6817273090763, 13022.283774392405, 13184.274864882416, 13250.602481925534, 13251.801222981663, 13256.33718314084, 12825.743485130291, 12910.93544532276, 12911.870881291185, 12931.0, 12949.41727622257, 822.5517093184214, 833.4582521361103, 854.2952064546743, 856.0797143071193, 858.2061593026457, 833.3291700181352, 835.0897521701345, 838.4633834346023, 840.9915900841005, 841.4320333774708, 887.49856331173, 890.692711014699, 895.011012830819, 895.5566994337812, 896.1486587741672, 872.677109469494, 876.8816209811657, 881.5856547422766, 883.8630012348096, 887.8535041718109, 646.1245013007355, 646.7445359083183, 647.9028145778171, 651.7490766055103, 652.4258652385918, 14212.50256241037, 14240.359183836752, 14291.071080379743, 14317.212553309564, 14525.128492290496, 12627.810582841264, 13036.41336139876, 13090.149140305944, 13184.934075329658, 13409.530666426726, 10408.843867341995, 10465.790684186273, 10505.107065899409, 10646.988536089058, 11095.72260693481, 3544.113971507123, 3570.9644203181047, 3613.8012409317475, 3632.745707800455, 3660.853565857389, 44747.77626111881, 48821.0, 49662.751686241696, 50302.24546631803, 51898.48101518974, 10011.295049583869, 10213.642522511676, 10284.28010039305, 10383.0, 10465.895341046644, 18431.26274948987, 18591.34930277434, 18600.720989185174, 18648.160832762558, 18688.439346819618, 7904.604769761604, 7925.722599708983, 8084.797880052928, 8097.635606397726, 8187.26314631686, 4381.16757816014, 4383.430154079949, 4406.581374769392, 4514.277715565494, 4662.160811054043, 3171.127939816569, 3182.9363412732077, 3210.775245732823, 3212.951805722916, 3222.8388580571345, 590.403692270801, 595.8748662780778, 598.5660396212711, 599.7031469422664, 601.167383174298, 402.8529586700833, 545.8140148704414, 594.8869714754182, 605.9697015149225, 607.1166452811149, 7730.265624765639, 7983.920160798434, 8087.393445491612, 8134.422422263527, 8356.122607126286, 503.189864318447, 537.8467136866053, 550.2159422822542, 631.2805977840777, 647.8283254937445, 3702.740808143404, 3908.5733707197237, 3926.469926559935, 3939.2515422070287, 3993.520777506718, 58920.0, 61151.69424152851, 61303.386966129765, 61354.0, 61533.0, 52440.0, 53373.73313133487, 53483.46516534863, 53780.0, 53828.46171538313, 47838.521614784106, 48254.517454825705, 48996.0, 49053.754731226116, 49440.25839612409, 7650.196729343339, 7777.144514103557, 7790.688372465264, 7913.44605877583, 8101.635426405708, 35394.0, 35929.82035089808, 36265.093372664836, 36384.454233187054, 36736.81631591932, 41552.1689566213, 41642.79178604088, 44853.10293794171, 45123.0975380484, 45738.77130614326, 10115.696529103845, 10207.336523125972, 10236.948815255875, 10335.534900929626, 10352.068313851489, 11291.0, 11407.714807129889, 11514.94242528782, 11770.058395328182, 11857.525698971944, 10140.54367553447, 10179.694609161737, 10259.640912568024, 10338.534765935401, 10525.9473702631, 10627.628033018807, 10663.520141593492, 10921.034213841585, 10951.0, 11141.777164456504, 10092.192624589869, 10258.692239232834, 10276.845847312146, 10518.158547316043, 10518.474076296308, 7844.2155784423385, 8086.838263234585, 8090.595470226347, 8320.583970801557, 8602.354823388396, 8145.755627331189, 8308.335333173452, 8560.101189375026, 8661.566921654017, 8676.219140277406], "unit": "score", "name": "yui.html", "value": 6233.896490491561}], "name": "dromaeo_css", "value": 6941.597348263951}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 111.0, 111.0, 112.0, 122.0, 111.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [149.0, 135.0, 160.0, 171.0, 131.0, 153.0, 160.0, 127.0, 176.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 163.0, 161.0, 163.0, 161.0, 162.0, 167.0, 167.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 83.0, 75.0, 72.0, 73.0, 75.0, 76.0, 136.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 145.0, 95.0, 94.0, 93.0, 152.0, 94.0, 94.0, 153.0], "unit": "score", "name": "audio-oscillator", "value": 110.8}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 58.0, 57.0, 64.0, 58.0, 58.0, 61.0, 58.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 71.0, 69.0, 69.0, 68.0, 67.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 81.0, 82.0, 83.0, 83.0, 83.0, 81.0, 82.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [120.0, 114.0, 114.0, 125.0, 120.0, 116.0, 117.0, 116.0, 124.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.1}, {"lowerIsBetter": true, "replicates": [152.0, 154.0, 160.0, 150.0, 150.0, 137.0, 152.0, 145.0, 151.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.0}, {"lowerIsBetter": true, "replicates": [77.0, 68.0, 67.0, 68.0, 67.0, 68.0, 70.0, 72.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1523.0999999999997}]} 09:53:30 INFO - Return code: 0 09:53:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:53:31 ERROR - # TBPL SUCCESS # 09:53:31 INFO - Running post-action listener: _resource_record_post_action 09:53:31 INFO - Running post-run listener: _resource_record_post_run 09:53:32 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 20480; Write bytes: 536838144; Read time: 224; Write time: 454632 09:53:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240574464; Read time: 0; Write time: 249816 09:53:32 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 20480; Write bytes: 295665664; Read time: 224; Write time: 204812 09:53:32 INFO - Running post-run listener: _upload_blobber_files 09:53:32 INFO - Blob upload gear active. 09:53:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:53:32 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:53:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 09:53:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 09:53:32 INFO - (blobuploader) - INFO - Open directory for files ... 09:53:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:53:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:53:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:33 INFO - (blobuploader) - INFO - Done attempting. 09:53:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:53:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:53:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:34 INFO - (blobuploader) - INFO - Done attempting. 09:53:34 INFO - (blobuploader) - INFO - Iteration through files over. 09:53:34 INFO - Return code: 0 09:53:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:53:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:53:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ecb12b61586ecfdbeb694ef4a3746cfab8d2380c565c29a51910b41b9308427afbabfe2a38ada1660f7cf8e078c559c654000efe28a5278161cdd1b36bd59a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/818e156f897cf8326057b6cad947fd72c7f046ad1d9657fe435ebda24d1669e2fd43ec37b459159545e4ab425088192932170e163489327fd02a599a44d4845a"} 09:53:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:53:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:53:34 INFO - Contents: 09:53:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ecb12b61586ecfdbeb694ef4a3746cfab8d2380c565c29a51910b41b9308427afbabfe2a38ada1660f7cf8e078c559c654000efe28a5278161cdd1b36bd59a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/818e156f897cf8326057b6cad947fd72c7f046ad1d9657fe435ebda24d1669e2fd43ec37b459159545e4ab425088192932170e163489327fd02a599a44d4845a"} 09:53:34 INFO - Running post-run listener: copy_logs_to_upload_dir 09:53:34 INFO - Copying logs to upload dir... 09:53:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:53:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.560319 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-03-07 09:53:33.607593) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 09:53:33.616553) ========= 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=32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ecb12b61586ecfdbeb694ef4a3746cfab8d2380c565c29a51910b41b9308427afbabfe2a38ada1660f7cf8e078c559c654000efe28a5278161cdd1b36bd59a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/818e156f897cf8326057b6cad947fd72c7f046ad1d9657fe435ebda24d1669e2fd43ec37b459159545e4ab425088192932170e163489327fd02a599a44d4845a"} build_url:https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011453 build_url: 'https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ecb12b61586ecfdbeb694ef4a3746cfab8d2380c565c29a51910b41b9308427afbabfe2a38ada1660f7cf8e078c559c654000efe28a5278161cdd1b36bd59a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/818e156f897cf8326057b6cad947fd72c7f046ad1d9657fe435ebda24d1669e2fd43ec37b459159545e4ab425088192932170e163489327fd02a599a44d4845a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 09:53:33.641644) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:53:33.642010) ========= 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=32c5991c409366f7fec8a718000001d2-1457371984.765088-2059228613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:53:33.691696) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 09:53:33.695061) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 09:53:33.695415) ========= ========= Total master_lag: 0.24 =========