builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1457372203.55 results: success (0) buildid: 20160307063917 builduid: 312d26195a5943de90ca150fc9705a8a revision: be593a64d7c6a826260514fe758ef32a6ee580f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:43.548731) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:43.549735) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:43.550430) ========= 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=745a4373a2a16df560f216e000000264-1457372203.874566-1782808492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005017 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:43.576416) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:43.576700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:43.590915) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:43.591475) ========= 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=745a4373a2a16df560f216e000000264-1457372203.874566-1782808492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004634 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:43.643498) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:43.644104) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:43.644981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:43.645612) ========= 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=745a4373a2a16df560f216e000000264-1457372203.874566-1782808492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-07 09:36:44-- 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% 222M=0s 2016-03-07 09:36:44 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100366 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:43.759554) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:43.759858) ========= 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=745a4373a2a16df560f216e000000264-1457372203.874566-1782808492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022879 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:43.809128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:43.809445) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev be593a64d7c6a826260514fe758ef32a6ee580f7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev be593a64d7c6a826260514fe758ef32a6ee580f7 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1457372203.874566-1782808492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-07 09:36:44,799 truncating revision to first 12 chars 2016-03-07 09:36:44,799 Setting DEBUG logging. 2016-03-07 09:36:44,799 attempt 1/10 2016-03-07 09:36:44,799 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/be593a64d7c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 09:36:45,031 unpacking tar archive at: mozilla-central-be593a64d7c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.499010 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:44.325034) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:44.325873) ========= echo be593a64d7c6a826260514fe758ef32a6ee580f7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'be593a64d7c6a826260514fe758ef32a6ee580f7'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1457372203.874566-1782808492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False be593a64d7c6a826260514fe758ef32a6ee580f7 program finished with exit code 0 elapsedTime=0.004644 script_repo_revision: 'be593a64d7c6a826260514fe758ef32a6ee580f7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:44.383314) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:44.384045) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 09:36:44.395395) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-07 09:36:44.395793) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1457372203.874566-1782808492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:36:45 INFO - MultiFileLogger online at 20160307 09:36:45 in /builds/slave/test-pgo 09:36:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:36:45 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:36:45 INFO - {'append_to_log': False, 09:36:45 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:36:45 INFO - 'blob_upload_branch': 'Firefox', 09:36:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:36:45 INFO - 'branch': 'Firefox', 09:36:45 INFO - 'buildbot_json_path': 'buildprops.json', 09:36:45 INFO - 'config_files': ('talos/linux_config.py',), 09:36:45 INFO - 'default_actions': ('clobber', 09:36:45 INFO - 'read-buildbot-config', 09:36:45 INFO - 'download-and-extract', 09:36:45 INFO - 'populate-webroot', 09:36:45 INFO - 'create-virtualenv', 09:36:45 INFO - 'install', 09:36:45 INFO - 'run-tests'), 09:36:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:36:45 INFO - 'download_minidump_stackwalk': True, 09:36:45 INFO - 'download_symbols': 'ondemand', 09:36:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:36:45 INFO - 'tooltool.py': '/tools/tooltool.py', 09:36:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:36:45 INFO - '/tools/misc-python/virtualenv.py')}, 09:36:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:36:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:36:45 INFO - 'installer_path': 'installer.exe', 09:36:45 INFO - 'log_level': 'info', 09:36:45 INFO - 'log_name': 'talos', 09:36:45 INFO - 'log_to_console': True, 09:36:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:36:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:36:45 INFO - 'opt_config_files': (), 09:36:45 INFO - 'pip_index': False, 09:36:45 INFO - 'sps_profile': False, 09:36:45 INFO - 'sps_profile_interval': 0, 09:36:45 INFO - 'suite': 'dromaeojs', 09:36:45 INFO - 'system_bits': '32', 09:36:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:36:45 INFO - 'title': 'talos-linux64-ix-032', 09:36:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:36:45 INFO - 'use_talos_json': True, 09:36:45 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:36:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:36:45 INFO - 'work_dir': 'build'} 09:36:45 INFO - ##### 09:36:45 INFO - ##### Running clobber step. 09:36:45 INFO - ##### 09:36:45 INFO - Running pre-action listener: _resource_record_pre_action 09:36:45 INFO - Running main action method: clobber 09:36:45 INFO - rmtree: /builds/slave/test-pgo/build 09:36:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:36:45 INFO - Running post-action listener: _resource_record_post_action 09:36:45 INFO - ##### 09:36:45 INFO - ##### Running read-buildbot-config step. 09:36:45 INFO - ##### 09:36:45 INFO - Running pre-action listener: _resource_record_pre_action 09:36:45 INFO - Running main action method: read_buildbot_config 09:36:45 INFO - Using buildbot properties: 09:36:45 INFO - { 09:36:45 INFO - "project": "", 09:36:45 INFO - "product": "firefox", 09:36:45 INFO - "script_repo_revision": "production", 09:36:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:36:45 INFO - "repository": "", 09:36:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 09:36:45 INFO - "buildid": "20160307063917", 09:36:45 INFO - "stage_platform": "linux64-pgo", 09:36:45 INFO - "basedir": "/builds/slave/test-pgo", 09:36:45 INFO - "nightly_build": "True", 09:36:45 INFO - "buildnumber": 704, 09:36:45 INFO - "slavename": "talos-linux64-ix-032", 09:36:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:36:45 INFO - "platform": "ubuntu64_hw", 09:36:45 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:36:45 INFO - "branch": "mozilla-central", 09:36:45 INFO - "repo_path": "mozilla-central", 09:36:45 INFO - "revision": "be593a64d7c6a826260514fe758ef32a6ee580f7", 09:36:45 INFO - "pgo_build": "True", 09:36:45 INFO - "builduid": "312d26195a5943de90ca150fc9705a8a", 09:36:45 INFO - "slavebuilddir": "test" 09:36:45 INFO - } 09:36:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:36:45 INFO - Running post-action listener: _resource_record_post_action 09:36:45 INFO - ##### 09:36:45 INFO - ##### Running download-and-extract step. 09:36:45 INFO - ##### 09:36:45 INFO - Running pre-action listener: _resource_record_pre_action 09:36:45 INFO - Running main action method: download_and_extract 09:36:45 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:45 INFO - https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:36:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:36:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:36:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:36:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:36:46 INFO - Downloaded 1448 bytes. 09:36:46 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:36:46 INFO - Using the following test package requirements: 09:36:46 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:36:46 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:36:46 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:36:46 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:46 INFO - u'jsshell-linux-x86_64.zip'], 09:36:46 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:36:46 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:36:46 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:36:46 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:36:46 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:36:46 INFO - u'webapprt': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:36:46 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:36:46 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:36: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')]} 09:36:46 INFO - https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:36:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:36:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:36:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:36:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:36:47 INFO - Downloaded 23405878 bytes. 09:36:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:36:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:36:48 INFO - Return code: 0 09:36:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:48 INFO - https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:36:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:36:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:36:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:36:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:36:50 INFO - Downloaded 23405878 bytes. 09:36:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:36:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:36:51 INFO - Return code: 0 09:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:51 INFO - https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:36:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:36:52 INFO - Downloaded 10845161 bytes. 09:36:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:36:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 09:36:52 INFO - Return code: 0 09:36: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')]} 09:36:52 INFO - https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:36:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:36:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:36:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:36:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:36:57 INFO - Downloaded 56178532 bytes. 09:36:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:36:57 INFO - mkdir: /builds/slave/test-pgo/properties 09:36:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:36:57 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:36:57 INFO - Contents: 09:36:57 INFO - build_url:https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:36:57 INFO - Running post-action listener: _resource_record_post_action 09:36:57 INFO - Running post-action listener: set_extra_try_arguments 09:36:57 INFO - ##### 09:36:57 INFO - ##### Running populate-webroot step. 09:36:57 INFO - ##### 09:36:57 INFO - Running pre-action listener: _resource_record_pre_action 09:36:57 INFO - Running main action method: populate_webroot 09:36:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:36:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:36:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:36:57 INFO - '--tppagecycles', 09:36:57 INFO - '7'], 09:36:57 INFO - 'tests': ['tsvgm']}}, 09:36:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:36:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:36:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:36:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:36:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:36:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:36:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:57 INFO - 'talos_options': ['--e10s'], 09:36:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:57 INFO - 'tests': ['damp', 'tps']}, 09:36:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:57 INFO - 'talos_options': ['--e10s'], 09:36:57 INFO - 'tests': ['damp', 'tps']}, 09:36:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:36:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:36:57 INFO - 'other': {'tests': ['a11yr', 09:36:57 INFO - 'ts_paint', 09:36:57 INFO - 'tpaint', 09:36:57 INFO - 'sessionrestore', 09:36:57 INFO - 'sessionrestore_no_auto_restore', 09:36:57 INFO - 'tabpaint']}, 09:36:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:36:57 INFO - 'tests': ['a11yr', 09:36:57 INFO - 'ts_paint', 09:36:57 INFO - 'tpaint', 09:36:57 INFO - 'sessionrestore', 09:36:57 INFO - 'sessionrestore_no_auto_restore', 09:36:57 INFO - 'tabpaint']}, 09:36:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:36:57 INFO - 'tests': ['a11yr', 09:36:57 INFO - 'ts_paint', 09:36:57 INFO - 'tpaint', 09:36:57 INFO - 'sessionrestore', 09:36:57 INFO - 'sessionrestore_no_auto_restore', 09:36:57 INFO - 'tabpaint']}, 09:36:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:36:57 INFO - 'tests': ['a11yr', 09:36:57 INFO - 'ts_paint', 09:36:57 INFO - 'tpaint', 09:36:57 INFO - 'sessionrestore', 09:36:57 INFO - 'sessionrestore_no_auto_restore', 09:36:57 INFO - 'tabpaint']}, 09:36:57 INFO - 'other_l64': {'tests': ['a11yr', 09:36:57 INFO - 'ts_paint', 09:36:57 INFO - 'tpaint', 09:36:57 INFO - 'sessionrestore', 09:36:57 INFO - 'sessionrestore_no_auto_restore', 09:36:57 INFO - 'tabpaint']}, 09:36:57 INFO - 'other_nol64': {'tests': ['a11yr', 09:36:57 INFO - 'ts_paint', 09:36:57 INFO - 'tpaint', 09:36:57 INFO - 'sessionrestore', 09:36:57 INFO - 'sessionrestore_no_auto_restore', 09:36:57 INFO - 'tabpaint']}, 09:36:57 INFO - 'svgr': {'tests': ['tsvgx', 09:36:57 INFO - 'tsvgr_opacity', 09:36:57 INFO - 'tart', 09:36:57 INFO - 'tscrollx', 09:36:57 INFO - 'cart']}, 09:36:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:36:57 INFO - 'tests': ['tsvgx', 09:36:57 INFO - 'tsvgr_opacity', 09:36:57 INFO - 'tart', 09:36:57 INFO - 'tscrollx', 09:36:57 INFO - 'cart']}, 09:36:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:57 INFO - 'tests': ['tp5o']}, 09:36:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:57 INFO - 'talos_options': ['--e10s'], 09:36:57 INFO - 'tests': ['tp5o']}, 09:36:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:57 INFO - 'talos_options': ['--xperf_path', 09:36:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:57 INFO - 'tests': ['tp5n']}, 09:36:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:57 INFO - 'talos_options': ['--e10s', 09:36:57 INFO - '--xperf_path', 09:36:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:57 INFO - 'tests': ['tp5n']}}, 09:36:57 INFO - 'talos.zip': {'path': '', 09:36:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:36:57 INFO - Running post-action listener: _resource_record_post_action 09:36:57 INFO - ##### 09:36:57 INFO - ##### Running create-virtualenv step. 09:36:57 INFO - ##### 09:36:57 INFO - Running pre-action listener: _resource_record_pre_action 09:36:57 INFO - Running main action method: create_virtualenv 09:36:57 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:36:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 09:36:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:36:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:36:57 INFO - Using real prefix '/usr' 09:36:57 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:36:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:37:00 INFO - Installing pip.................done. 09:37:00 INFO - Return code: 0 09:37:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:00 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 0x7ffa09872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b920>, '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 0x139c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139ccb0>, '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': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:37:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:37:00 INFO - Using env: {'DISPLAY': ':0', 09:37:00 INFO - 'HOME': '/home/cltbld', 09:37:00 INFO - 'LANG': 'en_US.UTF-8', 09:37:00 INFO - 'LANGUAGE': 'en_US:en', 09:37:00 INFO - 'LOGNAME': 'cltbld', 09:37:00 INFO - 'MAIL': '/var/mail/cltbld', 09:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:00 INFO - 'MOZ_NO_REMOTE': '1', 09:37:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:00 INFO - 'NO_EM_RESTART': '1', 09:37:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:37:00 INFO - 'PWD': '/builds/slave/test-pgo', 09:37:00 INFO - 'SHELL': '/bin/bash', 09:37:00 INFO - 'SHLVL': '1', 09:37:00 INFO - 'TERM': 'linux', 09:37:00 INFO - 'TMOUT': '86400', 09:37:00 INFO - 'USER': 'cltbld', 09:37:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 09:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:00 INFO - '_': '/tools/buildbot/bin/python'} 09:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:37:00 INFO - Cleaning up... 09:37:00 INFO - Return code: 0 09:37:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:00 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 0x7ffa09872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b920>, '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 0x139c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139ccb0>, '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': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:37:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:37:00 INFO - Using env: {'DISPLAY': ':0', 09:37:00 INFO - 'HOME': '/home/cltbld', 09:37:00 INFO - 'LANG': 'en_US.UTF-8', 09:37:00 INFO - 'LANGUAGE': 'en_US:en', 09:37:00 INFO - 'LOGNAME': 'cltbld', 09:37:00 INFO - 'MAIL': '/var/mail/cltbld', 09:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:00 INFO - 'MOZ_NO_REMOTE': '1', 09:37:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:00 INFO - 'NO_EM_RESTART': '1', 09:37:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:37:00 INFO - 'PWD': '/builds/slave/test-pgo', 09:37:00 INFO - 'SHELL': '/bin/bash', 09:37:00 INFO - 'SHLVL': '1', 09:37:00 INFO - 'TERM': 'linux', 09:37:00 INFO - 'TMOUT': '86400', 09:37:00 INFO - 'USER': 'cltbld', 09:37:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 09:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:00 INFO - '_': '/tools/buildbot/bin/python'} 09:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:00 INFO - Downloading/unpacking psutil>=0.7.1 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:37:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:02 INFO - Installing collected packages: psutil 09:37:02 INFO - Running setup.py install for psutil 09:37:02 INFO - building 'psutil._psutil_linux' extension 09:37:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:37:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:37:03 INFO - building 'psutil._psutil_posix' extension 09:37:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:37:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:37:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:03 INFO - Successfully installed psutil 09:37:03 INFO - Cleaning up... 09:37:03 INFO - Return code: 0 09:37:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:03 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 0x7ffa09872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b920>, '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 0x139c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139ccb0>, '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': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:37:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:37:03 INFO - Using env: {'DISPLAY': ':0', 09:37:03 INFO - 'HOME': '/home/cltbld', 09:37:03 INFO - 'LANG': 'en_US.UTF-8', 09:37:03 INFO - 'LANGUAGE': 'en_US:en', 09:37:03 INFO - 'LOGNAME': 'cltbld', 09:37:03 INFO - 'MAIL': '/var/mail/cltbld', 09:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:03 INFO - 'MOZ_NO_REMOTE': '1', 09:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:03 INFO - 'NO_EM_RESTART': '1', 09:37:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:37:03 INFO - 'PWD': '/builds/slave/test-pgo', 09:37:03 INFO - 'SHELL': '/bin/bash', 09:37:03 INFO - 'SHLVL': '1', 09:37:03 INFO - 'TERM': 'linux', 09:37:03 INFO - 'TMOUT': '86400', 09:37:03 INFO - 'USER': 'cltbld', 09:37:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 09:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:03 INFO - '_': '/tools/buildbot/bin/python'} 09:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:37:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:37:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:37:05 INFO - Installing collected packages: mozsystemmonitor 09:37:05 INFO - Running setup.py install for mozsystemmonitor 09:37:05 INFO - Successfully installed mozsystemmonitor 09:37:05 INFO - Cleaning up... 09:37:05 INFO - Return code: 0 09:37:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:05 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 0x7ffa09872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b920>, '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 0x139c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139ccb0>, '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': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:37:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:37:05 INFO - Using env: {'DISPLAY': ':0', 09:37:05 INFO - 'HOME': '/home/cltbld', 09:37:05 INFO - 'LANG': 'en_US.UTF-8', 09:37:05 INFO - 'LANGUAGE': 'en_US:en', 09:37:05 INFO - 'LOGNAME': 'cltbld', 09:37:05 INFO - 'MAIL': '/var/mail/cltbld', 09:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:05 INFO - 'MOZ_NO_REMOTE': '1', 09:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:05 INFO - 'NO_EM_RESTART': '1', 09:37:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:37:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:37:05 INFO - 'SHELL': '/bin/bash', 09:37:05 INFO - 'SHLVL': '1', 09:37:05 INFO - 'TERM': 'linux', 09:37:05 INFO - 'TMOUT': '86400', 09:37:05 INFO - 'USER': 'cltbld', 09:37:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 09:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:05 INFO - '_': '/tools/buildbot/bin/python'} 09:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:05 INFO - Downloading/unpacking blobuploader==1.2.4 09:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:07 INFO - Downloading blobuploader-1.2.4.tar.gz 09:37:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:37:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:37:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:08 INFO - Downloading docopt-0.6.1.tar.gz 09:37:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:37:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:37:08 INFO - Running setup.py install for blobuploader 09:37:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:37:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:37:08 INFO - Running setup.py install for requests 09:37:08 INFO - Running setup.py install for docopt 09:37:08 INFO - Successfully installed blobuploader requests docopt 09:37:08 INFO - Cleaning up... 09:37:08 INFO - Return code: 0 09:37:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:08 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 0x7ffa09872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b920>, '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 0x139c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139ccb0>, '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': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:37:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:37:08 INFO - Using env: {'DISPLAY': ':0', 09:37:08 INFO - 'HOME': '/home/cltbld', 09:37:08 INFO - 'LANG': 'en_US.UTF-8', 09:37:08 INFO - 'LANGUAGE': 'en_US:en', 09:37:08 INFO - 'LOGNAME': 'cltbld', 09:37:08 INFO - 'MAIL': '/var/mail/cltbld', 09:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:08 INFO - 'MOZ_NO_REMOTE': '1', 09:37:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:08 INFO - 'NO_EM_RESTART': '1', 09:37:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:37:08 INFO - 'PWD': '/builds/slave/test-pgo', 09:37:08 INFO - 'SHELL': '/bin/bash', 09:37:08 INFO - 'SHLVL': '1', 09:37:08 INFO - 'TERM': 'linux', 09:37:08 INFO - 'TMOUT': '86400', 09:37:08 INFO - 'USER': 'cltbld', 09:37:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 09:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:08 INFO - '_': '/tools/buildbot/bin/python'} 09:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:37:09 INFO - Running setup.py (path:/tmp/pip-ZoqV7W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:37:09 INFO - Running setup.py (path:/tmp/pip-0hvlex-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:37:09 INFO - Running setup.py (path:/tmp/pip-9QzSa5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:37:09 INFO - Running setup.py (path:/tmp/pip-8idFe0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:37:09 INFO - Running setup.py (path:/tmp/pip-5eZFAe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:37:09 INFO - Running setup.py (path:/tmp/pip-_0D5L0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:37:09 INFO - Running setup.py (path:/tmp/pip-AP6jbB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:37:09 INFO - Running setup.py (path:/tmp/pip-8juKNC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:37:09 INFO - Running setup.py (path:/tmp/pip-QRhpme-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:37:09 INFO - Running setup.py (path:/tmp/pip-oVz88G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:37:09 INFO - Running setup.py (path:/tmp/pip-RCjIFe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:37:09 INFO - Running setup.py (path:/tmp/pip-ejliYl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:37:10 INFO - Running setup.py (path:/tmp/pip-3EhTeK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:37:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:37:10 INFO - Running setup.py (path:/tmp/pip-wBTDAq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:37:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:37:10 INFO - Running setup.py (path:/tmp/pip-veQyGi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:37:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:37:10 INFO - Running setup.py (path:/tmp/pip-i92Y35-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:37:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:37:10 INFO - Running setup.py (path:/tmp/pip-0Te00u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:37:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:37:10 INFO - Running setup.py install for manifestparser 09:37:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:37:10 INFO - Running setup.py install for mozcrash 09:37:10 INFO - Running setup.py install for mozdebug 09:37:10 INFO - Running setup.py install for mozdevice 09:37:10 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:37:10 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:37:10 INFO - Running setup.py install for mozfile 09:37:10 INFO - Running setup.py install for mozhttpd 09:37:10 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:37:10 INFO - Running setup.py install for mozinfo 09:37:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:37:11 INFO - Running setup.py install for mozInstall 09:37:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:37:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:37:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:37:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:37:11 INFO - Running setup.py install for mozleak 09:37:11 INFO - Running setup.py install for mozlog 09:37:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:37:11 INFO - Running setup.py install for moznetwork 09:37:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:37:11 INFO - Running setup.py install for mozprocess 09:37:11 INFO - Running setup.py install for mozprofile 09:37:11 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:37:11 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:37:11 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:37:11 INFO - Running setup.py install for mozrunner 09:37:11 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:37:11 INFO - Running setup.py install for mozscreenshot 09:37:11 INFO - Running setup.py install for moztest 09:37:12 INFO - Running setup.py install for mozversion 09:37:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:37:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:37:12 INFO - Cleaning up... 09:37:12 INFO - Return code: 0 09:37:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:12 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 0x7ffa09872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b920>, '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 0x139c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139ccb0>, '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': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:37:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:37:12 INFO - Using env: {'DISPLAY': ':0', 09:37:12 INFO - 'HOME': '/home/cltbld', 09:37:12 INFO - 'LANG': 'en_US.UTF-8', 09:37:12 INFO - 'LANGUAGE': 'en_US:en', 09:37:12 INFO - 'LOGNAME': 'cltbld', 09:37:12 INFO - 'MAIL': '/var/mail/cltbld', 09:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:12 INFO - 'MOZ_NO_REMOTE': '1', 09:37:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:12 INFO - 'NO_EM_RESTART': '1', 09:37:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:37:12 INFO - 'PWD': '/builds/slave/test-pgo', 09:37:12 INFO - 'SHELL': '/bin/bash', 09:37:12 INFO - 'SHLVL': '1', 09:37:12 INFO - 'TERM': 'linux', 09:37:12 INFO - 'TMOUT': '86400', 09:37:12 INFO - 'USER': 'cltbld', 09:37:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 09:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:12 INFO - '_': '/tools/buildbot/bin/python'} 09:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:37:12 INFO - Running setup.py (path:/tmp/pip-Ymw2F0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 09:37:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:37:12 INFO - Running setup.py (path:/tmp/pip-mknBQ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:37:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:37:12 INFO - Running setup.py (path:/tmp/pip-PV6YQo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:37:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:37:12 INFO - Running setup.py (path:/tmp/pip-KFUuB5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:37:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:37:12 INFO - Running setup.py (path:/tmp/pip-Gf_hbd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:37:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:37:12 INFO - Running setup.py (path:/tmp/pip-ug6dMF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 09:37:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:37:12 INFO - Running setup.py (path:/tmp/pip-5AqTsJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 09:37:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:37:12 INFO - Running setup.py (path:/tmp/pip-QndDwE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 09:37:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:37:12 INFO - Running setup.py (path:/tmp/pip-eXj87Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 09:37:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:37:13 INFO - Running setup.py (path:/tmp/pip-qOSyxI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:37:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:37:13 INFO - Running setup.py (path:/tmp/pip-_eYemI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 09:37:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:37:13 INFO - Running setup.py (path:/tmp/pip-1GmKNq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 09:37:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:37:13 INFO - Running setup.py (path:/tmp/pip-BCNilH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 09:37:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:37:13 INFO - Running setup.py (path:/tmp/pip-UiwXjm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 09:37:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:37:13 INFO - Running setup.py (path:/tmp/pip-Kq7h36-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 09:37:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:37:13 INFO - Running setup.py (path:/tmp/pip-FlEBF_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 09:37:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:37:13 INFO - Running setup.py (path:/tmp/pip-XzoEAi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 09:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:37:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:15 INFO - Downloading blessings-1.6.tar.gz 09:37:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:37:15 INFO - Installing collected packages: blessings 09:37:15 INFO - Running setup.py install for blessings 09:37:15 INFO - Successfully installed blessings 09:37:15 INFO - Cleaning up... 09:37:15 INFO - Return code: 0 09:37:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:37:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:37:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:37:15 INFO - Reading from file tmpfile_stdout 09:37:15 INFO - Current package versions: 09:37:15 INFO - argparse == 1.2.1 09:37:15 INFO - blessings == 1.6 09:37:15 INFO - blobuploader == 1.2.4 09:37:15 INFO - docopt == 0.6.1 09:37:15 INFO - manifestparser == 1.1 09:37:15 INFO - mozInstall == 1.12 09:37:15 INFO - mozcrash == 0.17 09:37:15 INFO - mozdebug == 0.1 09:37:15 INFO - mozdevice == 0.48 09:37:15 INFO - mozfile == 1.2 09:37:15 INFO - mozhttpd == 0.7 09:37:15 INFO - mozinfo == 0.9 09:37:15 INFO - mozleak == 0.1 09:37:15 INFO - mozlog == 3.1 09:37:15 INFO - moznetwork == 0.27 09:37:15 INFO - mozprocess == 0.22 09:37:15 INFO - mozprofile == 0.28 09:37:15 INFO - mozrunner == 6.11 09:37:15 INFO - mozscreenshot == 0.1 09:37:15 INFO - mozsystemmonitor == 0.0 09:37:15 INFO - moztest == 0.7 09:37:15 INFO - mozversion == 1.4 09:37:15 INFO - psutil == 3.1.1 09:37:15 INFO - requests == 1.2.3 09:37:15 INFO - wsgiref == 0.1.2 09:37:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:15 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 0x7ffa09872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b920>, '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 0x139c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139ccb0>, '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': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 09:37:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:37:15 INFO - Using env: {'DISPLAY': ':0', 09:37:15 INFO - 'HOME': '/home/cltbld', 09:37:15 INFO - 'LANG': 'en_US.UTF-8', 09:37:15 INFO - 'LANGUAGE': 'en_US:en', 09:37:15 INFO - 'LOGNAME': 'cltbld', 09:37:15 INFO - 'MAIL': '/var/mail/cltbld', 09:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:15 INFO - 'MOZ_NO_REMOTE': '1', 09:37:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:15 INFO - 'NO_EM_RESTART': '1', 09:37:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:37:15 INFO - 'PWD': '/builds/slave/test-pgo', 09:37:15 INFO - 'SHELL': '/bin/bash', 09:37:15 INFO - 'SHLVL': '1', 09:37:15 INFO - 'TERM': 'linux', 09:37:15 INFO - 'TMOUT': '86400', 09:37:15 INFO - 'USER': 'cltbld', 09:37:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 09:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:15 INFO - '_': '/tools/buildbot/bin/python'} 09:37:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 09:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 09:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 09:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 09:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 09:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 09:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:37:16 INFO - Cleaning up... 09:37:16 INFO - Return code: 0 09:37:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:37: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')]} 09:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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')]} 09:37:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:16 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 0x7ffa09872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b920>, '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 0x139c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139ccb0>, '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': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:37:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:37:16 INFO - Using env: {'DISPLAY': ':0', 09:37:16 INFO - 'HOME': '/home/cltbld', 09:37:16 INFO - 'LANG': 'en_US.UTF-8', 09:37:16 INFO - 'LANGUAGE': 'en_US:en', 09:37:16 INFO - 'LOGNAME': 'cltbld', 09:37:16 INFO - 'MAIL': '/var/mail/cltbld', 09:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:16 INFO - 'MOZ_NO_REMOTE': '1', 09:37:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:16 INFO - 'NO_EM_RESTART': '1', 09:37:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:37:16 INFO - 'PWD': '/builds/slave/test-pgo', 09:37:16 INFO - 'SHELL': '/bin/bash', 09:37:16 INFO - 'SHLVL': '1', 09:37:16 INFO - 'TERM': 'linux', 09:37:16 INFO - 'TMOUT': '86400', 09:37:16 INFO - 'USER': 'cltbld', 09:37:16 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 09:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:16 INFO - '_': '/tools/buildbot/bin/python'} 09:37:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:16 INFO - Downloading/unpacking jsonschema 09:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:37:18 INFO - Downloading/unpacking functools32 (from jsonschema) 09:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:18 INFO - Downloading functools32-3.2.3-2.tar.gz 09:37:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:37:18 INFO - warning: no files found matching '*.txt' 09:37:18 INFO - no previously-included directories found matching 'build' 09:37:18 INFO - no previously-included directories found matching 'dist' 09:37:18 INFO - no previously-included directories found matching '.git*' 09:37:18 INFO - Installing collected packages: jsonschema, functools32 09:37:18 INFO - Running setup.py install for functools32 09:37:18 INFO - warning: no files found matching '*.txt' 09:37:18 INFO - no previously-included directories found matching 'build' 09:37:18 INFO - no previously-included directories found matching 'dist' 09:37:18 INFO - no previously-included directories found matching '.git*' 09:37:18 INFO - Successfully installed jsonschema functools32 09:37:18 INFO - Cleaning up... 09:37:18 INFO - Return code: 0 09:37:18 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:18 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 0x7ffa09872f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b920>, '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 0x139c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139ccb0>, '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': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:37:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:37:18 INFO - Using env: {'DISPLAY': ':0', 09:37:18 INFO - 'HOME': '/home/cltbld', 09:37:18 INFO - 'LANG': 'en_US.UTF-8', 09:37:18 INFO - 'LANGUAGE': 'en_US:en', 09:37:18 INFO - 'LOGNAME': 'cltbld', 09:37:18 INFO - 'MAIL': '/var/mail/cltbld', 09:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:18 INFO - 'MOZ_NO_REMOTE': '1', 09:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:18 INFO - 'NO_EM_RESTART': '1', 09:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:37:18 INFO - 'PWD': '/builds/slave/test-pgo', 09:37:18 INFO - 'SHELL': '/bin/bash', 09:37:18 INFO - 'SHLVL': '1', 09:37:18 INFO - 'TERM': 'linux', 09:37:18 INFO - 'TMOUT': '86400', 09:37:18 INFO - 'USER': 'cltbld', 09:37:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 09:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:18 INFO - '_': '/tools/buildbot/bin/python'} 09:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:18 INFO - Downloading/unpacking flake8 09:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:37:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:37:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:37:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:37:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:37:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:37:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:37:21 INFO - no previously-included directories found matching 'docs/_build' 09:37:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:37:21 INFO - Running setup.py install for pep8 09:37:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:37:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:37:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:37:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:37:21 INFO - no previously-included directories found matching 'docs/_build' 09:37:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:37:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:37:21 INFO - Cleaning up... 09:37:21 INFO - Return code: 0 09:37:21 INFO - Running post-action listener: _resource_record_post_action 09:37:21 INFO - Running post-action listener: _start_resource_monitoring 09:37:21 INFO - Starting resource monitoring. 09:37:21 INFO - ##### 09:37:21 INFO - ##### Running install step. 09:37:21 INFO - ##### 09:37:21 INFO - Running pre-action listener: _resource_record_pre_action 09:37:21 INFO - Running main action method: install 09:37:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:37:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:37:21 INFO - Reading from file tmpfile_stdout 09:37:21 INFO - Detecting whether we're running mozinstall >=1.0... 09:37:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:37:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:37:21 INFO - Reading from file tmpfile_stdout 09:37:21 INFO - Output received: 09:37:21 INFO - Usage: mozinstall [options] installer 09:37:21 INFO - Options: 09:37:21 INFO - -h, --help show this help message and exit 09:37:21 INFO - -d DEST, --destination=DEST 09:37:21 INFO - Directory to install application into. [default: 09:37:21 INFO - "/builds/slave/test-pgo"] 09:37:21 INFO - --app=APP Application being installed. [default: firefox] 09:37:21 INFO - mkdir: /builds/slave/test-pgo/build/application 09:37:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:37:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:37:38 INFO - Reading from file tmpfile_stdout 09:37:38 INFO - Output received: 09:37:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:37:38 INFO - Running post-action listener: _resource_record_post_action 09:37:38 INFO - ##### 09:37:38 INFO - ##### Running run-tests step. 09:37:38 INFO - ##### 09:37:38 INFO - Running pre-action listener: _resource_record_pre_action 09:37:38 INFO - Running main action method: run_tests 09:37:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:37:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:37:38 INFO - Python 2.7.3 09:37:38 INFO - Return code: 0 09:37:38 INFO - grabbing minidump binary from tooltool 09:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:38 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 0x139b920>, '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 0x139c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139ccb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:37:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 09:37:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:37:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:37:38 INFO - Return code: 0 09:37:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:37:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:37:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:37:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:37:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:37:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:37:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:37:39 INFO - Return code: 0 09:37:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 09:37:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 09:37:39 INFO - Using env: {'DISPLAY': ':0', 09:37:39 INFO - 'HOME': '/home/cltbld', 09:37:39 INFO - 'LANG': 'en_US.UTF-8', 09:37:39 INFO - 'LANGUAGE': 'en_US:en', 09:37:39 INFO - 'LOGNAME': 'cltbld', 09:37:39 INFO - 'MAIL': '/var/mail/cltbld', 09:37:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:37:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:39 INFO - 'MOZ_NO_REMOTE': '1', 09:37:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:37:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:39 INFO - 'NO_EM_RESTART': '1', 09:37:39 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:37:39 INFO - 'PWD': '/builds/slave/test-pgo', 09:37:39 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:37:39 INFO - 'SHELL': '/bin/bash', 09:37:39 INFO - 'SHLVL': '1', 09:37:39 INFO - 'TERM': 'linux', 09:37:39 INFO - 'TMOUT': '86400', 09:37:39 INFO - 'USER': 'cltbld', 09:37:39 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457372203.874566-1782808492', 09:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:39 INFO - '_': '/tools/buildbot/bin/python'} 09:37:39 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:37:39 INFO - mozversion application_buildid: 20160307063917 09:37:39 INFO - mozversion application_changeset: be593a64d7c6a826260514fe758ef32a6ee580f7 09:37:39 INFO - mozversion application_display_name: Nightly 09:37:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:37:39 INFO - mozversion application_name: Firefox 09:37:39 INFO - mozversion application_remotingname: firefox 09:37:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:37:39 INFO - mozversion application_vendor: Mozilla 09:37:39 INFO - mozversion application_version: 48.0a1 09:37:39 INFO - mozversion platform_buildid: 20160307063917 09:37:39 INFO - mozversion platform_changeset: be593a64d7c6a826260514fe758ef32a6ee580f7 09:37:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:37:39 INFO - mozversion platform_version: 48.0a1 09:37:39 INFO - using testdate: 1457372259 09:37:39 INFO - actual date: 1457372259 09:37:39 INFO - starting webserver on 'localhost:50401' 09:37:39 INFO - SUITE-START | Running 2 tests 09:37:39 INFO - TEST-START | dromaeo_css 09:37:39 INFO - operating with platform_type : linux_ 09:37:39 INFO - Initialising browser for dromaeo_css test... 09:37:39 INFO - TEST-INFO | started process 14907 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkdOHfI/profile http://localhost:50401/getInfo.html) 09:37:43 INFO - PROCESS | 14907 | __metrics Screen width/height:1600/1200 09:37:43 INFO - PROCESS | 14907 | colorDepth:24 09:37:43 INFO - PROCESS | 14907 | Browser inner width/height: 1024/697 09:37:43 INFO - PROCESS | 14907 | __metrics 09:37:44 INFO - PROCESS | 14907 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:37:45 INFO - PROCESS | 14907 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 09:37:45 INFO - TEST-INFO | 14907: exit 0 09:37:45 INFO - Browser initialized. 09:37:45 INFO - Running cycle 1/1 for dromaeo_css test... 09:37:45 INFO - TEST-INFO | started process 15002 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkdOHfI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:57 INFO - PROCESS | 15002 | RSS: Main: 156602368 09:37:57 INFO - PROCESS | 15002 | 09:38:49 INFO - PROCESS | 15002 | 1457372329165 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:40:57 INFO - PROCESS | 15002 | Cycle 1(1): loaded http://localhost:50401/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50401/tests/dromaeo/cssquery-ext.html) 09:40:58 INFO - PROCESS | 15002 | RSS: Main: 258838528 09:40:58 INFO - PROCESS | 15002 | 09:44:00 INFO - PROCESS | 15002 | Cycle 1(1): loaded http://localhost:50401/tests/dromaeo/cssquery-ext.html (next: http://localhost:50401/tests/dromaeo/cssquery-jquery.html) 09:44:01 INFO - PROCESS | 15002 | RSS: Main: 238235648 09:44:01 INFO - PROCESS | 15002 | 09:47:03 INFO - PROCESS | 15002 | Cycle 1(1): loaded http://localhost:50401/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50401/tests/dromaeo/cssquery-mootools.html) 09:47:03 INFO - PROCESS | 15002 | RSS: Main: 237318144 09:47:03 INFO - PROCESS | 15002 | 09:50:05 INFO - PROCESS | 15002 | Cycle 1(1): loaded http://localhost:50401/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50401/tests/dromaeo/cssquery-prototype.html) 09:50:06 INFO - PROCESS | 15002 | RSS: Main: 218140672 09:50:06 INFO - PROCESS | 15002 | 09:53:08 INFO - PROCESS | 15002 | Cycle 1(1): loaded http://localhost:50401/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50401/tests/dromaeo/cssquery-yui.html) 09:53:09 INFO - PROCESS | 15002 | RSS: Main: 220753920 09:53:09 INFO - PROCESS | 15002 | 09:56:12 INFO - PROCESS | 15002 | Cycle 1(1): loaded http://localhost:50401/tests/dromaeo/cssquery-yui.html (next: http://localhost:50401/tests/dromaeo/cssquery-dojo.html) 09:56:12 INFO - PROCESS | 15002 | RSS: Main: 283979776 09:56:12 INFO - PROCESS | 15002 | 09:56:12 INFO - PROCESS | 15002 | __start_tp_report 09:56:12 INFO - PROCESS | 15002 | _x_x_mozilla_page_load 09:56:12 INFO - PROCESS | 15002 | _x_x_mozilla_page_load_details 09:56:12 INFO - PROCESS | 15002 | |i|pagename|runs| 09:56:12 INFO - PROCESS | 15002 | |0;dojo.html;3094.597702298701;3162.3991441626104;3210.630777460591;3211.181148807054;3214.758893083018;5064.594832413407;5209.687418754877;5242.554382877455;5292.708901010443;5343.759530821113;5116;5155.175171972485;5235.895282094356;5251.86870328242;5261.158214685651;4635.513271106536;4650.86047418578;4661.5804577588015;4704.600108990723;4957.182064959277;4859.538343857328;4899;4912.950870491303;4915.82794602189;4916.680415772963;4748.857534273943;4760.690555113906;4839.612830973514;4864.246041863516;4881.536254055859;4794.616430685537;4811.13399588074;4819.277108433763;4822.590079843218;4862.927056094161;4642.79107440166;4770.236762118079;4794.472608013116;4810.158222311082;4848.636352273594;5192.55863251624;5227.947720522784;5239.869003274911;5272.630915835893;5284.365876094855;5612.719364031782;5613.158026296048;5613.775448982035;5613.915791263134;5624.859378515529;5601.103823388238;5636.210930469738;5636.633618814764;5651;5676.233708449389;5268.657537260104;5282.894342113136;5287.312649355559;5300.549453296436;5345.518903298722;5765.596408251382;5765.971170144123;5766.625169363978;5768.105943578752;5768.423157684198;5387.111126664056;5420.457954204627;5513.558915286768;5545.556355491551;5548.306461692288;5669.291338582677;5670.603057785998;5674.829755107354;5675.233843431167;5680.318361796528;5606.775728970877;5620;5630.239917611152;5635.718214089279;5637.8590535236945;5469.371022332403;5538.418466061005;5585.581081418829;5615.354234263112;5654.208410822488;4216.135692183095;4221.451211342506;4224.134052519226;4229.682773791917;4263.680223983214;3801.562820275704;3824.2160357126722;3833.923321533554;3852.114013776847;3863.4784304118584;5166.741662916839;5288.735563221823;5337.706426146521;5375.811846585429;5384.326959130109;5530.087535556588;5537.446255374511;5538.6399884007415;5547.362053363915;5566.053770858964;5185.637005409661;5214.947850521522;5222.060029194706;5238.842834714965;5269;4679.695819771704;4680.180968330528;4712.5758681718125;4754.667173297836;4755.310479980452;5813.186153938452;5813.970930145407;5817.0983497557945;5821.09772985188;5853.473187413153;5569.55443564522;5575.1915972183;5584.832455026356;5651.237082993744;5654.264945557051;5821.09772985188;5854.560907931837;5874.530037597067;5891.410858914074;5931.288245410406;5451.046066938349;5466.972665136649;5513.255710479194;5514.145307477347;5520.889582208413;5431.212474191141;5528.806491772769;5587.329520457572;5602.85992850182;5604.495595396434;5515.255440515479;5516.696581688046;5518.613697041169;5523.392426833126;5530.806421775219;5493.203485494501;5535;5542.418046105101;5549.15018387831;5551.361593416808;5227.764750586309;5439.728013599383;5465.180222966586;5509.669419834662;5510.421405752339;5562.193481945014;5569;5587.106063029895;5590.273264475755;5633.2113504110275;5438.782448702166;5480.808171713971;5481.616286859881;5482.80810171642;5490.91763623538 09:56:12 INFO - PROCESS | 15002 | |1;ext.html;487.9926801097984;504.54338823364867;545.2366686638707;556.6743455078779;556.7995521612219;28248.57627135592;29054.854725726367;29056;29069.709302906966;36995;40024.599754002455;40307.395389069185;40556.797216013954;40739;40841;8571.828563428711;8800.8679869802;8830.779230519256;8836;8843.425177363482;7581.924180758177;8745.825083498326;8941.642334306653;10420.426876521788;10670.679879603624;10359.067683908446;10465.372077675325;10466.005729455728;10467;10467.68596942089;10365.792684146312;10402.271840971134;10416.583336666487;10479.84280235797;10495.527701253424;10185.439800810953;10206.387616743019;10251.53868075931;10315.896841031643;10326.741831454274;40786.79606601978;41133.38299925504;41242.79378603088;41368.79315603403;41368.79315603403;3163.208411326614;3404.9829750851336;3782.678472329855;3880.1463677990796;3928.273269445162;31881.521777173362;32071.83964080188;32111;32227.260682841985;33157.17107072318;3977.6817854571564;3995.3407687731487;4024.255512730125;4052.959470405288;4105.67154627632;263332;264558;264706.6764666184;265236;265348;60808.695956519936;61455.38544614586;61528.69235653883;61548;61761;44969.55030449654;45157;45166.09667806626;45228.77385613051;45438;14016.439342426189;14609.78085328721;14799;14805.777913331309;14839.10965342083;9760.072793084646;10474.581016759244;10606.204534659932;10651.094656954245;10654.200934929911;20809.479763006046;21358.145674172858;21415.46461338448;21494;21515.78484215169;7714.151443341228;7843.882341764878;7911.971443712396;7967.8406431871035;8002.43921944972;882.3823323673454;951.372094417681;971.6599190283345;1002.9247806414548;1049.4595283428887;26973.595396068682;27811.443771124465;29302;29314.560281595794;29975;1004.638330201127;1063.611781699674;1075.7794652096302;1112.238116889933;1146.6502716671496;15171.544853654408;15513.612159696098;15519.689606207812;15774.211289435712;15831.920840395724;320718;483721;495758;497883;502287;51801.22298165531;51848;51850;52216.216756748676;52344.73827630837;1317.2425855133338;1317.3676635214958;1336.211635135275;1417.7306311800726;1461.926903654813;27244;30746.231344215677;30811.229719256302;31053.689463105078;31401.37197256088;42267.1546569073;42772.35841462318;42897.571024290606;43597;44067.77966110149;200926;202124;202580;216849;220250;27593.17220483389;30979.0706278812;31580.684193157773;31725;32622.390208782766;37818.24363512769;39736.40395394129;41205;41523.7923810379;42012.57987420087;34942.825285873405;34971.30057398888;35199.12002199965;35222.29555408929;35293.82353088218;35083.64916350906;35123.19014478785;35136.82431587826;35660.28679426345;35662.64337356697;34583;34745.13137171591;35058.298834023684;35287.82356088203;35523.82238088793;31009.68990310068;31383;31607.20981975469;31696.841515792272;32047.198820029687;24229.394265143514;24745;24859.627105593794;25186.874065630287;25283.87358063198 09:56:12 INFO - PROCESS | 15002 | |2;jquery.html;336.8664444145451;357.4441743089496;358.53927702901774;365.52664299731845;366.156010396037;14288.357023933922;16710.91644541777;16747.162641867904;16938.40715574955;18412.26350945964;16237.83762162378;16247;16646.83353166468;17279;17313.653726925455;5311.601629877765;5437.293151890269;5447.101228297326;5455.509004189622;5477.698726570037;3764.341240282953;5176.715280659562;5268.789248430058;5374.113271310229;5457.536109430703;5444.40111587725;5445.673259604417;5465.945340546603;5468.562514998791;5476.288082549263;5414.620976531644;5432.511074003339;5480.150576660624;5826.650400975955;5910.113482977545;5319.175527793198;5328.733563321818;5331.147016477384;5347.278117454132;5356.303680521546;19757.80242197574;19795.406137815888;20427.387178384673;20625;20637.587248255102;2045.856790024699;2065.3993600729123;2073.626747185506;2079.3034333498294;2636.9208923732126;9116.954415227949;9201.585928633227;9582.233421326277;9616.326857119935;9735.756606084833;1775;1832.6334733053443;1866.4027511196423;1895.9146838392305;1915.79884112169;63642;64064;64231.35768642347;66836.99999999952;67471;10366.896331036744;10468.319559228627;10471.371717696962;10575.524101415302;10696.411697356565;14058.297085145701;14230;14271.500497482539;14276.072055316372;14294.213818239888;7170.677319520634;7328.67020984057;7365.7790266292095;7432.219616940143;7443.516171448839;6773.491988100912;6871.312868713088;6920.377166055079;6923.342282483156;6970.546914450544;4573.291139873325;4614.1694494991225;4617.238155704338;4635.953640463552;4719.480857105716;1700.1074435921241;1718.4243278501592;1816.4913824129264;1898.7246849206788;1903.1340739963284;898.8247291778172;912.1349721292155;920.2683866326287;928.4707716601607;946.3659348236698;15688;16122.193890305438;16955.49133525996;17009;17384.47846564605;903.0608167505852;916.4272329793879;927.1284992107533;971.582219645545;980.2794945714894;9279.211267042241;9363.578638961262;9653.17947974416;9718.465484398426;9801.215902727765;344226;351642;351954;401170;406801;71920.64039679768;79319.4854207538;80725;83089;83834.5808270967;1004.7437903334603;1013.0882206014646;1040.0795296162798;1040.4485622620023;1043.4991204221865;15045.172515511751;15269.835596854915;15353;15447.768283475982;15719.449819256271;34888;35186.296274073866;35198.472022919166;35247;35913.1021724459;46991;50134.24798627951;50771;51055.234171486714;51158.74420627873;7992.6403311849945;8089.757307280791;8251.504909705196;8271.793205169919;8384.071663517547;9306.06939306064;11536.884631153916;12406.25562466255;12466.376681166086;12533;7625.733099341496;10086.82671974126;10532.947335263274;10735.731606709895;10827.67516974492;10623.575056997634;10683.145348372267;10718.14254859625;10816.134709223086;10968.725781855517;10266.332688375232;10759.193060520336;10847.457627118454;10915;11227;7834.804129896798;8010.679572817256;8184.83630327402;8320.417570769989;8335.291500222549;10191.796164076528;10576.682699519026;10684.145268378355;10770.784584308427;10838.132949363875 09:56:12 INFO - PROCESS | 15002 | |3;mootools.html;1356.1659579358698;1479.2234077109515;1480.5706345159902;1631.6084139806442;1751.4220307298585;7708.152103268636;7911.1693272206385;7927.484713493619;7928.722494712686;7932.801679958004;7507.73722919698;7652.19651936547;7654.9617251913805;7658.7702368928885;7663.310302072812;2041.9591608167827;2257.2551058150852;2283.6460348645946;2308.9538209235807;2314.3635500237483;2347.8708671023087;2356.5640356534095;2357.9410514737096;2358.6108292131776;2359.1507057459385;2259.7062381890414;2328.266596022256;2328.8020518255967;2329.5806754784217;2330.906763729449;2258.7402448718444;2287.782660647236;2350.3536527455003;2351.353377821096;2354.7880690737743;2322.5238826040622;2327.464683122891;2342.6486027095903;2362.7991620712087;2377.5363804058215;8094.51432914027;8117.553534555597;8181.590920454013;8184.386171037137;8194.344452443791;4760.666753327268;4875.8781030474165;4876.658633895629;4924.8276310328965;4932.21084626458;3078;3180.5547223388744;3220.5974253218346;3227.467467867799;3261.0868956692166;1017.0795430135739;1899.6675581773134;1914.1386376130797;1917.6931690929384;1929.7973712760238;10893.509792059298;10990.120790336754;10990.691954689524;11030.724231894186;11053.778924421547;4118.402831589403;4286.807093680792;4341.522432532419;4391.363252328459;4393.472783266028;8763.518006509576;8788.78028049291;8791.472511649321;8808.03111657717;8817.911820881838;4371.934420983688;4884.145274576935;4921.212605983025;4931.988942266827;4933.802647894116;4311.267084595626;4378.8029538670835;4431.047324825178;4433.5788100131085;4444.599986001275;3556.715462762973;3632.727545434103;3675.9448608270895;3677.485152078711;3688.0411093115445;1061.5647584490323;1098.7088421568292;1101.7686285879895;1116.609186784635;1118.3904771899333;1013.2552573858209;1024.446798728693;1031.6698656430021;1165.6794381545144;1378.3521744779937;7486.663100160506;7784.571848548384;7786.727464538714;7814.413918956101;7836;1116.3525155409843;1143.3290241396912;1154.6420609611048;1161.3206274329611;1172.6013155526991;5890.970545147246;5931.139984702194;5942.049272116527;5944.346121926585;5958.106284057426;9264.44413335202;9391.389559678599;9424.528773561295;9731.659391921248;10014.148797352162;9508.334416590773;9747.074027967332;9777.853332200022;9789.167920726817;9795.265355098396;7372.741954031583;7466.514676546007;7473.065866766654;7537.472376933562;7552.773416797505;7552.546847189186;7575.886361704469;7600.923990760243;7606.619669016638;7634.885476717965;8640;8683;8794.560271986247;9005.459672419676;9018.053104423941;8902.643894244158;9044.276457883485;9059.728208153765;9072.410293330913;9276.536173191449;6385.074164246251;6761.86476270462;6932.272111428228;7119.1457025157315;7243.674034668558;7650.961745191238;7653.272939070779;7693.346065584488;7700.961495192488;7706.07527096752;6925.792226233221;7091.680874360563;7116.822079447848;7264.382527485223;7273.854522909618;7050.717971281091;7079.8938015930835;7110.43116550685;7212.927870721435;7215;7138.214796372498;7370.557766534025;7417.258274172756;7437.851242975218;7441.888371674538;6788.694508747019;6791.117154769849;6796.524243303119;6805.3875151236625;6805.89791153143;6803.115594972622;6823.522353435212;6919.169699635874;6985.755498557526;7016.543924644881 09:56:12 INFO - PROCESS | 15002 | |4;prototype.html;325.29086591231123;331.6998116704382;337.3775384415755;339.8063104030702;347.44929287079975;5863.970680146599;5912.763489460416;5923.111533270012;5924.763009479621;5937.109433584965;5825.097109947954;5825.184474173609;5842.678652674102;5853.443922827335;5872.647641141534;4317.460317460317;4463.062756821071;4513.3230015497775;4539.750313732743;4542.091581683669;4536.478304994918;4541.137183935059;4550.931736023962;4564.995700945787;4580.725156490605;4507.233770259064;4511.932321015187;4520.412346394981;4520.932186017212;4530.478994915594;4304.913901721964;4408.955910440903;4491.371208030879;4496.820127194908;4504.09918016398;3949.8025098745234;3954.2882281189372;3955.4462375267485;3960.841566337343;3983.6813054955533;5610.18652295419;5617.101263797773;5625.1843482695185;5631.380548139701;5635.239242702224;5242.89899121185;5246.108161612535;5246.317978662788;5253.579713622901;5270.5520030797425;6200.069989501566;6201.751929922798;6207.068939659042;6213.937860621381;6216.160818289518;4295.591918767712;4383.539728328511;4406.383106365111;4410.1179764047;4416.757078360689;6419.069234960951;6475.514336424787;6476.870462590722;6484.837879053061;6520.967395163041;4576.8626941191815;4578.885527861764;4581.106684196549;4583.770811459413;4587.9082418351445;4632.5135860734135;4636.374089497942;4648.2330415481065;4650.069986002745;4652.325412815123;5281.313429254173;5293.338332708411;5297.152455607084;5300.946990530046;5303.310569626001;6098.26820781509;6250.656213908279;6258.718357673915;6267.65527895961;6268.780592679234;1583.1292788966023;1599.7520384340446;1607.0598699760537;1610.5812488752774;1620.2546828458806;1021.0759262867117;1099.8240281554913;1101.498818037791;1117.0337657925836;1121.6018313498591;5884.882302354014;5891.587588868823;5940.257467816523;5943.286805583271;5953.285605727254;6325.9051114233325;6351.8566658002;6356.332585078592;6356.332585078592;6365;5894.528437724972;5915.024021036481;5918.461200088008;5919;5927.873703996227;3400;3429.6570342966;3434.9484757728655;3436;3438.3639026780124;6603.70283337251;6676.232233293136;6707.396334329934;6814.557053791487;6824.863502729918;6540.37866402691;6602.735890564323;6616.96691516549;6623.701933413008;6625.204975402982;6795.830104247335;6796.592204467748;6802.14973128359;6803.25164231944;6804.557703749141;6427.357264273535;6439.388258115471;6443.806685799434;6449.064885591657;6450.612963222222;6237.157983672146;6418.261899881387;6421.93578064232;6429.132067170872;6429.646369449725;6781.93218067813;6803.387695107464;6804.965975170093;6807.897881531682;6817.965910170417;4330.198913201068;4343.19650864591;4346.978265108654;4352.499462561846;4356.172327257811;6460.483161346987;6466.838329041811;6468.223813142453;6469.8706025880165;6475.061116138228;6274.341194174728;6274.498040156685;6279.623222606659;6281.371862813682;6286.779962701284;6059.515238780975;6265.122882796503;6271.153394291712;6277.71750271248;6299.590526615755;6130.50955923534;6166.260048794174;6169.2288463942;6237.1891654084675;6241.063840423973;6277.497800176066;6294.339094395205;6295.150154729236;6299.055141728777;6301.936980630135;5927.644341339534;6019.217501724747;6155.6614386209185;6162.784302549389;6166.044263139221 09:56:12 INFO - PROCESS | 15002 | |5;yui.html;643.9484841212703;651.1209866679983;665.6971078159438;734.1630541183049;776.5496012312857;13722.313884305782;13988.37052332645;14012.509562165313;14013.50952716655;14053.859461405384;14158;14162.78755818661;14165.079269847452;14286.571402857931;14321.498747543837;838.513662075996;847.902491213509;855.2644725536034;855.6662901468433;856.4133568505594;552.6628756458557;838.6645341863242;850.6384786465758;855.6406309350057;860.0410542245382;864.360373323739;872.9388942774009;874.8337815815007;878.9824203515958;886.0519244408486;708.3023222126202;871.9302455803584;873.9519326437076;874.7332063720563;874.7419511244199;641;647.5531883000715;649.5875119299279;649.6069877723957;649.7628365646552;13762.931185344109;13807.309634518335;13848;13850.445982160702;13865.75208231254;12552.74894502114;12600.936995315056;12753.872461275361;12935.87064129356;13190.812826845535;10437.269391142623;10611;10878.945605272002;11019.393933333664;11495.482703278372;3514.7363947704025;3541;3600.171960449085;3600.567931848195;3670.7063434925144;46480.76759616214;47110.76444617789;47208.29187562189;47556.7622161887;48865.51134488645;9066.274698024143;9164.6792362267;9220.585073671567;9294.256459483226;9572.377795443273;17512.91243543774;17513.56216094608;17513.912430437766;17515.386961456286;17559.648807023787;7546.169921308651;7859.6463159157975;8078.434509584273;8144.918550814535;8182;3607.5129857469433;3629.020164555608;4126.381042843537;4426.933595996063;4615.076984603093;3099.6745341739243;3116.8441577921467;3119.454095533318;3121.4537455945574;3124.140861263171;561.0518224201087;561.2451253064621;566.9348024977098;583.6177303865975;587.6973358720262;475.538727434395;487.0648355158105;554.4621716934568;587.6209844650263;617.3301967365369;8020.35837133028;8046.919530804734;8063.1130575636635;8182.590870456454;8299.875501867476;590.9734061967222;602.7799853053604;612.8651696626735;625.2809269340295;639.191422850095;3700.6669399753614;3737.252549490113;3752.699784017272;3773.4905787718853;3774.50931378919;49877.75061124744;50107.24839127416;50393;54708;55694.72152639211;44734.55265447369;47209;47443.28835067477;48116;48404;44798.86407951477;45193.32210016852;45663.771681141385;45728.314075288894;46052;8194.426390152632;8241.25828675422;8399.622017009127;8405.95797021011;8472.661093556435;33591.32817343689;33609.495857562644;34330.65669343275;34795;35092.298154037286;39404.605953940096;39561.208775824896;40682.18635627212;42215.366769499095;42816.35775463433;10527;10791.514381852992;10926.945365273123;11200.719982000515;11347.20569560123;10976.396298203355;11191.16066295015;12027.4587643558;12544.74910501803;12597.811032834697;10296.330738501973;10956.671299860698;10999.120070394509;11128.833067504156;11277.661670149908;11506.942465287955;12069.637910862688;12076.275423474619;12151.574694885636;12163.81754273669;10264.794704105727;10421.114205292635;10430.165586753194;10473.68578942633;10810.081143102925;9447.527623618655;9621.807563848544;9694.22446204288;9995.550200240861;10003.849942251018;8345.749627511184;8883.689070882489;9009.954950225469;9350.812983740423;9463.668771592962 09:56:12 INFO - PROCESS | 15002 | __end_tp_report 09:56:12 INFO - PROCESS | 15002 | __start_cc_report 09:56:12 INFO - PROCESS | 15002 | _x_x_mozilla_cycle_collect,843 09:56:12 INFO - PROCESS | 15002 | __end_cc_report 09:56:12 INFO - PROCESS | 15002 | __startTimestamp1457373372371__endTimestamp 09:56:12 INFO - PROCESS | 15002 | 09:56:12 INFO - PROCESS | 15002 | ------- Summary: start ------- 09:56:12 INFO - PROCESS | 15002 | Number of tests: 6 09:56:12 INFO - PROCESS | 15002 | 09:56:12 INFO - PROCESS | 15002 | [#0] dojo.html Cycles:165 Average:5222.17 Median:5465.18 stddev:582.83 (10.7%) stddev-sans-first:560.21 09:56:12 INFO - PROCESS | 15002 | Values: 3094.6 3162.4 3210.6 3211.2 3214.8 5064.6 5209.7 5242.6 5292.7 5343.8 5116.0 5155.2 5235.9 5251.9 5261.2 4635.5 4650.9 4661.6 4704.6 4957.2 4859.5 4899.0 4913.0 4915.8 4916.7 4748.9 4760.7 4839.6 4864.2 4881.5 4794.6 4811.1 4819.3 4822.6 4862.9 4642.8 4770.2 4794.5 4810.2 4848.6 5192.6 5227.9 5239.9 5272.6 5284.4 5612.7 5613.2 5613.8 5613.9 5624.9 5601.1 5636.2 5636.6 5651.0 5676.2 5268.7 5282.9 5287.3 5300.5 5345.5 5765.6 5766.0 5766.6 5768.1 5768.4 5387.1 5420.5 5513.6 5545.6 5548.3 5669.3 5670.6 5674.8 5675.2 5680.3 5606.8 5620.0 5630.2 5635.7 5637.9 5469.4 5538.4 5585.6 5615.4 5654.2 4216.1 4221.5 4224.1 4229.7 4263.7 3801.6 3824.2 3833.9 3852.1 3863.5 5166.7 5288.7 5337.7 5375.8 5384.3 5530.1 5537.4 5538.6 5547.4 5566.1 5185.6 5214.9 5222.1 5238.8 5269.0 4679.7 4680.2 4712.6 4754.7 4755.3 5813.2 5814.0 5817.1 5821.1 5853.5 5569.6 5575.2 5584.8 5651.2 5654.3 5821.1 5854.6 5874.5 5891.4 5931.3 5451.0 5467.0 5513.3 5514.1 5520.9 5431.2 5528.8 5587.3 5602.9 5604.5 5515.3 5516.7 5518.6 5523.4 5530.8 5493.2 5535.0 5542.4 5549.2 5551.4 5227.8 5439.7 5465.2 5509.7 5510.4 5562.2 5569.0 5587.1 5590.3 5633.2 5438.8 5480.8 5481.6 5482.8 5490.9 09:56:12 INFO - PROCESS | 15002 | 09:56:12 INFO - PROCESS | 15002 | [#1] ext.html Cycles:180 Average:47284.82 Median:32169.13 stddev:87903.14 (273.3%) stddev-sans-first:88079.51 09:56:12 INFO - PROCESS | 15002 | Values: 488.0 504.5 545.2 556.7 556.8 28248.6 29054.9 29056.0 29069.7 36995.0 40024.6 40307.4 40556.8 40739.0 40841.0 8571.8 8800.9 8830.8 8836.0 8843.4 7581.9 8745.8 8941.6 10420.4 10670.7 10359.1 10465.4 10466.0 10467.0 10467.7 10365.8 10402.3 10416.6 10479.8 10495.5 10185.4 10206.4 10251.5 10315.9 10326.7 40786.8 41133.4 41242.8 41368.8 41368.8 3163.2 3405.0 3782.7 3880.1 3928.3 31881.5 32071.8 32111.0 32227.3 33157.2 3977.7 3995.3 4024.3 4053.0 4105.7 263332.0 264558.0 264706.7 265236.0 265348.0 60808.7 61455.4 61528.7 61548.0 61761.0 44969.6 45157.0 45166.1 45228.8 45438.0 14016.4 14609.8 14799.0 14805.8 14839.1 9760.1 10474.6 10606.2 10651.1 10654.2 20809.5 21358.1 21415.5 21494.0 21515.8 7714.2 7843.9 7912.0 7967.8 8002.4 882.4 951.4 971.7 1002.9 1049.5 26973.6 27811.4 29302.0 29314.6 29975.0 1004.6 1063.6 1075.8 1112.2 1146.7 15171.5 15513.6 15519.7 15774.2 15831.9 320718.0 483721.0 495758.0 497883.0 502287.0 51801.2 51848.0 51850.0 52216.2 52344.7 1317.2 1317.4 1336.2 1417.7 1461.9 27244.0 30746.2 30811.2 31053.7 31401.4 42267.2 42772.4 42897.6 43597.0 44067.8 200926.0 202124.0 202580.0 216849.0 220250.0 27593.2 30979.1 31580.7 31725.0 32622.4 37818.2 39736.4 41205.0 41523.8 42012.6 34942.8 34971.3 35199.1 35222.3 35293.8 35083.6 35123.2 35136.8 35660.3 35662.6 34583.0 34745.1 35058.3 35287.8 35523.8 31009.7 31383.0 31607.2 31696.8 32047.2 24229.4 24745.0 24859.6 25186.9 25283.9 09:56:12 INFO - PROCESS | 15002 | 09:56:12 INFO - PROCESS | 15002 | [#2] jquery.html Cycles:180 Average:23771.99 Median:2065.25 stddev:61524.18 (2979.0%) stddev-sans-first:61671.61 09:56:12 INFO - PROCESS | 15002 | Values: 336.9 357.4 358.5 365.5 366.2 14288.4 16710.9 16747.2 16938.4 18412.3 16237.8 16247.0 16646.8 17279.0 17313.7 5311.6 5437.3 5447.1 5455.5 5477.7 3764.3 5176.7 5268.8 5374.1 5457.5 5444.4 5445.7 5465.9 5468.6 5476.3 5414.6 5432.5 5480.2 5826.7 5910.1 5319.2 5328.7 5331.1 5347.3 5356.3 19757.8 19795.4 20427.4 20625.0 20637.6 2045.9 2065.4 2073.6 2079.3 2636.9 9117.0 9201.6 9582.2 9616.3 9735.8 1775.0 1832.6 1866.4 1895.9 1915.8 63642.0 64064.0 64231.4 66837.0 67471.0 10366.9 10468.3 10471.4 10575.5 10696.4 14058.3 14230.0 14271.5 14276.1 14294.2 7170.7 7328.7 7365.8 7432.2 7443.5 6773.5 6871.3 6920.4 6923.3 6970.5 4573.3 4614.2 4617.2 4636.0 4719.5 1700.1 1718.4 1816.5 1898.7 1903.1 898.8 912.1 920.3 928.5 946.4 15688.0 16122.2 16955.5 17009.0 17384.5 903.1 916.4 927.1 971.6 980.3 9279.2 9363.6 9653.2 9718.5 9801.2 344226.0 351642.0 351954.0 401170.0 406801.0 71920.6 79319.5 80725.0 83089.0 83834.6 1004.7 1013.1 1040.1 1040.4 1043.5 15045.2 15269.8 15353.0 15447.8 15719.4 34888.0 35186.3 35198.5 35247.0 35913.1 46991.0 50134.2 50771.0 51055.2 51158.7 7992.6 8089.8 8251.5 8271.8 8384.1 9306.1 11536.9 12406.3 12466.4 12533.0 7625.7 10086.8 10532.9 10735.7 10827.7 10623.6 10683.1 10718.1 10816.1 10968.7 10266.3 10759.2 10847.5 10915.0 11227.0 7834.8 8010.7 8184.8 8320.4 8335.3 10191.8 10576.7 10684.1 10770.8 10838.1 09:56:12 INFO - PROCESS | 15002 | 09:56:12 INFO - PROCESS | 15002 | [#3] mootools.html Cycles:180 Average:5631.91 Median:6171.59 stddev:2891.49 (46.9%) stddev-sans-first:2881.74 09:56:12 INFO - PROCESS | 15002 | Values: 1356.2 1479.2 1480.6 1631.6 1751.4 7708.2 7911.2 7927.5 7928.7 7932.8 7507.7 7652.2 7655.0 7658.8 7663.3 2042.0 2257.3 2283.6 2309.0 2314.4 2347.9 2356.6 2357.9 2358.6 2359.2 2259.7 2328.3 2328.8 2329.6 2330.9 2258.7 2287.8 2350.4 2351.4 2354.8 2322.5 2327.5 2342.6 2362.8 2377.5 8094.5 8117.6 8181.6 8184.4 8194.3 4760.7 4875.9 4876.7 4924.8 4932.2 3078.0 3180.6 3220.6 3227.5 3261.1 1017.1 1899.7 1914.1 1917.7 1929.8 10893.5 10990.1 10990.7 11030.7 11053.8 4118.4 4286.8 4341.5 4391.4 4393.5 8763.5 8788.8 8791.5 8808.0 8817.9 4371.9 4884.1 4921.2 4932.0 4933.8 4311.3 4378.8 4431.0 4433.6 4444.6 3556.7 3632.7 3675.9 3677.5 3688.0 1061.6 1098.7 1101.8 1116.6 1118.4 1013.3 1024.4 1031.7 1165.7 1378.4 7486.7 7784.6 7786.7 7814.4 7836.0 1116.4 1143.3 1154.6 1161.3 1172.6 5891.0 5931.1 5942.0 5944.3 5958.1 9264.4 9391.4 9424.5 9731.7 10014.1 9508.3 9747.1 9777.9 9789.2 9795.3 7372.7 7466.5 7473.1 7537.5 7552.8 7552.5 7575.9 7600.9 7606.6 7634.9 8640.0 8683.0 8794.6 9005.5 9018.1 8902.6 9044.3 9059.7 9072.4 9276.5 6385.1 6761.9 6932.3 7119.1 7243.7 7651.0 7653.3 7693.3 7701.0 7706.1 6925.8 7091.7 7116.8 7264.4 7273.9 7050.7 7079.9 7110.4 7212.9 7215.0 7138.2 7370.6 7417.3 7437.9 7441.9 6788.7 6791.1 6796.5 6805.4 6805.9 6803.1 6823.5 6919.2 6985.8 7016.5 09:56:12 INFO - PROCESS | 15002 | 09:56:12 INFO - PROCESS | 15002 | [#4] prototype.html Cycles:180 Average:5241.76 Median:5916.74 stddev:1572.76 (26.6%) stddev-sans-first:1533.27 09:56:12 INFO - PROCESS | 15002 | Values: 325.3 331.7 337.4 339.8 347.4 5864.0 5912.8 5923.1 5924.8 5937.1 5825.1 5825.2 5842.7 5853.4 5872.6 4317.5 4463.1 4513.3 4539.8 4542.1 4536.5 4541.1 4550.9 4565.0 4580.7 4507.2 4511.9 4520.4 4520.9 4530.5 4304.9 4409.0 4491.4 4496.8 4504.1 3949.8 3954.3 3955.4 3960.8 3983.7 5610.2 5617.1 5625.2 5631.4 5635.2 5242.9 5246.1 5246.3 5253.6 5270.6 6200.1 6201.8 6207.1 6213.9 6216.2 4295.6 4383.5 4406.4 4410.1 4416.8 6419.1 6475.5 6476.9 6484.8 6521.0 4576.9 4578.9 4581.1 4583.8 4587.9 4632.5 4636.4 4648.2 4650.1 4652.3 5281.3 5293.3 5297.2 5300.9 5303.3 6098.3 6250.7 6258.7 6267.7 6268.8 1583.1 1599.8 1607.1 1610.6 1620.3 1021.1 1099.8 1101.5 1117.0 1121.6 5884.9 5891.6 5940.3 5943.3 5953.3 6325.9 6351.9 6356.3 6356.3 6365.0 5894.5 5915.0 5918.5 5919.0 5927.9 3400.0 3429.7 3434.9 3436.0 3438.4 6603.7 6676.2 6707.4 6814.6 6824.9 6540.4 6602.7 6617.0 6623.7 6625.2 6795.8 6796.6 6802.1 6803.3 6804.6 6427.4 6439.4 6443.8 6449.1 6450.6 6237.2 6418.3 6421.9 6429.1 6429.6 6781.9 6803.4 6805.0 6807.9 6818.0 4330.2 4343.2 4347.0 4352.5 4356.2 6460.5 6466.8 6468.2 6469.9 6475.1 6274.3 6274.5 6279.6 6281.4 6286.8 6059.5 6265.1 6271.2 6277.7 6299.6 6130.5 6166.3 6169.2 6237.2 6241.1 6277.5 6294.3 6295.2 6299.1 6301.9 5927.6 6019.2 6155.7 6162.8 6166.0 09:56:12 INFO - PROCESS | 15002 | 09:56:12 INFO - PROCESS | 15002 | [#5] yui.html Cycles:180 Average:13343.29 Median:25333.54 stddev:14996.76 (59.2%) stddev-sans-first:15008.51 09:56:12 INFO - PROCESS | 15002 | Values: 643.9 651.1 665.7 734.2 776.5 13722.3 13988.4 14012.5 14013.5 14053.9 14158.0 14162.8 14165.1 14286.6 14321.5 838.5 847.9 855.3 855.7 856.4 552.7 838.7 850.6 855.6 860.0 864.4 872.9 874.8 879.0 886.1 708.3 871.9 874.0 874.7 874.7 641.0 647.6 649.6 649.6 649.8 13762.9 13807.3 13848.0 13850.4 13865.8 12552.7 12600.9 12753.9 12935.9 13190.8 10437.3 10611.0 10878.9 11019.4 11495.5 3514.7 3541.0 3600.2 3600.6 3670.7 46480.8 47110.8 47208.3 47556.8 48865.5 9066.3 9164.7 9220.6 9294.3 9572.4 17512.9 17513.6 17513.9 17515.4 17559.6 7546.2 7859.6 8078.4 8144.9 8182.0 3607.5 3629.0 4126.4 4426.9 4615.1 3099.7 3116.8 3119.5 3121.5 3124.1 561.1 561.2 566.9 583.6 587.7 475.5 487.1 554.5 587.6 617.3 8020.4 8046.9 8063.1 8182.6 8299.9 591.0 602.8 612.9 625.3 639.2 3700.7 3737.3 3752.7 3773.5 3774.5 49877.8 50107.2 50393.0 54708.0 55694.7 44734.6 47209.0 47443.3 48116.0 48404.0 44798.9 45193.3 45663.8 45728.3 46052.0 8194.4 8241.3 8399.6 8406.0 8472.7 33591.3 33609.5 34330.7 34795.0 35092.3 39404.6 39561.2 40682.2 42215.4 42816.4 10527.0 10791.5 10926.9 11200.7 11347.2 10976.4 11191.2 12027.5 12544.7 12597.8 10296.3 10956.7 10999.1 11128.8 11277.7 11506.9 12069.6 12076.3 12151.6 12163.8 10264.8 10421.1 10430.2 10473.7 10810.1 9447.5 9621.8 9694.2 9995.6 10003.8 8345.7 8883.7 9010.0 9350.8 9463.7 09:56:12 INFO - PROCESS | 15002 | -------- Summary: end -------- 09:56:12 INFO - PROCESS | 15002 | 09:56:13 INFO - TEST-INFO | 15002: exit 0 09:56:13 INFO - TEST-OK | dromaeo_css | took 1113680ms 09:56:13 INFO - TEST-START | kraken 09:56:13 INFO - operating with platform_type : linux_ 09:56:13 INFO - Initialising browser for kraken test... 09:56:13 INFO - TEST-INFO | started process 15189 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyXmlWU/profile http://localhost:50401/getInfo.html) 09:56:17 INFO - PROCESS | 15189 | __metrics Screen width/height:1600/1200 09:56:17 INFO - PROCESS | 15189 | colorDepth:24 09:56:17 INFO - PROCESS | 15189 | Browser inner width/height: 1024/697 09:56:17 INFO - PROCESS | 15189 | __metrics 09:56:18 INFO - PROCESS | 15189 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:56:19 INFO - TEST-INFO | 15189: exit 0 09:56:19 INFO - Browser initialized. 09:56:19 INFO - Running cycle 1/1 for kraken test... 09:56:19 INFO - TEST-INFO | started process 15273 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyXmlWU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:30 INFO - PROCESS | 15273 | RSS: Main: 156377088 09:56:30 INFO - PROCESS | 15273 | 09:56:33 INFO - PROCESS | 15273 | Cycle 1(1): loaded http://localhost:50401/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50401/tests/kraken/driver.html?testName=audio-beat-detection) 09:56:33 INFO - PROCESS | 15273 | RSS: Main: 201478144 09:56:33 INFO - PROCESS | 15273 | 09:56:36 INFO - PROCESS | 15273 | Cycle 1(1): loaded http://localhost:50401/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50401/tests/kraken/driver.html?testName=audio-dft) 09:56:37 INFO - PROCESS | 15273 | RSS: Main: 187973632 09:56:37 INFO - PROCESS | 15273 | 09:56:40 INFO - PROCESS | 15273 | Cycle 1(1): loaded http://localhost:50401/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50401/tests/kraken/driver.html?testName=audio-fft) 09:56:40 INFO - PROCESS | 15273 | RSS: Main: 173289472 09:56:40 INFO - PROCESS | 15273 | 09:56:42 INFO - PROCESS | 15273 | Cycle 1(1): loaded http://localhost:50401/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50401/tests/kraken/driver.html?testName=audio-oscillator) 09:56:43 INFO - PROCESS | 15273 | RSS: Main: 173346816 09:56:43 INFO - PROCESS | 15273 | 09:56:45 INFO - PROCESS | 15273 | Cycle 1(1): loaded http://localhost:50401/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50401/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:56:46 INFO - PROCESS | 15273 | RSS: Main: 176312320 09:56:46 INFO - PROCESS | 15273 | 09:56:49 INFO - PROCESS | 15273 | Cycle 1(1): loaded http://localhost:50401/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50401/tests/kraken/driver.html?testName=imaging-darkroom) 09:56:49 INFO - PROCESS | 15273 | RSS: Main: 175910912 09:56:49 INFO - PROCESS | 15273 | 09:56:53 INFO - PROCESS | 15273 | Cycle 1(1): loaded http://localhost:50401/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50401/tests/kraken/driver.html?testName=imaging-desaturate) 09:56:53 INFO - PROCESS | 15273 | RSS: Main: 177422336 09:56:53 INFO - PROCESS | 15273 | 09:56:56 INFO - PROCESS | 15273 | Cycle 1(1): loaded http://localhost:50401/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50401/tests/kraken/driver.html?testName=json-parse-financial) 09:56:57 INFO - PROCESS | 15273 | RSS: Main: 178130944 09:56:57 INFO - PROCESS | 15273 | 09:56:58 INFO - PROCESS | 15273 | Cycle 1(1): loaded http://localhost:50401/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50401/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:56:59 INFO - PROCESS | 15273 | RSS: Main: 186822656 09:56:59 INFO - PROCESS | 15273 | 09:57:01 INFO - PROCESS | 15273 | Cycle 1(1): loaded http://localhost:50401/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50401/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:57:01 INFO - PROCESS | 15273 | RSS: Main: 184233984 09:57:01 INFO - PROCESS | 15273 | 09:57:03 INFO - PROCESS | 15273 | Cycle 1(1): loaded http://localhost:50401/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50401/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:57:04 INFO - PROCESS | 15273 | RSS: Main: 198238208 09:57:04 INFO - PROCESS | 15273 | 09:57:06 INFO - PROCESS | 15273 | Cycle 1(1): loaded http://localhost:50401/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:57:07 INFO - PROCESS | 15273 | RSS: Main: 202805248 09:57:07 INFO - PROCESS | 15273 | 09:57:09 INFO - PROCESS | 15273 | Cycle 1(1): loaded http://localhost:50401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:57:10 INFO - PROCESS | 15273 | RSS: Main: 199708672 09:57:10 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | Cycle 1(1): loaded http://localhost:50401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50401/tests/kraken/driver.html?testName=ai-astar) 09:57:12 INFO - PROCESS | 15273 | RSS: Main: 260231168 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | __start_tp_report 09:57:12 INFO - PROCESS | 15273 | _x_x_mozilla_page_load 09:57:12 INFO - PROCESS | 15273 | _x_x_mozilla_page_load_details 09:57:12 INFO - PROCESS | 15273 | |i|pagename|runs| 09:57:12 INFO - PROCESS | 15273 | |0;ai-astar;108;109;104;109;111;112;103;110;109;110 09:57:12 INFO - PROCESS | 15273 | |1;audio-beat-detection;159;127;153;175;129;154;156;134;180;128 09:57:12 INFO - PROCESS | 15273 | |2;audio-dft;163;163;161;161;162;159;159;166;162;160 09:57:12 INFO - PROCESS | 15273 | |3;audio-fft;72;75;98;96;74;75;76;115;94;72 09:57:12 INFO - PROCESS | 15273 | |4;audio-oscillator;94;94;149;93;93;93;145;94;93;145 09:57:12 INFO - PROCESS | 15273 | |5;imaging-gaussian-blur;120;116;117;117;117;116;117;116;116;116 09:57:12 INFO - PROCESS | 15273 | |6;imaging-darkroom;145;146;145;145;144;144;145;145;144;145 09:57:12 INFO - PROCESS | 15273 | |7;imaging-desaturate;96;95;95;95;96;96;95;95;95;96 09:57:12 INFO - PROCESS | 15273 | |8;json-parse-financial;59;58;57;56;58;56;56;65;57;54 09:57:12 INFO - PROCESS | 15273 | |9;json-stringify-tinderbox;67;69;68;68;68;69;70;69;68;68 09:57:12 INFO - PROCESS | 15273 | |10;stanford-crypto-aes;80;81;81;81;81;81;80;82;82;84 09:57:12 INFO - PROCESS | 15273 | |11;stanford-crypto-ccm;131;114;115;117;114;120;115;115;115;115 09:57:12 INFO - PROCESS | 15273 | |12;stanford-crypto-pbkdf2;150;138;149;147;153;136;147;148;147;147 09:57:12 INFO - PROCESS | 15273 | |13;stanford-crypto-sha256-iterative;70;67;69;70;68;66;68;69;68;67 09:57:12 INFO - PROCESS | 15273 | __end_tp_report 09:57:12 INFO - PROCESS | 15273 | __start_cc_report 09:57:12 INFO - PROCESS | 15273 | _x_x_mozilla_cycle_collect,1113 09:57:12 INFO - PROCESS | 15273 | __end_cc_report 09:57:12 INFO - PROCESS | 15273 | __startTimestamp1457373432381__endTimestamp 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | ------- Summary: start ------- 09:57:12 INFO - PROCESS | 15273 | Number of tests: 14 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.50 stddev:2.88 (2.6%) stddev-sans-first:3.05 09:57:12 INFO - PROCESS | 15273 | Values: 108.0 109.0 104.0 109.0 111.0 112.0 103.0 110.0 109.0 110.0 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:155.00 stddev:19.36 (12.5%) stddev-sans-first:20.23 09:57:12 INFO - PROCESS | 15273 | Values: 159.0 127.0 153.0 175.0 129.0 154.0 156.0 134.0 180.0 128.0 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:2.12 (1.3%) stddev-sans-first:2.19 09:57:12 INFO - PROCESS | 15273 | Values: 163.0 163.0 161.0 161.0 162.0 159.0 159.0 166.0 162.0 160.0 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | [#3] audio-fft Cycles:10 Average:84.70 Median:75.50 stddev:14.94 (19.8%) stddev-sans-first:15.13 09:57:12 INFO - PROCESS | 15273 | Values: 72.0 75.0 98.0 96.0 74.0 75.0 76.0 115.0 94.0 72.0 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:93.00 stddev:25.58 (27.5%) stddev-sans-first:26.53 09:57:12 INFO - PROCESS | 15273 | Values: 94.0 94.0 149.0 93.0 93.0 93.0 145.0 94.0 93.0 145.0 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:1.23 (1.1%) stddev-sans-first:0.53 09:57:12 INFO - PROCESS | 15273 | Values: 120.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 116.0 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | [#6] imaging-darkroom Cycles:10 Average:144.80 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 09:57:12 INFO - PROCESS | 15273 | Values: 145.0 146.0 145.0 145.0 144.0 144.0 145.0 145.0 144.0 145.0 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:57:12 INFO - PROCESS | 15273 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.50 stddev:2.95 (5.1%) stddev-sans-first:3.09 09:57:12 INFO - PROCESS | 15273 | Values: 59.0 58.0 57.0 56.0 58.0 56.0 56.0 65.0 57.0 54.0 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.84 (1.2%) stddev-sans-first:0.73 09:57:12 INFO - PROCESS | 15273 | Values: 67.0 69.0 68.0 68.0 68.0 69.0 70.0 69.0 68.0 68.0 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:1.16 (1.4%) stddev-sans-first:1.13 09:57:12 INFO - PROCESS | 15273 | Values: 80.0 81.0 81.0 81.0 81.0 81.0 80.0 82.0 82.0 84.0 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:115.00 stddev:5.20 (4.5%) stddev-sans-first:1.88 09:57:12 INFO - PROCESS | 15273 | Values: 131.0 114.0 115.0 117.0 114.0 120.0 115.0 115.0 115.0 115.0 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.20 Median:147.50 stddev:5.22 (3.5%) stddev-sans-first:5.36 09:57:12 INFO - PROCESS | 15273 | Values: 150.0 138.0 149.0 147.0 153.0 136.0 147.0 148.0 147.0 147.0 09:57:12 INFO - PROCESS | 15273 | 09:57:12 INFO - PROCESS | 15273 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:1.32 (1.9%) stddev-sans-first:1.22 09:57:12 INFO - PROCESS | 15273 | Values: 70.0 67.0 69.0 70.0 68.0 66.0 68.0 69.0 68.0 67.0 09:57:12 INFO - PROCESS | 15273 | -------- Summary: end -------- 09:57:12 INFO - PROCESS | 15273 | 09:57:13 INFO - TEST-INFO | 15273: exit 0 09:57:13 INFO - TEST-OK | kraken | took 60250ms 09:57:13 INFO - SUITE-END | took 1173s 09:57:13 INFO - Completed test suite (00:19:34) 09:57:13 INFO - javascript benchmark 09:57:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3094.597702298701, 3162.3991441626104, 3210.630777460591, 3211.181148807054, 3214.758893083018, 5064.594832413407, 5209.687418754877, 5242.554382877455, 5292.708901010443, 5343.759530821113, 5116.0, 5155.175171972485, 5235.895282094356, 5251.86870328242, 5261.158214685651, 4635.513271106536, 4650.86047418578, 4661.5804577588015, 4704.600108990723, 4957.182064959277, 4859.538343857328, 4899.0, 4912.950870491303, 4915.82794602189, 4916.680415772963, 4748.857534273943, 4760.690555113906, 4839.612830973514, 4864.246041863516, 4881.536254055859, 4794.616430685537, 4811.13399588074, 4819.277108433763, 4822.590079843218, 4862.927056094161, 4642.79107440166, 4770.236762118079, 4794.472608013116, 4810.158222311082, 4848.636352273594, 5192.55863251624, 5227.947720522784, 5239.869003274911, 5272.630915835893, 5284.365876094855, 5612.719364031782, 5613.158026296048, 5613.775448982035, 5613.915791263134, 5624.859378515529, 5601.103823388238, 5636.210930469738, 5636.633618814764, 5651.0, 5676.233708449389, 5268.657537260104, 5282.894342113136, 5287.312649355559, 5300.549453296436, 5345.518903298722, 5765.596408251382, 5765.971170144123, 5766.625169363978, 5768.105943578752, 5768.423157684198, 5387.111126664056, 5420.457954204627, 5513.558915286768, 5545.556355491551, 5548.306461692288, 5669.291338582677, 5670.603057785998, 5674.829755107354, 5675.233843431167, 5680.318361796528, 5606.775728970877, 5620.0, 5630.239917611152, 5635.718214089279, 5637.8590535236945, 5469.371022332403, 5538.418466061005, 5585.581081418829, 5615.354234263112, 5654.208410822488, 4216.135692183095, 4221.451211342506, 4224.134052519226, 4229.682773791917, 4263.680223983214, 3801.562820275704, 3824.2160357126722, 3833.923321533554, 3852.114013776847, 3863.4784304118584, 5166.741662916839, 5288.735563221823, 5337.706426146521, 5375.811846585429, 5384.326959130109, 5530.087535556588, 5537.446255374511, 5538.6399884007415, 5547.362053363915, 5566.053770858964, 5185.637005409661, 5214.947850521522, 5222.060029194706, 5238.842834714965, 5269.0, 4679.695819771704, 4680.180968330528, 4712.5758681718125, 4754.667173297836, 4755.310479980452, 5813.186153938452, 5813.970930145407, 5817.0983497557945, 5821.09772985188, 5853.473187413153, 5569.55443564522, 5575.1915972183, 5584.832455026356, 5651.237082993744, 5654.264945557051, 5821.09772985188, 5854.560907931837, 5874.530037597067, 5891.410858914074, 5931.288245410406, 5451.046066938349, 5466.972665136649, 5513.255710479194, 5514.145307477347, 5520.889582208413, 5431.212474191141, 5528.806491772769, 5587.329520457572, 5602.85992850182, 5604.495595396434, 5515.255440515479, 5516.696581688046, 5518.613697041169, 5523.392426833126, 5530.806421775219, 5493.203485494501, 5535.0, 5542.418046105101, 5549.15018387831, 5551.361593416808, 5227.764750586309, 5439.728013599383, 5465.180222966586, 5509.669419834662, 5510.421405752339, 5562.193481945014, 5569.0, 5587.106063029895, 5590.273264475755, 5633.2113504110275, 5438.782448702166, 5480.808171713971, 5481.616286859881, 5482.80810171642, 5490.91763623538], "unit": "score", "name": "dojo.html", "value": 5184.276214875493}, {"lowerIsBetter": false, "replicates": [487.9926801097984, 504.54338823364867, 545.2366686638707, 556.6743455078779, 556.7995521612219, 28248.57627135592, 29054.854725726367, 29056.0, 29069.709302906966, 36995.0, 40024.599754002455, 40307.395389069185, 40556.797216013954, 40739.0, 40841.0, 8571.828563428711, 8800.8679869802, 8830.779230519256, 8836.0, 8843.425177363482, 7581.924180758177, 8745.825083498326, 8941.642334306653, 10420.426876521788, 10670.679879603624, 10359.067683908446, 10465.372077675325, 10466.005729455728, 10467.0, 10467.68596942089, 10365.792684146312, 10402.271840971134, 10416.583336666487, 10479.84280235797, 10495.527701253424, 10185.439800810953, 10206.387616743019, 10251.53868075931, 10315.896841031643, 10326.741831454274, 40786.79606601978, 41133.38299925504, 41242.79378603088, 41368.79315603403, 41368.79315603403, 3163.208411326614, 3404.9829750851336, 3782.678472329855, 3880.1463677990796, 3928.273269445162, 31881.521777173362, 32071.83964080188, 32111.0, 32227.260682841985, 33157.17107072318, 3977.6817854571564, 3995.3407687731487, 4024.255512730125, 4052.959470405288, 4105.67154627632, 263332.0, 264558.0, 264706.6764666184, 265236.0, 265348.0, 60808.695956519936, 61455.38544614586, 61528.69235653883, 61548.0, 61761.0, 44969.55030449654, 45157.0, 45166.09667806626, 45228.77385613051, 45438.0, 14016.439342426189, 14609.78085328721, 14799.0, 14805.777913331309, 14839.10965342083, 9760.072793084646, 10474.581016759244, 10606.204534659932, 10651.094656954245, 10654.200934929911, 20809.479763006046, 21358.145674172858, 21415.46461338448, 21494.0, 21515.78484215169, 7714.151443341228, 7843.882341764878, 7911.971443712396, 7967.8406431871035, 8002.43921944972, 882.3823323673454, 951.372094417681, 971.6599190283345, 1002.9247806414548, 1049.4595283428887, 26973.595396068682, 27811.443771124465, 29302.0, 29314.560281595794, 29975.0, 1004.638330201127, 1063.611781699674, 1075.7794652096302, 1112.238116889933, 1146.6502716671496, 15171.544853654408, 15513.612159696098, 15519.689606207812, 15774.211289435712, 15831.920840395724, 320718.0, 483721.0, 495758.0, 497883.0, 502287.0, 51801.22298165531, 51848.0, 51850.0, 52216.216756748676, 52344.73827630837, 1317.2425855133338, 1317.3676635214958, 1336.211635135275, 1417.7306311800726, 1461.926903654813, 27244.0, 30746.231344215677, 30811.229719256302, 31053.689463105078, 31401.37197256088, 42267.1546569073, 42772.35841462318, 42897.571024290606, 43597.0, 44067.77966110149, 200926.0, 202124.0, 202580.0, 216849.0, 220250.0, 27593.17220483389, 30979.0706278812, 31580.684193157773, 31725.0, 32622.390208782766, 37818.24363512769, 39736.40395394129, 41205.0, 41523.7923810379, 42012.57987420087, 34942.825285873405, 34971.30057398888, 35199.12002199965, 35222.29555408929, 35293.82353088218, 35083.64916350906, 35123.19014478785, 35136.82431587826, 35660.28679426345, 35662.64337356697, 34583.0, 34745.13137171591, 35058.298834023684, 35287.82356088203, 35523.82238088793, 31009.68990310068, 31383.0, 31607.20981975469, 31696.841515792272, 32047.198820029687, 24229.394265143514, 24745.0, 24859.627105593794, 25186.874065630287, 25283.87358063198], "unit": "score", "name": "ext.html", "value": 18468.672567904865}, {"lowerIsBetter": false, "replicates": [336.8664444145451, 357.4441743089496, 358.53927702901774, 365.52664299731845, 366.156010396037, 14288.357023933922, 16710.91644541777, 16747.162641867904, 16938.40715574955, 18412.26350945964, 16237.83762162378, 16247.0, 16646.83353166468, 17279.0, 17313.653726925455, 5311.601629877765, 5437.293151890269, 5447.101228297326, 5455.509004189622, 5477.698726570037, 3764.341240282953, 5176.715280659562, 5268.789248430058, 5374.113271310229, 5457.536109430703, 5444.40111587725, 5445.673259604417, 5465.945340546603, 5468.562514998791, 5476.288082549263, 5414.620976531644, 5432.511074003339, 5480.150576660624, 5826.650400975955, 5910.113482977545, 5319.175527793198, 5328.733563321818, 5331.147016477384, 5347.278117454132, 5356.303680521546, 19757.80242197574, 19795.406137815888, 20427.387178384673, 20625.0, 20637.587248255102, 2045.856790024699, 2065.3993600729123, 2073.626747185506, 2079.3034333498294, 2636.9208923732126, 9116.954415227949, 9201.585928633227, 9582.233421326277, 9616.326857119935, 9735.756606084833, 1775.0, 1832.6334733053443, 1866.4027511196423, 1895.9146838392305, 1915.79884112169, 63642.0, 64064.0, 64231.35768642347, 66836.99999999952, 67471.0, 10366.896331036744, 10468.319559228627, 10471.371717696962, 10575.524101415302, 10696.411697356565, 14058.297085145701, 14230.0, 14271.500497482539, 14276.072055316372, 14294.213818239888, 7170.677319520634, 7328.67020984057, 7365.7790266292095, 7432.219616940143, 7443.516171448839, 6773.491988100912, 6871.312868713088, 6920.377166055079, 6923.342282483156, 6970.546914450544, 4573.291139873325, 4614.1694494991225, 4617.238155704338, 4635.953640463552, 4719.480857105716, 1700.1074435921241, 1718.4243278501592, 1816.4913824129264, 1898.7246849206788, 1903.1340739963284, 898.8247291778172, 912.1349721292155, 920.2683866326287, 928.4707716601607, 946.3659348236698, 15688.0, 16122.193890305438, 16955.49133525996, 17009.0, 17384.47846564605, 903.0608167505852, 916.4272329793879, 927.1284992107533, 971.582219645545, 980.2794945714894, 9279.211267042241, 9363.578638961262, 9653.17947974416, 9718.465484398426, 9801.215902727765, 344226.0, 351642.0, 351954.0, 401170.0, 406801.0, 71920.64039679768, 79319.4854207538, 80725.0, 83089.0, 83834.5808270967, 1004.7437903334603, 1013.0882206014646, 1040.0795296162798, 1040.4485622620023, 1043.4991204221865, 15045.172515511751, 15269.835596854915, 15353.0, 15447.768283475982, 15719.449819256271, 34888.0, 35186.296274073866, 35198.472022919166, 35247.0, 35913.1021724459, 46991.0, 50134.24798627951, 50771.0, 51055.234171486714, 51158.74420627873, 7992.6403311849945, 8089.757307280791, 8251.504909705196, 8271.793205169919, 8384.071663517547, 9306.06939306064, 11536.884631153916, 12406.25562466255, 12466.376681166086, 12533.0, 7625.733099341496, 10086.82671974126, 10532.947335263274, 10735.731606709895, 10827.67516974492, 10623.575056997634, 10683.145348372267, 10718.14254859625, 10816.134709223086, 10968.725781855517, 10266.332688375232, 10759.193060520336, 10847.457627118454, 10915.0, 11227.0, 7834.804129896798, 8010.679572817256, 8184.83630327402, 8320.417570769989, 8335.291500222549, 10191.796164076528, 10576.682699519026, 10684.145268378355, 10770.784584308427, 10838.132949363875], "unit": "score", "name": "jquery.html", "value": 8354.656874412101}, {"lowerIsBetter": false, "replicates": [1356.1659579358698, 1479.2234077109515, 1480.5706345159902, 1631.6084139806442, 1751.4220307298585, 7708.152103268636, 7911.1693272206385, 7927.484713493619, 7928.722494712686, 7932.801679958004, 7507.73722919698, 7652.19651936547, 7654.9617251913805, 7658.7702368928885, 7663.310302072812, 2041.9591608167827, 2257.2551058150852, 2283.6460348645946, 2308.9538209235807, 2314.3635500237483, 2347.8708671023087, 2356.5640356534095, 2357.9410514737096, 2358.6108292131776, 2359.1507057459385, 2259.7062381890414, 2328.266596022256, 2328.8020518255967, 2329.5806754784217, 2330.906763729449, 2258.7402448718444, 2287.782660647236, 2350.3536527455003, 2351.353377821096, 2354.7880690737743, 2322.5238826040622, 2327.464683122891, 2342.6486027095903, 2362.7991620712087, 2377.5363804058215, 8094.51432914027, 8117.553534555597, 8181.590920454013, 8184.386171037137, 8194.344452443791, 4760.666753327268, 4875.8781030474165, 4876.658633895629, 4924.8276310328965, 4932.21084626458, 3078.0, 3180.5547223388744, 3220.5974253218346, 3227.467467867799, 3261.0868956692166, 1017.0795430135739, 1899.6675581773134, 1914.1386376130797, 1917.6931690929384, 1929.7973712760238, 10893.509792059298, 10990.120790336754, 10990.691954689524, 11030.724231894186, 11053.778924421547, 4118.402831589403, 4286.807093680792, 4341.522432532419, 4391.363252328459, 4393.472783266028, 8763.518006509576, 8788.78028049291, 8791.472511649321, 8808.03111657717, 8817.911820881838, 4371.934420983688, 4884.145274576935, 4921.212605983025, 4931.988942266827, 4933.802647894116, 4311.267084595626, 4378.8029538670835, 4431.047324825178, 4433.5788100131085, 4444.599986001275, 3556.715462762973, 3632.727545434103, 3675.9448608270895, 3677.485152078711, 3688.0411093115445, 1061.5647584490323, 1098.7088421568292, 1101.7686285879895, 1116.609186784635, 1118.3904771899333, 1013.2552573858209, 1024.446798728693, 1031.6698656430021, 1165.6794381545144, 1378.3521744779937, 7486.663100160506, 7784.571848548384, 7786.727464538714, 7814.413918956101, 7836.0, 1116.3525155409843, 1143.3290241396912, 1154.6420609611048, 1161.3206274329611, 1172.6013155526991, 5890.970545147246, 5931.139984702194, 5942.049272116527, 5944.346121926585, 5958.106284057426, 9264.44413335202, 9391.389559678599, 9424.528773561295, 9731.659391921248, 10014.148797352162, 9508.334416590773, 9747.074027967332, 9777.853332200022, 9789.167920726817, 9795.265355098396, 7372.741954031583, 7466.514676546007, 7473.065866766654, 7537.472376933562, 7552.773416797505, 7552.546847189186, 7575.886361704469, 7600.923990760243, 7606.619669016638, 7634.885476717965, 8640.0, 8683.0, 8794.560271986247, 9005.459672419676, 9018.053104423941, 8902.643894244158, 9044.276457883485, 9059.728208153765, 9072.410293330913, 9276.536173191449, 6385.074164246251, 6761.86476270462, 6932.272111428228, 7119.1457025157315, 7243.674034668558, 7650.961745191238, 7653.272939070779, 7693.346065584488, 7700.961495192488, 7706.07527096752, 6925.792226233221, 7091.680874360563, 7116.822079447848, 7264.382527485223, 7273.854522909618, 7050.717971281091, 7079.8938015930835, 7110.43116550685, 7212.927870721435, 7215.0, 7138.214796372498, 7370.557766534025, 7417.258274172756, 7437.851242975218, 7441.888371674538, 6788.694508747019, 6791.117154769849, 6796.524243303119, 6805.3875151236625, 6805.89791153143, 6803.115594972622, 6823.522353435212, 6919.169699635874, 6985.755498557526, 7016.543924644881], "unit": "score", "name": "mootools.html", "value": 4656.470609902451}, {"lowerIsBetter": false, "replicates": [325.29086591231123, 331.6998116704382, 337.3775384415755, 339.8063104030702, 347.44929287079975, 5863.970680146599, 5912.763489460416, 5923.111533270012, 5924.763009479621, 5937.109433584965, 5825.097109947954, 5825.184474173609, 5842.678652674102, 5853.443922827335, 5872.647641141534, 4317.460317460317, 4463.062756821071, 4513.3230015497775, 4539.750313732743, 4542.091581683669, 4536.478304994918, 4541.137183935059, 4550.931736023962, 4564.995700945787, 4580.725156490605, 4507.233770259064, 4511.932321015187, 4520.412346394981, 4520.932186017212, 4530.478994915594, 4304.913901721964, 4408.955910440903, 4491.371208030879, 4496.820127194908, 4504.09918016398, 3949.8025098745234, 3954.2882281189372, 3955.4462375267485, 3960.841566337343, 3983.6813054955533, 5610.18652295419, 5617.101263797773, 5625.1843482695185, 5631.380548139701, 5635.239242702224, 5242.89899121185, 5246.108161612535, 5246.317978662788, 5253.579713622901, 5270.5520030797425, 6200.069989501566, 6201.751929922798, 6207.068939659042, 6213.937860621381, 6216.160818289518, 4295.591918767712, 4383.539728328511, 4406.383106365111, 4410.1179764047, 4416.757078360689, 6419.069234960951, 6475.514336424787, 6476.870462590722, 6484.837879053061, 6520.967395163041, 4576.8626941191815, 4578.885527861764, 4581.106684196549, 4583.770811459413, 4587.9082418351445, 4632.5135860734135, 4636.374089497942, 4648.2330415481065, 4650.069986002745, 4652.325412815123, 5281.313429254173, 5293.338332708411, 5297.152455607084, 5300.946990530046, 5303.310569626001, 6098.26820781509, 6250.656213908279, 6258.718357673915, 6267.65527895961, 6268.780592679234, 1583.1292788966023, 1599.7520384340446, 1607.0598699760537, 1610.5812488752774, 1620.2546828458806, 1021.0759262867117, 1099.8240281554913, 1101.498818037791, 1117.0337657925836, 1121.6018313498591, 5884.882302354014, 5891.587588868823, 5940.257467816523, 5943.286805583271, 5953.285605727254, 6325.9051114233325, 6351.8566658002, 6356.332585078592, 6356.332585078592, 6365.0, 5894.528437724972, 5915.024021036481, 5918.461200088008, 5919.0, 5927.873703996227, 3400.0, 3429.6570342966, 3434.9484757728655, 3436.0, 3438.3639026780124, 6603.70283337251, 6676.232233293136, 6707.396334329934, 6814.557053791487, 6824.863502729918, 6540.37866402691, 6602.735890564323, 6616.96691516549, 6623.701933413008, 6625.204975402982, 6795.830104247335, 6796.592204467748, 6802.14973128359, 6803.25164231944, 6804.557703749141, 6427.357264273535, 6439.388258115471, 6443.806685799434, 6449.064885591657, 6450.612963222222, 6237.157983672146, 6418.261899881387, 6421.93578064232, 6429.132067170872, 6429.646369449725, 6781.93218067813, 6803.387695107464, 6804.965975170093, 6807.897881531682, 6817.965910170417, 4330.198913201068, 4343.19650864591, 4346.978265108654, 4352.499462561846, 4356.172327257811, 6460.483161346987, 6466.838329041811, 6468.223813142453, 6469.8706025880165, 6475.061116138228, 6274.341194174728, 6274.498040156685, 6279.623222606659, 6281.371862813682, 6286.779962701284, 6059.515238780975, 6265.122882796503, 6271.153394291712, 6277.71750271248, 6299.590526615755, 6130.50955923534, 6166.260048794174, 6169.2288463942, 6237.1891654084675, 6241.063840423973, 6277.497800176066, 6294.339094395205, 6295.150154729236, 6299.055141728777, 6301.936980630135, 5927.644341339534, 6019.217501724747, 6155.6614386209185, 6162.784302549389, 6166.044263139221], "unit": "score", "name": "prototype.html", "value": 4733.870705519777}, {"lowerIsBetter": false, "replicates": [643.9484841212703, 651.1209866679983, 665.6971078159438, 734.1630541183049, 776.5496012312857, 13722.313884305782, 13988.37052332645, 14012.509562165313, 14013.50952716655, 14053.859461405384, 14158.0, 14162.78755818661, 14165.079269847452, 14286.571402857931, 14321.498747543837, 838.513662075996, 847.902491213509, 855.2644725536034, 855.6662901468433, 856.4133568505594, 552.6628756458557, 838.6645341863242, 850.6384786465758, 855.6406309350057, 860.0410542245382, 864.360373323739, 872.9388942774009, 874.8337815815007, 878.9824203515958, 886.0519244408486, 708.3023222126202, 871.9302455803584, 873.9519326437076, 874.7332063720563, 874.7419511244199, 641.0, 647.5531883000715, 649.5875119299279, 649.6069877723957, 649.7628365646552, 13762.931185344109, 13807.309634518335, 13848.0, 13850.445982160702, 13865.75208231254, 12552.74894502114, 12600.936995315056, 12753.872461275361, 12935.87064129356, 13190.812826845535, 10437.269391142623, 10611.0, 10878.945605272002, 11019.393933333664, 11495.482703278372, 3514.7363947704025, 3541.0, 3600.171960449085, 3600.567931848195, 3670.7063434925144, 46480.76759616214, 47110.76444617789, 47208.29187562189, 47556.7622161887, 48865.51134488645, 9066.274698024143, 9164.6792362267, 9220.585073671567, 9294.256459483226, 9572.377795443273, 17512.91243543774, 17513.56216094608, 17513.912430437766, 17515.386961456286, 17559.648807023787, 7546.169921308651, 7859.6463159157975, 8078.434509584273, 8144.918550814535, 8182.0, 3607.5129857469433, 3629.020164555608, 4126.381042843537, 4426.933595996063, 4615.076984603093, 3099.6745341739243, 3116.8441577921467, 3119.454095533318, 3121.4537455945574, 3124.140861263171, 561.0518224201087, 561.2451253064621, 566.9348024977098, 583.6177303865975, 587.6973358720262, 475.538727434395, 487.0648355158105, 554.4621716934568, 587.6209844650263, 617.3301967365369, 8020.35837133028, 8046.919530804734, 8063.1130575636635, 8182.590870456454, 8299.875501867476, 590.9734061967222, 602.7799853053604, 612.8651696626735, 625.2809269340295, 639.191422850095, 3700.6669399753614, 3737.252549490113, 3752.699784017272, 3773.4905787718853, 3774.50931378919, 49877.75061124744, 50107.24839127416, 50393.0, 54708.0, 55694.72152639211, 44734.55265447369, 47209.0, 47443.28835067477, 48116.0, 48404.0, 44798.86407951477, 45193.32210016852, 45663.771681141385, 45728.314075288894, 46052.0, 8194.426390152632, 8241.25828675422, 8399.622017009127, 8405.95797021011, 8472.661093556435, 33591.32817343689, 33609.495857562644, 34330.65669343275, 34795.0, 35092.298154037286, 39404.605953940096, 39561.208775824896, 40682.18635627212, 42215.366769499095, 42816.35775463433, 10527.0, 10791.514381852992, 10926.945365273123, 11200.719982000515, 11347.20569560123, 10976.396298203355, 11191.16066295015, 12027.4587643558, 12544.74910501803, 12597.811032834697, 10296.330738501973, 10956.671299860698, 10999.120070394509, 11128.833067504156, 11277.661670149908, 11506.942465287955, 12069.637910862688, 12076.275423474619, 12151.574694885636, 12163.81754273669, 10264.794704105727, 10421.114205292635, 10430.165586753194, 10473.68578942633, 10810.081143102925, 9447.527623618655, 9621.807563848544, 9694.22446204288, 9995.550200240861, 10003.849942251018, 8345.749627511184, 8883.689070882489, 9009.954950225469, 9350.812983740423, 9463.668771592962], "unit": "score", "name": "yui.html", "value": 6173.958767365795}], "name": "dromaeo_css", "value": 6910.155528916401}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 104.0, 109.0, 111.0, 112.0, 103.0, 110.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [159.0, 127.0, 153.0, 175.0, 129.0, 154.0, 156.0, 134.0, 180.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.5}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 161.0, 161.0, 162.0, 159.0, 159.0, 166.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 98.0, 96.0, 74.0, 75.0, 76.0, 115.0, 94.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 149.0, 93.0, 93.0, 93.0, 145.0, 94.0, 93.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 144.0, 144.0, 145.0, 145.0, 144.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 144.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 57.0, 56.0, 58.0, 56.0, 56.0, 65.0, 57.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 68.0, 68.0, 69.0, 70.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 81.0, 81.0, 81.0, 81.0, 80.0, 82.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.3}, {"lowerIsBetter": true, "replicates": [131.0, 114.0, 115.0, 117.0, 114.0, 120.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.1}, {"lowerIsBetter": true, "replicates": [150.0, 138.0, 149.0, 147.0, 153.0, 136.0, 147.0, 148.0, 147.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.2}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 69.0, 70.0, 68.0, 66.0, 68.0, 69.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1509.4}]} 09:57:13 INFO - Return code: 0 09:57:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:57:13 INFO - # TBPL SUCCESS # 09:57:13 INFO - Running post-action listener: _resource_record_post_action 09:57:13 INFO - Running post-run listener: _resource_record_post_run 09:57:14 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 534478848; Read time: 0; Write time: 903716 09:57:14 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 246976512; Read time: 0; Write time: 501848 09:57:14 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 287502336; Read time: 0; Write time: 401868 09:57:14 INFO - Running post-run listener: _upload_blobber_files 09:57:14 INFO - Blob upload gear active. 09:57:14 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:57:14 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:57:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 09:57:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 09:57:15 INFO - (blobuploader) - INFO - Open directory for files ... 09:57:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 09:57:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:57:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:16 INFO - (blobuploader) - INFO - Done attempting. 09:57:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:57:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:57:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:17 INFO - (blobuploader) - INFO - Done attempting. 09:57:17 INFO - (blobuploader) - INFO - Iteration through files over. 09:57:17 INFO - Return code: 0 09:57:17 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:57:17 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:57:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d50afb39dcc318da0aeb74bd53b49d4b6adf641e4482b6ee439cfa23ca37702a0ca378230f30f233d7c32150d9ddd77d2a2deb95efb553f5e17776a316cbfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6eabb9096fabbd498585d1bdbe770b8943bd8f4509f3359ffc85735af15202107f499c1b46bcb9702b8c0f9a10c8274be82aca47431ff483ca1bf1e614e244a"} 09:57:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:57:17 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:57:17 INFO - Contents: 09:57:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d50afb39dcc318da0aeb74bd53b49d4b6adf641e4482b6ee439cfa23ca37702a0ca378230f30f233d7c32150d9ddd77d2a2deb95efb553f5e17776a316cbfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6eabb9096fabbd498585d1bdbe770b8943bd8f4509f3359ffc85735af15202107f499c1b46bcb9702b8c0f9a10c8274be82aca47431ff483ca1bf1e614e244a"} 09:57:17 INFO - Running post-run listener: copy_logs_to_upload_dir 09:57:17 INFO - Copying logs to upload dir... 09:57:17 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:57:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.163518 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-07 09:57:16.575816) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 09:57:16.579013) ========= 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=745a4373a2a16df560f216e000000264-1457372203.874566-1782808492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d50afb39dcc318da0aeb74bd53b49d4b6adf641e4482b6ee439cfa23ca37702a0ca378230f30f233d7c32150d9ddd77d2a2deb95efb553f5e17776a316cbfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6eabb9096fabbd498585d1bdbe770b8943bd8f4509f3359ffc85735af15202107f499c1b46bcb9702b8c0f9a10c8274be82aca47431ff483ca1bf1e614e244a"} build_url:https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/ZRK0Rr23SEqNJ3pOUaUB_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d50afb39dcc318da0aeb74bd53b49d4b6adf641e4482b6ee439cfa23ca37702a0ca378230f30f233d7c32150d9ddd77d2a2deb95efb553f5e17776a316cbfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6eabb9096fabbd498585d1bdbe770b8943bd8f4509f3359ffc85735af15202107f499c1b46bcb9702b8c0f9a10c8274be82aca47431ff483ca1bf1e614e244a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 09:57:16.602820) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:57:16.603119) ========= 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=745a4373a2a16df560f216e000000264-1457372203.874566-1782808492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:57:16.688243) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 09:57:16.688548) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 09:57:16.688841) ========= ========= Total master_lag: 0.29 =========