builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1459210456.83 results: success (0) buildid: 20160328143033 builduid: 188a35ba87ef4d4cb08166af3de2dde2 revision: 971ee95dade06b20742e94d58c471e76705ca478 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:16.831800) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:16.832252) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:16.832549) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006313 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:16.855964) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:16.856279) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:16.875932) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:16.876276) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004697 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:16.950583) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:16.950848) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:16.951422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:16.951698) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-28 17:14:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-03-28 17:14:19 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162011 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:17.125668) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:17.125961) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022372 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:17.178605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:17.178947) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 971ee95dade06b20742e94d58c471e76705ca478 --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/fx-team --rev 971ee95dade06b20742e94d58c471e76705ca478 --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=a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-28 17:14:19,438 truncating revision to first 12 chars 2016-03-28 17:14:19,438 Setting DEBUG logging. 2016-03-28 17:14:19,438 attempt 1/10 2016-03-28 17:14:19,438 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/971ee95dade0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-28 17:14:19,830 unpacking tar archive at: fx-team-971ee95dade0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.720903 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:17.912085) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:17.912403) ========= echo 971ee95dade06b20742e94d58c471e76705ca478 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'971ee95dade06b20742e94d58c471e76705ca478'] 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=a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 971ee95dade06b20742e94d58c471e76705ca478 program finished with exit code 0 elapsedTime=0.003125 script_repo_revision: '971ee95dade06b20742e94d58c471e76705ca478' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:17.959914) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:17.960244) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 17:14:17.970384) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-28 17:14:17.970650) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:14:20 INFO - MultiFileLogger online at 20160328 17:14:20 in /builds/slave/test-pgo 17:14:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:14:20 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:14:20 INFO - {'append_to_log': False, 17:14:20 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:14:20 INFO - 'blob_upload_branch': 'Fx-Team', 17:14:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:14:20 INFO - 'branch': 'Fx-Team', 17:14:20 INFO - 'buildbot_json_path': 'buildprops.json', 17:14:20 INFO - 'config_files': ('talos/linux_config.py',), 17:14:20 INFO - 'default_actions': ('clobber', 17:14:20 INFO - 'read-buildbot-config', 17:14:20 INFO - 'download-and-extract', 17:14:20 INFO - 'populate-webroot', 17:14:20 INFO - 'create-virtualenv', 17:14:20 INFO - 'install', 17:14:20 INFO - 'run-tests'), 17:14:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:14:20 INFO - 'download_minidump_stackwalk': True, 17:14:20 INFO - 'download_symbols': 'ondemand', 17:14:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:14:20 INFO - 'tooltool.py': '/tools/tooltool.py', 17:14:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:14:20 INFO - '/tools/misc-python/virtualenv.py')}, 17:14:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:14:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:14:20 INFO - 'installer_path': 'installer.exe', 17:14:20 INFO - 'log_level': 'info', 17:14:20 INFO - 'log_name': 'talos', 17:14:20 INFO - 'log_to_console': True, 17:14:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:14:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:14:20 INFO - 'opt_config_files': (), 17:14:20 INFO - 'pip_index': False, 17:14:20 INFO - 'sps_profile': False, 17:14:20 INFO - 'sps_profile_interval': 0, 17:14:20 INFO - 'suite': 'dromaeojs-e10s', 17:14:20 INFO - 'system_bits': '32', 17:14:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:14:20 INFO - 'title': 'talos-linux64-ix-064', 17:14:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:14:20 INFO - 'use_talos_json': True, 17:14:20 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:14:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:14:20 INFO - 'work_dir': 'build'} 17:14:20 INFO - ##### 17:14:20 INFO - ##### Running clobber step. 17:14:20 INFO - ##### 17:14:20 INFO - Running pre-action listener: _resource_record_pre_action 17:14:20 INFO - Running main action method: clobber 17:14:20 INFO - rmtree: /builds/slave/test-pgo/build 17:14:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:14:20 INFO - Running post-action listener: _resource_record_post_action 17:14:20 INFO - ##### 17:14:20 INFO - ##### Running read-buildbot-config step. 17:14:20 INFO - ##### 17:14:20 INFO - Running pre-action listener: _resource_record_pre_action 17:14:20 INFO - Running main action method: read_buildbot_config 17:14:20 INFO - Using buildbot properties: 17:14:20 INFO - { 17:14:20 INFO - "project": "", 17:14:20 INFO - "product": "firefox", 17:14:20 INFO - "script_repo_revision": "production", 17:14:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:14:20 INFO - "repository": "", 17:14:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:14:20 INFO - "buildid": "20160328143033", 17:14:20 INFO - "pgo_build": "True", 17:14:20 INFO - "basedir": "/builds/slave/test-pgo", 17:14:20 INFO - "buildnumber": 253, 17:14:20 INFO - "slavename": "talos-linux64-ix-064", 17:14:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:14:20 INFO - "platform": "ubuntu64_hw", 17:14:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:14:20 INFO - "branch": "fx-team", 17:14:20 INFO - "repo_path": "integration/fx-team", 17:14:20 INFO - "revision": "971ee95dade06b20742e94d58c471e76705ca478", 17:14:20 INFO - "stage_platform": "linux64-pgo", 17:14:20 INFO - "builduid": "188a35ba87ef4d4cb08166af3de2dde2", 17:14:20 INFO - "slavebuilddir": "test" 17:14:20 INFO - } 17:14:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:14:20 INFO - Running post-action listener: _resource_record_post_action 17:14:20 INFO - ##### 17:14:20 INFO - ##### Running download-and-extract step. 17:14:20 INFO - ##### 17:14:20 INFO - Running pre-action listener: _resource_record_pre_action 17:14:20 INFO - Running main action method: download_and_extract 17:14:20 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:14: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')]} 17:14:20 INFO - https://queue.taskcluster.net/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:14:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:14:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:14:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/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 17:14:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/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 17:14:21 INFO - Downloaded 1361 bytes. 17:14:21 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:14:21 INFO - Using the following test package requirements: 17:14:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:14:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:14:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:14:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:21 INFO - u'jsshell-linux-x86_64.zip'], 17:14:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:14:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:14:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:14:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:14:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:14:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:14:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:21 INFO - https://queue.taskcluster.net/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:14:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:14:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:14:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/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 17:14:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/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 17:14:23 INFO - Downloaded 23655828 bytes. 17:14:23 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'] 17:14:23 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 17:14:24 INFO - Return code: 0 17:14:24 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 17:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:24 INFO - https://queue.taskcluster.net/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:14:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:14:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:14:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/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 17:14:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/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 17:14:30 INFO - Downloaded 23655828 bytes. 17:14:30 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'] 17:14:30 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 17:14:31 INFO - Return code: 0 17:14: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')]} 17:14:31 INFO - https://queue.taskcluster.net/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:14:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:14:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:14:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/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 17:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/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 17:14:32 INFO - Downloaded 10847531 bytes. 17:14:32 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'] 17:14:32 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 17:14:32 INFO - Return code: 0 17:14:32 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')]} 17:14:32 INFO - https://queue.taskcluster.net/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:14:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:14:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:14:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/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 17:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/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 17:14:35 INFO - Downloaded 57717952 bytes. 17:14:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:14:35 INFO - mkdir: /builds/slave/test-pgo/properties 17:14:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:14:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:14:35 INFO - Contents: 17:14:35 INFO - build_url:https://queue.taskcluster.net/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:14:36 INFO - Running post-action listener: _resource_record_post_action 17:14:36 INFO - Running post-action listener: set_extra_try_arguments 17:14:36 INFO - ##### 17:14:36 INFO - ##### Running populate-webroot step. 17:14:36 INFO - ##### 17:14:36 INFO - Running pre-action listener: _resource_record_pre_action 17:14:36 INFO - Running main action method: populate_webroot 17:14:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:14:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:14:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:14:36 INFO - '--tppagecycles', 17:14:36 INFO - '7'], 17:14:36 INFO - 'tests': ['tsvgm']}}, 17:14:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:14:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:14:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:14:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:14:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:14:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:14:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:14:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:36 INFO - 'talos_options': ['--e10s'], 17:14:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:14:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:36 INFO - 'tests': ['damp', 'tps']}, 17:14:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:36 INFO - 'talos_options': ['--e10s'], 17:14:36 INFO - 'tests': ['damp', 'tps']}, 17:14:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:14:36 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 17:14:36 INFO - 'tests': ['dromaeo_dom']}, 17:14:36 INFO - 'other': {'tests': ['a11yr', 17:14:36 INFO - 'ts_paint', 17:14:36 INFO - 'tpaint', 17:14:36 INFO - 'sessionrestore', 17:14:36 INFO - 'sessionrestore_no_auto_restore', 17:14:36 INFO - 'tabpaint']}, 17:14:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:14:36 INFO - 'tests': ['a11yr', 17:14:36 INFO - 'ts_paint', 17:14:36 INFO - 'tpaint', 17:14:36 INFO - 'sessionrestore', 17:14:36 INFO - 'sessionrestore_no_auto_restore', 17:14:36 INFO - 'tabpaint']}, 17:14:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:14:36 INFO - 'tests': ['a11yr', 17:14:36 INFO - 'ts_paint', 17:14:36 INFO - 'tpaint', 17:14:36 INFO - 'sessionrestore', 17:14:36 INFO - 'sessionrestore_no_auto_restore', 17:14:36 INFO - 'tabpaint']}, 17:14:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:14:36 INFO - 'tests': ['a11yr', 17:14:36 INFO - 'ts_paint', 17:14:36 INFO - 'tpaint', 17:14:36 INFO - 'sessionrestore', 17:14:36 INFO - 'sessionrestore_no_auto_restore', 17:14:36 INFO - 'tabpaint']}, 17:14:36 INFO - 'other_l64': {'tests': ['a11yr', 17:14:36 INFO - 'ts_paint', 17:14:36 INFO - 'tpaint', 17:14:36 INFO - 'sessionrestore', 17:14:36 INFO - 'sessionrestore_no_auto_restore', 17:14:36 INFO - 'tabpaint']}, 17:14:36 INFO - 'other_nol64': {'tests': ['a11yr', 17:14:36 INFO - 'ts_paint', 17:14:36 INFO - 'tpaint', 17:14:36 INFO - 'sessionrestore', 17:14:36 INFO - 'sessionrestore_no_auto_restore', 17:14:36 INFO - 'tabpaint']}, 17:14:36 INFO - 'svgr': {'tests': ['tsvgx', 17:14:36 INFO - 'tsvgr_opacity', 17:14:36 INFO - 'tart', 17:14:36 INFO - 'tscrollx', 17:14:36 INFO - 'cart']}, 17:14:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:14:36 INFO - 'tests': ['tsvgx', 17:14:36 INFO - 'tsvgr_opacity', 17:14:36 INFO - 'tart', 17:14:36 INFO - 'tscrollx', 17:14:36 INFO - 'cart']}, 17:14:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:36 INFO - 'tests': ['tp5o']}, 17:14:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:36 INFO - 'talos_options': ['--e10s'], 17:14:36 INFO - 'tests': ['tp5o']}, 17:14:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:36 INFO - 'talos_options': ['--xperf_path', 17:14:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:14:36 INFO - 'tests': ['tp5n']}, 17:14:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:36 INFO - 'talos_options': ['--e10s', 17:14:36 INFO - '--xperf_path', 17:14:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:14:36 INFO - 'tests': ['tp5n']}}, 17:14:36 INFO - 'talos.zip': {'path': '', 17:14:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:14:36 INFO - Running post-action listener: _resource_record_post_action 17:14:36 INFO - ##### 17:14:36 INFO - ##### Running create-virtualenv step. 17:14:36 INFO - ##### 17:14:36 INFO - Running pre-action listener: _resource_record_pre_action 17:14:36 INFO - Running main action method: create_virtualenv 17:14:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:14:36 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 17:14:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:14:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:14:36 INFO - Using real prefix '/usr' 17:14:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:14:36 INFO - Installing distribute.............................................................................................................................................................................................done. 17:14:38 INFO - Installing pip.................done. 17:14:38 INFO - Return code: 0 17:14:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:14: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')]} 17:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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')]} 17:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34fa466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8b0>, '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 0x28ef7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28efc60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', '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 17:14:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 17:14:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:14:38 INFO - Using env: {'DISPLAY': ':0', 17:14:38 INFO - 'HOME': '/home/cltbld', 17:14:38 INFO - 'LANG': 'en_US.UTF-8', 17:14:38 INFO - 'LANGUAGE': 'en_US:en', 17:14:38 INFO - 'LOGNAME': 'cltbld', 17:14:38 INFO - 'MAIL': '/var/mail/cltbld', 17:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:38 INFO - 'MOZ_NO_REMOTE': '1', 17:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:38 INFO - 'NO_EM_RESTART': '1', 17:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:14:38 INFO - 'PWD': '/builds/slave/test-pgo', 17:14:38 INFO - 'SHELL': '/bin/bash', 17:14:38 INFO - 'SHLVL': '1', 17:14:38 INFO - 'TERM': 'linux', 17:14:38 INFO - 'TMOUT': '86400', 17:14:38 INFO - 'USER': 'cltbld', 17:14:38 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', 17:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:38 INFO - '_': '/tools/buildbot/bin/python'} 17:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:38 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 17:14:38 INFO - Cleaning up... 17:14:39 INFO - Return code: 0 17:14:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f34fa466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8b0>, '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 0x28ef7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28efc60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', '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 17:14:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 17:14:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:14:39 INFO - Using env: {'DISPLAY': ':0', 17:14:39 INFO - 'HOME': '/home/cltbld', 17:14:39 INFO - 'LANG': 'en_US.UTF-8', 17:14:39 INFO - 'LANGUAGE': 'en_US:en', 17:14:39 INFO - 'LOGNAME': 'cltbld', 17:14:39 INFO - 'MAIL': '/var/mail/cltbld', 17:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:39 INFO - 'MOZ_NO_REMOTE': '1', 17:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:39 INFO - 'NO_EM_RESTART': '1', 17:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:14:39 INFO - 'PWD': '/builds/slave/test-pgo', 17:14:39 INFO - 'SHELL': '/bin/bash', 17:14:39 INFO - 'SHLVL': '1', 17:14:39 INFO - 'TERM': 'linux', 17:14:39 INFO - 'TMOUT': '86400', 17:14:39 INFO - 'USER': 'cltbld', 17:14:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', 17:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:39 INFO - '_': '/tools/buildbot/bin/python'} 17:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:39 INFO - Downloading/unpacking psutil>=0.7.1 17:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:14:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:14:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:14:41 INFO - Installing collected packages: psutil 17:14:41 INFO - Running setup.py install for psutil 17:14:41 INFO - building 'psutil._psutil_linux' extension 17:14:41 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 17:14:41 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 17:14:41 INFO - building 'psutil._psutil_posix' extension 17:14:41 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 17:14:41 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 17:14:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:14:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:14:41 INFO - Successfully installed psutil 17:14:41 INFO - Cleaning up... 17:14:41 INFO - Return code: 0 17:14:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f34fa466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8b0>, '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 0x28ef7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28efc60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', '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 17:14:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:14:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:14:41 INFO - Using env: {'DISPLAY': ':0', 17:14:41 INFO - 'HOME': '/home/cltbld', 17:14:41 INFO - 'LANG': 'en_US.UTF-8', 17:14:41 INFO - 'LANGUAGE': 'en_US:en', 17:14:41 INFO - 'LOGNAME': 'cltbld', 17:14:41 INFO - 'MAIL': '/var/mail/cltbld', 17:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:41 INFO - 'MOZ_NO_REMOTE': '1', 17:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:41 INFO - 'NO_EM_RESTART': '1', 17:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:14:41 INFO - 'PWD': '/builds/slave/test-pgo', 17:14:41 INFO - 'SHELL': '/bin/bash', 17:14:41 INFO - 'SHLVL': '1', 17:14:41 INFO - 'TERM': 'linux', 17:14:41 INFO - 'TMOUT': '86400', 17:14:41 INFO - 'USER': 'cltbld', 17:14:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', 17:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:41 INFO - '_': '/tools/buildbot/bin/python'} 17:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:14:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:14:43 INFO - Installing collected packages: mozsystemmonitor 17:14:43 INFO - Running setup.py install for mozsystemmonitor 17:14:44 INFO - Successfully installed mozsystemmonitor 17:14:44 INFO - Cleaning up... 17:14:44 INFO - Return code: 0 17:14:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:14:44 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')]} 17:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:44 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')]} 17:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:44 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 0x7f34fa466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8b0>, '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 0x28ef7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28efc60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', '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 17:14:44 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 17:14:44 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 17:14:44 INFO - Using env: {'DISPLAY': ':0', 17:14:44 INFO - 'HOME': '/home/cltbld', 17:14:44 INFO - 'LANG': 'en_US.UTF-8', 17:14:44 INFO - 'LANGUAGE': 'en_US:en', 17:14:44 INFO - 'LOGNAME': 'cltbld', 17:14:44 INFO - 'MAIL': '/var/mail/cltbld', 17:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:44 INFO - 'MOZ_NO_REMOTE': '1', 17:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:44 INFO - 'NO_EM_RESTART': '1', 17:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:14:44 INFO - 'PWD': '/builds/slave/test-pgo', 17:14:44 INFO - 'SHELL': '/bin/bash', 17:14:44 INFO - 'SHLVL': '1', 17:14:44 INFO - 'TERM': 'linux', 17:14:44 INFO - 'TMOUT': '86400', 17:14:44 INFO - 'USER': 'cltbld', 17:14:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', 17:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:44 INFO - '_': '/tools/buildbot/bin/python'} 17:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:44 INFO - Downloading/unpacking blobuploader==1.2.4 17:14: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 17:14: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 17:14: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 17:14: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 17:14: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 17:14: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 17:14:46 INFO - Downloading blobuploader-1.2.4.tar.gz 17:14:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:14:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:14:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:46 INFO - Downloading docopt-0.6.1.tar.gz 17:14:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:14:47 INFO - Installing collected packages: blobuploader, requests, docopt 17:14:47 INFO - Running setup.py install for blobuploader 17:14:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:14:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:14:47 INFO - Running setup.py install for requests 17:14:47 INFO - Running setup.py install for docopt 17:14:47 INFO - Successfully installed blobuploader requests docopt 17:14:47 INFO - Cleaning up... 17:14:47 INFO - Return code: 0 17:14:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:47 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 0x7f34fa466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8b0>, '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 0x28ef7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28efc60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', '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 17:14:47 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 17:14:47 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 17:14:47 INFO - Using env: {'DISPLAY': ':0', 17:14:47 INFO - 'HOME': '/home/cltbld', 17:14:47 INFO - 'LANG': 'en_US.UTF-8', 17:14:47 INFO - 'LANGUAGE': 'en_US:en', 17:14:47 INFO - 'LOGNAME': 'cltbld', 17:14:47 INFO - 'MAIL': '/var/mail/cltbld', 17:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:47 INFO - 'MOZ_NO_REMOTE': '1', 17:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:47 INFO - 'NO_EM_RESTART': '1', 17:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:14:47 INFO - 'PWD': '/builds/slave/test-pgo', 17:14:47 INFO - 'SHELL': '/bin/bash', 17:14:47 INFO - 'SHLVL': '1', 17:14:47 INFO - 'TERM': 'linux', 17:14:47 INFO - 'TMOUT': '86400', 17:14:47 INFO - 'USER': 'cltbld', 17:14:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', 17:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:47 INFO - '_': '/tools/buildbot/bin/python'} 17:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:14:47 INFO - Running setup.py (path:/tmp/pip-FzyGcd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:14:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:14:47 INFO - Running setup.py (path:/tmp/pip-bU024x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:14:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:14:48 INFO - Running setup.py (path:/tmp/pip-3FFYun-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:14:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:14:48 INFO - Running setup.py (path:/tmp/pip-ykQ9JX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:14:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:14:48 INFO - Running setup.py (path:/tmp/pip-y3ycW7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:14:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:14:48 INFO - Running setup.py (path:/tmp/pip-G0nkiG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:14:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:14:48 INFO - Running setup.py (path:/tmp/pip-ZEWJfX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:14:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:14:48 INFO - Running setup.py (path:/tmp/pip-C06KRt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:14:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:14:48 INFO - Running setup.py (path:/tmp/pip-urtGJO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:14:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:14:48 INFO - Running setup.py (path:/tmp/pip-_qj6It-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:14:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:14:48 INFO - Running setup.py (path:/tmp/pip-0sAP9e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:14:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:14:48 INFO - Running setup.py (path:/tmp/pip-uBaWjV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:14:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:14:48 INFO - Running setup.py (path:/tmp/pip-YAz1mK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:14:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:14:48 INFO - Running setup.py (path:/tmp/pip-egiY6k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:14:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:14:48 INFO - Running setup.py (path:/tmp/pip-dGMffk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:14:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:14:48 INFO - Running setup.py (path:/tmp/pip-Di6KdC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:14:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:14:49 INFO - Running setup.py (path:/tmp/pip-rDSs8t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:14:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:14:49 INFO - Running setup.py install for manifestparser 17:14:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:14:49 INFO - Running setup.py install for mozcrash 17:14:49 INFO - Running setup.py install for mozdebug 17:14:49 INFO - Running setup.py install for mozdevice 17:14:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:14:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:14:49 INFO - Running setup.py install for mozfile 17:14:49 INFO - Running setup.py install for mozhttpd 17:14:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:14:49 INFO - Running setup.py install for mozinfo 17:14:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:14:49 INFO - Running setup.py install for mozInstall 17:14:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:14:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:14:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:14:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:14:49 INFO - Running setup.py install for mozleak 17:14:50 INFO - Running setup.py install for mozlog 17:14:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:14:50 INFO - Running setup.py install for moznetwork 17:14:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:14:50 INFO - Running setup.py install for mozprocess 17:14:50 INFO - Running setup.py install for mozprofile 17:14:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:14:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:14:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:14:50 INFO - Running setup.py install for mozrunner 17:14:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:14:50 INFO - Running setup.py install for mozscreenshot 17:14:50 INFO - Running setup.py install for moztest 17:14:50 INFO - Running setup.py install for mozversion 17:14:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:14:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:14:50 INFO - Cleaning up... 17:14:50 INFO - Return code: 0 17:14:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:14:50 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')]} 17:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:50 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')]} 17:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:50 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 0x7f34fa466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8b0>, '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 0x28ef7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28efc60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', '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 17:14:50 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 17:14:50 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 17:14:50 INFO - Using env: {'DISPLAY': ':0', 17:14:50 INFO - 'HOME': '/home/cltbld', 17:14:50 INFO - 'LANG': 'en_US.UTF-8', 17:14:50 INFO - 'LANGUAGE': 'en_US:en', 17:14:50 INFO - 'LOGNAME': 'cltbld', 17:14:50 INFO - 'MAIL': '/var/mail/cltbld', 17:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:50 INFO - 'MOZ_NO_REMOTE': '1', 17:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:50 INFO - 'NO_EM_RESTART': '1', 17:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:14:50 INFO - 'PWD': '/builds/slave/test-pgo', 17:14:50 INFO - 'SHELL': '/bin/bash', 17:14:50 INFO - 'SHLVL': '1', 17:14:50 INFO - 'TERM': 'linux', 17:14:50 INFO - 'TMOUT': '86400', 17:14:50 INFO - 'USER': 'cltbld', 17:14:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', 17:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:50 INFO - '_': '/tools/buildbot/bin/python'} 17:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:14:51 INFO - Running setup.py (path:/tmp/pip-KDuXQa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:14:51 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)) 17:14:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:14:51 INFO - Running setup.py (path:/tmp/pip-rsZsB5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:14:51 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)) 17:14:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:14:51 INFO - Running setup.py (path:/tmp/pip-rRPNBD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:14:51 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)) 17:14:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:14:51 INFO - Running setup.py (path:/tmp/pip-R1yrb4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:14:51 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)) 17:14:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:14:51 INFO - Running setup.py (path:/tmp/pip-42y5Mv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:14:51 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)) 17:14:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:14:51 INFO - Running setup.py (path:/tmp/pip-PST1V6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:14:51 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)) 17:14:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:14:51 INFO - Running setup.py (path:/tmp/pip-8dgquB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:14:51 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)) 17:14:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:14:51 INFO - Running setup.py (path:/tmp/pip-fFv74U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:14:51 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)) 17:14:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:14:51 INFO - Running setup.py (path:/tmp/pip-fBiLcM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:14:51 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)) 17:14:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:14:51 INFO - Running setup.py (path:/tmp/pip-Rz4LSv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:14:51 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)) 17:14:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:14:51 INFO - Running setup.py (path:/tmp/pip-wZXQVr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:14:51 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)) 17:14:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:14:51 INFO - Running setup.py (path:/tmp/pip-FbsnWO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:14:52 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)) 17:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:14:52 INFO - Running setup.py (path:/tmp/pip-A2BtH6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:14:52 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)) 17:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:14:52 INFO - Running setup.py (path:/tmp/pip-6CabPh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:14:52 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)) 17:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:14:52 INFO - Running setup.py (path:/tmp/pip-dmdgNw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:14:52 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)) 17:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:14:52 INFO - Running setup.py (path:/tmp/pip-VBankx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:14:52 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)) 17:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:14:52 INFO - Running setup.py (path:/tmp/pip-9H6JOn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:14:52 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)) 17:14:52 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)) 17:14:52 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)) 17:14:52 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)) 17:14:52 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)) 17:14:52 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)) 17:14:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:54 INFO - Downloading blessings-1.6.tar.gz 17:14:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:14:54 INFO - Installing collected packages: blessings 17:14:54 INFO - Running setup.py install for blessings 17:14:54 INFO - Successfully installed blessings 17:14:54 INFO - Cleaning up... 17:14:54 INFO - Return code: 0 17:14:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:14:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:14:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:14:54 INFO - Reading from file tmpfile_stdout 17:14:54 INFO - Current package versions: 17:14:54 INFO - argparse == 1.2.1 17:14:54 INFO - blessings == 1.6 17:14:54 INFO - blobuploader == 1.2.4 17:14:54 INFO - docopt == 0.6.1 17:14:54 INFO - manifestparser == 1.1 17:14:54 INFO - mozInstall == 1.12 17:14:54 INFO - mozcrash == 0.17 17:14:54 INFO - mozdebug == 0.1 17:14:54 INFO - mozdevice == 0.48 17:14:54 INFO - mozfile == 1.2 17:14:54 INFO - mozhttpd == 0.7 17:14:54 INFO - mozinfo == 0.9 17:14:54 INFO - mozleak == 0.1 17:14:54 INFO - mozlog == 3.1 17:14:54 INFO - moznetwork == 0.27 17:14:54 INFO - mozprocess == 0.22 17:14:54 INFO - mozprofile == 0.28 17:14:54 INFO - mozrunner == 6.11 17:14:54 INFO - mozscreenshot == 0.1 17:14:54 INFO - mozsystemmonitor == 0.0 17:14:54 INFO - moztest == 0.7 17:14:54 INFO - mozversion == 1.4 17:14:54 INFO - psutil == 3.1.1 17:14:54 INFO - requests == 1.2.3 17:14:54 INFO - wsgiref == 0.1.2 17:14:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:14:54 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')]} 17:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:54 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')]} 17:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:54 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 0x7f34fa466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8b0>, '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 0x28ef7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28efc60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', '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 17:14:54 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 17:14:54 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 17:14:54 INFO - Using env: {'DISPLAY': ':0', 17:14:54 INFO - 'HOME': '/home/cltbld', 17:14:54 INFO - 'LANG': 'en_US.UTF-8', 17:14:54 INFO - 'LANGUAGE': 'en_US:en', 17:14:54 INFO - 'LOGNAME': 'cltbld', 17:14:54 INFO - 'MAIL': '/var/mail/cltbld', 17:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:54 INFO - 'MOZ_NO_REMOTE': '1', 17:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:54 INFO - 'NO_EM_RESTART': '1', 17:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:14:54 INFO - 'PWD': '/builds/slave/test-pgo', 17:14:54 INFO - 'SHELL': '/bin/bash', 17:14:54 INFO - 'SHLVL': '1', 17:14:54 INFO - 'TERM': 'linux', 17:14:54 INFO - 'TMOUT': '86400', 17:14:54 INFO - 'USER': 'cltbld', 17:14:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', 17:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:54 INFO - '_': '/tools/buildbot/bin/python'} 17:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:55 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)) 17:14:55 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)) 17:14:55 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)) 17:14:55 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)) 17:14:55 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)) 17:14:55 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)) 17:14:55 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)) 17:14:55 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)) 17:14:55 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)) 17:14:55 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)) 17:14:55 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)) 17:14:55 INFO - Cleaning up... 17:14:55 INFO - Return code: 0 17:14:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:55 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 0x7f34fa466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8b0>, '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 0x28ef7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28efc60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', '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 17:14:55 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 17:14:55 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 17:14:55 INFO - Using env: {'DISPLAY': ':0', 17:14:55 INFO - 'HOME': '/home/cltbld', 17:14:55 INFO - 'LANG': 'en_US.UTF-8', 17:14:55 INFO - 'LANGUAGE': 'en_US:en', 17:14:55 INFO - 'LOGNAME': 'cltbld', 17:14:55 INFO - 'MAIL': '/var/mail/cltbld', 17:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:55 INFO - 'MOZ_NO_REMOTE': '1', 17:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:55 INFO - 'NO_EM_RESTART': '1', 17:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:14:55 INFO - 'PWD': '/builds/slave/test-pgo', 17:14:55 INFO - 'SHELL': '/bin/bash', 17:14:55 INFO - 'SHLVL': '1', 17:14:55 INFO - 'TERM': 'linux', 17:14:55 INFO - 'TMOUT': '86400', 17:14:55 INFO - 'USER': 'cltbld', 17:14:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', 17:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:55 INFO - '_': '/tools/buildbot/bin/python'} 17:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:55 INFO - Downloading/unpacking jsonschema 17:14:55 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 17:14:55 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 17:14:55 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 17:14:55 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 17:14:55 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 17:14:55 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 17:14:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:14:57 INFO - Downloading/unpacking functools32 (from jsonschema) 17:14:57 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 17:14:57 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 17:14:57 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 17:14:57 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 17:14:57 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 17:14:57 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 17:14:57 INFO - Downloading functools32-3.2.3-2.tar.gz 17:14:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:14:57 INFO - warning: no files found matching '*.txt' 17:14:57 INFO - no previously-included directories found matching 'build' 17:14:57 INFO - no previously-included directories found matching 'dist' 17:14:57 INFO - no previously-included directories found matching '.git*' 17:14:57 INFO - Installing collected packages: jsonschema, functools32 17:14:57 INFO - Running setup.py install for functools32 17:14:57 INFO - warning: no files found matching '*.txt' 17:14:57 INFO - no previously-included directories found matching 'build' 17:14:57 INFO - no previously-included directories found matching 'dist' 17:14:57 INFO - no previously-included directories found matching '.git*' 17:14:57 INFO - Successfully installed jsonschema functools32 17:14:57 INFO - Cleaning up... 17:14:57 INFO - Return code: 0 17:14:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:57 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 0x7f34fa466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285f8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ee8b0>, '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 0x28ef7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28efc60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', '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 17:14:57 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 17:14:57 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 17:14:57 INFO - Using env: {'DISPLAY': ':0', 17:14:57 INFO - 'HOME': '/home/cltbld', 17:14:57 INFO - 'LANG': 'en_US.UTF-8', 17:14:57 INFO - 'LANGUAGE': 'en_US:en', 17:14:57 INFO - 'LOGNAME': 'cltbld', 17:14:57 INFO - 'MAIL': '/var/mail/cltbld', 17:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:57 INFO - 'MOZ_NO_REMOTE': '1', 17:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:57 INFO - 'NO_EM_RESTART': '1', 17:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:14:57 INFO - 'PWD': '/builds/slave/test-pgo', 17:14:57 INFO - 'SHELL': '/bin/bash', 17:14:57 INFO - 'SHLVL': '1', 17:14:57 INFO - 'TERM': 'linux', 17:14:57 INFO - 'TMOUT': '86400', 17:14:57 INFO - 'USER': 'cltbld', 17:14:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', 17:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:57 INFO - '_': '/tools/buildbot/bin/python'} 17:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:57 INFO - Downloading/unpacking flake8 17:14:57 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 17:14:57 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 17:14:57 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 17:14:57 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 17:14:57 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 17:14:57 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 17:14:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:14:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:14:59 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 17:14:59 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 17:14:59 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 17:14:59 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 17:14:59 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 17:14:59 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 17:14:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:14:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:14:59 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 17:14:59 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 17:14:59 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 17:14:59 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 17:14:59 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 17:14:59 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 17:15:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:15:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:15:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:15:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:15:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:15:00 INFO - no previously-included directories found matching 'docs/_build' 17:15:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:15:00 INFO - Running setup.py install for pep8 17:15:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:15:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:15:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:15:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:15:00 INFO - no previously-included directories found matching 'docs/_build' 17:15:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:15:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:15:00 INFO - Cleaning up... 17:15:00 INFO - Return code: 0 17:15:00 INFO - Running post-action listener: _resource_record_post_action 17:15:00 INFO - Running post-action listener: _start_resource_monitoring 17:15:00 INFO - Starting resource monitoring. 17:15:00 INFO - ##### 17:15:00 INFO - ##### Running install step. 17:15:00 INFO - ##### 17:15:00 INFO - Running pre-action listener: _resource_record_pre_action 17:15:00 INFO - Running main action method: install 17:15:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:15:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:15:00 INFO - Reading from file tmpfile_stdout 17:15:00 INFO - Detecting whether we're running mozinstall >=1.0... 17:15:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:15:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:15:00 INFO - Reading from file tmpfile_stdout 17:15:00 INFO - Output received: 17:15:00 INFO - Usage: mozinstall [options] installer 17:15:00 INFO - Options: 17:15:00 INFO - -h, --help show this help message and exit 17:15:00 INFO - -d DEST, --destination=DEST 17:15:00 INFO - Directory to install application into. [default: 17:15:00 INFO - "/builds/slave/test-pgo"] 17:15:00 INFO - --app=APP Application being installed. [default: firefox] 17:15:00 INFO - mkdir: /builds/slave/test-pgo/build/application 17:15:00 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'] 17:15:00 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 17:15:17 INFO - Reading from file tmpfile_stdout 17:15:17 INFO - Output received: 17:15:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:15:17 INFO - Running post-action listener: _resource_record_post_action 17:15:17 INFO - ##### 17:15:17 INFO - ##### Running run-tests step. 17:15:17 INFO - ##### 17:15:17 INFO - Running pre-action listener: _resource_record_pre_action 17:15:17 INFO - Running main action method: run_tests 17:15:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:15:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:15:17 INFO - Python 2.7.3 17:15:17 INFO - Return code: 0 17:15:17 INFO - grabbing minidump binary from tooltool 17:15:17 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')]} 17:15:17 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 0x28ee8b0>, '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 0x28ef7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28efc60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:15:17 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 17:15:17 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 17:15:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:15:17 INFO - Return code: 0 17:15:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:15:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:15:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:15:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:15:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:15:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:15:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:15:18 INFO - Return code: 0 17:15:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 17:15:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 17:15:18 INFO - Using env: {'DISPLAY': ':0', 17:15:18 INFO - 'HOME': '/home/cltbld', 17:15:18 INFO - 'LANG': 'en_US.UTF-8', 17:15:18 INFO - 'LANGUAGE': 'en_US:en', 17:15:18 INFO - 'LOGNAME': 'cltbld', 17:15:18 INFO - 'MAIL': '/var/mail/cltbld', 17:15:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:15:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:18 INFO - 'MOZ_NO_REMOTE': '1', 17:15:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:18 INFO - 'NO_EM_RESTART': '1', 17:15:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:18 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:15:18 INFO - 'SHELL': '/bin/bash', 17:15:18 INFO - 'SHLVL': '1', 17:15:18 INFO - 'TERM': 'linux', 17:15:18 INFO - 'TMOUT': '86400', 17:15:18 INFO - 'USER': 'cltbld', 17:15:18 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782', 17:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:18 INFO - '_': '/tools/buildbot/bin/python'} 17:15:18 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 17:15:18 INFO - mozversion application_buildid: 20160328143033 17:15:18 INFO - mozversion application_changeset: 971ee95dade06b20742e94d58c471e76705ca478 17:15:18 INFO - mozversion application_display_name: Nightly 17:15:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:15:18 INFO - mozversion application_name: Firefox 17:15:18 INFO - mozversion application_remotingname: firefox 17:15:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:15:18 INFO - mozversion application_vendor: Mozilla 17:15:18 INFO - mozversion application_version: 48.0a1 17:15:18 INFO - mozversion platform_buildid: 20160328143033 17:15:18 INFO - mozversion platform_changeset: 971ee95dade06b20742e94d58c471e76705ca478 17:15:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:15:18 INFO - mozversion platform_version: 48.0a1 17:15:18 INFO - using testdate: 1459210518 17:15:18 INFO - actual date: 1459210518 17:15:18 INFO - starting webserver on 'localhost:52369' 17:15:18 INFO - SUITE-START | Running 2 tests 17:15:18 INFO - TEST-START | dromaeo_css 17:15:18 INFO - operating with platform_type : linux_ 17:15:18 INFO - Initialising browser for dromaeo_css test... 17:15:18 INFO - TEST-INFO | started process 14016 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUNmR0R/profile http://localhost:52369/getInfo.html) 17:15:22 INFO - PROCESS | 14016 | 17:15:22 INFO - PROCESS | 14016 | (process:14095): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:15:22 INFO - PROCESS | 14016 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:15:23 INFO - PROCESS | 14016 | __metrics Screen width/height:1600/1200 17:15:23 INFO - PROCESS | 14016 | colorDepth:24 17:15:23 INFO - PROCESS | 14016 | Browser inner width/height: 1024/697 17:15:23 INFO - PROCESS | 14016 | __metrics 17:15:24 ERROR - PROCESS | 14016 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 17:15:25 INFO - TEST-INFO | 14016: exit 0 17:15:25 INFO - Browser initialized. 17:15:25 INFO - Running cycle 1/1 for dromaeo_css test... 17:15:25 INFO - TEST-INFO | started process 14146 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUNmR0R/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:26 INFO - PROCESS | 14146 | 17:15:26 INFO - PROCESS | 14146 | (process:14210): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:15:36 INFO - PROCESS | 14146 | RSS: Main: 163557376 17:15:36 INFO - PROCESS | 14146 | 17:16:26 INFO - PROCESS | 14146 | 1459210586473 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] 17:18:33 INFO - PROCESS | 14146 | Cycle 1(1): loaded http://localhost:52369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52369/tests/dromaeo/cssquery-ext.html) 17:18:34 INFO - PROCESS | 14146 | RSS: Main: 168054784 17:18:34 INFO - PROCESS | 14146 | 17:21:36 INFO - PROCESS | 14146 | Cycle 1(1): loaded http://localhost:52369/tests/dromaeo/cssquery-ext.html (next: http://localhost:52369/tests/dromaeo/cssquery-jquery.html) 17:21:36 INFO - PROCESS | 14146 | RSS: Main: 165785600 17:21:36 INFO - PROCESS | 14146 | 17:24:38 INFO - PROCESS | 14146 | Cycle 1(1): loaded http://localhost:52369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52369/tests/dromaeo/cssquery-mootools.html) 17:24:39 INFO - PROCESS | 14146 | RSS: Main: 166903808 17:24:39 INFO - PROCESS | 14146 | 17:27:40 INFO - PROCESS | 14146 | Cycle 1(1): loaded http://localhost:52369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52369/tests/dromaeo/cssquery-prototype.html) 17:27:41 INFO - PROCESS | 14146 | RSS: Main: 164499456 17:27:41 INFO - PROCESS | 14146 | 17:30:43 INFO - PROCESS | 14146 | Cycle 1(1): loaded http://localhost:52369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52369/tests/dromaeo/cssquery-yui.html) 17:30:44 INFO - PROCESS | 14146 | RSS: Main: 165953536 17:30:44 INFO - PROCESS | 14146 | 17:33:46 INFO - PROCESS | 14146 | Cycle 1(1): loaded http://localhost:52369/tests/dromaeo/cssquery-yui.html (next: http://localhost:52369/tests/dromaeo/cssquery-dojo.html) 17:33:46 INFO - PROCESS | 14146 | RSS: Main: 167841792 17:33:46 INFO - PROCESS | 14146 | 17:33:46 INFO - PROCESS | 14146 | __start_tp_report 17:33:46 INFO - PROCESS | 14146 | _x_x_mozilla_page_load 17:33:46 INFO - PROCESS | 14146 | _x_x_mozilla_page_load_details 17:33:46 INFO - PROCESS | 14146 | |i|pagename|runs| 17:33:46 INFO - PROCESS | 14146 | |0;dojo.html;3099.938001239974;3133.357661679356;3135.451296023196;3184.777065605407;3200.7279381252592;5275.155975043994;5278.999999999995;5280.656757310777;5333.173358129487;5381.704006279653;5294.232336311242;5296.8146114885985;5313.256144139824;5378.2470454136455;5392.164214546741;4851.0540444613225;4901.754912254373;4957.454679985199;4959.752012399384;5003.224500202475;730.8185549111636;4836.51634836517;4857.757112144396;4906.975465122669;4944.975275123619;4820.204666230068;4829.1790395632825;4836.46798852126;4853.102176097434;4890.095332363507;4831.637627177941;4831.734254615994;4843.539863712942;4847.103285892086;4891.902161956777;4820.927686084711;4823.155947709172;4883.902321953541;4908.214685650314;4940.407151141886;5161.4322424533275;5214.582833373321;5214.843554693365;5218.6868787872845;5246.186841039606;5636.126400407943;5687.800926967537;5694.316681998145;5701.828945131652;5704.914426283609;5761;5770.163326317703;5774.971125144348;5838.2702162229725;5852.56105792063;5382.461753824626;5395.136778115482;5399.78400863965;5415.350157981028;5422.864428389322;5747.166660834156;5841.678707671119;5887.970560147171;5905.350411454737;5907.054871220584;5572.498475137257;5575.0522411190195;5583.190437386556;5630;5708.4862362387585;5647.519960803295;5662.631928924607;5665.631733937364;5675.77296908119;5722.313322401338;5581.888362232733;5608.411116832755;5608.579356548275;5619.353774316006;5621.241132447149;5626.943730562642;5652.18043383707;5652.378238393773;5653.123765816305;5655.349634791969;4332.956670433256;4335.111302183045;4342.6742994275555;4353.194658988097;4381.627561657231;3855.7108216883285;3877.7091718121255;3886.4753258309765;3914.5498267699577;3914.9625349282464;5343.145096784496;5379.67721936685;5411.78352865881;5430.91853622196;5463.890722185534;5609.242752228397;5631.155326700946;5656.8868622627315;5659.094544872801;5677.51741102011;5394.460553944653;5394.703291318937;5400.864978375572;5414.756335964891;5460.563154947595;4827;4853.781579828917;4858.78135483904;4885.3649025627155;4900.8774780630765;5821.53427725781;5831.679257640871;5840.328362238312;5866.560007999417;5868.413158684098;5673.06394444912;5676.914846277392;5679.432056794288;5690.715464226772;5692.971535142297;5907.793227237026;5964.493018093511;5968.253968253968;5973.4325239103955;5976.970115149396;5547.472990065938;5572.944270557243;5580.079286917613;5604.467575580314;5608.803691870765;5603.915941260966;5604.467575580314;5702.401247868914;5703.08750599902;5726.685032323262;5532;5569.248151499658;5582.441755824385;5585.636933599303;5624.240727501899;5478.068728316275;5478.260434841405;5478.479544443271;5481.314835645544;5491.093969494988;5430.592705547021;5482.917756233739;5520.227168196376;5535.529479994246;5593.161025845993;5555.416681248411;5590.664560126405;5597.104463286018;5632.408597097246;5643.943560564342;5408.8377348679605;5464.781408743605;5465.508104270635;5481.040817856939;5493.09363954943 17:33:46 INFO - PROCESS | 14146 | |1;ext.html;555.5472290083582;563.0484481226724;591.8461200087977;609.6951524237883;656.9934300656992;39173.608263917355;39201.4119788203;39501;39583.60416395835;39702.404463932995;42186.36720449188;42230.15539689204;42769;42861;42993.14013719724;8627.13728627137;8818.162274583905;8846.380753347268;8859.468431894074;8890;8659.69691060813;8733.475991440502;8774.473531588124;8971.730848074536;8983.775405614846;8953.865692014626;8965.641374345018;8992.8651070234;8994.595243214038;9005.54972251388;8907;8934.821303573892;8960.910390896073;8963.507007114606;8999;8995.55022248885;9112.271018318585;9124.361294709373;9126.543672816333;9148.222401095914;41888.790556047024;42113.36829947553;42167.57832421667;42188.57811421877;42453.787731061144;3527.805970671612;3532;3564.572251329831;3735.383661695817;4049.190161967618;31543.526847097313;31781;32085.1978700532;32121.839390802896;32914.67085329164;4306;4356.934645980313;4376.868693939187;4449.866504004885;4498.370228168059;317752;326044;326228;326492;326773;47320;48272.27591586129;48278.75860620674;58619.70690146522;59715.80568388608;47613.52386476091;47819.28271075937;47925;47982.28026579604;48031;15817.841821581867;15860;16010.279537420844;16014.279357428944;16086;12236.143469957018;12338.074644401526;12449.937750311372;12481.438335274934;12496.375181240901;16048.956817806806;16117.67764644724;16248.675026499404;16301.673966520602;16357.672846543002;6277.591956522811;6313.242410910629;6360.968195158995;6385.553011289165;6426.325235850262;1028.2134167361974;1030.3199888073834;1057.4448414582405;1057.534684738728;1072.9570817167225;32033;32063.839680801448;32305.631366903806;32762.672373275964;32848.50727239093;1150.206357613261;1151.228676786555;1187.7327601289815;1207.3118322556234;1229.1457437081142;16215.756763648555;16249.756253656205;16610.418635347705;16656.75014874778;16747.497575072768;419500;854938;870361;870520;871258;59462;59738;60234.39765602376;60312.69843650753;60371.39628603658;1411.632975426376;1423.7579611466076;1435.9928200358931;1442.9134251944918;1446.9493567725078;31338.686613133577;32854.83572582122;32926.83536582398;33060.51227694807;33654.49518257277;49342.50657493379;50132.49867501424;50295.245571315725;50318.49681503138;50387.496125038284;372462;373761;376393;378117;378745;36532.269354612225;36570.8171459141;36743.448848266766;36751.26497469982;36799.63200367962;46851.53148468608;46917.765411172724;47462.91491053071;47619.523804761506;47747;39248;39307;39317;39534.20931581295;39768.801155994035;38869.22261554696;39807;39966.80016600015;40020;40264.3960340601;39670.2065958685;40327.79836100918;40452.39321410123;41182;41336.58663413327;33870.491942620385;35074.123146921534;35118;35361.82319088388;35381.46927796137;28159;28233.294167645152;28327.58362081929;28402;28460.146195614165 17:33:46 INFO - PROCESS | 14146 | |2;jquery.html;372.56596065583614;375.498709223187;377.7091639437633;379.1317882050105;381.38216089934275;17219.655606887856;17479.300827966883;18084.909575452137;18104;18135.63728725425;17190.914045429785;17598.560035999075;17667.381641642543;17677.82322176778;17731.113444327795;5293.179557168635;5517.310336207974;5564.916526252109;5579.69311687857;5585.385607583163;5430.619856610039;5433.6196466247375;5466.043442397585;5470.288862447876;5519.089350257203;5088.440271570124;5244.79020839166;5254.133068043788;5260.789568417259;5277.8944421111555;5347.893042139135;5383.892322153554;5404.945950540484;6144.78493252734;6167.537434692371;5449.182622606601;5456.345238571357;5470.56235501159;5499.587530935156;5506.449355064502;12209.93895030528;13975.930120349332;20714.689279660815;21185.682214766635;21197.36407907765;2172.3374370816896;2183.945401364963;2254.267363106997;2286.2683941138844;2377.9405514862265;9825.263105267133;9910.40537567741;9982;11278.943605281922;13718.725625487534;1832.2762508809078;1863.4220108641593;1938.6510428122933;2019.5052212207956;2100.3803877855917;65616.34383656198;67928;68246.65876670585;75180;79296;9470.95264523673;9822.459764713009;10324.174066074696;10544.525496352682;10554.261201715806;14038;14054.578362649137;14136.363863626162;14160.433582656784;14180.361883715257;7752.961235193788;7765.883511747328;7786.587639589443;7931.167227441151;7982.321502672222;7821;7956.602169891482;7966.362690984707;8004;8050.11448740638;4030.7504673551293;4082.7346222495444;4158.8336466541605;4233.364995250737;4246.299360605527;1801.7027190513681;1887.1224880430666;1917.0893825433086;1929.2829033014145;1966.8623196376402;885.8041643780845;902.363833497396;952.7332346942867;963.4460185393427;987.1313244344931;17440.47678569645;17554.122293885255;17857.196426160855;18080.09599520045;18354.541136471427;989.9307048506536;1051.106559424483;1051.7686109055996;1059.8463222832645;1084.046039485248;10041.297109202433;10261.050400423896;10292.228082893813;10294.948525257325;10405.06354428105;438517;440353;461629;471537;508257;52081.99999999924;68981.31018689749;80651.5967420171;81307.59346203349;85291.57354213313;1033.3644808442905;1052.1109662335314;1071.6838532632737;1074.1621535202555;1075.5375188668947;16419.507414777574;16507;16615.252313645673;16672.583185419975;16778.832211677727;35454.46818297676;35556.644433556365;37558.248835023696;38067.61932380641;38271.80864095662;51996.480035199165;52350.73824630852;52443.47556524538;52516.47483525116;52678.73660631672;8051.396145289244;8082.313003394777;8087.716929907425;8106.432549721463;8201.58992050407;11629.88370116288;12871.163374380636;13101.541446049343;13120.212787232796;13233.073684842353;11255.66233013011;11406.48670809799;11411.657650270505;11636.476358564054;11639.359835209145;10969.561217551209;10971.067459266053;11122.721931951766;11242;11335.603253886075;11341.659750207507;11525.077993760648;11820.408979550815;11823.46794394237;11883.881161188623;8225.259726624632;8313.584320783815;8315;8393.706220282262;8440.029396619468;11623.76752464963;11641.59254426091;11652.53389864396;11658.125640576822;11815.409229538316 17:33:46 INFO - PROCESS | 14146 | |3;mootools.html;1499.2054211268028;1523.3449616664834;1695.2371432855218;1805.2688661092245;1813.646338963901;7369.299916507936;7859.449838511292;8024.959875200623;8336.91663083369;8337.583120843956;8009.2391222833885;8118.391120665959;8276.503409795401;8306.75079747607;8331.375146863995;2383.2373640435067;2406.9398265043337;2409.9518009639796;2416.178499310234;2417.3714834143075;2438.1100898172217;2468.6420469031978;2469.62955556667;2472.0606169655507;2483.8261321707396;2374.643803429482;2418.89114989825;2426.8301218914685;2428.7085549734056;2434.1602147259255;2380.9404814857394;2396.04158336665;2408.759124087586;2412.7225369082516;2423.745506721795;2427.8179136564827;2435.5128974205054;2448.167623008168;2462.753724627541;2462.913798017061;8473.915260847436;8484.194001569902;8503.872441913376;8516.361272904556;8593.398462107654;5224.764885580158;5314.309139811839;5333.280007199017;5367.060764366221;5387.353517577876;3386.255023894739;3400.931981360359;3476.165720227127;3539.1859872229275;3548.769329993542;1099.8001715648622;1101.0475938313302;1106.9705174188002;1110.4725255503652;1121.3496172220093;11741.941290293495;11796.646100616996;11828.23116497425;11903;11948.103892208032;4478.081993191388;4586.541345865387;4599.2871104978785;4631.791569379386;4688.296755486705;9460.95269523648;9465.053494650618;9466.337356384987;9474.289428292768;9489.193418559362;5233.319668443154;5250.0549901018185;5255.47445255479;5255.947440525622;5279.234510995884;4211.7472951623;4643.767811609474;4725.432948046187;4736.905261894743;4831.275308703723;3724.0689827543115;3819.350710379242;3823.2162406706557;3848.9807550962064;3868.361720316116;1176.1237877781107;1178.9941050294694;1201.5073819733868;1202.6572426858304;1203.5005472728894;1392.0742706100532;1405.8102156208986;1412.3573773932835;1417.5322143692556;1421.3461807568428;8031.317338026216;8208.917910820815;8236.423450358418;8243.793905152299;8256.628451719687;1075.4031512510476;1149.1898211760688;1171.5138217639756;1186.8575770907546;1196.3719047499958;6349.841253968688;6418.967905160444;6445.2587952386075;6473.676316184266;6485.935140648628;9882.357646752938;10188.083072523508;10219.48902554884;10356.844647330296;10611.628592999208;10147.289689721796;10193.592256309665;10353.378797272188;10384.11735002518;10464.686059418078;8019.959900200578;8025.03699556057;8029.5583742894705;8089.716859909875;8176.46852954556;7619.9238007619215;7734.5359278443475;7870.803229919298;7915.881261780963;7944.285014348737;8688.695895643623;8794.384393092421;8899.243564297107;9035.45787252767;9144.451332920045;8902.510361930155;9041.412308199946;9084.909150908406;9275.2579793615;9282.932462766597;6659.433948114464;7217.927820721936;7388.593627350332;7588.544687318778;7719.536827790351;8103.918960810316;8115.675372985014;8151.877721834058;8169.79575510617;8172.918270817454;7319.2314806944505;7461.141968673672;7476.887846682195;7533.924660753322;7579.962100189464;7331.2302208267365;7393.519421237603;7423.517471364344;7498.512596681198;7507.812304692208;7477.663505142173;7482.3639990601405;7498.887516687363;7577.355924746458;7595.88606170919;7049.436045116481;7059.329363710439;7162.176349719641;7182.317679820409;7221.711131554679;7202.567845929261;7210.71157153708;7238.0952380952385;7240.8913866290995;7270.236625154283 17:33:46 INFO - PROCESS | 14146 | |4;prototype.html;333.28510345309314;339.5195797945905;341.2901165575603;342.8114537004648;345.7026956817137;6279.089532017861;6377.39414755598;6455.225372955252;6492.870142597151;6496.155499785022;6367.331430199832;6389.488840892729;6394.584352017116;6413.903791443132;6464.385883341075;4664.883377915546;4739.170645137105;4768.356271903283;4770.833020844271;4844.20070688336;4729.337892695025;4752.453467851189;4752.809887604509;4756;4757.04859028194;4706.388169537955;4718.386609740729;4720.504347043562;4723.362346083286;4725.645576581753;4716.2218233991525;4726.527347265263;4730.834420795273;4734.881627959294;4840.6127509799135;4173.707840451169;4184.4141820145205;4184.769837658928;4185.351270553069;4188.874333769992;6081.6351018939;6145.907811382833;6157.3534778848025;6157.815265542041;6165.383461653843;5375.973120134374;5483.4920396890775;5593.133064375028;5597.496225339698;5606.046972014768;6651.368120028589;6670.533062685614;6684.465242780566;6687.164104486939;6719.0593316935665;4561.794719237642;4565.383673204108;4571.725696458223;4573.702709323883;4578.5650363215445;6922.169339679221;6986.231514533448;6992.440604751659;7015.508914375996;7041.838096713985;4617.8383756568355;4709;4723.197056500403;4727.2909063640045;4729.763511824395;4749.335093086971;4779.569838714463;4780.378550788375;4781.593564546983;4789.449213340441;5537.529310008695;5576.7211639417865;5579.246801681802;5579.6652200868075;5581.134924086773;6738;6785.457163426914;6793.660316984131;6805.013273075377;6811.9659401702675;1652.4712092130403;1677.1530377159456;1677.4799812058302;1681.4031018988328;1682.276621052959;1032.230987914009;1074.312440038376;1081.1350919264557;1086.2342048855696;1086.538221255979;6492.837679057967;6509.804705858737;6537;6564;6564;6997.895031574531;6999.615021173782;7005.894911576331;7006.229314775371;7032.92967070333;6449.742010319628;6500.089987401768;6591.0442985766795;6637.601743895285;6655.933440665532;3799.3920972644246;3815.1606646537716;3817.7900215488417;3825.6365645263654;3828.5022947017264;7280.41756659466;7307.7807665770115;7314.524555903956;7315.195328513859;7341.669624866894;7240.891386629205;7252.202257751643;7283.417326613858;7285.089363829521;7293.927060729431;7079.752208672672;7270.600116993616;7292.562446253241;7301.963490182515;7345.265473452719;7031.613261270679;7061.929380706332;7072.3634872861685;7073.6463176839925;7084.822879428056;6978.197507286727;7009.1939426966555;7012.2286548478605;7019.964900175466;7026.6135362553505;7270;7295.708171673074;7313.414926805949;7326.3406293433845;7326.96336518314;4553.749543775124;4672.626189904731;4683.367745354333;4687.5781179693995;4708.529147085401;6970.546914450544;6995.545289556163;7014.824629384306;7015.6842942066705;7023.262557431396;6811.761588344384;6819.488538359742;6844.281350458329;6850.801109805664;6851.828704282433;6669.0663307136065;6674.16572928384;6674.16572928384;6677.766278180435;6678.7328506859185;6442.2591401989375;6613.966930165318;6733.595984240961;6746.325367463214;6748.73005079811;6873.243943166348;6896.137982752156;6915.6887940043825;6928.445724342141;6934.479914006571;6689.163854518185;6691.2639609643875;6737.831554211184;6743.763968261087;6760.053592496956 17:33:46 INFO - PROCESS | 14146 | |5;yui.html;795.7732046366783;825.2201669422394;839.3578912132224;839.6935118681681;871.7166920750758;14009.579712608613;15704.842951570481;16125.677486450279;16199.514014579581;16203.756943645825;15235.695286094298;15259.923700381483;15288.31202595883;15295;15318.923405382957;686.4508393285352;824.2705205892798;840.0759164918602;852.7740148860557;855.2601999270648;848.2069265237024;849.1762989899787;852.910444403338;853.5988085599759;853.6670698427619;866.3069544364515;867.7483529776357;867.8437881181385;868.1188593577524;869.7738587967142;851.748734123435;854.0989256334565;859.9656013759442;861.1861790607878;863.6372723456163;618.9009758438673;619.7366119399283;621.3258614403378;621.8041316985181;626.7962912053555;14176.92911535446;14183.858161418357;14236.359363828653;14263.78604320936;14299.571012869526;14049.43802247909;14108.788368174486;14132.505362312373;14146.646333841736;14294.142351458842;11189.72025699364;11200.327980321124;11220.831687524693;11325.263857849213;11340.092792576574;3768.9623103768886;3784.735068545203;3795.2409518096215;3851.306764782366;3853.344931361675;54995.450045499434;55423;55553.44446555523;55662;55665.16502252469;11172.10623150146;11186.832197517044;11227.27022743519;11387.658370248906;11459.828102578467;20338.491537711674;20489.795102049087;20526.07632656534;20580.176792928414;20596.27913023067;8265.504069755834;8296.917030829614;8413.70552030676;8413.95793021031;8755.255803256667;4709.599684026896;4728.834490792875;5006.4743201964;5065.645404821701;5185.403678576937;3377.6960073593496;3378.662133786651;3387.6104248011793;3401.5748031496064;3410.2326976430104;597.9342272350038;609.3845216331448;610.0513701194596;610.3499772742016;610.7862248213179;565.2341077839551;665.8601693644292;690.1993687322681;701.4388489208612;703.8768215562257;8193.46742461738;8838.55807209637;8846.601902914384;8849.64601415949;8904.109589041174;571.1147721032384;604.0456079394546;628.3527966194827;670.8394477553859;701.4458577723643;3959.980200098981;4201.978990105091;4232.285924200703;4262.595053469915;4338.305871060616;57203.71398142983;57727.711361442925;58048.4195158043;58089.709551451975;58595.70702146462;51053.48946510562;52643.473565263856;52846.35768211574;53048.46951530435;53133.46866531285;47480.762596186796;47629.28556071662;47927.76036119867;48146.27780583294;48695.75652121717;8238.546879921661;8489.490630562186;8628.913710863062;8732.039475657799;8751.212390884852;35389.823050885614;35750.106247342985;36100.45849312315;36564.63435365719;36705.28876834699;41961;44795.77602111969;45359.77320113379;45619.543804562854;45813.31280030736;11290.604828830952;11396.145289103184;11415.37215453125;11806.232594881305;11820.82268765952;12873.098883078095;13021.395720855677;13316.800247996482;13332.666683332995;13487.730245394841;11879;12127.81808272859;12282.324472154118;12285.447154877873;12569.685757856127;12270.570530031406;12339.13626046168;12366.134370593973;12449.633175114564;12479;11255.437228138724;11272.380019099028;11660.999371778018;11931.105167112328;12154.209976351509;9863.112319891245;9929.950350248202;10273;10483.947580262049;10759.408232547285;10408.181555650795;10701;10814.837777433502;10844.403557804397;11015.228933974546 17:33:46 INFO - PROCESS | 14146 | __end_tp_report 17:33:46 INFO - PROCESS | 14146 | __start_cc_report 17:33:46 INFO - PROCESS | 14146 | _x_x_mozilla_cycle_collect,334 17:33:46 INFO - PROCESS | 14146 | __end_cc_report 17:33:46 INFO - PROCESS | 14146 | __startTimestamp1459211626924__endTimestamp 17:33:46 INFO - PROCESS | 14146 | 17:33:46 INFO - PROCESS | 14146 | ------- Summary: start ------- 17:33:46 INFO - PROCESS | 14146 | Number of tests: 6 17:33:46 INFO - PROCESS | 14146 | 17:33:46 INFO - PROCESS | 14146 | [#0] dojo.html Cycles:165 Average:5266.78 Median:5481.31 stddev:685.92 (12.5%) stddev-sans-first:666.63 17:33:46 INFO - PROCESS | 14146 | Values: 3099.9 3133.4 3135.5 3184.8 3200.7 5275.2 5279.0 5280.7 5333.2 5381.7 5294.2 5296.8 5313.3 5378.2 5392.2 4851.1 4901.8 4957.5 4959.8 5003.2 730.8 4836.5 4857.8 4907.0 4945.0 4820.2 4829.2 4836.5 4853.1 4890.1 4831.6 4831.7 4843.5 4847.1 4891.9 4820.9 4823.2 4883.9 4908.2 4940.4 5161.4 5214.6 5214.8 5218.7 5246.2 5636.1 5687.8 5694.3 5701.8 5704.9 5761.0 5770.2 5775.0 5838.3 5852.6 5382.5 5395.1 5399.8 5415.4 5422.9 5747.2 5841.7 5888.0 5905.4 5907.1 5572.5 5575.1 5583.2 5630.0 5708.5 5647.5 5662.6 5665.6 5675.8 5722.3 5581.9 5608.4 5608.6 5619.4 5621.2 5626.9 5652.2 5652.4 5653.1 5655.3 4333.0 4335.1 4342.7 4353.2 4381.6 3855.7 3877.7 3886.5 3914.5 3915.0 5343.1 5379.7 5411.8 5430.9 5463.9 5609.2 5631.2 5656.9 5659.1 5677.5 5394.5 5394.7 5400.9 5414.8 5460.6 4827.0 4853.8 4858.8 4885.4 4900.9 5821.5 5831.7 5840.3 5866.6 5868.4 5673.1 5676.9 5679.4 5690.7 5693.0 5907.8 5964.5 5968.3 5973.4 5977.0 5547.5 5572.9 5580.1 5604.5 5608.8 5603.9 5604.5 5702.4 5703.1 5726.7 5532.0 5569.2 5582.4 5585.6 5624.2 5478.1 5478.3 5478.5 5481.3 5491.1 5430.6 5482.9 5520.2 5535.5 5593.2 5555.4 5590.7 5597.1 5632.4 5643.9 5408.8 5464.8 5465.5 5481.0 5493.1 17:33:46 INFO - PROCESS | 14146 | 17:33:46 INFO - PROCESS | 14146 | [#1] ext.html Cycles:180 Average:63924.70 Median:39787.90 stddev:146388.33 (367.9%) stddev-sans-first:146721.66 17:33:46 INFO - PROCESS | 14146 | Values: 555.5 563.0 591.8 609.7 657.0 39173.6 39201.4 39501.0 39583.6 39702.4 42186.4 42230.2 42769.0 42861.0 42993.1 8627.1 8818.2 8846.4 8859.5 8890.0 8659.7 8733.5 8774.5 8971.7 8983.8 8953.9 8965.6 8992.9 8994.6 9005.5 8907.0 8934.8 8960.9 8963.5 8999.0 8995.6 9112.3 9124.4 9126.5 9148.2 41888.8 42113.4 42167.6 42188.6 42453.8 3527.8 3532.0 3564.6 3735.4 4049.2 31543.5 31781.0 32085.2 32121.8 32914.7 4306.0 4356.9 4376.9 4449.9 4498.4 317752.0 326044.0 326228.0 326492.0 326773.0 47320.0 48272.3 48278.8 58619.7 59715.8 47613.5 47819.3 47925.0 47982.3 48031.0 15817.8 15860.0 16010.3 16014.3 16086.0 12236.1 12338.1 12449.9 12481.4 12496.4 16049.0 16117.7 16248.7 16301.7 16357.7 6277.6 6313.2 6361.0 6385.6 6426.3 1028.2 1030.3 1057.4 1057.5 1073.0 32033.0 32063.8 32305.6 32762.7 32848.5 1150.2 1151.2 1187.7 1207.3 1229.1 16215.8 16249.8 16610.4 16656.8 16747.5 419500.0 854938.0 870361.0 870520.0 871258.0 59462.0 59738.0 60234.4 60312.7 60371.4 1411.6 1423.8 1436.0 1442.9 1446.9 31338.7 32854.8 32926.8 33060.5 33654.5 49342.5 50132.5 50295.2 50318.5 50387.5 372462.0 373761.0 376393.0 378117.0 378745.0 36532.3 36570.8 36743.4 36751.3 36799.6 46851.5 46917.8 47462.9 47619.5 47747.0 39248.0 39307.0 39317.0 39534.2 39768.8 38869.2 39807.0 39966.8 40020.0 40264.4 39670.2 40327.8 40452.4 41182.0 41336.6 33870.5 35074.1 35118.0 35361.8 35381.5 28159.0 28233.3 28327.6 28402.0 28460.1 17:33:46 INFO - PROCESS | 14146 | 17:33:46 INFO - PROCESS | 14146 | [#2] jquery.html Cycles:180 Average:26765.03 Median:17964.61 stddev:76263.51 (424.5%) stddev-sans-first:76451.70 17:33:46 INFO - PROCESS | 14146 | Values: 372.6 375.5 377.7 379.1 381.4 17219.7 17479.3 18084.9 18104.0 18135.6 17190.9 17598.6 17667.4 17677.8 17731.1 5293.2 5517.3 5564.9 5579.7 5585.4 5430.6 5433.6 5466.0 5470.3 5519.1 5088.4 5244.8 5254.1 5260.8 5277.9 5347.9 5383.9 5404.9 6144.8 6167.5 5449.2 5456.3 5470.6 5499.6 5506.4 12209.9 13975.9 20714.7 21185.7 21197.4 2172.3 2183.9 2254.3 2286.3 2377.9 9825.3 9910.4 9982.0 11278.9 13718.7 1832.3 1863.4 1938.7 2019.5 2100.4 65616.3 67928.0 68246.7 75180.0 79296.0 9471.0 9822.5 10324.2 10544.5 10554.3 14038.0 14054.6 14136.4 14160.4 14180.4 7753.0 7765.9 7786.6 7931.2 7982.3 7821.0 7956.6 7966.4 8004.0 8050.1 4030.8 4082.7 4158.8 4233.4 4246.3 1801.7 1887.1 1917.1 1929.3 1966.9 885.8 902.4 952.7 963.4 987.1 17440.5 17554.1 17857.2 18080.1 18354.5 989.9 1051.1 1051.8 1059.8 1084.0 10041.3 10261.1 10292.2 10294.9 10405.1 438517.0 440353.0 461629.0 471537.0 508257.0 52082.0 68981.3 80651.6 81307.6 85291.6 1033.4 1052.1 1071.7 1074.2 1075.5 16419.5 16507.0 16615.3 16672.6 16778.8 35454.5 35556.6 37558.2 38067.6 38271.8 51996.5 52350.7 52443.5 52516.5 52678.7 8051.4 8082.3 8087.7 8106.4 8201.6 11629.9 12871.2 13101.5 13120.2 13233.1 11255.7 11406.5 11411.7 11636.5 11639.4 10969.6 10971.1 11122.7 11242.0 11335.6 11341.7 11525.1 11820.4 11823.5 11883.9 8225.3 8313.6 8315.0 8393.7 8440.0 11623.8 11641.6 11652.5 11658.1 11815.4 17:33:46 INFO - PROCESS | 14146 | 17:33:46 INFO - PROCESS | 14146 | [#3] mootools.html Cycles:180 Average:5920.96 Median:5323.79 stddev:3058.65 (57.5%) stddev-sans-first:3049.17 17:33:46 INFO - PROCESS | 14146 | Values: 1499.2 1523.3 1695.2 1805.3 1813.6 7369.3 7859.4 8025.0 8336.9 8337.6 8009.2 8118.4 8276.5 8306.8 8331.4 2383.2 2406.9 2410.0 2416.2 2417.4 2438.1 2468.6 2469.6 2472.1 2483.8 2374.6 2418.9 2426.8 2428.7 2434.2 2380.9 2396.0 2408.8 2412.7 2423.7 2427.8 2435.5 2448.2 2462.8 2462.9 8473.9 8484.2 8503.9 8516.4 8593.4 5224.8 5314.3 5333.3 5367.1 5387.4 3386.3 3400.9 3476.2 3539.2 3548.8 1099.8 1101.0 1107.0 1110.5 1121.3 11741.9 11796.6 11828.2 11903.0 11948.1 4478.1 4586.5 4599.3 4631.8 4688.3 9461.0 9465.1 9466.3 9474.3 9489.2 5233.3 5250.1 5255.5 5255.9 5279.2 4211.7 4643.8 4725.4 4736.9 4831.3 3724.1 3819.4 3823.2 3849.0 3868.4 1176.1 1179.0 1201.5 1202.7 1203.5 1392.1 1405.8 1412.4 1417.5 1421.3 8031.3 8208.9 8236.4 8243.8 8256.6 1075.4 1149.2 1171.5 1186.9 1196.4 6349.8 6419.0 6445.3 6473.7 6485.9 9882.4 10188.1 10219.5 10356.8 10611.6 10147.3 10193.6 10353.4 10384.1 10464.7 8020.0 8025.0 8029.6 8089.7 8176.5 7619.9 7734.5 7870.8 7915.9 7944.3 8688.7 8794.4 8899.2 9035.5 9144.5 8902.5 9041.4 9084.9 9275.3 9282.9 6659.4 7217.9 7388.6 7588.5 7719.5 8103.9 8115.7 8151.9 8169.8 8172.9 7319.2 7461.1 7476.9 7533.9 7580.0 7331.2 7393.5 7423.5 7498.5 7507.8 7477.7 7482.4 7498.9 7577.4 7595.9 7049.4 7059.3 7162.2 7182.3 7221.7 7202.6 7210.7 7238.1 7240.9 7270.2 17:33:46 INFO - PROCESS | 14146 | 17:33:46 INFO - PROCESS | 14146 | [#4] prototype.html Cycles:180 Average:5651.08 Median:6492.85 stddev:1747.20 (26.9%) stddev-sans-first:1705.90 17:33:46 INFO - PROCESS | 14146 | Values: 333.3 339.5 341.3 342.8 345.7 6279.1 6377.4 6455.2 6492.9 6496.2 6367.3 6389.5 6394.6 6413.9 6464.4 4664.9 4739.2 4768.4 4770.8 4844.2 4729.3 4752.5 4752.8 4756.0 4757.0 4706.4 4718.4 4720.5 4723.4 4725.6 4716.2 4726.5 4730.8 4734.9 4840.6 4173.7 4184.4 4184.8 4185.4 4188.9 6081.6 6145.9 6157.4 6157.8 6165.4 5376.0 5483.5 5593.1 5597.5 5606.0 6651.4 6670.5 6684.5 6687.2 6719.1 4561.8 4565.4 4571.7 4573.7 4578.6 6922.2 6986.2 6992.4 7015.5 7041.8 4617.8 4709.0 4723.2 4727.3 4729.8 4749.3 4779.6 4780.4 4781.6 4789.4 5537.5 5576.7 5579.2 5579.7 5581.1 6738.0 6785.5 6793.7 6805.0 6812.0 1652.5 1677.2 1677.5 1681.4 1682.3 1032.2 1074.3 1081.1 1086.2 1086.5 6492.8 6509.8 6537.0 6564.0 6564.0 6997.9 6999.6 7005.9 7006.2 7032.9 6449.7 6500.1 6591.0 6637.6 6655.9 3799.4 3815.2 3817.8 3825.6 3828.5 7280.4 7307.8 7314.5 7315.2 7341.7 7240.9 7252.2 7283.4 7285.1 7293.9 7079.8 7270.6 7292.6 7302.0 7345.3 7031.6 7061.9 7072.4 7073.6 7084.8 6978.2 7009.2 7012.2 7020.0 7026.6 7270.0 7295.7 7313.4 7326.3 7327.0 4553.7 4672.6 4683.4 4687.6 4708.5 6970.5 6995.5 7014.8 7015.7 7023.3 6811.8 6819.5 6844.3 6850.8 6851.8 6669.1 6674.2 6674.2 6677.8 6678.7 6442.3 6614.0 6733.6 6746.3 6748.7 6873.2 6896.1 6915.7 6928.4 6934.5 6689.2 6691.3 6737.8 6743.8 6760.1 17:33:46 INFO - PROCESS | 14146 | 17:33:46 INFO - PROCESS | 14146 | [#5] yui.html Cycles:180 Average:14664.81 Median:45489.66 stddev:16609.61 (36.5%) stddev-sans-first:16623.55 17:33:46 INFO - PROCESS | 14146 | Values: 795.8 825.2 839.4 839.7 871.7 14009.6 15704.8 16125.7 16199.5 16203.8 15235.7 15259.9 15288.3 15295.0 15318.9 686.5 824.3 840.1 852.8 855.3 848.2 849.2 852.9 853.6 853.7 866.3 867.7 867.8 868.1 869.8 851.7 854.1 860.0 861.2 863.6 618.9 619.7 621.3 621.8 626.8 14176.9 14183.9 14236.4 14263.8 14299.6 14049.4 14108.8 14132.5 14146.6 14294.1 11189.7 11200.3 11220.8 11325.3 11340.1 3769.0 3784.7 3795.2 3851.3 3853.3 54995.5 55423.0 55553.4 55662.0 55665.2 11172.1 11186.8 11227.3 11387.7 11459.8 20338.5 20489.8 20526.1 20580.2 20596.3 8265.5 8296.9 8413.7 8414.0 8755.3 4709.6 4728.8 5006.5 5065.6 5185.4 3377.7 3378.7 3387.6 3401.6 3410.2 597.9 609.4 610.1 610.3 610.8 565.2 665.9 690.2 701.4 703.9 8193.5 8838.6 8846.6 8849.6 8904.1 571.1 604.0 628.4 670.8 701.4 3960.0 4202.0 4232.3 4262.6 4338.3 57203.7 57727.7 58048.4 58089.7 58595.7 51053.5 52643.5 52846.4 53048.5 53133.5 47480.8 47629.3 47927.8 48146.3 48695.8 8238.5 8489.5 8628.9 8732.0 8751.2 35389.8 35750.1 36100.5 36564.6 36705.3 41961.0 44795.8 45359.8 45619.5 45813.3 11290.6 11396.1 11415.4 11806.2 11820.8 12873.1 13021.4 13316.8 13332.7 13487.7 11879.0 12127.8 12282.3 12285.4 12569.7 12270.6 12339.1 12366.1 12449.6 12479.0 11255.4 11272.4 11661.0 11931.1 12154.2 9863.1 9930.0 10273.0 10483.9 10759.4 10408.2 10701.0 10814.8 10844.4 11015.2 17:33:46 INFO - PROCESS | 14146 | -------- Summary: end -------- 17:33:46 INFO - PROCESS | 14146 | 17:33:47 INFO - TEST-INFO | 14146: exit 0 17:33:47 INFO - TEST-OK | dromaeo_css | took 1108896ms 17:33:47 INFO - TEST-START | kraken 17:33:47 INFO - operating with platform_type : linux_ 17:33:47 INFO - Initialising browser for kraken test... 17:33:47 INFO - TEST-INFO | started process 14388 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp65fFky/profile http://localhost:52369/getInfo.html) 17:33:51 INFO - PROCESS | 14388 | 17:33:51 INFO - PROCESS | 14388 | (process:14460): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:33:51 INFO - PROCESS | 14388 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:33:52 INFO - PROCESS | 14388 | __metrics Screen width/height:1600/1200 17:33:52 INFO - PROCESS | 14388 | colorDepth:24 17:33:52 INFO - PROCESS | 14388 | Browser inner width/height: 1024/697 17:33:52 INFO - PROCESS | 14388 | __metrics 17:33:52 ERROR - PROCESS | 14388 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 17:33:53 INFO - TEST-INFO | 14388: exit 0 17:33:53 INFO - Browser initialized. 17:33:53 INFO - Running cycle 1/1 for kraken test... 17:33:53 INFO - TEST-INFO | started process 14511 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp65fFky/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:33:55 INFO - PROCESS | 14511 | 17:33:55 INFO - PROCESS | 14511 | (process:14574): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:34:05 INFO - PROCESS | 14511 | RSS: Main: 163491840 17:34:05 INFO - PROCESS | 14511 | 17:34:08 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:52369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52369/tests/kraken/driver.html?testName=audio-beat-detection) 17:34:08 INFO - PROCESS | 14511 | RSS: Main: 167690240 17:34:08 INFO - PROCESS | 14511 | 17:34:11 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:52369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52369/tests/kraken/driver.html?testName=audio-dft) 17:34:11 INFO - PROCESS | 14511 | RSS: Main: 171118592 17:34:11 INFO - PROCESS | 14511 | 17:34:14 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:52369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52369/tests/kraken/driver.html?testName=audio-fft) 17:34:15 INFO - PROCESS | 14511 | RSS: Main: 161902592 17:34:15 INFO - PROCESS | 14511 | 17:34:17 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:52369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52369/tests/kraken/driver.html?testName=audio-oscillator) 17:34:18 INFO - PROCESS | 14511 | RSS: Main: 161533952 17:34:18 INFO - PROCESS | 14511 | 17:34:20 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:52369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:34:20 INFO - PROCESS | 14511 | RSS: Main: 163241984 17:34:20 INFO - PROCESS | 14511 | 17:34:23 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:52369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52369/tests/kraken/driver.html?testName=imaging-darkroom) 17:34:24 INFO - PROCESS | 14511 | RSS: Main: 164257792 17:34:24 INFO - PROCESS | 14511 | 17:34:27 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:52369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52369/tests/kraken/driver.html?testName=imaging-desaturate) 17:34:28 INFO - PROCESS | 14511 | RSS: Main: 163831808 17:34:28 INFO - PROCESS | 14511 | 17:34:31 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:52369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52369/tests/kraken/driver.html?testName=json-parse-financial) 17:34:31 INFO - PROCESS | 14511 | RSS: Main: 166342656 17:34:31 INFO - PROCESS | 14511 | 17:34:33 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:52369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:34:34 INFO - PROCESS | 14511 | RSS: Main: 165949440 17:34:34 INFO - PROCESS | 14511 | 17:34:35 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:52369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52369/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:34:36 INFO - PROCESS | 14511 | RSS: Main: 166080512 17:34:36 INFO - PROCESS | 14511 | 17:34:38 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:52369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:34:39 INFO - PROCESS | 14511 | RSS: Main: 166268928 17:34:39 INFO - PROCESS | 14511 | 17:34:41 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:52369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:34:42 INFO - PROCESS | 14511 | RSS: Main: 166629376 17:34:42 INFO - PROCESS | 14511 | 17:34:44 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:52369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:34:45 INFO - PROCESS | 14511 | RSS: Main: 166662144 17:34:45 INFO - PROCESS | 14511 | 17:34:46 INFO - PROCESS | 14511 | Cycle 1(1): loaded http://localhost:52369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52369/tests/kraken/driver.html?testName=ai-astar) 17:34:47 INFO - PROCESS | 14511 | RSS: Main: 168476672 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | __start_tp_report 17:34:47 INFO - PROCESS | 14511 | _x_x_mozilla_page_load 17:34:47 INFO - PROCESS | 14511 | _x_x_mozilla_page_load_details 17:34:47 INFO - PROCESS | 14511 | |i|pagename|runs| 17:34:47 INFO - PROCESS | 14511 | |0;ai-astar;112;106;112;111;111;125;110;111;110;110 17:34:47 INFO - PROCESS | 14511 | |1;audio-beat-detection;162;123;154;168;128;155;148;129;169;127 17:34:47 INFO - PROCESS | 14511 | |2;audio-dft;164;163;164;161;164;163;163;167;171;169 17:34:47 INFO - PROCESS | 14511 | |3;audio-fft;77;72;88;77;75;73;73;73;153;75 17:34:47 INFO - PROCESS | 14511 | |4;audio-oscillator;92;92;135;94;94;93;150;94;94;141 17:34:47 INFO - PROCESS | 14511 | |5;imaging-gaussian-blur;119;118;118;117;118;118;117;116;118;117 17:34:47 INFO - PROCESS | 14511 | |6;imaging-darkroom;148;147;147;147;148;147;148;146;148;146 17:34:47 INFO - PROCESS | 14511 | |7;imaging-desaturate;97;97;100;96;98;96;96;96;97;96 17:34:47 INFO - PROCESS | 14511 | |8;json-parse-financial;56;57;60;59;62;59;56;58;55;55 17:34:47 INFO - PROCESS | 14511 | |9;json-stringify-tinderbox;60;60;60;61;60;61;59;60;60;60 17:34:47 INFO - PROCESS | 14511 | |10;stanford-crypto-aes;83;79;80;88;79;78;78;81;83;81 17:34:47 INFO - PROCESS | 14511 | |11;stanford-crypto-ccm;116;120;120;129;122;120;111;126;111;124 17:34:47 INFO - PROCESS | 14511 | |12;stanford-crypto-pbkdf2;137;146;150;146;144;143;147;141;142;140 17:34:47 INFO - PROCESS | 14511 | |13;stanford-crypto-sha256-iterative;63;64;64;75;63;65;63;62;62;61 17:34:47 INFO - PROCESS | 14511 | __end_tp_report 17:34:47 INFO - PROCESS | 14511 | __start_cc_report 17:34:47 INFO - PROCESS | 14511 | _x_x_mozilla_cycle_collect,873 17:34:47 INFO - PROCESS | 14511 | __end_cc_report 17:34:47 INFO - PROCESS | 14511 | __startTimestamp1459211687164__endTimestamp 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | ------- Summary: start ------- 17:34:47 INFO - PROCESS | 14511 | Number of tests: 14 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.00 stddev:4.94 (4.5%) stddev-sans-first:5.24 17:34:47 INFO - PROCESS | 14511 | Values: 112.0 106.0 112.0 111.0 111.0 125.0 110.0 111.0 110.0 110.0 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:154.50 stddev:18.01 (11.7%) stddev-sans-first:18.19 17:34:47 INFO - PROCESS | 14511 | Values: 162.0 123.0 154.0 168.0 128.0 155.0 148.0 129.0 169.0 127.0 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:3.11 (1.9%) stddev-sans-first:3.28 17:34:47 INFO - PROCESS | 14511 | Values: 164.0 163.0 164.0 161.0 164.0 163.0 163.0 167.0 171.0 169.0 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | [#3] audio-fft Cycles:10 Average:83.60 Median:75.00 stddev:24.82 (33.1%) stddev-sans-first:26.21 17:34:47 INFO - PROCESS | 14511 | Values: 77.0 72.0 88.0 77.0 75.0 73.0 73.0 73.0 153.0 75.0 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:93.50 stddev:23.81 (25.5%) stddev-sans-first:24.55 17:34:47 INFO - PROCESS | 14511 | Values: 92.0 92.0 135.0 94.0 94.0 93.0 150.0 94.0 94.0 141.0 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.84 (0.7%) stddev-sans-first:0.73 17:34:47 INFO - PROCESS | 14511 | Values: 119.0 118.0 118.0 117.0 118.0 118.0 117.0 116.0 118.0 117.0 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 17:34:47 INFO - PROCESS | 14511 | Values: 148.0 147.0 147.0 147.0 148.0 147.0 148.0 146.0 148.0 146.0 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:96.50 stddev:1.29 (1.3%) stddev-sans-first:1.36 17:34:47 INFO - PROCESS | 14511 | Values: 97.0 97.0 100.0 96.0 98.0 96.0 96.0 96.0 97.0 96.0 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.50 stddev:2.31 (4.0%) stddev-sans-first:2.37 17:34:47 INFO - PROCESS | 14511 | Values: 56.0 57.0 60.0 59.0 62.0 59.0 56.0 58.0 55.0 55.0 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 17:34:47 INFO - PROCESS | 14511 | Values: 60.0 60.0 60.0 61.0 60.0 61.0 59.0 60.0 60.0 60.0 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.00 stddev:3.06 (3.8%) stddev-sans-first:3.15 17:34:47 INFO - PROCESS | 14511 | Values: 83.0 79.0 80.0 88.0 79.0 78.0 78.0 81.0 83.0 81.0 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:121.00 stddev:5.92 (4.9%) stddev-sans-first:6.10 17:34:47 INFO - PROCESS | 14511 | Values: 116.0 120.0 120.0 129.0 122.0 120.0 111.0 126.0 111.0 124.0 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.60 Median:145.00 stddev:3.81 (2.6%) stddev-sans-first:3.20 17:34:47 INFO - PROCESS | 14511 | Values: 137.0 146.0 150.0 146.0 144.0 143.0 147.0 141.0 142.0 140.0 17:34:47 INFO - PROCESS | 14511 | 17:34:47 INFO - PROCESS | 14511 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:63.50 stddev:3.97 (6.2%) stddev-sans-first:4.18 17:34:47 INFO - PROCESS | 14511 | Values: 63.0 64.0 64.0 75.0 63.0 65.0 63.0 62.0 62.0 61.0 17:34:47 INFO - PROCESS | 14511 | -------- Summary: end -------- 17:34:47 INFO - PROCESS | 14511 | 17:34:48 INFO - TEST-INFO | 14511: exit 0 17:34:48 INFO - TEST-OK | kraken | took 60463ms 17:34:48 INFO - SUITE-END | took 1169s 17:34:48 INFO - Completed test suite (00:19:29) 17:34:48 INFO - javascript benchmark 17:34:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3099.938001239974, 3133.357661679356, 3135.451296023196, 3184.777065605407, 3200.7279381252592, 5275.155975043994, 5278.999999999995, 5280.656757310777, 5333.173358129487, 5381.704006279653, 5294.232336311242, 5296.8146114885985, 5313.256144139824, 5378.2470454136455, 5392.164214546741, 4851.0540444613225, 4901.754912254373, 4957.454679985199, 4959.752012399384, 5003.224500202475, 730.8185549111636, 4836.51634836517, 4857.757112144396, 4906.975465122669, 4944.975275123619, 4820.204666230068, 4829.1790395632825, 4836.46798852126, 4853.102176097434, 4890.095332363507, 4831.637627177941, 4831.734254615994, 4843.539863712942, 4847.103285892086, 4891.902161956777, 4820.927686084711, 4823.155947709172, 4883.902321953541, 4908.214685650314, 4940.407151141886, 5161.4322424533275, 5214.582833373321, 5214.843554693365, 5218.6868787872845, 5246.186841039606, 5636.126400407943, 5687.800926967537, 5694.316681998145, 5701.828945131652, 5704.914426283609, 5761.0, 5770.163326317703, 5774.971125144348, 5838.2702162229725, 5852.56105792063, 5382.461753824626, 5395.136778115482, 5399.78400863965, 5415.350157981028, 5422.864428389322, 5747.166660834156, 5841.678707671119, 5887.970560147171, 5905.350411454737, 5907.054871220584, 5572.498475137257, 5575.0522411190195, 5583.190437386556, 5630.0, 5708.4862362387585, 5647.519960803295, 5662.631928924607, 5665.631733937364, 5675.77296908119, 5722.313322401338, 5581.888362232733, 5608.411116832755, 5608.579356548275, 5619.353774316006, 5621.241132447149, 5626.943730562642, 5652.18043383707, 5652.378238393773, 5653.123765816305, 5655.349634791969, 4332.956670433256, 4335.111302183045, 4342.6742994275555, 4353.194658988097, 4381.627561657231, 3855.7108216883285, 3877.7091718121255, 3886.4753258309765, 3914.5498267699577, 3914.9625349282464, 5343.145096784496, 5379.67721936685, 5411.78352865881, 5430.91853622196, 5463.890722185534, 5609.242752228397, 5631.155326700946, 5656.8868622627315, 5659.094544872801, 5677.51741102011, 5394.460553944653, 5394.703291318937, 5400.864978375572, 5414.756335964891, 5460.563154947595, 4827.0, 4853.781579828917, 4858.78135483904, 4885.3649025627155, 4900.8774780630765, 5821.53427725781, 5831.679257640871, 5840.328362238312, 5866.560007999417, 5868.413158684098, 5673.06394444912, 5676.914846277392, 5679.432056794288, 5690.715464226772, 5692.971535142297, 5907.793227237026, 5964.493018093511, 5968.253968253968, 5973.4325239103955, 5976.970115149396, 5547.472990065938, 5572.944270557243, 5580.079286917613, 5604.467575580314, 5608.803691870765, 5603.915941260966, 5604.467575580314, 5702.401247868914, 5703.08750599902, 5726.685032323262, 5532.0, 5569.248151499658, 5582.441755824385, 5585.636933599303, 5624.240727501899, 5478.068728316275, 5478.260434841405, 5478.479544443271, 5481.314835645544, 5491.093969494988, 5430.592705547021, 5482.917756233739, 5520.227168196376, 5535.529479994246, 5593.161025845993, 5555.416681248411, 5590.664560126405, 5597.104463286018, 5632.408597097246, 5643.943560564342, 5408.8377348679605, 5464.781408743605, 5465.508104270635, 5481.040817856939, 5493.09363954943], "unit": "score", "name": "dojo.html", "value": 5223.720521180401}, {"lowerIsBetter": false, "replicates": [555.5472290083582, 563.0484481226724, 591.8461200087977, 609.6951524237883, 656.9934300656992, 39173.608263917355, 39201.4119788203, 39501.0, 39583.60416395835, 39702.404463932995, 42186.36720449188, 42230.15539689204, 42769.0, 42861.0, 42993.14013719724, 8627.13728627137, 8818.162274583905, 8846.380753347268, 8859.468431894074, 8890.0, 8659.69691060813, 8733.475991440502, 8774.473531588124, 8971.730848074536, 8983.775405614846, 8953.865692014626, 8965.641374345018, 8992.8651070234, 8994.595243214038, 9005.54972251388, 8907.0, 8934.821303573892, 8960.910390896073, 8963.507007114606, 8999.0, 8995.55022248885, 9112.271018318585, 9124.361294709373, 9126.543672816333, 9148.222401095914, 41888.790556047024, 42113.36829947553, 42167.57832421667, 42188.57811421877, 42453.787731061144, 3527.805970671612, 3532.0, 3564.572251329831, 3735.383661695817, 4049.190161967618, 31543.526847097313, 31781.0, 32085.1978700532, 32121.839390802896, 32914.67085329164, 4306.0, 4356.934645980313, 4376.868693939187, 4449.866504004885, 4498.370228168059, 317752.0, 326044.0, 326228.0, 326492.0, 326773.0, 47320.0, 48272.27591586129, 48278.75860620674, 58619.70690146522, 59715.80568388608, 47613.52386476091, 47819.28271075937, 47925.0, 47982.28026579604, 48031.0, 15817.841821581867, 15860.0, 16010.279537420844, 16014.279357428944, 16086.0, 12236.143469957018, 12338.074644401526, 12449.937750311372, 12481.438335274934, 12496.375181240901, 16048.956817806806, 16117.67764644724, 16248.675026499404, 16301.673966520602, 16357.672846543002, 6277.591956522811, 6313.242410910629, 6360.968195158995, 6385.553011289165, 6426.325235850262, 1028.2134167361974, 1030.3199888073834, 1057.4448414582405, 1057.534684738728, 1072.9570817167225, 32033.0, 32063.839680801448, 32305.631366903806, 32762.672373275964, 32848.50727239093, 1150.206357613261, 1151.228676786555, 1187.7327601289815, 1207.3118322556234, 1229.1457437081142, 16215.756763648555, 16249.756253656205, 16610.418635347705, 16656.75014874778, 16747.497575072768, 419500.0, 854938.0, 870361.0, 870520.0, 871258.0, 59462.0, 59738.0, 60234.39765602376, 60312.69843650753, 60371.39628603658, 1411.632975426376, 1423.7579611466076, 1435.9928200358931, 1442.9134251944918, 1446.9493567725078, 31338.686613133577, 32854.83572582122, 32926.83536582398, 33060.51227694807, 33654.49518257277, 49342.50657493379, 50132.49867501424, 50295.245571315725, 50318.49681503138, 50387.496125038284, 372462.0, 373761.0, 376393.0, 378117.0, 378745.0, 36532.269354612225, 36570.8171459141, 36743.448848266766, 36751.26497469982, 36799.63200367962, 46851.53148468608, 46917.765411172724, 47462.91491053071, 47619.523804761506, 47747.0, 39248.0, 39307.0, 39317.0, 39534.20931581295, 39768.801155994035, 38869.22261554696, 39807.0, 39966.80016600015, 40020.0, 40264.3960340601, 39670.2065958685, 40327.79836100918, 40452.39321410123, 41182.0, 41336.58663413327, 33870.491942620385, 35074.123146921534, 35118.0, 35361.82319088388, 35381.46927796137, 28159.0, 28233.294167645152, 28327.58362081929, 28402.0, 28460.146195614165], "unit": "score", "name": "ext.html", "value": 19946.4413600589}, {"lowerIsBetter": false, "replicates": [372.56596065583614, 375.498709223187, 377.7091639437633, 379.1317882050105, 381.38216089934275, 17219.655606887856, 17479.300827966883, 18084.909575452137, 18104.0, 18135.63728725425, 17190.914045429785, 17598.560035999075, 17667.381641642543, 17677.82322176778, 17731.113444327795, 5293.179557168635, 5517.310336207974, 5564.916526252109, 5579.69311687857, 5585.385607583163, 5430.619856610039, 5433.6196466247375, 5466.043442397585, 5470.288862447876, 5519.089350257203, 5088.440271570124, 5244.79020839166, 5254.133068043788, 5260.789568417259, 5277.8944421111555, 5347.893042139135, 5383.892322153554, 5404.945950540484, 6144.78493252734, 6167.537434692371, 5449.182622606601, 5456.345238571357, 5470.56235501159, 5499.587530935156, 5506.449355064502, 12209.93895030528, 13975.930120349332, 20714.689279660815, 21185.682214766635, 21197.36407907765, 2172.3374370816896, 2183.945401364963, 2254.267363106997, 2286.2683941138844, 2377.9405514862265, 9825.263105267133, 9910.40537567741, 9982.0, 11278.943605281922, 13718.725625487534, 1832.2762508809078, 1863.4220108641593, 1938.6510428122933, 2019.5052212207956, 2100.3803877855917, 65616.34383656198, 67928.0, 68246.65876670585, 75180.0, 79296.0, 9470.95264523673, 9822.459764713009, 10324.174066074696, 10544.525496352682, 10554.261201715806, 14038.0, 14054.578362649137, 14136.363863626162, 14160.433582656784, 14180.361883715257, 7752.961235193788, 7765.883511747328, 7786.587639589443, 7931.167227441151, 7982.321502672222, 7821.0, 7956.602169891482, 7966.362690984707, 8004.0, 8050.11448740638, 4030.7504673551293, 4082.7346222495444, 4158.8336466541605, 4233.364995250737, 4246.299360605527, 1801.7027190513681, 1887.1224880430666, 1917.0893825433086, 1929.2829033014145, 1966.8623196376402, 885.8041643780845, 902.363833497396, 952.7332346942867, 963.4460185393427, 987.1313244344931, 17440.47678569645, 17554.122293885255, 17857.196426160855, 18080.09599520045, 18354.541136471427, 989.9307048506536, 1051.106559424483, 1051.7686109055996, 1059.8463222832645, 1084.046039485248, 10041.297109202433, 10261.050400423896, 10292.228082893813, 10294.948525257325, 10405.06354428105, 438517.0, 440353.0, 461629.0, 471537.0, 508257.0, 52081.99999999924, 68981.31018689749, 80651.5967420171, 81307.59346203349, 85291.57354213313, 1033.3644808442905, 1052.1109662335314, 1071.6838532632737, 1074.1621535202555, 1075.5375188668947, 16419.507414777574, 16507.0, 16615.252313645673, 16672.583185419975, 16778.832211677727, 35454.46818297676, 35556.644433556365, 37558.248835023696, 38067.61932380641, 38271.80864095662, 51996.480035199165, 52350.73824630852, 52443.47556524538, 52516.47483525116, 52678.73660631672, 8051.396145289244, 8082.313003394777, 8087.716929907425, 8106.432549721463, 8201.58992050407, 11629.88370116288, 12871.163374380636, 13101.541446049343, 13120.212787232796, 13233.073684842353, 11255.66233013011, 11406.48670809799, 11411.657650270505, 11636.476358564054, 11639.359835209145, 10969.561217551209, 10971.067459266053, 11122.721931951766, 11242.0, 11335.603253886075, 11341.659750207507, 11525.077993760648, 11820.408979550815, 11823.46794394237, 11883.881161188623, 8225.259726624632, 8313.584320783815, 8315.0, 8393.706220282262, 8440.029396619468, 11623.76752464963, 11641.59254426091, 11652.53389864396, 11658.125640576822, 11815.409229538316], "unit": "score", "name": "jquery.html", "value": 8743.089745105268}, {"lowerIsBetter": false, "replicates": [1499.2054211268028, 1523.3449616664834, 1695.2371432855218, 1805.2688661092245, 1813.646338963901, 7369.299916507936, 7859.449838511292, 8024.959875200623, 8336.91663083369, 8337.583120843956, 8009.2391222833885, 8118.391120665959, 8276.503409795401, 8306.75079747607, 8331.375146863995, 2383.2373640435067, 2406.9398265043337, 2409.9518009639796, 2416.178499310234, 2417.3714834143075, 2438.1100898172217, 2468.6420469031978, 2469.62955556667, 2472.0606169655507, 2483.8261321707396, 2374.643803429482, 2418.89114989825, 2426.8301218914685, 2428.7085549734056, 2434.1602147259255, 2380.9404814857394, 2396.04158336665, 2408.759124087586, 2412.7225369082516, 2423.745506721795, 2427.8179136564827, 2435.5128974205054, 2448.167623008168, 2462.753724627541, 2462.913798017061, 8473.915260847436, 8484.194001569902, 8503.872441913376, 8516.361272904556, 8593.398462107654, 5224.764885580158, 5314.309139811839, 5333.280007199017, 5367.060764366221, 5387.353517577876, 3386.255023894739, 3400.931981360359, 3476.165720227127, 3539.1859872229275, 3548.769329993542, 1099.8001715648622, 1101.0475938313302, 1106.9705174188002, 1110.4725255503652, 1121.3496172220093, 11741.941290293495, 11796.646100616996, 11828.23116497425, 11903.0, 11948.103892208032, 4478.081993191388, 4586.541345865387, 4599.2871104978785, 4631.791569379386, 4688.296755486705, 9460.95269523648, 9465.053494650618, 9466.337356384987, 9474.289428292768, 9489.193418559362, 5233.319668443154, 5250.0549901018185, 5255.47445255479, 5255.947440525622, 5279.234510995884, 4211.7472951623, 4643.767811609474, 4725.432948046187, 4736.905261894743, 4831.275308703723, 3724.0689827543115, 3819.350710379242, 3823.2162406706557, 3848.9807550962064, 3868.361720316116, 1176.1237877781107, 1178.9941050294694, 1201.5073819733868, 1202.6572426858304, 1203.5005472728894, 1392.0742706100532, 1405.8102156208986, 1412.3573773932835, 1417.5322143692556, 1421.3461807568428, 8031.317338026216, 8208.917910820815, 8236.423450358418, 8243.793905152299, 8256.628451719687, 1075.4031512510476, 1149.1898211760688, 1171.5138217639756, 1186.8575770907546, 1196.3719047499958, 6349.841253968688, 6418.967905160444, 6445.2587952386075, 6473.676316184266, 6485.935140648628, 9882.357646752938, 10188.083072523508, 10219.48902554884, 10356.844647330296, 10611.628592999208, 10147.289689721796, 10193.592256309665, 10353.378797272188, 10384.11735002518, 10464.686059418078, 8019.959900200578, 8025.03699556057, 8029.5583742894705, 8089.716859909875, 8176.46852954556, 7619.9238007619215, 7734.5359278443475, 7870.803229919298, 7915.881261780963, 7944.285014348737, 8688.695895643623, 8794.384393092421, 8899.243564297107, 9035.45787252767, 9144.451332920045, 8902.510361930155, 9041.412308199946, 9084.909150908406, 9275.2579793615, 9282.932462766597, 6659.433948114464, 7217.927820721936, 7388.593627350332, 7588.544687318778, 7719.536827790351, 8103.918960810316, 8115.675372985014, 8151.877721834058, 8169.79575510617, 8172.918270817454, 7319.2314806944505, 7461.141968673672, 7476.887846682195, 7533.924660753322, 7579.962100189464, 7331.2302208267365, 7393.519421237603, 7423.517471364344, 7498.512596681198, 7507.812304692208, 7477.663505142173, 7482.3639990601405, 7498.887516687363, 7577.355924746458, 7595.88606170919, 7049.436045116481, 7059.329363710439, 7162.176349719641, 7182.317679820409, 7221.711131554679, 7202.567845929261, 7210.71157153708, 7238.0952380952385, 7240.8913866290995, 7270.236625154283], "unit": "score", "name": "mootools.html", "value": 4866.810015774088}, {"lowerIsBetter": false, "replicates": [333.28510345309314, 339.5195797945905, 341.2901165575603, 342.8114537004648, 345.7026956817137, 6279.089532017861, 6377.39414755598, 6455.225372955252, 6492.870142597151, 6496.155499785022, 6367.331430199832, 6389.488840892729, 6394.584352017116, 6413.903791443132, 6464.385883341075, 4664.883377915546, 4739.170645137105, 4768.356271903283, 4770.833020844271, 4844.20070688336, 4729.337892695025, 4752.453467851189, 4752.809887604509, 4756.0, 4757.04859028194, 4706.388169537955, 4718.386609740729, 4720.504347043562, 4723.362346083286, 4725.645576581753, 4716.2218233991525, 4726.527347265263, 4730.834420795273, 4734.881627959294, 4840.6127509799135, 4173.707840451169, 4184.4141820145205, 4184.769837658928, 4185.351270553069, 4188.874333769992, 6081.6351018939, 6145.907811382833, 6157.3534778848025, 6157.815265542041, 6165.383461653843, 5375.973120134374, 5483.4920396890775, 5593.133064375028, 5597.496225339698, 5606.046972014768, 6651.368120028589, 6670.533062685614, 6684.465242780566, 6687.164104486939, 6719.0593316935665, 4561.794719237642, 4565.383673204108, 4571.725696458223, 4573.702709323883, 4578.5650363215445, 6922.169339679221, 6986.231514533448, 6992.440604751659, 7015.508914375996, 7041.838096713985, 4617.8383756568355, 4709.0, 4723.197056500403, 4727.2909063640045, 4729.763511824395, 4749.335093086971, 4779.569838714463, 4780.378550788375, 4781.593564546983, 4789.449213340441, 5537.529310008695, 5576.7211639417865, 5579.246801681802, 5579.6652200868075, 5581.134924086773, 6738.0, 6785.457163426914, 6793.660316984131, 6805.013273075377, 6811.9659401702675, 1652.4712092130403, 1677.1530377159456, 1677.4799812058302, 1681.4031018988328, 1682.276621052959, 1032.230987914009, 1074.312440038376, 1081.1350919264557, 1086.2342048855696, 1086.538221255979, 6492.837679057967, 6509.804705858737, 6537.0, 6564.0, 6564.0, 6997.895031574531, 6999.615021173782, 7005.894911576331, 7006.229314775371, 7032.92967070333, 6449.742010319628, 6500.089987401768, 6591.0442985766795, 6637.601743895285, 6655.933440665532, 3799.3920972644246, 3815.1606646537716, 3817.7900215488417, 3825.6365645263654, 3828.5022947017264, 7280.41756659466, 7307.7807665770115, 7314.524555903956, 7315.195328513859, 7341.669624866894, 7240.891386629205, 7252.202257751643, 7283.417326613858, 7285.089363829521, 7293.927060729431, 7079.752208672672, 7270.600116993616, 7292.562446253241, 7301.963490182515, 7345.265473452719, 7031.613261270679, 7061.929380706332, 7072.3634872861685, 7073.6463176839925, 7084.822879428056, 6978.197507286727, 7009.1939426966555, 7012.2286548478605, 7019.964900175466, 7026.6135362553505, 7270.0, 7295.708171673074, 7313.414926805949, 7326.3406293433845, 7326.96336518314, 4553.749543775124, 4672.626189904731, 4683.367745354333, 4687.5781179693995, 4708.529147085401, 6970.546914450544, 6995.545289556163, 7014.824629384306, 7015.6842942066705, 7023.262557431396, 6811.761588344384, 6819.488538359742, 6844.281350458329, 6850.801109805664, 6851.828704282433, 6669.0663307136065, 6674.16572928384, 6674.16572928384, 6677.766278180435, 6678.7328506859185, 6442.2591401989375, 6613.966930165318, 6733.595984240961, 6746.325367463214, 6748.73005079811, 6873.243943166348, 6896.137982752156, 6915.6887940043825, 6928.445724342141, 6934.479914006571, 6689.163854518185, 6691.2639609643875, 6737.831554211184, 6743.763968261087, 6760.053592496956], "unit": "score", "name": "prototype.html", "value": 5071.655158792067}, {"lowerIsBetter": false, "replicates": [795.7732046366783, 825.2201669422394, 839.3578912132224, 839.6935118681681, 871.7166920750758, 14009.579712608613, 15704.842951570481, 16125.677486450279, 16199.514014579581, 16203.756943645825, 15235.695286094298, 15259.923700381483, 15288.31202595883, 15295.0, 15318.923405382957, 686.4508393285352, 824.2705205892798, 840.0759164918602, 852.7740148860557, 855.2601999270648, 848.2069265237024, 849.1762989899787, 852.910444403338, 853.5988085599759, 853.6670698427619, 866.3069544364515, 867.7483529776357, 867.8437881181385, 868.1188593577524, 869.7738587967142, 851.748734123435, 854.0989256334565, 859.9656013759442, 861.1861790607878, 863.6372723456163, 618.9009758438673, 619.7366119399283, 621.3258614403378, 621.8041316985181, 626.7962912053555, 14176.92911535446, 14183.858161418357, 14236.359363828653, 14263.78604320936, 14299.571012869526, 14049.43802247909, 14108.788368174486, 14132.505362312373, 14146.646333841736, 14294.142351458842, 11189.72025699364, 11200.327980321124, 11220.831687524693, 11325.263857849213, 11340.092792576574, 3768.9623103768886, 3784.735068545203, 3795.2409518096215, 3851.306764782366, 3853.344931361675, 54995.450045499434, 55423.0, 55553.44446555523, 55662.0, 55665.16502252469, 11172.10623150146, 11186.832197517044, 11227.27022743519, 11387.658370248906, 11459.828102578467, 20338.491537711674, 20489.795102049087, 20526.07632656534, 20580.176792928414, 20596.27913023067, 8265.504069755834, 8296.917030829614, 8413.70552030676, 8413.95793021031, 8755.255803256667, 4709.599684026896, 4728.834490792875, 5006.4743201964, 5065.645404821701, 5185.403678576937, 3377.6960073593496, 3378.662133786651, 3387.6104248011793, 3401.5748031496064, 3410.2326976430104, 597.9342272350038, 609.3845216331448, 610.0513701194596, 610.3499772742016, 610.7862248213179, 565.2341077839551, 665.8601693644292, 690.1993687322681, 701.4388489208612, 703.8768215562257, 8193.46742461738, 8838.55807209637, 8846.601902914384, 8849.64601415949, 8904.109589041174, 571.1147721032384, 604.0456079394546, 628.3527966194827, 670.8394477553859, 701.4458577723643, 3959.980200098981, 4201.978990105091, 4232.285924200703, 4262.595053469915, 4338.305871060616, 57203.71398142983, 57727.711361442925, 58048.4195158043, 58089.709551451975, 58595.70702146462, 51053.48946510562, 52643.473565263856, 52846.35768211574, 53048.46951530435, 53133.46866531285, 47480.762596186796, 47629.28556071662, 47927.76036119867, 48146.27780583294, 48695.75652121717, 8238.546879921661, 8489.490630562186, 8628.913710863062, 8732.039475657799, 8751.212390884852, 35389.823050885614, 35750.106247342985, 36100.45849312315, 36564.63435365719, 36705.28876834699, 41961.0, 44795.77602111969, 45359.77320113379, 45619.543804562854, 45813.31280030736, 11290.604828830952, 11396.145289103184, 11415.37215453125, 11806.232594881305, 11820.82268765952, 12873.098883078095, 13021.395720855677, 13316.800247996482, 13332.666683332995, 13487.730245394841, 11879.0, 12127.81808272859, 12282.324472154118, 12285.447154877873, 12569.685757856127, 12270.570530031406, 12339.13626046168, 12366.134370593973, 12449.633175114564, 12479.0, 11255.437228138724, 11272.380019099028, 11660.999371778018, 11931.105167112328, 12154.209976351509, 9863.112319891245, 9929.950350248202, 10273.0, 10483.947580262049, 10759.408232547285, 10408.181555650795, 10701.0, 10814.837777433502, 10844.403557804397, 11015.228933974546], "unit": "score", "name": "yui.html", "value": 6707.181717693018}], "name": "dromaeo_css", "value": 7295.923183483858}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 112.0, 111.0, 111.0, 125.0, 110.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [162.0, 123.0, 154.0, 168.0, 128.0, 155.0, 148.0, 129.0, 169.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 164.0, 161.0, 164.0, 163.0, 163.0, 167.0, 171.0, 169.0], "unit": "score", "name": "audio-dft", "value": 164.9}, {"lowerIsBetter": true, "replicates": [77.0, 72.0, 88.0, 77.0, 75.0, 73.0, 73.0, 73.0, 153.0, 75.0], "unit": "score", "name": "audio-fft", "value": 83.6}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 135.0, 94.0, 94.0, 93.0, 150.0, 94.0, 94.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 116.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.6}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 146.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 100.0, 96.0, 98.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 60.0, 59.0, 62.0, 59.0, 56.0, 58.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 60.0, 61.0, 60.0, 61.0, 59.0, 60.0, 60.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.1}, {"lowerIsBetter": true, "replicates": [83.0, 79.0, 80.0, 88.0, 79.0, 78.0, 78.0, 81.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.0}, {"lowerIsBetter": true, "replicates": [116.0, 120.0, 120.0, 129.0, 122.0, 120.0, 111.0, 126.0, 111.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.9}, {"lowerIsBetter": true, "replicates": [137.0, 146.0, 150.0, 146.0, 144.0, 143.0, 147.0, 141.0, 142.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 75.0, 63.0, 65.0, 63.0, 62.0, 62.0, 61.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.2}], "name": "kraken", "value": 1502.6999999999998}]} 17:34:48 INFO - Return code: 0 17:34:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:34:48 ERROR - # TBPL SUCCESS # 17:34:48 INFO - Running post-action listener: _resource_record_post_action 17:34:48 INFO - Running post-run listener: _resource_record_post_run 17:34:49 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 537280512; Read time: 144; Write time: 561724 17:34:49 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 242966528; Read time: 0; Write time: 408968 17:34:49 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294252544; Read time: 144; Write time: 152716 17:34:49 INFO - Running post-run listener: _upload_blobber_files 17:34:49 INFO - Blob upload gear active. 17:34:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:34:49 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 17:34:49 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:34:49 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:34:51 INFO - (blobuploader) - INFO - Open directory for files ... 17:34:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:34:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:34:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:55 INFO - (blobuploader) - INFO - Done attempting. 17:34:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:34:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:34:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:58 INFO - (blobuploader) - INFO - Done attempting. 17:34:58 INFO - (blobuploader) - INFO - Iteration through files over. 17:34:58 INFO - Return code: 0 17:34:58 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:34:58 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:34:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efb8b1bf80b91b5da1c779182eb0cb6a5878a40e458fbdd48a216e602b5af1953e988fd5ce0f55ae03efee62819c7d0adede9e95e45002c1701205ce641ba197", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f134eaa9e95ba26bb4187548931882f6023f17e4ffbbb24014c5521913c4d4497281b663cb2601860eb404d6150d4d2c0bb384afbd7cf93d0ccd6a4186bca27"} 17:34:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:34:58 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:34:58 INFO - Contents: 17:34:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/efb8b1bf80b91b5da1c779182eb0cb6a5878a40e458fbdd48a216e602b5af1953e988fd5ce0f55ae03efee62819c7d0adede9e95e45002c1701205ce641ba197", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f134eaa9e95ba26bb4187548931882f6023f17e4ffbbb24014c5521913c4d4497281b663cb2601860eb404d6150d4d2c0bb384afbd7cf93d0ccd6a4186bca27"} 17:34:58 INFO - Running post-run listener: copy_logs_to_upload_dir 17:34:58 INFO - Copying logs to upload dir... 17:34:58 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:34:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.179466 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-28 17:34:56.144339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 17:34:56.147601) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782 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/Fx-Team/sha512/efb8b1bf80b91b5da1c779182eb0cb6a5878a40e458fbdd48a216e602b5af1953e988fd5ce0f55ae03efee62819c7d0adede9e95e45002c1701205ce641ba197", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f134eaa9e95ba26bb4187548931882f6023f17e4ffbbb24014c5521913c4d4497281b663cb2601860eb404d6150d4d2c0bb384afbd7cf93d0ccd6a4186bca27"} build_url:https://queue.taskcluster.net/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011384 build_url: 'https://queue.taskcluster.net/v1/task/GcBcGdEKQTy9L2LAeS9kfQ/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/Fx-Team/sha512/efb8b1bf80b91b5da1c779182eb0cb6a5878a40e458fbdd48a216e602b5af1953e988fd5ce0f55ae03efee62819c7d0adede9e95e45002c1701205ce641ba197", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f134eaa9e95ba26bb4187548931882f6023f17e4ffbbb24014c5521913c4d4497281b663cb2601860eb404d6150d4d2c0bb384afbd7cf93d0ccd6a4186bca27"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 17:34:56.178898) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 17:34:56.179216) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1459210331.809183-1863101782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 17:34:56.269649) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 17:34:56.269962) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 17:34:56.270270) ========= ========= Total master_lag: 0.29 =========