builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1457493418.76 results: success (0) buildid: 20160308163019 builduid: bc3033a6eaa14443b08719beb908f07b revision: 886b5480b5781f204b89dc9e10bc991a0fa3d3c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 19:16:58.765211) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 19:16:58.765811) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 19:16:58.766158) ========= 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=7de08804244eb36560b44971000001c3-1457493412.887070-1404109586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.002995 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 19:16:58.779753) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 19:16:58.780081) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 19:16:58.802056) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 19:16:58.802401) ========= 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=7de08804244eb36560b44971000001c3-1457493412.887070-1404109586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.037895 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 19:16:58.848618) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 19:16:58.848973) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 19:16:58.849385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 19:16:58.849720) ========= 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=7de08804244eb36560b44971000001c3-1457493412.887070-1404109586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-08 19:16:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.9M=0s 2016-03-08 19:16:59 (40.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144913 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 19:16:59.003995) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 19:16:59.004353) ========= 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=7de08804244eb36560b44971000001c3-1457493412.887070-1404109586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.114844 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 19:16:59.126828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-08 19:16:59.127223) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 886b5480b5781f204b89dc9e10bc991a0fa3d3c9 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 886b5480b5781f204b89dc9e10bc991a0fa3d3c9 --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=7de08804244eb36560b44971000001c3-1457493412.887070-1404109586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-08 19:16:59,363 truncating revision to first 12 chars 2016-03-08 19:16:59,363 Setting DEBUG logging. 2016-03-08 19:16:59,363 attempt 1/10 2016-03-08 19:16:59,363 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/886b5480b578?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-08 19:17:00,506 unpacking tar archive at: mozilla-central-886b5480b578/testing/mozharness/ program finished with exit code 0 elapsedTime=1.382725 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-08 19:17:00.520327) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 19:17:00.520751) ========= echo 886b5480b5781f204b89dc9e10bc991a0fa3d3c9 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'886b5480b5781f204b89dc9e10bc991a0fa3d3c9'] 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=7de08804244eb36560b44971000001c3-1457493412.887070-1404109586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 886b5480b5781f204b89dc9e10bc991a0fa3d3c9 program finished with exit code 0 elapsedTime=0.002298 script_repo_revision: '886b5480b5781f204b89dc9e10bc991a0fa3d3c9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 19:17:00.568472) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 19:17:00.569185) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 19:17:00.576099) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-03-08 19:17:00.576411) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1457493412.887070-1404109586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:17:00 INFO - MultiFileLogger online at 20160308 19:17:00 in /builds/slave/test-pgo 19:17:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:17:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:17:00 INFO - {'append_to_log': False, 19:17:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:17:00 INFO - 'blob_upload_branch': 'Firefox', 19:17:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:17:00 INFO - 'branch': 'Firefox', 19:17:00 INFO - 'buildbot_json_path': 'buildprops.json', 19:17:00 INFO - 'config_files': ('talos/linux_config.py',), 19:17:00 INFO - 'default_actions': ('clobber', 19:17:00 INFO - 'read-buildbot-config', 19:17:00 INFO - 'download-and-extract', 19:17:00 INFO - 'populate-webroot', 19:17:00 INFO - 'create-virtualenv', 19:17:00 INFO - 'install', 19:17:00 INFO - 'run-tests'), 19:17:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:17:00 INFO - 'download_minidump_stackwalk': True, 19:17:00 INFO - 'download_symbols': 'ondemand', 19:17:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:17:00 INFO - 'tooltool.py': '/tools/tooltool.py', 19:17:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:17:00 INFO - '/tools/misc-python/virtualenv.py')}, 19:17:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:17:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:17:00 INFO - 'installer_path': 'installer.exe', 19:17:00 INFO - 'log_level': 'info', 19:17:00 INFO - 'log_name': 'talos', 19:17:00 INFO - 'log_to_console': True, 19:17:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:17:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:17:00 INFO - 'opt_config_files': (), 19:17:00 INFO - 'pip_index': False, 19:17:00 INFO - 'sps_profile': False, 19:17:00 INFO - 'sps_profile_interval': 0, 19:17:00 INFO - 'suite': 'dromaeojs', 19:17:00 INFO - 'system_bits': '32', 19:17:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:17:00 INFO - 'title': 'talos-linux64-ix-003', 19:17:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:17:00 INFO - 'use_talos_json': True, 19:17:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:17:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:17:00 INFO - 'work_dir': 'build'} 19:17:00 INFO - ##### 19:17:00 INFO - ##### Running clobber step. 19:17:00 INFO - ##### 19:17:00 INFO - Running pre-action listener: _resource_record_pre_action 19:17:00 INFO - Running main action method: clobber 19:17:00 INFO - rmtree: /builds/slave/test-pgo/build 19:17:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:17:05 INFO - Running post-action listener: _resource_record_post_action 19:17:05 INFO - ##### 19:17:05 INFO - ##### Running read-buildbot-config step. 19:17:05 INFO - ##### 19:17:05 INFO - Running pre-action listener: _resource_record_pre_action 19:17:05 INFO - Running main action method: read_buildbot_config 19:17:05 INFO - Using buildbot properties: 19:17:05 INFO - { 19:17:05 INFO - "project": "", 19:17:05 INFO - "product": "firefox", 19:17:05 INFO - "script_repo_revision": "production", 19:17:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:17:05 INFO - "repository": "", 19:17:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 19:17:05 INFO - "buildid": "20160308163019", 19:17:05 INFO - "pgo_build": "True", 19:17:05 INFO - "basedir": "/builds/slave/test-pgo", 19:17:05 INFO - "buildnumber": 707, 19:17:05 INFO - "slavename": "talos-linux64-ix-003", 19:17:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:17:05 INFO - "platform": "ubuntu64_hw", 19:17:05 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:17:05 INFO - "branch": "mozilla-central", 19:17:05 INFO - "repo_path": "mozilla-central", 19:17:05 INFO - "revision": "886b5480b5781f204b89dc9e10bc991a0fa3d3c9", 19:17:05 INFO - "stage_platform": "linux64-pgo", 19:17:05 INFO - "builduid": "bc3033a6eaa14443b08719beb908f07b", 19:17:05 INFO - "slavebuilddir": "test" 19:17:05 INFO - } 19:17:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 19:17:05 INFO - Running post-action listener: _resource_record_post_action 19:17:05 INFO - ##### 19:17:05 INFO - ##### Running download-and-extract step. 19:17:05 INFO - ##### 19:17:05 INFO - Running pre-action listener: _resource_record_pre_action 19:17:05 INFO - Running main action method: download_and_extract 19:17:05 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:05 INFO - https://queue.taskcluster.net/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:17:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:17:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:17:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/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 19:17:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/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 19:17:05 INFO - Downloaded 1361 bytes. 19:17:05 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:17:05 INFO - Using the following test package requirements: 19:17:05 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:17:05 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:17:05 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:17:05 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:05 INFO - u'jsshell-linux-x86_64.zip'], 19:17:05 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:17:05 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:17:05 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:17:05 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:17:05 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:17:05 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:17:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:05 INFO - https://queue.taskcluster.net/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:17:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:17:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:17:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/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 19:17:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/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 19:17:06 INFO - Downloaded 23405704 bytes. 19:17:06 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'] 19:17:06 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 19:17:08 INFO - Return code: 0 19:17:08 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 19:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:08 INFO - https://queue.taskcluster.net/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:17:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:17:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:17:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/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 19:17:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/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 19:17:09 INFO - Downloaded 23405704 bytes. 19:17:09 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'] 19:17:09 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 19:17:10 INFO - Return code: 0 19:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:10 INFO - https://queue.taskcluster.net/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:17:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:17:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:17:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/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 19:17:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/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 19:17:11 INFO - Downloaded 10845161 bytes. 19:17:11 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'] 19:17:11 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 19:17:11 INFO - Return code: 0 19:17: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')]} 19:17:11 INFO - https://queue.taskcluster.net/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:17:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:17:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:17:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/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 19:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WaO3JPuLSvm4FqK8oz84iA/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 19:17:12 INFO - Downloaded 56130354 bytes. 19:17:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:17:12 INFO - mkdir: /builds/slave/test-pgo/properties 19:17:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:17:12 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:17:12 INFO - Contents: 19:17:12 INFO - build_url:https://queue.taskcluster.net/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:17:13 INFO - Running post-action listener: _resource_record_post_action 19:17:13 INFO - Running post-action listener: set_extra_try_arguments 19:17:13 INFO - ##### 19:17:13 INFO - ##### Running populate-webroot step. 19:17:13 INFO - ##### 19:17:13 INFO - Running pre-action listener: _resource_record_pre_action 19:17:13 INFO - Running main action method: populate_webroot 19:17:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:17:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:17:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:17:13 INFO - '--tppagecycles', 19:17:13 INFO - '7'], 19:17:13 INFO - 'tests': ['tsvgm']}}, 19:17:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:17:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:17:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:17:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:17:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:17:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:17:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:13 INFO - 'talos_options': ['--e10s'], 19:17:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:13 INFO - 'tests': ['damp', 'tps']}, 19:17:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:13 INFO - 'talos_options': ['--e10s'], 19:17:13 INFO - 'tests': ['damp', 'tps']}, 19:17:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:17:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:17:13 INFO - 'other': {'tests': ['a11yr', 19:17:13 INFO - 'ts_paint', 19:17:13 INFO - 'tpaint', 19:17:13 INFO - 'sessionrestore', 19:17:13 INFO - 'sessionrestore_no_auto_restore', 19:17:13 INFO - 'tabpaint']}, 19:17:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:17:13 INFO - 'tests': ['a11yr', 19:17:13 INFO - 'ts_paint', 19:17:13 INFO - 'tpaint', 19:17:13 INFO - 'sessionrestore', 19:17:13 INFO - 'sessionrestore_no_auto_restore', 19:17:13 INFO - 'tabpaint']}, 19:17:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:17:13 INFO - 'tests': ['a11yr', 19:17:13 INFO - 'ts_paint', 19:17:13 INFO - 'tpaint', 19:17:13 INFO - 'sessionrestore', 19:17:13 INFO - 'sessionrestore_no_auto_restore', 19:17:13 INFO - 'tabpaint']}, 19:17:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:17:13 INFO - 'tests': ['a11yr', 19:17:13 INFO - 'ts_paint', 19:17:13 INFO - 'tpaint', 19:17:13 INFO - 'sessionrestore', 19:17:13 INFO - 'sessionrestore_no_auto_restore', 19:17:13 INFO - 'tabpaint']}, 19:17:13 INFO - 'other_l64': {'tests': ['a11yr', 19:17:13 INFO - 'ts_paint', 19:17:13 INFO - 'tpaint', 19:17:13 INFO - 'sessionrestore', 19:17:13 INFO - 'sessionrestore_no_auto_restore', 19:17:13 INFO - 'tabpaint']}, 19:17:13 INFO - 'other_nol64': {'tests': ['a11yr', 19:17:13 INFO - 'ts_paint', 19:17:13 INFO - 'tpaint', 19:17:13 INFO - 'sessionrestore', 19:17:13 INFO - 'sessionrestore_no_auto_restore', 19:17:13 INFO - 'tabpaint']}, 19:17:13 INFO - 'svgr': {'tests': ['tsvgx', 19:17:13 INFO - 'tsvgr_opacity', 19:17:13 INFO - 'tart', 19:17:13 INFO - 'tscrollx', 19:17:13 INFO - 'cart']}, 19:17:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:17:13 INFO - 'tests': ['tsvgx', 19:17:13 INFO - 'tsvgr_opacity', 19:17:13 INFO - 'tart', 19:17:13 INFO - 'tscrollx', 19:17:13 INFO - 'cart']}, 19:17:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:13 INFO - 'tests': ['tp5o']}, 19:17:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:13 INFO - 'talos_options': ['--e10s'], 19:17:13 INFO - 'tests': ['tp5o']}, 19:17:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:13 INFO - 'talos_options': ['--xperf_path', 19:17:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:13 INFO - 'tests': ['tp5n']}, 19:17:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:13 INFO - 'talos_options': ['--e10s', 19:17:13 INFO - '--xperf_path', 19:17:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:13 INFO - 'tests': ['tp5n']}}, 19:17:13 INFO - 'talos.zip': {'path': '', 19:17:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:17:13 INFO - Running post-action listener: _resource_record_post_action 19:17:13 INFO - ##### 19:17:13 INFO - ##### Running create-virtualenv step. 19:17:13 INFO - ##### 19:17:13 INFO - Running pre-action listener: _resource_record_pre_action 19:17:13 INFO - Running main action method: create_virtualenv 19:17:13 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:17:13 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 19:17:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:17:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:17:13 INFO - Using real prefix '/usr' 19:17:13 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:17:14 INFO - Installing distribute.............................................................................................................................................................................................done. 19:17:16 INFO - Installing pip.................done. 19:17:16 INFO - Return code: 0 19:17:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd655f2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1b920>, '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 0x1d1c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ccb0>, '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': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', '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 19:17:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:17:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:17:16 INFO - Using env: {'DISPLAY': ':0', 19:17:16 INFO - 'HOME': '/home/cltbld', 19:17:16 INFO - 'LANG': 'en_US.UTF-8', 19:17:16 INFO - 'LANGUAGE': 'en_US:en', 19:17:16 INFO - 'LOGNAME': 'cltbld', 19:17:16 INFO - 'MAIL': '/var/mail/cltbld', 19:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:16 INFO - 'MOZ_NO_REMOTE': '1', 19:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:16 INFO - 'NO_EM_RESTART': '1', 19:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:16 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:16 INFO - 'SHELL': '/bin/bash', 19:17:16 INFO - 'SHLVL': '1', 19:17:16 INFO - 'TERM': 'linux', 19:17:16 INFO - 'TMOUT': '86400', 19:17:16 INFO - 'USER': 'cltbld', 19:17:16 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', 19:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:16 INFO - '_': '/tools/buildbot/bin/python'} 19:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:16 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 19:17:16 INFO - Cleaning up... 19:17:16 INFO - Return code: 0 19:17:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd655f2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1b920>, '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 0x1d1c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ccb0>, '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': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', '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 19:17:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:17:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:17:16 INFO - Using env: {'DISPLAY': ':0', 19:17:16 INFO - 'HOME': '/home/cltbld', 19:17:16 INFO - 'LANG': 'en_US.UTF-8', 19:17:16 INFO - 'LANGUAGE': 'en_US:en', 19:17:16 INFO - 'LOGNAME': 'cltbld', 19:17:16 INFO - 'MAIL': '/var/mail/cltbld', 19:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:16 INFO - 'MOZ_NO_REMOTE': '1', 19:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:16 INFO - 'NO_EM_RESTART': '1', 19:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:16 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:16 INFO - 'SHELL': '/bin/bash', 19:17:16 INFO - 'SHLVL': '1', 19:17:16 INFO - 'TERM': 'linux', 19:17:16 INFO - 'TMOUT': '86400', 19:17:16 INFO - 'USER': 'cltbld', 19:17:16 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', 19:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:16 INFO - '_': '/tools/buildbot/bin/python'} 19:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:16 INFO - Downloading/unpacking psutil>=0.7.1 19:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:17:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:18 INFO - Installing collected packages: psutil 19:17:18 INFO - Running setup.py install for psutil 19:17:18 INFO - building 'psutil._psutil_linux' extension 19:17:18 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 19:17:18 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 19:17:18 INFO - building 'psutil._psutil_posix' extension 19:17:18 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 19:17:18 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 19:17:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:18 INFO - Successfully installed psutil 19:17:18 INFO - Cleaning up... 19:17:18 INFO - Return code: 0 19:17:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd655f2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1b920>, '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 0x1d1c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ccb0>, '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': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', '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 19:17:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:17:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:17:18 INFO - Using env: {'DISPLAY': ':0', 19:17:18 INFO - 'HOME': '/home/cltbld', 19:17:18 INFO - 'LANG': 'en_US.UTF-8', 19:17:18 INFO - 'LANGUAGE': 'en_US:en', 19:17:18 INFO - 'LOGNAME': 'cltbld', 19:17:18 INFO - 'MAIL': '/var/mail/cltbld', 19:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:18 INFO - 'MOZ_NO_REMOTE': '1', 19:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:18 INFO - 'NO_EM_RESTART': '1', 19:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:18 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:18 INFO - 'SHELL': '/bin/bash', 19:17:18 INFO - 'SHLVL': '1', 19:17:18 INFO - 'TERM': 'linux', 19:17:18 INFO - 'TMOUT': '86400', 19:17:18 INFO - 'USER': 'cltbld', 19:17:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', 19:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:18 INFO - '_': '/tools/buildbot/bin/python'} 19:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:17:19 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 19:17:19 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 19:17:19 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 19:17:19 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 19:17:19 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 19:17:19 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 19:17:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:17:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:17:20 INFO - Installing collected packages: mozsystemmonitor 19:17:20 INFO - Running setup.py install for mozsystemmonitor 19:17:20 INFO - Successfully installed mozsystemmonitor 19:17:20 INFO - Cleaning up... 19:17:21 INFO - Return code: 0 19:17:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:21 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 0x7fd655f2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1b920>, '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 0x1d1c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ccb0>, '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': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', '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 19:17:21 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 19:17:21 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 19:17:21 INFO - Using env: {'DISPLAY': ':0', 19:17:21 INFO - 'HOME': '/home/cltbld', 19:17:21 INFO - 'LANG': 'en_US.UTF-8', 19:17:21 INFO - 'LANGUAGE': 'en_US:en', 19:17:21 INFO - 'LOGNAME': 'cltbld', 19:17:21 INFO - 'MAIL': '/var/mail/cltbld', 19:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:21 INFO - 'MOZ_NO_REMOTE': '1', 19:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:21 INFO - 'NO_EM_RESTART': '1', 19:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:21 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:21 INFO - 'SHELL': '/bin/bash', 19:17:21 INFO - 'SHLVL': '1', 19:17:21 INFO - 'TERM': 'linux', 19:17:21 INFO - 'TMOUT': '86400', 19:17:21 INFO - 'USER': 'cltbld', 19:17:21 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', 19:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:21 INFO - '_': '/tools/buildbot/bin/python'} 19:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:21 INFO - Downloading/unpacking blobuploader==1.2.4 19:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:22 INFO - Downloading blobuploader-1.2.4.tar.gz 19:17:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:17:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:17:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17:23 INFO - Downloading docopt-0.6.1.tar.gz 19:17:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:17:23 INFO - Installing collected packages: blobuploader, requests, docopt 19:17:23 INFO - Running setup.py install for blobuploader 19:17:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:17:23 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:17:23 INFO - Running setup.py install for requests 19:17:24 INFO - Running setup.py install for docopt 19:17:24 INFO - Successfully installed blobuploader requests docopt 19:17:24 INFO - Cleaning up... 19:17:24 INFO - Return code: 0 19:17:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:24 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 0x7fd655f2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1b920>, '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 0x1d1c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ccb0>, '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': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', '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 19:17:24 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 19:17:24 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 19:17:24 INFO - Using env: {'DISPLAY': ':0', 19:17:24 INFO - 'HOME': '/home/cltbld', 19:17:24 INFO - 'LANG': 'en_US.UTF-8', 19:17:24 INFO - 'LANGUAGE': 'en_US:en', 19:17:24 INFO - 'LOGNAME': 'cltbld', 19:17:24 INFO - 'MAIL': '/var/mail/cltbld', 19:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:24 INFO - 'MOZ_NO_REMOTE': '1', 19:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:24 INFO - 'NO_EM_RESTART': '1', 19:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:24 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:24 INFO - 'SHELL': '/bin/bash', 19:17:24 INFO - 'SHLVL': '1', 19:17:24 INFO - 'TERM': 'linux', 19:17:24 INFO - 'TMOUT': '86400', 19:17:24 INFO - 'USER': 'cltbld', 19:17:24 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', 19:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:24 INFO - '_': '/tools/buildbot/bin/python'} 19:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:17:24 INFO - Running setup.py (path:/tmp/pip-jrUsbZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:17:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:17:24 INFO - Running setup.py (path:/tmp/pip-w8bCpS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:17:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:17:24 INFO - Running setup.py (path:/tmp/pip-65Dvko-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:17:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:17:24 INFO - Running setup.py (path:/tmp/pip-d7xvvk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:17:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:17:24 INFO - Running setup.py (path:/tmp/pip-CFlC4D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:17:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:17:24 INFO - Running setup.py (path:/tmp/pip-QlOoWW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:17:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:17:24 INFO - Running setup.py (path:/tmp/pip-4wod2o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:17:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:17:24 INFO - Running setup.py (path:/tmp/pip-y5AGbc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:17:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:17:24 INFO - Running setup.py (path:/tmp/pip-X7d9qV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:17:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:17:24 INFO - Running setup.py (path:/tmp/pip-76a80W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:17:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:17:24 INFO - Running setup.py (path:/tmp/pip-wMJhpn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:17:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:17:25 INFO - Running setup.py (path:/tmp/pip-ms0D8o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:17:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:17:25 INFO - Running setup.py (path:/tmp/pip-3vN3ln-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:17:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:17:25 INFO - Running setup.py (path:/tmp/pip-ju0LGk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:17:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:17:25 INFO - Running setup.py (path:/tmp/pip-zOlaxw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:17:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:17:25 INFO - Running setup.py (path:/tmp/pip-cLF9HO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:17:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:17:25 INFO - Running setup.py (path:/tmp/pip-0U2a1z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:17:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:17:25 INFO - Running setup.py install for manifestparser 19:17:25 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:17:25 INFO - Running setup.py install for mozcrash 19:17:25 INFO - Running setup.py install for mozdebug 19:17:25 INFO - Running setup.py install for mozdevice 19:17:25 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:17:25 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:17:25 INFO - Running setup.py install for mozfile 19:17:25 INFO - Running setup.py install for mozhttpd 19:17:25 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:17:25 INFO - Running setup.py install for mozinfo 19:17:26 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:17:26 INFO - Running setup.py install for mozInstall 19:17:26 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:17:26 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:17:26 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:17:26 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:17:26 INFO - Running setup.py install for mozleak 19:17:26 INFO - Running setup.py install for mozlog 19:17:26 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:17:26 INFO - Running setup.py install for moznetwork 19:17:26 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:17:26 INFO - Running setup.py install for mozprocess 19:17:26 INFO - Running setup.py install for mozprofile 19:17:26 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:17:26 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:17:26 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:17:26 INFO - Running setup.py install for mozrunner 19:17:26 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:17:26 INFO - Running setup.py install for mozscreenshot 19:17:26 INFO - Running setup.py install for moztest 19:17:26 INFO - Running setup.py install for mozversion 19:17:26 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:17:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:17:26 INFO - Cleaning up... 19:17:26 INFO - Return code: 0 19:17:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:26 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 0x7fd655f2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1b920>, '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 0x1d1c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ccb0>, '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': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', '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 19:17:26 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 19:17:26 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 19:17:26 INFO - Using env: {'DISPLAY': ':0', 19:17:26 INFO - 'HOME': '/home/cltbld', 19:17:26 INFO - 'LANG': 'en_US.UTF-8', 19:17:26 INFO - 'LANGUAGE': 'en_US:en', 19:17:26 INFO - 'LOGNAME': 'cltbld', 19:17:26 INFO - 'MAIL': '/var/mail/cltbld', 19:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:26 INFO - 'MOZ_NO_REMOTE': '1', 19:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:26 INFO - 'NO_EM_RESTART': '1', 19:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:26 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:26 INFO - 'SHELL': '/bin/bash', 19:17:26 INFO - 'SHLVL': '1', 19:17:26 INFO - 'TERM': 'linux', 19:17:26 INFO - 'TMOUT': '86400', 19:17:26 INFO - 'USER': 'cltbld', 19:17:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', 19:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:26 INFO - '_': '/tools/buildbot/bin/python'} 19:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:17:27 INFO - Running setup.py (path:/tmp/pip-xAGceB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:17:27 INFO - Running setup.py (path:/tmp/pip-CPpc8Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:17:27 INFO - Running setup.py (path:/tmp/pip-lnm4Jt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:17:27 INFO - Running setup.py (path:/tmp/pip-a0UFv3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:17:27 INFO - Running setup.py (path:/tmp/pip-kRTRsB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:17:27 INFO - Running setup.py (path:/tmp/pip-JPLQUp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:17:27 INFO - Running setup.py (path:/tmp/pip-B_C3eH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:17:27 INFO - Running setup.py (path:/tmp/pip-Tj6on9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:17:27 INFO - Running setup.py (path:/tmp/pip-m1xTQY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:17:27 INFO - Running setup.py (path:/tmp/pip-zgYiJJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:17:27 INFO - Running setup.py (path:/tmp/pip-_3H1hn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:17:27 INFO - Running setup.py (path:/tmp/pip-eaIHLS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:17:27 INFO - Running setup.py (path:/tmp/pip-KO76uT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:17:27 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)) 19:17:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:17:28 INFO - Running setup.py (path:/tmp/pip-ycxwtl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:17:28 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)) 19:17:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:17:28 INFO - Running setup.py (path:/tmp/pip-rcja8q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:17:28 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)) 19:17:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:17:28 INFO - Running setup.py (path:/tmp/pip-m8JQSb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:17:28 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)) 19:17:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:17:28 INFO - Running setup.py (path:/tmp/pip-4gwIog-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:17:28 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)) 19:17:28 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)) 19:17:28 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)) 19:17:28 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)) 19:17:28 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)) 19:17:28 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)) 19:17:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17:30 INFO - Downloading blessings-1.6.tar.gz 19:17:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:17:30 INFO - Installing collected packages: blessings 19:17:30 INFO - Running setup.py install for blessings 19:17:30 INFO - Successfully installed blessings 19:17:30 INFO - Cleaning up... 19:17:30 INFO - Return code: 0 19:17:30 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:17:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:17:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:17:30 INFO - Reading from file tmpfile_stdout 19:17:30 INFO - Current package versions: 19:17:30 INFO - argparse == 1.2.1 19:17:30 INFO - blessings == 1.6 19:17:30 INFO - blobuploader == 1.2.4 19:17:30 INFO - docopt == 0.6.1 19:17:30 INFO - manifestparser == 1.1 19:17:30 INFO - mozInstall == 1.12 19:17:30 INFO - mozcrash == 0.17 19:17:30 INFO - mozdebug == 0.1 19:17:30 INFO - mozdevice == 0.48 19:17:30 INFO - mozfile == 1.2 19:17:30 INFO - mozhttpd == 0.7 19:17:30 INFO - mozinfo == 0.9 19:17:30 INFO - mozleak == 0.1 19:17:30 INFO - mozlog == 3.1 19:17:30 INFO - moznetwork == 0.27 19:17:30 INFO - mozprocess == 0.22 19:17:30 INFO - mozprofile == 0.28 19:17:30 INFO - mozrunner == 6.11 19:17:30 INFO - mozscreenshot == 0.1 19:17:30 INFO - mozsystemmonitor == 0.0 19:17:30 INFO - moztest == 0.7 19:17:30 INFO - mozversion == 1.4 19:17:30 INFO - psutil == 3.1.1 19:17:30 INFO - requests == 1.2.3 19:17:30 INFO - wsgiref == 0.1.2 19:17:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:17:30 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')]} 19:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:30 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')]} 19:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:30 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 0x7fd655f2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1b920>, '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 0x1d1c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ccb0>, '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': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', '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 19:17:30 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 19:17:30 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 19:17:30 INFO - Using env: {'DISPLAY': ':0', 19:17:30 INFO - 'HOME': '/home/cltbld', 19:17:30 INFO - 'LANG': 'en_US.UTF-8', 19:17:30 INFO - 'LANGUAGE': 'en_US:en', 19:17:30 INFO - 'LOGNAME': 'cltbld', 19:17:30 INFO - 'MAIL': '/var/mail/cltbld', 19:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:30 INFO - 'MOZ_NO_REMOTE': '1', 19:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:30 INFO - 'NO_EM_RESTART': '1', 19:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:30 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:30 INFO - 'SHELL': '/bin/bash', 19:17:30 INFO - 'SHLVL': '1', 19:17:30 INFO - 'TERM': 'linux', 19:17:30 INFO - 'TMOUT': '86400', 19:17:30 INFO - 'USER': 'cltbld', 19:17:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', 19:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:30 INFO - '_': '/tools/buildbot/bin/python'} 19:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 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)) 19:17:30 INFO - Cleaning up... 19:17:30 INFO - Return code: 0 19:17:30 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:17:30 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')]} 19:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:30 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')]} 19:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:30 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 0x7fd655f2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1b920>, '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 0x1d1c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ccb0>, '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': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', '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 19:17:30 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 19:17:30 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 19:17:30 INFO - Using env: {'DISPLAY': ':0', 19:17:30 INFO - 'HOME': '/home/cltbld', 19:17:30 INFO - 'LANG': 'en_US.UTF-8', 19:17:30 INFO - 'LANGUAGE': 'en_US:en', 19:17:30 INFO - 'LOGNAME': 'cltbld', 19:17:30 INFO - 'MAIL': '/var/mail/cltbld', 19:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:30 INFO - 'MOZ_NO_REMOTE': '1', 19:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:30 INFO - 'NO_EM_RESTART': '1', 19:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:30 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:30 INFO - 'SHELL': '/bin/bash', 19:17:30 INFO - 'SHLVL': '1', 19:17:30 INFO - 'TERM': 'linux', 19:17:30 INFO - 'TMOUT': '86400', 19:17:30 INFO - 'USER': 'cltbld', 19:17:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', 19:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:30 INFO - '_': '/tools/buildbot/bin/python'} 19:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:30 INFO - Downloading/unpacking jsonschema 19:17:30 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 19:17:30 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 19:17:30 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 19:17:30 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 19:17:30 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 19:17:30 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 19:17:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:17:32 INFO - Downloading/unpacking functools32 (from jsonschema) 19:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:32 INFO - Downloading functools32-3.2.3-2.tar.gz 19:17:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:17:32 INFO - warning: no files found matching '*.txt' 19:17:32 INFO - no previously-included directories found matching 'build' 19:17:32 INFO - no previously-included directories found matching 'dist' 19:17:32 INFO - no previously-included directories found matching '.git*' 19:17:32 INFO - Installing collected packages: jsonschema, functools32 19:17:32 INFO - Running setup.py install for functools32 19:17:33 INFO - warning: no files found matching '*.txt' 19:17:33 INFO - no previously-included directories found matching 'build' 19:17:33 INFO - no previously-included directories found matching 'dist' 19:17:33 INFO - no previously-included directories found matching '.git*' 19:17:33 INFO - Successfully installed jsonschema functools32 19:17:33 INFO - Cleaning up... 19:17:33 INFO - Return code: 0 19:17:33 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:17:33 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')]} 19:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:33 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')]} 19:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:33 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 0x7fd655f2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1b920>, '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 0x1d1c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ccb0>, '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': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', '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 19:17:33 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 19:17:33 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 19:17:33 INFO - Using env: {'DISPLAY': ':0', 19:17:33 INFO - 'HOME': '/home/cltbld', 19:17:33 INFO - 'LANG': 'en_US.UTF-8', 19:17:33 INFO - 'LANGUAGE': 'en_US:en', 19:17:33 INFO - 'LOGNAME': 'cltbld', 19:17:33 INFO - 'MAIL': '/var/mail/cltbld', 19:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:33 INFO - 'MOZ_NO_REMOTE': '1', 19:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:33 INFO - 'NO_EM_RESTART': '1', 19:17:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:33 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:33 INFO - 'SHELL': '/bin/bash', 19:17:33 INFO - 'SHLVL': '1', 19:17:33 INFO - 'TERM': 'linux', 19:17:33 INFO - 'TMOUT': '86400', 19:17:33 INFO - 'USER': 'cltbld', 19:17:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', 19:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:33 INFO - '_': '/tools/buildbot/bin/python'} 19:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:33 INFO - Downloading/unpacking flake8 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:17:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:17:35 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 19:17:35 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 19:17:35 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 19:17:35 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 19:17:35 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 19:17:35 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 19:17:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:17:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:17:35 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 19:17:35 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 19:17:35 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 19:17:35 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 19:17:35 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 19:17:35 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 19:17:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:17:35 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 19:17:35 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 19:17:35 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 19:17:35 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 19:17:35 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 19:17:35 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 19:17:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:17:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:17:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:17:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:17:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:17:35 INFO - no previously-included directories found matching 'docs/_build' 19:17:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:17:35 INFO - Running setup.py install for pep8 19:17:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:17:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:17:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:17:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:17:35 INFO - no previously-included directories found matching 'docs/_build' 19:17:35 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:17:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:17:35 INFO - Cleaning up... 19:17:35 INFO - Return code: 0 19:17:35 INFO - Running post-action listener: _resource_record_post_action 19:17:35 INFO - Running post-action listener: _start_resource_monitoring 19:17:35 INFO - Starting resource monitoring. 19:17:35 INFO - ##### 19:17:35 INFO - ##### Running install step. 19:17:35 INFO - ##### 19:17:35 INFO - Running pre-action listener: _resource_record_pre_action 19:17:35 INFO - Running main action method: install 19:17:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:17:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:17:36 INFO - Reading from file tmpfile_stdout 19:17:36 INFO - Detecting whether we're running mozinstall >=1.0... 19:17:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:17:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:17:36 INFO - Reading from file tmpfile_stdout 19:17:36 INFO - Output received: 19:17:36 INFO - Usage: mozinstall [options] installer 19:17:36 INFO - Options: 19:17:36 INFO - -h, --help show this help message and exit 19:17:36 INFO - -d DEST, --destination=DEST 19:17:36 INFO - Directory to install application into. [default: 19:17:36 INFO - "/builds/slave/test-pgo"] 19:17:36 INFO - --app=APP Application being installed. [default: firefox] 19:17:36 INFO - mkdir: /builds/slave/test-pgo/build/application 19:17:36 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'] 19:17:36 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 19:17:52 INFO - Reading from file tmpfile_stdout 19:17:52 INFO - Output received: 19:17:52 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:17:52 INFO - Running post-action listener: _resource_record_post_action 19:17:52 INFO - ##### 19:17:52 INFO - ##### Running run-tests step. 19:17:52 INFO - ##### 19:17:52 INFO - Running pre-action listener: _resource_record_pre_action 19:17:52 INFO - Running main action method: run_tests 19:17:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:17:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:17:52 INFO - Python 2.7.3 19:17:52 INFO - Return code: 0 19:17:52 INFO - grabbing minidump binary from tooltool 19:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:52 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 0x1d1b920>, '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 0x1d1c820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ccb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:17:52 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 19:17:52 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 19:17:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:17:52 INFO - Return code: 0 19:17:52 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:17:52 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:17:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:17:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:17:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:17:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:17:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:17:53 INFO - Return code: 0 19:17:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 19:17:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 19:17:53 INFO - Using env: {'DISPLAY': ':0', 19:17:53 INFO - 'HOME': '/home/cltbld', 19:17:53 INFO - 'LANG': 'en_US.UTF-8', 19:17:53 INFO - 'LANGUAGE': 'en_US:en', 19:17:53 INFO - 'LOGNAME': 'cltbld', 19:17:53 INFO - 'MAIL': '/var/mail/cltbld', 19:17:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:17:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:53 INFO - 'MOZ_NO_REMOTE': '1', 19:17:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:53 INFO - 'NO_EM_RESTART': '1', 19:17:53 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:17:53 INFO - 'PWD': '/builds/slave/test-pgo', 19:17:53 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:17:53 INFO - 'SHELL': '/bin/bash', 19:17:53 INFO - 'SHLVL': '1', 19:17:53 INFO - 'TERM': 'linux', 19:17:53 INFO - 'TMOUT': '86400', 19:17:53 INFO - 'USER': 'cltbld', 19:17:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1457493412.887070-1404109586', 19:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:53 INFO - '_': '/tools/buildbot/bin/python'} 19:17:53 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 19:17:53 INFO - mozversion application_buildid: 20160308163019 19:17:53 INFO - mozversion application_changeset: 886b5480b5781f204b89dc9e10bc991a0fa3d3c9 19:17:53 INFO - mozversion application_display_name: Nightly 19:17:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:17:53 INFO - mozversion application_name: Firefox 19:17:53 INFO - mozversion application_remotingname: firefox 19:17:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:17:53 INFO - mozversion application_vendor: Mozilla 19:17:53 INFO - mozversion application_version: 48.0a1 19:17:53 INFO - mozversion platform_buildid: 20160308163019 19:17:53 INFO - mozversion platform_changeset: 886b5480b5781f204b89dc9e10bc991a0fa3d3c9 19:17:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:17:53 INFO - mozversion platform_version: 48.0a1 19:17:53 INFO - using testdate: 1457493473 19:17:53 INFO - actual date: 1457493473 19:17:53 INFO - starting webserver on 'localhost:35194' 19:17:53 INFO - SUITE-START | Running 2 tests 19:17:53 INFO - TEST-START | dromaeo_css 19:17:53 INFO - operating with platform_type : linux_ 19:17:53 INFO - Initialising browser for dromaeo_css test... 19:17:53 INFO - TEST-INFO | started process 26012 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ9H6FV/profile http://localhost:35194/getInfo.html) 19:17:57 INFO - PROCESS | 26012 | __metrics Screen width/height:1600/1200 19:17:57 INFO - PROCESS | 26012 | colorDepth:24 19:17:57 INFO - PROCESS | 26012 | Browser inner width/height: 1024/697 19:17:57 INFO - PROCESS | 26012 | __metrics 19:17:58 ERROR - PROCESS | 26012 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:17:58 INFO - TEST-INFO | 26012: exit 0 19:17:58 INFO - Browser initialized. 19:17:58 INFO - Running cycle 1/1 for dromaeo_css test... 19:17:58 INFO - TEST-INFO | started process 26103 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ9H6FV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:18:10 INFO - PROCESS | 26103 | RSS: Main: 153944064 19:18:10 INFO - PROCESS | 26103 | 19:19:01 INFO - PROCESS | 26103 | 1457493541824 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] 19:21:09 INFO - PROCESS | 26103 | Cycle 1(1): loaded http://localhost:35194/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35194/tests/dromaeo/cssquery-ext.html) 19:21:11 INFO - PROCESS | 26103 | RSS: Main: 278896640 19:21:11 INFO - PROCESS | 26103 | 19:24:13 INFO - PROCESS | 26103 | Cycle 1(1): loaded http://localhost:35194/tests/dromaeo/cssquery-ext.html (next: http://localhost:35194/tests/dromaeo/cssquery-jquery.html) 19:24:14 INFO - PROCESS | 26103 | RSS: Main: 233213952 19:24:14 INFO - PROCESS | 26103 | 19:27:15 INFO - PROCESS | 26103 | Cycle 1(1): loaded http://localhost:35194/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35194/tests/dromaeo/cssquery-mootools.html) 19:27:16 INFO - PROCESS | 26103 | RSS: Main: 233222144 19:27:16 INFO - PROCESS | 26103 | 19:30:18 INFO - PROCESS | 26103 | Cycle 1(1): loaded http://localhost:35194/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35194/tests/dromaeo/cssquery-prototype.html) 19:30:18 INFO - PROCESS | 26103 | RSS: Main: 215560192 19:30:18 INFO - PROCESS | 26103 | 19:33:21 INFO - PROCESS | 26103 | Cycle 1(1): loaded http://localhost:35194/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35194/tests/dromaeo/cssquery-yui.html) 19:33:21 INFO - PROCESS | 26103 | RSS: Main: 218152960 19:33:21 INFO - PROCESS | 26103 | 19:36:24 INFO - PROCESS | 26103 | Cycle 1(1): loaded http://localhost:35194/tests/dromaeo/cssquery-yui.html (next: http://localhost:35194/tests/dromaeo/cssquery-dojo.html) 19:36:24 INFO - PROCESS | 26103 | RSS: Main: 269090816 19:36:24 INFO - PROCESS | 26103 | 19:36:24 INFO - PROCESS | 26103 | __start_tp_report 19:36:24 INFO - PROCESS | 26103 | _x_x_mozilla_page_load 19:36:24 INFO - PROCESS | 26103 | _x_x_mozilla_page_load_details 19:36:24 INFO - PROCESS | 26103 | |i|pagename|runs| 19:36:24 INFO - PROCESS | 26103 | |0;dojo.html;3120.4851199552077;3154.05378386484;3209.422303985283;3216.083416226376;3243.0595127413053;4911.852644420665;4913.8771530711665;5102.10713125203;5167.974160129199;5172.948270517294;5043.672161309512;5056.064628043814;5076.543111119999;5100;5153.201253805657;4567.931481027771;4616.2613981762925;4660.813567457298;4756.239001759719;4819.566239038486;4582.518835522255;4768.546988036131;4769.5707386335225;4787.880302992436;4846.176150054499;4658.487566367697;4662.533746625344;4672.275797251432;4675.88310292242;4679.789409476582;4656.627469802442;4665.906681866344;4678.602318802872;4739.573438390527;4767.308740232646;4616.907661846744;4643.326717625925;4645.5586719261955;4646.581807637329;4685.835995740167;4947.653664243504;4949.529794669501;4957.182064959277;4966.279889416014;5018.422881368653;5360.061989151883;5448.7548060336985;5545.584081193927;5577.274954255961;5579.832605021816;5479.917801232985;5538.169274608801;5564.610477266593;5566.582506312043;5571.108622620402;5033.094043072282;5179.274901513753;5183.041137389595;5188.870278243036;5223.3209682741;5527.972360138174;5615.213870058195;5633.63381380209;5663.631863928831;5670.5180059695385;5389.514943655012;5393.2449457076045;5396.298481197419;5416.0792665247;5417.702026388586;5343.946560534423;5427.6472029317965;5447.700376479253;5483.479069488392;5497.835064948058;5425.755840987086;5440.455954404528;5449.182622606561;5460.426655201226;5513.9448605514235;5393.352797664305;5417.349918009864;5424.701641409761;5442.755076021588;5466.262054622654;4080.510338759368;4120.608542188487;4157.147784704129;4175.97912010438;4197.748135111903;3755.117547376364;3765.811709414518;3770.1517158639085;3808.7524310919703;3838.5777564467885;5140.228965655182;5153.896922061613;5161.66449180802;5166.664166829144;5170.1727723564045;5279.762410691528;5405.324334458192;5434.049041417736;5490.011797876421;5505.394406615349;5135.512126347991;5140.1004824155625;5143.5113664201845;5152.433232344439;5199.428062913076;4658.254679251304;4661.114388266218;4681.8361357353015;4726.645501587326;4734.7632618369635;5658.207850900877;5675.971620141873;5714.742836572447;5755.510781583613;5794.536437085023;5412.648177868426;5431.56547476193;5439.5104440600535;5443.564514838724;5484.91772623403;5507.284053073075;5701.629394089371;5712.971435142797;5738.081906895044;5742.454466825645;5414.133738601805;5449.809256675997;5450.182472629137;5452.073147565003;5486.753096110605;5356.223347614497;5441.83674489766;5475.6440831345835;5481.260029895913;5487.1494918286135;5175.508326708957;5317.97341013308;5332.226827110125;5338.946610533845;5352.0366334060245;5321.441248668834;5324.227986941794;5336.386315573759;5353.732313384393;5399.514043736082;5221.060209162387;5244.632875698664;5261.868453288698;5270.314859068297;5277.050130976461;5149.897002060013;5333;5338;5353.089974704231;5427.05026620332;5089.13484707608;5199.948000519947;5224.686518808883;5242.868928276824;5245.89508209826 19:36:24 INFO - PROCESS | 26103 | |1;ext.html;518.2407772613121;550.4138092931029;564.2636359550787;566.3006187358611;588.7497813429293;37676.811615941915;37894;37915.620843791556;37957.81021094898;38101.04747381313;40911.18177636453;41132;41185.52886826785;41277;41331.17337653245;8420.452670576407;8566.486010839339;8588.098249683788;8606.612702428374;8614.569271536398;8548.145185481464;8671.523066231355;8687.695930642429;8834.293256539462;8848.690295839648;8846.292296616288;8854.247388971946;8927.06265842087;8933.285337173043;8941.865872011926;8762.60568274426;8851.203391694746;8865.379423440361;8879.200871921526;8906.465612063297;8690.261327787146;8734.90813648294;8778.47329160246;8789.121087891224;8832.425892317044;40242.39636405456;40694.59305406937;40698.1860362794;40835.79582102071;41018.79490602558;3152.274976755336;3620.4931309616672;3850.5186851643543;3924.666403355718;3968;30311.24221894448;30767.628062029242;30999.690003099906;31226.53160202599;31410.057698269087;3776.603456637041;3801.448789925473;3838.865639702597;3897.80510974453;3932.0956180078742;265830;266059;266254;267680;268447;41652.79173604112;42550.57449425466;58863.70568147132;58935.41064589299;59208.70395647994;40227.79886100551;40394;40466.59533404687;40532.39201411981;40570.39144412836;13350.866491335157;13459;13475.730485390237;13500.257485838176;13564.253966031765;10716.946415267874;10788.622398216025;10792.082672972729;10792.352458852494;10805.351678899291;13643.113197642122;14116.85883141176;14157.07978981363;14167.504137355349;14188;5718.485336319751;5806.158107074535;5823.301203855564;5878.5297176225795;5888.499477544457;892.6474042753076;922.5663937949154;934.6541779541614;943.2077055273603;1043.2071625564627;27900.302492437444;28613.28466788347;29280.414391712045;29391.55912661312;29413.85293073521;1004.8241557727368;1023.2325755683238;1028.3161697471248;1100.1418893263267;1107.8781334053247;14429.35067921946;14904.776428353583;14956.925215373854;15140.242987850563;15171.16558589266;341724;346146;351665;351834;353014;52471.21293180529;52686.473135268156;52945.7352713234;53027.73486132544;53140.46859531433;1108.3294606762954;1251.9499220031096;1290.6966862787237;1296.598054603076;1415.6673181802269;25626.87186564055;26861.86569067142;27064.594031089156;27554.448911022067;28001.71998279991;40426.59573404228;40970.59029409668;41412.585874140874;41422.58577414187;41443;186215;186794;196800;200213;201021;27427.588586170823;31490.527642085846;31560.52659210068;32094.67905320917;32170.19574510656;38086.23827523489;38572.80713596414;39102.6089739099;39595.406068909564;39707;32538.186545336557;32542;33232.00303990884;34958.47562286517;35819.64180358163;34791.304173916884;34862.47706284357;35012.64987350094;35751.64248357483;35759.106022349646;34106;34717.652823472454;34935;35287.82356088203;35541.466877997365;30821.537676935313;31353.52969705502;31498;31726.841365793025;31749;23532.526172780115;24526.54300370402;24537.754622453547;24775.25674229776;25019 19:36:24 INFO - PROCESS | 26103 | |2;jquery.html;359.1595666141229;361.65461983805466;364.3787342580899;370.9128354836611;372.9984990301042;16808;16813.411530596433;17395.82604173958;17472.91263543682;17867.106644667747;15321.616959575987;16313.592160196002;16852.494425167235;16872.578185545335;16874.746878796795;5882.29412470503;6534.640594767286;6756.831079223034;6768.729250829961;6823.3858952694245;4322.113966636847;6494.707738151795;6663.167104111986;6793.184817821868;6812.965935170318;6689.096971908779;6757.425618822406;6788.049673045777;6793.184817821868;6795.286494918037;6766.086578311914;6772.932270677304;6941.5140940134215;6943.132108486439;6968.303169683017;4203.4115223868685;6132.264128304588;6510.056041873901;6517.055027021055;6656.500762442788;21265;22058.227962021254;22205;22349.10603575855;22353.55292894149;2093.874367537953;2115.777843326444;2133.4986278224605;2157.600843843878;2391.5336509380677;13086.476540938445;13958.860411395959;14184.439711631712;14484.203368814711;14689.926550367287;1924.6246981838547;1930.94207173785;1968.3307675390436;1970.7967379228942;1979.5051237190703;69573;69689.65155174192;69763.65118174428;72118.27881721169;74525.62737186279;15201.239938003277;15505.457308994357;15525;15548.455804046804;15548.533543993699;23749.168779092648;23886.7611323888;24103.879480602485;24113.27660170198;24124;8522.65909363631;8615.526146061902;8687.956560217284;8723.084076172037;8805.42764720304;7336.963315183497;7372.741954031583;7460.70157193717;7467.477276590586;7481.401487881065;7694.384449244159;7710.267524585155;7780;7791.688332466638;7799.142094369615;2452.6075827867458;2916.2126225918882;2946.852657367123;2948.616679831608;3031.7574594032426;843.852325842975;880.7365071765502;1026.0867827633413;1031.7317497450717;1035.9896401036044;15746.76379854303;16178.352865885232;16187.271572779018;16203.756943645854;16903.32386704518;895.3016647015338;896.9551522423983;898.380117718772;912.5847739278612;995.5022488755623;9096.408733432305;9279.304052196112;9327.533623318806;9461.19579835708;9551.474668893277;440155;451607;455866;473257.9011314833;475642.21788910415;67773;72649.45726899533;72677.2732272681;72784.63607681928;73080.63459682667;954.1841725324747;964.3779762053437;971.2618410008445;971.946542940145;976.1751320134475;14317;14742.778858316919;14768.63078423048;14784.408623654934;14917.701645967238;32191;33755.493667594514;33985.490217646264;34229.65770342265;34382;44003.559964399945;47510;47747.28379074386;47895;47949.520504794506;7515.962420187864;7542.736004239825;7645.770626881203;7762.68949242024;7768.339691126317;11184.94407527957;12390.81413778776;12529.37353132358;12598.622041338775;12777.297248651414;10657;10682.198835087243;10703.3577985318;10725.356478611307;10813.297135686154;8799.912000880166;10372.948135259276;10597.682069537927;10706.518206680874;10753.784924301626;10842;10905.509252083833;10952.616658416917;11267.042301404144;11304.43477826089;7519.887201692089;7662.118856331594;7739.883901741591;7749.961250193713;8200.220979006985;10480.213983951387;10553.472326383804;10631.574737010433;10678.412687302272;11219.158563107636 19:36:24 INFO - PROCESS | 26103 | |3;mootools.html;1316.4799904037911;1451.1728314860527;1460.5034288341965;1617.6683779825137;1780.14553014553;7443.702251909924;7649.235076492348;7665.923340766604;7674.731384401554;7689.653965571549;7474.738384156555;7624.0851097868335;7671.693132274702;7679.961600191991;7701.499402538831;1984.4046785964226;2210.834187435949;2261.5929132756096;2280.042382199476;2298.54029194161;2210.060724192212;2219.112355057982;2225.866448013124;2228.2869481765842;2230.9888450557723;2191.2221161487682;2255.7293124825046;2262.061244583496;2263.151318255654;2277.578647950126;2143.603433364825;2206.4925067234626;2208.216083290441;2245;2253.0987604957986;2242.742084660252;2255.8082562982167;2269.262489690857;2273.522560262347;2292.6331786914016;7808.570528620923;7889.8816517752275;7895.763127106138;7914.169012253746;7928.207179282025;4687.484376718558;4833.03339332135;4854.611631069506;4859.441164266119;4887.486813884562;2932.8680209390627;2966.5401862711096;3002.1143762590086;3011.4729922263737;3102.16241614765;920.1994264989502;940.3229674634252;943.5989704375613;944.5985456181164;956.8421210500259;10690.572377104907;10849.349039057683;10885.455727213608;10890.673279801618;10973.286736362112;4296.613304802583;4402.537733537996;4422.624076953431;4426.313921342197;4442.866713998521;9198;9199.310051746146;9229.95385023084;9231.76920576991;9267.304952128618;4269.146170765859;4764.784979830121;4779.856604301876;4782.760861956888;4800.279958006257;4173.812178451977;4213.241616508996;4214.157168566299;4238.406623072772;4250.298700714347;3662.505561749183;3675.00774790805;3679.061839230979;3757.0231739747865;3768.6231376862092;1189.9286042837457;1203.0736333023524;1213.7208442058377;1214.611324376191;1220.060553373915;955.0497255231089;960.1838437328215;966.1256562810668;1050.3277902142636;1328.0902581731546;7499.8500029999095;7535.849283014419;7555.811104722316;7562.546247225184;7568.962155189189;496.14415133893743;500.92986981821844;510.7752588860889;513.5378159656265;514.4649564452927;5707.0868661014865;5711.371749107595;5714.342850572154;5773.1051686988585;5784.971075144682;9030;9077.500737459372;9257.629694812267;9268.35121541499;9302.953485232665;9067.274618030542;9132.543372831331;9145.588448519833;9187.494687792236;9211.585478653476;7067.293270672892;7194.568325900358;7279.963600181965;7288.6720097595735;7296.270372962661;7256.310650488195;7318.231585683427;7320.670569824264;7322.2677732228485;7351.963240183765;8083.19168083187;8351.457155284887;8494.362922780692;8510.872336915076;8534.189252021048;7743.651535680795;7973.282404583615;8088.352931765562;8144.511329320259;8161.959190204011;6295.779647712308;6451.935480645134;6543.116679248431;6613.470922326299;6644.069830223869;7343.963280183565;7355.705771769283;7387.335139837441;7402.888956665762;7415.443841712001;6704.9607310866895;6842.623655698785;6910.06714093611;7050.788476345718;7057.788266352018;6596.076549283008;6630.104935833793;6707.4969377297875;6724.73101075971;6837.3162683731225;6415.679216039272;6625.105610742488;7040.964795176196;7057.6471176442;7111.644417778987;5953.613015154001;5958.255218097738;5975.133605627073;5987.371326010706;6005.039193728982;5975.103734439695;6008.218931538872;6015.72929218195;6022.277326720821;6044.214252147192 19:36:24 INFO - PROCESS | 26103 | |4;prototype.html;320.2394313505425;326.73044738091096;339.3416771463361;339.6925782167138;348.58170195765075;5827;5900.734466948992;5937.079752638342;5980.073088671252;6040.546958978072;5797.043487824504;5801.332846722628;5825.359210486843;5837.211976383187;5843.503302219306;4352.73883566987;4412.24991751403;4480.865574032784;4487.371767952481;4516.9096618067615;4489.842855500058;4506.77466126694;4509.210888094587;4532.8413505527315;4539.7957091930775;4477.641788656916;4478.955210447903;4490.842820501283;4503.301988191819;4514.548545145492;4308.43990281263;4391.516933137336;4480.171168333836;4499.707519011254;4502.819887204508;3961.375835907264;3968.40473928913;3968.444417781513;3977.5823538528325;3984.980075099635;5574.470425309589;5591.524720398771;5608.4111168327145;5622.49397554218;5625.212470254127;5237.528622424;5239.397469291042;5247.921281180786;5264.42091369949;5270.025045366619;6137.7851775187655;6160.630362178284;6161.537884658624;6197.349278325801;6198.566100372976;4081.551029386765;4254.106637606106;4258.510271318807;4424.292113261863;4424.380586717862;6316.463100636452;6362.981922892315;6408.711607977605;6421.8394540136405;6434.485241180694;4356.106998065452;4359.237133501624;4359.346098085312;4359.716618419856;4381.496127945264;4413.161499315184;4421.955780442155;4424.982254081515;4425.004374015885;4449.621782148489;5130.48695130484;5130.692158470503;5143.61422893277;5160.690358578498;5167.199084141964;5971.253593300838;6171.753129874754;6204.169769917885;6213.968930155411;6221.9377806222265;1592.1243316176058;1600.1599160440628;1610.2592807308536;1612.1052815687171;1615.200475764504;996.9651062212788;1047.696168111239;1085.3596378136938;1112.7996960547018;1127.233481232753;5851.795187168429;5856.209411729447;5861.443162899518;5919.822405327847;5934.673592952429;6300.3699630037545;6302.1177035215105;6315.936840631627;6329.303776584572;6340.207474065742;5880.235569376039;5886.087656413263;5922.1412895130825;5923.585349025613;5935.614185077956;3362.9495557566656;3414.129397003748;3420.1278673937986;3426.7258619310396;3433.5536380270905;6534.640594767334;6672.466202703772;6677.532572719863;6829.146356705412;6939.93060069403;6556.344365563501;6569.605823650596;6605.438537724252;6618.536702430783;6626.271110177877;6771.864562708718;6779.762708305284;6784.185897692309;6792.3886850182735;6799.558028728117;6402.90395644075;6422.32565580626;6433.13439102655;6433.356664333716;6476.287608363171;6132.9080063799975;6312.621242725451;6344.460720838781;6345.206849143857;6348.587341822767;6801.9319806801295;6828.760993365208;6874.518783685294;6900.551464154814;6909.619970901447;4257.318828987347;4297.892552686208;4308.526062133225;4308.547602501818;4309.439772829513;6461.547691661539;6463.709133089116;6465.030245463218;6469.3530646936815;6471.546991710535;6289.7169627365965;6294.622322660655;6296.5592408530965;6300.936990630218;6303.621782693053;6034.366391529002;6243.250809902841;6243.406876346739;6251.468625166912;6256.154434441942;6115.694215289129;6136.723847426966;6138.324784273816;6144.324124346229;6150.169727086786;6273.843153921189;6276.717547710273;6284.465820405317;6288.213973253343;6304.873902522016;5893.675847828239;5974.551908606959;6091.451769340781;6174.104754810617;6189.721462534107 19:36:24 INFO - PROCESS | 26103 | |5;yui.html;801.8556659801235;814.9429539932204;816.1348970091703;817.5380909785974;832.2925513313683;12340.382980850954;12786.488540458371;12799.552015679441;12849.743005139891;12858.22850628963;11879.881201187985;11962.342071186082;11973.760524789499;11999.460024298905;12054.57808976686;821.3593397150232;847.2501835875264;847.9448835825682;849.1508491508491;851.0510780479751;684.7226873116371;792.7265093542718;812.4718932693737;813.3980854167933;814.226484839402;884.747846863644;884.9469031858109;887.3744010472634;887.6893087419384;891.6968230801526;710.183289217399;880.0363601856021;882.9779255518631;885.3315746611299;886.5301390263138;644.249449391463;652;653.7058323754329;654.2802916791538;654.3227759269181;13190.142640728322;13222.206667599974;13305.201687898758;13311.201327920258;13331.733365332639;11798.764024719543;12491.812622810665;12530.972396704889;12672.303023333712;12773.936130319382;10360.844587331196;10503.264771466;10633.627823026234;10650.680479585624;10672.306300090548;3519.1202199450136;3576.499290099388;3659.871904483357;3688.3729765939856;3700.4449332600325;50982.490175098515;52347.47652523464;52585.948281034165;52615.47384526144;52765;10048.145506419378;10194.847077293847;10266.794664106676;10310.123639490577;10316.793664126675;18805;18829.905850470936;18866.434006979813;18887.150078246235;18894.05529723508;6775.322467753185;6848.931510684829;6914.792556223321;7191.388731957738;7205.603691796897;4271.188474189894;4382.145481631115;4430.5126436092005;4562.087582483517;4568.337591049346;3094.4894092474487;3126.4841301185506;3137.7803553751473;3145.402373549018;3150.2439414540345;591.7189335065896;598.5720210049835;605.6699098990972;612.9448349648553;613.2671457608204;650.5088658063132;654.9705263263164;684.3772167327708;685.2530741491698;734.4124700239787;7739.535627862234;8107.2703456688005;8235.341172706168;8271.54506502148;8416.873746893802;561.719140429785;612.3203244398713;612.9946887105151;641.3874749614107;679.0357692077262;3755.6619904208205;3769.698424126118;3860.864869729546;3960.742551734186;4045.2516284486874;58891.41108588859;59386.70306648439;60519.69740151359;61124;61174;53090.73454632702;53447.732761335945;53670.194947075826;53696.194557081675;54133.72933135309;46717.53282467132;47125;47242;47770.5222947773;47799.76100119477;7661.016271538657;7724.266194711493;7812.140664527011;7861.292483676497;7971.72098976533;33241;35465.29069418545;36048.27903441864;36214.8189259052;36557.817210914836;41982;41994.58005419907;44873.32690009718;46408.53591464042;47418.76290618525;9821.950890245504;9931.602735890483;10009.199264058712;10010.549525271526;10445.321054131457;11054.170937179582;11188.384638844616;11221.495032723711;11271.549138034386;11283.153763467608;9274.44353338802;10966.835497467384;11195.888041119484;11494.94252528732;11537.538498459968;10749.946250268698;10797.211125722839;10913.454327283764;10967.890321096687;11269.098472122047;11033.227674062739;11245.116019456196;11285.661430157108;11317.264377815416;11586.826197607212;9569;9573.473458959825;9636.42181469114;9660.468674222704;9849.212063035084;10059.748506287402;10200.795984080425;10218.489075546342;10246.6413675521;10293.125084367912 19:36:24 INFO - PROCESS | 26103 | __end_tp_report 19:36:24 INFO - PROCESS | 26103 | __start_cc_report 19:36:24 INFO - PROCESS | 26103 | _x_x_mozilla_cycle_collect,990 19:36:24 INFO - PROCESS | 26103 | __end_cc_report 19:36:24 INFO - PROCESS | 26103 | __startTimestamp1457494584775__endTimestamp 19:36:24 INFO - PROCESS | 26103 | 19:36:24 INFO - PROCESS | 26103 | ------- Summary: start ------- 19:36:24 INFO - PROCESS | 26103 | Number of tests: 6 19:36:24 INFO - PROCESS | 26103 | 19:36:24 INFO - PROCESS | 26103 | [#0] dojo.html Cycles:165 Average:5086.06 Median:5244.63 stddev:548.38 (10.5%) stddev-sans-first:527.94 19:36:24 INFO - PROCESS | 26103 | Values: 3120.5 3154.1 3209.4 3216.1 3243.1 4911.9 4913.9 5102.1 5168.0 5172.9 5043.7 5056.1 5076.5 5100.0 5153.2 4567.9 4616.3 4660.8 4756.2 4819.6 4582.5 4768.5 4769.6 4787.9 4846.2 4658.5 4662.5 4672.3 4675.9 4679.8 4656.6 4665.9 4678.6 4739.6 4767.3 4616.9 4643.3 4645.6 4646.6 4685.8 4947.7 4949.5 4957.2 4966.3 5018.4 5360.1 5448.8 5545.6 5577.3 5579.8 5479.9 5538.2 5564.6 5566.6 5571.1 5033.1 5179.3 5183.0 5188.9 5223.3 5528.0 5615.2 5633.6 5663.6 5670.5 5389.5 5393.2 5396.3 5416.1 5417.7 5343.9 5427.6 5447.7 5483.5 5497.8 5425.8 5440.5 5449.2 5460.4 5513.9 5393.4 5417.3 5424.7 5442.8 5466.3 4080.5 4120.6 4157.1 4176.0 4197.7 3755.1 3765.8 3770.2 3808.8 3838.6 5140.2 5153.9 5161.7 5166.7 5170.2 5279.8 5405.3 5434.0 5490.0 5505.4 5135.5 5140.1 5143.5 5152.4 5199.4 4658.3 4661.1 4681.8 4726.6 4734.8 5658.2 5676.0 5714.7 5755.5 5794.5 5412.6 5431.6 5439.5 5443.6 5484.9 5507.3 5701.6 5713.0 5738.1 5742.5 5414.1 5449.8 5450.2 5452.1 5486.8 5356.2 5441.8 5475.6 5481.3 5487.1 5175.5 5318.0 5332.2 5338.9 5352.0 5321.4 5324.2 5336.4 5353.7 5399.5 5221.1 5244.6 5261.9 5270.3 5277.1 5149.9 5333.0 5338.0 5353.1 5427.1 5089.1 5199.9 5224.7 5242.9 5245.9 19:36:24 INFO - PROCESS | 26103 | 19:36:24 INFO - PROCESS | 26103 | [#1] ext.html Cycles:180 Average:42981.52 Median:35789.37 stddev:72711.88 (203.2%) stddev-sans-first:72845.95 19:36:24 INFO - PROCESS | 26103 | Values: 518.2 550.4 564.3 566.3 588.7 37676.8 37894.0 37915.6 37957.8 38101.0 40911.2 41132.0 41185.5 41277.0 41331.2 8420.5 8566.5 8588.1 8606.6 8614.6 8548.1 8671.5 8687.7 8834.3 8848.7 8846.3 8854.2 8927.1 8933.3 8941.9 8762.6 8851.2 8865.4 8879.2 8906.5 8690.3 8734.9 8778.5 8789.1 8832.4 40242.4 40694.6 40698.2 40835.8 41018.8 3152.3 3620.5 3850.5 3924.7 3968.0 30311.2 30767.6 30999.7 31226.5 31410.1 3776.6 3801.4 3838.9 3897.8 3932.1 265830.0 266059.0 266254.0 267680.0 268447.0 41652.8 42550.6 58863.7 58935.4 59208.7 40227.8 40394.0 40466.6 40532.4 40570.4 13350.9 13459.0 13475.7 13500.3 13564.3 10716.9 10788.6 10792.1 10792.4 10805.4 13643.1 14116.9 14157.1 14167.5 14188.0 5718.5 5806.2 5823.3 5878.5 5888.5 892.6 922.6 934.7 943.2 1043.2 27900.3 28613.3 29280.4 29391.6 29413.9 1004.8 1023.2 1028.3 1100.1 1107.9 14429.4 14904.8 14956.9 15140.2 15171.2 341724.0 346146.0 351665.0 351834.0 353014.0 52471.2 52686.5 52945.7 53027.7 53140.5 1108.3 1251.9 1290.7 1296.6 1415.7 25626.9 26861.9 27064.6 27554.4 28001.7 40426.6 40970.6 41412.6 41422.6 41443.0 186215.0 186794.0 196800.0 200213.0 201021.0 27427.6 31490.5 31560.5 32094.7 32170.2 38086.2 38572.8 39102.6 39595.4 39707.0 32538.2 32542.0 33232.0 34958.5 35819.6 34791.3 34862.5 35012.6 35751.6 35759.1 34106.0 34717.7 34935.0 35287.8 35541.5 30821.5 31353.5 31498.0 31726.8 31749.0 23532.5 24526.5 24537.8 24775.3 25019.0 19:36:24 INFO - PROCESS | 26103 | 19:36:24 INFO - PROCESS | 26103 | [#2] jquery.html Cycles:180 Average:26930.16 Median:371.96 stddev:75189.30 (20214.6%) stddev-sans-first:75373.76 19:36:24 INFO - PROCESS | 26103 | Values: 359.2 361.7 364.4 370.9 373.0 16808.0 16813.4 17395.8 17472.9 17867.1 15321.6 16313.6 16852.5 16872.6 16874.7 5882.3 6534.6 6756.8 6768.7 6823.4 4322.1 6494.7 6663.2 6793.2 6813.0 6689.1 6757.4 6788.0 6793.2 6795.3 6766.1 6772.9 6941.5 6943.1 6968.3 4203.4 6132.3 6510.1 6517.1 6656.5 21265.0 22058.2 22205.0 22349.1 22353.6 2093.9 2115.8 2133.5 2157.6 2391.5 13086.5 13958.9 14184.4 14484.2 14689.9 1924.6 1930.9 1968.3 1970.8 1979.5 69573.0 69689.7 69763.7 72118.3 74525.6 15201.2 15505.5 15525.0 15548.5 15548.5 23749.2 23886.8 24103.9 24113.3 24124.0 8522.7 8615.5 8688.0 8723.1 8805.4 7337.0 7372.7 7460.7 7467.5 7481.4 7694.4 7710.3 7780.0 7791.7 7799.1 2452.6 2916.2 2946.9 2948.6 3031.8 843.9 880.7 1026.1 1031.7 1036.0 15746.8 16178.4 16187.3 16203.8 16903.3 895.3 897.0 898.4 912.6 995.5 9096.4 9279.3 9327.5 9461.2 9551.5 440155.0 451607.0 455866.0 473257.9 475642.2 67773.0 72649.5 72677.3 72784.6 73080.6 954.2 964.4 971.3 971.9 976.2 14317.0 14742.8 14768.6 14784.4 14917.7 32191.0 33755.5 33985.5 34229.7 34382.0 44003.6 47510.0 47747.3 47895.0 47949.5 7516.0 7542.7 7645.8 7762.7 7768.3 11184.9 12390.8 12529.4 12598.6 12777.3 10657.0 10682.2 10703.4 10725.4 10813.3 8799.9 10372.9 10597.7 10706.5 10753.8 10842.0 10905.5 10952.6 11267.0 11304.4 7519.9 7662.1 7739.9 7750.0 8200.2 10480.2 10553.5 10631.6 10678.4 11219.2 19:36:24 INFO - PROCESS | 26103 | 19:36:24 INFO - PROCESS | 26103 | [#3] mootools.html Cycles:180 Average:5371.29 Median:6033.25 stddev:2826.97 (46.9%) stddev-sans-first:2818.47 19:36:24 INFO - PROCESS | 26103 | Values: 1316.5 1451.2 1460.5 1617.7 1780.1 7443.7 7649.2 7665.9 7674.7 7689.7 7474.7 7624.1 7671.7 7680.0 7701.5 1984.4 2210.8 2261.6 2280.0 2298.5 2210.1 2219.1 2225.9 2228.3 2231.0 2191.2 2255.7 2262.1 2263.2 2277.6 2143.6 2206.5 2208.2 2245.0 2253.1 2242.7 2255.8 2269.3 2273.5 2292.6 7808.6 7889.9 7895.8 7914.2 7928.2 4687.5 4833.0 4854.6 4859.4 4887.5 2932.9 2966.5 3002.1 3011.5 3102.2 920.2 940.3 943.6 944.6 956.8 10690.6 10849.3 10885.5 10890.7 10973.3 4296.6 4402.5 4422.6 4426.3 4442.9 9198.0 9199.3 9230.0 9231.8 9267.3 4269.1 4764.8 4779.9 4782.8 4800.3 4173.8 4213.2 4214.2 4238.4 4250.3 3662.5 3675.0 3679.1 3757.0 3768.6 1189.9 1203.1 1213.7 1214.6 1220.1 955.0 960.2 966.1 1050.3 1328.1 7499.9 7535.8 7555.8 7562.5 7569.0 496.1 500.9 510.8 513.5 514.5 5707.1 5711.4 5714.3 5773.1 5785.0 9030.0 9077.5 9257.6 9268.4 9303.0 9067.3 9132.5 9145.6 9187.5 9211.6 7067.3 7194.6 7280.0 7288.7 7296.3 7256.3 7318.2 7320.7 7322.3 7352.0 8083.2 8351.5 8494.4 8510.9 8534.2 7743.7 7973.3 8088.4 8144.5 8162.0 6295.8 6451.9 6543.1 6613.5 6644.1 7344.0 7355.7 7387.3 7402.9 7415.4 6705.0 6842.6 6910.1 7050.8 7057.8 6596.1 6630.1 6707.5 6724.7 6837.3 6415.7 6625.1 7041.0 7057.6 7111.6 5953.6 5958.3 5975.1 5987.4 6005.0 5975.1 6008.2 6015.7 6022.3 6044.2 19:36:24 INFO - PROCESS | 26103 | 19:36:24 INFO - PROCESS | 26103 | [#4] prototype.html Cycles:180 Average:5206.10 Median:5897.21 stddev:1576.55 (26.7%) stddev-sans-first:1537.73 19:36:24 INFO - PROCESS | 26103 | Values: 320.2 326.7 339.3 339.7 348.6 5827.0 5900.7 5937.1 5980.1 6040.5 5797.0 5801.3 5825.4 5837.2 5843.5 4352.7 4412.2 4480.9 4487.4 4516.9 4489.8 4506.8 4509.2 4532.8 4539.8 4477.6 4479.0 4490.8 4503.3 4514.5 4308.4 4391.5 4480.2 4499.7 4502.8 3961.4 3968.4 3968.4 3977.6 3985.0 5574.5 5591.5 5608.4 5622.5 5625.2 5237.5 5239.4 5247.9 5264.4 5270.0 6137.8 6160.6 6161.5 6197.3 6198.6 4081.6 4254.1 4258.5 4424.3 4424.4 6316.5 6363.0 6408.7 6421.8 6434.5 4356.1 4359.2 4359.3 4359.7 4381.5 4413.2 4422.0 4425.0 4425.0 4449.6 5130.5 5130.7 5143.6 5160.7 5167.2 5971.3 6171.8 6204.2 6214.0 6221.9 1592.1 1600.2 1610.3 1612.1 1615.2 997.0 1047.7 1085.4 1112.8 1127.2 5851.8 5856.2 5861.4 5919.8 5934.7 6300.4 6302.1 6315.9 6329.3 6340.2 5880.2 5886.1 5922.1 5923.6 5935.6 3362.9 3414.1 3420.1 3426.7 3433.6 6534.6 6672.5 6677.5 6829.1 6939.9 6556.3 6569.6 6605.4 6618.5 6626.3 6771.9 6779.8 6784.2 6792.4 6799.6 6402.9 6422.3 6433.1 6433.4 6476.3 6132.9 6312.6 6344.5 6345.2 6348.6 6801.9 6828.8 6874.5 6900.6 6909.6 4257.3 4297.9 4308.5 4308.5 4309.4 6461.5 6463.7 6465.0 6469.4 6471.5 6289.7 6294.6 6296.6 6300.9 6303.6 6034.4 6243.3 6243.4 6251.5 6256.2 6115.7 6136.7 6138.3 6144.3 6150.2 6273.8 6276.7 6284.5 6288.2 6304.9 5893.7 5974.6 6091.5 6174.1 6189.7 19:36:24 INFO - PROCESS | 26103 | 19:36:24 INFO - PROCESS | 26103 | [#5] yui.html Cycles:180 Average:13959.34 Median:46563.03 stddev:16668.51 (35.8%) stddev-sans-first:16685.99 19:36:24 INFO - PROCESS | 26103 | Values: 801.9 814.9 816.1 817.5 832.3 12340.4 12786.5 12799.6 12849.7 12858.2 11879.9 11962.3 11973.8 11999.5 12054.6 821.4 847.3 847.9 849.2 851.1 684.7 792.7 812.5 813.4 814.2 884.7 884.9 887.4 887.7 891.7 710.2 880.0 883.0 885.3 886.5 644.2 652.0 653.7 654.3 654.3 13190.1 13222.2 13305.2 13311.2 13331.7 11798.8 12491.8 12531.0 12672.3 12773.9 10360.8 10503.3 10633.6 10650.7 10672.3 3519.1 3576.5 3659.9 3688.4 3700.4 50982.5 52347.5 52585.9 52615.5 52765.0 10048.1 10194.8 10266.8 10310.1 10316.8 18805.0 18829.9 18866.4 18887.2 18894.1 6775.3 6848.9 6914.8 7191.4 7205.6 4271.2 4382.1 4430.5 4562.1 4568.3 3094.5 3126.5 3137.8 3145.4 3150.2 591.7 598.6 605.7 612.9 613.3 650.5 655.0 684.4 685.3 734.4 7739.5 8107.3 8235.3 8271.5 8416.9 561.7 612.3 613.0 641.4 679.0 3755.7 3769.7 3860.9 3960.7 4045.3 58891.4 59386.7 60519.7 61124.0 61174.0 53090.7 53447.7 53670.2 53696.2 54133.7 46717.5 47125.0 47242.0 47770.5 47799.8 7661.0 7724.3 7812.1 7861.3 7971.7 33241.0 35465.3 36048.3 36214.8 36557.8 41982.0 41994.6 44873.3 46408.5 47418.8 9822.0 9931.6 10009.2 10010.5 10445.3 11054.2 11188.4 11221.5 11271.5 11283.2 9274.4 10966.8 11195.9 11494.9 11537.5 10749.9 10797.2 10913.5 10967.9 11269.1 11033.2 11245.1 11285.7 11317.3 11586.8 9569.0 9573.5 9636.4 9660.5 9849.2 10059.7 10200.8 10218.5 10246.6 10293.1 19:36:24 INFO - PROCESS | 26103 | -------- Summary: end -------- 19:36:24 INFO - PROCESS | 26103 | 19:36:25 INFO - TEST-INFO | 26103: exit 0 19:36:25 INFO - TEST-OK | dromaeo_css | took 1111663ms 19:36:25 INFO - TEST-START | kraken 19:36:25 INFO - operating with platform_type : linux_ 19:36:25 INFO - Initialising browser for kraken test... 19:36:25 INFO - TEST-INFO | started process 26290 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRxakvF/profile http://localhost:35194/getInfo.html) 19:36:28 INFO - PROCESS | 26290 | __metrics Screen width/height:1600/1200 19:36:28 INFO - PROCESS | 26290 | colorDepth:24 19:36:28 INFO - PROCESS | 26290 | Browser inner width/height: 1024/697 19:36:28 INFO - PROCESS | 26290 | __metrics 19:36:29 ERROR - PROCESS | 26290 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:36:29 INFO - PROCESS | 26290 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 19:36:30 INFO - TEST-INFO | 26290: exit 0 19:36:30 INFO - Browser initialized. 19:36:30 INFO - Running cycle 1/1 for kraken test... 19:36:30 INFO - TEST-INFO | started process 26369 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRxakvF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:36:41 INFO - PROCESS | 26369 | RSS: Main: 153878528 19:36:41 INFO - PROCESS | 26369 | 19:36:44 INFO - PROCESS | 26369 | Cycle 1(1): loaded http://localhost:35194/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35194/tests/kraken/driver.html?testName=audio-beat-detection) 19:36:45 INFO - PROCESS | 26369 | RSS: Main: 193630208 19:36:45 INFO - PROCESS | 26369 | 19:36:47 INFO - PROCESS | 26369 | Cycle 1(1): loaded http://localhost:35194/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35194/tests/kraken/driver.html?testName=audio-dft) 19:36:48 INFO - PROCESS | 26369 | RSS: Main: 184750080 19:36:48 INFO - PROCESS | 26369 | 19:36:51 INFO - PROCESS | 26369 | Cycle 1(1): loaded http://localhost:35194/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35194/tests/kraken/driver.html?testName=audio-fft) 19:36:51 INFO - PROCESS | 26369 | RSS: Main: 170520576 19:36:51 INFO - PROCESS | 26369 | 19:36:53 INFO - PROCESS | 26369 | Cycle 1(1): loaded http://localhost:35194/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35194/tests/kraken/driver.html?testName=audio-oscillator) 19:36:54 INFO - PROCESS | 26369 | RSS: Main: 172036096 19:36:54 INFO - PROCESS | 26369 | 19:36:56 INFO - PROCESS | 26369 | Cycle 1(1): loaded http://localhost:35194/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35194/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:36:56 INFO - PROCESS | 26369 | RSS: Main: 173268992 19:36:56 INFO - PROCESS | 26369 | 19:36:59 INFO - PROCESS | 26369 | Cycle 1(1): loaded http://localhost:35194/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35194/tests/kraken/driver.html?testName=imaging-darkroom) 19:37:00 INFO - PROCESS | 26369 | RSS: Main: 174592000 19:37:00 INFO - PROCESS | 26369 | 19:37:03 INFO - PROCESS | 26369 | Cycle 1(1): loaded http://localhost:35194/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35194/tests/kraken/driver.html?testName=imaging-desaturate) 19:37:04 INFO - PROCESS | 26369 | RSS: Main: 175075328 19:37:04 INFO - PROCESS | 26369 | 19:37:07 INFO - PROCESS | 26369 | Cycle 1(1): loaded http://localhost:35194/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35194/tests/kraken/driver.html?testName=json-parse-financial) 19:37:07 INFO - PROCESS | 26369 | RSS: Main: 175312896 19:37:07 INFO - PROCESS | 26369 | 19:37:09 INFO - PROCESS | 26369 | Cycle 1(1): loaded http://localhost:35194/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35194/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:37:10 INFO - PROCESS | 26369 | RSS: Main: 182988800 19:37:10 INFO - PROCESS | 26369 | 19:37:11 INFO - PROCESS | 26369 | Cycle 1(1): loaded http://localhost:35194/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35194/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:37:12 INFO - PROCESS | 26369 | RSS: Main: 180178944 19:37:12 INFO - PROCESS | 26369 | 19:37:14 INFO - PROCESS | 26369 | Cycle 1(1): loaded http://localhost:35194/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35194/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:37:15 INFO - PROCESS | 26369 | RSS: Main: 195350528 19:37:15 INFO - PROCESS | 26369 | 19:37:17 INFO - PROCESS | 26369 | Cycle 1(1): loaded http://localhost:35194/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:37:18 INFO - PROCESS | 26369 | RSS: Main: 199888896 19:37:18 INFO - PROCESS | 26369 | 19:37:20 INFO - PROCESS | 26369 | Cycle 1(1): loaded http://localhost:35194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:37:21 INFO - PROCESS | 26369 | RSS: Main: 200130560 19:37:21 INFO - PROCESS | 26369 | 19:37:22 INFO - PROCESS | 26369 | Cycle 1(1): loaded http://localhost:35194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35194/tests/kraken/driver.html?testName=ai-astar) 19:37:23 INFO - PROCESS | 26369 | RSS: Main: 259600384 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | __start_tp_report 19:37:23 INFO - PROCESS | 26369 | _x_x_mozilla_page_load 19:37:23 INFO - PROCESS | 26369 | _x_x_mozilla_page_load_details 19:37:23 INFO - PROCESS | 26369 | |i|pagename|runs| 19:37:23 INFO - PROCESS | 26369 | |0;ai-astar;111;112;107;111;113;113;100;111;111;111 19:37:23 INFO - PROCESS | 26369 | |1;audio-beat-detection;153;131;155;171;138;157;154;139;174;137 19:37:23 INFO - PROCESS | 26369 | |2;audio-dft;161;163;161;163;162;164;163;166;163;161 19:37:23 INFO - PROCESS | 26369 | |3;audio-fft;72;76;100;93;83;77;76;116;93;75 19:37:23 INFO - PROCESS | 26369 | |4;audio-oscillator;97;95;137;94;94;95;137;96;95;133 19:37:23 INFO - PROCESS | 26369 | |5;imaging-gaussian-blur;118;118;117;117;118;118;117;117;119;118 19:37:23 INFO - PROCESS | 26369 | |6;imaging-darkroom;148;149;149;147;149;148;147;147;148;147 19:37:23 INFO - PROCESS | 26369 | |7;imaging-desaturate;97;96;97;97;97;96;96;96;97;96 19:37:23 INFO - PROCESS | 26369 | |8;json-parse-financial;64;62;62;64;64;63;63;71;60;60 19:37:23 INFO - PROCESS | 26369 | |9;json-stringify-tinderbox;68;68;70;69;70;69;70;68;68;69 19:37:23 INFO - PROCESS | 26369 | |10;stanford-crypto-aes;85;86;84;86;89;84;86;84;84;84 19:37:23 INFO - PROCESS | 26369 | |11;stanford-crypto-ccm;123;129;125;123;120;135;133;123;134;132 19:37:23 INFO - PROCESS | 26369 | |12;stanford-crypto-pbkdf2;159;146;158;158;160;150;159;157;160;157 19:37:23 INFO - PROCESS | 26369 | |13;stanford-crypto-sha256-iterative;72;73;72;70;70;71;71;71;70;69 19:37:23 INFO - PROCESS | 26369 | __end_tp_report 19:37:23 INFO - PROCESS | 26369 | __start_cc_report 19:37:23 INFO - PROCESS | 26369 | _x_x_mozilla_cycle_collect,943 19:37:23 INFO - PROCESS | 26369 | __end_cc_report 19:37:23 INFO - PROCESS | 26369 | __startTimestamp1457494643178__endTimestamp 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | ------- Summary: start ------- 19:37:23 INFO - PROCESS | 26369 | Number of tests: 14 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:3.89 (3.5%) stddev-sans-first:4.11 19:37:23 INFO - PROCESS | 26369 | Values: 111.0 112.0 107.0 111.0 113.0 113.0 100.0 111.0 111.0 111.0 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:154.50 stddev:14.54 (9.4%) stddev-sans-first:15.40 19:37:23 INFO - PROCESS | 26369 | Values: 153.0 131.0 155.0 171.0 138.0 157.0 154.0 139.0 174.0 137.0 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.57 (1.0%) stddev-sans-first:1.54 19:37:23 INFO - PROCESS | 26369 | Values: 161.0 163.0 161.0 163.0 162.0 164.0 163.0 166.0 163.0 161.0 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | [#3] audio-fft Cycles:10 Average:86.10 Median:76.50 stddev:14.15 (18.5%) stddev-sans-first:14.05 19:37:23 INFO - PROCESS | 26369 | Values: 72.0 76.0 100.0 93.0 83.0 77.0 76.0 116.0 93.0 75.0 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:95.00 stddev:19.62 (20.7%) stddev-sans-first:20.46 19:37:23 INFO - PROCESS | 26369 | Values: 97.0 95.0 137.0 94.0 94.0 95.0 137.0 96.0 95.0 133.0 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 19:37:23 INFO - PROCESS | 26369 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 119.0 118.0 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 19:37:23 INFO - PROCESS | 26369 | Values: 148.0 149.0 149.0 147.0 149.0 148.0 147.0 147.0 148.0 147.0 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 19:37:23 INFO - PROCESS | 26369 | Values: 97.0 96.0 97.0 97.0 97.0 96.0 96.0 96.0 97.0 96.0 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.50 stddev:3.09 (4.9%) stddev-sans-first:3.27 19:37:23 INFO - PROCESS | 26369 | Values: 64.0 62.0 62.0 64.0 64.0 63.0 63.0 71.0 60.0 60.0 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 19:37:23 INFO - PROCESS | 26369 | Values: 68.0 68.0 70.0 69.0 70.0 69.0 70.0 68.0 68.0 69.0 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.50 stddev:1.62 (1.9%) stddev-sans-first:1.72 19:37:23 INFO - PROCESS | 26369 | Values: 85.0 86.0 84.0 86.0 89.0 84.0 86.0 84.0 84.0 84.0 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:130.50 stddev:5.52 (4.2%) stddev-sans-first:5.59 19:37:23 INFO - PROCESS | 26369 | Values: 123.0 129.0 125.0 123.0 120.0 135.0 133.0 123.0 134.0 132.0 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.40 Median:158.50 stddev:4.65 (2.9%) stddev-sans-first:4.83 19:37:23 INFO - PROCESS | 26369 | Values: 159.0 146.0 158.0 158.0 160.0 150.0 159.0 157.0 160.0 157.0 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - PROCESS | 26369 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:1.20 (1.7%) stddev-sans-first:1.20 19:37:23 INFO - PROCESS | 26369 | Values: 72.0 73.0 72.0 70.0 70.0 71.0 71.0 71.0 70.0 69.0 19:37:23 INFO - PROCESS | 26369 | -------- Summary: end -------- 19:37:23 INFO - PROCESS | 26369 | 19:37:23 INFO - TEST-INFO | 26369: exit 0 19:37:23 INFO - TEST-OK | kraken | took 58659ms 19:37:23 INFO - SUITE-END | took 1170s 19:37:24 INFO - Completed test suite (00:19:30) 19:37:24 INFO - javascript benchmark 19:37:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3120.4851199552077, 3154.05378386484, 3209.422303985283, 3216.083416226376, 3243.0595127413053, 4911.852644420665, 4913.8771530711665, 5102.10713125203, 5167.974160129199, 5172.948270517294, 5043.672161309512, 5056.064628043814, 5076.543111119999, 5100.0, 5153.201253805657, 4567.931481027771, 4616.2613981762925, 4660.813567457298, 4756.239001759719, 4819.566239038486, 4582.518835522255, 4768.546988036131, 4769.5707386335225, 4787.880302992436, 4846.176150054499, 4658.487566367697, 4662.533746625344, 4672.275797251432, 4675.88310292242, 4679.789409476582, 4656.627469802442, 4665.906681866344, 4678.602318802872, 4739.573438390527, 4767.308740232646, 4616.907661846744, 4643.326717625925, 4645.5586719261955, 4646.581807637329, 4685.835995740167, 4947.653664243504, 4949.529794669501, 4957.182064959277, 4966.279889416014, 5018.422881368653, 5360.061989151883, 5448.7548060336985, 5545.584081193927, 5577.274954255961, 5579.832605021816, 5479.917801232985, 5538.169274608801, 5564.610477266593, 5566.582506312043, 5571.108622620402, 5033.094043072282, 5179.274901513753, 5183.041137389595, 5188.870278243036, 5223.3209682741, 5527.972360138174, 5615.213870058195, 5633.63381380209, 5663.631863928831, 5670.5180059695385, 5389.514943655012, 5393.2449457076045, 5396.298481197419, 5416.0792665247, 5417.702026388586, 5343.946560534423, 5427.6472029317965, 5447.700376479253, 5483.479069488392, 5497.835064948058, 5425.755840987086, 5440.455954404528, 5449.182622606561, 5460.426655201226, 5513.9448605514235, 5393.352797664305, 5417.349918009864, 5424.701641409761, 5442.755076021588, 5466.262054622654, 4080.510338759368, 4120.608542188487, 4157.147784704129, 4175.97912010438, 4197.748135111903, 3755.117547376364, 3765.811709414518, 3770.1517158639085, 3808.7524310919703, 3838.5777564467885, 5140.228965655182, 5153.896922061613, 5161.66449180802, 5166.664166829144, 5170.1727723564045, 5279.762410691528, 5405.324334458192, 5434.049041417736, 5490.011797876421, 5505.394406615349, 5135.512126347991, 5140.1004824155625, 5143.5113664201845, 5152.433232344439, 5199.428062913076, 4658.254679251304, 4661.114388266218, 4681.8361357353015, 4726.645501587326, 4734.7632618369635, 5658.207850900877, 5675.971620141873, 5714.742836572447, 5755.510781583613, 5794.536437085023, 5412.648177868426, 5431.56547476193, 5439.5104440600535, 5443.564514838724, 5484.91772623403, 5507.284053073075, 5701.629394089371, 5712.971435142797, 5738.081906895044, 5742.454466825645, 5414.133738601805, 5449.809256675997, 5450.182472629137, 5452.073147565003, 5486.753096110605, 5356.223347614497, 5441.83674489766, 5475.6440831345835, 5481.260029895913, 5487.1494918286135, 5175.508326708957, 5317.97341013308, 5332.226827110125, 5338.946610533845, 5352.0366334060245, 5321.441248668834, 5324.227986941794, 5336.386315573759, 5353.732313384393, 5399.514043736082, 5221.060209162387, 5244.632875698664, 5261.868453288698, 5270.314859068297, 5277.050130976461, 5149.897002060013, 5333.0, 5338.0, 5353.089974704231, 5427.05026620332, 5089.13484707608, 5199.948000519947, 5224.686518808883, 5242.868928276824, 5245.89508209826], "unit": "score", "name": "dojo.html", "value": 5052.186789132956}, {"lowerIsBetter": false, "replicates": [518.2407772613121, 550.4138092931029, 564.2636359550787, 566.3006187358611, 588.7497813429293, 37676.811615941915, 37894.0, 37915.620843791556, 37957.81021094898, 38101.04747381313, 40911.18177636453, 41132.0, 41185.52886826785, 41277.0, 41331.17337653245, 8420.452670576407, 8566.486010839339, 8588.098249683788, 8606.612702428374, 8614.569271536398, 8548.145185481464, 8671.523066231355, 8687.695930642429, 8834.293256539462, 8848.690295839648, 8846.292296616288, 8854.247388971946, 8927.06265842087, 8933.285337173043, 8941.865872011926, 8762.60568274426, 8851.203391694746, 8865.379423440361, 8879.200871921526, 8906.465612063297, 8690.261327787146, 8734.90813648294, 8778.47329160246, 8789.121087891224, 8832.425892317044, 40242.39636405456, 40694.59305406937, 40698.1860362794, 40835.79582102071, 41018.79490602558, 3152.274976755336, 3620.4931309616672, 3850.5186851643543, 3924.666403355718, 3968.0, 30311.24221894448, 30767.628062029242, 30999.690003099906, 31226.53160202599, 31410.057698269087, 3776.603456637041, 3801.448789925473, 3838.865639702597, 3897.80510974453, 3932.0956180078742, 265830.0, 266059.0, 266254.0, 267680.0, 268447.0, 41652.79173604112, 42550.57449425466, 58863.70568147132, 58935.41064589299, 59208.70395647994, 40227.79886100551, 40394.0, 40466.59533404687, 40532.39201411981, 40570.39144412836, 13350.866491335157, 13459.0, 13475.730485390237, 13500.257485838176, 13564.253966031765, 10716.946415267874, 10788.622398216025, 10792.082672972729, 10792.352458852494, 10805.351678899291, 13643.113197642122, 14116.85883141176, 14157.07978981363, 14167.504137355349, 14188.0, 5718.485336319751, 5806.158107074535, 5823.301203855564, 5878.5297176225795, 5888.499477544457, 892.6474042753076, 922.5663937949154, 934.6541779541614, 943.2077055273603, 1043.2071625564627, 27900.302492437444, 28613.28466788347, 29280.414391712045, 29391.55912661312, 29413.85293073521, 1004.8241557727368, 1023.2325755683238, 1028.3161697471248, 1100.1418893263267, 1107.8781334053247, 14429.35067921946, 14904.776428353583, 14956.925215373854, 15140.242987850563, 15171.16558589266, 341724.0, 346146.0, 351665.0, 351834.0, 353014.0, 52471.21293180529, 52686.473135268156, 52945.7352713234, 53027.73486132544, 53140.46859531433, 1108.3294606762954, 1251.9499220031096, 1290.6966862787237, 1296.598054603076, 1415.6673181802269, 25626.87186564055, 26861.86569067142, 27064.594031089156, 27554.448911022067, 28001.71998279991, 40426.59573404228, 40970.59029409668, 41412.585874140874, 41422.58577414187, 41443.0, 186215.0, 186794.0, 196800.0, 200213.0, 201021.0, 27427.588586170823, 31490.527642085846, 31560.52659210068, 32094.67905320917, 32170.19574510656, 38086.23827523489, 38572.80713596414, 39102.6089739099, 39595.406068909564, 39707.0, 32538.186545336557, 32542.0, 33232.00303990884, 34958.47562286517, 35819.64180358163, 34791.304173916884, 34862.47706284357, 35012.64987350094, 35751.64248357483, 35759.106022349646, 34106.0, 34717.652823472454, 34935.0, 35287.82356088203, 35541.466877997365, 30821.537676935313, 31353.52969705502, 31498.0, 31726.841365793025, 31749.0, 23532.526172780115, 24526.54300370402, 24537.754622453547, 24775.25674229776, 25019.0], "unit": "score", "name": "ext.html", "value": 17399.637564344415}, {"lowerIsBetter": false, "replicates": [359.1595666141229, 361.65461983805466, 364.3787342580899, 370.9128354836611, 372.9984990301042, 16808.0, 16813.411530596433, 17395.82604173958, 17472.91263543682, 17867.106644667747, 15321.616959575987, 16313.592160196002, 16852.494425167235, 16872.578185545335, 16874.746878796795, 5882.29412470503, 6534.640594767286, 6756.831079223034, 6768.729250829961, 6823.3858952694245, 4322.113966636847, 6494.707738151795, 6663.167104111986, 6793.184817821868, 6812.965935170318, 6689.096971908779, 6757.425618822406, 6788.049673045777, 6793.184817821868, 6795.286494918037, 6766.086578311914, 6772.932270677304, 6941.5140940134215, 6943.132108486439, 6968.303169683017, 4203.4115223868685, 6132.264128304588, 6510.056041873901, 6517.055027021055, 6656.500762442788, 21265.0, 22058.227962021254, 22205.0, 22349.10603575855, 22353.55292894149, 2093.874367537953, 2115.777843326444, 2133.4986278224605, 2157.600843843878, 2391.5336509380677, 13086.476540938445, 13958.860411395959, 14184.439711631712, 14484.203368814711, 14689.926550367287, 1924.6246981838547, 1930.94207173785, 1968.3307675390436, 1970.7967379228942, 1979.5051237190703, 69573.0, 69689.65155174192, 69763.65118174428, 72118.27881721169, 74525.62737186279, 15201.239938003277, 15505.457308994357, 15525.0, 15548.455804046804, 15548.533543993699, 23749.168779092648, 23886.7611323888, 24103.879480602485, 24113.27660170198, 24124.0, 8522.65909363631, 8615.526146061902, 8687.956560217284, 8723.084076172037, 8805.42764720304, 7336.963315183497, 7372.741954031583, 7460.70157193717, 7467.477276590586, 7481.401487881065, 7694.384449244159, 7710.267524585155, 7780.0, 7791.688332466638, 7799.142094369615, 2452.6075827867458, 2916.2126225918882, 2946.852657367123, 2948.616679831608, 3031.7574594032426, 843.852325842975, 880.7365071765502, 1026.0867827633413, 1031.7317497450717, 1035.9896401036044, 15746.76379854303, 16178.352865885232, 16187.271572779018, 16203.756943645854, 16903.32386704518, 895.3016647015338, 896.9551522423983, 898.380117718772, 912.5847739278612, 995.5022488755623, 9096.408733432305, 9279.304052196112, 9327.533623318806, 9461.19579835708, 9551.474668893277, 440155.0, 451607.0, 455866.0, 473257.9011314833, 475642.21788910415, 67773.0, 72649.45726899533, 72677.2732272681, 72784.63607681928, 73080.63459682667, 954.1841725324747, 964.3779762053437, 971.2618410008445, 971.946542940145, 976.1751320134475, 14317.0, 14742.778858316919, 14768.63078423048, 14784.408623654934, 14917.701645967238, 32191.0, 33755.493667594514, 33985.490217646264, 34229.65770342265, 34382.0, 44003.559964399945, 47510.0, 47747.28379074386, 47895.0, 47949.520504794506, 7515.962420187864, 7542.736004239825, 7645.770626881203, 7762.68949242024, 7768.339691126317, 11184.94407527957, 12390.81413778776, 12529.37353132358, 12598.622041338775, 12777.297248651414, 10657.0, 10682.198835087243, 10703.3577985318, 10725.356478611307, 10813.297135686154, 8799.912000880166, 10372.948135259276, 10597.682069537927, 10706.518206680874, 10753.784924301626, 10842.0, 10905.509252083833, 10952.616658416917, 11267.042301404144, 11304.43477826089, 7519.887201692089, 7662.118856331594, 7739.883901741591, 7749.961250193713, 8200.220979006985, 10480.213983951387, 10553.472326383804, 10631.574737010433, 10678.412687302272, 11219.158563107636], "unit": "score", "name": "jquery.html", "value": 9232.153940549804}, {"lowerIsBetter": false, "replicates": [1316.4799904037911, 1451.1728314860527, 1460.5034288341965, 1617.6683779825137, 1780.14553014553, 7443.702251909924, 7649.235076492348, 7665.923340766604, 7674.731384401554, 7689.653965571549, 7474.738384156555, 7624.0851097868335, 7671.693132274702, 7679.961600191991, 7701.499402538831, 1984.4046785964226, 2210.834187435949, 2261.5929132756096, 2280.042382199476, 2298.54029194161, 2210.060724192212, 2219.112355057982, 2225.866448013124, 2228.2869481765842, 2230.9888450557723, 2191.2221161487682, 2255.7293124825046, 2262.061244583496, 2263.151318255654, 2277.578647950126, 2143.603433364825, 2206.4925067234626, 2208.216083290441, 2245.0, 2253.0987604957986, 2242.742084660252, 2255.8082562982167, 2269.262489690857, 2273.522560262347, 2292.6331786914016, 7808.570528620923, 7889.8816517752275, 7895.763127106138, 7914.169012253746, 7928.207179282025, 4687.484376718558, 4833.03339332135, 4854.611631069506, 4859.441164266119, 4887.486813884562, 2932.8680209390627, 2966.5401862711096, 3002.1143762590086, 3011.4729922263737, 3102.16241614765, 920.1994264989502, 940.3229674634252, 943.5989704375613, 944.5985456181164, 956.8421210500259, 10690.572377104907, 10849.349039057683, 10885.455727213608, 10890.673279801618, 10973.286736362112, 4296.613304802583, 4402.537733537996, 4422.624076953431, 4426.313921342197, 4442.866713998521, 9198.0, 9199.310051746146, 9229.95385023084, 9231.76920576991, 9267.304952128618, 4269.146170765859, 4764.784979830121, 4779.856604301876, 4782.760861956888, 4800.279958006257, 4173.812178451977, 4213.241616508996, 4214.157168566299, 4238.406623072772, 4250.298700714347, 3662.505561749183, 3675.00774790805, 3679.061839230979, 3757.0231739747865, 3768.6231376862092, 1189.9286042837457, 1203.0736333023524, 1213.7208442058377, 1214.611324376191, 1220.060553373915, 955.0497255231089, 960.1838437328215, 966.1256562810668, 1050.3277902142636, 1328.0902581731546, 7499.8500029999095, 7535.849283014419, 7555.811104722316, 7562.546247225184, 7568.962155189189, 496.14415133893743, 500.92986981821844, 510.7752588860889, 513.5378159656265, 514.4649564452927, 5707.0868661014865, 5711.371749107595, 5714.342850572154, 5773.1051686988585, 5784.971075144682, 9030.0, 9077.500737459372, 9257.629694812267, 9268.35121541499, 9302.953485232665, 9067.274618030542, 9132.543372831331, 9145.588448519833, 9187.494687792236, 9211.585478653476, 7067.293270672892, 7194.568325900358, 7279.963600181965, 7288.6720097595735, 7296.270372962661, 7256.310650488195, 7318.231585683427, 7320.670569824264, 7322.2677732228485, 7351.963240183765, 8083.19168083187, 8351.457155284887, 8494.362922780692, 8510.872336915076, 8534.189252021048, 7743.651535680795, 7973.282404583615, 8088.352931765562, 8144.511329320259, 8161.959190204011, 6295.779647712308, 6451.935480645134, 6543.116679248431, 6613.470922326299, 6644.069830223869, 7343.963280183565, 7355.705771769283, 7387.335139837441, 7402.888956665762, 7415.443841712001, 6704.9607310866895, 6842.623655698785, 6910.06714093611, 7050.788476345718, 7057.788266352018, 6596.076549283008, 6630.104935833793, 6707.4969377297875, 6724.73101075971, 6837.3162683731225, 6415.679216039272, 6625.105610742488, 7040.964795176196, 7057.6471176442, 7111.644417778987, 5953.613015154001, 5958.255218097738, 5975.133605627073, 5987.371326010706, 6005.039193728982, 5975.103734439695, 6008.218931538872, 6015.72929218195, 6022.277326720821, 6044.214252147192], "unit": "score", "name": "mootools.html", "value": 4324.265938622136}, {"lowerIsBetter": false, "replicates": [320.2394313505425, 326.73044738091096, 339.3416771463361, 339.6925782167138, 348.58170195765075, 5827.0, 5900.734466948992, 5937.079752638342, 5980.073088671252, 6040.546958978072, 5797.043487824504, 5801.332846722628, 5825.359210486843, 5837.211976383187, 5843.503302219306, 4352.73883566987, 4412.24991751403, 4480.865574032784, 4487.371767952481, 4516.9096618067615, 4489.842855500058, 4506.77466126694, 4509.210888094587, 4532.8413505527315, 4539.7957091930775, 4477.641788656916, 4478.955210447903, 4490.842820501283, 4503.301988191819, 4514.548545145492, 4308.43990281263, 4391.516933137336, 4480.171168333836, 4499.707519011254, 4502.819887204508, 3961.375835907264, 3968.40473928913, 3968.444417781513, 3977.5823538528325, 3984.980075099635, 5574.470425309589, 5591.524720398771, 5608.4111168327145, 5622.49397554218, 5625.212470254127, 5237.528622424, 5239.397469291042, 5247.921281180786, 5264.42091369949, 5270.025045366619, 6137.7851775187655, 6160.630362178284, 6161.537884658624, 6197.349278325801, 6198.566100372976, 4081.551029386765, 4254.106637606106, 4258.510271318807, 4424.292113261863, 4424.380586717862, 6316.463100636452, 6362.981922892315, 6408.711607977605, 6421.8394540136405, 6434.485241180694, 4356.106998065452, 4359.237133501624, 4359.346098085312, 4359.716618419856, 4381.496127945264, 4413.161499315184, 4421.955780442155, 4424.982254081515, 4425.004374015885, 4449.621782148489, 5130.48695130484, 5130.692158470503, 5143.61422893277, 5160.690358578498, 5167.199084141964, 5971.253593300838, 6171.753129874754, 6204.169769917885, 6213.968930155411, 6221.9377806222265, 1592.1243316176058, 1600.1599160440628, 1610.2592807308536, 1612.1052815687171, 1615.200475764504, 996.9651062212788, 1047.696168111239, 1085.3596378136938, 1112.7996960547018, 1127.233481232753, 5851.795187168429, 5856.209411729447, 5861.443162899518, 5919.822405327847, 5934.673592952429, 6300.3699630037545, 6302.1177035215105, 6315.936840631627, 6329.303776584572, 6340.207474065742, 5880.235569376039, 5886.087656413263, 5922.1412895130825, 5923.585349025613, 5935.614185077956, 3362.9495557566656, 3414.129397003748, 3420.1278673937986, 3426.7258619310396, 3433.5536380270905, 6534.640594767334, 6672.466202703772, 6677.532572719863, 6829.146356705412, 6939.93060069403, 6556.344365563501, 6569.605823650596, 6605.438537724252, 6618.536702430783, 6626.271110177877, 6771.864562708718, 6779.762708305284, 6784.185897692309, 6792.3886850182735, 6799.558028728117, 6402.90395644075, 6422.32565580626, 6433.13439102655, 6433.356664333716, 6476.287608363171, 6132.9080063799975, 6312.621242725451, 6344.460720838781, 6345.206849143857, 6348.587341822767, 6801.9319806801295, 6828.760993365208, 6874.518783685294, 6900.551464154814, 6909.619970901447, 4257.318828987347, 4297.892552686208, 4308.526062133225, 4308.547602501818, 4309.439772829513, 6461.547691661539, 6463.709133089116, 6465.030245463218, 6469.3530646936815, 6471.546991710535, 6289.7169627365965, 6294.622322660655, 6296.5592408530965, 6300.936990630218, 6303.621782693053, 6034.366391529002, 6243.250809902841, 6243.406876346739, 6251.468625166912, 6256.154434441942, 6115.694215289129, 6136.723847426966, 6138.324784273816, 6144.324124346229, 6150.169727086786, 6273.843153921189, 6276.717547710273, 6284.465820405317, 6288.213973253343, 6304.873902522016, 5893.675847828239, 5974.551908606959, 6091.451769340781, 6174.104754810617, 6189.721462534107], "unit": "score", "name": "prototype.html", "value": 4698.191294412434}, {"lowerIsBetter": false, "replicates": [801.8556659801235, 814.9429539932204, 816.1348970091703, 817.5380909785974, 832.2925513313683, 12340.382980850954, 12786.488540458371, 12799.552015679441, 12849.743005139891, 12858.22850628963, 11879.881201187985, 11962.342071186082, 11973.760524789499, 11999.460024298905, 12054.57808976686, 821.3593397150232, 847.2501835875264, 847.9448835825682, 849.1508491508491, 851.0510780479751, 684.7226873116371, 792.7265093542718, 812.4718932693737, 813.3980854167933, 814.226484839402, 884.747846863644, 884.9469031858109, 887.3744010472634, 887.6893087419384, 891.6968230801526, 710.183289217399, 880.0363601856021, 882.9779255518631, 885.3315746611299, 886.5301390263138, 644.249449391463, 652.0, 653.7058323754329, 654.2802916791538, 654.3227759269181, 13190.142640728322, 13222.206667599974, 13305.201687898758, 13311.201327920258, 13331.733365332639, 11798.764024719543, 12491.812622810665, 12530.972396704889, 12672.303023333712, 12773.936130319382, 10360.844587331196, 10503.264771466, 10633.627823026234, 10650.680479585624, 10672.306300090548, 3519.1202199450136, 3576.499290099388, 3659.871904483357, 3688.3729765939856, 3700.4449332600325, 50982.490175098515, 52347.47652523464, 52585.948281034165, 52615.47384526144, 52765.0, 10048.145506419378, 10194.847077293847, 10266.794664106676, 10310.123639490577, 10316.793664126675, 18805.0, 18829.905850470936, 18866.434006979813, 18887.150078246235, 18894.05529723508, 6775.322467753185, 6848.931510684829, 6914.792556223321, 7191.388731957738, 7205.603691796897, 4271.188474189894, 4382.145481631115, 4430.5126436092005, 4562.087582483517, 4568.337591049346, 3094.4894092474487, 3126.4841301185506, 3137.7803553751473, 3145.402373549018, 3150.2439414540345, 591.7189335065896, 598.5720210049835, 605.6699098990972, 612.9448349648553, 613.2671457608204, 650.5088658063132, 654.9705263263164, 684.3772167327708, 685.2530741491698, 734.4124700239787, 7739.535627862234, 8107.2703456688005, 8235.341172706168, 8271.54506502148, 8416.873746893802, 561.719140429785, 612.3203244398713, 612.9946887105151, 641.3874749614107, 679.0357692077262, 3755.6619904208205, 3769.698424126118, 3860.864869729546, 3960.742551734186, 4045.2516284486874, 58891.41108588859, 59386.70306648439, 60519.69740151359, 61124.0, 61174.0, 53090.73454632702, 53447.732761335945, 53670.194947075826, 53696.194557081675, 54133.72933135309, 46717.53282467132, 47125.0, 47242.0, 47770.5222947773, 47799.76100119477, 7661.016271538657, 7724.266194711493, 7812.140664527011, 7861.292483676497, 7971.72098976533, 33241.0, 35465.29069418545, 36048.27903441864, 36214.8189259052, 36557.817210914836, 41982.0, 41994.58005419907, 44873.32690009718, 46408.53591464042, 47418.76290618525, 9821.950890245504, 9931.602735890483, 10009.199264058712, 10010.549525271526, 10445.321054131457, 11054.170937179582, 11188.384638844616, 11221.495032723711, 11271.549138034386, 11283.153763467608, 9274.44353338802, 10966.835497467384, 11195.888041119484, 11494.94252528732, 11537.538498459968, 10749.946250268698, 10797.211125722839, 10913.454327283764, 10967.890321096687, 11269.098472122047, 11033.227674062739, 11245.116019456196, 11285.661430157108, 11317.264377815416, 11586.826197607212, 9569.0, 9573.473458959825, 9636.42181469114, 9660.468674222704, 9849.212063035084, 10059.748506287402, 10200.795984080425, 10218.489075546342, 10246.6413675521, 10293.125084367912], "unit": "score", "name": "yui.html", "value": 6293.831695287082}], "name": "dromaeo_css", "value": 6855.199436518722}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 107.0, 111.0, 113.0, 113.0, 100.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [153.0, 131.0, 155.0, 171.0, 138.0, 157.0, 154.0, 139.0, 174.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 150.9}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 161.0, 163.0, 162.0, 164.0, 163.0, 166.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 100.0, 93.0, 83.0, 77.0, 76.0, 116.0, 93.0, 75.0], "unit": "score", "name": "audio-fft", "value": 86.1}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 137.0, 94.0, 94.0, 95.0, 137.0, 96.0, 95.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 119.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.7}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 149.0, 147.0, 149.0, 148.0, 147.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 62.0, 64.0, 64.0, 63.0, 63.0, 71.0, 60.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 63.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 69.0, 70.0, 69.0, 70.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 84.0, 86.0, 89.0, 84.0, 86.0, 84.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [123.0, 129.0, 125.0, 123.0, 120.0, 135.0, 133.0, 123.0, 134.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.7}, {"lowerIsBetter": true, "replicates": [159.0, 146.0, 158.0, 158.0, 160.0, 150.0, 159.0, 157.0, 160.0, 157.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 156.4}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 70.0, 70.0, 71.0, 71.0, 71.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1551.5000000000002}]} 19:37:24 INFO - Return code: 0 19:37:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:37:24 ERROR - # TBPL SUCCESS # 19:37:24 INFO - Running post-action listener: _resource_record_post_action 19:37:24 INFO - Running post-run listener: _resource_record_post_run 19:37:25 INFO - Total resource usage - Wall time: 1188s; CPU: 25.0%; Read bytes: 28672; Write bytes: 535572480; Read time: 64; Write time: 549236 19:37:25 INFO - install - Wall time: 16s; CPU: 27.0%; Read bytes: 0; Write bytes: 250511360; Read time: 0; Write time: 328680 19:37:25 INFO - run-tests - Wall time: 1172s; CPU: 25.0%; Read bytes: 28672; Write bytes: 284778496; Read time: 64; Write time: 220528 19:37:25 INFO - Running post-run listener: _upload_blobber_files 19:37:25 INFO - Blob upload gear active. 19:37:25 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:37:25 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 19:37:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:37:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:37:25 INFO - (blobuploader) - INFO - Open directory for files ... 19:37:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:37:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:37:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:37:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:37:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:37:26 INFO - (blobuploader) - INFO - Done attempting. 19:37:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:37:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:37:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:37:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:37:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:37:27 INFO - (blobuploader) - INFO - Done attempting. 19:37:27 INFO - (blobuploader) - INFO - Iteration through files over. 19:37:27 INFO - Return code: 0 19:37:27 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:37:27 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:37:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fadd4fe36ee7cee7fc51fb53c38f6b9b855a53c0459db925408e7f1eddaa289db1877cabcee22d00f443f5adf37908bf33fa754fcdc8f48731a4ed983c31e32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce1803c764a454f8d6142c9477a77513458a56884d951112a0d1833ac2fec4247fb010c98db9dd20c242b57e532969c4f6814d25db56adf6ed2828e2054ec035"} 19:37:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:37:27 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:37:27 INFO - Contents: 19:37:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fadd4fe36ee7cee7fc51fb53c38f6b9b855a53c0459db925408e7f1eddaa289db1877cabcee22d00f443f5adf37908bf33fa754fcdc8f48731a4ed983c31e32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce1803c764a454f8d6142c9477a77513458a56884d951112a0d1833ac2fec4247fb010c98db9dd20c242b57e532969c4f6814d25db56adf6ed2828e2054ec035"} 19:37:27 INFO - Running post-run listener: copy_logs_to_upload_dir 19:37:27 INFO - Copying logs to upload dir... 19:37:27 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:37:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.804078 ========= master_lag: 0.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-03-08 19:37:27.778640) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 19:37:27.786044) ========= 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=7de08804244eb36560b44971000001c3-1457493412.887070-1404109586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fadd4fe36ee7cee7fc51fb53c38f6b9b855a53c0459db925408e7f1eddaa289db1877cabcee22d00f443f5adf37908bf33fa754fcdc8f48731a4ed983c31e32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce1803c764a454f8d6142c9477a77513458a56884d951112a0d1833ac2fec4247fb010c98db9dd20c242b57e532969c4f6814d25db56adf6ed2828e2054ec035"} build_url:https://queue.taskcluster.net/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005522 build_url: 'https://queue.taskcluster.net/v1/task/WaO3JPuLSvm4FqK8oz84iA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fadd4fe36ee7cee7fc51fb53c38f6b9b855a53c0459db925408e7f1eddaa289db1877cabcee22d00f443f5adf37908bf33fa754fcdc8f48731a4ed983c31e32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce1803c764a454f8d6142c9477a77513458a56884d951112a0d1833ac2fec4247fb010c98db9dd20c242b57e532969c4f6814d25db56adf6ed2828e2054ec035"}' ========= master_lag: 0.42 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 19:37:28.207399) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 19:37:28.207747) ========= 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=7de08804244eb36560b44971000001c3-1457493412.887070-1404109586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002256 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 19:37:28.220328) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 19:37:28.220618) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 19:37:28.220899) ========= ========= Total master_lag: 0.92 =========