builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1458259006.31 results: success (0) buildid: 20160317142924 builduid: 832211d5895e4f44bebee4d84e6ae878 revision: c138edad150f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:46.313150) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:46.313634) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:46.314368) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006465 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:46.348329) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:46.348674) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:46.404585) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:46.404892) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027566 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:46.463989) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:46.464298) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:46.464676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:46.465008) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-17 16:56:46-- 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% 41.6K=0.3s 2016-03-17 16:56:47 (41.6 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.454813 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:46.934682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:46.935078) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.117490 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:47.065895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:47.066279) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c138edad150f --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c138edad150f --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=934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-17 16:56:47,245 Setting DEBUG logging. 2016-03-17 16:56:47,245 attempt 1/10 2016-03-17 16:56:47,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c138edad150f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 16:56:47,500 unpacking tar archive at: mozilla-inbound-c138edad150f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.561583 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:47.644030) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:47.644818) ========= echo c138edad150f in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c138edad150f'] 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=934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c138edad150f program finished with exit code 0 elapsedTime=0.004649 script_repo_revision: 'c138edad150f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:47.700086) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:47.700598) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 16:56:47.714203) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-03-17 16:56:47.714523) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:56:47 INFO - MultiFileLogger online at 20160317 16:56:47 in /builds/slave/test-pgo 16:56:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:56:47 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:56:47 INFO - {'append_to_log': False, 16:56:47 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:56:47 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:56:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:56:47 INFO - 'branch': 'Mozilla-Inbound', 16:56:47 INFO - 'buildbot_json_path': 'buildprops.json', 16:56:47 INFO - 'config_files': ('talos/linux_config.py',), 16:56:47 INFO - 'default_actions': ('clobber', 16:56:47 INFO - 'read-buildbot-config', 16:56:47 INFO - 'download-and-extract', 16:56:47 INFO - 'populate-webroot', 16:56:47 INFO - 'create-virtualenv', 16:56:47 INFO - 'install', 16:56:47 INFO - 'run-tests'), 16:56:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:56:47 INFO - 'download_minidump_stackwalk': True, 16:56:47 INFO - 'download_symbols': 'ondemand', 16:56:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:56:47 INFO - 'tooltool.py': '/tools/tooltool.py', 16:56:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:56:47 INFO - '/tools/misc-python/virtualenv.py')}, 16:56:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:56:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:56:47 INFO - 'installer_path': 'installer.exe', 16:56:47 INFO - 'log_level': 'info', 16:56:47 INFO - 'log_name': 'talos', 16:56:47 INFO - 'log_to_console': True, 16:56:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:56:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:56:47 INFO - 'opt_config_files': (), 16:56:47 INFO - 'pip_index': False, 16:56:47 INFO - 'sps_profile': False, 16:56:47 INFO - 'sps_profile_interval': 0, 16:56:47 INFO - 'suite': 'dromaeojs', 16:56:47 INFO - 'system_bits': '32', 16:56:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:56:47 INFO - 'title': 'talos-linux64-ix-057', 16:56:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:56:47 INFO - 'use_talos_json': True, 16:56:47 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:56:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:56:47 INFO - 'work_dir': 'build'} 16:56:47 INFO - ##### 16:56:47 INFO - ##### Running clobber step. 16:56:47 INFO - ##### 16:56:47 INFO - Running pre-action listener: _resource_record_pre_action 16:56:47 INFO - Running main action method: clobber 16:56:47 INFO - rmtree: /builds/slave/test-pgo/build 16:56:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:56:49 INFO - Running post-action listener: _resource_record_post_action 16:56:49 INFO - ##### 16:56:49 INFO - ##### Running read-buildbot-config step. 16:56:49 INFO - ##### 16:56:49 INFO - Running pre-action listener: _resource_record_pre_action 16:56:49 INFO - Running main action method: read_buildbot_config 16:56:49 INFO - Using buildbot properties: 16:56:49 INFO - { 16:56:49 INFO - "project": "", 16:56:49 INFO - "product": "firefox", 16:56:49 INFO - "script_repo_revision": "production", 16:56:49 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:56:49 INFO - "repository": "", 16:56:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:56:49 INFO - "buildid": "20160317142924", 16:56:49 INFO - "pgo_build": "True", 16:56:49 INFO - "basedir": "/builds/slave/test-pgo", 16:56:49 INFO - "buildnumber": 800, 16:56:49 INFO - "slavename": "talos-linux64-ix-057", 16:56:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:56:49 INFO - "platform": "ubuntu64_hw", 16:56:49 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:56:49 INFO - "branch": "mozilla-inbound", 16:56:49 INFO - "repo_path": "integration/mozilla-inbound", 16:56:49 INFO - "revision": "c138edad150f", 16:56:49 INFO - "stage_platform": "linux64-pgo", 16:56:49 INFO - "builduid": "832211d5895e4f44bebee4d84e6ae878", 16:56:49 INFO - "slavebuilddir": "test" 16:56:49 INFO - } 16:56:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:56:49 INFO - Running post-action listener: _resource_record_post_action 16:56:49 INFO - ##### 16:56:49 INFO - ##### Running download-and-extract step. 16:56:49 INFO - ##### 16:56:49 INFO - Running pre-action listener: _resource_record_pre_action 16:56:49 INFO - Running main action method: download_and_extract 16:56:49 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:49 INFO - https://queue.taskcluster.net/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:56:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:56:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:56:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/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 16:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/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 16:56:56 INFO - Downloaded 1361 bytes. 16:56:56 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:56:56 INFO - Using the following test package requirements: 16:56:56 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:56:56 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:56 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:56:56 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:56 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:56:56 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:56 INFO - u'jsshell-linux-x86_64.zip'], 16:56:56 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:56 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:56:56 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:56:56 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:56 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:56:56 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:56 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:56:56 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:56 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:56:56 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:56 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:56:56 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:56:56 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')]} 16:56:56 INFO - https://queue.taskcluster.net/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:56:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:56:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:56:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/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 16:56:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/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 16:57:10 INFO - Downloaded 23406632 bytes. 16:57:10 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'] 16:57:10 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 16:57:11 INFO - Return code: 0 16:57:11 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 16:57:11 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')]} 16:57:11 INFO - https://queue.taskcluster.net/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:57:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:57:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:57:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/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 16:57:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/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 16:57:12 INFO - Downloaded 23406632 bytes. 16:57:12 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'] 16:57:12 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 16:57:14 INFO - Return code: 0 16:57:14 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')]} 16:57:14 INFO - https://queue.taskcluster.net/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:57:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:57:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:57:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/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 16:57:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/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 16:57:15 INFO - Downloaded 10845263 bytes. 16:57:15 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'] 16:57:15 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 16:57:15 INFO - Return code: 0 16:57: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')]} 16:57:15 INFO - https://queue.taskcluster.net/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:57:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:57:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:57:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/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 16:57:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSQV3V6lTEuSzLhBof5g0Q/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 16:57:16 INFO - Downloaded 56242398 bytes. 16:57:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:57:16 INFO - mkdir: /builds/slave/test-pgo/properties 16:57:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:57:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:57:16 INFO - Contents: 16:57:16 INFO - build_url:https://queue.taskcluster.net/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:57:17 INFO - Running post-action listener: _resource_record_post_action 16:57:17 INFO - Running post-action listener: set_extra_try_arguments 16:57:17 INFO - ##### 16:57:17 INFO - ##### Running populate-webroot step. 16:57:17 INFO - ##### 16:57:17 INFO - Running pre-action listener: _resource_record_pre_action 16:57:17 INFO - Running main action method: populate_webroot 16:57:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:57:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:57:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:57:17 INFO - '--tppagecycles', 16:57:17 INFO - '7'], 16:57:17 INFO - 'tests': ['tsvgm']}}, 16:57:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:57:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:57:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:57:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:57:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:57:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:57:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:17 INFO - 'talos_options': ['--e10s'], 16:57:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:17 INFO - 'tests': ['damp', 'tps']}, 16:57:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:17 INFO - 'talos_options': ['--e10s'], 16:57:17 INFO - 'tests': ['damp', 'tps']}, 16:57:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:57:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:57:17 INFO - 'other': {'tests': ['a11yr', 16:57:17 INFO - 'ts_paint', 16:57:17 INFO - 'tpaint', 16:57:17 INFO - 'sessionrestore', 16:57:17 INFO - 'sessionrestore_no_auto_restore', 16:57:17 INFO - 'tabpaint']}, 16:57:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:57:17 INFO - 'tests': ['a11yr', 16:57:17 INFO - 'ts_paint', 16:57:17 INFO - 'tpaint', 16:57:17 INFO - 'sessionrestore', 16:57:17 INFO - 'sessionrestore_no_auto_restore', 16:57:17 INFO - 'tabpaint']}, 16:57:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:57:17 INFO - 'tests': ['a11yr', 16:57:17 INFO - 'ts_paint', 16:57:17 INFO - 'tpaint', 16:57:17 INFO - 'sessionrestore', 16:57:17 INFO - 'sessionrestore_no_auto_restore', 16:57:17 INFO - 'tabpaint']}, 16:57:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:57:17 INFO - 'tests': ['a11yr', 16:57:17 INFO - 'ts_paint', 16:57:17 INFO - 'tpaint', 16:57:17 INFO - 'sessionrestore', 16:57:17 INFO - 'sessionrestore_no_auto_restore', 16:57:17 INFO - 'tabpaint']}, 16:57:17 INFO - 'other_l64': {'tests': ['a11yr', 16:57:17 INFO - 'ts_paint', 16:57:17 INFO - 'tpaint', 16:57:17 INFO - 'sessionrestore', 16:57:17 INFO - 'sessionrestore_no_auto_restore', 16:57:17 INFO - 'tabpaint']}, 16:57:17 INFO - 'other_nol64': {'tests': ['a11yr', 16:57:17 INFO - 'ts_paint', 16:57:17 INFO - 'tpaint', 16:57:17 INFO - 'sessionrestore', 16:57:17 INFO - 'sessionrestore_no_auto_restore', 16:57:17 INFO - 'tabpaint']}, 16:57:17 INFO - 'svgr': {'tests': ['tsvgx', 16:57:17 INFO - 'tsvgr_opacity', 16:57:17 INFO - 'tart', 16:57:17 INFO - 'tscrollx', 16:57:17 INFO - 'cart']}, 16:57:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:57:17 INFO - 'tests': ['tsvgx', 16:57:17 INFO - 'tsvgr_opacity', 16:57:17 INFO - 'tart', 16:57:17 INFO - 'tscrollx', 16:57:17 INFO - 'cart']}, 16:57:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:17 INFO - 'tests': ['tp5o']}, 16:57:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:17 INFO - 'talos_options': ['--e10s'], 16:57:17 INFO - 'tests': ['tp5o']}, 16:57:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:17 INFO - 'talos_options': ['--xperf_path', 16:57:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:17 INFO - 'tests': ['tp5n']}, 16:57:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:17 INFO - 'talos_options': ['--e10s', 16:57:17 INFO - '--xperf_path', 16:57:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:17 INFO - 'tests': ['tp5n']}}, 16:57:17 INFO - 'talos.zip': {'path': '', 16:57:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:57:17 INFO - Running post-action listener: _resource_record_post_action 16:57:17 INFO - ##### 16:57:17 INFO - ##### Running create-virtualenv step. 16:57:17 INFO - ##### 16:57:17 INFO - Running pre-action listener: _resource_record_pre_action 16:57:17 INFO - Running main action method: create_virtualenv 16:57:17 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:57:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 16:57:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:57:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:57:17 INFO - Using real prefix '/usr' 16:57:17 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:57:18 INFO - Installing distribute.............................................................................................................................................................................................done. 16:57:20 INFO - Installing pip.................done. 16:57:20 INFO - Return code: 0 16:57:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:20 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 0x7f8ad5921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24446d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d3920>, '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 0x24d4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', '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 16:57:20 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 16:57:20 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 16:57:20 INFO - Using env: {'DISPLAY': ':0', 16:57:20 INFO - 'HOME': '/home/cltbld', 16:57:20 INFO - 'LANG': 'en_US.UTF-8', 16:57:20 INFO - 'LANGUAGE': 'en_US:en', 16:57:20 INFO - 'LOGNAME': 'cltbld', 16:57:20 INFO - 'MAIL': '/var/mail/cltbld', 16:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:20 INFO - 'MOZ_NO_REMOTE': '1', 16:57:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:20 INFO - 'NO_EM_RESTART': '1', 16:57:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:57:20 INFO - 'PWD': '/builds/slave/test-pgo', 16:57:20 INFO - 'SHELL': '/bin/bash', 16:57:20 INFO - 'SHLVL': '1', 16:57:20 INFO - 'TERM': 'linux', 16:57:20 INFO - 'TMOUT': '86400', 16:57:20 INFO - 'USER': 'cltbld', 16:57:20 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', 16:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:20 INFO - '_': '/tools/buildbot/bin/python'} 16:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:20 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 16:57:20 INFO - Cleaning up... 16:57:20 INFO - Return code: 0 16:57:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:20 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 0x7f8ad5921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24446d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d3920>, '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 0x24d4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', '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 16:57:20 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 16:57:20 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 16:57:20 INFO - Using env: {'DISPLAY': ':0', 16:57:20 INFO - 'HOME': '/home/cltbld', 16:57:20 INFO - 'LANG': 'en_US.UTF-8', 16:57:20 INFO - 'LANGUAGE': 'en_US:en', 16:57:20 INFO - 'LOGNAME': 'cltbld', 16:57:20 INFO - 'MAIL': '/var/mail/cltbld', 16:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:20 INFO - 'MOZ_NO_REMOTE': '1', 16:57:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:20 INFO - 'NO_EM_RESTART': '1', 16:57:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:57:20 INFO - 'PWD': '/builds/slave/test-pgo', 16:57:20 INFO - 'SHELL': '/bin/bash', 16:57:20 INFO - 'SHLVL': '1', 16:57:20 INFO - 'TERM': 'linux', 16:57:20 INFO - 'TMOUT': '86400', 16:57:20 INFO - 'USER': 'cltbld', 16:57:20 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', 16:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:20 INFO - '_': '/tools/buildbot/bin/python'} 16:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:20 INFO - Downloading/unpacking psutil>=0.7.1 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:57:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:22 INFO - Installing collected packages: psutil 16:57:22 INFO - Running setup.py install for psutil 16:57:22 INFO - building 'psutil._psutil_linux' extension 16:57:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:57:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:57:22 INFO - building 'psutil._psutil_posix' extension 16:57:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:57:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:57:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:23 INFO - Successfully installed psutil 16:57:23 INFO - Cleaning up... 16:57:23 INFO - Return code: 0 16:57:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:57:23 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')]} 16:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:23 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')]} 16:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:23 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 0x7f8ad5921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24446d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d3920>, '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 0x24d4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', '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 16:57:23 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 16:57:23 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 16:57:23 INFO - Using env: {'DISPLAY': ':0', 16:57:23 INFO - 'HOME': '/home/cltbld', 16:57:23 INFO - 'LANG': 'en_US.UTF-8', 16:57:23 INFO - 'LANGUAGE': 'en_US:en', 16:57:23 INFO - 'LOGNAME': 'cltbld', 16:57:23 INFO - 'MAIL': '/var/mail/cltbld', 16:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:23 INFO - 'MOZ_NO_REMOTE': '1', 16:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:23 INFO - 'NO_EM_RESTART': '1', 16:57:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:57:23 INFO - 'PWD': '/builds/slave/test-pgo', 16:57:23 INFO - 'SHELL': '/bin/bash', 16:57:23 INFO - 'SHLVL': '1', 16:57:23 INFO - 'TERM': 'linux', 16:57:23 INFO - 'TMOUT': '86400', 16:57:23 INFO - 'USER': 'cltbld', 16:57:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', 16:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:23 INFO - '_': '/tools/buildbot/bin/python'} 16:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:57:23 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 16:57:23 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 16:57:23 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 16:57:23 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 16:57:23 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 16:57:23 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 16:57:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:57:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:57:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:57:25 INFO - Installing collected packages: mozsystemmonitor 16:57:25 INFO - Running setup.py install for mozsystemmonitor 16:57:25 INFO - Successfully installed mozsystemmonitor 16:57:25 INFO - Cleaning up... 16:57:25 INFO - Return code: 0 16:57:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:25 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 0x7f8ad5921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24446d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d3920>, '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 0x24d4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', '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 16:57:25 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 16:57:25 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 16:57:25 INFO - Using env: {'DISPLAY': ':0', 16:57:25 INFO - 'HOME': '/home/cltbld', 16:57:25 INFO - 'LANG': 'en_US.UTF-8', 16:57:25 INFO - 'LANGUAGE': 'en_US:en', 16:57:25 INFO - 'LOGNAME': 'cltbld', 16:57:25 INFO - 'MAIL': '/var/mail/cltbld', 16:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:25 INFO - 'MOZ_NO_REMOTE': '1', 16:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:25 INFO - 'NO_EM_RESTART': '1', 16:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:57:25 INFO - 'PWD': '/builds/slave/test-pgo', 16:57:25 INFO - 'SHELL': '/bin/bash', 16:57:25 INFO - 'SHLVL': '1', 16:57:25 INFO - 'TERM': 'linux', 16:57:25 INFO - 'TMOUT': '86400', 16:57:25 INFO - 'USER': 'cltbld', 16:57:25 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', 16:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:25 INFO - '_': '/tools/buildbot/bin/python'} 16:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:25 INFO - Downloading/unpacking blobuploader==1.2.4 16:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:27 INFO - Downloading blobuploader-1.2.4.tar.gz 16:57:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:57:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:57:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:57:28 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 16:57:28 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 16:57:28 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 16:57:28 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 16:57:28 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 16:57:28 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 16:57:28 INFO - Downloading docopt-0.6.1.tar.gz 16:57:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:57:28 INFO - Installing collected packages: blobuploader, requests, docopt 16:57:28 INFO - Running setup.py install for blobuploader 16:57:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:57:28 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:57:28 INFO - Running setup.py install for requests 16:57:28 INFO - Running setup.py install for docopt 16:57:29 INFO - Successfully installed blobuploader requests docopt 16:57:29 INFO - Cleaning up... 16:57:29 INFO - Return code: 0 16:57:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:29 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 0x7f8ad5921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24446d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d3920>, '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 0x24d4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', '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 16:57:29 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 16:57:29 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 16:57:29 INFO - Using env: {'DISPLAY': ':0', 16:57:29 INFO - 'HOME': '/home/cltbld', 16:57:29 INFO - 'LANG': 'en_US.UTF-8', 16:57:29 INFO - 'LANGUAGE': 'en_US:en', 16:57:29 INFO - 'LOGNAME': 'cltbld', 16:57:29 INFO - 'MAIL': '/var/mail/cltbld', 16:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:29 INFO - 'MOZ_NO_REMOTE': '1', 16:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:29 INFO - 'NO_EM_RESTART': '1', 16:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:57:29 INFO - 'PWD': '/builds/slave/test-pgo', 16:57:29 INFO - 'SHELL': '/bin/bash', 16:57:29 INFO - 'SHLVL': '1', 16:57:29 INFO - 'TERM': 'linux', 16:57:29 INFO - 'TMOUT': '86400', 16:57:29 INFO - 'USER': 'cltbld', 16:57:29 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', 16:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:29 INFO - '_': '/tools/buildbot/bin/python'} 16:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:57:29 INFO - Running setup.py (path:/tmp/pip-tDQZtO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:57:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:57:29 INFO - Running setup.py (path:/tmp/pip-7E2BOz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:57:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:57:29 INFO - Running setup.py (path:/tmp/pip-nOCVGu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:57:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:57:29 INFO - Running setup.py (path:/tmp/pip-v83ePw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:57:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:57:29 INFO - Running setup.py (path:/tmp/pip-mXaVBA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:57:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:57:29 INFO - Running setup.py (path:/tmp/pip-X9pxn7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:57:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:57:29 INFO - Running setup.py (path:/tmp/pip-mCarST-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:57:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:57:29 INFO - Running setup.py (path:/tmp/pip-jSefB6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:57:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:57:29 INFO - Running setup.py (path:/tmp/pip-nfLbLU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:57:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:57:29 INFO - Running setup.py (path:/tmp/pip-rxgorL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:57:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:57:30 INFO - Running setup.py (path:/tmp/pip-bsytqy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:57:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:57:30 INFO - Running setup.py (path:/tmp/pip-TB79zT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:57:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:57:30 INFO - Running setup.py (path:/tmp/pip-Tu5gWt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:57:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:57:30 INFO - Running setup.py (path:/tmp/pip-_XVn6M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:57:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:57:30 INFO - Running setup.py (path:/tmp/pip-fOCwN6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:57:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:57:30 INFO - Running setup.py (path:/tmp/pip-pzzE0U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:57:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:57:30 INFO - Running setup.py (path:/tmp/pip-aDklPV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:57:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:57:30 INFO - Running setup.py install for manifestparser 16:57:30 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:57:30 INFO - Running setup.py install for mozcrash 16:57:30 INFO - Running setup.py install for mozdebug 16:57:30 INFO - Running setup.py install for mozdevice 16:57:30 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:57:30 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:57:30 INFO - Running setup.py install for mozfile 16:57:31 INFO - Running setup.py install for mozhttpd 16:57:31 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:57:31 INFO - Running setup.py install for mozinfo 16:57:31 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:57:31 INFO - Running setup.py install for mozInstall 16:57:31 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:57:31 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:57:31 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:57:31 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:57:31 INFO - Running setup.py install for mozleak 16:57:31 INFO - Running setup.py install for mozlog 16:57:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:57:31 INFO - Running setup.py install for moznetwork 16:57:31 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:57:31 INFO - Running setup.py install for mozprocess 16:57:31 INFO - Running setup.py install for mozprofile 16:57:31 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:57:31 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:57:31 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:57:31 INFO - Running setup.py install for mozrunner 16:57:32 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:57:32 INFO - Running setup.py install for mozscreenshot 16:57:32 INFO - Running setup.py install for moztest 16:57:32 INFO - Running setup.py install for mozversion 16:57:32 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:57:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:57:32 INFO - Cleaning up... 16:57:32 INFO - Return code: 0 16:57:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:32 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 0x7f8ad5921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24446d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d3920>, '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 0x24d4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', '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 16:57:32 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 16:57:32 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 16:57:32 INFO - Using env: {'DISPLAY': ':0', 16:57:32 INFO - 'HOME': '/home/cltbld', 16:57:32 INFO - 'LANG': 'en_US.UTF-8', 16:57:32 INFO - 'LANGUAGE': 'en_US:en', 16:57:32 INFO - 'LOGNAME': 'cltbld', 16:57:32 INFO - 'MAIL': '/var/mail/cltbld', 16:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:32 INFO - 'MOZ_NO_REMOTE': '1', 16:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:32 INFO - 'NO_EM_RESTART': '1', 16:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:57:32 INFO - 'PWD': '/builds/slave/test-pgo', 16:57:32 INFO - 'SHELL': '/bin/bash', 16:57:32 INFO - 'SHLVL': '1', 16:57:32 INFO - 'TERM': 'linux', 16:57:32 INFO - 'TMOUT': '86400', 16:57:32 INFO - 'USER': 'cltbld', 16:57:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', 16:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:32 INFO - '_': '/tools/buildbot/bin/python'} 16:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:57:32 INFO - Running setup.py (path:/tmp/pip-3dno8Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:57:32 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)) 16:57:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:57:32 INFO - Running setup.py (path:/tmp/pip-wyVWmV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:57:32 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)) 16:57:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:57:32 INFO - Running setup.py (path:/tmp/pip-ZswOk2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:57:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:57:32 INFO - Running setup.py (path:/tmp/pip-O1200v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:57:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:57:32 INFO - Running setup.py (path:/tmp/pip-LlIkCA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 16:57:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:57:32 INFO - Running setup.py (path:/tmp/pip-8oNiaf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 16:57:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:57:32 INFO - Running setup.py (path:/tmp/pip-zZk7DR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:57:33 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)) 16:57:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:57:33 INFO - Running setup.py (path:/tmp/pip-QvXHZB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:57:33 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)) 16:57:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:57:33 INFO - Running setup.py (path:/tmp/pip-CUfRvb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:57:33 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)) 16:57:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:57:33 INFO - Running setup.py (path:/tmp/pip-b6QCqk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:57:33 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)) 16:57:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:57:33 INFO - Running setup.py (path:/tmp/pip-kJNJKZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:57:33 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)) 16:57:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:57:33 INFO - Running setup.py (path:/tmp/pip-w8fXH_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:57:33 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)) 16:57:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:57:33 INFO - Running setup.py (path:/tmp/pip-V6hEim-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:57:33 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)) 16:57:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:57:33 INFO - Running setup.py (path:/tmp/pip-RvckEI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:57:33 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)) 16:57:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:57:33 INFO - Running setup.py (path:/tmp/pip-BV1CwM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:57:33 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)) 16:57:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:57:33 INFO - Running setup.py (path:/tmp/pip-YsuX7R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:57:33 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)) 16:57:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:57:33 INFO - Running setup.py (path:/tmp/pip-9QjOW4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 16:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:57:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:35 INFO - Downloading blessings-1.6.tar.gz 16:57:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:57:35 INFO - Installing collected packages: blessings 16:57:35 INFO - Running setup.py install for blessings 16:57:35 INFO - Successfully installed blessings 16:57:35 INFO - Cleaning up... 16:57:35 INFO - Return code: 0 16:57:35 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:57:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:57:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:57:36 INFO - Reading from file tmpfile_stdout 16:57:36 INFO - Current package versions: 16:57:36 INFO - argparse == 1.2.1 16:57:36 INFO - blessings == 1.6 16:57:36 INFO - blobuploader == 1.2.4 16:57:36 INFO - docopt == 0.6.1 16:57:36 INFO - manifestparser == 1.1 16:57:36 INFO - mozInstall == 1.12 16:57:36 INFO - mozcrash == 0.17 16:57:36 INFO - mozdebug == 0.1 16:57:36 INFO - mozdevice == 0.48 16:57:36 INFO - mozfile == 1.2 16:57:36 INFO - mozhttpd == 0.7 16:57:36 INFO - mozinfo == 0.9 16:57:36 INFO - mozleak == 0.1 16:57:36 INFO - mozlog == 3.1 16:57:36 INFO - moznetwork == 0.27 16:57:36 INFO - mozprocess == 0.22 16:57:36 INFO - mozprofile == 0.28 16:57:36 INFO - mozrunner == 6.11 16:57:36 INFO - mozscreenshot == 0.1 16:57:36 INFO - mozsystemmonitor == 0.0 16:57:36 INFO - moztest == 0.7 16:57:36 INFO - mozversion == 1.4 16:57:36 INFO - psutil == 3.1.1 16:57:36 INFO - requests == 1.2.3 16:57:36 INFO - wsgiref == 0.1.2 16:57:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:57:36 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')]} 16:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:36 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')]} 16:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:36 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 0x7f8ad5921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24446d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d3920>, '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 0x24d4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', '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 16:57:36 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 16:57:36 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 16:57:36 INFO - Using env: {'DISPLAY': ':0', 16:57:36 INFO - 'HOME': '/home/cltbld', 16:57:36 INFO - 'LANG': 'en_US.UTF-8', 16:57:36 INFO - 'LANGUAGE': 'en_US:en', 16:57:36 INFO - 'LOGNAME': 'cltbld', 16:57:36 INFO - 'MAIL': '/var/mail/cltbld', 16:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:36 INFO - 'MOZ_NO_REMOTE': '1', 16:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:36 INFO - 'NO_EM_RESTART': '1', 16:57:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:57:36 INFO - 'PWD': '/builds/slave/test-pgo', 16:57:36 INFO - 'SHELL': '/bin/bash', 16:57:36 INFO - 'SHLVL': '1', 16:57:36 INFO - 'TERM': 'linux', 16:57:36 INFO - 'TMOUT': '86400', 16:57:36 INFO - 'USER': 'cltbld', 16:57:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', 16:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:36 INFO - '_': '/tools/buildbot/bin/python'} 16:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:36 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)) 16:57:36 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)) 16:57:36 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)) 16:57:36 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)) 16:57:36 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)) 16:57:36 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)) 16:57:36 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)) 16:57:36 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)) 16:57:36 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)) 16:57:36 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)) 16:57:36 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)) 16:57:36 INFO - Cleaning up... 16:57:36 INFO - Return code: 0 16:57:36 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:57:36 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')]} 16:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:36 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')]} 16:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:36 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 0x7f8ad5921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24446d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d3920>, '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 0x24d4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', '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 16:57:36 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 16:57:36 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 16:57:36 INFO - Using env: {'DISPLAY': ':0', 16:57:36 INFO - 'HOME': '/home/cltbld', 16:57:36 INFO - 'LANG': 'en_US.UTF-8', 16:57:36 INFO - 'LANGUAGE': 'en_US:en', 16:57:36 INFO - 'LOGNAME': 'cltbld', 16:57:36 INFO - 'MAIL': '/var/mail/cltbld', 16:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:36 INFO - 'MOZ_NO_REMOTE': '1', 16:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:36 INFO - 'NO_EM_RESTART': '1', 16:57:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:57:36 INFO - 'PWD': '/builds/slave/test-pgo', 16:57:36 INFO - 'SHELL': '/bin/bash', 16:57:36 INFO - 'SHLVL': '1', 16:57:36 INFO - 'TERM': 'linux', 16:57:36 INFO - 'TMOUT': '86400', 16:57:36 INFO - 'USER': 'cltbld', 16:57:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', 16:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:36 INFO - '_': '/tools/buildbot/bin/python'} 16:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:36 INFO - Downloading/unpacking jsonschema 16:57:36 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 16:57:36 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 16:57:36 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 16:57:36 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 16:57:36 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 16:57:36 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 16:57:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:57:38 INFO - Downloading/unpacking functools32 (from jsonschema) 16:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:38 INFO - Downloading functools32-3.2.3-2.tar.gz 16:57:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:57:38 INFO - warning: no files found matching '*.txt' 16:57:38 INFO - no previously-included directories found matching 'build' 16:57:38 INFO - no previously-included directories found matching 'dist' 16:57:38 INFO - no previously-included directories found matching '.git*' 16:57:38 INFO - Installing collected packages: jsonschema, functools32 16:57:38 INFO - Running setup.py install for functools32 16:57:38 INFO - warning: no files found matching '*.txt' 16:57:38 INFO - no previously-included directories found matching 'build' 16:57:38 INFO - no previously-included directories found matching 'dist' 16:57:38 INFO - no previously-included directories found matching '.git*' 16:57:38 INFO - Successfully installed jsonschema functools32 16:57:38 INFO - Cleaning up... 16:57:38 INFO - Return code: 0 16:57:38 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:57: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')]} 16:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ad5921f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24446d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d3920>, '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 0x24d4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4cb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', '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 16:57:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:57:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:57:38 INFO - Using env: {'DISPLAY': ':0', 16:57:38 INFO - 'HOME': '/home/cltbld', 16:57:38 INFO - 'LANG': 'en_US.UTF-8', 16:57:38 INFO - 'LANGUAGE': 'en_US:en', 16:57:38 INFO - 'LOGNAME': 'cltbld', 16:57:38 INFO - 'MAIL': '/var/mail/cltbld', 16:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:38 INFO - 'MOZ_NO_REMOTE': '1', 16:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:38 INFO - 'NO_EM_RESTART': '1', 16:57:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:57:38 INFO - 'PWD': '/builds/slave/test-pgo', 16:57:38 INFO - 'SHELL': '/bin/bash', 16:57:38 INFO - 'SHLVL': '1', 16:57:38 INFO - 'TERM': 'linux', 16:57:38 INFO - 'TMOUT': '86400', 16:57:38 INFO - 'USER': 'cltbld', 16:57:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', 16:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:38 INFO - '_': '/tools/buildbot/bin/python'} 16:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:39 INFO - Downloading/unpacking flake8 16:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:57:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:57:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:57:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:57:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:57:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:57:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:57:41 INFO - no previously-included directories found matching 'docs/_build' 16:57:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:57:41 INFO - Running setup.py install for pep8 16:57:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:57:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:57:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:57:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:57:41 INFO - no previously-included directories found matching 'docs/_build' 16:57:41 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:57:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:57:41 INFO - Cleaning up... 16:57:41 INFO - Return code: 0 16:57:41 INFO - Running post-action listener: _resource_record_post_action 16:57:41 INFO - Running post-action listener: _start_resource_monitoring 16:57:41 INFO - Starting resource monitoring. 16:57:41 INFO - ##### 16:57:41 INFO - ##### Running install step. 16:57:41 INFO - ##### 16:57:41 INFO - Running pre-action listener: _resource_record_pre_action 16:57:41 INFO - Running main action method: install 16:57:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:57:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:57:42 INFO - Reading from file tmpfile_stdout 16:57:42 INFO - Detecting whether we're running mozinstall >=1.0... 16:57:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:57:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:57:42 INFO - Reading from file tmpfile_stdout 16:57:42 INFO - Output received: 16:57:42 INFO - Usage: mozinstall [options] installer 16:57:42 INFO - Options: 16:57:42 INFO - -h, --help show this help message and exit 16:57:42 INFO - -d DEST, --destination=DEST 16:57:42 INFO - Directory to install application into. [default: 16:57:42 INFO - "/builds/slave/test-pgo"] 16:57:42 INFO - --app=APP Application being installed. [default: firefox] 16:57:42 INFO - mkdir: /builds/slave/test-pgo/build/application 16:57:42 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'] 16:57:42 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 16:57:58 INFO - Reading from file tmpfile_stdout 16:57:58 INFO - Output received: 16:57:58 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:57:58 INFO - Running post-action listener: _resource_record_post_action 16:57:58 INFO - ##### 16:57:58 INFO - ##### Running run-tests step. 16:57:58 INFO - ##### 16:57:58 INFO - Running pre-action listener: _resource_record_pre_action 16:57:58 INFO - Running main action method: run_tests 16:57:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:57:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:57:58 INFO - Python 2.7.3 16:57:58 INFO - Return code: 0 16:57:58 INFO - grabbing minidump binary from tooltool 16:57:58 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')]} 16:57:58 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 0x24d3920>, '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 0x24d4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:57:58 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 16:57:58 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 16:57:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:57:58 INFO - Return code: 0 16:57:58 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:57:58 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:57:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:57:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:57:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:57:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:57:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:57:59 INFO - Return code: 0 16:57:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 16:57:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 16:57:59 INFO - Using env: {'DISPLAY': ':0', 16:57:59 INFO - 'HOME': '/home/cltbld', 16:57:59 INFO - 'LANG': 'en_US.UTF-8', 16:57:59 INFO - 'LANGUAGE': 'en_US:en', 16:57:59 INFO - 'LOGNAME': 'cltbld', 16:57:59 INFO - 'MAIL': '/var/mail/cltbld', 16:57:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:57:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:59 INFO - 'MOZ_NO_REMOTE': '1', 16:57:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:59 INFO - 'NO_EM_RESTART': '1', 16:57:59 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:57:59 INFO - 'PWD': '/builds/slave/test-pgo', 16:57:59 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:57:59 INFO - 'SHELL': '/bin/bash', 16:57:59 INFO - 'SHLVL': '1', 16:57:59 INFO - 'TERM': 'linux', 16:57:59 INFO - 'TMOUT': '86400', 16:57:59 INFO - 'USER': 'cltbld', 16:57:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127', 16:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:59 INFO - '_': '/tools/buildbot/bin/python'} 16:57:59 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 16:57:59 INFO - mozversion application_buildid: 20160317142924 16:57:59 INFO - mozversion application_changeset: c138edad150faa48e0e25910d6c00e4a25d199b4 16:57:59 INFO - mozversion application_display_name: Nightly 16:57:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:57:59 INFO - mozversion application_name: Firefox 16:57:59 INFO - mozversion application_remotingname: firefox 16:57:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:57:59 INFO - mozversion application_vendor: Mozilla 16:57:59 INFO - mozversion application_version: 48.0a1 16:57:59 INFO - mozversion platform_buildid: 20160317142924 16:57:59 INFO - mozversion platform_changeset: c138edad150faa48e0e25910d6c00e4a25d199b4 16:57:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:57:59 INFO - mozversion platform_version: 48.0a1 16:57:59 INFO - using testdate: 1458259079 16:57:59 INFO - actual date: 1458259079 16:57:59 INFO - starting webserver on 'localhost:39081' 16:57:59 INFO - SUITE-START | Running 2 tests 16:57:59 INFO - TEST-START | dromaeo_css 16:57:59 INFO - operating with platform_type : linux_ 16:57:59 INFO - Initialising browser for dromaeo_css test... 16:57:59 INFO - TEST-INFO | started process 9161 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvuhRYY/profile http://localhost:39081/getInfo.html) 16:58:03 INFO - PROCESS | 9161 | __metrics Screen width/height:1600/1200 16:58:03 INFO - PROCESS | 9161 | colorDepth:24 16:58:03 INFO - PROCESS | 9161 | Browser inner width/height: 1024/697 16:58:03 INFO - PROCESS | 9161 | __metrics 16:58:05 ERROR - PROCESS | 9161 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:58:05 INFO - TEST-INFO | 9161: exit 0 16:58:05 INFO - Browser initialized. 16:58:05 INFO - Running cycle 1/1 for dromaeo_css test... 16:58:05 INFO - TEST-INFO | started process 9256 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvuhRYY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:58:17 INFO - PROCESS | 9256 | RSS: Main: 153722880 16:58:17 INFO - PROCESS | 9256 | 16:59:09 INFO - PROCESS | 9256 | 1458259149078 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:01:17 INFO - PROCESS | 9256 | Cycle 1(1): loaded http://localhost:39081/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39081/tests/dromaeo/cssquery-ext.html) 17:01:18 INFO - PROCESS | 9256 | RSS: Main: 262402048 17:01:18 INFO - PROCESS | 9256 | 17:04:20 INFO - PROCESS | 9256 | Cycle 1(1): loaded http://localhost:39081/tests/dromaeo/cssquery-ext.html (next: http://localhost:39081/tests/dromaeo/cssquery-jquery.html) 17:04:20 INFO - PROCESS | 9256 | RSS: Main: 233996288 17:04:20 INFO - PROCESS | 9256 | 17:07:22 INFO - PROCESS | 9256 | Cycle 1(1): loaded http://localhost:39081/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39081/tests/dromaeo/cssquery-mootools.html) 17:07:23 INFO - PROCESS | 9256 | RSS: Main: 237101056 17:07:23 INFO - PROCESS | 9256 | 17:10:25 INFO - PROCESS | 9256 | Cycle 1(1): loaded http://localhost:39081/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39081/tests/dromaeo/cssquery-prototype.html) 17:10:25 INFO - PROCESS | 9256 | RSS: Main: 219226112 17:10:25 INFO - PROCESS | 9256 | 17:13:28 INFO - PROCESS | 9256 | Cycle 1(1): loaded http://localhost:39081/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39081/tests/dromaeo/cssquery-yui.html) 17:13:29 INFO - PROCESS | 9256 | RSS: Main: 218206208 17:13:29 INFO - PROCESS | 9256 | 17:16:31 INFO - PROCESS | 9256 | Cycle 1(1): loaded http://localhost:39081/tests/dromaeo/cssquery-yui.html (next: http://localhost:39081/tests/dromaeo/cssquery-dojo.html) 17:16:32 INFO - PROCESS | 9256 | RSS: Main: 309006336 17:16:32 INFO - PROCESS | 9256 | 17:16:32 INFO - PROCESS | 9256 | __start_tp_report 17:16:32 INFO - PROCESS | 9256 | _x_x_mozilla_page_load 17:16:32 INFO - PROCESS | 9256 | _x_x_mozilla_page_load_details 17:16:32 INFO - PROCESS | 9256 | |i|pagename|runs| 17:16:32 INFO - PROCESS | 9256 | |0;dojo.html;3142.277276226468;3197;3206.8396580171;3223;3260.054584170591;5067.341245638071;5167.870803229921;5181.974090129549;5199.50604692554;5237.13587258102;5187.870303242421;5223.947760522394;5225.242339860727;5253.711045892474;5305.204219367097;4658.580727734503;4779.378680771503;4829.975850120744;4877.8780530486665;4883.609311255091;4672.252439609663;4753.0493901219725;4829.68607040543;4831.661783675144;4968.403791545002;4809.519048095198;4817.879553011167;4842.782074806607;4859.635527335464;4870.43989941156;4833.540813622701;4834.226523756217;4837.226043833005;4857.6599638025355;4896.975515122437;4667.15991121598;4697.318888761145;4800.567948884617;4807.399075115611;4848.5636292733825;5100.617453690951;5115.079285728568;5118.590512759008;5127.102757017507;5129.563987061104;5608.663480191201;5611.242482264883;5615.831525054255;5616;5654.943450565524;5499.065158922993;5540.279763630702;5612.130119831432;5695.971520142414;5697.088465845486;5246.317978662788;5251.448597897204;5254;5255.527002569787;5271.630985830993;5540.667559946416;5705.144228365695;5708;5708.143778433268;5725.971370143123;5560.7219639017885;5595.552355811526;5604.60767746262;5610.326760788732;5655.264815573949;5607.271054762855;5619.522340601095;5620.5503559715125;5621.016322143609;5621.522170615462;5473.781048758085;5564.387917329091;5568.805091821767;5569.66582005081;5590.965671350813;5560.7219639018695;5591.580631452657;5594.384617692051;5607.551395888319;5646.040173170571;4325.134973005349;4330.2205602991135;4331.177076355482;4336.3278691802825;4370.541093185233;3769.208466222069;3879.0690234343556;3901.8634347797692;3924.6467817895955;3946.6842652587725;5195.2986346843445;5208.348956380452;5215.061288967946;5217.921731174036;5226.660267082703;5661.264035675418;5664.065429204217;5666.631668941505;5675.5459563234845;5687.203791469197;5045.041442125985;5147.047796157648;5215.947840521622;5218.6868787872845;5235.973820130875;4769.952300476951;4772.212584923449;4776.116418462596;4799.472058073609;4812;5792.739326730307;5818.069108942634;5819.272590926134;5821.679807610537;5825.592208545446;5467.890642187054;5608.383077861514;5623.522000629992;5697.373288938296;5702.144678298288;5799.971000145141;5824.301083869963;5830.18377427169;5849.736761845642;5854.619449735754;5604.103343465189;5607.243022191952;5609.915851262316;5612.915806262828;5613.971930140323;5429.647072940246;5636.661800291996;5674.007048766367;5736.42635736423;5741.712914354349;5415.918761218663;5425.864353391197;5446.291982042309;5449.754761035683;5454.372747133972;5272.7100009499845;5389.676619402691;5459.07195776711;5475.06923822959;5487.972560137174;5351.438098999549;5412.43169467216;5428.972855135699;5435.130379139318;5452.318460192476;5392.406835248041;5435.782568697208;5436.103042998019;5471.343438787371;5473.042217611982;5272.130098533699;5356.196570514298;5368;5368.141097424394;5369.4630536946 17:16:32 INFO - PROCESS | 9256 | |1;ext.html;531.2297169104797;544.5888354292508;565.6295126692015;572.9140628905665;591.7278052096033;36782.26435471289;37630.4355434668;37652.811735941315;37658.246835063284;37749;39638.20723585527;39946;40134.39798403026;40178.59821401785;40222.59777402225;8490.490570565786;8698.173673501007;8701.695440659578;8704.347173961947;8706.695265665703;8503.489790612552;8554.35842311826;8633.223009929105;8837.469751814911;8842.823143537125;8827.205551500363;8911.598978046004;8920.955395223014;8928.642854285821;8936.106389361077;8732.345074119436;8803.383763136582;8808;8811.030786613468;8812.823743525158;8696.130386961253;8800.647974081028;8812.779680508038;8817.515036672981;8824.69113581028;40712.592874071175;41096.79451602723;41166.588334116874;41185.588144118476;41229.38155927663;3465.047112044183;3796.620337966209;3834.9041273968096;4068.5524592294823;4153.7507749535125;30946.381072378652;31062;31226.53160202599;31514;32211.51682724761;3316.7346612271203;3335.933281334384;3341.5154802553493;3361.798292102482;3443.3113377324635;288452;289056;289246.9999999979;289883;290303;58474.7076264616;59321.40678593245;59367.70316148478;59385;59394.10908836284;62656;67947.3205267941;69239.30760692329;69276.307236928;69381.65309173422;15273.159976201416;15321.6169595761;15375.461858835111;15375.538733838002;15431.38274469031;12720.173188742701;12730.490780368682;12800;12830.80753788694;12866.614001579968;20106.59786804285;20423.489412764502;21185.576288474145;21203.15187392518;21231.893840531007;8008.7597372078935;8013;8138.755837324889;8157.306628936607;8216.424850260424;935.209747763139;939.68050862707;1002.7192386131894;1037.5382954585136;1049.6746008737316;27664;28543.14370568886;28636;28952.565711514344;29137.56293655597;1043.2175868098925;1057.5716834681966;1073.7154654016692;1076.4025965589174;1125.763589646167;14737.557873263819;15136.394544218108;15152.393904243927;15324.693506130037;15436.614084647974;336241.2315568992;338179;338763;339627;339868;52402;52958;52985.2052219217;53011.73494132505;53041.2043819343;1205.3370646144585;1305.0864394923592;1317.9934100329629;1326.2970625568657;1335.9666008349675;28000.29999250035;29409.411811764072;29426.411471770018;29833.10500684983;29856.85071574628;42794.78602607091;43444.782776085915;43525;43527;43535.78232108946;238736;248084;248246;248737;249210;28190.71809281881;31920.201994950312;32129.196770080936;32858.67141328556;32861.50707739338;39861.60138398579;40610.593894061865;40866.591334086275;41615.79192104141;41871;36936.630633694396;37076.258474830895;37483.43774843434;37506.437403438424;37590.43614345732;35839.82080089583;35936.640633594376;36733.26533469262;36816.81591592025;37327.81336093302;35706.64293357137;36529.086772830895;36742;36992.44511332386;38691;31150.84424577953;33219.33561328808;33635.49546756849;33816.83091584526;33895.3220935575;25211;25694.486110278063;25745.613815793153;25841;25994.35014124662 17:16:32 INFO - PROCESS | 9256 | |2;jquery.html;344.3045049001018;356.0931213352499;357.1749259211222;365.2257214704826;366.7707682698312;16746.91626541867;16904.1547922604;18400.447986560426;18410.079496025195;18433.44699659009;16697.33210671575;17099.74350384742;17175.312987480487;17180.914095429536;17183.570410739707;5285.709285989278;5391.460853914617;5587.832365029035;5588.91616625751;5603.439656034405;3971.0866500704856;5540.612157149001;5831.387704291052;6074.5747797654185;6100.664463454508;6022.698865056752;6023.909641355362;6034.69826508675;6065.878682426349;6068.271807383098;5777.306723193223;5888.676122813244;5898.026825573776;5908.615939963888;5909.409059094078;3647.854085836563;5028.4971502849785;5213.348331458567;5286.841394758163;5286.894262114774;19823.30618428348;20076.196952121896;20129.698054529195;21235.787642123534;21419.250326238507;2278.1456953642382;2366.396568874943;2459.692538432696;2720.3743139077924;2829.405824776779;12947.741045179138;13106.541271055563;13252.86747132526;13452.461901524026;13817.654558636013;1860.8325250727364;1878.1829903991807;1886.2549293029315;1886.8584856135844;1934.516370907273;62397;62399.064014039825;63358.36641633571;64031.67984160096;64119.03821442682;9711;9880.703578892644;10111.7472063199;10188.490575471196;10296.176305895511;13450;13536;13545.458181672622;13555.66110847217;13558.322083895962;7519.511231769918;7785.961070194613;7929;7945.808128780729;8054.677812887536;7811.062672479339;7874.094479134858;7967.2431119043595;8013.19868013194;8013.358931285483;5952.10718392236;6071.210742603522;6091.51267898567;6098.451139397475;6177.289611694623;1637.6560922206231;1708.735146052364;1751.3169863753146;1798.856091512676;1815.4553633909775;864.6671031652859;947.9099485548862;952.3952290295712;1015.2537884654773;1037.569408695383;16724.49826505207;16875.915620422064;17603.911980440014;17826.46520604384;18131.093445327682;934.6773268427951;937.9718608441758;939.736873675372;944.2304521814699;972.5623469438781;9734.610615575297;9797.657082002095;10001.199904007663;10039.899601004043;10146.137578305927;449271;450894;467988;468646;470608;80919.59540202378;81290;82528;82652.58673706593;82725;1031.6440827914357;1044.8454457824148;1075.6181555547823;1085.5549224817787;1093.6172339681048;15373.23133843281;15457.227138642798;15502.379904803682;15534.922325388301;15884.126373049594;33807.15482112967;33820.3235935275;34554.65445345514;34760.30479390347;35728.464073039446;49989.250161246884;50188;50207.49792502028;50292.74853625709;50866;8049.356051515748;8186.426950113435;8260.339172866277;8296.543690097102;8549.658013679384;12554.372281385711;12601;12615.81076283838;12642.620721378373;12715.427805748579;10720.571177153139;10732.731681707708;10793.136549075898;10972.067374273276;11213.831792522955;4973.378327709036;8797.12028797115;9734.318597698377;10870;11004.174686898354;5577.191307260506;8219.383546234176;9576.904230957602;11042.779144417227;11300.60447884353;8180.631871565674;8307.667693292442;8391;8433.915660843559;8505.82988340242;8855.91144088551;10698.251122421356;11357.659270221906;11645.41772911368;11747.706307342385 17:16:32 INFO - PROCESS | 9256 | |3;mootools.html;1323.206076354187;1455.9272036398181;1458.496818597584;1626.6584017356354;1795.9730604040933;6671.833204169892;7576.924230757698;7755.37956963443;7760.650770715317;7765.301122898938;7550.471466997313;7730.884036739453;7732.690692372298;7743.457957942932;7745;1972.2899756087797;1991.312997016027;2264.5923733727923;2267.6938613287243;2292.8165746740306;2350.189184731265;2357.834951553392;2358.1274928276475;2359.8230132740027;2363.1847012780563;2161.2111579273533;2208.8895555222257;2216.756156822756;2237.776222377757;2241.2267767620147;1993.2425678242248;2252.718410198725;2288.0390236100793;2300.1719381022817;2301.252093069759;2251.6735073414425;2278.1343089626002;2282.1441959265276;2282.8173746100274;2287.4738810073777;7616.23837616234;7653.732119375851;7663.157052724252;7675.961620191919;7679.57762323072;4691.483936766953;4769.952300476985;4780.928286075677;4783;4792.544708252711;3137.247060705437;3176.0948129783133;3279.1310302769784;3280.0815771583993;3291.6872897074977;1005.3612611443374;1014.7361685961703;1047.1099565369452;1048.8007278617038;1050.2543194332034;10953.83569246462;11000.504977276041;11002.174836887265;11022.614208502664;11025.44872756359;4326.286162783168;4465.017696106851;4520.95479045212;4541.523140070245;4563.475200351935;9349.252059835197;9374.484403357745;9377.765555861159;9387.57755900986;9393.342466027449;4921.5078492151215;4959.181735013754;4964.975175124174;4969.453360130383;4970.950290497121;3855.094052897567;4332.241857674894;4441.644668426518;4489;4489.147062058264;3706.9073273168387;3749.5875453700073;3749.887503374903;3782.111203867089;3803.6006219347123;1187.8277649740912;1195.0320240605138;1202.903767698582;1217.6286232699113;1227.7421741434398;1095.2771171027243;1106.093003736928;1110.211749657736;1243.247835059794;1331.6937104465833;7461.813454663677;7536.623168841536;7555.508891922117;7574;7581.924180758232;496.1045313209619;508.351851389474;509.6483426435747;511.82597916707755;513.4070148977936;5489.066858634042;5504.284443022461;5508.586855985737;5510.201020851954;5532.5573954083575;9003.819923601492;9154.40496367734;9157.221636160868;9169.495677737656;9184.8622270666;9198.356115072014;9231.769205769775;9253.213476854542;9266.768330791649;9309.48797816113;7262.31008054234;7286.271372862671;7341.486095973338;7472.70109195637;7485.25147485258;7394.408447324094;7426.777196684108;7445.181030086578;7455.403567714461;7596;8385.95807020961;8488.363372746946;8560.571971401281;8757.90526184227;8779;8674.262687671619;8864;8868.379213454997;8999.415038022507;9027.684031058881;6523.608583485006;7127.643617819192;7279.745208917662;7562.432817538596;7691.653875575501;7544.735934242275;7575;7600.657970391456;7637.809054773675;7645.732399365996;6769.323067693388;6780.694868731018;6926.06498122747;7004.509684322048;7015.789526314219;6692.531522793358;6727.260001399744;6806.489513286424;6864.862702746017;6890.173179218526;6865.588064715933;7055.400290975119;7086.220515743161;7130.964345178241;7132.358087772125;6515.869682606227;6530.151080359523;6563.113979612691;6565.540412171103;6572.079908812866;6526.575772574767;6580.407763301326;6596.109525214035;6617.66911654425;6619.470442364695 17:16:32 INFO - PROCESS | 9256 | |4;prototype.html;332.6756412497815;333.0109574563547;336.5876800918875;341.55938838897805;342.5854715793889;5824.912626310604;5858.502027327677;5862.384449632791;5870.00209964306;5894.705264736767;5774.5091667208335;5789.160571717099;5800.100984347433;5806.477417032466;5816.360200377966;4308.784560771973;4401.60385565299;4454.57681520255;4494.68537202396;4505.166544189336;4493.595576398124;4507.1211113832815;4529.614982726473;4535.909281814362;4544.568266014723;4279.7218180818145;4498.955010449887;4499.61753250974;4502.212112880233;4505.909881802362;4403.075354175611;4497.730136191806;4506.211413002711;4509.255972764523;4524.11779702958;3944.073142811437;3951.9802400988096;3952.8418863245724;3954.762714237126;3971.6822654187595;5512.91730624041;5518;5519.889602207933;5520;5528.391876893538;5210;5211.661242019257;5212.739363031833;5217.113090774539;5222.112240919015;6142.907856382158;6215.160953271341;6218.844528886769;6224.906626400608;6225.875482490324;4123.9381409278885;4240.342746874208;4257.254980378452;4266;4401.361802538614;6368.681565921685;6388.073729309271;6423.164988551505;6424.196975378078;6429.6142231466265;4330.610245077895;4338.739675619473;4338.76136812472;4343.0662407581885;4351.0645211279725;4393.692441529126;4397.428334316518;4402.933955990663;4403.867883963486;4405.03089320349;5097.286379906816;5098.439171691111;5106.617003724736;5112.795488180431;5113.258577506241;6102.8169154924535;6160.1375807387;6188.164597779332;6205.441510264098;6240.344763799826;1527.0990115831712;1538.6614944712146;1542.0593438002809;1545.99510318294;1550.2248875562218;961.9663311784054;1006.1598565198142;1038.9896101038894;1041.6458404142627;1041.7239431550645;5714.085746280658;5718.599698021182;5782.161586569924;5785.132230165509;5785.71071446426;6242.563020588515;6303.180586523814;6320.399562041599;6321.209848768904;6330.145430366933;5775.075987841925;5779.653220806681;5783.826485205451;5789.363170051291;5790.681512516852;3364.8485818138242;3401.9319613608086;3402.6767457091537;3402.897913062612;3403.0471467989005;6469.159009328851;6562.245341785756;6637.535372523877;6639.966800165968;6651.833704157435;6506.512011599054;6524.641144737085;6524.6737663116655;6595.439387652007;6604.96697516519;6705.798826035129;6706.463482921355;6707.3292670732535;6711.161104861892;6713.597184168965;6426.678666066771;6434.742610295536;6437.291897891135;6440.259370172303;6444.806655800334;6189.319174890848;6346.492280617632;6352.36476352361;6360.681965901594;6370.936290637034;6666.899996500153;6682.498812589172;6689.632070236184;6690.933090669226;6694.230163531256;4514.255147900691;4548.044910568818;4552.88617784558;4557.430321209848;4558.179527685049;6348.523860710373;6355.269144048493;6356.2054743157105;6361.695852350164;6362.491000719839;6032.366601506954;6141;6162.568620196544;6164.938350616616;6165.784197553064;6101.969490152521;6168.383161683796;6178.351273116258;6240.875182496416;6241.032639940817;6043.123747056564;6055.091736239423;6060.303065147388;6069.484093852072;6070.362611925684;6170.167027451236;6181.320054794059;6188.752449901954;6191.071339299141;6192;5852.7658893643775;5952.136940143741;6035.6076855004285;6039.214902062704;6081.148639190428 17:16:32 INFO - PROCESS | 9256 | |5;yui.html;691.5850489706177;749.1459735901074;754.3399525415261;758.7913323835941;767.3017554025835;12832.037597180226;12898.871011289884;13087.934560327198;13126.47494100236;14021.929890350546;13315.20108793473;13329.800052999188;13401;13461.865381346184;13500.459981600749;676.4892506157844;809.114020147937;818.54161669465;820.1019883227856;820.4912953968518;681.0227323790376;684.0389253099403;684.2199892122984;807.7172989453703;827.5448503323179;848.6435697007241;854.9700760473385;861.5218553702692;861.9525926074064;862.3101518784978;845.4631309118754;849.3969281809923;852.1350828908662;855.6149732620314;856.5503110866782;512.3569919750727;627.7645882793952;629.361198383641;633.607163558592;637.5728262064428;12882.484700611963;12964.416601252966;13076.476940922446;13079.542216022393;13083.149595276276;12344.876551234553;12575.622731318075;13166.934165329112;13308.401121949439;13444.5294414696;10174.745631359201;10266.589336426534;10328.380297182193;10379;10385.196374622377;3688.0595448160816;3722.571904231021;3794.5636251831115;3798.734088613798;3799.9620003799882;49637.25544116841;49933.75033124848;49973.25040124401;50002.49997500015;50004.749976249885;9711.66009189675;9846;9879.851802222973;10107.69676909694;10207.701493432232;19080.427587172406;19106;19106.044697765057;19138.425847224604;19147.425577232705;7804.375649948104;7808.453408261367;7843;7894.368450524059;7899.684012639545;4186.120914607966;4399.472063352418;4448.7108337957925;4456.821727130879;4460.598546130864;3055.220918665726;3067.647220569663;3093.8453077346044;3094.9381012380077;3125.4999200127872;583.1049339264293;586.8239528141626;588.1824264272665;588.8586739182565;591.819495054004;549.1076999875203;562.6258538072218;567.9719707329747;580.9186713860063;588.6056342250703;7729.149793522708;7779.144294127642;7796.986391769034;7979.20207979209;8004.279614834692;567.5771550195132;575.8358867722679;587.9029960056629;600.5075837812951;608.3065305551675;3564.8395822188063;3618.6743193112748;3620.3161037171913;3751.306008388457;3765.4916586260506;54545.45454545483;55156.724216379465;55183.17225241625;55332.44667553354;55345.44654553403;48623;49121.263181051596;50399.24401133986;51051;51142.74428627833;44408.77795611001;44823.77588112038;45093.77453112779;45430.091398171855;46055.30917036314;7094.290570942864;7103.218645949045;7143.107111611049;7253.093363329584;7281.089863767029;34996.47505287372;35230.295394092485;35561.288774224886;35790.28419431649;36146.27707445784;40175;40446;42325.57674423217;43011.569884300756;43171.78414107909;9208.263338932735;9326.393784403992;9341.626334946526;9405.106514881076;9907.504624768877;9982.550785214828;10104.494775261355;10121.544530495998;10393.84409233847;10764.946175269073;9149.588268528065;9400.811983760423;9643.395278754517;9888;9924.877995284278;9339;9363.812723745623;9447.191011235955;9611.807763844823;9624.230061594915;9067.2984466541;9395.624175032923;9652.420854748738;9683.757906052124;9684.56419461112;7882.251186137308;8082;8314.79213019655;8405.32757379396;8455;8017.559034253172;8090.393220508603;8151.575018117855;8237.79405514867;8431.915680843113 17:16:32 INFO - PROCESS | 9256 | __end_tp_report 17:16:32 INFO - PROCESS | 9256 | __start_cc_report 17:16:32 INFO - PROCESS | 9256 | _x_x_mozilla_cycle_collect,876 17:16:32 INFO - PROCESS | 9256 | __end_cc_report 17:16:32 INFO - PROCESS | 9256 | __startTimestamp1458260192222__endTimestamp 17:16:32 INFO - PROCESS | 9256 | 17:16:32 INFO - PROCESS | 9256 | ------- Summary: start ------- 17:16:32 INFO - PROCESS | 9256 | Number of tests: 6 17:16:32 INFO - PROCESS | 9256 | 17:16:32 INFO - PROCESS | 9256 | [#0] dojo.html Cycles:165 Average:5211.91 Median:5389.68 stddev:563.87 (10.5%) stddev-sans-first:541.72 17:16:32 INFO - PROCESS | 9256 | Values: 3142.3 3197.0 3206.8 3223.0 3260.1 5067.3 5167.9 5182.0 5199.5 5237.1 5187.9 5223.9 5225.2 5253.7 5305.2 4658.6 4779.4 4830.0 4877.9 4883.6 4672.3 4753.0 4829.7 4831.7 4968.4 4809.5 4817.9 4842.8 4859.6 4870.4 4833.5 4834.2 4837.2 4857.7 4897.0 4667.2 4697.3 4800.6 4807.4 4848.6 5100.6 5115.1 5118.6 5127.1 5129.6 5608.7 5611.2 5615.8 5616.0 5654.9 5499.1 5540.3 5612.1 5696.0 5697.1 5246.3 5251.4 5254.0 5255.5 5271.6 5540.7 5705.1 5708.0 5708.1 5726.0 5560.7 5595.6 5604.6 5610.3 5655.3 5607.3 5619.5 5620.6 5621.0 5621.5 5473.8 5564.4 5568.8 5569.7 5591.0 5560.7 5591.6 5594.4 5607.6 5646.0 4325.1 4330.2 4331.2 4336.3 4370.5 3769.2 3879.1 3901.9 3924.6 3946.7 5195.3 5208.3 5215.1 5217.9 5226.7 5661.3 5664.1 5666.6 5675.5 5687.2 5045.0 5147.0 5215.9 5218.7 5236.0 4770.0 4772.2 4776.1 4799.5 4812.0 5792.7 5818.1 5819.3 5821.7 5825.6 5467.9 5608.4 5623.5 5697.4 5702.1 5800.0 5824.3 5830.2 5849.7 5854.6 5604.1 5607.2 5609.9 5612.9 5614.0 5429.6 5636.7 5674.0 5736.4 5741.7 5415.9 5425.9 5446.3 5449.8 5454.4 5272.7 5389.7 5459.1 5475.1 5488.0 5351.4 5412.4 5429.0 5435.1 5452.3 5392.4 5435.8 5436.1 5471.3 5473.0 5272.1 5356.2 5368.0 5368.1 5369.5 17:16:32 INFO - PROCESS | 9256 | 17:16:32 INFO - PROCESS | 9256 | [#1] ext.html Cycles:180 Average:46525.97 Median:36799.54 stddev:76854.80 (208.8%) stddev-sans-first:76992.81 17:16:32 INFO - PROCESS | 9256 | Values: 531.2 544.6 565.6 572.9 591.7 36782.3 37630.4 37652.8 37658.2 37749.0 39638.2 39946.0 40134.4 40178.6 40222.6 8490.5 8698.2 8701.7 8704.3 8706.7 8503.5 8554.4 8633.2 8837.5 8842.8 8827.2 8911.6 8921.0 8928.6 8936.1 8732.3 8803.4 8808.0 8811.0 8812.8 8696.1 8800.6 8812.8 8817.5 8824.7 40712.6 41096.8 41166.6 41185.6 41229.4 3465.0 3796.6 3834.9 4068.6 4153.8 30946.4 31062.0 31226.5 31514.0 32211.5 3316.7 3335.9 3341.5 3361.8 3443.3 288452.0 289056.0 289247.0 289883.0 290303.0 58474.7 59321.4 59367.7 59385.0 59394.1 62656.0 67947.3 69239.3 69276.3 69381.7 15273.2 15321.6 15375.5 15375.5 15431.4 12720.2 12730.5 12800.0 12830.8 12866.6 20106.6 20423.5 21185.6 21203.2 21231.9 8008.8 8013.0 8138.8 8157.3 8216.4 935.2 939.7 1002.7 1037.5 1049.7 27664.0 28543.1 28636.0 28952.6 29137.6 1043.2 1057.6 1073.7 1076.4 1125.8 14737.6 15136.4 15152.4 15324.7 15436.6 336241.2 338179.0 338763.0 339627.0 339868.0 52402.0 52958.0 52985.2 53011.7 53041.2 1205.3 1305.1 1318.0 1326.3 1336.0 28000.3 29409.4 29426.4 29833.1 29856.9 42794.8 43444.8 43525.0 43527.0 43535.8 238736.0 248084.0 248246.0 248737.0 249210.0 28190.7 31920.2 32129.2 32858.7 32861.5 39861.6 40610.6 40866.6 41615.8 41871.0 36936.6 37076.3 37483.4 37506.4 37590.4 35839.8 35936.6 36733.3 36816.8 37327.8 35706.6 36529.1 36742.0 36992.4 38691.0 31150.8 33219.3 33635.5 33816.8 33895.3 25211.0 25694.5 25745.6 25841.0 25994.4 17:16:32 INFO - PROCESS | 9256 | 17:16:32 INFO - PROCESS | 9256 | [#2] jquery.html Cycles:180 Average:26533.04 Median:366.00 stddev:75735.67 (20692.9%) stddev-sans-first:75922.60 17:16:32 INFO - PROCESS | 9256 | Values: 344.3 356.1 357.2 365.2 366.8 16746.9 16904.2 18400.4 18410.1 18433.4 16697.3 17099.7 17175.3 17180.9 17183.6 5285.7 5391.5 5587.8 5588.9 5603.4 3971.1 5540.6 5831.4 6074.6 6100.7 6022.7 6023.9 6034.7 6065.9 6068.3 5777.3 5888.7 5898.0 5908.6 5909.4 3647.9 5028.5 5213.3 5286.8 5286.9 19823.3 20076.2 20129.7 21235.8 21419.3 2278.1 2366.4 2459.7 2720.4 2829.4 12947.7 13106.5 13252.9 13452.5 13817.7 1860.8 1878.2 1886.3 1886.9 1934.5 62397.0 62399.1 63358.4 64031.7 64119.0 9711.0 9880.7 10111.7 10188.5 10296.2 13450.0 13536.0 13545.5 13555.7 13558.3 7519.5 7786.0 7929.0 7945.8 8054.7 7811.1 7874.1 7967.2 8013.2 8013.4 5952.1 6071.2 6091.5 6098.5 6177.3 1637.7 1708.7 1751.3 1798.9 1815.5 864.7 947.9 952.4 1015.3 1037.6 16724.5 16875.9 17603.9 17826.5 18131.1 934.7 938.0 939.7 944.2 972.6 9734.6 9797.7 10001.2 10039.9 10146.1 449271.0 450894.0 467988.0 468646.0 470608.0 80919.6 81290.0 82528.0 82652.6 82725.0 1031.6 1044.8 1075.6 1085.6 1093.6 15373.2 15457.2 15502.4 15534.9 15884.1 33807.2 33820.3 34554.7 34760.3 35728.5 49989.3 50188.0 50207.5 50292.7 50866.0 8049.4 8186.4 8260.3 8296.5 8549.7 12554.4 12601.0 12615.8 12642.6 12715.4 10720.6 10732.7 10793.1 10972.1 11213.8 4973.4 8797.1 9734.3 10870.0 11004.2 5577.2 8219.4 9576.9 11042.8 11300.6 8180.6 8307.7 8391.0 8433.9 8505.8 8855.9 10698.3 11357.7 11645.4 11747.7 17:16:32 INFO - PROCESS | 9256 | 17:16:32 INFO - PROCESS | 9256 | [#3] mootools.html Cycles:180 Average:5497.87 Median:6519.74 stddev:2880.95 (44.2%) stddev-sans-first:2871.95 17:16:32 INFO - PROCESS | 9256 | Values: 1323.2 1455.9 1458.5 1626.7 1796.0 6671.8 7576.9 7755.4 7760.7 7765.3 7550.5 7730.9 7732.7 7743.5 7745.0 1972.3 1991.3 2264.6 2267.7 2292.8 2350.2 2357.8 2358.1 2359.8 2363.2 2161.2 2208.9 2216.8 2237.8 2241.2 1993.2 2252.7 2288.0 2300.2 2301.3 2251.7 2278.1 2282.1 2282.8 2287.5 7616.2 7653.7 7663.2 7676.0 7679.6 4691.5 4770.0 4780.9 4783.0 4792.5 3137.2 3176.1 3279.1 3280.1 3291.7 1005.4 1014.7 1047.1 1048.8 1050.3 10953.8 11000.5 11002.2 11022.6 11025.4 4326.3 4465.0 4521.0 4541.5 4563.5 9349.3 9374.5 9377.8 9387.6 9393.3 4921.5 4959.2 4965.0 4969.5 4971.0 3855.1 4332.2 4441.6 4489.0 4489.1 3706.9 3749.6 3749.9 3782.1 3803.6 1187.8 1195.0 1202.9 1217.6 1227.7 1095.3 1106.1 1110.2 1243.2 1331.7 7461.8 7536.6 7555.5 7574.0 7581.9 496.1 508.4 509.6 511.8 513.4 5489.1 5504.3 5508.6 5510.2 5532.6 9003.8 9154.4 9157.2 9169.5 9184.9 9198.4 9231.8 9253.2 9266.8 9309.5 7262.3 7286.3 7341.5 7472.7 7485.3 7394.4 7426.8 7445.2 7455.4 7596.0 8386.0 8488.4 8560.6 8757.9 8779.0 8674.3 8864.0 8868.4 8999.4 9027.7 6523.6 7127.6 7279.7 7562.4 7691.7 7544.7 7575.0 7600.7 7637.8 7645.7 6769.3 6780.7 6926.1 7004.5 7015.8 6692.5 6727.3 6806.5 6864.9 6890.2 6865.6 7055.4 7086.2 7131.0 7132.4 6515.9 6530.2 6563.1 6565.5 6572.1 6526.6 6580.4 6596.1 6617.7 6619.5 17:16:32 INFO - PROCESS | 9256 | 17:16:32 INFO - PROCESS | 9256 | [#4] prototype.html Cycles:180 Average:5167.73 Median:5795.39 stddev:1558.06 (26.9%) stddev-sans-first:1519.58 17:16:32 INFO - PROCESS | 9256 | Values: 332.7 333.0 336.6 341.6 342.6 5824.9 5858.5 5862.4 5870.0 5894.7 5774.5 5789.2 5800.1 5806.5 5816.4 4308.8 4401.6 4454.6 4494.7 4505.2 4493.6 4507.1 4529.6 4535.9 4544.6 4279.7 4499.0 4499.6 4502.2 4505.9 4403.1 4497.7 4506.2 4509.3 4524.1 3944.1 3952.0 3952.8 3954.8 3971.7 5512.9 5518.0 5519.9 5520.0 5528.4 5210.0 5211.7 5212.7 5217.1 5222.1 6142.9 6215.2 6218.8 6224.9 6225.9 4123.9 4240.3 4257.3 4266.0 4401.4 6368.7 6388.1 6423.2 6424.2 6429.6 4330.6 4338.7 4338.8 4343.1 4351.1 4393.7 4397.4 4402.9 4403.9 4405.0 5097.3 5098.4 5106.6 5112.8 5113.3 6102.8 6160.1 6188.2 6205.4 6240.3 1527.1 1538.7 1542.1 1546.0 1550.2 962.0 1006.2 1039.0 1041.6 1041.7 5714.1 5718.6 5782.2 5785.1 5785.7 6242.6 6303.2 6320.4 6321.2 6330.1 5775.1 5779.7 5783.8 5789.4 5790.7 3364.8 3401.9 3402.7 3402.9 3403.0 6469.2 6562.2 6637.5 6640.0 6651.8 6506.5 6524.6 6524.7 6595.4 6605.0 6705.8 6706.5 6707.3 6711.2 6713.6 6426.7 6434.7 6437.3 6440.3 6444.8 6189.3 6346.5 6352.4 6360.7 6370.9 6666.9 6682.5 6689.6 6690.9 6694.2 4514.3 4548.0 4552.9 4557.4 4558.2 6348.5 6355.3 6356.2 6361.7 6362.5 6032.4 6141.0 6162.6 6164.9 6165.8 6102.0 6168.4 6178.4 6240.9 6241.0 6043.1 6055.1 6060.3 6069.5 6070.4 6170.2 6181.3 6188.8 6191.1 6192.0 5852.8 5952.1 6035.6 6039.2 6081.1 17:16:32 INFO - PROCESS | 9256 | 17:16:32 INFO - PROCESS | 9256 | [#5] yui.html Cycles:180 Average:13288.79 Median:571.90 stddev:15708.32 (2746.7%) stddev-sans-first:15723.91 17:16:32 INFO - PROCESS | 9256 | Values: 691.6 749.1 754.3 758.8 767.3 12832.0 12898.9 13087.9 13126.5 14021.9 13315.2 13329.8 13401.0 13461.9 13500.5 676.5 809.1 818.5 820.1 820.5 681.0 684.0 684.2 807.7 827.5 848.6 855.0 861.5 862.0 862.3 845.5 849.4 852.1 855.6 856.6 512.4 627.8 629.4 633.6 637.6 12882.5 12964.4 13076.5 13079.5 13083.1 12344.9 12575.6 13166.9 13308.4 13444.5 10174.7 10266.6 10328.4 10379.0 10385.2 3688.1 3722.6 3794.6 3798.7 3800.0 49637.3 49933.8 49973.3 50002.5 50004.7 9711.7 9846.0 9879.9 10107.7 10207.7 19080.4 19106.0 19106.0 19138.4 19147.4 7804.4 7808.5 7843.0 7894.4 7899.7 4186.1 4399.5 4448.7 4456.8 4460.6 3055.2 3067.6 3093.8 3094.9 3125.5 583.1 586.8 588.2 588.9 591.8 549.1 562.6 568.0 580.9 588.6 7729.1 7779.1 7797.0 7979.2 8004.3 567.6 575.8 587.9 600.5 608.3 3564.8 3618.7 3620.3 3751.3 3765.5 54545.5 55156.7 55183.2 55332.4 55345.4 48623.0 49121.3 50399.2 51051.0 51142.7 44408.8 44823.8 45093.8 45430.1 46055.3 7094.3 7103.2 7143.1 7253.1 7281.1 34996.5 35230.3 35561.3 35790.3 36146.3 40175.0 40446.0 42325.6 43011.6 43171.8 9208.3 9326.4 9341.6 9405.1 9907.5 9982.6 10104.5 10121.5 10393.8 10764.9 9149.6 9400.8 9643.4 9888.0 9924.9 9339.0 9363.8 9447.2 9611.8 9624.2 9067.3 9395.6 9652.4 9683.8 9684.6 7882.3 8082.0 8314.8 8405.3 8455.0 8017.6 8090.4 8151.6 8237.8 8431.9 17:16:32 INFO - PROCESS | 9256 | -------- Summary: end -------- 17:16:32 INFO - PROCESS | 9256 | 17:16:32 INFO - TEST-INFO | 9256: exit 0 17:16:32 INFO - TEST-OK | dromaeo_css | took 1113400ms 17:16:32 INFO - TEST-START | kraken 17:16:32 INFO - operating with platform_type : linux_ 17:16:32 INFO - Initialising browser for kraken test... 17:16:32 INFO - TEST-INFO | started process 9437 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSaGYao/profile http://localhost:39081/getInfo.html) 17:16:37 INFO - PROCESS | 9437 | __metrics Screen width/height:1600/1200 17:16:37 INFO - PROCESS | 9437 | colorDepth:24 17:16:37 INFO - PROCESS | 9437 | Browser inner width/height: 1024/697 17:16:37 INFO - PROCESS | 9437 | __metrics 17:16:38 ERROR - PROCESS | 9437 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:16:38 INFO - TEST-INFO | 9437: exit 0 17:16:38 INFO - Browser initialized. 17:16:38 INFO - Running cycle 1/1 for kraken test... 17:16:38 INFO - TEST-INFO | started process 9517 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSaGYao/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:50 INFO - PROCESS | 9517 | RSS: Main: 154890240 17:16:50 INFO - PROCESS | 9517 | 17:16:53 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39081/tests/kraken/driver.html?testName=audio-beat-detection) 17:16:53 INFO - PROCESS | 9517 | RSS: Main: 195674112 17:16:53 INFO - PROCESS | 9517 | 17:16:56 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39081/tests/kraken/driver.html?testName=audio-dft) 17:16:57 INFO - PROCESS | 9517 | RSS: Main: 184606720 17:16:57 INFO - PROCESS | 9517 | 17:17:00 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39081/tests/kraken/driver.html?testName=audio-fft) 17:17:00 INFO - PROCESS | 9517 | RSS: Main: 169955328 17:17:00 INFO - PROCESS | 9517 | 17:17:02 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39081/tests/kraken/driver.html?testName=audio-oscillator) 17:17:03 INFO - PROCESS | 9517 | RSS: Main: 173203456 17:17:03 INFO - PROCESS | 9517 | 17:17:05 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39081/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:17:05 INFO - PROCESS | 9517 | RSS: Main: 174137344 17:17:05 INFO - PROCESS | 9517 | 17:17:08 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39081/tests/kraken/driver.html?testName=imaging-darkroom) 17:17:09 INFO - PROCESS | 9517 | RSS: Main: 174252032 17:17:09 INFO - PROCESS | 9517 | 17:17:12 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39081/tests/kraken/driver.html?testName=imaging-desaturate) 17:17:13 INFO - PROCESS | 9517 | RSS: Main: 176439296 17:17:13 INFO - PROCESS | 9517 | 17:17:16 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39081/tests/kraken/driver.html?testName=json-parse-financial) 17:17:16 INFO - PROCESS | 9517 | RSS: Main: 175874048 17:17:16 INFO - PROCESS | 9517 | 17:17:18 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39081/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:17:19 INFO - PROCESS | 9517 | RSS: Main: 183021568 17:17:19 INFO - PROCESS | 9517 | 17:17:20 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:17:21 INFO - PROCESS | 9517 | RSS: Main: 180973568 17:17:21 INFO - PROCESS | 9517 | 17:17:23 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:17:24 INFO - PROCESS | 9517 | RSS: Main: 191307776 17:17:24 INFO - PROCESS | 9517 | 17:17:26 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:17:27 INFO - PROCESS | 9517 | RSS: Main: 196395008 17:17:27 INFO - PROCESS | 9517 | 17:17:29 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:17:30 INFO - PROCESS | 9517 | RSS: Main: 196460544 17:17:30 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39081/tests/kraken/driver.html?testName=ai-astar) 17:17:32 INFO - PROCESS | 9517 | RSS: Main: 256458752 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | __start_tp_report 17:17:32 INFO - PROCESS | 9517 | _x_x_mozilla_page_load 17:17:32 INFO - PROCESS | 9517 | _x_x_mozilla_page_load_details 17:17:32 INFO - PROCESS | 9517 | |i|pagename|runs| 17:17:32 INFO - PROCESS | 9517 | |0;ai-astar;111;110;106;110;112;112;99;111;112;110 17:17:32 INFO - PROCESS | 9517 | |1;audio-beat-detection;160;124;147;168;135;149;152;133;180;126 17:17:32 INFO - PROCESS | 9517 | |2;audio-dft;159;162;161;160;162;161;159;164;162;164 17:17:32 INFO - PROCESS | 9517 | |3;audio-fft;76;76;103;99;76;76;75;118;96;75 17:17:32 INFO - PROCESS | 9517 | |4;audio-oscillator;93;95;142;98;94;94;142;94;94;143 17:17:32 INFO - PROCESS | 9517 | |5;imaging-gaussian-blur;118;117;117;116;118;117;117;117;117;117 17:17:32 INFO - PROCESS | 9517 | |6;imaging-darkroom;145;146;144;144;146;146;144;146;145;146 17:17:32 INFO - PROCESS | 9517 | |7;imaging-desaturate;96;95;95;95;96;95;96;96;96;95 17:17:32 INFO - PROCESS | 9517 | |8;json-parse-financial;62;59;57;56;56;57;58;66;56;55 17:17:32 INFO - PROCESS | 9517 | |9;json-stringify-tinderbox;68;67;67;67;68;68;67;73;67;68 17:17:32 INFO - PROCESS | 9517 | |10;stanford-crypto-aes;81;81;82;82;80;81;82;83;83;90 17:17:32 INFO - PROCESS | 9517 | |11;stanford-crypto-ccm;118;114;118;119;123;117;125;121;116;113 17:17:32 INFO - PROCESS | 9517 | |12;stanford-crypto-pbkdf2;153;142;159;158;143;143;153;150;151;153 17:17:32 INFO - PROCESS | 9517 | |13;stanford-crypto-sha256-iterative;70;69;70;70;68;68;68;73;69;68 17:17:32 INFO - PROCESS | 9517 | __end_tp_report 17:17:32 INFO - PROCESS | 9517 | __start_cc_report 17:17:32 INFO - PROCESS | 9517 | _x_x_mozilla_cycle_collect,1047 17:17:32 INFO - PROCESS | 9517 | __end_cc_report 17:17:32 INFO - PROCESS | 9517 | __startTimestamp1458260252300__endTimestamp 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | ------- Summary: start ------- 17:17:32 INFO - PROCESS | 9517 | Number of tests: 14 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.50 stddev:4.03 (3.6%) stddev-sans-first:4.23 17:17:32 INFO - PROCESS | 9517 | Values: 111.0 110.0 106.0 110.0 112.0 112.0 99.0 111.0 112.0 110.0 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:150.50 stddev:18.37 (12.2%) stddev-sans-first:18.91 17:17:32 INFO - PROCESS | 9517 | Values: 160.0 124.0 147.0 168.0 135.0 149.0 152.0 133.0 180.0 126.0 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.78 (1.1%) stddev-sans-first:1.66 17:17:32 INFO - PROCESS | 9517 | Values: 159.0 162.0 161.0 160.0 162.0 161.0 159.0 164.0 162.0 164.0 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | [#3] audio-fft Cycles:10 Average:87.00 Median:76.00 stddev:15.68 (20.6%) stddev-sans-first:16.12 17:17:32 INFO - PROCESS | 9517 | Values: 76.0 76.0 103.0 99.0 76.0 76.0 75.0 118.0 96.0 75.0 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:94.00 stddev:23.11 (24.6%) stddev-sans-first:23.79 17:17:32 INFO - PROCESS | 9517 | Values: 93.0 95.0 142.0 98.0 94.0 94.0 142.0 94.0 94.0 143.0 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 17:17:32 INFO - PROCESS | 9517 | Values: 118.0 117.0 117.0 116.0 118.0 117.0 117.0 117.0 117.0 117.0 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 17:17:32 INFO - PROCESS | 9517 | Values: 145.0 146.0 144.0 144.0 146.0 146.0 144.0 146.0 145.0 146.0 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:17:32 INFO - PROCESS | 9517 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:57.50 stddev:3.39 (5.9%) stddev-sans-first:3.31 17:17:32 INFO - PROCESS | 9517 | Values: 62.0 59.0 57.0 56.0 56.0 57.0 58.0 66.0 56.0 55.0 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:1.83 (2.7%) stddev-sans-first:1.94 17:17:32 INFO - PROCESS | 9517 | Values: 68.0 67.0 67.0 67.0 68.0 68.0 67.0 73.0 67.0 68.0 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.00 stddev:2.80 (3.4%) stddev-sans-first:2.92 17:17:32 INFO - PROCESS | 9517 | Values: 81.0 81.0 82.0 82.0 80.0 81.0 82.0 83.0 83.0 90.0 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:118.50 stddev:3.78 (3.2%) stddev-sans-first:4.00 17:17:32 INFO - PROCESS | 9517 | Values: 118.0 114.0 118.0 119.0 123.0 117.0 125.0 121.0 116.0 113.0 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.50 Median:153.00 stddev:6.08 (4.0%) stddev-sans-first:6.38 17:17:32 INFO - PROCESS | 9517 | Values: 153.0 142.0 159.0 158.0 143.0 143.0 153.0 150.0 151.0 153.0 17:17:32 INFO - PROCESS | 9517 | 17:17:32 INFO - PROCESS | 9517 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.57 (2.3%) stddev-sans-first:1.64 17:17:32 INFO - PROCESS | 9517 | Values: 70.0 69.0 70.0 70.0 68.0 68.0 68.0 73.0 69.0 68.0 17:17:32 INFO - PROCESS | 9517 | -------- Summary: end -------- 17:17:32 INFO - PROCESS | 9517 | 17:17:33 INFO - TEST-INFO | 9517: exit 0 17:17:33 INFO - TEST-OK | kraken | took 60344ms 17:17:33 INFO - SUITE-END | took 1173s 17:17:33 INFO - Completed test suite (00:19:33) 17:17:33 INFO - javascript benchmark 17:17:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3142.277276226468, 3197.0, 3206.8396580171, 3223.0, 3260.054584170591, 5067.341245638071, 5167.870803229921, 5181.974090129549, 5199.50604692554, 5237.13587258102, 5187.870303242421, 5223.947760522394, 5225.242339860727, 5253.711045892474, 5305.204219367097, 4658.580727734503, 4779.378680771503, 4829.975850120744, 4877.8780530486665, 4883.609311255091, 4672.252439609663, 4753.0493901219725, 4829.68607040543, 4831.661783675144, 4968.403791545002, 4809.519048095198, 4817.879553011167, 4842.782074806607, 4859.635527335464, 4870.43989941156, 4833.540813622701, 4834.226523756217, 4837.226043833005, 4857.6599638025355, 4896.975515122437, 4667.15991121598, 4697.318888761145, 4800.567948884617, 4807.399075115611, 4848.5636292733825, 5100.617453690951, 5115.079285728568, 5118.590512759008, 5127.102757017507, 5129.563987061104, 5608.663480191201, 5611.242482264883, 5615.831525054255, 5616.0, 5654.943450565524, 5499.065158922993, 5540.279763630702, 5612.130119831432, 5695.971520142414, 5697.088465845486, 5246.317978662788, 5251.448597897204, 5254.0, 5255.527002569787, 5271.630985830993, 5540.667559946416, 5705.144228365695, 5708.0, 5708.143778433268, 5725.971370143123, 5560.7219639017885, 5595.552355811526, 5604.60767746262, 5610.326760788732, 5655.264815573949, 5607.271054762855, 5619.522340601095, 5620.5503559715125, 5621.016322143609, 5621.522170615462, 5473.781048758085, 5564.387917329091, 5568.805091821767, 5569.66582005081, 5590.965671350813, 5560.7219639018695, 5591.580631452657, 5594.384617692051, 5607.551395888319, 5646.040173170571, 4325.134973005349, 4330.2205602991135, 4331.177076355482, 4336.3278691802825, 4370.541093185233, 3769.208466222069, 3879.0690234343556, 3901.8634347797692, 3924.6467817895955, 3946.6842652587725, 5195.2986346843445, 5208.348956380452, 5215.061288967946, 5217.921731174036, 5226.660267082703, 5661.264035675418, 5664.065429204217, 5666.631668941505, 5675.5459563234845, 5687.203791469197, 5045.041442125985, 5147.047796157648, 5215.947840521622, 5218.6868787872845, 5235.973820130875, 4769.952300476951, 4772.212584923449, 4776.116418462596, 4799.472058073609, 4812.0, 5792.739326730307, 5818.069108942634, 5819.272590926134, 5821.679807610537, 5825.592208545446, 5467.890642187054, 5608.383077861514, 5623.522000629992, 5697.373288938296, 5702.144678298288, 5799.971000145141, 5824.301083869963, 5830.18377427169, 5849.736761845642, 5854.619449735754, 5604.103343465189, 5607.243022191952, 5609.915851262316, 5612.915806262828, 5613.971930140323, 5429.647072940246, 5636.661800291996, 5674.007048766367, 5736.42635736423, 5741.712914354349, 5415.918761218663, 5425.864353391197, 5446.291982042309, 5449.754761035683, 5454.372747133972, 5272.7100009499845, 5389.676619402691, 5459.07195776711, 5475.06923822959, 5487.972560137174, 5351.438098999549, 5412.43169467216, 5428.972855135699, 5435.130379139318, 5452.318460192476, 5392.406835248041, 5435.782568697208, 5436.103042998019, 5471.343438787371, 5473.042217611982, 5272.130098533699, 5356.196570514298, 5368.0, 5368.141097424394, 5369.4630536946], "unit": "score", "name": "dojo.html", "value": 5176.61897902629}, {"lowerIsBetter": false, "replicates": [531.2297169104797, 544.5888354292508, 565.6295126692015, 572.9140628905665, 591.7278052096033, 36782.26435471289, 37630.4355434668, 37652.811735941315, 37658.246835063284, 37749.0, 39638.20723585527, 39946.0, 40134.39798403026, 40178.59821401785, 40222.59777402225, 8490.490570565786, 8698.173673501007, 8701.695440659578, 8704.347173961947, 8706.695265665703, 8503.489790612552, 8554.35842311826, 8633.223009929105, 8837.469751814911, 8842.823143537125, 8827.205551500363, 8911.598978046004, 8920.955395223014, 8928.642854285821, 8936.106389361077, 8732.345074119436, 8803.383763136582, 8808.0, 8811.030786613468, 8812.823743525158, 8696.130386961253, 8800.647974081028, 8812.779680508038, 8817.515036672981, 8824.69113581028, 40712.592874071175, 41096.79451602723, 41166.588334116874, 41185.588144118476, 41229.38155927663, 3465.047112044183, 3796.620337966209, 3834.9041273968096, 4068.5524592294823, 4153.7507749535125, 30946.381072378652, 31062.0, 31226.53160202599, 31514.0, 32211.51682724761, 3316.7346612271203, 3335.933281334384, 3341.5154802553493, 3361.798292102482, 3443.3113377324635, 288452.0, 289056.0, 289246.9999999979, 289883.0, 290303.0, 58474.7076264616, 59321.40678593245, 59367.70316148478, 59385.0, 59394.10908836284, 62656.0, 67947.3205267941, 69239.30760692329, 69276.307236928, 69381.65309173422, 15273.159976201416, 15321.6169595761, 15375.461858835111, 15375.538733838002, 15431.38274469031, 12720.173188742701, 12730.490780368682, 12800.0, 12830.80753788694, 12866.614001579968, 20106.59786804285, 20423.489412764502, 21185.576288474145, 21203.15187392518, 21231.893840531007, 8008.7597372078935, 8013.0, 8138.755837324889, 8157.306628936607, 8216.424850260424, 935.209747763139, 939.68050862707, 1002.7192386131894, 1037.5382954585136, 1049.6746008737316, 27664.0, 28543.14370568886, 28636.0, 28952.565711514344, 29137.56293655597, 1043.2175868098925, 1057.5716834681966, 1073.7154654016692, 1076.4025965589174, 1125.763589646167, 14737.557873263819, 15136.394544218108, 15152.393904243927, 15324.693506130037, 15436.614084647974, 336241.2315568992, 338179.0, 338763.0, 339627.0, 339868.0, 52402.0, 52958.0, 52985.2052219217, 53011.73494132505, 53041.2043819343, 1205.3370646144585, 1305.0864394923592, 1317.9934100329629, 1326.2970625568657, 1335.9666008349675, 28000.29999250035, 29409.411811764072, 29426.411471770018, 29833.10500684983, 29856.85071574628, 42794.78602607091, 43444.782776085915, 43525.0, 43527.0, 43535.78232108946, 238736.0, 248084.0, 248246.0, 248737.0, 249210.0, 28190.71809281881, 31920.201994950312, 32129.196770080936, 32858.67141328556, 32861.50707739338, 39861.60138398579, 40610.593894061865, 40866.591334086275, 41615.79192104141, 41871.0, 36936.630633694396, 37076.258474830895, 37483.43774843434, 37506.437403438424, 37590.43614345732, 35839.82080089583, 35936.640633594376, 36733.26533469262, 36816.81591592025, 37327.81336093302, 35706.64293357137, 36529.086772830895, 36742.0, 36992.44511332386, 38691.0, 31150.84424577953, 33219.33561328808, 33635.49546756849, 33816.83091584526, 33895.3220935575, 25211.0, 25694.486110278063, 25745.613815793153, 25841.0, 25994.35014124662], "unit": "score", "name": "ext.html", "value": 18622.687269224145}, {"lowerIsBetter": false, "replicates": [344.3045049001018, 356.0931213352499, 357.1749259211222, 365.2257214704826, 366.7707682698312, 16746.91626541867, 16904.1547922604, 18400.447986560426, 18410.079496025195, 18433.44699659009, 16697.33210671575, 17099.74350384742, 17175.312987480487, 17180.914095429536, 17183.570410739707, 5285.709285989278, 5391.460853914617, 5587.832365029035, 5588.91616625751, 5603.439656034405, 3971.0866500704856, 5540.612157149001, 5831.387704291052, 6074.5747797654185, 6100.664463454508, 6022.698865056752, 6023.909641355362, 6034.69826508675, 6065.878682426349, 6068.271807383098, 5777.306723193223, 5888.676122813244, 5898.026825573776, 5908.615939963888, 5909.409059094078, 3647.854085836563, 5028.4971502849785, 5213.348331458567, 5286.841394758163, 5286.894262114774, 19823.30618428348, 20076.196952121896, 20129.698054529195, 21235.787642123534, 21419.250326238507, 2278.1456953642382, 2366.396568874943, 2459.692538432696, 2720.3743139077924, 2829.405824776779, 12947.741045179138, 13106.541271055563, 13252.86747132526, 13452.461901524026, 13817.654558636013, 1860.8325250727364, 1878.1829903991807, 1886.2549293029315, 1886.8584856135844, 1934.516370907273, 62397.0, 62399.064014039825, 63358.36641633571, 64031.67984160096, 64119.03821442682, 9711.0, 9880.703578892644, 10111.7472063199, 10188.490575471196, 10296.176305895511, 13450.0, 13536.0, 13545.458181672622, 13555.66110847217, 13558.322083895962, 7519.511231769918, 7785.961070194613, 7929.0, 7945.808128780729, 8054.677812887536, 7811.062672479339, 7874.094479134858, 7967.2431119043595, 8013.19868013194, 8013.358931285483, 5952.10718392236, 6071.210742603522, 6091.51267898567, 6098.451139397475, 6177.289611694623, 1637.6560922206231, 1708.735146052364, 1751.3169863753146, 1798.856091512676, 1815.4553633909775, 864.6671031652859, 947.9099485548862, 952.3952290295712, 1015.2537884654773, 1037.569408695383, 16724.49826505207, 16875.915620422064, 17603.911980440014, 17826.46520604384, 18131.093445327682, 934.6773268427951, 937.9718608441758, 939.736873675372, 944.2304521814699, 972.5623469438781, 9734.610615575297, 9797.657082002095, 10001.199904007663, 10039.899601004043, 10146.137578305927, 449271.0, 450894.0, 467988.0, 468646.0, 470608.0, 80919.59540202378, 81290.0, 82528.0, 82652.58673706593, 82725.0, 1031.6440827914357, 1044.8454457824148, 1075.6181555547823, 1085.5549224817787, 1093.6172339681048, 15373.23133843281, 15457.227138642798, 15502.379904803682, 15534.922325388301, 15884.126373049594, 33807.15482112967, 33820.3235935275, 34554.65445345514, 34760.30479390347, 35728.464073039446, 49989.250161246884, 50188.0, 50207.49792502028, 50292.74853625709, 50866.0, 8049.356051515748, 8186.426950113435, 8260.339172866277, 8296.543690097102, 8549.658013679384, 12554.372281385711, 12601.0, 12615.81076283838, 12642.620721378373, 12715.427805748579, 10720.571177153139, 10732.731681707708, 10793.136549075898, 10972.067374273276, 11213.831792522955, 4973.378327709036, 8797.12028797115, 9734.318597698377, 10870.0, 11004.174686898354, 5577.191307260506, 8219.383546234176, 9576.904230957602, 11042.779144417227, 11300.60447884353, 8180.631871565674, 8307.667693292442, 8391.0, 8433.915660843559, 8505.82988340242, 8855.91144088551, 10698.251122421356, 11357.659270221906, 11645.41772911368, 11747.706307342385], "unit": "score", "name": "jquery.html", "value": 8685.948249318462}, {"lowerIsBetter": false, "replicates": [1323.206076354187, 1455.9272036398181, 1458.496818597584, 1626.6584017356354, 1795.9730604040933, 6671.833204169892, 7576.924230757698, 7755.37956963443, 7760.650770715317, 7765.301122898938, 7550.471466997313, 7730.884036739453, 7732.690692372298, 7743.457957942932, 7745.0, 1972.2899756087797, 1991.312997016027, 2264.5923733727923, 2267.6938613287243, 2292.8165746740306, 2350.189184731265, 2357.834951553392, 2358.1274928276475, 2359.8230132740027, 2363.1847012780563, 2161.2111579273533, 2208.8895555222257, 2216.756156822756, 2237.776222377757, 2241.2267767620147, 1993.2425678242248, 2252.718410198725, 2288.0390236100793, 2300.1719381022817, 2301.252093069759, 2251.6735073414425, 2278.1343089626002, 2282.1441959265276, 2282.8173746100274, 2287.4738810073777, 7616.23837616234, 7653.732119375851, 7663.157052724252, 7675.961620191919, 7679.57762323072, 4691.483936766953, 4769.952300476985, 4780.928286075677, 4783.0, 4792.544708252711, 3137.247060705437, 3176.0948129783133, 3279.1310302769784, 3280.0815771583993, 3291.6872897074977, 1005.3612611443374, 1014.7361685961703, 1047.1099565369452, 1048.8007278617038, 1050.2543194332034, 10953.83569246462, 11000.504977276041, 11002.174836887265, 11022.614208502664, 11025.44872756359, 4326.286162783168, 4465.017696106851, 4520.95479045212, 4541.523140070245, 4563.475200351935, 9349.252059835197, 9374.484403357745, 9377.765555861159, 9387.57755900986, 9393.342466027449, 4921.5078492151215, 4959.181735013754, 4964.975175124174, 4969.453360130383, 4970.950290497121, 3855.094052897567, 4332.241857674894, 4441.644668426518, 4489.0, 4489.147062058264, 3706.9073273168387, 3749.5875453700073, 3749.887503374903, 3782.111203867089, 3803.6006219347123, 1187.8277649740912, 1195.0320240605138, 1202.903767698582, 1217.6286232699113, 1227.7421741434398, 1095.2771171027243, 1106.093003736928, 1110.211749657736, 1243.247835059794, 1331.6937104465833, 7461.813454663677, 7536.623168841536, 7555.508891922117, 7574.0, 7581.924180758232, 496.1045313209619, 508.351851389474, 509.6483426435747, 511.82597916707755, 513.4070148977936, 5489.066858634042, 5504.284443022461, 5508.586855985737, 5510.201020851954, 5532.5573954083575, 9003.819923601492, 9154.40496367734, 9157.221636160868, 9169.495677737656, 9184.8622270666, 9198.356115072014, 9231.769205769775, 9253.213476854542, 9266.768330791649, 9309.48797816113, 7262.31008054234, 7286.271372862671, 7341.486095973338, 7472.70109195637, 7485.25147485258, 7394.408447324094, 7426.777196684108, 7445.181030086578, 7455.403567714461, 7596.0, 8385.95807020961, 8488.363372746946, 8560.571971401281, 8757.90526184227, 8779.0, 8674.262687671619, 8864.0, 8868.379213454997, 8999.415038022507, 9027.684031058881, 6523.608583485006, 7127.643617819192, 7279.745208917662, 7562.432817538596, 7691.653875575501, 7544.735934242275, 7575.0, 7600.657970391456, 7637.809054773675, 7645.732399365996, 6769.323067693388, 6780.694868731018, 6926.06498122747, 7004.509684322048, 7015.789526314219, 6692.531522793358, 6727.260001399744, 6806.489513286424, 6864.862702746017, 6890.173179218526, 6865.588064715933, 7055.400290975119, 7086.220515743161, 7130.964345178241, 7132.358087772125, 6515.869682606227, 6530.151080359523, 6563.113979612691, 6565.540412171103, 6572.079908812866, 6526.575772574767, 6580.407763301326, 6596.109525214035, 6617.66911654425, 6619.470442364695], "unit": "score", "name": "mootools.html", "value": 4433.744541410775}, {"lowerIsBetter": false, "replicates": [332.6756412497815, 333.0109574563547, 336.5876800918875, 341.55938838897805, 342.5854715793889, 5824.912626310604, 5858.502027327677, 5862.384449632791, 5870.00209964306, 5894.705264736767, 5774.5091667208335, 5789.160571717099, 5800.100984347433, 5806.477417032466, 5816.360200377966, 4308.784560771973, 4401.60385565299, 4454.57681520255, 4494.68537202396, 4505.166544189336, 4493.595576398124, 4507.1211113832815, 4529.614982726473, 4535.909281814362, 4544.568266014723, 4279.7218180818145, 4498.955010449887, 4499.61753250974, 4502.212112880233, 4505.909881802362, 4403.075354175611, 4497.730136191806, 4506.211413002711, 4509.255972764523, 4524.11779702958, 3944.073142811437, 3951.9802400988096, 3952.8418863245724, 3954.762714237126, 3971.6822654187595, 5512.91730624041, 5518.0, 5519.889602207933, 5520.0, 5528.391876893538, 5210.0, 5211.661242019257, 5212.739363031833, 5217.113090774539, 5222.112240919015, 6142.907856382158, 6215.160953271341, 6218.844528886769, 6224.906626400608, 6225.875482490324, 4123.9381409278885, 4240.342746874208, 4257.254980378452, 4266.0, 4401.361802538614, 6368.681565921685, 6388.073729309271, 6423.164988551505, 6424.196975378078, 6429.6142231466265, 4330.610245077895, 4338.739675619473, 4338.76136812472, 4343.0662407581885, 4351.0645211279725, 4393.692441529126, 4397.428334316518, 4402.933955990663, 4403.867883963486, 4405.03089320349, 5097.286379906816, 5098.439171691111, 5106.617003724736, 5112.795488180431, 5113.258577506241, 6102.8169154924535, 6160.1375807387, 6188.164597779332, 6205.441510264098, 6240.344763799826, 1527.0990115831712, 1538.6614944712146, 1542.0593438002809, 1545.99510318294, 1550.2248875562218, 961.9663311784054, 1006.1598565198142, 1038.9896101038894, 1041.6458404142627, 1041.7239431550645, 5714.085746280658, 5718.599698021182, 5782.161586569924, 5785.132230165509, 5785.71071446426, 6242.563020588515, 6303.180586523814, 6320.399562041599, 6321.209848768904, 6330.145430366933, 5775.075987841925, 5779.653220806681, 5783.826485205451, 5789.363170051291, 5790.681512516852, 3364.8485818138242, 3401.9319613608086, 3402.6767457091537, 3402.897913062612, 3403.0471467989005, 6469.159009328851, 6562.245341785756, 6637.535372523877, 6639.966800165968, 6651.833704157435, 6506.512011599054, 6524.641144737085, 6524.6737663116655, 6595.439387652007, 6604.96697516519, 6705.798826035129, 6706.463482921355, 6707.3292670732535, 6711.161104861892, 6713.597184168965, 6426.678666066771, 6434.742610295536, 6437.291897891135, 6440.259370172303, 6444.806655800334, 6189.319174890848, 6346.492280617632, 6352.36476352361, 6360.681965901594, 6370.936290637034, 6666.899996500153, 6682.498812589172, 6689.632070236184, 6690.933090669226, 6694.230163531256, 4514.255147900691, 4548.044910568818, 4552.88617784558, 4557.430321209848, 4558.179527685049, 6348.523860710373, 6355.269144048493, 6356.2054743157105, 6361.695852350164, 6362.491000719839, 6032.366601506954, 6141.0, 6162.568620196544, 6164.938350616616, 6165.784197553064, 6101.969490152521, 6168.383161683796, 6178.351273116258, 6240.875182496416, 6241.032639940817, 6043.123747056564, 6055.091736239423, 6060.303065147388, 6069.484093852072, 6070.362611925684, 6170.167027451236, 6181.320054794059, 6188.752449901954, 6191.071339299141, 6192.0, 5852.7658893643775, 5952.136940143741, 6035.6076855004285, 6039.214902062704, 6081.148639190428], "unit": "score", "name": "prototype.html", "value": 4660.983201955442}, {"lowerIsBetter": false, "replicates": [691.5850489706177, 749.1459735901074, 754.3399525415261, 758.7913323835941, 767.3017554025835, 12832.037597180226, 12898.871011289884, 13087.934560327198, 13126.47494100236, 14021.929890350546, 13315.20108793473, 13329.800052999188, 13401.0, 13461.865381346184, 13500.459981600749, 676.4892506157844, 809.114020147937, 818.54161669465, 820.1019883227856, 820.4912953968518, 681.0227323790376, 684.0389253099403, 684.2199892122984, 807.7172989453703, 827.5448503323179, 848.6435697007241, 854.9700760473385, 861.5218553702692, 861.9525926074064, 862.3101518784978, 845.4631309118754, 849.3969281809923, 852.1350828908662, 855.6149732620314, 856.5503110866782, 512.3569919750727, 627.7645882793952, 629.361198383641, 633.607163558592, 637.5728262064428, 12882.484700611963, 12964.416601252966, 13076.476940922446, 13079.542216022393, 13083.149595276276, 12344.876551234553, 12575.622731318075, 13166.934165329112, 13308.401121949439, 13444.5294414696, 10174.745631359201, 10266.589336426534, 10328.380297182193, 10379.0, 10385.196374622377, 3688.0595448160816, 3722.571904231021, 3794.5636251831115, 3798.734088613798, 3799.9620003799882, 49637.25544116841, 49933.75033124848, 49973.25040124401, 50002.49997500015, 50004.749976249885, 9711.66009189675, 9846.0, 9879.851802222973, 10107.69676909694, 10207.701493432232, 19080.427587172406, 19106.0, 19106.044697765057, 19138.425847224604, 19147.425577232705, 7804.375649948104, 7808.453408261367, 7843.0, 7894.368450524059, 7899.684012639545, 4186.120914607966, 4399.472063352418, 4448.7108337957925, 4456.821727130879, 4460.598546130864, 3055.220918665726, 3067.647220569663, 3093.8453077346044, 3094.9381012380077, 3125.4999200127872, 583.1049339264293, 586.8239528141626, 588.1824264272665, 588.8586739182565, 591.819495054004, 549.1076999875203, 562.6258538072218, 567.9719707329747, 580.9186713860063, 588.6056342250703, 7729.149793522708, 7779.144294127642, 7796.986391769034, 7979.20207979209, 8004.279614834692, 567.5771550195132, 575.8358867722679, 587.9029960056629, 600.5075837812951, 608.3065305551675, 3564.8395822188063, 3618.6743193112748, 3620.3161037171913, 3751.306008388457, 3765.4916586260506, 54545.45454545483, 55156.724216379465, 55183.17225241625, 55332.44667553354, 55345.44654553403, 48623.0, 49121.263181051596, 50399.24401133986, 51051.0, 51142.74428627833, 44408.77795611001, 44823.77588112038, 45093.77453112779, 45430.091398171855, 46055.30917036314, 7094.290570942864, 7103.218645949045, 7143.107111611049, 7253.093363329584, 7281.089863767029, 34996.47505287372, 35230.295394092485, 35561.288774224886, 35790.28419431649, 36146.27707445784, 40175.0, 40446.0, 42325.57674423217, 43011.569884300756, 43171.78414107909, 9208.263338932735, 9326.393784403992, 9341.626334946526, 9405.106514881076, 9907.504624768877, 9982.550785214828, 10104.494775261355, 10121.544530495998, 10393.84409233847, 10764.946175269073, 9149.588268528065, 9400.811983760423, 9643.395278754517, 9888.0, 9924.877995284278, 9339.0, 9363.812723745623, 9447.191011235955, 9611.807763844823, 9624.230061594915, 9067.2984466541, 9395.624175032923, 9652.420854748738, 9683.757906052124, 9684.56419461112, 7882.251186137308, 8082.0, 8314.79213019655, 8405.32757379396, 8455.0, 8017.559034253172, 8090.393220508603, 8151.575018117855, 8237.79405514867, 8431.915680843113], "unit": "score", "name": "yui.html", "value": 5989.008604355762}], "name": "dromaeo_css", "value": 6853.697464759252}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 106.0, 110.0, 112.0, 112.0, 99.0, 111.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [160.0, 124.0, 147.0, 168.0, 135.0, 149.0, 152.0, 133.0, 180.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [159.0, 162.0, 161.0, 160.0, 162.0, 161.0, 159.0, 164.0, 162.0, 164.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 103.0, 99.0, 76.0, 76.0, 75.0, 118.0, 96.0, 75.0], "unit": "score", "name": "audio-fft", "value": 87.0}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 142.0, 98.0, 94.0, 94.0, 142.0, 94.0, 94.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 144.0, 144.0, 146.0, 146.0, 144.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [62.0, 59.0, 57.0, 56.0, 56.0, 57.0, 58.0, 66.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 73.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 82.0, 82.0, 80.0, 81.0, 82.0, 83.0, 83.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [118.0, 114.0, 118.0, 119.0, 123.0, 117.0, 125.0, 121.0, 116.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [153.0, 142.0, 159.0, 158.0, 143.0, 143.0, 153.0, 150.0, 151.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.5}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 70.0, 70.0, 68.0, 68.0, 68.0, 73.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1518.7}]} 17:17:33 INFO - Return code: 0 17:17:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:17:33 ERROR - # TBPL SUCCESS # 17:17:33 INFO - Running post-action listener: _resource_record_post_action 17:17:33 INFO - Running post-run listener: _resource_record_post_run 17:17:34 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 364544; Write bytes: 305385472; Read time: 268; Write time: 184940 17:17:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13856768; Read time: 0; Write time: 4200 17:17:34 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 364544; Write bytes: 288428032; Read time: 268; Write time: 175968 17:17:34 INFO - Running post-run listener: _upload_blobber_files 17:17:34 INFO - Blob upload gear active. 17:17:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:17:34 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:17:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:17:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:17:35 INFO - (blobuploader) - INFO - Open directory for files ... 17:17:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:17:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:17:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:35 INFO - (blobuploader) - INFO - Done attempting. 17:17:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:17:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:17:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:36 INFO - (blobuploader) - INFO - Done attempting. 17:17:36 INFO - (blobuploader) - INFO - Iteration through files over. 17:17:36 INFO - Return code: 0 17:17:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:17:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:17:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/989000fd86db38fa5813781c82a2196c118f8fc4ec28f0af4729c747a57fd00bd6320c73105d1abd4ecf5d3995cf19daa9649ac32133f275d0e913a576f6f374", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2b66dff7cadfb419bff332ea13590a44955e67a427eb35ff766fddf2c8d4030cef27c462483161fdc2686a6bbeb80aa1ab79181f4a6537dc4ce15c62d5ff1788"} 17:17:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:17:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:17:36 INFO - Contents: 17:17:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/989000fd86db38fa5813781c82a2196c118f8fc4ec28f0af4729c747a57fd00bd6320c73105d1abd4ecf5d3995cf19daa9649ac32133f275d0e913a576f6f374", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2b66dff7cadfb419bff332ea13590a44955e67a427eb35ff766fddf2c8d4030cef27c462483161fdc2686a6bbeb80aa1ab79181f4a6537dc4ce15c62d5ff1788"} 17:17:36 INFO - Running post-run listener: copy_logs_to_upload_dir 17:17:36 INFO - Copying logs to upload dir... 17:17:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:17:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.101312 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-03-17 17:17:36.845530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 17:17:36.853422) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/989000fd86db38fa5813781c82a2196c118f8fc4ec28f0af4729c747a57fd00bd6320c73105d1abd4ecf5d3995cf19daa9649ac32133f275d0e913a576f6f374", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2b66dff7cadfb419bff332ea13590a44955e67a427eb35ff766fddf2c8d4030cef27c462483161fdc2686a6bbeb80aa1ab79181f4a6537dc4ce15c62d5ff1788"} build_url:https://queue.taskcluster.net/v1/task/XSQV3V6lTEuSzLhBof5g0Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/XSQV3V6lTEuSzLhBof5g0Q/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/Mozilla-Inbound/sha512/989000fd86db38fa5813781c82a2196c118f8fc4ec28f0af4729c747a57fd00bd6320c73105d1abd4ecf5d3995cf19daa9649ac32133f275d0e913a576f6f374", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2b66dff7cadfb419bff332ea13590a44955e67a427eb35ff766fddf2c8d4030cef27c462483161fdc2686a6bbeb80aa1ab79181f4a6537dc4ce15c62d5ff1788"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 17:17:36.878338) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 17:17:36.878703) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1458251123.526485-174059127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004689 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 17:17:36.966015) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 17:17:36.966765) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 17:17:36.967422) ========= ========= Total master_lag: 0.28 =========