builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1457698144.42 results: success (0) buildid: 20160311013218 builduid: 2aca9fa7fbf24d6794fec7b4f939db58 revision: 89cfc24de850 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:04.420325) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:04.420833) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:04.421154) ========= 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=337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006336 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:04.442550) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:04.442863) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:04.469289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:04.469595) ========= 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=337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.026015 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:04.519356) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:04.519697) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:04.520101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:04.520439) ========= 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=337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 04:09:04-- 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% 94.1M=0s 2016-03-11 04:09:04 (94.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088041 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:04.624218) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:04.624543) ========= 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=337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.113802 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:04.750589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:04.750981) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 89cfc24de850 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 89cfc24de850 --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=337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 04:09:04,890 Setting DEBUG logging. 2016-03-11 04:09:04,890 attempt 1/10 2016-03-11 04:09:04,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/89cfc24de850?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 04:09:05,137 unpacking tar archive at: mozilla-inbound-89cfc24de850/testing/mozharness/ program finished with exit code 0 elapsedTime=0.523893 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:05.288437) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:05.288815) ========= echo 89cfc24de850 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'89cfc24de850'] 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=337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 89cfc24de850 program finished with exit code 0 elapsedTime=0.003339 script_repo_revision: '89cfc24de850' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:05.337115) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:05.337488) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 04:09:05.347912) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-11 04:09:05.348271) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:09:05 INFO - MultiFileLogger online at 20160311 04:09:05 in /builds/slave/test-pgo 04:09:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:09:05 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:09:05 INFO - {'append_to_log': False, 04:09:05 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:09:05 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:09:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:09:05 INFO - 'branch': 'Mozilla-Inbound', 04:09:05 INFO - 'buildbot_json_path': 'buildprops.json', 04:09:05 INFO - 'config_files': ('talos/linux_config.py',), 04:09:05 INFO - 'default_actions': ('clobber', 04:09:05 INFO - 'read-buildbot-config', 04:09:05 INFO - 'download-and-extract', 04:09:05 INFO - 'populate-webroot', 04:09:05 INFO - 'create-virtualenv', 04:09:05 INFO - 'install', 04:09:05 INFO - 'run-tests'), 04:09:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:09:05 INFO - 'download_minidump_stackwalk': True, 04:09:05 INFO - 'download_symbols': 'ondemand', 04:09:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:09:05 INFO - 'tooltool.py': '/tools/tooltool.py', 04:09:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:09:05 INFO - '/tools/misc-python/virtualenv.py')}, 04:09:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:09:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:09:05 INFO - 'installer_path': 'installer.exe', 04:09:05 INFO - 'log_level': 'info', 04:09:05 INFO - 'log_name': 'talos', 04:09:05 INFO - 'log_to_console': True, 04:09:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:09:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:09:05 INFO - 'opt_config_files': (), 04:09:05 INFO - 'pip_index': False, 04:09:05 INFO - 'sps_profile': False, 04:09:05 INFO - 'sps_profile_interval': 0, 04:09:05 INFO - 'suite': 'dromaeojs-e10s', 04:09:05 INFO - 'system_bits': '32', 04:09:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:09:05 INFO - 'title': 'talos-linux64-ix-060', 04:09:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:09:05 INFO - 'use_talos_json': True, 04:09:05 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:09:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:09:05 INFO - 'work_dir': 'build'} 04:09:05 INFO - ##### 04:09:05 INFO - ##### Running clobber step. 04:09:05 INFO - ##### 04:09:05 INFO - Running pre-action listener: _resource_record_pre_action 04:09:05 INFO - Running main action method: clobber 04:09:05 INFO - rmtree: /builds/slave/test-pgo/build 04:09:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:09:09 INFO - Running post-action listener: _resource_record_post_action 04:09:09 INFO - ##### 04:09:09 INFO - ##### Running read-buildbot-config step. 04:09:09 INFO - ##### 04:09:09 INFO - Running pre-action listener: _resource_record_pre_action 04:09:09 INFO - Running main action method: read_buildbot_config 04:09:09 INFO - Using buildbot properties: 04:09:09 INFO - { 04:09:09 INFO - "project": "", 04:09:09 INFO - "product": "firefox", 04:09:09 INFO - "script_repo_revision": "production", 04:09:09 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:09:09 INFO - "repository": "", 04:09:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:09:09 INFO - "buildid": "20160311013218", 04:09:09 INFO - "pgo_build": "True", 04:09:09 INFO - "basedir": "/builds/slave/test-pgo", 04:09:09 INFO - "buildnumber": 394, 04:09:09 INFO - "slavename": "talos-linux64-ix-060", 04:09:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:09:09 INFO - "platform": "ubuntu64_hw", 04:09:09 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:09:09 INFO - "branch": "mozilla-inbound", 04:09:09 INFO - "repo_path": "integration/mozilla-inbound", 04:09:09 INFO - "revision": "89cfc24de850", 04:09:09 INFO - "stage_platform": "linux64-pgo", 04:09:09 INFO - "builduid": "2aca9fa7fbf24d6794fec7b4f939db58", 04:09:09 INFO - "slavebuilddir": "test" 04:09:09 INFO - } 04:09:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:09:09 INFO - Running post-action listener: _resource_record_post_action 04:09:09 INFO - ##### 04:09:09 INFO - ##### Running download-and-extract step. 04:09:09 INFO - ##### 04:09:09 INFO - Running pre-action listener: _resource_record_pre_action 04:09:09 INFO - Running main action method: download_and_extract 04:09:09 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:09:09 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')]} 04:09:09 INFO - https://queue.taskcluster.net/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:09:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:09:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:09:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/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 04:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/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 04:09:10 INFO - Downloaded 1361 bytes. 04:09:10 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:09:10 INFO - Using the following test package requirements: 04:09:10 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:10 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:09:10 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:09:10 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:10 INFO - u'jsshell-linux-x86_64.zip'], 04:09:10 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:09:10 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:10 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:09:10 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:09:10 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:09:10 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:09:10 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:09: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')]} 04:09:10 INFO - https://queue.taskcluster.net/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:09:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:09:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:09:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/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 04:09:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/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 04:09:13 INFO - Downloaded 23403626 bytes. 04:09:13 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'] 04:09:13 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 04:09:15 INFO - Return code: 0 04:09:15 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 04:09: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')]} 04:09:15 INFO - https://queue.taskcluster.net/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:09:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:09:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:09:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/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 04:09:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/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 04:09:17 INFO - Downloaded 23403626 bytes. 04:09:17 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'] 04:09:17 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 04:09:19 INFO - Return code: 0 04:09: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')]} 04:09:19 INFO - https://queue.taskcluster.net/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:09:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/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 04:09:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/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 04:09:20 INFO - Downloaded 10845263 bytes. 04:09:20 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'] 04:09:20 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 04:09:20 INFO - Return code: 0 04:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:20 INFO - https://queue.taskcluster.net/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/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 04:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaZHrwGPQim5gDZWxurXgg/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 04:09:21 INFO - Downloaded 56239767 bytes. 04:09:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:09:21 INFO - mkdir: /builds/slave/test-pgo/properties 04:09:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:09:21 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:09:21 INFO - Contents: 04:09:21 INFO - build_url:https://queue.taskcluster.net/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:09:22 INFO - Running post-action listener: _resource_record_post_action 04:09:22 INFO - Running post-action listener: set_extra_try_arguments 04:09:22 INFO - ##### 04:09:22 INFO - ##### Running populate-webroot step. 04:09:22 INFO - ##### 04:09:22 INFO - Running pre-action listener: _resource_record_pre_action 04:09:22 INFO - Running main action method: populate_webroot 04:09:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:09:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:09:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:09:22 INFO - '--tppagecycles', 04:09:22 INFO - '7'], 04:09:22 INFO - 'tests': ['tsvgm']}}, 04:09:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:09:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:09:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:09:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:09:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:09:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:09:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:22 INFO - 'talos_options': ['--e10s'], 04:09:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:22 INFO - 'tests': ['damp', 'tps']}, 04:09:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:22 INFO - 'talos_options': ['--e10s'], 04:09:22 INFO - 'tests': ['damp', 'tps']}, 04:09:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:09:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:09:22 INFO - 'other': {'tests': ['a11yr', 04:09:22 INFO - 'ts_paint', 04:09:22 INFO - 'tpaint', 04:09:22 INFO - 'sessionrestore', 04:09:22 INFO - 'sessionrestore_no_auto_restore', 04:09:22 INFO - 'tabpaint']}, 04:09:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:09:22 INFO - 'tests': ['a11yr', 04:09:22 INFO - 'ts_paint', 04:09:22 INFO - 'tpaint', 04:09:22 INFO - 'sessionrestore', 04:09:22 INFO - 'sessionrestore_no_auto_restore', 04:09:22 INFO - 'tabpaint']}, 04:09:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:09:22 INFO - 'tests': ['a11yr', 04:09:22 INFO - 'ts_paint', 04:09:22 INFO - 'tpaint', 04:09:22 INFO - 'sessionrestore', 04:09:22 INFO - 'sessionrestore_no_auto_restore', 04:09:22 INFO - 'tabpaint']}, 04:09:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:09:22 INFO - 'tests': ['a11yr', 04:09:22 INFO - 'ts_paint', 04:09:22 INFO - 'tpaint', 04:09:22 INFO - 'sessionrestore', 04:09:22 INFO - 'sessionrestore_no_auto_restore', 04:09:22 INFO - 'tabpaint']}, 04:09:22 INFO - 'other_l64': {'tests': ['a11yr', 04:09:22 INFO - 'ts_paint', 04:09:22 INFO - 'tpaint', 04:09:22 INFO - 'sessionrestore', 04:09:22 INFO - 'sessionrestore_no_auto_restore', 04:09:22 INFO - 'tabpaint']}, 04:09:22 INFO - 'other_nol64': {'tests': ['a11yr', 04:09:22 INFO - 'ts_paint', 04:09:22 INFO - 'tpaint', 04:09:22 INFO - 'sessionrestore', 04:09:22 INFO - 'sessionrestore_no_auto_restore', 04:09:22 INFO - 'tabpaint']}, 04:09:22 INFO - 'svgr': {'tests': ['tsvgx', 04:09:22 INFO - 'tsvgr_opacity', 04:09:22 INFO - 'tart', 04:09:22 INFO - 'tscrollx', 04:09:22 INFO - 'cart']}, 04:09:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:09:22 INFO - 'tests': ['tsvgx', 04:09:22 INFO - 'tsvgr_opacity', 04:09:22 INFO - 'tart', 04:09:22 INFO - 'tscrollx', 04:09:22 INFO - 'cart']}, 04:09:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:22 INFO - 'tests': ['tp5o']}, 04:09:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:22 INFO - 'talos_options': ['--e10s'], 04:09:22 INFO - 'tests': ['tp5o']}, 04:09:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:22 INFO - 'talos_options': ['--xperf_path', 04:09:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:22 INFO - 'tests': ['tp5n']}, 04:09:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:22 INFO - 'talos_options': ['--e10s', 04:09:22 INFO - '--xperf_path', 04:09:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:22 INFO - 'tests': ['tp5n']}}, 04:09:22 INFO - 'talos.zip': {'path': '', 04:09:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:09:22 INFO - Running post-action listener: _resource_record_post_action 04:09:22 INFO - ##### 04:09:22 INFO - ##### Running create-virtualenv step. 04:09:22 INFO - ##### 04:09:22 INFO - Running pre-action listener: _resource_record_pre_action 04:09:22 INFO - Running main action method: create_virtualenv 04:09:22 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:09:22 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 04:09:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:09:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:09:23 INFO - Using real prefix '/usr' 04:09:23 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:09:23 INFO - Installing distribute.............................................................................................................................................................................................done. 04:09:26 INFO - Installing pip.................done. 04:09:26 INFO - Return code: 0 04:09:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:26 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 0x7fd4b8fb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176920>, '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 0x1177820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177cb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', '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 04:09:26 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 04:09:26 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 04:09:26 INFO - Using env: {'DISPLAY': ':0', 04:09:26 INFO - 'HOME': '/home/cltbld', 04:09:26 INFO - 'LANG': 'en_US.UTF-8', 04:09:26 INFO - 'LANGUAGE': 'en_US:en', 04:09:26 INFO - 'LOGNAME': 'cltbld', 04:09:26 INFO - 'MAIL': '/var/mail/cltbld', 04:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:26 INFO - 'MOZ_NO_REMOTE': '1', 04:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:26 INFO - 'NO_EM_RESTART': '1', 04:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:26 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:26 INFO - 'SHELL': '/bin/bash', 04:09:26 INFO - 'SHLVL': '1', 04:09:26 INFO - 'TERM': 'linux', 04:09:26 INFO - 'TMOUT': '86400', 04:09:26 INFO - 'USER': 'cltbld', 04:09:26 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', 04:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:26 INFO - '_': '/tools/buildbot/bin/python'} 04:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:26 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 04:09:26 INFO - Cleaning up... 04:09:26 INFO - Return code: 0 04:09:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:26 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 0x7fd4b8fb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176920>, '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 0x1177820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177cb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', '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 04:09:26 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 04:09:26 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 04:09:26 INFO - Using env: {'DISPLAY': ':0', 04:09:26 INFO - 'HOME': '/home/cltbld', 04:09:26 INFO - 'LANG': 'en_US.UTF-8', 04:09:26 INFO - 'LANGUAGE': 'en_US:en', 04:09:26 INFO - 'LOGNAME': 'cltbld', 04:09:26 INFO - 'MAIL': '/var/mail/cltbld', 04:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:26 INFO - 'MOZ_NO_REMOTE': '1', 04:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:26 INFO - 'NO_EM_RESTART': '1', 04:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:26 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:26 INFO - 'SHELL': '/bin/bash', 04:09:26 INFO - 'SHLVL': '1', 04:09:26 INFO - 'TERM': 'linux', 04:09:26 INFO - 'TMOUT': '86400', 04:09:26 INFO - 'USER': 'cltbld', 04:09:26 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', 04:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:26 INFO - '_': '/tools/buildbot/bin/python'} 04:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:26 INFO - Downloading/unpacking psutil>=0.7.1 04:09:26 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 04:09:26 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 04:09:26 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 04:09:26 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 04:09:26 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 04:09:26 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 04:09:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:09:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:28 INFO - Installing collected packages: psutil 04:09:28 INFO - Running setup.py install for psutil 04:09:28 INFO - building 'psutil._psutil_linux' extension 04:09:28 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 04:09:28 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 04:09:28 INFO - building 'psutil._psutil_posix' extension 04:09:28 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 04:09:28 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 04:09:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:29 INFO - Successfully installed psutil 04:09:29 INFO - Cleaning up... 04:09:29 INFO - Return code: 0 04:09:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd4b8fb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176920>, '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 0x1177820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177cb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', '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 04:09:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:09:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:09:29 INFO - Using env: {'DISPLAY': ':0', 04:09:29 INFO - 'HOME': '/home/cltbld', 04:09:29 INFO - 'LANG': 'en_US.UTF-8', 04:09:29 INFO - 'LANGUAGE': 'en_US:en', 04:09:29 INFO - 'LOGNAME': 'cltbld', 04:09:29 INFO - 'MAIL': '/var/mail/cltbld', 04:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:29 INFO - 'MOZ_NO_REMOTE': '1', 04:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:29 INFO - 'NO_EM_RESTART': '1', 04:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:29 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:29 INFO - 'SHELL': '/bin/bash', 04:09:29 INFO - 'SHLVL': '1', 04:09:29 INFO - 'TERM': 'linux', 04:09:29 INFO - 'TMOUT': '86400', 04:09:29 INFO - 'USER': 'cltbld', 04:09:29 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', 04:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:29 INFO - '_': '/tools/buildbot/bin/python'} 04:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:09:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:09:31 INFO - Installing collected packages: mozsystemmonitor 04:09:31 INFO - Running setup.py install for mozsystemmonitor 04:09:31 INFO - Successfully installed mozsystemmonitor 04:09:31 INFO - Cleaning up... 04:09:31 INFO - Return code: 0 04:09:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:09: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')]} 04:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:31 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 0x7fd4b8fb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176920>, '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 0x1177820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177cb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', '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 04:09:31 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 04:09:31 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 04:09:31 INFO - Using env: {'DISPLAY': ':0', 04:09:31 INFO - 'HOME': '/home/cltbld', 04:09:31 INFO - 'LANG': 'en_US.UTF-8', 04:09:31 INFO - 'LANGUAGE': 'en_US:en', 04:09:31 INFO - 'LOGNAME': 'cltbld', 04:09:31 INFO - 'MAIL': '/var/mail/cltbld', 04:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:31 INFO - 'MOZ_NO_REMOTE': '1', 04:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:31 INFO - 'NO_EM_RESTART': '1', 04:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:31 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:31 INFO - 'SHELL': '/bin/bash', 04:09:31 INFO - 'SHLVL': '1', 04:09:31 INFO - 'TERM': 'linux', 04:09:31 INFO - 'TMOUT': '86400', 04:09:31 INFO - 'USER': 'cltbld', 04:09:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', 04:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:31 INFO - '_': '/tools/buildbot/bin/python'} 04:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:32 INFO - Downloading/unpacking blobuploader==1.2.4 04:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:34 INFO - Downloading blobuploader-1.2.4.tar.gz 04:09:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:09:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:09:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:34 INFO - Downloading docopt-0.6.1.tar.gz 04:09:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:09:34 INFO - Installing collected packages: blobuploader, requests, docopt 04:09:34 INFO - Running setup.py install for blobuploader 04:09:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:09:34 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:09:34 INFO - Running setup.py install for requests 04:09:35 INFO - Running setup.py install for docopt 04:09:35 INFO - Successfully installed blobuploader requests docopt 04:09:35 INFO - Cleaning up... 04:09:35 INFO - Return code: 0 04:09:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:09: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')]} 04:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:35 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 0x7fd4b8fb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176920>, '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 0x1177820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177cb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', '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 04:09:35 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 04:09:35 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 04:09:35 INFO - Using env: {'DISPLAY': ':0', 04:09:35 INFO - 'HOME': '/home/cltbld', 04:09:35 INFO - 'LANG': 'en_US.UTF-8', 04:09:35 INFO - 'LANGUAGE': 'en_US:en', 04:09:35 INFO - 'LOGNAME': 'cltbld', 04:09:35 INFO - 'MAIL': '/var/mail/cltbld', 04:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:35 INFO - 'MOZ_NO_REMOTE': '1', 04:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:35 INFO - 'NO_EM_RESTART': '1', 04:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:35 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:35 INFO - 'SHELL': '/bin/bash', 04:09:35 INFO - 'SHLVL': '1', 04:09:35 INFO - 'TERM': 'linux', 04:09:35 INFO - 'TMOUT': '86400', 04:09:35 INFO - 'USER': 'cltbld', 04:09:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', 04:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:35 INFO - '_': '/tools/buildbot/bin/python'} 04:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:09:35 INFO - Running setup.py (path:/tmp/pip-k6ykSx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:09:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:09:35 INFO - Running setup.py (path:/tmp/pip-oi0PHp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:09:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:09:35 INFO - Running setup.py (path:/tmp/pip-tklmI7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:09:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:09:35 INFO - Running setup.py (path:/tmp/pip-_ColLx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:09:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:09:35 INFO - Running setup.py (path:/tmp/pip-GXuSbq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:09:36 INFO - Running setup.py (path:/tmp/pip-dR7pef-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:09:36 INFO - Running setup.py (path:/tmp/pip-X5Nk0O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:09:36 INFO - Running setup.py (path:/tmp/pip-3G_PRf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:09:36 INFO - Running setup.py (path:/tmp/pip-4nvTi0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:09:36 INFO - Running setup.py (path:/tmp/pip-tLJZhR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:09:36 INFO - Running setup.py (path:/tmp/pip-BvkdSz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:09:36 INFO - Running setup.py (path:/tmp/pip-g_2uXX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:09:36 INFO - Running setup.py (path:/tmp/pip-goqyuW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:09:36 INFO - Running setup.py (path:/tmp/pip-qkiq7m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:09:36 INFO - Running setup.py (path:/tmp/pip-ocPhIf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:09:36 INFO - Running setup.py (path:/tmp/pip-2DvGQB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:09:36 INFO - Running setup.py (path:/tmp/pip-bfoQZ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:09:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:09:36 INFO - Running setup.py install for manifestparser 04:09:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:09:37 INFO - Running setup.py install for mozcrash 04:09:37 INFO - Running setup.py install for mozdebug 04:09:37 INFO - Running setup.py install for mozdevice 04:09:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:09:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:09:37 INFO - Running setup.py install for mozfile 04:09:37 INFO - Running setup.py install for mozhttpd 04:09:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:09:37 INFO - Running setup.py install for mozinfo 04:09:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:09:37 INFO - Running setup.py install for mozInstall 04:09:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:09:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:09:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:09:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:09:37 INFO - Running setup.py install for mozleak 04:09:37 INFO - Running setup.py install for mozlog 04:09:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:09:37 INFO - Running setup.py install for moznetwork 04:09:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:09:38 INFO - Running setup.py install for mozprocess 04:09:38 INFO - Running setup.py install for mozprofile 04:09:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:09:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:09:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:09:38 INFO - Running setup.py install for mozrunner 04:09:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:09:38 INFO - Running setup.py install for mozscreenshot 04:09:38 INFO - Running setup.py install for moztest 04:09:38 INFO - Running setup.py install for mozversion 04:09:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:09:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:09:38 INFO - Cleaning up... 04:09:38 INFO - Return code: 0 04:09:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:09: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')]} 04:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:38 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 0x7fd4b8fb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176920>, '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 0x1177820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177cb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', '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 04:09:38 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 04:09:38 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 04:09:38 INFO - Using env: {'DISPLAY': ':0', 04:09:38 INFO - 'HOME': '/home/cltbld', 04:09:38 INFO - 'LANG': 'en_US.UTF-8', 04:09:38 INFO - 'LANGUAGE': 'en_US:en', 04:09:38 INFO - 'LOGNAME': 'cltbld', 04:09:38 INFO - 'MAIL': '/var/mail/cltbld', 04:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:38 INFO - 'MOZ_NO_REMOTE': '1', 04:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:38 INFO - 'NO_EM_RESTART': '1', 04:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:38 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:38 INFO - 'SHELL': '/bin/bash', 04:09:38 INFO - 'SHLVL': '1', 04:09:38 INFO - 'TERM': 'linux', 04:09:38 INFO - 'TMOUT': '86400', 04:09:38 INFO - 'USER': 'cltbld', 04:09:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', 04:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:38 INFO - '_': '/tools/buildbot/bin/python'} 04:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:09:38 INFO - Running setup.py (path:/tmp/pip-AZEXfD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:09:38 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)) 04:09:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:09:38 INFO - Running setup.py (path:/tmp/pip-7uWAvp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:09:39 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)) 04:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:09:39 INFO - Running setup.py (path:/tmp/pip-h10tW1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:09:39 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)) 04:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:09:39 INFO - Running setup.py (path:/tmp/pip-oqTnbJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:09:39 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)) 04:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:09:39 INFO - Running setup.py (path:/tmp/pip-zxx3_h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:09:39 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)) 04:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:09:39 INFO - Running setup.py (path:/tmp/pip-i1SC4P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:09:39 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)) 04:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:09:39 INFO - Running setup.py (path:/tmp/pip-U8lRs7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:09:39 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)) 04:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:09:39 INFO - Running setup.py (path:/tmp/pip-iSvMZ0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:09:39 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)) 04:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:09:39 INFO - Running setup.py (path:/tmp/pip-uVX90c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:09:39 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)) 04:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:09:39 INFO - Running setup.py (path:/tmp/pip-lDPdL6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:09:39 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)) 04:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:09:39 INFO - Running setup.py (path:/tmp/pip-Wswglx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:09:39 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)) 04:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:09:39 INFO - Running setup.py (path:/tmp/pip-WdN216-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:09:39 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)) 04:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:09:39 INFO - Running setup.py (path:/tmp/pip-6P5QM9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:09:39 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)) 04:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:09:39 INFO - Running setup.py (path:/tmp/pip-hasjJD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:09:39 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)) 04:09:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:09:39 INFO - Running setup.py (path:/tmp/pip-jF23ZC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:09:40 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)) 04:09:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:09:40 INFO - Running setup.py (path:/tmp/pip-vag5UW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:09:40 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)) 04:09:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:09:40 INFO - Running setup.py (path:/tmp/pip-Vb6x6S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:09:40 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)) 04:09:40 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)) 04:09:40 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)) 04:09:40 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)) 04:09:40 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)) 04:09:40 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)) 04:09:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09:41 INFO - Downloading blessings-1.6.tar.gz 04:09:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:09:42 INFO - Installing collected packages: blessings 04:09:42 INFO - Running setup.py install for blessings 04:09:42 INFO - Successfully installed blessings 04:09:42 INFO - Cleaning up... 04:09:42 INFO - Return code: 0 04:09:42 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:09:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:09:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:09:42 INFO - Reading from file tmpfile_stdout 04:09:42 INFO - Current package versions: 04:09:42 INFO - argparse == 1.2.1 04:09:42 INFO - blessings == 1.6 04:09:42 INFO - blobuploader == 1.2.4 04:09:42 INFO - docopt == 0.6.1 04:09:42 INFO - manifestparser == 1.1 04:09:42 INFO - mozInstall == 1.12 04:09:42 INFO - mozcrash == 0.17 04:09:42 INFO - mozdebug == 0.1 04:09:42 INFO - mozdevice == 0.48 04:09:42 INFO - mozfile == 1.2 04:09:42 INFO - mozhttpd == 0.7 04:09:42 INFO - mozinfo == 0.9 04:09:42 INFO - mozleak == 0.1 04:09:42 INFO - mozlog == 3.1 04:09:42 INFO - moznetwork == 0.27 04:09:42 INFO - mozprocess == 0.22 04:09:42 INFO - mozprofile == 0.28 04:09:42 INFO - mozrunner == 6.11 04:09:42 INFO - mozscreenshot == 0.1 04:09:42 INFO - mozsystemmonitor == 0.0 04:09:42 INFO - moztest == 0.7 04:09:42 INFO - mozversion == 1.4 04:09:42 INFO - psutil == 3.1.1 04:09:42 INFO - requests == 1.2.3 04:09:42 INFO - wsgiref == 0.1.2 04:09:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:42 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 0x7fd4b8fb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176920>, '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 0x1177820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177cb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', '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 04:09:42 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 04:09:42 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 04:09:42 INFO - Using env: {'DISPLAY': ':0', 04:09:42 INFO - 'HOME': '/home/cltbld', 04:09:42 INFO - 'LANG': 'en_US.UTF-8', 04:09:42 INFO - 'LANGUAGE': 'en_US:en', 04:09:42 INFO - 'LOGNAME': 'cltbld', 04:09:42 INFO - 'MAIL': '/var/mail/cltbld', 04:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:42 INFO - 'MOZ_NO_REMOTE': '1', 04:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:42 INFO - 'NO_EM_RESTART': '1', 04:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:42 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:42 INFO - 'SHELL': '/bin/bash', 04:09:42 INFO - 'SHLVL': '1', 04:09:42 INFO - 'TERM': 'linux', 04:09:42 INFO - 'TMOUT': '86400', 04:09:42 INFO - 'USER': 'cltbld', 04:09:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', 04:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:42 INFO - '_': '/tools/buildbot/bin/python'} 04:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:42 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)) 04:09:42 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)) 04:09:42 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)) 04:09:42 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)) 04:09:42 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)) 04:09:42 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)) 04:09:42 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)) 04:09:42 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)) 04:09:42 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)) 04:09:42 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)) 04:09:42 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)) 04:09:42 INFO - Cleaning up... 04:09:42 INFO - Return code: 0 04:09:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:42 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 0x7fd4b8fb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176920>, '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 0x1177820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177cb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', '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 04:09:42 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 04:09:42 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 04:09:42 INFO - Using env: {'DISPLAY': ':0', 04:09:42 INFO - 'HOME': '/home/cltbld', 04:09:42 INFO - 'LANG': 'en_US.UTF-8', 04:09:42 INFO - 'LANGUAGE': 'en_US:en', 04:09:42 INFO - 'LOGNAME': 'cltbld', 04:09:42 INFO - 'MAIL': '/var/mail/cltbld', 04:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:42 INFO - 'MOZ_NO_REMOTE': '1', 04:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:42 INFO - 'NO_EM_RESTART': '1', 04:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:42 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:42 INFO - 'SHELL': '/bin/bash', 04:09:42 INFO - 'SHLVL': '1', 04:09:42 INFO - 'TERM': 'linux', 04:09:42 INFO - 'TMOUT': '86400', 04:09:42 INFO - 'USER': 'cltbld', 04:09:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', 04:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:42 INFO - '_': '/tools/buildbot/bin/python'} 04:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:42 INFO - Downloading/unpacking jsonschema 04:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:44 INFO - Downloading/unpacking functools32 (from jsonschema) 04:09:44 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 04:09:44 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 04:09:44 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 04:09:44 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 04:09:44 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 04:09:44 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 04:09:44 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:44 INFO - warning: no files found matching '*.txt' 04:09:44 INFO - no previously-included directories found matching 'build' 04:09:44 INFO - no previously-included directories found matching 'dist' 04:09:44 INFO - no previously-included directories found matching '.git*' 04:09:44 INFO - Installing collected packages: jsonschema, functools32 04:09:45 INFO - Running setup.py install for functools32 04:09:45 INFO - warning: no files found matching '*.txt' 04:09:45 INFO - no previously-included directories found matching 'build' 04:09:45 INFO - no previously-included directories found matching 'dist' 04:09:45 INFO - no previously-included directories found matching '.git*' 04:09:45 INFO - Successfully installed jsonschema functools32 04:09:45 INFO - Cleaning up... 04:09:45 INFO - Return code: 0 04:09:45 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4b8fb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e76d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1176920>, '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 0x1177820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177cb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', '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 04:09:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 04:09:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:09:45 INFO - Using env: {'DISPLAY': ':0', 04:09:45 INFO - 'HOME': '/home/cltbld', 04:09:45 INFO - 'LANG': 'en_US.UTF-8', 04:09:45 INFO - 'LANGUAGE': 'en_US:en', 04:09:45 INFO - 'LOGNAME': 'cltbld', 04:09:45 INFO - 'MAIL': '/var/mail/cltbld', 04:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:45 INFO - 'MOZ_NO_REMOTE': '1', 04:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:45 INFO - 'NO_EM_RESTART': '1', 04:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:45 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:45 INFO - 'SHELL': '/bin/bash', 04:09:45 INFO - 'SHLVL': '1', 04:09:45 INFO - 'TERM': 'linux', 04:09:45 INFO - 'TMOUT': '86400', 04:09:45 INFO - 'USER': 'cltbld', 04:09:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', 04:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:45 INFO - '_': '/tools/buildbot/bin/python'} 04:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:45 INFO - Downloading/unpacking flake8 04:09:45 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 04:09:45 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 04:09:45 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 04:09:45 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 04:09:45 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 04:09:45 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 04:09:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:09:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:09:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:09:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:47 INFO - no previously-included directories found matching 'docs/_build' 04:09:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:09:47 INFO - Running setup.py install for pep8 04:09:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:48 INFO - no previously-included directories found matching 'docs/_build' 04:09:48 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:09:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:09:48 INFO - Cleaning up... 04:09:48 INFO - Return code: 0 04:09:48 INFO - Running post-action listener: _resource_record_post_action 04:09:48 INFO - Running post-action listener: _start_resource_monitoring 04:09:48 INFO - Starting resource monitoring. 04:09:48 INFO - ##### 04:09:48 INFO - ##### Running install step. 04:09:48 INFO - ##### 04:09:48 INFO - Running pre-action listener: _resource_record_pre_action 04:09:48 INFO - Running main action method: install 04:09:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:09:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:09:48 INFO - Reading from file tmpfile_stdout 04:09:48 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:09:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:09:48 INFO - Reading from file tmpfile_stdout 04:09:48 INFO - Output received: 04:09:48 INFO - Usage: mozinstall [options] installer 04:09:48 INFO - Options: 04:09:48 INFO - -h, --help show this help message and exit 04:09:48 INFO - -d DEST, --destination=DEST 04:09:48 INFO - Directory to install application into. [default: 04:09:48 INFO - "/builds/slave/test-pgo"] 04:09:48 INFO - --app=APP Application being installed. [default: firefox] 04:09:48 INFO - mkdir: /builds/slave/test-pgo/build/application 04:09:48 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'] 04:09:48 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 04:10:04 INFO - Reading from file tmpfile_stdout 04:10:04 INFO - Output received: 04:10:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:10:04 INFO - Running post-action listener: _resource_record_post_action 04:10:04 INFO - ##### 04:10:04 INFO - ##### Running run-tests step. 04:10:04 INFO - ##### 04:10:04 INFO - Running pre-action listener: _resource_record_pre_action 04:10:04 INFO - Running main action method: run_tests 04:10:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:10:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:10:04 INFO - Python 2.7.3 04:10:04 INFO - Return code: 0 04:10:04 INFO - grabbing minidump binary from tooltool 04:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:04 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 0x1176920>, '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 0x1177820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1177cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:10:04 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 04:10:04 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 04:10:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:10:04 INFO - Return code: 0 04:10:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:10:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:10:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:10:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:10:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:10:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:10:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:10:05 INFO - Return code: 0 04:10:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 04:10:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 04:10:05 INFO - Using env: {'DISPLAY': ':0', 04:10:05 INFO - 'HOME': '/home/cltbld', 04:10:05 INFO - 'LANG': 'en_US.UTF-8', 04:10:05 INFO - 'LANGUAGE': 'en_US:en', 04:10:05 INFO - 'LOGNAME': 'cltbld', 04:10:05 INFO - 'MAIL': '/var/mail/cltbld', 04:10:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:10:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:05 INFO - 'MOZ_NO_REMOTE': '1', 04:10:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:05 INFO - 'NO_EM_RESTART': '1', 04:10:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:10:05 INFO - 'PWD': '/builds/slave/test-pgo', 04:10:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:10:05 INFO - 'SHELL': '/bin/bash', 04:10:05 INFO - 'SHLVL': '1', 04:10:05 INFO - 'TERM': 'linux', 04:10:05 INFO - 'TMOUT': '86400', 04:10:05 INFO - 'USER': 'cltbld', 04:10:05 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670', 04:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:05 INFO - '_': '/tools/buildbot/bin/python'} 04:10:05 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 04:10:05 INFO - mozversion application_buildid: 20160311013218 04:10:05 INFO - mozversion application_changeset: 89cfc24de8501a471b6fab892c6674645f6fce60 04:10:05 INFO - mozversion application_display_name: Nightly 04:10:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:10:05 INFO - mozversion application_name: Firefox 04:10:05 INFO - mozversion application_remotingname: firefox 04:10:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:10:05 INFO - mozversion application_vendor: Mozilla 04:10:05 INFO - mozversion application_version: 48.0a1 04:10:05 INFO - mozversion platform_buildid: 20160311013218 04:10:05 INFO - mozversion platform_changeset: 89cfc24de8501a471b6fab892c6674645f6fce60 04:10:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:10:05 INFO - mozversion platform_version: 48.0a1 04:10:05 INFO - using testdate: 1457698205 04:10:05 INFO - actual date: 1457698205 04:10:05 INFO - starting webserver on 'localhost:34380' 04:10:05 INFO - SUITE-START | Running 2 tests 04:10:05 INFO - TEST-START | dromaeo_css 04:10:05 INFO - operating with platform_type : linux_ 04:10:05 INFO - Initialising browser for dromaeo_css test... 04:10:05 INFO - TEST-INFO | started process 6508 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9PD1jK/profile http://localhost:34380/getInfo.html) 04:10:09 INFO - PROCESS | 6508 | 04:10:09 INFO - PROCESS | 6508 | (process:6588): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:10:10 INFO - PROCESS | 6508 | __metrics Screen width/height:1600/1200 04:10:10 INFO - PROCESS | 6508 | colorDepth:24 04:10:10 INFO - PROCESS | 6508 | Browser inner width/height: 1024/697 04:10:10 INFO - PROCESS | 6508 | __metrics 04:10:11 ERROR - PROCESS | 6508 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 04:10:12 INFO - TEST-INFO | 6508: exit 0 04:10:12 INFO - Browser initialized. 04:10:12 INFO - Running cycle 1/1 for dromaeo_css test... 04:10:12 INFO - TEST-INFO | started process 6640 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9PD1jK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:14 INFO - PROCESS | 6640 | 04:10:14 INFO - PROCESS | 6640 | (process:6701): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:10:24 INFO - PROCESS | 6640 | RSS: Main: 164626432 04:10:24 INFO - PROCESS | 6640 | 04:11:13 INFO - PROCESS | 6640 | 1457698273682 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] 04:13:22 INFO - PROCESS | 6640 | Cycle 1(1): loaded http://localhost:34380/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34380/tests/dromaeo/cssquery-ext.html) 04:13:23 INFO - PROCESS | 6640 | RSS: Main: 170024960 04:13:23 INFO - PROCESS | 6640 | 04:16:25 INFO - PROCESS | 6640 | Cycle 1(1): loaded http://localhost:34380/tests/dromaeo/cssquery-ext.html (next: http://localhost:34380/tests/dromaeo/cssquery-jquery.html) 04:16:26 INFO - PROCESS | 6640 | RSS: Main: 169070592 04:16:26 INFO - PROCESS | 6640 | 04:19:27 INFO - PROCESS | 6640 | Cycle 1(1): loaded http://localhost:34380/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34380/tests/dromaeo/cssquery-mootools.html) 04:19:28 INFO - PROCESS | 6640 | RSS: Main: 169955328 04:19:28 INFO - PROCESS | 6640 | 04:22:30 INFO - PROCESS | 6640 | Cycle 1(1): loaded http://localhost:34380/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34380/tests/dromaeo/cssquery-prototype.html) 04:22:30 INFO - PROCESS | 6640 | RSS: Main: 167751680 04:22:30 INFO - PROCESS | 6640 | 04:25:33 INFO - PROCESS | 6640 | Cycle 1(1): loaded http://localhost:34380/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34380/tests/dromaeo/cssquery-yui.html) 04:25:33 INFO - PROCESS | 6640 | RSS: Main: 167636992 04:25:33 INFO - PROCESS | 6640 | 04:28:36 INFO - PROCESS | 6640 | Cycle 1(1): loaded http://localhost:34380/tests/dromaeo/cssquery-yui.html (next: http://localhost:34380/tests/dromaeo/cssquery-dojo.html) 04:28:36 INFO - PROCESS | 6640 | RSS: Main: 171978752 04:28:36 INFO - PROCESS | 6640 | 04:28:36 INFO - PROCESS | 6640 | __start_tp_report 04:28:36 INFO - PROCESS | 6640 | _x_x_mozilla_page_load 04:28:36 INFO - PROCESS | 6640 | _x_x_mozilla_page_load_details 04:28:36 INFO - PROCESS | 6640 | |i|pagename|runs| 04:28:36 INFO - PROCESS | 6640 | |0;dojo.html;3180.300333926535;3190.202449387653;3218.2437127275102;3226.709596136349;3268.2809781847986;5255.973720131399;5284.2866213061225;5305.230741542474;5339.733013349327;5346.919796203055;5242.842714718555;5371.838844834661;5457.536109430694;5477.370102438221;5501.614886957905;4902.264660300957;4942.901141977159;4991.450940396553;5018;5029.924551131736;4901.460839307673;4940.110780059588;4961.280614310923;4967.180415231501;5001.8249361272365;4843.467218605951;4885.218365061609;4904.509549045102;4923.236898280755;4937.901241975176;4842.44311904132;4844.927326090112;4856.465788763233;4877.0489754497885;4908.239222920453;4825.686330388548;4836.443808961944;4836.443808961979;4842.055799119138;4876.609871210295;5144.897102057976;5186.5332120109;5230.320058392423;5248.448912864171;5302.708351040691;5674.744636491368;5682.488576028136;5688.829335119912;5695.373508914016;5708.4291570843;5605.047141985872;5717.770679303928;5719.428057194289;5722.914156287659;5737.254156959569;5338.439463856278;5360.865978350534;5381.865453363658;5404.32445944257;5414.512693857532;5902.911456328158;5928.851778705567;5929;5935.910961335583;5953.851153721192;5496.80761173357;5576.247206627135;5665.80169694067;5695.145728140812;5718.628289161191;5612.607117501736;5631.155326701028;5685.943140568624;5701.572382071361;5756.827295181151;5604.495595396353;5616.522595579421;5638.661680299113;5650.265465489542;5700.315962084576;5614.6631202128;5633.549316054706;5683.658980461186;5686.43135686428;5691.0609749391715;4326.524082350938;4383.189110014594;4386.035072284092;4386.0569977455;4411.360352748833;3903.160820423566;3910.042039700235;3911.1786524829536;3926.391409331558;3929.4695216146024;5180.740962951837;5234.18870075139;5310.654807437504;5320.866978325573;5343.118385466354;5566.387697353288;5615.101583746581;5636.887262254814;5650.858728531737;5667.206591077253;5278.709670968134;5288.8413347599635;5289.18017707256;5314.627976041717;5350.036993341236;4791.305260737174;4813.663043586916;4840.782164802522;4887.120318342732;4887.657863949489;5898.14476900847;5932.762689492458;5938.792142275086;5940.227770389908;5941.465268125803;5683.71581420919;5686.9715651421475;5688.175214593778;5688.203651488878;5707.229524014205;5797.333306669619;5904.468597826216;5948.553858460719;5956.404359564009;6006.579539432372;5548.583856210881;5580.693061881636;5590.5527557796095;5595.272614560244;5610.663360198401;5576.247206627054;5581.441855814549;5581.939431508001;5663.32040155184;5674.432556744293;5420.647657902224;5535.612507124623;5561;5584.106542953108;5609.046462101534;5487.6158668892795;5499.862503437286;5563.916541251803;5570.86072848182;5571.972140139435;5395.838124856261;5444.428335024765;5482.068048431856;5502.532284755841;5505.504504594605;5653.265075540154;5659.6321239119325;5708.828735137952;5713.514351280188;5740.885182296414;5501.9174712380145;5519.39286678473;5526.530244929226;5526.944730552804;5540.501354878081 04:28:36 INFO - PROCESS | 6640 | |1;ext.html;474.3264564318665;515.9165751920966;516.6280278199695;520.7916833266694;540.1492649077703;28026.719732802667;35588.644113558854;35848.64151358486;35946;35957.64042359572;41857;42309.36535951956;42316.36525452121;42405.787971060105;42432.78783606085;8730.21428071472;8857.645694172226;8871.600777965006;8900.065493123226;8919.95540022299;8701.912980870173;8795.076516965722;8818.559072046372;8819.691310804123;8843.823123537526;8812.16284452976;8922.73231803047;8924.196822285992;8943.284537237005;8952.239059679903;8821.867671984925;8846.071162527905;8880.289576833839;8915.2422044126;8921.375503714742;8728.258098061673;8844.292456603456;8848.867266991001;8853.645854165825;8861.73414797557;39322.60677393218;39866;39902.60097399047;39985.80007099975;40028;2926.6308526416547;2988.716071973181;3226.3869864725625;3602.423612222032;3750.606186350421;25049.373765655822;26509.204723858315;26752.59871101935;26774.33064173392;26790.196294111014;3781.810909454516;3895;3897.2400381925536;3901.51231096113;4062.634362907323;281137;281398;282926;284200;284689.576552118;41756.3736543946;42458.150836983084;42521.57478425238;61044.69477652583;61362.38637613656;39603.603963960566;39744.801275993435;39787.80106099509;40139.59860401417;40168.196636067114;13987;14056.859431405555;14087.788683169761;14116.153030818185;14153.646158846112;12519.748025197407;12642.115051946275;12652.746945061232;12730.554430594884;12749.872501275055;13851.653708657364;13926;14017.68708163162;14025.018248722696;14120.576382708536;5777.88444231113;5827.825165245049;5920.851978700567;5942.584019118706;5958.076498142795;788.9960550197212;874.0167311774254;963.8939716631165;1023.2019025160387;1058.5606973106228;28053.438931221262;28995.855020725183;29317.56023659647;29438.852805735834;29611.259718507208;998.9950050249702;1012.448215722433;1024.9596659390725;1070.5129166229347;1073.7476692977143;13341.266230357423;13442.731145377038;13477.39351729155;13862.792058119136;13905.374258158407;298829;302657;302759;303289;305647;51731;52351.738241309315;52582.73708631432;52929.2060619091;53009.734951324994;1279.7248591552861;1281.135233717237;1321.5440672967811;1326.6152815683345;1328.9867101329057;25978;27073.729262707122;27091.72908270892;27198;27489;44149.55850441455;44287.55712442963;44366.11267774691;44409.33385999148;44482;288512;293682;294009;295319;295653;31890.362192756478;32192;32200;32205.677943221206;32272.193195170308;43758.56241437545;43872.122557548035;44106.55893441025;44109.55890441054;44490.77754611206;36694.71568495197;36926;37100;37462.06344841401;38014;36571;36610.26779464449;36679;36854.44718329281;37321.81339093287;31780.887668931475;34747.30505389827;35008.29983400267;35895.64104359027;37125.814370927976;30099.54850677198;31608.683913160574;31609.841950790098;31855.203619909687;31922.52116218305;24452.633210501503;24545.509089817748;24748.38129046716;25067.87466062731;25121.120760773287 04:28:36 INFO - PROCESS | 6640 | |2;jquery.html;337.8680525881686;357.973152013599;362.2754491017963;367.36629314432605;368.51908259721085;15855.84144158558;16429.671406571862;17302.567435814097;17594.29622815089;17688.20403081861;15663.843361566382;16019.279132439038;16113.355465781384;16135.515934521984;16420.589485262873;4764.428268607763;5237.214417837316;5363.061464243761;5374.328208973879;5410.810621628244;5326.280952071459;5336.199570064502;5348.598855085865;5380.058489764295;5391.487808658171;5106.923396149061;5300.867478313054;5335.226392173133;5355.571554275668;5359.1425371940495;5290.7354632268425;5297.549708274802;5306.495882891119;5341.332333458317;5347.304850369446;4684.648651351128;4700.623950083985;4711.670183087151;4721.976390118028;4753.096911586822;19479.415617531355;19844.702329465068;19974.500637484034;19981.30065447717;20040.298589549442;2002.3992802159294;2178.0743184146672;2292.4039749665208;2380.690510233676;2802.0613094613327;11461.140414468864;11716.707082322924;11811;12100.334481603508;12267.877321226762;1669.5074952888806;1715.288155415501;1737.3050779688099;1737.3658614605704;1783.3758184635274;61495.69252153755;63009;63155.368446315406;63569;64232.357676423104;9579.664711735057;9615.9038409615;9765.267604929659;9888.20894328452;10063.5471403787;12800.423980920881;12815.487380504861;12909.741805164032;12924.547640832525;12944.288064156373;7709.922900771033;7732.845343093107;7859.096203936506;7897.9978799325345;7959.920400795918;7643.808904777314;7763.9611801941755;7774.883376749353;7934.880976785353;7962.6416811243635;5831.358550559435;5903.439173278532;5931.851703707442;5933.762649493972;6088.786892458831;1813.274690123961;1818.6362727454562;1826.059579316653;1837.9632407351778;1845.4740398986226;907.3059109780891;911.0616065452595;915.0803442540205;991.504247876062;1052.55792567122;16160.191990400433;16440.424585139463;16486.75269870953;16591.004539727655;17065.488035358958;986.6891929042329;1004.6885465505717;1018.8166130096654;1026.225199974015;1027.7893031928436;9559.808803824024;9644.517774111266;9810.313278070467;9856.162226210708;9959.352642078242;399961;409237;409508.477033766;411556;414093;62049.37950620526;64674;65503.344966549725;66156;67019;1033.4677641014882;1055.9683209503573;1071.5178169823455;1074.854894589236;1087.119433259047;14446.494372697325;14744;14824.7776283358;14919.104853708812;15089.924550377178;31013;31607.367852642357;31885.521717174724;31949.68050319467;31974.200644984063;40549;42174.578254217064;42445.36331955085;42451.15097697967;42683.786581066895;7361.779146625609;7449.776506704808;7577.204393538819;7614.086309642878;7630;9729.221662267144;10869.29349592274;11279.210455268052;11525.942370288094;11540.94229528847;8893.777655558662;9399.765005874908;9605.711828645151;9702.611895524382;10096.596136154472;9314.813703726024;9325.440473571607;9668.516574171404;9728.610855565697;9802.313838031268;9353.298502612468;9525.618975240914;9692.660756873476;9799.510024498604;10180.796384072426;7456.925430745623;7596.8480630385975;7634.198409167179;7664.693412263447;7871.803204919923;9062.320325975446;9369.906300936904;9651.034896510293;9805.754856128653;10013.799724005334 04:28:36 INFO - PROCESS | 6640 | |3;mootools.html;1497.760358342665;1511.8488151184883;1713.982860171398;1800.5858652509914;1837.3110083718614;6901.792946211609;7522.699092036312;7595.354394876435;7802.765917022484;7833.725819596315;7598.39212862971;7618.96190519048;7636.847263054749;7690.077190737119;7722.034745656793;2280.5780930527862;2310.8844557772127;2320.7679232076825;2324.151684635113;2324.6280595104786;2257.2776711452343;2284.314705588317;2287.2909398086563;2293.243229734192;2295.036084844361;2272.488690044735;2279.0314116500504;2297.471581536248;2316.4324740438533;2330.7902288794007;2266.263464374085;2267.875266860322;2274.226762900605;2277.419258089193;2282.132789539981;2288.988555057214;2292.117534749117;2294.89672964717;2299.471121642015;2302.861828290308;7799.0641123065025;7825.452218344718;7827.491213071189;7848.2151784821635;7849.68601255949;4713.693609915379;4821.807127714887;4828.830990915336;4831.782569784333;4845.636577256684;2919.44530539199;2939.426811771705;3064;3064.2033071401374;3081.876724931;946.8248374050754;958.2046901072093;967.4195482710388;989.4211886046671;994.6021591363512;10681.572737090508;10713.196510261683;10718;10748.677539673823;10751.731206719816;4287.292596721569;4314.288142456522;4397.494288156839;4413.426254586883;4423.845165419195;9176.495292758962;9180.44917304964;9184.03567625403;9199.264058875275;9217.262618990464;4848.17581011229;4861.197902346144;4868.464468908417;4874.561289483963;4901.607871370282;3911.9804400978383;4269.103488267437;4306.82772689089;4314.61168494837;4420.336949457607;3677.724170687209;3689.6679298862696;3700.2599480104086;3727.0309719473134;3729;1178.7524619829933;1185.105245539612;1187.6615164678199;1187.703074231442;1191.53530123252;1260.87391260875;1265.5697062998624;1275.776739070659;1305.9934700326437;1306.203216038216;6993.930060699429;7101.467389945775;7120.71517139319;7147.392471639969;7153.284671532909;1127.0814286356592;1142.2004596782285;1148.2249481599886;1154.6824623228679;1163.941802909851;5739.13912913058;5774.422557744192;5793.2179155814265;5808.970955145197;5820;9163.541822908828;9225.169734723908;9472.810543789223;9577.090176433228;9588.952055239679;9373.250139988784;9455.14903658674;9462.479563624067;9469.905300946903;9501.382410143318;7243.7464688735645;7326.633668316669;7412.369948554326;7469.141048779351;7481.21447248042;6873.759418420332;6888.724451021903;6900.6204658744255;6920.5847649141215;6930.5148639594745;8127.187281271826;8355.331573473986;8488.236058754741;8496.192861678132;8503.107173746916;8509.511629765766;8590.82818343642;8662.480251184948;8760.78098047554;8778.517181555077;5762.2221000164445;6045.667488288186;6173.444390004921;6547.803565893031;6666.533342665967;7278.96360518194;7300.306470885257;7340.70637174507;7349.926500734924;7355.227701091522;6341.587796793194;6539.149910511603;6544.574602650812;6582.868342633024;6656.334366563305;6466.353364663496;6552.6068435894;6578.901316480353;6595.835104122435;6619.007148927507;6886.208086069965;6901.827454313682;6908.44732421395;6930.099087118642;6940.757073502605;6190.50475961913;6279.529035322278;6282.4974002080635;6305.432511074026;6317.778877739441;6347.39699728525;6351.2696039956;6360.204974378203;6367.3314301997625;6383.106365108795 04:28:36 INFO - PROCESS | 6640 | |4;prototype.html;330.2931726106133;342.43498227923914;342.6778827901772;346.9340825243205;351.1607258651824;6232.813015609528;6329.050642403642;6342.651154186524;6377.043443483474;6378.330275321083;6218.595791273564;6256.061590761388;6262.2172228471445;6268.968655156717;6270.184875966118;4642.373279607261;4724.24412094065;4771.308160316769;4790.856274311759;4828.927566086511;4740.620750339982;4746.976265118669;4748.4301883774;4773.236282194849;4784.97607511962;4669.556392142741;4693.131770622429;4699.412573428322;4702.90594188116;4709.693869898463;4698.154332220216;4703.412073490814;4703.882402939937;4730.479647238801;4735.12400205963;4147.730397524181;4148.585141485857;4152.667786577066;4154;4155.958440415618;6002.909956350658;6006.699665016732;6011.639301641915;6015.09773533969;6019.097135429677;5350.5184533392185;5540.113581826889;5548.500634942875;5549.417311182348;5572.164175373686;6627.867442651168;6631.303713110102;6642.867142657168;6645.66771661415;6646.036324732887;4560.8859778505475;4576.8626941191815;4578.35902973584;4590;4599.977000115012;6860.211075726305;6906.930930690679;6938.202106757686;6967.372936435796;6978.302169783032;4659.324397962277;4663.230566956414;4678.087772884323;4704.1062198182235;4725.794922294862;4588.334691469719;4722.409698787652;4737.147313483537;4737.336772851803;4744.979829336709;5503.669779813224;5504.697241651747;5509.972450137724;5516.8966206758805;5553;6675.265720770712;6688.966555167291;6711.094002309724;6716.899246511306;6719.798406047827;1670.9164541773107;1696.1943077038309;1696.9660606787795;1696.991515042417;1698.0915210362398;1093.2128867215592;1113.0372228022864;1117.4245263689206;1124.2186680257144;1139.9658010259704;6297.023961285917;6322.33615470369;6324.873502529924;6327.303996560375;6329.620222786648;6831.69257383419;6882.724691012303;6898.1377327834025;6911.6544172791155;6917.066196063568;6132.172156758869;6218.06728990655;6256.968715156395;6355.777547785805;6399.9040014399825;3729.8135093245774;3733.3093377724663;3765.284595926765;3772.86794962175;3778.1499162688174;7267.527610705287;7301.59841208728;7322.63386830667;7332.8900066499045;7345.045144131335;7138.179109402381;7141.535800172972;7142.5000249982;7157.964210178916;7170.426365890717;7165.24764899678;7315.4147668186415;7321.267873212636;7339.633018349168;7344.522606030698;6945.305469453015;6977.825554361181;6983.301669832976;6986.091808064919;6992.1958974718555;6888;6890.8621827562165;6897.7585784497305;6902.585844849325;6906.482013849082;7267.236940121423;7282.563046217244;7303.269673032654;7312.378447831781;7323.560586364835;4564.360989461545;4684.1334353144775;4696.906061878675;4698.906021879475;4713.6936099153445;6919.446444284345;6949.478789090737;6956.826079348057;6966.3730264276455;6969.895451568332;6703.061571380108;6714.899276510759;6717.16035495563;6757.087793147862;6759.966200168968;6752.69612867432;6761.256261811099;6764.458843292623;6765.594064356154;6781.152355955505;6468.062130991074;6544.9672751637845;6619.238787539494;6648.767293144717;6649.202095748541;6788.151481064867;6791.89812152828;6799.524033317818;6812.761553345609;6814.1482314710665;6564.343565643398;6614.305497922841;6642.4686025118845;6645.069690243273;6655.767048153291 04:28:36 INFO - PROCESS | 6640 | |5;yui.html;714.8355878148026;726;732.8131326511739;735.4741359927652;765.2997507280837;12801.167924084928;13124.934375328123;13155.473781048759;14257.643558911032;14556.636084097903;13927.930360348184;13997.930010349934;14018.088824226417;14079.225642589654;14082.929585352085;821.4414198345123;829.1873963515758;847.0301504777027;847.894013248344;861.1431625532604;846.6020970144053;847.4068152293419;848.9448185867899;849.8852654891572;852.0116664668985;876.408424313589;878.0253918150847;885.0397318908991;885.2563846369048;888.3159966825541;877.627008521379;880.1990188928077;884.0805562215321;885.2298500304712;886.9911300886973;655.3708439897704;659.8185498987768;659.8251463362213;660.0725979998062;660.207750699163;13522.594322170351;13553.457861685521;13554.661133471644;13570.389332479963;13603.115797473132;12058.879411205864;12155.756884862341;12301.569445069379;12504.437300321417;12652.68368290791;10338.84491732617;10394.740131496774;10478.266521343508;10512.264141510097;10690.572377104907;3545.946810797814;3551.236484155919;3554.608993010767;3571.535700358963;3679.871204507856;50009.24986125211;50217.497825022016;50870.7456462719;50994.49005509935;51219;8573.871391929126;8584.39909206362;8721.345899057596;8927.687530936386;8970.461772293684;17806.46580602584;17950.820491795177;17954.461366159037;18021.819781802013;18086.819131808777;7356.632168391666;7608.467407281548;7627.618619069135;7753.961230193813;7800.219978002267;4220.388043733703;4248.299030659969;4337.7614231217585;4410.676796960899;4444.133393988206;3103.0690792762534;3128.311771410286;3131.232847952266;3137.1529686984386;3146.685331466835;594.47983014862;594.9018411962064;598.2880372356882;599.7690889007763;608.7199888051546;528.7937704295327;558.3216392083557;559.6949662433983;595.9165716799652;645.3385280087854;7241.813602015097;7395.186529481753;7589.196731114255;7662.693492260359;7711.421643376657;520.7292208051867;551.5008916930185;588.690937257943;597.5130268830889;609.622034338704;3579.6957258632788;3730.9067273318383;3742.4386342048365;3743.887683369503;3745.2135051638916;54706;56150.43849561452;56636.43363566394;57293.427065729644;57958.42041579614;50404;51333.743331283855;51496.74251628718;51728.48271517312;51776.482235177165;44332.3350149748;45670.771646141555;46136.3079553807;47383.52616473791;47580.7620961893;7420.888686669812;7454;7512.13610434807;7576.545407275581;7792.37660987131;32627.67372326341;33080;33347.83326083354;33993.660063400035;34577.48133777945;38800;38988.415173772984;40365.59634403736;41834.790826045675;42070;10423.895761042595;10542.947285263524;10657.840132397865;10668.8933110671;11152.832707509231;11928.343941083323;11945.16383853122;11994;12361.320127393079;12979.221246725227;10278.17774578017;10377.948110259702;10798.622048228588;10803.675889723321;10957.232993690364;10770.676879693621;10853.34879907208;10927.235093543375;11105.278156919774;11498.482568284615;10690.465476725976;10900.291481053706;10958.780824383308;11047.72380690489;11120.054795342487;9835.754106147404;10010.64962726301;10015.649452269136;10147.238957078102;10178.745531361776;8242.587870606325;8431.28334091609;8714.25928796034;9156.862647060167;9164.862527062232 04:28:36 INFO - PROCESS | 6640 | __end_tp_report 04:28:36 INFO - PROCESS | 6640 | __start_cc_report 04:28:36 INFO - PROCESS | 6640 | _x_x_mozilla_cycle_collect,336 04:28:36 INFO - PROCESS | 6640 | __end_cc_report 04:28:36 INFO - PROCESS | 6640 | __startTimestamp1457699316380__endTimestamp 04:28:36 INFO - PROCESS | 6640 | 04:28:36 INFO - PROCESS | 6640 | ------- Summary: start ------- 04:28:36 INFO - PROCESS | 6640 | Number of tests: 6 04:28:36 INFO - PROCESS | 6640 | 04:28:36 INFO - PROCESS | 6640 | [#0] dojo.html Cycles:165 Average:5298.97 Median:5501.92 stddev:578.10 (10.5%) stddev-sans-first:555.46 04:28:36 INFO - PROCESS | 6640 | Values: 3180.3 3190.2 3218.2 3226.7 3268.3 5256.0 5284.3 5305.2 5339.7 5346.9 5242.8 5371.8 5457.5 5477.4 5501.6 4902.3 4942.9 4991.5 5018.0 5029.9 4901.5 4940.1 4961.3 4967.2 5001.8 4843.5 4885.2 4904.5 4923.2 4937.9 4842.4 4844.9 4856.5 4877.0 4908.2 4825.7 4836.4 4836.4 4842.1 4876.6 5144.9 5186.5 5230.3 5248.4 5302.7 5674.7 5682.5 5688.8 5695.4 5708.4 5605.0 5717.8 5719.4 5722.9 5737.3 5338.4 5360.9 5381.9 5404.3 5414.5 5902.9 5928.9 5929.0 5935.9 5953.9 5496.8 5576.2 5665.8 5695.1 5718.6 5612.6 5631.2 5685.9 5701.6 5756.8 5604.5 5616.5 5638.7 5650.3 5700.3 5614.7 5633.5 5683.7 5686.4 5691.1 4326.5 4383.2 4386.0 4386.1 4411.4 3903.2 3910.0 3911.2 3926.4 3929.5 5180.7 5234.2 5310.7 5320.9 5343.1 5566.4 5615.1 5636.9 5650.9 5667.2 5278.7 5288.8 5289.2 5314.6 5350.0 4791.3 4813.7 4840.8 4887.1 4887.7 5898.1 5932.8 5938.8 5940.2 5941.5 5683.7 5687.0 5688.2 5688.2 5707.2 5797.3 5904.5 5948.6 5956.4 6006.6 5548.6 5580.7 5590.6 5595.3 5610.7 5576.2 5581.4 5581.9 5663.3 5674.4 5420.6 5535.6 5561.0 5584.1 5609.0 5487.6 5499.9 5563.9 5570.9 5572.0 5395.8 5444.4 5482.1 5502.5 5505.5 5653.3 5659.6 5708.8 5713.5 5740.9 5501.9 5519.4 5526.5 5526.9 5540.5 04:28:36 INFO - PROCESS | 6640 | 04:28:36 INFO - PROCESS | 6640 | [#1] ext.html Cycles:180 Average:45032.71 Median:36644.63 stddev:76619.35 (209.1%) stddev-sans-first:76761.24 04:28:36 INFO - PROCESS | 6640 | Values: 474.3 515.9 516.6 520.8 540.1 28026.7 35588.6 35848.6 35946.0 35957.6 41857.0 42309.4 42316.4 42405.8 42432.8 8730.2 8857.6 8871.6 8900.1 8920.0 8701.9 8795.1 8818.6 8819.7 8843.8 8812.2 8922.7 8924.2 8943.3 8952.2 8821.9 8846.1 8880.3 8915.2 8921.4 8728.3 8844.3 8848.9 8853.6 8861.7 39322.6 39866.0 39902.6 39985.8 40028.0 2926.6 2988.7 3226.4 3602.4 3750.6 25049.4 26509.2 26752.6 26774.3 26790.2 3781.8 3895.0 3897.2 3901.5 4062.6 281137.0 281398.0 282926.0 284200.0 284689.6 41756.4 42458.2 42521.6 61044.7 61362.4 39603.6 39744.8 39787.8 40139.6 40168.2 13987.0 14056.9 14087.8 14116.2 14153.6 12519.7 12642.1 12652.7 12730.6 12749.9 13851.7 13926.0 14017.7 14025.0 14120.6 5777.9 5827.8 5920.9 5942.6 5958.1 789.0 874.0 963.9 1023.2 1058.6 28053.4 28995.9 29317.6 29438.9 29611.3 999.0 1012.4 1025.0 1070.5 1073.7 13341.3 13442.7 13477.4 13862.8 13905.4 298829.0 302657.0 302759.0 303289.0 305647.0 51731.0 52351.7 52582.7 52929.2 53009.7 1279.7 1281.1 1321.5 1326.6 1329.0 25978.0 27073.7 27091.7 27198.0 27489.0 44149.6 44287.6 44366.1 44409.3 44482.0 288512.0 293682.0 294009.0 295319.0 295653.0 31890.4 32192.0 32200.0 32205.7 32272.2 43758.6 43872.1 44106.6 44109.6 44490.8 36694.7 36926.0 37100.0 37462.1 38014.0 36571.0 36610.3 36679.0 36854.4 37321.8 31780.9 34747.3 35008.3 35895.6 37125.8 30099.5 31608.7 31609.8 31855.2 31922.5 24452.6 24545.5 24748.4 25067.9 25121.1 04:28:36 INFO - PROCESS | 6640 | 04:28:36 INFO - PROCESS | 6640 | [#2] jquery.html Cycles:180 Average:23907.92 Median:4716.82 stddev:66948.73 (1419.4%) stddev-sans-first:67113.15 04:28:36 INFO - PROCESS | 6640 | Values: 337.9 358.0 362.3 367.4 368.5 15855.8 16429.7 17302.6 17594.3 17688.2 15663.8 16019.3 16113.4 16135.5 16420.6 4764.4 5237.2 5363.1 5374.3 5410.8 5326.3 5336.2 5348.6 5380.1 5391.5 5106.9 5300.9 5335.2 5355.6 5359.1 5290.7 5297.5 5306.5 5341.3 5347.3 4684.6 4700.6 4711.7 4722.0 4753.1 19479.4 19844.7 19974.5 19981.3 20040.3 2002.4 2178.1 2292.4 2380.7 2802.1 11461.1 11716.7 11811.0 12100.3 12267.9 1669.5 1715.3 1737.3 1737.4 1783.4 61495.7 63009.0 63155.4 63569.0 64232.4 9579.7 9615.9 9765.3 9888.2 10063.5 12800.4 12815.5 12909.7 12924.5 12944.3 7709.9 7732.8 7859.1 7898.0 7959.9 7643.8 7764.0 7774.9 7934.9 7962.6 5831.4 5903.4 5931.9 5933.8 6088.8 1813.3 1818.6 1826.1 1838.0 1845.5 907.3 911.1 915.1 991.5 1052.6 16160.2 16440.4 16486.8 16591.0 17065.5 986.7 1004.7 1018.8 1026.2 1027.8 9559.8 9644.5 9810.3 9856.2 9959.4 399961.0 409237.0 409508.5 411556.0 414093.0 62049.4 64674.0 65503.3 66156.0 67019.0 1033.5 1056.0 1071.5 1074.9 1087.1 14446.5 14744.0 14824.8 14919.1 15089.9 31013.0 31607.4 31885.5 31949.7 31974.2 40549.0 42174.6 42445.4 42451.2 42683.8 7361.8 7449.8 7577.2 7614.1 7630.0 9729.2 10869.3 11279.2 11525.9 11540.9 8893.8 9399.8 9605.7 9702.6 10096.6 9314.8 9325.4 9668.5 9728.6 9802.3 9353.3 9525.6 9692.7 9799.5 10180.8 7456.9 7596.8 7634.2 7664.7 7871.8 9062.3 9369.9 9651.0 9805.8 10013.8 04:28:36 INFO - PROCESS | 6640 | 04:28:36 INFO - PROCESS | 6640 | [#3] mootools.html Cycles:180 Average:5415.68 Median:6293.96 stddev:2782.25 (44.2%) stddev-sans-first:2774.47 04:28:36 INFO - PROCESS | 6640 | Values: 1497.8 1511.8 1714.0 1800.6 1837.3 6901.8 7522.7 7595.4 7802.8 7833.7 7598.4 7619.0 7636.8 7690.1 7722.0 2280.6 2310.9 2320.8 2324.2 2324.6 2257.3 2284.3 2287.3 2293.2 2295.0 2272.5 2279.0 2297.5 2316.4 2330.8 2266.3 2267.9 2274.2 2277.4 2282.1 2289.0 2292.1 2294.9 2299.5 2302.9 7799.1 7825.5 7827.5 7848.2 7849.7 4713.7 4821.8 4828.8 4831.8 4845.6 2919.4 2939.4 3064.0 3064.2 3081.9 946.8 958.2 967.4 989.4 994.6 10681.6 10713.2 10718.0 10748.7 10751.7 4287.3 4314.3 4397.5 4413.4 4423.8 9176.5 9180.4 9184.0 9199.3 9217.3 4848.2 4861.2 4868.5 4874.6 4901.6 3912.0 4269.1 4306.8 4314.6 4420.3 3677.7 3689.7 3700.3 3727.0 3729.0 1178.8 1185.1 1187.7 1187.7 1191.5 1260.9 1265.6 1275.8 1306.0 1306.2 6993.9 7101.5 7120.7 7147.4 7153.3 1127.1 1142.2 1148.2 1154.7 1163.9 5739.1 5774.4 5793.2 5809.0 5820.0 9163.5 9225.2 9472.8 9577.1 9589.0 9373.3 9455.1 9462.5 9469.9 9501.4 7243.7 7326.6 7412.4 7469.1 7481.2 6873.8 6888.7 6900.6 6920.6 6930.5 8127.2 8355.3 8488.2 8496.2 8503.1 8509.5 8590.8 8662.5 8760.8 8778.5 5762.2 6045.7 6173.4 6547.8 6666.5 7279.0 7300.3 7340.7 7349.9 7355.2 6341.6 6539.1 6544.6 6582.9 6656.3 6466.4 6552.6 6578.9 6595.8 6619.0 6886.2 6901.8 6908.4 6930.1 6940.8 6190.5 6279.5 6282.5 6305.4 6317.8 6347.4 6351.3 6360.2 6367.3 6383.1 04:28:36 INFO - PROCESS | 6640 | 04:28:36 INFO - PROCESS | 6640 | [#4] prototype.html Cycles:180 Average:5594.38 Median:6323.60 stddev:1717.23 (27.2%) stddev-sans-first:1675.98 04:28:36 INFO - PROCESS | 6640 | Values: 330.3 342.4 342.7 346.9 351.2 6232.8 6329.1 6342.7 6377.0 6378.3 6218.6 6256.1 6262.2 6269.0 6270.2 4642.4 4724.2 4771.3 4790.9 4828.9 4740.6 4747.0 4748.4 4773.2 4785.0 4669.6 4693.1 4699.4 4702.9 4709.7 4698.2 4703.4 4703.9 4730.5 4735.1 4147.7 4148.6 4152.7 4154.0 4156.0 6002.9 6006.7 6011.6 6015.1 6019.1 5350.5 5540.1 5548.5 5549.4 5572.2 6627.9 6631.3 6642.9 6645.7 6646.0 4560.9 4576.9 4578.4 4590.0 4600.0 6860.2 6906.9 6938.2 6967.4 6978.3 4659.3 4663.2 4678.1 4704.1 4725.8 4588.3 4722.4 4737.1 4737.3 4745.0 5503.7 5504.7 5510.0 5516.9 5553.0 6675.3 6689.0 6711.1 6716.9 6719.8 1670.9 1696.2 1697.0 1697.0 1698.1 1093.2 1113.0 1117.4 1124.2 1140.0 6297.0 6322.3 6324.9 6327.3 6329.6 6831.7 6882.7 6898.1 6911.7 6917.1 6132.2 6218.1 6257.0 6355.8 6399.9 3729.8 3733.3 3765.3 3772.9 3778.1 7267.5 7301.6 7322.6 7332.9 7345.0 7138.2 7141.5 7142.5 7158.0 7170.4 7165.2 7315.4 7321.3 7339.6 7344.5 6945.3 6977.8 6983.3 6986.1 6992.2 6888.0 6890.9 6897.8 6902.6 6906.5 7267.2 7282.6 7303.3 7312.4 7323.6 4564.4 4684.1 4696.9 4698.9 4713.7 6919.4 6949.5 6956.8 6966.4 6969.9 6703.1 6714.9 6717.2 6757.1 6760.0 6752.7 6761.3 6764.5 6765.6 6781.2 6468.1 6545.0 6619.2 6648.8 6649.2 6788.2 6791.9 6799.5 6812.8 6814.1 6564.3 6614.3 6642.5 6645.1 6655.8 04:28:36 INFO - PROCESS | 6640 | 04:28:36 INFO - PROCESS | 6640 | [#5] yui.html Cycles:180 Average:13549.86 Median:45903.54 stddev:15807.66 (34.4%) stddev-sans-first:15822.62 04:28:36 INFO - PROCESS | 6640 | Values: 714.8 726.0 732.8 735.5 765.3 12801.2 13124.9 13155.5 14257.6 14556.6 13927.9 13997.9 14018.1 14079.2 14082.9 821.4 829.2 847.0 847.9 861.1 846.6 847.4 848.9 849.9 852.0 876.4 878.0 885.0 885.3 888.3 877.6 880.2 884.1 885.2 887.0 655.4 659.8 659.8 660.1 660.2 13522.6 13553.5 13554.7 13570.4 13603.1 12058.9 12155.8 12301.6 12504.4 12652.7 10338.8 10394.7 10478.3 10512.3 10690.6 3545.9 3551.2 3554.6 3571.5 3679.9 50009.2 50217.5 50870.7 50994.5 51219.0 8573.9 8584.4 8721.3 8927.7 8970.5 17806.5 17950.8 17954.5 18021.8 18086.8 7356.6 7608.5 7627.6 7754.0 7800.2 4220.4 4248.3 4337.8 4410.7 4444.1 3103.1 3128.3 3131.2 3137.2 3146.7 594.5 594.9 598.3 599.8 608.7 528.8 558.3 559.7 595.9 645.3 7241.8 7395.2 7589.2 7662.7 7711.4 520.7 551.5 588.7 597.5 609.6 3579.7 3730.9 3742.4 3743.9 3745.2 54706.0 56150.4 56636.4 57293.4 57958.4 50404.0 51333.7 51496.7 51728.5 51776.5 44332.3 45670.8 46136.3 47383.5 47580.8 7420.9 7454.0 7512.1 7576.5 7792.4 32627.7 33080.0 33347.8 33993.7 34577.5 38800.0 38988.4 40365.6 41834.8 42070.0 10423.9 10542.9 10657.8 10668.9 11152.8 11928.3 11945.2 11994.0 12361.3 12979.2 10278.2 10377.9 10798.6 10803.7 10957.2 10770.7 10853.3 10927.2 11105.3 11498.5 10690.5 10900.3 10958.8 11047.7 11120.1 9835.8 10010.6 10015.6 10147.2 10178.7 8242.6 8431.3 8714.3 9156.9 9164.9 04:28:36 INFO - PROCESS | 6640 | -------- Summary: end -------- 04:28:36 INFO - PROCESS | 6640 | 04:28:37 INFO - TEST-INFO | 6640: exit 0 04:28:37 INFO - TEST-OK | dromaeo_css | took 1111292ms 04:28:37 INFO - TEST-START | kraken 04:28:37 INFO - operating with platform_type : linux_ 04:28:37 INFO - Initialising browser for kraken test... 04:28:37 INFO - TEST-INFO | started process 6872 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp08v3_4/profile http://localhost:34380/getInfo.html) 04:28:40 INFO - PROCESS | 6872 | 04:28:40 INFO - PROCESS | 6872 | (process:6940): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:28:41 INFO - PROCESS | 6872 | __metrics Screen width/height:1600/1200 04:28:41 INFO - PROCESS | 6872 | colorDepth:24 04:28:41 INFO - PROCESS | 6872 | Browser inner width/height: 1024/697 04:28:41 INFO - PROCESS | 6872 | __metrics 04:28:42 ERROR - PROCESS | 6872 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 04:28:42 INFO - TEST-INFO | 6872: exit 0 04:28:42 INFO - Browser initialized. 04:28:42 INFO - Running cycle 1/1 for kraken test... 04:28:43 INFO - TEST-INFO | started process 6992 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp08v3_4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:44 INFO - PROCESS | 6992 | 04:28:44 INFO - PROCESS | 6992 | (process:7052): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:28:54 INFO - PROCESS | 6992 | RSS: Main: 164282368 04:28:54 INFO - PROCESS | 6992 | 04:28:57 INFO - PROCESS | 6992 | Cycle 1(1): loaded http://localhost:34380/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34380/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:57 INFO - PROCESS | 6992 | RSS: Main: 169431040 04:28:57 INFO - PROCESS | 6992 | 04:29:00 INFO - PROCESS | 6992 | Cycle 1(1): loaded http://localhost:34380/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34380/tests/kraken/driver.html?testName=audio-dft) 04:29:01 INFO - PROCESS | 6992 | RSS: Main: 170754048 04:29:01 INFO - PROCESS | 6992 | 04:29:04 INFO - PROCESS | 6992 | Cycle 1(1): loaded http://localhost:34380/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34380/tests/kraken/driver.html?testName=audio-fft) 04:29:04 INFO - PROCESS | 6992 | RSS: Main: 166260736 04:29:04 INFO - PROCESS | 6992 | 04:29:06 INFO - PROCESS | 6992 | Cycle 1(1): loaded http://localhost:34380/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34380/tests/kraken/driver.html?testName=audio-oscillator) 04:29:07 INFO - PROCESS | 6992 | RSS: Main: 165036032 04:29:07 INFO - PROCESS | 6992 | 04:29:09 INFO - PROCESS | 6992 | Cycle 1(1): loaded http://localhost:34380/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34380/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:29:10 INFO - PROCESS | 6992 | RSS: Main: 166273024 04:29:10 INFO - PROCESS | 6992 | 04:29:13 INFO - PROCESS | 6992 | Cycle 1(1): loaded http://localhost:34380/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34380/tests/kraken/driver.html?testName=imaging-darkroom) 04:29:13 INFO - PROCESS | 6992 | RSS: Main: 167706624 04:29:13 INFO - PROCESS | 6992 | 04:29:17 INFO - PROCESS | 6992 | Cycle 1(1): loaded http://localhost:34380/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34380/tests/kraken/driver.html?testName=imaging-desaturate) 04:29:17 INFO - PROCESS | 6992 | RSS: Main: 168022016 04:29:17 INFO - PROCESS | 6992 | 04:29:20 INFO - PROCESS | 6992 | Cycle 1(1): loaded http://localhost:34380/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34380/tests/kraken/driver.html?testName=json-parse-financial) 04:29:21 INFO - PROCESS | 6992 | RSS: Main: 170385408 04:29:21 INFO - PROCESS | 6992 | 04:29:23 INFO - PROCESS | 6992 | Cycle 1(1): loaded http://localhost:34380/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34380/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:29:23 INFO - PROCESS | 6992 | RSS: Main: 169578496 04:29:23 INFO - PROCESS | 6992 | 04:29:25 INFO - PROCESS | 6992 | Cycle 1(1): loaded http://localhost:34380/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34380/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:29:26 INFO - PROCESS | 6992 | RSS: Main: 170975232 04:29:26 INFO - PROCESS | 6992 | 04:29:28 INFO - PROCESS | 6992 | Cycle 1(1): loaded http://localhost:34380/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34380/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:29:28 INFO - PROCESS | 6992 | RSS: Main: 171307008 04:29:28 INFO - PROCESS | 6992 | 04:29:31 INFO - PROCESS | 6992 | Cycle 1(1): loaded http://localhost:34380/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:29:31 INFO - PROCESS | 6992 | RSS: Main: 171237376 04:29:31 INFO - PROCESS | 6992 | 04:29:34 INFO - PROCESS | 6992 | Cycle 1(1): loaded http://localhost:34380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:35 INFO - PROCESS | 6992 | RSS: Main: 170909696 04:29:35 INFO - PROCESS | 6992 | 04:29:36 INFO - PROCESS | 6992 | Cycle 1(1): loaded http://localhost:34380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34380/tests/kraken/driver.html?testName=ai-astar) 04:29:37 INFO - PROCESS | 6992 | RSS: Main: 171745280 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | __start_tp_report 04:29:37 INFO - PROCESS | 6992 | _x_x_mozilla_page_load 04:29:37 INFO - PROCESS | 6992 | _x_x_mozilla_page_load_details 04:29:37 INFO - PROCESS | 6992 | |i|pagename|runs| 04:29:37 INFO - PROCESS | 6992 | |0;ai-astar;113;106;114;112;113;124;112;111;113;112 04:29:37 INFO - PROCESS | 6992 | |1;audio-beat-detection;158;128;153;170;128;151;157;130;169;128 04:29:37 INFO - PROCESS | 6992 | |2;audio-dft;163;163;166;162;166;163;162;173;168;162 04:29:37 INFO - PROCESS | 6992 | |3;audio-fft;75;74;74;74;78;72;71;73;139;76 04:29:37 INFO - PROCESS | 6992 | |4;audio-oscillator;94;95;146;94;95;94;144;93;95;144 04:29:37 INFO - PROCESS | 6992 | |5;imaging-gaussian-blur;118;117;117;118;118;118;117;117;117;118 04:29:37 INFO - PROCESS | 6992 | |6;imaging-darkroom;146;146;146;147;146;147;147;146;147;146 04:29:37 INFO - PROCESS | 6992 | |7;imaging-desaturate;97;96;96;96;97;95;96;96;97;98 04:29:37 INFO - PROCESS | 6992 | |8;json-parse-financial;59;60;58;58;58;60;57;63;60;57 04:29:37 INFO - PROCESS | 6992 | |9;json-stringify-tinderbox;68;68;67;70;69;69;68;69;68;69 04:29:37 INFO - PROCESS | 6992 | |10;stanford-crypto-aes;83;85;89;83;84;83;82;83;85;93 04:29:37 INFO - PROCESS | 6992 | |11;stanford-crypto-ccm;122;128;123;117;119;119;124;128;126;117 04:29:37 INFO - PROCESS | 6992 | |12;stanford-crypto-pbkdf2;143;164;156;163;143;145;150;150;150;142 04:29:37 INFO - PROCESS | 6992 | |13;stanford-crypto-sha256-iterative;70;69;73;71;69;68;69;69;70;71 04:29:37 INFO - PROCESS | 6992 | __end_tp_report 04:29:37 INFO - PROCESS | 6992 | __start_cc_report 04:29:37 INFO - PROCESS | 6992 | _x_x_mozilla_cycle_collect,831 04:29:37 INFO - PROCESS | 6992 | __end_cc_report 04:29:37 INFO - PROCESS | 6992 | __startTimestamp1457699377037__endTimestamp 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | ------- Summary: start ------- 04:29:37 INFO - PROCESS | 6992 | Number of tests: 14 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:4.45 (3.9%) stddev-sans-first:4.72 04:29:37 INFO - PROCESS | 6992 | Values: 113.0 106.0 114.0 112.0 113.0 124.0 112.0 111.0 113.0 112.0 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:155.00 stddev:17.18 (11.1%) stddev-sans-first:17.78 04:29:37 INFO - PROCESS | 6992 | Values: 158.0 128.0 153.0 170.0 128.0 151.0 157.0 130.0 169.0 128.0 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:3.55 (2.2%) stddev-sans-first:3.71 04:29:37 INFO - PROCESS | 6992 | Values: 163.0 163.0 166.0 162.0 166.0 163.0 162.0 173.0 168.0 162.0 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | [#3] audio-fft Cycles:10 Average:80.60 Median:74.00 stddev:20.61 (27.9%) stddev-sans-first:21.76 04:29:37 INFO - PROCESS | 6992 | Values: 75.0 74.0 74.0 74.0 78.0 72.0 71.0 73.0 139.0 76.0 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:94.00 stddev:24.35 (25.9%) stddev-sans-first:25.18 04:29:37 INFO - PROCESS | 6992 | Values: 94.0 95.0 146.0 94.0 95.0 94.0 144.0 93.0 95.0 144.0 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:29:37 INFO - PROCESS | 6992 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 117.0 118.0 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:29:37 INFO - PROCESS | 6992 | Values: 146.0 146.0 146.0 147.0 146.0 147.0 147.0 146.0 147.0 146.0 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 04:29:37 INFO - PROCESS | 6992 | Values: 97.0 96.0 96.0 96.0 97.0 95.0 96.0 96.0 97.0 98.0 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.50 stddev:1.83 (3.1%) stddev-sans-first:1.94 04:29:37 INFO - PROCESS | 6992 | Values: 59.0 60.0 58.0 58.0 58.0 60.0 57.0 63.0 60.0 57.0 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 04:29:37 INFO - PROCESS | 6992 | Values: 68.0 68.0 67.0 70.0 69.0 69.0 68.0 69.0 68.0 69.0 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.50 stddev:3.43 (4.1%) stddev-sans-first:3.56 04:29:37 INFO - PROCESS | 6992 | Values: 83.0 85.0 89.0 83.0 84.0 83.0 82.0 83.0 85.0 93.0 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:123.50 stddev:4.22 (3.4%) stddev-sans-first:4.47 04:29:37 INFO - PROCESS | 6992 | Values: 122.0 128.0 123.0 117.0 119.0 119.0 124.0 128.0 126.0 117.0 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.60 Median:150.00 stddev:8.06 (5.4%) stddev-sans-first:8.06 04:29:37 INFO - PROCESS | 6992 | Values: 143.0 164.0 156.0 163.0 143.0 145.0 150.0 150.0 150.0 142.0 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - PROCESS | 6992 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.45 (2.1%) stddev-sans-first:1.54 04:29:37 INFO - PROCESS | 6992 | Values: 70.0 69.0 73.0 71.0 69.0 68.0 69.0 69.0 70.0 71.0 04:29:37 INFO - PROCESS | 6992 | -------- Summary: end -------- 04:29:37 INFO - PROCESS | 6992 | 04:29:37 INFO - TEST-INFO | 6992: exit 0 04:29:38 INFO - TEST-OK | kraken | took 60931ms 04:29:38 INFO - SUITE-END | took 1172s 04:29:38 INFO - Completed test suite (00:19:32) 04:29:38 INFO - javascript benchmark 04:29:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3180.300333926535, 3190.202449387653, 3218.2437127275102, 3226.709596136349, 3268.2809781847986, 5255.973720131399, 5284.2866213061225, 5305.230741542474, 5339.733013349327, 5346.919796203055, 5242.842714718555, 5371.838844834661, 5457.536109430694, 5477.370102438221, 5501.614886957905, 4902.264660300957, 4942.901141977159, 4991.450940396553, 5018.0, 5029.924551131736, 4901.460839307673, 4940.110780059588, 4961.280614310923, 4967.180415231501, 5001.8249361272365, 4843.467218605951, 4885.218365061609, 4904.509549045102, 4923.236898280755, 4937.901241975176, 4842.44311904132, 4844.927326090112, 4856.465788763233, 4877.0489754497885, 4908.239222920453, 4825.686330388548, 4836.443808961944, 4836.443808961979, 4842.055799119138, 4876.609871210295, 5144.897102057976, 5186.5332120109, 5230.320058392423, 5248.448912864171, 5302.708351040691, 5674.744636491368, 5682.488576028136, 5688.829335119912, 5695.373508914016, 5708.4291570843, 5605.047141985872, 5717.770679303928, 5719.428057194289, 5722.914156287659, 5737.254156959569, 5338.439463856278, 5360.865978350534, 5381.865453363658, 5404.32445944257, 5414.512693857532, 5902.911456328158, 5928.851778705567, 5929.0, 5935.910961335583, 5953.851153721192, 5496.80761173357, 5576.247206627135, 5665.80169694067, 5695.145728140812, 5718.628289161191, 5612.607117501736, 5631.155326701028, 5685.943140568624, 5701.572382071361, 5756.827295181151, 5604.495595396353, 5616.522595579421, 5638.661680299113, 5650.265465489542, 5700.315962084576, 5614.6631202128, 5633.549316054706, 5683.658980461186, 5686.43135686428, 5691.0609749391715, 4326.524082350938, 4383.189110014594, 4386.035072284092, 4386.0569977455, 4411.360352748833, 3903.160820423566, 3910.042039700235, 3911.1786524829536, 3926.391409331558, 3929.4695216146024, 5180.740962951837, 5234.18870075139, 5310.654807437504, 5320.866978325573, 5343.118385466354, 5566.387697353288, 5615.101583746581, 5636.887262254814, 5650.858728531737, 5667.206591077253, 5278.709670968134, 5288.8413347599635, 5289.18017707256, 5314.627976041717, 5350.036993341236, 4791.305260737174, 4813.663043586916, 4840.782164802522, 4887.120318342732, 4887.657863949489, 5898.14476900847, 5932.762689492458, 5938.792142275086, 5940.227770389908, 5941.465268125803, 5683.71581420919, 5686.9715651421475, 5688.175214593778, 5688.203651488878, 5707.229524014205, 5797.333306669619, 5904.468597826216, 5948.553858460719, 5956.404359564009, 6006.579539432372, 5548.583856210881, 5580.693061881636, 5590.5527557796095, 5595.272614560244, 5610.663360198401, 5576.247206627054, 5581.441855814549, 5581.939431508001, 5663.32040155184, 5674.432556744293, 5420.647657902224, 5535.612507124623, 5561.0, 5584.106542953108, 5609.046462101534, 5487.6158668892795, 5499.862503437286, 5563.916541251803, 5570.86072848182, 5571.972140139435, 5395.838124856261, 5444.428335024765, 5482.068048431856, 5502.532284755841, 5505.504504594605, 5653.265075540154, 5659.6321239119325, 5708.828735137952, 5713.514351280188, 5740.885182296414, 5501.9174712380145, 5519.39286678473, 5526.530244929226, 5526.944730552804, 5540.501354878081], "unit": "score", "name": "dojo.html", "value": 5262.050976933373}, {"lowerIsBetter": false, "replicates": [474.3264564318665, 515.9165751920966, 516.6280278199695, 520.7916833266694, 540.1492649077703, 28026.719732802667, 35588.644113558854, 35848.64151358486, 35946.0, 35957.64042359572, 41857.0, 42309.36535951956, 42316.36525452121, 42405.787971060105, 42432.78783606085, 8730.21428071472, 8857.645694172226, 8871.600777965006, 8900.065493123226, 8919.95540022299, 8701.912980870173, 8795.076516965722, 8818.559072046372, 8819.691310804123, 8843.823123537526, 8812.16284452976, 8922.73231803047, 8924.196822285992, 8943.284537237005, 8952.239059679903, 8821.867671984925, 8846.071162527905, 8880.289576833839, 8915.2422044126, 8921.375503714742, 8728.258098061673, 8844.292456603456, 8848.867266991001, 8853.645854165825, 8861.73414797557, 39322.60677393218, 39866.0, 39902.60097399047, 39985.80007099975, 40028.0, 2926.6308526416547, 2988.716071973181, 3226.3869864725625, 3602.423612222032, 3750.606186350421, 25049.373765655822, 26509.204723858315, 26752.59871101935, 26774.33064173392, 26790.196294111014, 3781.810909454516, 3895.0, 3897.2400381925536, 3901.51231096113, 4062.634362907323, 281137.0, 281398.0, 282926.0, 284200.0, 284689.576552118, 41756.3736543946, 42458.150836983084, 42521.57478425238, 61044.69477652583, 61362.38637613656, 39603.603963960566, 39744.801275993435, 39787.80106099509, 40139.59860401417, 40168.196636067114, 13987.0, 14056.859431405555, 14087.788683169761, 14116.153030818185, 14153.646158846112, 12519.748025197407, 12642.115051946275, 12652.746945061232, 12730.554430594884, 12749.872501275055, 13851.653708657364, 13926.0, 14017.68708163162, 14025.018248722696, 14120.576382708536, 5777.88444231113, 5827.825165245049, 5920.851978700567, 5942.584019118706, 5958.076498142795, 788.9960550197212, 874.0167311774254, 963.8939716631165, 1023.2019025160387, 1058.5606973106228, 28053.438931221262, 28995.855020725183, 29317.56023659647, 29438.852805735834, 29611.259718507208, 998.9950050249702, 1012.448215722433, 1024.9596659390725, 1070.5129166229347, 1073.7476692977143, 13341.266230357423, 13442.731145377038, 13477.39351729155, 13862.792058119136, 13905.374258158407, 298829.0, 302657.0, 302759.0, 303289.0, 305647.0, 51731.0, 52351.738241309315, 52582.73708631432, 52929.2060619091, 53009.734951324994, 1279.7248591552861, 1281.135233717237, 1321.5440672967811, 1326.6152815683345, 1328.9867101329057, 25978.0, 27073.729262707122, 27091.72908270892, 27198.0, 27489.0, 44149.55850441455, 44287.55712442963, 44366.11267774691, 44409.33385999148, 44482.0, 288512.0, 293682.0, 294009.0, 295319.0, 295653.0, 31890.362192756478, 32192.0, 32200.0, 32205.677943221206, 32272.193195170308, 43758.56241437545, 43872.122557548035, 44106.55893441025, 44109.55890441054, 44490.77754611206, 36694.71568495197, 36926.0, 37100.0, 37462.06344841401, 38014.0, 36571.0, 36610.26779464449, 36679.0, 36854.44718329281, 37321.81339093287, 31780.887668931475, 34747.30505389827, 35008.29983400267, 35895.64104359027, 37125.814370927976, 30099.54850677198, 31608.683913160574, 31609.841950790098, 31855.203619909687, 31922.52116218305, 24452.633210501503, 24545.509089817748, 24748.38129046716, 25067.87466062731, 25121.120760773287], "unit": "score", "name": "ext.html", "value": 17589.81216744793}, {"lowerIsBetter": false, "replicates": [337.8680525881686, 357.973152013599, 362.2754491017963, 367.36629314432605, 368.51908259721085, 15855.84144158558, 16429.671406571862, 17302.567435814097, 17594.29622815089, 17688.20403081861, 15663.843361566382, 16019.279132439038, 16113.355465781384, 16135.515934521984, 16420.589485262873, 4764.428268607763, 5237.214417837316, 5363.061464243761, 5374.328208973879, 5410.810621628244, 5326.280952071459, 5336.199570064502, 5348.598855085865, 5380.058489764295, 5391.487808658171, 5106.923396149061, 5300.867478313054, 5335.226392173133, 5355.571554275668, 5359.1425371940495, 5290.7354632268425, 5297.549708274802, 5306.495882891119, 5341.332333458317, 5347.304850369446, 4684.648651351128, 4700.623950083985, 4711.670183087151, 4721.976390118028, 4753.096911586822, 19479.415617531355, 19844.702329465068, 19974.500637484034, 19981.30065447717, 20040.298589549442, 2002.3992802159294, 2178.0743184146672, 2292.4039749665208, 2380.690510233676, 2802.0613094613327, 11461.140414468864, 11716.707082322924, 11811.0, 12100.334481603508, 12267.877321226762, 1669.5074952888806, 1715.288155415501, 1737.3050779688099, 1737.3658614605704, 1783.3758184635274, 61495.69252153755, 63009.0, 63155.368446315406, 63569.0, 64232.357676423104, 9579.664711735057, 9615.9038409615, 9765.267604929659, 9888.20894328452, 10063.5471403787, 12800.423980920881, 12815.487380504861, 12909.741805164032, 12924.547640832525, 12944.288064156373, 7709.922900771033, 7732.845343093107, 7859.096203936506, 7897.9978799325345, 7959.920400795918, 7643.808904777314, 7763.9611801941755, 7774.883376749353, 7934.880976785353, 7962.6416811243635, 5831.358550559435, 5903.439173278532, 5931.851703707442, 5933.762649493972, 6088.786892458831, 1813.274690123961, 1818.6362727454562, 1826.059579316653, 1837.9632407351778, 1845.4740398986226, 907.3059109780891, 911.0616065452595, 915.0803442540205, 991.504247876062, 1052.55792567122, 16160.191990400433, 16440.424585139463, 16486.75269870953, 16591.004539727655, 17065.488035358958, 986.6891929042329, 1004.6885465505717, 1018.8166130096654, 1026.225199974015, 1027.7893031928436, 9559.808803824024, 9644.517774111266, 9810.313278070467, 9856.162226210708, 9959.352642078242, 399961.0, 409237.0, 409508.477033766, 411556.0, 414093.0, 62049.37950620526, 64674.0, 65503.344966549725, 66156.0, 67019.0, 1033.4677641014882, 1055.9683209503573, 1071.5178169823455, 1074.854894589236, 1087.119433259047, 14446.494372697325, 14744.0, 14824.7776283358, 14919.104853708812, 15089.924550377178, 31013.0, 31607.367852642357, 31885.521717174724, 31949.68050319467, 31974.200644984063, 40549.0, 42174.578254217064, 42445.36331955085, 42451.15097697967, 42683.786581066895, 7361.779146625609, 7449.776506704808, 7577.204393538819, 7614.086309642878, 7630.0, 9729.221662267144, 10869.29349592274, 11279.210455268052, 11525.942370288094, 11540.94229528847, 8893.777655558662, 9399.765005874908, 9605.711828645151, 9702.611895524382, 10096.596136154472, 9314.813703726024, 9325.440473571607, 9668.516574171404, 9728.610855565697, 9802.313838031268, 9353.298502612468, 9525.618975240914, 9692.660756873476, 9799.510024498604, 10180.796384072426, 7456.925430745623, 7596.8480630385975, 7634.198409167179, 7664.693412263447, 7871.803204919923, 9062.320325975446, 9369.906300936904, 9651.034896510293, 9805.754856128653, 10013.799724005334], "unit": "score", "name": "jquery.html", "value": 8220.02014128416}, {"lowerIsBetter": false, "replicates": [1497.760358342665, 1511.8488151184883, 1713.982860171398, 1800.5858652509914, 1837.3110083718614, 6901.792946211609, 7522.699092036312, 7595.354394876435, 7802.765917022484, 7833.725819596315, 7598.39212862971, 7618.96190519048, 7636.847263054749, 7690.077190737119, 7722.034745656793, 2280.5780930527862, 2310.8844557772127, 2320.7679232076825, 2324.151684635113, 2324.6280595104786, 2257.2776711452343, 2284.314705588317, 2287.2909398086563, 2293.243229734192, 2295.036084844361, 2272.488690044735, 2279.0314116500504, 2297.471581536248, 2316.4324740438533, 2330.7902288794007, 2266.263464374085, 2267.875266860322, 2274.226762900605, 2277.419258089193, 2282.132789539981, 2288.988555057214, 2292.117534749117, 2294.89672964717, 2299.471121642015, 2302.861828290308, 7799.0641123065025, 7825.452218344718, 7827.491213071189, 7848.2151784821635, 7849.68601255949, 4713.693609915379, 4821.807127714887, 4828.830990915336, 4831.782569784333, 4845.636577256684, 2919.44530539199, 2939.426811771705, 3064.0, 3064.2033071401374, 3081.876724931, 946.8248374050754, 958.2046901072093, 967.4195482710388, 989.4211886046671, 994.6021591363512, 10681.572737090508, 10713.196510261683, 10718.0, 10748.677539673823, 10751.731206719816, 4287.292596721569, 4314.288142456522, 4397.494288156839, 4413.426254586883, 4423.845165419195, 9176.495292758962, 9180.44917304964, 9184.03567625403, 9199.264058875275, 9217.262618990464, 4848.17581011229, 4861.197902346144, 4868.464468908417, 4874.561289483963, 4901.607871370282, 3911.9804400978383, 4269.103488267437, 4306.82772689089, 4314.61168494837, 4420.336949457607, 3677.724170687209, 3689.6679298862696, 3700.2599480104086, 3727.0309719473134, 3729.0, 1178.7524619829933, 1185.105245539612, 1187.6615164678199, 1187.703074231442, 1191.53530123252, 1260.87391260875, 1265.5697062998624, 1275.776739070659, 1305.9934700326437, 1306.203216038216, 6993.930060699429, 7101.467389945775, 7120.71517139319, 7147.392471639969, 7153.284671532909, 1127.0814286356592, 1142.2004596782285, 1148.2249481599886, 1154.6824623228679, 1163.941802909851, 5739.13912913058, 5774.422557744192, 5793.2179155814265, 5808.970955145197, 5820.0, 9163.541822908828, 9225.169734723908, 9472.810543789223, 9577.090176433228, 9588.952055239679, 9373.250139988784, 9455.14903658674, 9462.479563624067, 9469.905300946903, 9501.382410143318, 7243.7464688735645, 7326.633668316669, 7412.369948554326, 7469.141048779351, 7481.21447248042, 6873.759418420332, 6888.724451021903, 6900.6204658744255, 6920.5847649141215, 6930.5148639594745, 8127.187281271826, 8355.331573473986, 8488.236058754741, 8496.192861678132, 8503.107173746916, 8509.511629765766, 8590.82818343642, 8662.480251184948, 8760.78098047554, 8778.517181555077, 5762.2221000164445, 6045.667488288186, 6173.444390004921, 6547.803565893031, 6666.533342665967, 7278.96360518194, 7300.306470885257, 7340.70637174507, 7349.926500734924, 7355.227701091522, 6341.587796793194, 6539.149910511603, 6544.574602650812, 6582.868342633024, 6656.334366563305, 6466.353364663496, 6552.6068435894, 6578.901316480353, 6595.835104122435, 6619.007148927507, 6886.208086069965, 6901.827454313682, 6908.44732421395, 6930.099087118642, 6940.757073502605, 6190.50475961913, 6279.529035322278, 6282.4974002080635, 6305.432511074026, 6317.778877739441, 6347.39699728525, 6351.2696039956, 6360.204974378203, 6367.3314301997625, 6383.106365108795], "unit": "score", "name": "mootools.html", "value": 4482.304535444479}, {"lowerIsBetter": false, "replicates": [330.2931726106133, 342.43498227923914, 342.6778827901772, 346.9340825243205, 351.1607258651824, 6232.813015609528, 6329.050642403642, 6342.651154186524, 6377.043443483474, 6378.330275321083, 6218.595791273564, 6256.061590761388, 6262.2172228471445, 6268.968655156717, 6270.184875966118, 4642.373279607261, 4724.24412094065, 4771.308160316769, 4790.856274311759, 4828.927566086511, 4740.620750339982, 4746.976265118669, 4748.4301883774, 4773.236282194849, 4784.97607511962, 4669.556392142741, 4693.131770622429, 4699.412573428322, 4702.90594188116, 4709.693869898463, 4698.154332220216, 4703.412073490814, 4703.882402939937, 4730.479647238801, 4735.12400205963, 4147.730397524181, 4148.585141485857, 4152.667786577066, 4154.0, 4155.958440415618, 6002.909956350658, 6006.699665016732, 6011.639301641915, 6015.09773533969, 6019.097135429677, 5350.5184533392185, 5540.113581826889, 5548.500634942875, 5549.417311182348, 5572.164175373686, 6627.867442651168, 6631.303713110102, 6642.867142657168, 6645.66771661415, 6646.036324732887, 4560.8859778505475, 4576.8626941191815, 4578.35902973584, 4590.0, 4599.977000115012, 6860.211075726305, 6906.930930690679, 6938.202106757686, 6967.372936435796, 6978.302169783032, 4659.324397962277, 4663.230566956414, 4678.087772884323, 4704.1062198182235, 4725.794922294862, 4588.334691469719, 4722.409698787652, 4737.147313483537, 4737.336772851803, 4744.979829336709, 5503.669779813224, 5504.697241651747, 5509.972450137724, 5516.8966206758805, 5553.0, 6675.265720770712, 6688.966555167291, 6711.094002309724, 6716.899246511306, 6719.798406047827, 1670.9164541773107, 1696.1943077038309, 1696.9660606787795, 1696.991515042417, 1698.0915210362398, 1093.2128867215592, 1113.0372228022864, 1117.4245263689206, 1124.2186680257144, 1139.9658010259704, 6297.023961285917, 6322.33615470369, 6324.873502529924, 6327.303996560375, 6329.620222786648, 6831.69257383419, 6882.724691012303, 6898.1377327834025, 6911.6544172791155, 6917.066196063568, 6132.172156758869, 6218.06728990655, 6256.968715156395, 6355.777547785805, 6399.9040014399825, 3729.8135093245774, 3733.3093377724663, 3765.284595926765, 3772.86794962175, 3778.1499162688174, 7267.527610705287, 7301.59841208728, 7322.63386830667, 7332.8900066499045, 7345.045144131335, 7138.179109402381, 7141.535800172972, 7142.5000249982, 7157.964210178916, 7170.426365890717, 7165.24764899678, 7315.4147668186415, 7321.267873212636, 7339.633018349168, 7344.522606030698, 6945.305469453015, 6977.825554361181, 6983.301669832976, 6986.091808064919, 6992.1958974718555, 6888.0, 6890.8621827562165, 6897.7585784497305, 6902.585844849325, 6906.482013849082, 7267.236940121423, 7282.563046217244, 7303.269673032654, 7312.378447831781, 7323.560586364835, 4564.360989461545, 4684.1334353144775, 4696.906061878675, 4698.906021879475, 4713.6936099153445, 6919.446444284345, 6949.478789090737, 6956.826079348057, 6966.3730264276455, 6969.895451568332, 6703.061571380108, 6714.899276510759, 6717.16035495563, 6757.087793147862, 6759.966200168968, 6752.69612867432, 6761.256261811099, 6764.458843292623, 6765.594064356154, 6781.152355955505, 6468.062130991074, 6544.9672751637845, 6619.238787539494, 6648.767293144717, 6649.202095748541, 6788.151481064867, 6791.89812152828, 6799.524033317818, 6812.761553345609, 6814.1482314710665, 6564.343565643398, 6614.305497922841, 6642.4686025118845, 6645.069690243273, 6655.767048153291], "unit": "score", "name": "prototype.html", "value": 5032.48819586051}, {"lowerIsBetter": false, "replicates": [714.8355878148026, 726.0, 732.8131326511739, 735.4741359927652, 765.2997507280837, 12801.167924084928, 13124.934375328123, 13155.473781048759, 14257.643558911032, 14556.636084097903, 13927.930360348184, 13997.930010349934, 14018.088824226417, 14079.225642589654, 14082.929585352085, 821.4414198345123, 829.1873963515758, 847.0301504777027, 847.894013248344, 861.1431625532604, 846.6020970144053, 847.4068152293419, 848.9448185867899, 849.8852654891572, 852.0116664668985, 876.408424313589, 878.0253918150847, 885.0397318908991, 885.2563846369048, 888.3159966825541, 877.627008521379, 880.1990188928077, 884.0805562215321, 885.2298500304712, 886.9911300886973, 655.3708439897704, 659.8185498987768, 659.8251463362213, 660.0725979998062, 660.207750699163, 13522.594322170351, 13553.457861685521, 13554.661133471644, 13570.389332479963, 13603.115797473132, 12058.879411205864, 12155.756884862341, 12301.569445069379, 12504.437300321417, 12652.68368290791, 10338.84491732617, 10394.740131496774, 10478.266521343508, 10512.264141510097, 10690.572377104907, 3545.946810797814, 3551.236484155919, 3554.608993010767, 3571.535700358963, 3679.871204507856, 50009.24986125211, 50217.497825022016, 50870.7456462719, 50994.49005509935, 51219.0, 8573.871391929126, 8584.39909206362, 8721.345899057596, 8927.687530936386, 8970.461772293684, 17806.46580602584, 17950.820491795177, 17954.461366159037, 18021.819781802013, 18086.819131808777, 7356.632168391666, 7608.467407281548, 7627.618619069135, 7753.961230193813, 7800.219978002267, 4220.388043733703, 4248.299030659969, 4337.7614231217585, 4410.676796960899, 4444.133393988206, 3103.0690792762534, 3128.311771410286, 3131.232847952266, 3137.1529686984386, 3146.685331466835, 594.47983014862, 594.9018411962064, 598.2880372356882, 599.7690889007763, 608.7199888051546, 528.7937704295327, 558.3216392083557, 559.6949662433983, 595.9165716799652, 645.3385280087854, 7241.813602015097, 7395.186529481753, 7589.196731114255, 7662.693492260359, 7711.421643376657, 520.7292208051867, 551.5008916930185, 588.690937257943, 597.5130268830889, 609.622034338704, 3579.6957258632788, 3730.9067273318383, 3742.4386342048365, 3743.887683369503, 3745.2135051638916, 54706.0, 56150.43849561452, 56636.43363566394, 57293.427065729644, 57958.42041579614, 50404.0, 51333.743331283855, 51496.74251628718, 51728.48271517312, 51776.482235177165, 44332.3350149748, 45670.771646141555, 46136.3079553807, 47383.52616473791, 47580.7620961893, 7420.888686669812, 7454.0, 7512.13610434807, 7576.545407275581, 7792.37660987131, 32627.67372326341, 33080.0, 33347.83326083354, 33993.660063400035, 34577.48133777945, 38800.0, 38988.415173772984, 40365.59634403736, 41834.790826045675, 42070.0, 10423.895761042595, 10542.947285263524, 10657.840132397865, 10668.8933110671, 11152.832707509231, 11928.343941083323, 11945.16383853122, 11994.0, 12361.320127393079, 12979.221246725227, 10278.17774578017, 10377.948110259702, 10798.622048228588, 10803.675889723321, 10957.232993690364, 10770.676879693621, 10853.34879907208, 10927.235093543375, 11105.278156919774, 11498.482568284615, 10690.465476725976, 10900.291481053706, 10958.780824383308, 11047.72380690489, 11120.054795342487, 9835.754106147404, 10010.64962726301, 10015.649452269136, 10147.238957078102, 10178.745531361776, 8242.587870606325, 8431.28334091609, 8714.25928796034, 9156.862647060167, 9164.862527062232], "unit": "score", "name": "yui.html", "value": 6181.033358861755}], "name": "dromaeo_css", "value": 6880.365669247605}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 114.0, 112.0, 113.0, 124.0, 112.0, 111.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [158.0, 128.0, 153.0, 170.0, 128.0, 151.0, 157.0, 130.0, 169.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 166.0, 162.0, 166.0, 163.0, 162.0, 173.0, 168.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.8}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 74.0, 74.0, 78.0, 72.0, 71.0, 73.0, 139.0, 76.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 146.0, 94.0, 95.0, 94.0, 144.0, 93.0, 95.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 97.0, 98.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 58.0, 58.0, 58.0, 60.0, 57.0, 63.0, 60.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 70.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 89.0, 83.0, 84.0, 83.0, 82.0, 83.0, 85.0, 93.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [122.0, 128.0, 123.0, 117.0, 119.0, 119.0, 124.0, 128.0, 126.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.3}, {"lowerIsBetter": true, "replicates": [143.0, 164.0, 156.0, 163.0, 143.0, 145.0, 150.0, 150.0, 150.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.6}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 73.0, 71.0, 69.0, 68.0, 69.0, 69.0, 70.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1530.6}]} 04:29:38 INFO - Return code: 0 04:29:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:29:38 ERROR - # TBPL SUCCESS # 04:29:38 INFO - Running post-action listener: _resource_record_post_action 04:29:38 INFO - Running post-run listener: _resource_record_post_run 04:29:39 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 258048; Write bytes: 295821312; Read time: 120; Write time: 179704 04:29:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5189632; Read time: 0; Write time: 456 04:29:39 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 258048; Write bytes: 290631680; Read time: 120; Write time: 179248 04:29:39 INFO - Running post-run listener: _upload_blobber_files 04:29:39 INFO - Blob upload gear active. 04:29:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:29:39 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 04:29:39 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 04:29:39 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 04:29:39 INFO - (blobuploader) - INFO - Open directory for files ... 04:29:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:29:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:29:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:40 INFO - (blobuploader) - INFO - Done attempting. 04:29:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:29:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:29:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:41 INFO - (blobuploader) - INFO - Done attempting. 04:29:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:29:41 INFO - Return code: 0 04:29:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:29:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:29:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/34f0e70532ef03ecad513af526d2f80f587d40e582756f586adeb1d389f25325c546e326aca18cea6f85d49212716983e61d61e6097d46bc3b30dab7d61d16e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2a8f38e8d1d9c65a39949d001689ed36e343b6e9b03b5efa2c5353c7ee6032728db549bad7bec0b7ab6dd8c1d7ea8876751111a7b9b122c0c35af8b96abae450"} 04:29:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:29:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:29:41 INFO - Contents: 04:29:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/34f0e70532ef03ecad513af526d2f80f587d40e582756f586adeb1d389f25325c546e326aca18cea6f85d49212716983e61d61e6097d46bc3b30dab7d61d16e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2a8f38e8d1d9c65a39949d001689ed36e343b6e9b03b5efa2c5353c7ee6032728db549bad7bec0b7ab6dd8c1d7ea8876751111a7b9b122c0c35af8b96abae450"} 04:29:41 INFO - Running post-run listener: copy_logs_to_upload_dir 04:29:41 INFO - Copying logs to upload dir... 04:29:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 04:29:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.945154 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-11 04:29:41.308868) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 04:29:41.312641) ========= 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=337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670 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/Mozilla-Inbound/sha512/34f0e70532ef03ecad513af526d2f80f587d40e582756f586adeb1d389f25325c546e326aca18cea6f85d49212716983e61d61e6097d46bc3b30dab7d61d16e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2a8f38e8d1d9c65a39949d001689ed36e343b6e9b03b5efa2c5353c7ee6032728db549bad7bec0b7ab6dd8c1d7ea8876751111a7b9b122c0c35af8b96abae450"} build_url:https://queue.taskcluster.net/v1/task/XaZHrwGPQim5gDZWxurXgg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://queue.taskcluster.net/v1/task/XaZHrwGPQim5gDZWxurXgg/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/Mozilla-Inbound/sha512/34f0e70532ef03ecad513af526d2f80f587d40e582756f586adeb1d389f25325c546e326aca18cea6f85d49212716983e61d61e6097d46bc3b30dab7d61d16e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2a8f38e8d1d9c65a39949d001689ed36e343b6e9b03b5efa2c5353c7ee6032728db549bad7bec0b7ab6dd8c1d7ea8876751111a7b9b122c0c35af8b96abae450"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 04:29:41.337472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 04:29:41.337786) ========= 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=337fe3f4b1febe37b85fccc40000019e-1457697831.977629-70744670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 04:29:41.422535) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 04:29:41.422920) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 04:29:41.423282) ========= ========= Total master_lag: 0.23 =========