builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-028 starttime: 1460004853.89 results: success (0) buildid: 20160406193137 builduid: ab6eadf99ca64a8a810b7408af20e4db revision: ab62a777c115ca638278771925f27921675b9efd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:13.893446) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:13.894020) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:13.894361) ========= 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=836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006429 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:13.919340) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:13.919679) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:13.935045) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:13.935536) ========= 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=836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004670 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:13.986737) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:13.987036) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:13.987423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:13.987779) ========= 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=836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-06 21:54:14-- 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% 86.6M=0s 2016-04-06 21:54:14 (86.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090576 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:14.091111) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:14.091427) ========= 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=836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022106 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:14.143618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:14.144423) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ab62a777c115ca638278771925f27921675b9efd --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ab62a777c115ca638278771925f27921675b9efd --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=836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-06 21:54:14,613 truncating revision to first 12 chars 2016-04-06 21:54:14,613 Setting DEBUG logging. 2016-04-06 21:54:14,613 attempt 1/10 2016-04-06 21:54:14,613 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ab62a777c115?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-06 21:54:15,272 unpacking tar archive at: mozilla-inbound-ab62a777c115/testing/mozharness/ program finished with exit code 0 elapsedTime=0.919720 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:15.083130) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:15.083517) ========= echo ab62a777c115ca638278771925f27921675b9efd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ab62a777c115ca638278771925f27921675b9efd'] 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=836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ab62a777c115ca638278771925f27921675b9efd program finished with exit code 0 elapsedTime=0.004841 script_repo_revision: 'ab62a777c115ca638278771925f27921675b9efd' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:15.142053) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:15.142377) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:15.153362) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-06 21:54:15.153676) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:54:15 INFO - MultiFileLogger online at 20160406 21:54:15 in /builds/slave/test-pgo 21:54:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:54:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:54:15 INFO - {'append_to_log': False, 21:54:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:54:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:54:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:54:15 INFO - 'branch': 'Mozilla-Inbound', 21:54:15 INFO - 'buildbot_json_path': 'buildprops.json', 21:54:15 INFO - 'config_files': ('talos/linux_config.py',), 21:54:15 INFO - 'default_actions': ('clobber', 21:54:15 INFO - 'read-buildbot-config', 21:54:15 INFO - 'download-and-extract', 21:54:15 INFO - 'populate-webroot', 21:54:15 INFO - 'create-virtualenv', 21:54:15 INFO - 'install', 21:54:15 INFO - 'run-tests'), 21:54:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:54:15 INFO - 'download_minidump_stackwalk': True, 21:54:15 INFO - 'download_symbols': 'ondemand', 21:54:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:54:15 INFO - 'tooltool.py': '/tools/tooltool.py', 21:54:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:54:15 INFO - '/tools/misc-python/virtualenv.py')}, 21:54:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:54:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:54:15 INFO - 'installer_path': 'installer.exe', 21:54:15 INFO - 'log_level': 'info', 21:54:15 INFO - 'log_name': 'talos', 21:54:15 INFO - 'log_to_console': True, 21:54:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:54:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:54:15 INFO - 'opt_config_files': (), 21:54:15 INFO - 'pip_index': False, 21:54:15 INFO - 'sps_profile': False, 21:54:15 INFO - 'sps_profile_interval': 0, 21:54:15 INFO - 'suite': 'dromaeojs-e10s', 21:54:15 INFO - 'system_bits': '32', 21:54:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:54:15 INFO - 'title': 'talos-linux64-ix-028', 21:54:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:54:15 INFO - 'use_talos_json': True, 21:54:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:54:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:54:15 INFO - 'work_dir': 'build'} 21:54:15 INFO - ##### 21:54:15 INFO - ##### Running clobber step. 21:54:15 INFO - ##### 21:54:15 INFO - Running pre-action listener: _resource_record_pre_action 21:54:15 INFO - Running main action method: clobber 21:54:15 INFO - rmtree: /builds/slave/test-pgo/build 21:54:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:54:16 INFO - Running post-action listener: _resource_record_post_action 21:54:16 INFO - ##### 21:54:16 INFO - ##### Running read-buildbot-config step. 21:54:16 INFO - ##### 21:54:16 INFO - Running pre-action listener: _resource_record_pre_action 21:54:16 INFO - Running main action method: read_buildbot_config 21:54:16 INFO - Using buildbot properties: 21:54:16 INFO - { 21:54:16 INFO - "project": "", 21:54:16 INFO - "product": "firefox", 21:54:16 INFO - "script_repo_revision": "production", 21:54:16 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:54:16 INFO - "repository": "", 21:54:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:54:16 INFO - "buildid": "20160406193137", 21:54:16 INFO - "pgo_build": "True", 21:54:16 INFO - "basedir": "/builds/slave/test-pgo", 21:54:16 INFO - "buildnumber": 897, 21:54:16 INFO - "slavename": "talos-linux64-ix-028", 21:54:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:54:16 INFO - "platform": "ubuntu64_hw", 21:54:16 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:54:16 INFO - "branch": "mozilla-inbound", 21:54:16 INFO - "repo_path": "integration/mozilla-inbound", 21:54:16 INFO - "revision": "ab62a777c115ca638278771925f27921675b9efd", 21:54:16 INFO - "stage_platform": "linux64-pgo", 21:54:16 INFO - "builduid": "ab6eadf99ca64a8a810b7408af20e4db", 21:54:16 INFO - "slavebuilddir": "test" 21:54:16 INFO - } 21:54:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 21:54:16 INFO - Running post-action listener: _resource_record_post_action 21:54:16 INFO - ##### 21:54:16 INFO - ##### Running download-and-extract step. 21:54:16 INFO - ##### 21:54:16 INFO - Running pre-action listener: _resource_record_pre_action 21:54:16 INFO - Running main action method: download_and_extract 21:54:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:16 INFO - https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:54:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:54:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:54:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:25 INFO - Downloaded 1361 bytes. 21:54:25 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:54:25 INFO - Using the following test package requirements: 21:54:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:54:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:54:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:54:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:25 INFO - u'jsshell-linux-x86_64.zip'], 21:54:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:54:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:54:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:54:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:54:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:54:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:54:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:54:25 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')]} 21:54:25 INFO - https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:54:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:54:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:54:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:27 INFO - Downloaded 23707416 bytes. 21:54:27 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'] 21:54:27 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 21:54:28 INFO - Return code: 0 21:54:28 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 21:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:28 INFO - https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:54:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:54:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:54:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:34 INFO - Downloaded 23707416 bytes. 21:54:34 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'] 21:54:34 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 21:54:35 INFO - Return code: 0 21:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:35 INFO - https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:54:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:54:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:54:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:38 INFO - Downloaded 10847693 bytes. 21:54:38 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'] 21:54:38 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 21:54:38 INFO - Return code: 0 21:54: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')]} 21:54:38 INFO - https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:54:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:54:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:54:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:40 INFO - Downloaded 57855899 bytes. 21:54:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:54:40 INFO - mkdir: /builds/slave/test-pgo/properties 21:54:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:54:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:54:40 INFO - Contents: 21:54:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:54:41 INFO - Running post-action listener: _resource_record_post_action 21:54:41 INFO - Running post-action listener: set_extra_try_arguments 21:54:41 INFO - ##### 21:54:41 INFO - ##### Running populate-webroot step. 21:54:41 INFO - ##### 21:54:41 INFO - Running pre-action listener: _resource_record_pre_action 21:54:41 INFO - Running main action method: populate_webroot 21:54:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:54:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:54:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:54:41 INFO - '--tppagecycles', 21:54:41 INFO - '7'], 21:54:41 INFO - 'tests': ['tsvgm']}}, 21:54:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:54:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:54:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:54:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:54:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:54:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:54:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:41 INFO - 'talos_options': ['--disable-e10s'], 21:54:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:54:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:54:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:41 INFO - 'talos_options': ['--disable-e10s'], 21:54:41 INFO - 'tests': ['damp', 'tps']}, 21:54:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:41 INFO - 'tests': ['damp', 'tps']}, 21:54:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:54:41 INFO - 'tests': ['dromaeo_dom']}, 21:54:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:54:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:54:41 INFO - 'tests': ['a11yr', 21:54:41 INFO - 'ts_paint', 21:54:41 INFO - 'tpaint', 21:54:41 INFO - 'sessionrestore', 21:54:41 INFO - 'sessionrestore_no_auto_restore', 21:54:41 INFO - 'tabpaint']}, 21:54:41 INFO - 'other-e10s': {'tests': ['a11yr', 21:54:41 INFO - 'ts_paint', 21:54:41 INFO - 'tpaint', 21:54:41 INFO - 'sessionrestore', 21:54:41 INFO - 'sessionrestore_no_auto_restore', 21:54:41 INFO - 'tabpaint']}, 21:54:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:54:41 INFO - 'ts_paint', 21:54:41 INFO - 'tpaint', 21:54:41 INFO - 'sessionrestore', 21:54:41 INFO - 'sessionrestore_no_auto_restore', 21:54:41 INFO - 'tabpaint']}, 21:54:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:54:41 INFO - 'ts_paint', 21:54:41 INFO - 'tpaint', 21:54:41 INFO - 'sessionrestore', 21:54:41 INFO - 'sessionrestore_no_auto_restore', 21:54:41 INFO - 'tabpaint']}, 21:54:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:54:41 INFO - 'tests': ['a11yr', 21:54:41 INFO - 'ts_paint', 21:54:41 INFO - 'tpaint', 21:54:41 INFO - 'sessionrestore', 21:54:41 INFO - 'sessionrestore_no_auto_restore', 21:54:41 INFO - 'tabpaint']}, 21:54:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:54:41 INFO - 'tests': ['a11yr', 21:54:41 INFO - 'ts_paint', 21:54:41 INFO - 'tpaint', 21:54:41 INFO - 'sessionrestore', 21:54:41 INFO - 'sessionrestore_no_auto_restore', 21:54:41 INFO - 'tabpaint']}, 21:54:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:54:41 INFO - 'tests': ['tsvgx', 21:54:41 INFO - 'tsvgr_opacity', 21:54:41 INFO - 'tart', 21:54:41 INFO - 'tscrollx', 21:54:41 INFO - 'cart']}, 21:54:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:54:41 INFO - 'tsvgr_opacity', 21:54:41 INFO - 'tart', 21:54:41 INFO - 'tscrollx', 21:54:41 INFO - 'cart']}, 21:54:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:41 INFO - 'talos_options': ['--disable-e10s'], 21:54:41 INFO - 'tests': ['tp5o']}, 21:54:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:41 INFO - 'tests': ['tp5o']}, 21:54:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:41 INFO - 'talos_options': ['--disable-e10s', 21:54:41 INFO - '--xperf_path', 21:54:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:54:41 INFO - 'tests': ['tp5n']}, 21:54:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:41 INFO - 'talos_options': ['--xperf_path', 21:54:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:54:41 INFO - 'tests': ['tp5n']}}, 21:54:41 INFO - 'talos.zip': {'path': '', 21:54:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:54:41 INFO - Running post-action listener: _resource_record_post_action 21:54:41 INFO - ##### 21:54:41 INFO - ##### Running create-virtualenv step. 21:54:41 INFO - ##### 21:54:41 INFO - Running pre-action listener: _resource_record_pre_action 21:54:41 INFO - Running main action method: create_virtualenv 21:54:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:54:41 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 21:54:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:54:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:54:41 INFO - Using real prefix '/usr' 21:54:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:54:41 INFO - Installing distribute.............................................................................................................................................................................................done. 21:54:43 INFO - Installing pip.................done. 21:54:43 INFO - Return code: 0 21:54:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72acd4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aca8b0>, '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 0x1acb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acbc60>, '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': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', '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 21:54:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:54:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:54:43 INFO - Using env: {'DISPLAY': ':0', 21:54:43 INFO - 'HOME': '/home/cltbld', 21:54:43 INFO - 'LANG': 'en_US.UTF-8', 21:54:43 INFO - 'LANGUAGE': 'en_US:en', 21:54:43 INFO - 'LOGNAME': 'cltbld', 21:54:43 INFO - 'MAIL': '/var/mail/cltbld', 21:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:43 INFO - 'MOZ_NO_REMOTE': '1', 21:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:43 INFO - 'NO_EM_RESTART': '1', 21:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:43 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:43 INFO - 'SHELL': '/bin/bash', 21:54:43 INFO - 'SHLVL': '1', 21:54:43 INFO - 'TERM': 'linux', 21:54:43 INFO - 'TMOUT': '86400', 21:54:43 INFO - 'USER': 'cltbld', 21:54:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', 21:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:43 INFO - '_': '/tools/buildbot/bin/python'} 21:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:44 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 21:54:44 INFO - Cleaning up... 21:54:44 INFO - Return code: 0 21:54:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:54: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')]} 21:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54: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')]} 21:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54: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', '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 0x7f72acd4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aca8b0>, '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 0x1acb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acbc60>, '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': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', '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 21:54: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:54: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 psutil>=0.7.1 21:54:44 INFO - Using env: {'DISPLAY': ':0', 21:54:44 INFO - 'HOME': '/home/cltbld', 21:54:44 INFO - 'LANG': 'en_US.UTF-8', 21:54:44 INFO - 'LANGUAGE': 'en_US:en', 21:54:44 INFO - 'LOGNAME': 'cltbld', 21:54:44 INFO - 'MAIL': '/var/mail/cltbld', 21:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:44 INFO - 'MOZ_NO_REMOTE': '1', 21:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:44 INFO - 'NO_EM_RESTART': '1', 21:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:44 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:44 INFO - 'SHELL': '/bin/bash', 21:54:44 INFO - 'SHLVL': '1', 21:54:44 INFO - 'TERM': 'linux', 21:54:44 INFO - 'TMOUT': '86400', 21:54:44 INFO - 'USER': 'cltbld', 21:54:44 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', 21:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:44 INFO - '_': '/tools/buildbot/bin/python'} 21:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:44 INFO - Downloading/unpacking psutil>=0.7.1 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:54:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:54:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:54:46 INFO - Installing collected packages: psutil 21:54:46 INFO - Running setup.py install for psutil 21:54:46 INFO - building 'psutil._psutil_linux' extension 21:54:46 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 21:54:46 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 21:54:46 INFO - building 'psutil._psutil_posix' extension 21:54:46 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 21:54:46 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 21:54:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:54:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:54:46 INFO - Successfully installed psutil 21:54:46 INFO - Cleaning up... 21:54:46 INFO - Return code: 0 21:54:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:54:46 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')]} 21:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:46 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')]} 21:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:46 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 0x7f72acd4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aca8b0>, '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 0x1acb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acbc60>, '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': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', '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 21:54:46 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 21:54:46 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 21:54:46 INFO - Using env: {'DISPLAY': ':0', 21:54:46 INFO - 'HOME': '/home/cltbld', 21:54:46 INFO - 'LANG': 'en_US.UTF-8', 21:54:46 INFO - 'LANGUAGE': 'en_US:en', 21:54:46 INFO - 'LOGNAME': 'cltbld', 21:54:46 INFO - 'MAIL': '/var/mail/cltbld', 21:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:46 INFO - 'MOZ_NO_REMOTE': '1', 21:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:46 INFO - 'NO_EM_RESTART': '1', 21:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:46 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:46 INFO - 'SHELL': '/bin/bash', 21:54:46 INFO - 'SHLVL': '1', 21:54:46 INFO - 'TERM': 'linux', 21:54:46 INFO - 'TMOUT': '86400', 21:54:46 INFO - 'USER': 'cltbld', 21:54:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', 21:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:46 INFO - '_': '/tools/buildbot/bin/python'} 21:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:54:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:54:48 INFO - Installing collected packages: mozsystemmonitor 21:54:48 INFO - Running setup.py install for mozsystemmonitor 21:54:49 INFO - Successfully installed mozsystemmonitor 21:54:49 INFO - Cleaning up... 21:54:49 INFO - Return code: 0 21:54:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:49 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 0x7f72acd4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aca8b0>, '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 0x1acb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acbc60>, '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': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', '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 21:54:49 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 21:54:49 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 21:54:49 INFO - Using env: {'DISPLAY': ':0', 21:54:49 INFO - 'HOME': '/home/cltbld', 21:54:49 INFO - 'LANG': 'en_US.UTF-8', 21:54:49 INFO - 'LANGUAGE': 'en_US:en', 21:54:49 INFO - 'LOGNAME': 'cltbld', 21:54:49 INFO - 'MAIL': '/var/mail/cltbld', 21:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:49 INFO - 'MOZ_NO_REMOTE': '1', 21:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:49 INFO - 'NO_EM_RESTART': '1', 21:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:49 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:49 INFO - 'SHELL': '/bin/bash', 21:54:49 INFO - 'SHLVL': '1', 21:54:49 INFO - 'TERM': 'linux', 21:54:49 INFO - 'TMOUT': '86400', 21:54:49 INFO - 'USER': 'cltbld', 21:54:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', 21:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:49 INFO - '_': '/tools/buildbot/bin/python'} 21:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:49 INFO - Downloading/unpacking blobuploader==1.2.4 21:54:49 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 21:54:49 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 21:54:49 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 21:54:49 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 21:54:49 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 21:54:49 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 21:54:51 INFO - Downloading blobuploader-1.2.4.tar.gz 21:54:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:54:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:54:51 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 21:54:51 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 21:54:51 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 21:54:51 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 21:54:51 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 21:54:51 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 21:54:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:54:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:54:51 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 21:54:51 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 21:54:51 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 21:54:51 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 21:54:51 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 21:54:51 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 21:54:51 INFO - Downloading docopt-0.6.1.tar.gz 21:54:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:54:51 INFO - Installing collected packages: blobuploader, requests, docopt 21:54:51 INFO - Running setup.py install for blobuploader 21:54:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:54:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:54:52 INFO - Running setup.py install for requests 21:54:52 INFO - Running setup.py install for docopt 21:54:52 INFO - Successfully installed blobuploader requests docopt 21:54:52 INFO - Cleaning up... 21:54:52 INFO - Return code: 0 21:54:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:52 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 0x7f72acd4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aca8b0>, '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 0x1acb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acbc60>, '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': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', '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 21:54:52 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 21:54:52 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 21:54:52 INFO - Using env: {'DISPLAY': ':0', 21:54:52 INFO - 'HOME': '/home/cltbld', 21:54:52 INFO - 'LANG': 'en_US.UTF-8', 21:54:52 INFO - 'LANGUAGE': 'en_US:en', 21:54:52 INFO - 'LOGNAME': 'cltbld', 21:54:52 INFO - 'MAIL': '/var/mail/cltbld', 21:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:52 INFO - 'MOZ_NO_REMOTE': '1', 21:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:52 INFO - 'NO_EM_RESTART': '1', 21:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:52 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:52 INFO - 'SHELL': '/bin/bash', 21:54:52 INFO - 'SHLVL': '1', 21:54:52 INFO - 'TERM': 'linux', 21:54:52 INFO - 'TMOUT': '86400', 21:54:52 INFO - 'USER': 'cltbld', 21:54:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', 21:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:52 INFO - '_': '/tools/buildbot/bin/python'} 21:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:52 INFO - Running setup.py (path:/tmp/pip-bUZMQm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:52 INFO - Running setup.py (path:/tmp/pip-Za9uMy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:52 INFO - Running setup.py (path:/tmp/pip-a5zoo8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:53 INFO - Running setup.py (path:/tmp/pip-ADfDsR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:53 INFO - Running setup.py (path:/tmp/pip-tuj8Xe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:53 INFO - Running setup.py (path:/tmp/pip-Ek18_R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:54:53 INFO - Running setup.py (path:/tmp/pip-TY8Ylo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:54:53 INFO - Running setup.py (path:/tmp/pip-LApNIV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:54:53 INFO - Running setup.py (path:/tmp/pip-0ZkpeY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:54:53 INFO - Running setup.py (path:/tmp/pip-VwYl39-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:54:53 INFO - Running setup.py (path:/tmp/pip-GaIhjB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:54:53 INFO - Running setup.py (path:/tmp/pip-D2ePuS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:53 INFO - Running setup.py (path:/tmp/pip-MigDzU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:53 INFO - Running setup.py (path:/tmp/pip-fmwU6U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:53 INFO - Running setup.py (path:/tmp/pip-RZRsYK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:53 INFO - Running setup.py (path:/tmp/pip-km2RLJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:53 INFO - Running setup.py (path:/tmp/pip-9vSLr4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:54:54 INFO - Running setup.py install for manifestparser 21:54:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:54:54 INFO - Running setup.py install for mozcrash 21:54:54 INFO - Running setup.py install for mozdebug 21:54:54 INFO - Running setup.py install for mozdevice 21:54:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:54:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:54:54 INFO - Running setup.py install for mozfile 21:54:54 INFO - Running setup.py install for mozhttpd 21:54:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:54:54 INFO - Running setup.py install for mozinfo 21:54:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:54:54 INFO - Running setup.py install for mozInstall 21:54:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:54:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:54:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:54:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:54:54 INFO - Running setup.py install for mozleak 21:54:54 INFO - Running setup.py install for mozlog 21:54:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:54:55 INFO - Running setup.py install for moznetwork 21:54:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:54:55 INFO - Running setup.py install for mozprocess 21:54:55 INFO - Running setup.py install for mozprofile 21:54:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:54:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:54:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:54:55 INFO - Running setup.py install for mozrunner 21:54:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:54:55 INFO - Running setup.py install for mozscreenshot 21:54:55 INFO - Running setup.py install for moztest 21:54:55 INFO - Running setup.py install for mozversion 21:54:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:54:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:54:55 INFO - Cleaning up... 21:54:55 INFO - Return code: 0 21:54:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:54: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')]} 21:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54: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')]} 21:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f72acd4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aca8b0>, '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 0x1acb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acbc60>, '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': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', '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 21:54:55 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 21:54:55 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 21:54:55 INFO - Using env: {'DISPLAY': ':0', 21:54:55 INFO - 'HOME': '/home/cltbld', 21:54:55 INFO - 'LANG': 'en_US.UTF-8', 21:54:55 INFO - 'LANGUAGE': 'en_US:en', 21:54:55 INFO - 'LOGNAME': 'cltbld', 21:54:55 INFO - 'MAIL': '/var/mail/cltbld', 21:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:55 INFO - 'MOZ_NO_REMOTE': '1', 21:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:55 INFO - 'NO_EM_RESTART': '1', 21:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:55 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:55 INFO - 'SHELL': '/bin/bash', 21:54:55 INFO - 'SHLVL': '1', 21:54:55 INFO - 'TERM': 'linux', 21:54:55 INFO - 'TMOUT': '86400', 21:54:55 INFO - 'USER': 'cltbld', 21:54:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', 21:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:55 INFO - '_': '/tools/buildbot/bin/python'} 21:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:56 INFO - Running setup.py (path:/tmp/pip-U3bFqK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:56 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)) 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:56 INFO - Running setup.py (path:/tmp/pip-gDQla8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:56 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)) 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:56 INFO - Running setup.py (path:/tmp/pip-h_3NUh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:56 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)) 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:56 INFO - Running setup.py (path:/tmp/pip-jUt8ZO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:56 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)) 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:56 INFO - Running setup.py (path:/tmp/pip-dOJwkL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:56 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)) 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:56 INFO - Running setup.py (path:/tmp/pip-FN6G0e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:56 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)) 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:54:56 INFO - Running setup.py (path:/tmp/pip-FP1eaM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:54:56 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)) 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:54:56 INFO - Running setup.py (path:/tmp/pip-vaKQIU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:54:56 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)) 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:54:56 INFO - Running setup.py (path:/tmp/pip-9H1Tmj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:54:56 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)) 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:54:56 INFO - Running setup.py (path:/tmp/pip-dRILdB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:54:56 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)) 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:54:56 INFO - Running setup.py (path:/tmp/pip-jViRbs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:54:56 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)) 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:54:56 INFO - Running setup.py (path:/tmp/pip-TjSXhi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:54:56 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)) 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:56 INFO - Running setup.py (path:/tmp/pip-fugz2f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:56 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)) 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:56 INFO - Running setup.py (path:/tmp/pip-RiXjeC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:57 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)) 21:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:57 INFO - Running setup.py (path:/tmp/pip-zDQfen-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:57 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)) 21:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:57 INFO - Running setup.py (path:/tmp/pip-KAQeHx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:57 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)) 21:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:57 INFO - Running setup.py (path:/tmp/pip-pbFj4j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:57 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)) 21:54:57 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)) 21:54:57 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)) 21:54:57 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)) 21:54:57 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)) 21:54:57 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)) 21:54:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54:59 INFO - Downloading blessings-1.6.tar.gz 21:54:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:54:59 INFO - Installing collected packages: blessings 21:54:59 INFO - Running setup.py install for blessings 21:54:59 INFO - Successfully installed blessings 21:54:59 INFO - Cleaning up... 21:54:59 INFO - Return code: 0 21:54:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:54:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:54:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:54:59 INFO - Reading from file tmpfile_stdout 21:54:59 INFO - Current package versions: 21:54:59 INFO - argparse == 1.2.1 21:54:59 INFO - blessings == 1.6 21:54:59 INFO - blobuploader == 1.2.4 21:54:59 INFO - docopt == 0.6.1 21:54:59 INFO - manifestparser == 1.1 21:54:59 INFO - mozInstall == 1.12 21:54:59 INFO - mozcrash == 0.17 21:54:59 INFO - mozdebug == 0.1 21:54:59 INFO - mozdevice == 0.48 21:54:59 INFO - mozfile == 1.2 21:54:59 INFO - mozhttpd == 0.7 21:54:59 INFO - mozinfo == 0.9 21:54:59 INFO - mozleak == 0.1 21:54:59 INFO - mozlog == 3.1 21:54:59 INFO - moznetwork == 0.27 21:54:59 INFO - mozprocess == 0.22 21:54:59 INFO - mozprofile == 0.28 21:54:59 INFO - mozrunner == 6.11 21:54:59 INFO - mozscreenshot == 0.1 21:54:59 INFO - mozsystemmonitor == 0.0 21:54:59 INFO - moztest == 0.7 21:54:59 INFO - mozversion == 1.4 21:54:59 INFO - psutil == 3.1.1 21:54:59 INFO - requests == 1.2.3 21:54:59 INFO - wsgiref == 0.1.2 21:54:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:54:59 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')]} 21:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:59 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')]} 21:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:59 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 0x7f72acd4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aca8b0>, '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 0x1acb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acbc60>, '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': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', '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 21:54:59 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 21:54:59 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 21:54:59 INFO - Using env: {'DISPLAY': ':0', 21:54:59 INFO - 'HOME': '/home/cltbld', 21:54:59 INFO - 'LANG': 'en_US.UTF-8', 21:54:59 INFO - 'LANGUAGE': 'en_US:en', 21:54:59 INFO - 'LOGNAME': 'cltbld', 21:54:59 INFO - 'MAIL': '/var/mail/cltbld', 21:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:59 INFO - 'MOZ_NO_REMOTE': '1', 21:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:59 INFO - 'NO_EM_RESTART': '1', 21:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:59 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:59 INFO - 'SHELL': '/bin/bash', 21:54:59 INFO - 'SHLVL': '1', 21:54:59 INFO - 'TERM': 'linux', 21:54:59 INFO - 'TMOUT': '86400', 21:54:59 INFO - 'USER': 'cltbld', 21:54:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', 21:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:59 INFO - '_': '/tools/buildbot/bin/python'} 21:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:59 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)) 21:54:59 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)) 21:54:59 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)) 21:54:59 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)) 21:54:59 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)) 21:54:59 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)) 21:54:59 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)) 21:54:59 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)) 21:54:59 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)) 21:54:59 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)) 21:54:59 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)) 21:54:59 INFO - Cleaning up... 21:54:59 INFO - Return code: 0 21:54:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:54:59 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')]} 21:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:59 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')]} 21:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:59 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 0x7f72acd4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aca8b0>, '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 0x1acb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acbc60>, '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': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', '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 21:54:59 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 21:54:59 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 21:54:59 INFO - Using env: {'DISPLAY': ':0', 21:54:59 INFO - 'HOME': '/home/cltbld', 21:54:59 INFO - 'LANG': 'en_US.UTF-8', 21:54:59 INFO - 'LANGUAGE': 'en_US:en', 21:54:59 INFO - 'LOGNAME': 'cltbld', 21:54:59 INFO - 'MAIL': '/var/mail/cltbld', 21:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:59 INFO - 'MOZ_NO_REMOTE': '1', 21:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:59 INFO - 'NO_EM_RESTART': '1', 21:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:59 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:59 INFO - 'SHELL': '/bin/bash', 21:54:59 INFO - 'SHLVL': '1', 21:54:59 INFO - 'TERM': 'linux', 21:54:59 INFO - 'TMOUT': '86400', 21:54:59 INFO - 'USER': 'cltbld', 21:54:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', 21:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:59 INFO - '_': '/tools/buildbot/bin/python'} 21:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:00 INFO - Downloading/unpacking jsonschema 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:55:01 INFO - Downloading/unpacking functools32 (from jsonschema) 21:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:02 INFO - Downloading functools32-3.2.3-2.tar.gz 21:55:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:55:02 INFO - warning: no files found matching '*.txt' 21:55:02 INFO - no previously-included directories found matching 'build' 21:55:02 INFO - no previously-included directories found matching 'dist' 21:55:02 INFO - no previously-included directories found matching '.git*' 21:55:02 INFO - Installing collected packages: jsonschema, functools32 21:55:02 INFO - Running setup.py install for functools32 21:55:02 INFO - warning: no files found matching '*.txt' 21:55:02 INFO - no previously-included directories found matching 'build' 21:55:02 INFO - no previously-included directories found matching 'dist' 21:55:02 INFO - no previously-included directories found matching '.git*' 21:55:02 INFO - Successfully installed jsonschema functools32 21:55:02 INFO - Cleaning up... 21:55:02 INFO - Return code: 0 21:55:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:55:02 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')]} 21:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:02 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')]} 21:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:02 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 0x7f72acd4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aca8b0>, '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 0x1acb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acbc60>, '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': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', '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 21:55:02 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 21:55:02 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 21:55:02 INFO - Using env: {'DISPLAY': ':0', 21:55:02 INFO - 'HOME': '/home/cltbld', 21:55:02 INFO - 'LANG': 'en_US.UTF-8', 21:55:02 INFO - 'LANGUAGE': 'en_US:en', 21:55:02 INFO - 'LOGNAME': 'cltbld', 21:55:02 INFO - 'MAIL': '/var/mail/cltbld', 21:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:02 INFO - 'MOZ_NO_REMOTE': '1', 21:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:02 INFO - 'NO_EM_RESTART': '1', 21:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:02 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:02 INFO - 'SHELL': '/bin/bash', 21:55:02 INFO - 'SHLVL': '1', 21:55:02 INFO - 'TERM': 'linux', 21:55:02 INFO - 'TMOUT': '86400', 21:55:02 INFO - 'USER': 'cltbld', 21:55:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', 21:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:02 INFO - '_': '/tools/buildbot/bin/python'} 21:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:02 INFO - Downloading/unpacking flake8 21:55:02 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 21:55:02 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 21:55:02 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 21:55:02 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 21:55:02 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 21:55:02 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 21:55:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:55:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:55:04 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 21:55:04 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 21:55:04 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 21:55:04 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 21:55:04 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 21:55:04 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 21:55:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:55:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:55:04 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 21:55:04 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 21:55:04 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 21:55:04 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 21:55:04 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 21:55:04 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 21:55:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:55:04 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 21:55:04 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 21:55:04 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 21:55:04 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 21:55:04 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 21:55:04 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 21:55:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:55:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:55:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:55:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:55:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:55:05 INFO - no previously-included directories found matching 'docs/_build' 21:55:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:55:05 INFO - Running setup.py install for pep8 21:55:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:55:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:55:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:55:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:55:05 INFO - no previously-included directories found matching 'docs/_build' 21:55:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:55:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:55:05 INFO - Cleaning up... 21:55:05 INFO - Return code: 0 21:55:05 INFO - Running post-action listener: _resource_record_post_action 21:55:05 INFO - Running post-action listener: _start_resource_monitoring 21:55:05 INFO - Starting resource monitoring. 21:55:05 INFO - ##### 21:55:05 INFO - ##### Running install step. 21:55:05 INFO - ##### 21:55:05 INFO - Running pre-action listener: _resource_record_pre_action 21:55:05 INFO - Running main action method: install 21:55:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:55:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:55:05 INFO - Reading from file tmpfile_stdout 21:55:05 INFO - Detecting whether we're running mozinstall >=1.0... 21:55:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:55:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:55:05 INFO - Reading from file tmpfile_stdout 21:55:05 INFO - Output received: 21:55:05 INFO - Usage: mozinstall [options] installer 21:55:05 INFO - Options: 21:55:05 INFO - -h, --help show this help message and exit 21:55:05 INFO - -d DEST, --destination=DEST 21:55:05 INFO - Directory to install application into. [default: 21:55:05 INFO - "/builds/slave/test-pgo"] 21:55:05 INFO - --app=APP Application being installed. [default: firefox] 21:55:05 INFO - mkdir: /builds/slave/test-pgo/build/application 21:55:05 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'] 21:55:05 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 21:55:22 INFO - Reading from file tmpfile_stdout 21:55:22 INFO - Output received: 21:55:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:55:22 INFO - Running post-action listener: _resource_record_post_action 21:55:22 INFO - ##### 21:55:22 INFO - ##### Running run-tests step. 21:55:22 INFO - ##### 21:55:22 INFO - Running pre-action listener: _resource_record_pre_action 21:55:22 INFO - Running main action method: run_tests 21:55:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:55:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:55:22 INFO - Python 2.7.3 21:55:22 INFO - Return code: 0 21:55:22 INFO - grabbing minidump binary from tooltool 21:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:22 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 0x1aca8b0>, '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 0x1acb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acbc60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:55:22 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 21:55:22 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 21:55:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:55:22 INFO - Return code: 0 21:55:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:55:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:55:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:55:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:55:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:55:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:55:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:55:23 INFO - Return code: 0 21:55:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 21:55:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 21:55:23 INFO - Using env: {'DISPLAY': ':0', 21:55:23 INFO - 'HOME': '/home/cltbld', 21:55:23 INFO - 'LANG': 'en_US.UTF-8', 21:55:23 INFO - 'LANGUAGE': 'en_US:en', 21:55:23 INFO - 'LOGNAME': 'cltbld', 21:55:23 INFO - 'MAIL': '/var/mail/cltbld', 21:55:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:55:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:23 INFO - 'MOZ_NO_REMOTE': '1', 21:55:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:55:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:23 INFO - 'NO_EM_RESTART': '1', 21:55:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:23 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:55:23 INFO - 'SHELL': '/bin/bash', 21:55:23 INFO - 'SHLVL': '1', 21:55:23 INFO - 'TERM': 'linux', 21:55:23 INFO - 'TMOUT': '86400', 21:55:23 INFO - 'USER': 'cltbld', 21:55:23 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405', 21:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:23 INFO - '_': '/tools/buildbot/bin/python'} 21:55:23 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 21:55:23 INFO - mozversion application_buildid: 20160406193137 21:55:23 INFO - mozversion application_changeset: ab62a777c115ca638278771925f27921675b9efd 21:55:23 INFO - mozversion application_display_name: Nightly 21:55:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:55:23 INFO - mozversion application_name: Firefox 21:55:23 INFO - mozversion application_remotingname: firefox 21:55:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:55:23 INFO - mozversion application_vendor: Mozilla 21:55:23 INFO - mozversion application_version: 48.0a1 21:55:23 INFO - mozversion platform_buildid: 20160406193137 21:55:23 INFO - mozversion platform_changeset: ab62a777c115ca638278771925f27921675b9efd 21:55:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:55:23 INFO - mozversion platform_version: 48.0a1 21:55:23 INFO - using testdate: 1460004923 21:55:23 INFO - actual date: 1460004923 21:55:23 INFO - starting webserver on 'localhost:45081' 21:55:23 INFO - SUITE-START | Running 2 tests 21:55:23 INFO - TEST-START | dromaeo_css 21:55:23 INFO - operating with platform_type : linux_ 21:55:23 INFO - Initialising browser for dromaeo_css test... 21:55:23 INFO - TEST-INFO | started process 11489 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdru8hp/profile http://localhost:45081/getInfo.html) 21:55:27 INFO - PROCESS | 11489 | 21:55:27 INFO - PROCESS | 11489 | (process:11557): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:55:27 INFO - PROCESS | 11489 | 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] 21:55:27 INFO - PROCESS | 11489 | __metrics Screen width/height:1600/1200 21:55:27 INFO - PROCESS | 11489 | colorDepth:24 21:55:27 INFO - PROCESS | 11489 | Browser inner width/height: 1024/697 21:55:27 INFO - PROCESS | 11489 | __metrics 21:55:28 ERROR - PROCESS | 11489 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 21:55:29 INFO - TEST-INFO | 11489: exit 0 21:55:29 INFO - Browser initialized. 21:55:29 INFO - Running cycle 1/1 for dromaeo_css test... 21:55:29 INFO - TEST-INFO | started process 11607 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdru8hp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:55:31 INFO - PROCESS | 11607 | 21:55:31 INFO - PROCESS | 11607 | (process:11669): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:55:41 INFO - PROCESS | 11607 | RSS: Main: 161751040 21:55:41 INFO - PROCESS | 11607 | 21:56:30 INFO - PROCESS | 11607 | 1460004990711 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] 21:58:38 INFO - PROCESS | 11607 | Cycle 1(1): loaded http://localhost:45081/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45081/tests/dromaeo/cssquery-ext.html) 21:58:39 INFO - PROCESS | 11607 | RSS: Main: 162652160 21:58:39 INFO - PROCESS | 11607 | 22:01:40 INFO - PROCESS | 11607 | Cycle 1(1): loaded http://localhost:45081/tests/dromaeo/cssquery-ext.html (next: http://localhost:45081/tests/dromaeo/cssquery-jquery.html) 22:01:41 INFO - PROCESS | 11607 | RSS: Main: 162926592 22:01:41 INFO - PROCESS | 11607 | 22:04:43 INFO - PROCESS | 11607 | Cycle 1(1): loaded http://localhost:45081/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45081/tests/dromaeo/cssquery-mootools.html) 22:04:43 INFO - PROCESS | 11607 | RSS: Main: 161689600 22:04:43 INFO - PROCESS | 11607 | 22:07:45 INFO - PROCESS | 11607 | Cycle 1(1): loaded http://localhost:45081/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45081/tests/dromaeo/cssquery-prototype.html) 22:07:46 INFO - PROCESS | 11607 | RSS: Main: 163123200 22:07:46 INFO - PROCESS | 11607 | 22:10:48 INFO - PROCESS | 11607 | Cycle 1(1): loaded http://localhost:45081/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45081/tests/dromaeo/cssquery-yui.html) 22:10:48 INFO - PROCESS | 11607 | RSS: Main: 162332672 22:10:48 INFO - PROCESS | 11607 | 22:13:51 INFO - PROCESS | 11607 | Cycle 1(1): loaded http://localhost:45081/tests/dromaeo/cssquery-yui.html (next: http://localhost:45081/tests/dromaeo/cssquery-dojo.html) 22:13:51 INFO - PROCESS | 11607 | RSS: Main: 163598336 22:13:51 INFO - PROCESS | 11607 | 22:13:51 INFO - PROCESS | 11607 | __start_tp_report 22:13:51 INFO - PROCESS | 11607 | _x_x_mozilla_page_load 22:13:51 INFO - PROCESS | 11607 | _x_x_mozilla_page_load_details 22:13:51 INFO - PROCESS | 11607 | |i|pagename|runs| 22:13:51 INFO - PROCESS | 11607 | |0;dojo.html;3114;3126.202818281338;3138.074268090913;3170.778045536812;3171.4767063434533;5226.790928362866;5235.083860324447;5240.97800928819;5241.240020197079;5285.762140703668;5219.138842091051;5245.6852588844695;5264.921026184601;5281.656692314997;5355.303810504629;4804.351412559304;4822.7829747661435;4826.758662066883;4995.300657907896;5005.624578156635;4977.850664480072;5000.349954505909;5014.523620256088;5028.472010438906;5030.320906677606;4838.201696720037;4868.9756551217015;4882.731449770261;4932.654714170009;4940.036692844897;4826.300186472977;4853.514648535153;4871.561559459666;4871.561559459666;4900;4753.809847606091;4823.734694591796;4841.709497430165;4846.927296090562;4861.0277944411255;5174.430812610647;5207.297014903015;5244.265802787613;5247.501487358695;5270.209468579706;5585.944140558583;5591.440855914376;5592.944070559283;5606.21512988182;5616.157576363537;5527.447255274481;5637.43625637433;5656.321241451053;5660.490555849993;5723.313202415695;5288.92066619001;5293.788248470057;5297.5232229099565;5304.416514183476;5353.411124776271;5703.030484817591;5706.543476521868;5715.8856822864145;5725.914111288334;5746.770129194869;5533.667979921218;5539.556835453154;5568;5620.522255608237;5704.229928959538;5513.9448605514235;5699.715014249354;5706.9429305707245;5707.229524014288;5722.856928576819;5636.520895723909;5653.830385088454;5657.57568182388;5660.858478537987;5712.857178570486;5482.150266708666;5520.199571062173;5581.972090139523;5585.441455854382;5605.80379686709;4297.333913243452;4317.568243175658;4318.136372725405;4334.631556317685;4346.326319420495;3820.6370394812448;3834.2523207974177;3861.189150278417;3882.5340959085092;3920.1375697347107;5278.208268759717;5406.270153529302;5418.133098704188;5434.157705555645;5436.700981446058;5724.542036637059;5742.08126699726;5750.568707346965;5768.653880767168;5779.393163717833;5421.213923981;5449.809256675997;5451.882364115426;5455.454454554513;5457.20870473787;4636.814527418933;4719.3628860103445;4756.1438940990265;4799.6400269979895;4800.831970881002;5877.089051197071;5902.675352855548;5907.734151963172;5909.3204281507315;5929.6145750526075;5613.354464236665;5718.342390625048;5736.282964629421;5737.454941780524;5766.192733017297;5830.387809279964;5858.502027327725;5874.265716785402;5882.882342353215;5912.911306330495;5543.72281385921;5548.056830338772;5561.110222364402;5563.248961390161;5566.721663916869;5580.274564306615;5657.4908258256955;5664.943350566442;5685.943140568541;5695.1457281406465;5410.675359478444;5457.481539253765;5502.752376143003;5515.834524964257;5566.165075238747;5475.644083134743;5498.835034948958;5521.751521181476;5540.667559946416;5572.108462645957;5426.104692725814;5433.673979561239;5438.809641662523;5439.5920305978;5440.265564148789;5510.118381059011;5516.862078448071;5537.446255374431;5555.611107222618;5598.272224610774;5342;5393.595480339069;5396.703181325065;5409.107497262908;5412.648177868426 22:13:51 INFO - PROCESS | 11607 | |1;ext.html;495.464897910257;533;542.6554138122292;557.3534699748292;570.7842295909712;35707.2858542829;36078.81960590197;36086.45870311944;36141.0964725882;36162.27675446496;37630;38027.61972380275;38299.61700382995;38355;38436.615633843656;8449.873251901241;8539.573021348939;8597.527136007517;8607.655693772242;8619.913800861974;8405.705800296992;8486.363522735788;8519.3610479214;8522.57387130644;8533.615987280557;8734.12658734128;8812.295016398704;8839.16027977341;8846.778830529256;8858.557072146366;8731.301495880347;8732.738017859474;8781.868271975925;8797.7800554986;8832.11678832118;8556.957215213884;8682.088380719997;8683.652653893836;8697.347698922606;8737.563121843947;37648.24703505915;38049.80975095107;38050.42924356137;38103.809480952696;38169.809150954345;3379.932401351959;3763.5295588051495;3933.599412243597;3945.171513982067;3959.4456776051375;29749.851250743824;29759.10722678323;29811.403771924655;30018.549721754192;30036.849815750782;4209.894752631178;4336.457942757155;4393.51671316155;4462.955370446286;4470.776461176928;222336;222542;222629.3028022921;222744;223451;50959.980800384525;51517;51620.74189629028;51751;51969.74015129976;55237.72381138149;55252;55555.166672499945;55612.16581751277;55717.72141139268;15557.14435706047;15746.212689365715;15790.842091579167;15813.920930395274;15885.126318052618;12030.578929737418;12077.27536347822;12080.21478603888;12114.333711645768;12128.393580320948;16300;17558.736618950727;17798.733019004725;17849.28602855897;17882;6089.451949324493;6238.313785483593;6387.648679322589;6534.4445722113205;6568.6058836469965;882.8410886040574;987.7431867714446;1067.4662668665667;1082.976587125159;1096.3750662122513;28693.56959645607;28971.85514072416;29720.55419168714;29963.40073198524;30008.54987175194;1049.9395610433364;1054.6548221328178;1061.2518174686827;1086.559943222996;1097.1223021582703;14929.701405972037;15271.083734975937;15411.22943852803;15536.223188840739;15569.221538923008;392468;397652;398407;399575;400051;48947.26579101316;49668;49738.25392619114;49751.50248497541;49803.75098124486;1207.9516819327305;1241.211830487647;1291.4704970961861;1296.3906963727034;1307.6600083978235;28418.857905710338;28588.857055714587;28814.12708173962;29142.417151656424;29339.85330073336;44478.55521444874;44595.777021114685;44756;44803;45055.09889802251;330481;330685;330803;330890;334301;31765.523517146798;33250.50124248186;33256.501152483215;33399.49900751539;33443.66556334503;42039.3694094595;42935.355969661105;42944.570554294056;43335.56664433315;43866.56133438625;36994;37194.25611487701;37196.44205336868;37253.0686732823;37254.25491490209;36069.45895811617;36118.27763444769;36883;37385.62614373821;37420.81289593643;31796.36407271888;36313.45529817002;37021.25957480889;37024.62975370212;37338;30403.84798076084;31265;31406;31445.52831707572;31448.842755786074;25891.741082588935;26186.73813261843;26290.079847205256;26324.605130923435;26374 22:13:51 INFO - PROCESS | 11607 | |2;jquery.html;349.4251955533148;353.0626187472261;356.28031376619214;362.94737263096835;363.66906115434944;16579.668406631874;16801.66396672066;17222.827771722277;17277.91361043193;17290.56773580658;15987.360505579793;16400.343986240565;17131.486055418358;17572.56068598286;17583.64832703345;5464.863378415552;5468.644538105021;5597.7201139943045;5610.326760788711;5644.604877658566;5449.155380915964;5525.861853453655;5575.498205161534;5590.692511911843;5614.8596285093;5341.919871201935;5536;5537.944620553803;5557.221988921554;5588.050031494636;5514.117741161415;5520.917186242169;5535.529479994185;5544.750486228129;5571.387147413781;4907.779149938226;4943.555080042777;4965.82619608312;4981.37732783402;4998.850034498934;18923.24307027717;19527.90236048825;20374.388768336972;21125.366239012856;21158.576828463345;2359.6460530920326;2381.5951288281035;2386.021731090262;2401.8558886466867;2439.658447817307;9343;9654.855177172349;9714.90285097154;9732.07545283197;9883.802323953552;1753.2986805277862;1811.7101263797729;1916.281394477071;1920.5774729559614;1977.6736838421643;56279.43720562783;63648;69559.3044069558;70004.99999999949;75210;10015.849762253572;10078.294519383573;10097.899021009844;10167.847482287623;10438.269321147447;13696.794548081787;13699.041067125205;13703.657408564866;13779.862201378059;13819.585412437644;7283.344498995116;7645.732399365996;7684.193159718149;7844.9607751960875;7991.920080799234;7369.22623124575;7593.9368488411665;7693.576853273124;7775.3390961767755;7816.687332506636;4324;4419.911601768011;4420.027593929331;4430.069685366045;4484.798184081724;1799.6220793633222;1826.6803309420798;1842.2262649687164;1869.3737597904583;1895.734597156399;920.1074957291416;960.9903900961041;978.706388083572;997.1972562087444;1057.3021805608262;17274.96350218991;17732.822671773116;17780.149306577005;18097.909510452362;18358;934.1079269297804;951.6003278622995;964.4936408385513;989.5893204320126;990.6334656177116;10121.544530496145;10123.493825308706;10163;10246.59013639461;10455.111315538112;492598;492634;496516;505987;510169;81304;84775;85239.57380213059;86408;87496.94956447236;993.1508560181086;1016.5577973581516;1045.278757657214;1045.3675526306627;1047.1518070363031;16182.352705891632;16208;16315.428959986344;16349.509514714578;16415.17924103814;37475.25049499049;38662;39250;39597.80201098976;39879.202415952095;53712.194317086054;55225;55273;55311;55894.720526397105;8180.7954801130445;8235.794105147419;8411.663533458594;8444.155584441753;8510.531920744419;10907.2364934457;12775.1057425983;12810.871891280967;12846.293453860128;12867.742645146858;11076.723081923017;11328.433578321215;11351.091912646803;11474.483648236017;11530.711732206762;10885.891141088488;10916.727081823017;10998.230123891572;11222.10223182127;11284.774304514029;11465.885341146482;11613.941930290295;11874.762504749684;11899.524019039141;11942.70143246391;8097.554634494923;8141.185881411811;8191.286226374731;8256.587170641564;8531.95734021326;8953.373263871727;11252.66242012741;11868.881311187122;11933.761324773282;11982.340971246666 22:13:51 INFO - PROCESS | 11607 | |3;mootools.html;1335.0854664554781;1341.9798703019455;1407.2611878763648;1564.2491604030072;1570.5680937742113;6799.286074962132;6987.860242795154;7150.034745309388;7296.197418283985;7356.301151390616;7460;7499.962500187491;7522.887156692654;7574.242575742423;7665.5783931883725;2246.3036458697775;2270.9886450567806;2274.124462082102;2295.6097463431256;2298.241580278504;2261.231181398324;2281;2321.5008773113777;2321.918732844351;2325.1861848353024;2272.5682120397155;2272.8409011369213;2282.052948026567;2286.371247906822;2296.1045192374986;2281.0875649740155;2281.133169395619;2283.600369935263;2288.5880541502524;2289.347535952246;2378.6432035194684;2382.6902502674716;2385.2128797496785;2389.2473870730664;2394.8682822444757;7611.467197296191;7629.198934111894;7656.770296891046;7657.425693073042;7683.231676832328;4973.626977976666;5077.365329333833;5102.234664800272;5107.7956881724685;5119.56483698886;3408.5739282589675;3447.620761716209;3539.3452211340727;3594.3170797548382;3646.890593282206;1147.68438679363;1166.2302880099178;1166.422620802708;1171.8945294923412;1215.2829830400105;10151.492425378701;10298.7425314367;10301.53643086063;10303.793924121475;10308.123809476203;4293.50624678166;4365.367021781887;4375.584319489707;4397.538258482878;4404.933925991113;8247.546384948766;8254.257116859511;8282.337413006944;8307.169283071644;8344.707935222237;4780.593649539758;4782.187028205213;4808.639352048541;4823.2282834746275;4834.274858771142;4072.1041370898356;4517.548245175456;4527.275635898241;4530.818767249273;4601.102784956901;3476.1483436558206;3512.121969507623;3523.2601153757487;3545.9290814184087;3592.479090531858;1108.0692218536467;1118.8601424821898;1121.1815374776295;1121.899029087386;1123.3540714089431;1277.3485522383467;1281.6027031620229;1284.8329717136712;1292.424870932426;1311.698309388846;6793.354631310018;6826.522143449911;6902.620355880475;7089.291070892869;7109.040279562297;504.957078648319;505.0505050505027;508.0043115493674;510.65020460984346;516.339085969959;5504.80733174345;5538.695371754511;5539.9169012464845;5664.178694089416;5682.659040457503;8902.73291801247;8913.197812196804;9100.544972751468;9173.678921237724;9187.26501879848;8977.685780997634;8990.865137022949;9018.458892466473;9019.098090191059;9041.367104302635;7014.158301003912;7016.298370162943;7197.064381630459;7270.563766174047;7294.635268236673;6951.930480695129;6994.755183568551;7002.929970700227;7008.334208250208;7015.684294206875;7684.154742978156;7838.686452541834;7873.645685944031;7961.522308661499;8022.318102961313;8512.276456501268;8839.955800220958;8883.777905552413;8954.820903582022;9007.729768106967;6263.749450021948;6357.554971151975;6403.839904002437;6499;6647.800565983028;6912.619805910522;6928.757493487704;6945.201301850352;6959.8608027838145;6960.651967401711;6239.438450539473;6348.428641422294;6407.71165297572;6449.193850768654;6549.410553050057;6355.650439225887;6362.04569314588;6386.457151142019;6434.935650643433;6453.548251622341;6258.812235632939;6310.148130002391;6334.90497642545;6383.9361606383345;6387.808365749035;6113.816585502442;6128.050152226412;6161.722722477589;6165.506759459143;6204.193454850841;6487.935120648733;6491.545591808528;6516.250631177475;6523.282438931618;6547 22:13:51 INFO - PROCESS | 11607 | |4;prototype.html;333.8697907815952;334.72050837550677;336.0959020235566;336.28203784919197;342.56152125279635;6483.351664833514;6487.41613254807;6511.316311787259;6581.6380099094595;6582.80251592453;6484.254310754264;6488.383603557654;6492;6493.155889734339;6495.447886929616;4669.533046695337;4735.195016847127;4903.1174388610125;4912.631552633549;4915.680480768757;4924.975375123119;4938.48145944676;4947.678400903929;4951.133551628451;4956.87607809804;4875.341828853113;4876.585490233334;4878.268259761029;4896.730679812609;4914.533119353674;4909.0672772173175;4914.967856750087;4917.0903382874285;4917.3607431033915;4922.335484709554;4298.11888562847;4299.484061912559;4300.397944287803;4302.311630139163;4308.5045219799495;6154.353792851731;6226.159468471744;6266.592671476339;6306.968465157691;6324.430801227865;5657.264555607786;5695.857603559944;5700.458456446631;5701.059325211335;5701.372848986608;6822.3859852613;6822.931770682279;6831.062643063481;6831.521793474459;6835.624040677761;4731.976340118277;4737.076270127326;4738.952610473885;4739.4075740532435;4741.122892264908;7053.153621565445;7105.8223544411285;7147;7151.249118842498;7158.248383919666;4516.593506584423;4650.906981860344;4675.57919787214;4851.830185943475;4865.1485989952325;4668.5798278155125;4693.624510039189;4702.435707715096;4704.835330763407;4734.21885388907;5525.502704756591;5550.888982220333;5553.111502159635;5557.166425036196;5575.219469274305;6899.48253880961;6944.687489063004;6956.339147780953;6968.198657154492;6973.79078627642;1646.6788976149535;1667.0414511655604;1667.1914121650989;1669.9415520456726;1671.607172314505;1036.4713995862014;1062.6440142552176;1065.1319174872453;1067.9626213082504;1077.7521170130758;6570.934290657128;6589.7364105435245;6602.966985165043;6606.603603783692;6611.834704132435;7003.3346832050875;7095.787126386217;7102.289771022856;7108.040414544073;7108.040414544073;6443.838904027343;6639.236487803868;6666.166729158856;6674.766383176566;6675.265720770712;3836.4820749199057;3857.9228415431535;3878.030492376906;3880.1269714314617;3888.183481468867;7518.060242469692;7546.2831031051965;7565.73519926811;7579.924200758032;7605.391568674493;7408.629568521553;7412.814679633052;7416.555006699616;7418.591977441292;7423.4061275097865;7226.385757210591;7492.138404083491;7505.849883002309;7538.585377804164;7544.735934242275;7157.821054473679;7201.567905925661;7208.675609597476;7215.8556828864175;7216.89174662391;7112.324329188718;7113.928860711327;7118.679659415442;7134.286571342825;7148.499605027599;7184.173820010766;7439.665215065227;7455.7017719290625;7485.401167906445;7499.700011999459;4698.718076915396;4707.693999889996;4732.077244937204;4736.478987311462;4736.8578942631775;7157.821054473679;7178.461615378972;7182.820429489305;7190.856182876418;7195.604241766753;6933.653317334012;6940.722371105301;6949.270326615632;6972.7210911565;6974.442044636518;6657.53397262187;6848.14398200225;6911.17065952089;6921.2732663071665;6951.721931122901;6755.189377274758;6765.797026089225;6800.387965083166;6814.965925170342;6815.727370905108;6976.860462790817;6977.755778547727;6985.336393042653;6990.475714321345;6994.720211191496;6756.763513277012;6762.830929226809;6771.3905748482875;6773.661316934035;6774.42417394527 22:13:51 INFO - PROCESS | 11607 | |5;yui.html;727.4725823777759;750.5496701978814;767.4014268870283;772.4824367673658;780.4107898536606;13873.653158671039;14045.43818247269;14045.57863264101;14065.578032659037;14119;12933.094683372168;13015.34923253836;13026.80459793104;13049;13067.085304028722;573.1345668041267;662.4402379988902;678.8065401360614;680.2585182151454;681.2914568848416;660.2242365220847;665.2250128600175;665.8435267712084;667.6628302707151;670.8423520472685;709.1065257775189;711.1359697966969;713.4684659928361;713.6645776485044;713.6681443128944;701.1516065560678;701.9578825270474;704.2042491984051;705.9576425414491;707.4552594502256;516.2978349444752;519.571353633254;520.0846510142139;520.3729505945364;520.7240162713767;13454.529091481849;13472.5284615038;13479.393427295698;13495.325233738275;13512.121712088683;12176.939115304456;12243.69390765229;12832.935835320857;12885.226886386754;13134.34328283582;10503.2122590806;10530.36817790935;10646.25476216665;10669.946650266776;10679.145668346513;3718.222855785236;3722.292764374787;3758.7368884178118;3767.453719210699;3893.669038131762;55132.724336378466;55154.72422637861;55241.72379138119;56997.43002569963;58005.12992305119;9600.66397676092;9780.608775649036;9891.35706179096;9954.452505112144;9982.60069597208;18953.526161846064;18964.715529267072;19029.61940761205;19061;19108;7934.404919631051;8144.633491492897;8150.144234855374;8256.422050456531;8323.625436855356;4643.164230438486;4700.388949436551;4707.835225767081;4724.173269677862;4762.857114286577;3239.4492936200904;3247.7401807855786;3248.1067706380463;3275.4922986936585;3278.5901762279714;578.9305283365939;582.8834233153386;585.6369051188206;586.1471558881902;586.6978506069378;690.4476418864888;695.0026711668771;730.9780706578811;743.2344684974485;751.3876190904396;9118.954405228063;9634.325597208268;9638.277129215337;9660.420374777535;9698.951505242429;653.8953767397194;698.1308271202386;720.8857734586536;730.5762657658545;733.3143510817403;4356.283542485521;4434.224010798098;4497.123061003073;4584.6561507887045;4588.655850811202;69783.30216697768;70370.29629703739;70786.292137079;71247.6437617819;71361.2863871365;59670.403295966484;60804;60975;61290.38709612847;61329.38670613326;53502.73248633732;53749.1937620936;54297.45702543003;54708.452915471134;54777.726111369986;8805.207531322212;8971.910280897107;9145;9209.539523023956;9269.76825579339;38867.416988744626;40169.179698436375;40176.39735403913;41214;41881.16237675169;50988.74505627596;52889.471105289995;53316.46683533115;53497.73251133719;53629.7318513405;10913.39976301311;10914.072303853944;11286.830697539708;11304.095672346357;11453.541858325574;11510.991743758215;11538.3653899033;11571.826422603835;12292.323922184365;12728;11595.420228988685;11631;11839.348835814113;11857;11944.880551194377;11110.44447777624;11134.665960021212;11137.665870023913;11240.896247065053;11357.093318564634;11668.941655292008;11695.941520292345;11760.411979400824;11824.527018919147;12082.577109801467;9872.457014863965;9985.500724963578;9990.400575965465;10022.699319020441;10279.897201027894;9858.85211721839;10364.274500784873;10404.739881503023;10417.531211095671;10432.530536126045 22:13:51 INFO - PROCESS | 11607 | __end_tp_report 22:13:51 INFO - PROCESS | 11607 | __start_cc_report 22:13:51 INFO - PROCESS | 11607 | _x_x_mozilla_cycle_collect,310 22:13:51 INFO - PROCESS | 11607 | __end_cc_report 22:13:51 INFO - PROCESS | 11607 | __startTimestamp1460006031282__endTimestamp 22:13:51 INFO - PROCESS | 11607 | 22:13:51 INFO - PROCESS | 11607 | ------- Summary: start ------- 22:13:51 INFO - PROCESS | 11607 | Number of tests: 6 22:13:51 INFO - PROCESS | 11607 | 22:13:51 INFO - PROCESS | 11607 | [#0] dojo.html Cycles:165 Average:5264.75 Median:5449.81 stddev:581.70 (10.7%) stddev-sans-first:558.47 22:13:51 INFO - PROCESS | 11607 | Values: 3114.0 3126.2 3138.1 3170.8 3171.5 5226.8 5235.1 5241.0 5241.2 5285.8 5219.1 5245.7 5264.9 5281.7 5355.3 4804.4 4822.8 4826.8 4995.3 5005.6 4977.9 5000.3 5014.5 5028.5 5030.3 4838.2 4869.0 4882.7 4932.7 4940.0 4826.3 4853.5 4871.6 4871.6 4900.0 4753.8 4823.7 4841.7 4846.9 4861.0 5174.4 5207.3 5244.3 5247.5 5270.2 5585.9 5591.4 5592.9 5606.2 5616.2 5527.4 5637.4 5656.3 5660.5 5723.3 5288.9 5293.8 5297.5 5304.4 5353.4 5703.0 5706.5 5715.9 5725.9 5746.8 5533.7 5539.6 5568.0 5620.5 5704.2 5513.9 5699.7 5706.9 5707.2 5722.9 5636.5 5653.8 5657.6 5660.9 5712.9 5482.2 5520.2 5582.0 5585.4 5605.8 4297.3 4317.6 4318.1 4334.6 4346.3 3820.6 3834.3 3861.2 3882.5 3920.1 5278.2 5406.3 5418.1 5434.2 5436.7 5724.5 5742.1 5750.6 5768.7 5779.4 5421.2 5449.8 5451.9 5455.5 5457.2 4636.8 4719.4 4756.1 4799.6 4800.8 5877.1 5902.7 5907.7 5909.3 5929.6 5613.4 5718.3 5736.3 5737.5 5766.2 5830.4 5858.5 5874.3 5882.9 5912.9 5543.7 5548.1 5561.1 5563.2 5566.7 5580.3 5657.5 5664.9 5685.9 5695.1 5410.7 5457.5 5502.8 5515.8 5566.2 5475.6 5498.8 5521.8 5540.7 5572.1 5426.1 5433.7 5438.8 5439.6 5440.3 5510.1 5516.9 5537.4 5555.6 5598.3 5342.0 5393.6 5396.7 5409.1 5412.6 22:13:51 INFO - PROCESS | 11607 | 22:13:51 INFO - PROCESS | 11607 | [#1] ext.html Cycles:180 Average:47758.05 Median:37296.13 stddev:85626.15 (229.6%) stddev-sans-first:85792.82 22:13:51 INFO - PROCESS | 11607 | Values: 495.5 533.0 542.7 557.4 570.8 35707.3 36078.8 36086.5 36141.1 36162.3 37630.0 38027.6 38299.6 38355.0 38436.6 8449.9 8539.6 8597.5 8607.7 8619.9 8405.7 8486.4 8519.4 8522.6 8533.6 8734.1 8812.3 8839.2 8846.8 8858.6 8731.3 8732.7 8781.9 8797.8 8832.1 8557.0 8682.1 8683.7 8697.3 8737.6 37648.2 38049.8 38050.4 38103.8 38169.8 3379.9 3763.5 3933.6 3945.2 3959.4 29749.9 29759.1 29811.4 30018.5 30036.8 4209.9 4336.5 4393.5 4463.0 4470.8 222336.0 222542.0 222629.3 222744.0 223451.0 50960.0 51517.0 51620.7 51751.0 51969.7 55237.7 55252.0 55555.2 55612.2 55717.7 15557.1 15746.2 15790.8 15813.9 15885.1 12030.6 12077.3 12080.2 12114.3 12128.4 16300.0 17558.7 17798.7 17849.3 17882.0 6089.5 6238.3 6387.6 6534.4 6568.6 882.8 987.7 1067.5 1083.0 1096.4 28693.6 28971.9 29720.6 29963.4 30008.5 1049.9 1054.7 1061.3 1086.6 1097.1 14929.7 15271.1 15411.2 15536.2 15569.2 392468.0 397652.0 398407.0 399575.0 400051.0 48947.3 49668.0 49738.3 49751.5 49803.8 1208.0 1241.2 1291.5 1296.4 1307.7 28418.9 28588.9 28814.1 29142.4 29339.9 44478.6 44595.8 44756.0 44803.0 45055.1 330481.0 330685.0 330803.0 330890.0 334301.0 31765.5 33250.5 33256.5 33399.5 33443.7 42039.4 42935.4 42944.6 43335.6 43866.6 36994.0 37194.3 37196.4 37253.1 37254.3 36069.5 36118.3 36883.0 37385.6 37420.8 31796.4 36313.5 37021.3 37024.6 37338.0 30403.8 31265.0 31406.0 31445.5 31448.8 25891.7 26186.7 26290.1 26324.6 26374.0 22:13:51 INFO - PROCESS | 11607 | 22:13:51 INFO - PROCESS | 11607 | [#2] jquery.html Cycles:180 Average:28013.37 Median:38956.00 stddev:82025.22 (210.6%) stddev-sans-first:82229.02 22:13:51 INFO - PROCESS | 11607 | Values: 349.4 353.1 356.3 362.9 363.7 16579.7 16801.7 17222.8 17277.9 17290.6 15987.4 16400.3 17131.5 17572.6 17583.6 5464.9 5468.6 5597.7 5610.3 5644.6 5449.2 5525.9 5575.5 5590.7 5614.9 5341.9 5536.0 5537.9 5557.2 5588.1 5514.1 5520.9 5535.5 5544.8 5571.4 4907.8 4943.6 4965.8 4981.4 4998.9 18923.2 19527.9 20374.4 21125.4 21158.6 2359.6 2381.6 2386.0 2401.9 2439.7 9343.0 9654.9 9714.9 9732.1 9883.8 1753.3 1811.7 1916.3 1920.6 1977.7 56279.4 63648.0 69559.3 70005.0 75210.0 10015.8 10078.3 10097.9 10167.8 10438.3 13696.8 13699.0 13703.7 13779.9 13819.6 7283.3 7645.7 7684.2 7845.0 7991.9 7369.2 7593.9 7693.6 7775.3 7816.7 4324.0 4419.9 4420.0 4430.1 4484.8 1799.6 1826.7 1842.2 1869.4 1895.7 920.1 961.0 978.7 997.2 1057.3 17275.0 17732.8 17780.1 18097.9 18358.0 934.1 951.6 964.5 989.6 990.6 10121.5 10123.5 10163.0 10246.6 10455.1 492598.0 492634.0 496516.0 505987.0 510169.0 81304.0 84775.0 85239.6 86408.0 87496.9 993.2 1016.6 1045.3 1045.4 1047.2 16182.4 16208.0 16315.4 16349.5 16415.2 37475.3 38662.0 39250.0 39597.8 39879.2 53712.2 55225.0 55273.0 55311.0 55894.7 8180.8 8235.8 8411.7 8444.2 8510.5 10907.2 12775.1 12810.9 12846.3 12867.7 11076.7 11328.4 11351.1 11474.5 11530.7 10885.9 10916.7 10998.2 11222.1 11284.8 11465.9 11613.9 11874.8 11899.5 11942.7 8097.6 8141.2 8191.3 8256.6 8532.0 8953.4 11252.7 11868.9 11933.8 11982.3 22:13:51 INFO - PROCESS | 11607 | 22:13:51 INFO - PROCESS | 11607 | [#3] mootools.html Cycles:180 Average:5287.04 Median:6120.93 stddev:2668.63 (43.6%) stddev-sans-first:2659.58 22:13:51 INFO - PROCESS | 11607 | Values: 1335.1 1342.0 1407.3 1564.2 1570.6 6799.3 6987.9 7150.0 7296.2 7356.3 7460.0 7500.0 7522.9 7574.2 7665.6 2246.3 2271.0 2274.1 2295.6 2298.2 2261.2 2281.0 2321.5 2321.9 2325.2 2272.6 2272.8 2282.1 2286.4 2296.1 2281.1 2281.1 2283.6 2288.6 2289.3 2378.6 2382.7 2385.2 2389.2 2394.9 7611.5 7629.2 7656.8 7657.4 7683.2 4973.6 5077.4 5102.2 5107.8 5119.6 3408.6 3447.6 3539.3 3594.3 3646.9 1147.7 1166.2 1166.4 1171.9 1215.3 10151.5 10298.7 10301.5 10303.8 10308.1 4293.5 4365.4 4375.6 4397.5 4404.9 8247.5 8254.3 8282.3 8307.2 8344.7 4780.6 4782.2 4808.6 4823.2 4834.3 4072.1 4517.5 4527.3 4530.8 4601.1 3476.1 3512.1 3523.3 3545.9 3592.5 1108.1 1118.9 1121.2 1121.9 1123.4 1277.3 1281.6 1284.8 1292.4 1311.7 6793.4 6826.5 6902.6 7089.3 7109.0 505.0 505.1 508.0 510.7 516.3 5504.8 5538.7 5539.9 5664.2 5682.7 8902.7 8913.2 9100.5 9173.7 9187.3 8977.7 8990.9 9018.5 9019.1 9041.4 7014.2 7016.3 7197.1 7270.6 7294.6 6951.9 6994.8 7002.9 7008.3 7015.7 7684.2 7838.7 7873.6 7961.5 8022.3 8512.3 8840.0 8883.8 8954.8 9007.7 6263.7 6357.6 6403.8 6499.0 6647.8 6912.6 6928.8 6945.2 6959.9 6960.7 6239.4 6348.4 6407.7 6449.2 6549.4 6355.7 6362.0 6386.5 6434.9 6453.5 6258.8 6310.1 6334.9 6383.9 6387.8 6113.8 6128.1 6161.7 6165.5 6204.2 6487.9 6491.5 6516.3 6523.3 6547.0 22:13:51 INFO - PROCESS | 11607 | 22:13:51 INFO - PROCESS | 11607 | [#4] prototype.html Cycles:180 Average:5753.24 Median:6582.22 stddev:1786.13 (27.1%) stddev-sans-first:1744.21 22:13:51 INFO - PROCESS | 11607 | Values: 333.9 334.7 336.1 336.3 342.6 6483.4 6487.4 6511.3 6581.6 6582.8 6484.3 6488.4 6492.0 6493.2 6495.4 4669.5 4735.2 4903.1 4912.6 4915.7 4925.0 4938.5 4947.7 4951.1 4956.9 4875.3 4876.6 4878.3 4896.7 4914.5 4909.1 4915.0 4917.1 4917.4 4922.3 4298.1 4299.5 4300.4 4302.3 4308.5 6154.4 6226.2 6266.6 6307.0 6324.4 5657.3 5695.9 5700.5 5701.1 5701.4 6822.4 6822.9 6831.1 6831.5 6835.6 4732.0 4737.1 4739.0 4739.4 4741.1 7053.2 7105.8 7147.0 7151.2 7158.2 4516.6 4650.9 4675.6 4851.8 4865.1 4668.6 4693.6 4702.4 4704.8 4734.2 5525.5 5550.9 5553.1 5557.2 5575.2 6899.5 6944.7 6956.3 6968.2 6973.8 1646.7 1667.0 1667.2 1669.9 1671.6 1036.5 1062.6 1065.1 1068.0 1077.8 6570.9 6589.7 6603.0 6606.6 6611.8 7003.3 7095.8 7102.3 7108.0 7108.0 6443.8 6639.2 6666.2 6674.8 6675.3 3836.5 3857.9 3878.0 3880.1 3888.2 7518.1 7546.3 7565.7 7579.9 7605.4 7408.6 7412.8 7416.6 7418.6 7423.4 7226.4 7492.1 7505.8 7538.6 7544.7 7157.8 7201.6 7208.7 7215.9 7216.9 7112.3 7113.9 7118.7 7134.3 7148.5 7184.2 7439.7 7455.7 7485.4 7499.7 4698.7 4707.7 4732.1 4736.5 4736.9 7157.8 7178.5 7182.8 7190.9 7195.6 6933.7 6940.7 6949.3 6972.7 6974.4 6657.5 6848.1 6911.2 6921.3 6951.7 6755.2 6765.8 6800.4 6815.0 6815.7 6976.9 6977.8 6985.3 6990.5 6994.7 6756.8 6762.8 6771.4 6773.7 6774.4 22:13:51 INFO - PROCESS | 11607 | 22:13:51 INFO - PROCESS | 11607 | [#5] yui.html Cycles:180 Average:15418.80 Median:520.55 stddev:19151.63 (3679.1%) stddev-sans-first:19173.58 22:13:51 INFO - PROCESS | 11607 | Values: 727.5 750.5 767.4 772.5 780.4 13873.7 14045.4 14045.6 14065.6 14119.0 12933.1 13015.3 13026.8 13049.0 13067.1 573.1 662.4 678.8 680.3 681.3 660.2 665.2 665.8 667.7 670.8 709.1 711.1 713.5 713.7 713.7 701.2 702.0 704.2 706.0 707.5 516.3 519.6 520.1 520.4 520.7 13454.5 13472.5 13479.4 13495.3 13512.1 12176.9 12243.7 12832.9 12885.2 13134.3 10503.2 10530.4 10646.3 10669.9 10679.1 3718.2 3722.3 3758.7 3767.5 3893.7 55132.7 55154.7 55241.7 56997.4 58005.1 9600.7 9780.6 9891.4 9954.5 9982.6 18953.5 18964.7 19029.6 19061.0 19108.0 7934.4 8144.6 8150.1 8256.4 8323.6 4643.2 4700.4 4707.8 4724.2 4762.9 3239.4 3247.7 3248.1 3275.5 3278.6 578.9 582.9 585.6 586.1 586.7 690.4 695.0 731.0 743.2 751.4 9119.0 9634.3 9638.3 9660.4 9699.0 653.9 698.1 720.9 730.6 733.3 4356.3 4434.2 4497.1 4584.7 4588.7 69783.3 70370.3 70786.3 71247.6 71361.3 59670.4 60804.0 60975.0 61290.4 61329.4 53502.7 53749.2 54297.5 54708.5 54777.7 8805.2 8971.9 9145.0 9209.5 9269.8 38867.4 40169.2 40176.4 41214.0 41881.2 50988.7 52889.5 53316.5 53497.7 53629.7 10913.4 10914.1 11286.8 11304.1 11453.5 11511.0 11538.4 11571.8 12292.3 12728.0 11595.4 11631.0 11839.3 11857.0 11944.9 11110.4 11134.7 11137.7 11240.9 11357.1 11668.9 11695.9 11760.4 11824.5 12082.6 9872.5 9985.5 9990.4 10022.7 10279.9 9858.9 10364.3 10404.7 10417.5 10432.5 22:13:51 INFO - PROCESS | 11607 | -------- Summary: end -------- 22:13:51 INFO - PROCESS | 11607 | 22:13:51 INFO - TEST-INFO | 11607: exit 0 22:13:51 INFO - TEST-OK | dromaeo_css | took 1108349ms 22:13:51 INFO - TEST-START | kraken 22:13:51 INFO - operating with platform_type : linux_ 22:13:51 INFO - Initialising browser for kraken test... 22:13:51 INFO - TEST-INFO | started process 11838 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsZdoMU/profile http://localhost:45081/getInfo.html) 22:13:55 INFO - PROCESS | 11838 | 22:13:55 INFO - PROCESS | 11838 | (process:11909): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:13:55 INFO - PROCESS | 11838 | 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] 22:13:56 INFO - PROCESS | 11838 | __metrics Screen width/height:1600/1200 22:13:56 INFO - PROCESS | 11838 | colorDepth:24 22:13:56 INFO - PROCESS | 11838 | Browser inner width/height: 1024/697 22:13:56 INFO - PROCESS | 11838 | __metrics 22:13:57 ERROR - PROCESS | 11838 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 22:13:57 INFO - TEST-INFO | 11838: exit 0 22:13:57 INFO - Browser initialized. 22:13:57 INFO - Running cycle 1/1 for kraken test... 22:13:57 INFO - TEST-INFO | started process 11959 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsZdoMU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:13:59 INFO - PROCESS | 11959 | 22:13:59 INFO - PROCESS | 11959 | (process:12021): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:14:09 INFO - PROCESS | 11959 | RSS: Main: 162754560 22:14:09 INFO - PROCESS | 11959 | 22:14:12 INFO - PROCESS | 11959 | Cycle 1(1): loaded http://localhost:45081/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45081/tests/kraken/driver.html?testName=audio-beat-detection) 22:14:12 INFO - PROCESS | 11959 | RSS: Main: 167124992 22:14:12 INFO - PROCESS | 11959 | 22:14:15 INFO - PROCESS | 11959 | Cycle 1(1): loaded http://localhost:45081/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45081/tests/kraken/driver.html?testName=audio-dft) 22:14:15 INFO - PROCESS | 11959 | RSS: Main: 170807296 22:14:15 INFO - PROCESS | 11959 | 22:14:18 INFO - PROCESS | 11959 | Cycle 1(1): loaded http://localhost:45081/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45081/tests/kraken/driver.html?testName=audio-fft) 22:14:19 INFO - PROCESS | 11959 | RSS: Main: 161001472 22:14:19 INFO - PROCESS | 11959 | 22:14:21 INFO - PROCESS | 11959 | Cycle 1(1): loaded http://localhost:45081/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45081/tests/kraken/driver.html?testName=audio-oscillator) 22:14:22 INFO - PROCESS | 11959 | RSS: Main: 161587200 22:14:22 INFO - PROCESS | 11959 | 22:14:24 INFO - PROCESS | 11959 | Cycle 1(1): loaded http://localhost:45081/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45081/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:14:24 INFO - PROCESS | 11959 | RSS: Main: 163020800 22:14:24 INFO - PROCESS | 11959 | 22:14:27 INFO - PROCESS | 11959 | Cycle 1(1): loaded http://localhost:45081/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45081/tests/kraken/driver.html?testName=imaging-darkroom) 22:14:28 INFO - PROCESS | 11959 | RSS: Main: 163106816 22:14:28 INFO - PROCESS | 11959 | 22:14:31 INFO - PROCESS | 11959 | Cycle 1(1): loaded http://localhost:45081/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45081/tests/kraken/driver.html?testName=imaging-desaturate) 22:14:32 INFO - PROCESS | 11959 | RSS: Main: 163172352 22:14:32 INFO - PROCESS | 11959 | 22:14:35 INFO - PROCESS | 11959 | Cycle 1(1): loaded http://localhost:45081/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45081/tests/kraken/driver.html?testName=json-parse-financial) 22:14:35 INFO - PROCESS | 11959 | RSS: Main: 165744640 22:14:35 INFO - PROCESS | 11959 | 22:14:37 INFO - PROCESS | 11959 | Cycle 1(1): loaded http://localhost:45081/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45081/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:14:37 INFO - PROCESS | 11959 | RSS: Main: 165675008 22:14:37 INFO - PROCESS | 11959 | 22:14:39 INFO - PROCESS | 11959 | Cycle 1(1): loaded http://localhost:45081/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45081/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:14:40 INFO - PROCESS | 11959 | RSS: Main: 166064128 22:14:40 INFO - PROCESS | 11959 | 22:14:42 INFO - PROCESS | 11959 | Cycle 1(1): loaded http://localhost:45081/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45081/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:14:42 INFO - PROCESS | 11959 | RSS: Main: 165969920 22:14:42 INFO - PROCESS | 11959 | 22:14:45 INFO - PROCESS | 11959 | Cycle 1(1): loaded http://localhost:45081/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:14:46 INFO - PROCESS | 11959 | RSS: Main: 166211584 22:14:46 INFO - PROCESS | 11959 | 22:14:48 INFO - PROCESS | 11959 | Cycle 1(1): loaded http://localhost:45081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:14:49 INFO - PROCESS | 11959 | RSS: Main: 166268928 22:14:49 INFO - PROCESS | 11959 | 22:14:50 INFO - PROCESS | 11959 | Cycle 1(1): loaded http://localhost:45081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45081/tests/kraken/driver.html?testName=ai-astar) 22:14:51 INFO - PROCESS | 11959 | RSS: Main: 167452672 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | __start_tp_report 22:14:51 INFO - PROCESS | 11959 | _x_x_mozilla_page_load 22:14:51 INFO - PROCESS | 11959 | _x_x_mozilla_page_load_details 22:14:51 INFO - PROCESS | 11959 | |i|pagename|runs| 22:14:51 INFO - PROCESS | 11959 | |0;ai-astar;111;102;111;110;109;122;110;116;108;108 22:14:51 INFO - PROCESS | 11959 | |1;audio-beat-detection;165;128;164;176;134;153;156;125;172;128 22:14:51 INFO - PROCESS | 11959 | |2;audio-dft;164;164;164;163;162;164;165;170;168;162 22:14:51 INFO - PROCESS | 11959 | |3;audio-fft;77;76;76;73;73;76;77;73;145;73 22:14:51 INFO - PROCESS | 11959 | |4;audio-oscillator;94;92;141;97;93;95;142;93;93;143 22:14:51 INFO - PROCESS | 11959 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;117;117;117 22:14:51 INFO - PROCESS | 11959 | |6;imaging-darkroom;149;147;146;146;147;146;146;148;147;149 22:14:51 INFO - PROCESS | 11959 | |7;imaging-desaturate;95;96;96;96;96;95;96;97;97;95 22:14:51 INFO - PROCESS | 11959 | |8;json-parse-financial;61;57;61;59;63;57;58;58;55;56 22:14:51 INFO - PROCESS | 11959 | |9;json-stringify-tinderbox;61;61;62;62;61;61;61;66;61;61 22:14:51 INFO - PROCESS | 11959 | |10;stanford-crypto-aes;80;79;81;80;79;83;80;80;80;81 22:14:51 INFO - PROCESS | 11959 | |11;stanford-crypto-ccm;118;124;117;121;129;114;114;127;115;124 22:14:51 INFO - PROCESS | 11959 | |12;stanford-crypto-pbkdf2;143;144;142;143;150;153;147;142;145;150 22:14:51 INFO - PROCESS | 11959 | |13;stanford-crypto-sha256-iterative;67;65;64;66;67;64;64;71;64;64 22:14:51 INFO - PROCESS | 11959 | __end_tp_report 22:14:51 INFO - PROCESS | 11959 | __start_cc_report 22:14:51 INFO - PROCESS | 11959 | _x_x_mozilla_cycle_collect,817 22:14:51 INFO - PROCESS | 11959 | __end_cc_report 22:14:51 INFO - PROCESS | 11959 | __startTimestamp1460006091081__endTimestamp 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | ------- Summary: start ------- 22:14:51 INFO - PROCESS | 11959 | Number of tests: 14 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | [#0] ai-astar Cycles:10 Average:110.70 Median:110.50 stddev:5.27 (4.8%) stddev-sans-first:5.59 22:14:51 INFO - PROCESS | 11959 | Values: 111.0 102.0 111.0 110.0 109.0 122.0 110.0 116.0 108.0 108.0 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:160.00 stddev:19.65 (12.3%) stddev-sans-first:20.09 22:14:51 INFO - PROCESS | 11959 | Values: 165.0 128.0 164.0 176.0 134.0 153.0 156.0 125.0 172.0 128.0 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:2.55 (1.6%) stddev-sans-first:2.69 22:14:51 INFO - PROCESS | 11959 | Values: 164.0 164.0 164.0 163.0 162.0 164.0 165.0 170.0 168.0 162.0 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:22.24 (29.3%) stddev-sans-first:23.52 22:14:51 INFO - PROCESS | 11959 | Values: 77.0 76.0 76.0 73.0 73.0 76.0 77.0 73.0 145.0 73.0 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:93.00 stddev:23.30 (25.1%) stddev-sans-first:24.13 22:14:51 INFO - PROCESS | 11959 | Values: 94.0 92.0 141.0 97.0 93.0 95.0 142.0 93.0 93.0 143.0 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:14:51 INFO - PROCESS | 11959 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:1.05 22:14:51 INFO - PROCESS | 11959 | Values: 149.0 147.0 146.0 146.0 147.0 146.0 146.0 148.0 147.0 149.0 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 22:14:51 INFO - PROCESS | 11959 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 96.0 97.0 97.0 95.0 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.50 stddev:2.51 (4.3%) stddev-sans-first:2.49 22:14:51 INFO - PROCESS | 11959 | Values: 61.0 57.0 61.0 59.0 63.0 57.0 58.0 58.0 55.0 56.0 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:61.00 stddev:1.57 (2.6%) stddev-sans-first:1.64 22:14:51 INFO - PROCESS | 11959 | Values: 61.0 61.0 62.0 62.0 61.0 61.0 61.0 66.0 61.0 61.0 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:1.16 (1.4%) stddev-sans-first:1.22 22:14:51 INFO - PROCESS | 11959 | Values: 80.0 79.0 81.0 80.0 79.0 83.0 80.0 80.0 80.0 81.0 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:122.50 stddev:5.50 (4.5%) stddev-sans-first:5.77 22:14:51 INFO - PROCESS | 11959 | Values: 118.0 124.0 117.0 121.0 129.0 114.0 114.0 127.0 115.0 124.0 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.90 Median:146.00 stddev:3.90 (2.7%) stddev-sans-first:3.99 22:14:51 INFO - PROCESS | 11959 | Values: 143.0 144.0 142.0 143.0 150.0 153.0 147.0 142.0 145.0 150.0 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - PROCESS | 11959 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:2.27 (3.5%) stddev-sans-first:2.35 22:14:51 INFO - PROCESS | 11959 | Values: 67.0 65.0 64.0 66.0 67.0 64.0 64.0 71.0 64.0 64.0 22:14:51 INFO - PROCESS | 11959 | -------- Summary: end -------- 22:14:51 INFO - PROCESS | 11959 | 22:14:51 INFO - TEST-INFO | 11959: exit 0 22:14:51 INFO - TEST-OK | kraken | took 60021ms 22:14:51 INFO - SUITE-END | took 1168s 22:14:52 INFO - Completed test suite (00:19:28) 22:14:52 INFO - javascript benchmark 22:14:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.0, 3126.202818281338, 3138.074268090913, 3170.778045536812, 3171.4767063434533, 5226.790928362866, 5235.083860324447, 5240.97800928819, 5241.240020197079, 5285.762140703668, 5219.138842091051, 5245.6852588844695, 5264.921026184601, 5281.656692314997, 5355.303810504629, 4804.351412559304, 4822.7829747661435, 4826.758662066883, 4995.300657907896, 5005.624578156635, 4977.850664480072, 5000.349954505909, 5014.523620256088, 5028.472010438906, 5030.320906677606, 4838.201696720037, 4868.9756551217015, 4882.731449770261, 4932.654714170009, 4940.036692844897, 4826.300186472977, 4853.514648535153, 4871.561559459666, 4871.561559459666, 4900.0, 4753.809847606091, 4823.734694591796, 4841.709497430165, 4846.927296090562, 4861.0277944411255, 5174.430812610647, 5207.297014903015, 5244.265802787613, 5247.501487358695, 5270.209468579706, 5585.944140558583, 5591.440855914376, 5592.944070559283, 5606.21512988182, 5616.157576363537, 5527.447255274481, 5637.43625637433, 5656.321241451053, 5660.490555849993, 5723.313202415695, 5288.92066619001, 5293.788248470057, 5297.5232229099565, 5304.416514183476, 5353.411124776271, 5703.030484817591, 5706.543476521868, 5715.8856822864145, 5725.914111288334, 5746.770129194869, 5533.667979921218, 5539.556835453154, 5568.0, 5620.522255608237, 5704.229928959538, 5513.9448605514235, 5699.715014249354, 5706.9429305707245, 5707.229524014288, 5722.856928576819, 5636.520895723909, 5653.830385088454, 5657.57568182388, 5660.858478537987, 5712.857178570486, 5482.150266708666, 5520.199571062173, 5581.972090139523, 5585.441455854382, 5605.80379686709, 4297.333913243452, 4317.568243175658, 4318.136372725405, 4334.631556317685, 4346.326319420495, 3820.6370394812448, 3834.2523207974177, 3861.189150278417, 3882.5340959085092, 3920.1375697347107, 5278.208268759717, 5406.270153529302, 5418.133098704188, 5434.157705555645, 5436.700981446058, 5724.542036637059, 5742.08126699726, 5750.568707346965, 5768.653880767168, 5779.393163717833, 5421.213923981, 5449.809256675997, 5451.882364115426, 5455.454454554513, 5457.20870473787, 4636.814527418933, 4719.3628860103445, 4756.1438940990265, 4799.6400269979895, 4800.831970881002, 5877.089051197071, 5902.675352855548, 5907.734151963172, 5909.3204281507315, 5929.6145750526075, 5613.354464236665, 5718.342390625048, 5736.282964629421, 5737.454941780524, 5766.192733017297, 5830.387809279964, 5858.502027327725, 5874.265716785402, 5882.882342353215, 5912.911306330495, 5543.72281385921, 5548.056830338772, 5561.110222364402, 5563.248961390161, 5566.721663916869, 5580.274564306615, 5657.4908258256955, 5664.943350566442, 5685.943140568541, 5695.1457281406465, 5410.675359478444, 5457.481539253765, 5502.752376143003, 5515.834524964257, 5566.165075238747, 5475.644083134743, 5498.835034948958, 5521.751521181476, 5540.667559946416, 5572.108462645957, 5426.104692725814, 5433.673979561239, 5438.809641662523, 5439.5920305978, 5440.265564148789, 5510.118381059011, 5516.862078448071, 5537.446255374431, 5555.611107222618, 5598.272224610774, 5342.0, 5393.595480339069, 5396.703181325065, 5409.107497262908, 5412.648177868426], "value": 5226.722456286616, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.464897910257, 533.0, 542.6554138122292, 557.3534699748292, 570.7842295909712, 35707.2858542829, 36078.81960590197, 36086.45870311944, 36141.0964725882, 36162.27675446496, 37630.0, 38027.61972380275, 38299.61700382995, 38355.0, 38436.615633843656, 8449.873251901241, 8539.573021348939, 8597.527136007517, 8607.655693772242, 8619.913800861974, 8405.705800296992, 8486.363522735788, 8519.3610479214, 8522.57387130644, 8533.615987280557, 8734.12658734128, 8812.295016398704, 8839.16027977341, 8846.778830529256, 8858.557072146366, 8731.301495880347, 8732.738017859474, 8781.868271975925, 8797.7800554986, 8832.11678832118, 8556.957215213884, 8682.088380719997, 8683.652653893836, 8697.347698922606, 8737.563121843947, 37648.24703505915, 38049.80975095107, 38050.42924356137, 38103.809480952696, 38169.809150954345, 3379.932401351959, 3763.5295588051495, 3933.599412243597, 3945.171513982067, 3959.4456776051375, 29749.851250743824, 29759.10722678323, 29811.403771924655, 30018.549721754192, 30036.849815750782, 4209.894752631178, 4336.457942757155, 4393.51671316155, 4462.955370446286, 4470.776461176928, 222336.0, 222542.0, 222629.3028022921, 222744.0, 223451.0, 50959.980800384525, 51517.0, 51620.74189629028, 51751.0, 51969.74015129976, 55237.72381138149, 55252.0, 55555.166672499945, 55612.16581751277, 55717.72141139268, 15557.14435706047, 15746.212689365715, 15790.842091579167, 15813.920930395274, 15885.126318052618, 12030.578929737418, 12077.27536347822, 12080.21478603888, 12114.333711645768, 12128.393580320948, 16300.0, 17558.736618950727, 17798.733019004725, 17849.28602855897, 17882.0, 6089.451949324493, 6238.313785483593, 6387.648679322589, 6534.4445722113205, 6568.6058836469965, 882.8410886040574, 987.7431867714446, 1067.4662668665667, 1082.976587125159, 1096.3750662122513, 28693.56959645607, 28971.85514072416, 29720.55419168714, 29963.40073198524, 30008.54987175194, 1049.9395610433364, 1054.6548221328178, 1061.2518174686827, 1086.559943222996, 1097.1223021582703, 14929.701405972037, 15271.083734975937, 15411.22943852803, 15536.223188840739, 15569.221538923008, 392468.0, 397652.0, 398407.0, 399575.0, 400051.0, 48947.26579101316, 49668.0, 49738.25392619114, 49751.50248497541, 49803.75098124486, 1207.9516819327305, 1241.211830487647, 1291.4704970961861, 1296.3906963727034, 1307.6600083978235, 28418.857905710338, 28588.857055714587, 28814.12708173962, 29142.417151656424, 29339.85330073336, 44478.55521444874, 44595.777021114685, 44756.0, 44803.0, 45055.09889802251, 330481.0, 330685.0, 330803.0, 330890.0, 334301.0, 31765.523517146798, 33250.50124248186, 33256.501152483215, 33399.49900751539, 33443.66556334503, 42039.3694094595, 42935.355969661105, 42944.570554294056, 43335.56664433315, 43866.56133438625, 36994.0, 37194.25611487701, 37196.44205336868, 37253.0686732823, 37254.25491490209, 36069.45895811617, 36118.27763444769, 36883.0, 37385.62614373821, 37420.81289593643, 31796.36407271888, 36313.45529817002, 37021.25957480889, 37024.62975370212, 37338.0, 30403.84798076084, 31265.0, 31406.0, 31445.52831707572, 31448.842755786074, 25891.741082588935, 26186.73813261843, 26290.079847205256, 26324.605130923435, 26374.0], "value": 18298.590511899463, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.4251955533148, 353.0626187472261, 356.28031376619214, 362.94737263096835, 363.66906115434944, 16579.668406631874, 16801.66396672066, 17222.827771722277, 17277.91361043193, 17290.56773580658, 15987.360505579793, 16400.343986240565, 17131.486055418358, 17572.56068598286, 17583.64832703345, 5464.863378415552, 5468.644538105021, 5597.7201139943045, 5610.326760788711, 5644.604877658566, 5449.155380915964, 5525.861853453655, 5575.498205161534, 5590.692511911843, 5614.8596285093, 5341.919871201935, 5536.0, 5537.944620553803, 5557.221988921554, 5588.050031494636, 5514.117741161415, 5520.917186242169, 5535.529479994185, 5544.750486228129, 5571.387147413781, 4907.779149938226, 4943.555080042777, 4965.82619608312, 4981.37732783402, 4998.850034498934, 18923.24307027717, 19527.90236048825, 20374.388768336972, 21125.366239012856, 21158.576828463345, 2359.6460530920326, 2381.5951288281035, 2386.021731090262, 2401.8558886466867, 2439.658447817307, 9343.0, 9654.855177172349, 9714.90285097154, 9732.07545283197, 9883.802323953552, 1753.2986805277862, 1811.7101263797729, 1916.281394477071, 1920.5774729559614, 1977.6736838421643, 56279.43720562783, 63648.0, 69559.3044069558, 70004.99999999949, 75210.0, 10015.849762253572, 10078.294519383573, 10097.899021009844, 10167.847482287623, 10438.269321147447, 13696.794548081787, 13699.041067125205, 13703.657408564866, 13779.862201378059, 13819.585412437644, 7283.344498995116, 7645.732399365996, 7684.193159718149, 7844.9607751960875, 7991.920080799234, 7369.22623124575, 7593.9368488411665, 7693.576853273124, 7775.3390961767755, 7816.687332506636, 4324.0, 4419.911601768011, 4420.027593929331, 4430.069685366045, 4484.798184081724, 1799.6220793633222, 1826.6803309420798, 1842.2262649687164, 1869.3737597904583, 1895.734597156399, 920.1074957291416, 960.9903900961041, 978.706388083572, 997.1972562087444, 1057.3021805608262, 17274.96350218991, 17732.822671773116, 17780.149306577005, 18097.909510452362, 18358.0, 934.1079269297804, 951.6003278622995, 964.4936408385513, 989.5893204320126, 990.6334656177116, 10121.544530496145, 10123.493825308706, 10163.0, 10246.59013639461, 10455.111315538112, 492598.0, 492634.0, 496516.0, 505987.0, 510169.0, 81304.0, 84775.0, 85239.57380213059, 86408.0, 87496.94956447236, 993.1508560181086, 1016.5577973581516, 1045.278757657214, 1045.3675526306627, 1047.1518070363031, 16182.352705891632, 16208.0, 16315.428959986344, 16349.509514714578, 16415.17924103814, 37475.25049499049, 38662.0, 39250.0, 39597.80201098976, 39879.202415952095, 53712.194317086054, 55225.0, 55273.0, 55311.0, 55894.720526397105, 8180.7954801130445, 8235.794105147419, 8411.663533458594, 8444.155584441753, 8510.531920744419, 10907.2364934457, 12775.1057425983, 12810.871891280967, 12846.293453860128, 12867.742645146858, 11076.723081923017, 11328.433578321215, 11351.091912646803, 11474.483648236017, 11530.711732206762, 10885.891141088488, 10916.727081823017, 10998.230123891572, 11222.10223182127, 11284.774304514029, 11465.885341146482, 11613.941930290295, 11874.762504749684, 11899.524019039141, 11942.70143246391, 8097.554634494923, 8141.185881411811, 8191.286226374731, 8256.587170641564, 8531.95734021326, 8953.373263871727, 11252.66242012741, 11868.881311187122, 11933.761324773282, 11982.340971246666], "value": 8717.698543371589, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.0854664554781, 1341.9798703019455, 1407.2611878763648, 1564.2491604030072, 1570.5680937742113, 6799.286074962132, 6987.860242795154, 7150.034745309388, 7296.197418283985, 7356.301151390616, 7460.0, 7499.962500187491, 7522.887156692654, 7574.242575742423, 7665.5783931883725, 2246.3036458697775, 2270.9886450567806, 2274.124462082102, 2295.6097463431256, 2298.241580278504, 2261.231181398324, 2281.0, 2321.5008773113777, 2321.918732844351, 2325.1861848353024, 2272.5682120397155, 2272.8409011369213, 2282.052948026567, 2286.371247906822, 2296.1045192374986, 2281.0875649740155, 2281.133169395619, 2283.600369935263, 2288.5880541502524, 2289.347535952246, 2378.6432035194684, 2382.6902502674716, 2385.2128797496785, 2389.2473870730664, 2394.8682822444757, 7611.467197296191, 7629.198934111894, 7656.770296891046, 7657.425693073042, 7683.231676832328, 4973.626977976666, 5077.365329333833, 5102.234664800272, 5107.7956881724685, 5119.56483698886, 3408.5739282589675, 3447.620761716209, 3539.3452211340727, 3594.3170797548382, 3646.890593282206, 1147.68438679363, 1166.2302880099178, 1166.422620802708, 1171.8945294923412, 1215.2829830400105, 10151.492425378701, 10298.7425314367, 10301.53643086063, 10303.793924121475, 10308.123809476203, 4293.50624678166, 4365.367021781887, 4375.584319489707, 4397.538258482878, 4404.933925991113, 8247.546384948766, 8254.257116859511, 8282.337413006944, 8307.169283071644, 8344.707935222237, 4780.593649539758, 4782.187028205213, 4808.639352048541, 4823.2282834746275, 4834.274858771142, 4072.1041370898356, 4517.548245175456, 4527.275635898241, 4530.818767249273, 4601.102784956901, 3476.1483436558206, 3512.121969507623, 3523.2601153757487, 3545.9290814184087, 3592.479090531858, 1108.0692218536467, 1118.8601424821898, 1121.1815374776295, 1121.899029087386, 1123.3540714089431, 1277.3485522383467, 1281.6027031620229, 1284.8329717136712, 1292.424870932426, 1311.698309388846, 6793.354631310018, 6826.522143449911, 6902.620355880475, 7089.291070892869, 7109.040279562297, 504.957078648319, 505.0505050505027, 508.0043115493674, 510.65020460984346, 516.339085969959, 5504.80733174345, 5538.695371754511, 5539.9169012464845, 5664.178694089416, 5682.659040457503, 8902.73291801247, 8913.197812196804, 9100.544972751468, 9173.678921237724, 9187.26501879848, 8977.685780997634, 8990.865137022949, 9018.458892466473, 9019.098090191059, 9041.367104302635, 7014.158301003912, 7016.298370162943, 7197.064381630459, 7270.563766174047, 7294.635268236673, 6951.930480695129, 6994.755183568551, 7002.929970700227, 7008.334208250208, 7015.684294206875, 7684.154742978156, 7838.686452541834, 7873.645685944031, 7961.522308661499, 8022.318102961313, 8512.276456501268, 8839.955800220958, 8883.777905552413, 8954.820903582022, 9007.729768106967, 6263.749450021948, 6357.554971151975, 6403.839904002437, 6499.0, 6647.800565983028, 6912.619805910522, 6928.757493487704, 6945.201301850352, 6959.8608027838145, 6960.651967401711, 6239.438450539473, 6348.428641422294, 6407.71165297572, 6449.193850768654, 6549.410553050057, 6355.650439225887, 6362.04569314588, 6386.457151142019, 6434.935650643433, 6453.548251622341, 6258.812235632939, 6310.148130002391, 6334.90497642545, 6383.9361606383345, 6387.808365749035, 6113.816585502442, 6128.050152226412, 6161.722722477589, 6165.506759459143, 6204.193454850841, 6487.935120648733, 6491.545591808528, 6516.250631177475, 6523.282438931618, 6547.0], "value": 4335.909746341112, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.8697907815952, 334.72050837550677, 336.0959020235566, 336.28203784919197, 342.56152125279635, 6483.351664833514, 6487.41613254807, 6511.316311787259, 6581.6380099094595, 6582.80251592453, 6484.254310754264, 6488.383603557654, 6492.0, 6493.155889734339, 6495.447886929616, 4669.533046695337, 4735.195016847127, 4903.1174388610125, 4912.631552633549, 4915.680480768757, 4924.975375123119, 4938.48145944676, 4947.678400903929, 4951.133551628451, 4956.87607809804, 4875.341828853113, 4876.585490233334, 4878.268259761029, 4896.730679812609, 4914.533119353674, 4909.0672772173175, 4914.967856750087, 4917.0903382874285, 4917.3607431033915, 4922.335484709554, 4298.11888562847, 4299.484061912559, 4300.397944287803, 4302.311630139163, 4308.5045219799495, 6154.353792851731, 6226.159468471744, 6266.592671476339, 6306.968465157691, 6324.430801227865, 5657.264555607786, 5695.857603559944, 5700.458456446631, 5701.059325211335, 5701.372848986608, 6822.3859852613, 6822.931770682279, 6831.062643063481, 6831.521793474459, 6835.624040677761, 4731.976340118277, 4737.076270127326, 4738.952610473885, 4739.4075740532435, 4741.122892264908, 7053.153621565445, 7105.8223544411285, 7147.0, 7151.249118842498, 7158.248383919666, 4516.593506584423, 4650.906981860344, 4675.57919787214, 4851.830185943475, 4865.1485989952325, 4668.5798278155125, 4693.624510039189, 4702.435707715096, 4704.835330763407, 4734.21885388907, 5525.502704756591, 5550.888982220333, 5553.111502159635, 5557.166425036196, 5575.219469274305, 6899.48253880961, 6944.687489063004, 6956.339147780953, 6968.198657154492, 6973.79078627642, 1646.6788976149535, 1667.0414511655604, 1667.1914121650989, 1669.9415520456726, 1671.607172314505, 1036.4713995862014, 1062.6440142552176, 1065.1319174872453, 1067.9626213082504, 1077.7521170130758, 6570.934290657128, 6589.7364105435245, 6602.966985165043, 6606.603603783692, 6611.834704132435, 7003.3346832050875, 7095.787126386217, 7102.289771022856, 7108.040414544073, 7108.040414544073, 6443.838904027343, 6639.236487803868, 6666.166729158856, 6674.766383176566, 6675.265720770712, 3836.4820749199057, 3857.9228415431535, 3878.030492376906, 3880.1269714314617, 3888.183481468867, 7518.060242469692, 7546.2831031051965, 7565.73519926811, 7579.924200758032, 7605.391568674493, 7408.629568521553, 7412.814679633052, 7416.555006699616, 7418.591977441292, 7423.4061275097865, 7226.385757210591, 7492.138404083491, 7505.849883002309, 7538.585377804164, 7544.735934242275, 7157.821054473679, 7201.567905925661, 7208.675609597476, 7215.8556828864175, 7216.89174662391, 7112.324329188718, 7113.928860711327, 7118.679659415442, 7134.286571342825, 7148.499605027599, 7184.173820010766, 7439.665215065227, 7455.7017719290625, 7485.401167906445, 7499.700011999459, 4698.718076915396, 4707.693999889996, 4732.077244937204, 4736.478987311462, 4736.8578942631775, 7157.821054473679, 7178.461615378972, 7182.820429489305, 7190.856182876418, 7195.604241766753, 6933.653317334012, 6940.722371105301, 6949.270326615632, 6972.7210911565, 6974.442044636518, 6657.53397262187, 6848.14398200225, 6911.17065952089, 6921.2732663071665, 6951.721931122901, 6755.189377274758, 6765.797026089225, 6800.387965083166, 6814.965925170342, 6815.727370905108, 6976.860462790817, 6977.755778547727, 6985.336393042653, 6990.475714321345, 6994.720211191496, 6756.763513277012, 6762.830929226809, 6771.3905748482875, 6773.661316934035, 6774.42417394527], "value": 5153.6659061644405, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.4725823777759, 750.5496701978814, 767.4014268870283, 772.4824367673658, 780.4107898536606, 13873.653158671039, 14045.43818247269, 14045.57863264101, 14065.578032659037, 14119.0, 12933.094683372168, 13015.34923253836, 13026.80459793104, 13049.0, 13067.085304028722, 573.1345668041267, 662.4402379988902, 678.8065401360614, 680.2585182151454, 681.2914568848416, 660.2242365220847, 665.2250128600175, 665.8435267712084, 667.6628302707151, 670.8423520472685, 709.1065257775189, 711.1359697966969, 713.4684659928361, 713.6645776485044, 713.6681443128944, 701.1516065560678, 701.9578825270474, 704.2042491984051, 705.9576425414491, 707.4552594502256, 516.2978349444752, 519.571353633254, 520.0846510142139, 520.3729505945364, 520.7240162713767, 13454.529091481849, 13472.5284615038, 13479.393427295698, 13495.325233738275, 13512.121712088683, 12176.939115304456, 12243.69390765229, 12832.935835320857, 12885.226886386754, 13134.34328283582, 10503.2122590806, 10530.36817790935, 10646.25476216665, 10669.946650266776, 10679.145668346513, 3718.222855785236, 3722.292764374787, 3758.7368884178118, 3767.453719210699, 3893.669038131762, 55132.724336378466, 55154.72422637861, 55241.72379138119, 56997.43002569963, 58005.12992305119, 9600.66397676092, 9780.608775649036, 9891.35706179096, 9954.452505112144, 9982.60069597208, 18953.526161846064, 18964.715529267072, 19029.61940761205, 19061.0, 19108.0, 7934.404919631051, 8144.633491492897, 8150.144234855374, 8256.422050456531, 8323.625436855356, 4643.164230438486, 4700.388949436551, 4707.835225767081, 4724.173269677862, 4762.857114286577, 3239.4492936200904, 3247.7401807855786, 3248.1067706380463, 3275.4922986936585, 3278.5901762279714, 578.9305283365939, 582.8834233153386, 585.6369051188206, 586.1471558881902, 586.6978506069378, 690.4476418864888, 695.0026711668771, 730.9780706578811, 743.2344684974485, 751.3876190904396, 9118.954405228063, 9634.325597208268, 9638.277129215337, 9660.420374777535, 9698.951505242429, 653.8953767397194, 698.1308271202386, 720.8857734586536, 730.5762657658545, 733.3143510817403, 4356.283542485521, 4434.224010798098, 4497.123061003073, 4584.6561507887045, 4588.655850811202, 69783.30216697768, 70370.29629703739, 70786.292137079, 71247.6437617819, 71361.2863871365, 59670.403295966484, 60804.0, 60975.0, 61290.38709612847, 61329.38670613326, 53502.73248633732, 53749.1937620936, 54297.45702543003, 54708.452915471134, 54777.726111369986, 8805.207531322212, 8971.910280897107, 9145.0, 9209.539523023956, 9269.76825579339, 38867.416988744626, 40169.179698436375, 40176.39735403913, 41214.0, 41881.16237675169, 50988.74505627596, 52889.471105289995, 53316.46683533115, 53497.73251133719, 53629.7318513405, 10913.39976301311, 10914.072303853944, 11286.830697539708, 11304.095672346357, 11453.541858325574, 11510.991743758215, 11538.3653899033, 11571.826422603835, 12292.323922184365, 12728.0, 11595.420228988685, 11631.0, 11839.348835814113, 11857.0, 11944.880551194377, 11110.44447777624, 11134.665960021212, 11137.665870023913, 11240.896247065053, 11357.093318564634, 11668.941655292008, 11695.941520292345, 11760.411979400824, 11824.527018919147, 12082.577109801467, 9872.457014863965, 9985.500724963578, 9990.400575965465, 10022.699319020441, 10279.897201027894, 9858.85211721839, 10364.274500784873, 10404.739881503023, 10417.531211095671, 10432.530536126045], "value": 6493.590507773173, "unit": "score"}], "name": "dromaeo_css", "value": 7032.794989423326, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 102.0, 111.0, 110.0, 109.0, 122.0, 110.0, 116.0, 108.0, 108.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 128.0, 164.0, 176.0, 134.0, 153.0, 156.0, 125.0, 172.0, 128.0], "value": 150.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 163.0, 162.0, 164.0, 165.0, 170.0, 168.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 73.0, 73.0, 76.0, 77.0, 73.0, 145.0, 73.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 141.0, 97.0, 93.0, 95.0, 142.0, 93.0, 93.0, 143.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 148.0, 147.0, 149.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 97.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 57.0, 61.0, 59.0, 63.0, 57.0, 58.0, 58.0, 55.0, 56.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 66.0, 61.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 81.0, 80.0, 79.0, 83.0, 80.0, 80.0, 80.0, 81.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 124.0, 117.0, 121.0, 129.0, 114.0, 114.0, 127.0, 115.0, 124.0], "value": 120.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 144.0, 142.0, 143.0, 150.0, 153.0, 147.0, 142.0, 145.0, 150.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 66.0, 67.0, 64.0, 64.0, 71.0, 64.0, 64.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1508.1, "alertThreshold": 2.0}]} 22:14:52 INFO - Return code: 0 22:14:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:14:52 ERROR - # TBPL SUCCESS # 22:14:52 INFO - Running post-action listener: _resource_record_post_action 22:14:52 INFO - Running post-run listener: _resource_record_post_run 22:14:53 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538648576; Read time: 8; Write time: 554612 22:14:53 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 243511296; Read time: 0; Write time: 343580 22:14:53 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295137280; Read time: 8; Write time: 211032 22:14:53 INFO - Running post-run listener: _upload_blobber_files 22:14:53 INFO - Blob upload gear active. 22:14:53 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:14:53 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 22:14:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:14:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:14:53 INFO - (blobuploader) - INFO - Open directory for files ... 22:14:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:14:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:14:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:14:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:14:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:14:54 INFO - (blobuploader) - INFO - Done attempting. 22:14:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:14:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:14:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:14:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:14:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:14:55 INFO - (blobuploader) - INFO - Done attempting. 22:14:55 INFO - (blobuploader) - INFO - Iteration through files over. 22:14:55 INFO - Return code: 0 22:14:55 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:14:55 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:14:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/80a4a4c3a4a663e9cf3c39b9d55dd91ba75c9a9382d1d9b982f6282d27333190826774d69f7d9c063f95055bf84380842a7f2e9aea0ec5d99e35b0814da78a9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1a6115c1afc66d3656c1f998d16be32dcedb4e908ab0614b17106ef5c664c3b1e986ec6ef13e68278f6c12503337e536abd904abc0549ad2094b0a5fa08dae3f"} 22:14:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:14:55 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:14:55 INFO - Contents: 22:14:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/80a4a4c3a4a663e9cf3c39b9d55dd91ba75c9a9382d1d9b982f6282d27333190826774d69f7d9c063f95055bf84380842a7f2e9aea0ec5d99e35b0814da78a9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1a6115c1afc66d3656c1f998d16be32dcedb4e908ab0614b17106ef5c664c3b1e986ec6ef13e68278f6c12503337e536abd904abc0549ad2094b0a5fa08dae3f"} 22:14:55 INFO - Running post-run listener: copy_logs_to_upload_dir 22:14:55 INFO - Copying logs to upload dir... 22:14:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:14:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.975804 ========= master_lag: 0.98 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-06 22:14:56.109528) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 22:14:56.117083) ========= 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=836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/80a4a4c3a4a663e9cf3c39b9d55dd91ba75c9a9382d1d9b982f6282d27333190826774d69f7d9c063f95055bf84380842a7f2e9aea0ec5d99e35b0814da78a9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1a6115c1afc66d3656c1f998d16be32dcedb4e908ab0614b17106ef5c664c3b1e986ec6ef13e68278f6c12503337e536abd904abc0549ad2094b0a5fa08dae3f"} build_url:https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/80a4a4c3a4a663e9cf3c39b9d55dd91ba75c9a9382d1d9b982f6282d27333190826774d69f7d9c063f95055bf84380842a7f2e9aea0ec5d99e35b0814da78a9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1a6115c1afc66d3656c1f998d16be32dcedb4e908ab0614b17106ef5c664c3b1e986ec6ef13e68278f6c12503337e536abd904abc0549ad2094b0a5fa08dae3f"}' ========= master_lag: 0.29 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 22:14:56.422959) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 22:14:56.423323) ========= 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=836cfdc75598d54cb747368e000001a9-1459999331.536748-1555627405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 22:14:56.442679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 22:14:56.443004) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 22:14:56.443306) ========= ========= Total master_lag: 1.47 =========