builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1460512695.81 results: success (0) buildid: 20160412163035 builduid: 10dfc807cdf946a68de9b59ba3a2d81d revision: fb921246e2d60f521f83defed54e30a38df1be3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:15.811946) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:15.812429) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:15.812723) ========= 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=20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006425 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:15.835657) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:15.835937) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:15.849109) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:15.849432) ========= 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=20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:15.897890) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:15.898347) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:15.898767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:15.899088) ========= 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=20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-12 18:58:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 97.3M=0s 2016-04-12 18:58:16 (97.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101833 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:16.012876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:16.013158) ========= 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=20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022924 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:16.061686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-12 18:58:16.062012) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fb921246e2d60f521f83defed54e30a38df1be3e --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 fb921246e2d60f521f83defed54e30a38df1be3e --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=20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-12 18:58:16,399 truncating revision to first 12 chars 2016-04-12 18:58:16,399 Setting DEBUG logging. 2016-04-12 18:58:16,399 attempt 1/10 2016-04-12 18:58:16,399 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fb921246e2d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 18:58:17,614 unpacking tar archive at: mozilla-central-fb921246e2d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.494837 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-12 18:58:17.569681) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:17.570023) ========= echo fb921246e2d60f521f83defed54e30a38df1be3e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fb921246e2d60f521f83defed54e30a38df1be3e'] 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=20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False fb921246e2d60f521f83defed54e30a38df1be3e program finished with exit code 0 elapsedTime=0.003418 script_repo_revision: 'fb921246e2d60f521f83defed54e30a38df1be3e' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:17.618036) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:17.618370) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:17.628030) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-12 18:58:17.628317) ========= /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=20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:58:18 INFO - MultiFileLogger online at 20160412 18:58:18 in /builds/slave/test-pgo 18:58:18 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 18:58:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:58:18 INFO - {'append_to_log': False, 18:58:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:58:18 INFO - 'blob_upload_branch': 'Firefox', 18:58:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:58:18 INFO - 'branch': 'Firefox', 18:58:18 INFO - 'buildbot_json_path': 'buildprops.json', 18:58:18 INFO - 'config_files': ('talos/linux_config.py',), 18:58:18 INFO - 'default_actions': ('clobber', 18:58:18 INFO - 'read-buildbot-config', 18:58:18 INFO - 'download-and-extract', 18:58:18 INFO - 'populate-webroot', 18:58:18 INFO - 'create-virtualenv', 18:58:18 INFO - 'install', 18:58:18 INFO - 'run-tests'), 18:58:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:58:18 INFO - 'download_minidump_stackwalk': True, 18:58:18 INFO - 'download_symbols': 'ondemand', 18:58:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:58:18 INFO - 'tooltool.py': '/tools/tooltool.py', 18:58:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:58:18 INFO - '/tools/misc-python/virtualenv.py')}, 18:58:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:58:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:58:18 INFO - 'installer_path': 'installer.exe', 18:58:18 INFO - 'log_level': 'info', 18:58:18 INFO - 'log_name': 'talos', 18:58:18 INFO - 'log_to_console': True, 18:58:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:58:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:58:18 INFO - 'opt_config_files': (), 18:58:18 INFO - 'pip_index': False, 18:58:18 INFO - 'sps_profile': False, 18:58:18 INFO - 'sps_profile_interval': 0, 18:58:18 INFO - 'suite': 'dromaeojs', 18:58:18 INFO - 'system_bits': '32', 18:58:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:58:18 INFO - 'title': 'talos-linux64-ix-015', 18:58:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:58:18 INFO - 'use_talos_json': True, 18:58:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:58:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:58:18 INFO - 'work_dir': 'build'} 18:58:18 INFO - ##### 18:58:18 INFO - ##### Running clobber step. 18:58:18 INFO - ##### 18:58:18 INFO - Running pre-action listener: _resource_record_pre_action 18:58:18 INFO - Running main action method: clobber 18:58:18 INFO - rmtree: /builds/slave/test-pgo/build 18:58:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:58:19 INFO - Running post-action listener: _resource_record_post_action 18:58:19 INFO - ##### 18:58:19 INFO - ##### Running read-buildbot-config step. 18:58:19 INFO - ##### 18:58:19 INFO - Running pre-action listener: _resource_record_pre_action 18:58:19 INFO - Running main action method: read_buildbot_config 18:58:19 INFO - Using buildbot properties: 18:58:19 INFO - { 18:58:19 INFO - "project": "", 18:58:19 INFO - "product": "firefox", 18:58:19 INFO - "script_repo_revision": "production", 18:58:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:58:19 INFO - "repository": "", 18:58:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 18:58:19 INFO - "buildid": "20160412163035", 18:58:19 INFO - "pgo_build": "True", 18:58:19 INFO - "basedir": "/builds/slave/test-pgo", 18:58:19 INFO - "buildnumber": 401, 18:58:19 INFO - "slavename": "talos-linux64-ix-015", 18:58:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:58:19 INFO - "platform": "ubuntu64_hw", 18:58:19 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:58:19 INFO - "branch": "mozilla-central", 18:58:19 INFO - "repo_path": "mozilla-central", 18:58:19 INFO - "revision": "fb921246e2d60f521f83defed54e30a38df1be3e", 18:58:19 INFO - "stage_platform": "linux64-pgo", 18:58:19 INFO - "builduid": "10dfc807cdf946a68de9b59ba3a2d81d", 18:58:19 INFO - "slavebuilddir": "test" 18:58:19 INFO - } 18:58:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:58:19 INFO - Running post-action listener: _resource_record_post_action 18:58:19 INFO - ##### 18:58:19 INFO - ##### Running download-and-extract step. 18:58:19 INFO - ##### 18:58:19 INFO - Running pre-action listener: _resource_record_pre_action 18:58:19 INFO - Running main action method: download_and_extract 18:58:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:58:19 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')]} 18:58:19 INFO - https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:58:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:58:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:58:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/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 18:58:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/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 18:58:22 INFO - Downloaded 1361 bytes. 18:58:22 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:58:22 INFO - Using the following test package requirements: 18:58:22 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:58:22 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:58:22 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:58:22 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:22 INFO - u'jsshell-linux-x86_64.zip'], 18:58:22 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:58:22 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:58:22 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:58:22 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:58:22 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:58:22 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:58:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:22 INFO - https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:58:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:58:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:58:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/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 18:58:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/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 18:58:23 INFO - Downloaded 23769494 bytes. 18:58:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:58:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:58:25 INFO - Return code: 0 18:58:25 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 18:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:25 INFO - https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:58:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:58:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:58:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/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 18:58:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/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 18:58:26 INFO - Downloaded 23769494 bytes. 18:58:26 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'] 18:58:26 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 18:58:27 INFO - Return code: 0 18:58:27 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')]} 18:58:27 INFO - https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:58:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:58:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:58:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/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 18:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/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 18:58:29 INFO - Downloaded 10841076 bytes. 18:58:29 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'] 18:58:29 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 18:58:29 INFO - Return code: 0 18:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:29 INFO - https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:58:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:58:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:58:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/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 18:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/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 18:58:31 INFO - Downloaded 57823919 bytes. 18:58:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:58:31 INFO - mkdir: /builds/slave/test-pgo/properties 18:58:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:58:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:58:31 INFO - Contents: 18:58:31 INFO - build_url:https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:58:32 INFO - Running post-action listener: _resource_record_post_action 18:58:32 INFO - Running post-action listener: set_extra_try_arguments 18:58:32 INFO - ##### 18:58:32 INFO - ##### Running populate-webroot step. 18:58:32 INFO - ##### 18:58:32 INFO - Running pre-action listener: _resource_record_pre_action 18:58:32 INFO - Running main action method: populate_webroot 18:58:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:58:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:58:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:58:32 INFO - '--tppagecycles', 18:58:32 INFO - '7'], 18:58:32 INFO - 'tests': ['tsvgm']}}, 18:58:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:58:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:58:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:58:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:58:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:58:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:58:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:32 INFO - 'talos_options': ['--disable-e10s'], 18:58:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:32 INFO - 'talos_options': ['--disable-e10s'], 18:58:32 INFO - 'tests': ['damp', 'tps']}, 18:58:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:32 INFO - 'tests': ['damp', 'tps']}, 18:58:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:58:32 INFO - 'tests': ['dromaeo_dom']}, 18:58:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:58:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:58:32 INFO - 'tests': ['a11yr', 18:58:32 INFO - 'ts_paint', 18:58:32 INFO - 'tpaint', 18:58:32 INFO - 'sessionrestore', 18:58:32 INFO - 'sessionrestore_no_auto_restore', 18:58:32 INFO - 'tabpaint']}, 18:58:32 INFO - 'other-e10s': {'tests': ['a11yr', 18:58:32 INFO - 'ts_paint', 18:58:32 INFO - 'tpaint', 18:58:32 INFO - 'sessionrestore', 18:58:32 INFO - 'sessionrestore_no_auto_restore', 18:58:32 INFO - 'tabpaint']}, 18:58:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:58:32 INFO - 'ts_paint', 18:58:32 INFO - 'tpaint', 18:58:32 INFO - 'sessionrestore', 18:58:32 INFO - 'sessionrestore_no_auto_restore', 18:58:32 INFO - 'tabpaint']}, 18:58:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:58:32 INFO - 'ts_paint', 18:58:32 INFO - 'tpaint', 18:58:32 INFO - 'sessionrestore', 18:58:32 INFO - 'sessionrestore_no_auto_restore', 18:58:32 INFO - 'tabpaint']}, 18:58:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:58:32 INFO - 'tests': ['a11yr', 18:58:32 INFO - 'ts_paint', 18:58:32 INFO - 'tpaint', 18:58:32 INFO - 'sessionrestore', 18:58:32 INFO - 'sessionrestore_no_auto_restore', 18:58:32 INFO - 'tabpaint']}, 18:58:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:58:32 INFO - 'tests': ['a11yr', 18:58:32 INFO - 'ts_paint', 18:58:32 INFO - 'tpaint', 18:58:32 INFO - 'sessionrestore', 18:58:32 INFO - 'sessionrestore_no_auto_restore', 18:58:32 INFO - 'tabpaint']}, 18:58:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:58:32 INFO - 'tests': ['tsvgx', 18:58:32 INFO - 'tsvgr_opacity', 18:58:32 INFO - 'tart', 18:58:32 INFO - 'tscrollx', 18:58:32 INFO - 'cart']}, 18:58:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:58:32 INFO - 'tsvgr_opacity', 18:58:32 INFO - 'tart', 18:58:32 INFO - 'tscrollx', 18:58:32 INFO - 'cart']}, 18:58:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:32 INFO - 'talos_options': ['--disable-e10s'], 18:58:32 INFO - 'tests': ['tp5o']}, 18:58:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:32 INFO - 'tests': ['tp5o']}, 18:58:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:32 INFO - 'talos_options': ['--disable-e10s', 18:58:32 INFO - '--xperf_path', 18:58:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:32 INFO - 'tests': ['tp5n']}, 18:58:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:32 INFO - 'talos_options': ['--xperf_path', 18:58:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:32 INFO - 'tests': ['tp5n']}}, 18:58:32 INFO - 'talos.zip': {'path': '', 18:58:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:58:32 INFO - Running post-action listener: _resource_record_post_action 18:58:32 INFO - ##### 18:58:32 INFO - ##### Running create-virtualenv step. 18:58:32 INFO - ##### 18:58:32 INFO - Running pre-action listener: _resource_record_pre_action 18:58:32 INFO - Running main action method: create_virtualenv 18:58:32 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:58:32 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 18:58:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:58:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:58:32 INFO - Using real prefix '/usr' 18:58:32 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:58:33 INFO - Installing distribute.............................................................................................................................................................................................done. 18:58:35 INFO - Installing pip.................done. 18:58:35 INFO - Return code: 0 18:58:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:35 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 0x7f34c55d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1d0>, '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 0x2700750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2700be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', '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 18:58:35 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 18:58:35 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 18:58:35 INFO - Using env: {'DISPLAY': ':0', 18:58:35 INFO - 'HOME': '/home/cltbld', 18:58:35 INFO - 'LANG': 'en_US.UTF-8', 18:58:35 INFO - 'LANGUAGE': 'en_US:en', 18:58:35 INFO - 'LOGNAME': 'cltbld', 18:58:35 INFO - 'MAIL': '/var/mail/cltbld', 18:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:35 INFO - 'MOZ_NO_REMOTE': '1', 18:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:35 INFO - 'NO_EM_RESTART': '1', 18:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:35 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:35 INFO - 'SHELL': '/bin/bash', 18:58:35 INFO - 'SHLVL': '1', 18:58:35 INFO - 'TERM': 'linux', 18:58:35 INFO - 'TMOUT': '86400', 18:58:35 INFO - 'USER': 'cltbld', 18:58:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', 18:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:35 INFO - '_': '/tools/buildbot/bin/python'} 18:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:35 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 18:58:35 INFO - Cleaning up... 18:58:35 INFO - Return code: 0 18:58:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:35 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 0x7f34c55d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1d0>, '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 0x2700750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2700be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', '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 18:58:35 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 18:58:35 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 18:58:35 INFO - Using env: {'DISPLAY': ':0', 18:58:35 INFO - 'HOME': '/home/cltbld', 18:58:35 INFO - 'LANG': 'en_US.UTF-8', 18:58:35 INFO - 'LANGUAGE': 'en_US:en', 18:58:35 INFO - 'LOGNAME': 'cltbld', 18:58:35 INFO - 'MAIL': '/var/mail/cltbld', 18:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:35 INFO - 'MOZ_NO_REMOTE': '1', 18:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:35 INFO - 'NO_EM_RESTART': '1', 18:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:35 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:35 INFO - 'SHELL': '/bin/bash', 18:58:35 INFO - 'SHLVL': '1', 18:58:35 INFO - 'TERM': 'linux', 18:58:35 INFO - 'TMOUT': '86400', 18:58:35 INFO - 'USER': 'cltbld', 18:58:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', 18:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:35 INFO - '_': '/tools/buildbot/bin/python'} 18:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:35 INFO - Downloading/unpacking psutil>=0.7.1 18:58: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 18:58: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 18:58: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 18:58: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 18:58: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 18:58: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 18:58:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:58:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:58:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:58:37 INFO - Installing collected packages: psutil 18:58:37 INFO - Running setup.py install for psutil 18:58:37 INFO - building 'psutil._psutil_linux' extension 18:58:37 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 18:58:38 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 18:58:38 INFO - building 'psutil._psutil_posix' extension 18:58:38 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 18:58:38 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 18:58:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:58:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:58:38 INFO - Successfully installed psutil 18:58:38 INFO - Cleaning up... 18:58:38 INFO - Return code: 0 18:58:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f34c55d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1d0>, '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 0x2700750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2700be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', '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 18:58:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:58:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:58:38 INFO - Using env: {'DISPLAY': ':0', 18:58:38 INFO - 'HOME': '/home/cltbld', 18:58:38 INFO - 'LANG': 'en_US.UTF-8', 18:58:38 INFO - 'LANGUAGE': 'en_US:en', 18:58:38 INFO - 'LOGNAME': 'cltbld', 18:58:38 INFO - 'MAIL': '/var/mail/cltbld', 18:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:38 INFO - 'MOZ_NO_REMOTE': '1', 18:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:38 INFO - 'NO_EM_RESTART': '1', 18:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:38 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:38 INFO - 'SHELL': '/bin/bash', 18:58:38 INFO - 'SHLVL': '1', 18:58:38 INFO - 'TERM': 'linux', 18:58:38 INFO - 'TMOUT': '86400', 18:58:38 INFO - 'USER': 'cltbld', 18:58:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', 18:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:38 INFO - '_': '/tools/buildbot/bin/python'} 18:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:58:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:58:40 INFO - Installing collected packages: mozsystemmonitor 18:58:40 INFO - Running setup.py install for mozsystemmonitor 18:58:40 INFO - Successfully installed mozsystemmonitor 18:58:40 INFO - Cleaning up... 18:58:40 INFO - Return code: 0 18:58:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:58:40 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')]} 18:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:40 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')]} 18:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:40 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 0x7f34c55d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1d0>, '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 0x2700750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2700be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', '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 18:58:40 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 18:58:40 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 18:58:40 INFO - Using env: {'DISPLAY': ':0', 18:58:40 INFO - 'HOME': '/home/cltbld', 18:58:40 INFO - 'LANG': 'en_US.UTF-8', 18:58:40 INFO - 'LANGUAGE': 'en_US:en', 18:58:40 INFO - 'LOGNAME': 'cltbld', 18:58:40 INFO - 'MAIL': '/var/mail/cltbld', 18:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:40 INFO - 'MOZ_NO_REMOTE': '1', 18:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:40 INFO - 'NO_EM_RESTART': '1', 18:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:40 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:40 INFO - 'SHELL': '/bin/bash', 18:58:40 INFO - 'SHLVL': '1', 18:58:40 INFO - 'TERM': 'linux', 18:58:40 INFO - 'TMOUT': '86400', 18:58:40 INFO - 'USER': 'cltbld', 18:58:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', 18:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:40 INFO - '_': '/tools/buildbot/bin/python'} 18:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:40 INFO - Downloading/unpacking blobuploader==1.2.4 18:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:42 INFO - Downloading blobuploader-1.2.4.tar.gz 18:58:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:58:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:58:42 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 18:58:42 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 18:58:42 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 18:58:42 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 18:58:42 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 18:58:42 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 18:58:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:58:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:58:43 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 18:58:43 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 18:58:43 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 18:58:43 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 18:58:43 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 18:58:43 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 18:58:43 INFO - Downloading docopt-0.6.1.tar.gz 18:58:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:58:43 INFO - Installing collected packages: blobuploader, requests, docopt 18:58:43 INFO - Running setup.py install for blobuploader 18:58:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:58:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:58:43 INFO - Running setup.py install for requests 18:58:43 INFO - Running setup.py install for docopt 18:58:44 INFO - Successfully installed blobuploader requests docopt 18:58:44 INFO - Cleaning up... 18:58:44 INFO - Return code: 0 18:58:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:44 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 0x7f34c55d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1d0>, '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 0x2700750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2700be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', '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 18:58:44 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 18:58:44 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 18:58:44 INFO - Using env: {'DISPLAY': ':0', 18:58:44 INFO - 'HOME': '/home/cltbld', 18:58:44 INFO - 'LANG': 'en_US.UTF-8', 18:58:44 INFO - 'LANGUAGE': 'en_US:en', 18:58:44 INFO - 'LOGNAME': 'cltbld', 18:58:44 INFO - 'MAIL': '/var/mail/cltbld', 18:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:44 INFO - 'MOZ_NO_REMOTE': '1', 18:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:44 INFO - 'NO_EM_RESTART': '1', 18:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:44 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:44 INFO - 'SHELL': '/bin/bash', 18:58:44 INFO - 'SHLVL': '1', 18:58:44 INFO - 'TERM': 'linux', 18:58:44 INFO - 'TMOUT': '86400', 18:58:44 INFO - 'USER': 'cltbld', 18:58:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', 18:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:44 INFO - '_': '/tools/buildbot/bin/python'} 18:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:58:44 INFO - Running setup.py (path:/tmp/pip-q0wNkV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:58:44 INFO - Running setup.py (path:/tmp/pip-yYQAVD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:58:44 INFO - Running setup.py (path:/tmp/pip-ZPI7Tf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:58:44 INFO - Running setup.py (path:/tmp/pip-ZGLHzs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:58:44 INFO - Running setup.py (path:/tmp/pip-1YXukT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:58:44 INFO - Running setup.py (path:/tmp/pip-pUkKnu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:58:44 INFO - Running setup.py (path:/tmp/pip-0hnhFw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:58:44 INFO - Running setup.py (path:/tmp/pip-L3jE_k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:58:44 INFO - Running setup.py (path:/tmp/pip-1cIlXD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:58:44 INFO - Running setup.py (path:/tmp/pip-B_NwNR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:58:45 INFO - Running setup.py (path:/tmp/pip-P9YH0Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:58:45 INFO - Running setup.py (path:/tmp/pip-R3CILf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:58:45 INFO - Running setup.py (path:/tmp/pip-bYeDhj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:58:45 INFO - Running setup.py (path:/tmp/pip-QeaSi1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:58:45 INFO - Running setup.py (path:/tmp/pip-8UgtwF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:58:45 INFO - Running setup.py (path:/tmp/pip-Yot2m7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:58:45 INFO - Running setup.py (path:/tmp/pip-7MbcCn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:58:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:58:45 INFO - Running setup.py install for manifestparser 18:58:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:58:45 INFO - Running setup.py install for mozcrash 18:58:45 INFO - Running setup.py install for mozdebug 18:58:45 INFO - Running setup.py install for mozdevice 18:58:45 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:58:45 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:58:45 INFO - Running setup.py install for mozfile 18:58:46 INFO - Running setup.py install for mozhttpd 18:58:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:58:46 INFO - Running setup.py install for mozinfo 18:58:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:58:46 INFO - Running setup.py install for mozInstall 18:58:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:58:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:58:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:58:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:58:46 INFO - Running setup.py install for mozleak 18:58:46 INFO - Running setup.py install for mozlog 18:58:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:58:46 INFO - Running setup.py install for moznetwork 18:58:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:58:46 INFO - Running setup.py install for mozprocess 18:58:46 INFO - Running setup.py install for mozprofile 18:58:46 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:58:46 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:58:46 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:58:46 INFO - Running setup.py install for mozrunner 18:58:46 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:58:46 INFO - Running setup.py install for mozscreenshot 18:58:47 INFO - Running setup.py install for moztest 18:58:47 INFO - Running setup.py install for mozversion 18:58:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:58:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:58:47 INFO - Cleaning up... 18:58:47 INFO - Return code: 0 18:58:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:47 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 0x7f34c55d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1d0>, '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 0x2700750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2700be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', '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 18:58:47 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 18:58:47 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 18:58:47 INFO - Using env: {'DISPLAY': ':0', 18:58:47 INFO - 'HOME': '/home/cltbld', 18:58:47 INFO - 'LANG': 'en_US.UTF-8', 18:58:47 INFO - 'LANGUAGE': 'en_US:en', 18:58:47 INFO - 'LOGNAME': 'cltbld', 18:58:47 INFO - 'MAIL': '/var/mail/cltbld', 18:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:47 INFO - 'MOZ_NO_REMOTE': '1', 18:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:47 INFO - 'NO_EM_RESTART': '1', 18:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:47 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:47 INFO - 'SHELL': '/bin/bash', 18:58:47 INFO - 'SHLVL': '1', 18:58:47 INFO - 'TERM': 'linux', 18:58:47 INFO - 'TMOUT': '86400', 18:58:47 INFO - 'USER': 'cltbld', 18:58:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', 18:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:47 INFO - '_': '/tools/buildbot/bin/python'} 18:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:58:47 INFO - Running setup.py (path:/tmp/pip-3zjNdc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:58:47 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)) 18:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:58:47 INFO - Running setup.py (path:/tmp/pip-w7k8QB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:58:47 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)) 18:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:58:47 INFO - Running setup.py (path:/tmp/pip-GG6bTg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:58:47 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)) 18:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:58:47 INFO - Running setup.py (path:/tmp/pip-_lSJdy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:58:47 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)) 18:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:58:47 INFO - Running setup.py (path:/tmp/pip-v9vCvL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:58:47 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)) 18:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:58:47 INFO - Running setup.py (path:/tmp/pip-XRbr3P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:58:47 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)) 18:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:58:47 INFO - Running setup.py (path:/tmp/pip-8dL0Yw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:58:48 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)) 18:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:58:48 INFO - Running setup.py (path:/tmp/pip-Us4Ycf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:58:48 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)) 18:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:58:48 INFO - Running setup.py (path:/tmp/pip-s2KqAj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:58:48 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)) 18:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:58:48 INFO - Running setup.py (path:/tmp/pip-xgFlY3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:58:48 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)) 18:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:58:48 INFO - Running setup.py (path:/tmp/pip-eJcfy9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:58:48 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)) 18:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:58:48 INFO - Running setup.py (path:/tmp/pip-YufNUg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:58:48 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)) 18:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:58:48 INFO - Running setup.py (path:/tmp/pip-s6GRts-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:58:48 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)) 18:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:58:48 INFO - Running setup.py (path:/tmp/pip-y83F_1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:58:48 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)) 18:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:58:48 INFO - Running setup.py (path:/tmp/pip-HQgPnn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:58:48 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)) 18:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:58:48 INFO - Running setup.py (path:/tmp/pip-iVN3bO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:58:48 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)) 18:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:58:48 INFO - Running setup.py (path:/tmp/pip-ZeH2bm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:58:48 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)) 18:58:48 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)) 18:58:48 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)) 18:58:48 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)) 18:58:48 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)) 18:58:48 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)) 18:58:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:58:48 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 18:58:48 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 18:58:48 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 18:58:48 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 18:58:48 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 18:58:48 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 18:58:50 INFO - Downloading blessings-1.6.tar.gz 18:58:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:58:50 INFO - Installing collected packages: blessings 18:58:50 INFO - Running setup.py install for blessings 18:58:50 INFO - Successfully installed blessings 18:58:50 INFO - Cleaning up... 18:58:50 INFO - Return code: 0 18:58:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:58:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:58:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:58:51 INFO - Reading from file tmpfile_stdout 18:58:51 INFO - Current package versions: 18:58:51 INFO - argparse == 1.2.1 18:58:51 INFO - blessings == 1.6 18:58:51 INFO - blobuploader == 1.2.4 18:58:51 INFO - docopt == 0.6.1 18:58:51 INFO - manifestparser == 1.1 18:58:51 INFO - mozInstall == 1.12 18:58:51 INFO - mozcrash == 0.17 18:58:51 INFO - mozdebug == 0.1 18:58:51 INFO - mozdevice == 0.48 18:58:51 INFO - mozfile == 1.2 18:58:51 INFO - mozhttpd == 0.7 18:58:51 INFO - mozinfo == 0.9 18:58:51 INFO - mozleak == 0.1 18:58:51 INFO - mozlog == 3.1 18:58:51 INFO - moznetwork == 0.27 18:58:51 INFO - mozprocess == 0.22 18:58:51 INFO - mozprofile == 0.28 18:58:51 INFO - mozrunner == 6.11 18:58:51 INFO - mozscreenshot == 0.1 18:58:51 INFO - mozsystemmonitor == 0.0 18:58:51 INFO - moztest == 0.7 18:58:51 INFO - mozversion == 1.4 18:58:51 INFO - psutil == 3.1.1 18:58:51 INFO - requests == 1.2.3 18:58:51 INFO - wsgiref == 0.1.2 18:58:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:51 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 0x7f34c55d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1d0>, '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 0x2700750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2700be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', '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 18:58:51 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 18:58:51 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 18:58:51 INFO - Using env: {'DISPLAY': ':0', 18:58:51 INFO - 'HOME': '/home/cltbld', 18:58:51 INFO - 'LANG': 'en_US.UTF-8', 18:58:51 INFO - 'LANGUAGE': 'en_US:en', 18:58:51 INFO - 'LOGNAME': 'cltbld', 18:58:51 INFO - 'MAIL': '/var/mail/cltbld', 18:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:51 INFO - 'MOZ_NO_REMOTE': '1', 18:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:51 INFO - 'NO_EM_RESTART': '1', 18:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:51 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:51 INFO - 'SHELL': '/bin/bash', 18:58:51 INFO - 'SHLVL': '1', 18:58:51 INFO - 'TERM': 'linux', 18:58:51 INFO - 'TMOUT': '86400', 18:58:51 INFO - 'USER': 'cltbld', 18:58:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', 18:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:51 INFO - '_': '/tools/buildbot/bin/python'} 18:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:51 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)) 18:58:51 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)) 18:58:51 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)) 18:58:51 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)) 18:58:51 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)) 18:58:51 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)) 18:58:51 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)) 18:58:51 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)) 18:58:51 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)) 18:58:51 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)) 18:58:51 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)) 18:58:51 INFO - Cleaning up... 18:58:51 INFO - Return code: 0 18:58:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:51 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 0x7f34c55d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1d0>, '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 0x2700750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2700be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', '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 18:58:51 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 18:58:51 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 18:58:51 INFO - Using env: {'DISPLAY': ':0', 18:58:51 INFO - 'HOME': '/home/cltbld', 18:58:51 INFO - 'LANG': 'en_US.UTF-8', 18:58:51 INFO - 'LANGUAGE': 'en_US:en', 18:58:51 INFO - 'LOGNAME': 'cltbld', 18:58:51 INFO - 'MAIL': '/var/mail/cltbld', 18:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:51 INFO - 'MOZ_NO_REMOTE': '1', 18:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:51 INFO - 'NO_EM_RESTART': '1', 18:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:51 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:51 INFO - 'SHELL': '/bin/bash', 18:58:51 INFO - 'SHLVL': '1', 18:58:51 INFO - 'TERM': 'linux', 18:58:51 INFO - 'TMOUT': '86400', 18:58:51 INFO - 'USER': 'cltbld', 18:58:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', 18:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:51 INFO - '_': '/tools/buildbot/bin/python'} 18:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:51 INFO - Downloading/unpacking jsonschema 18:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:58:53 INFO - Downloading/unpacking functools32 (from jsonschema) 18:58:53 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 18:58:53 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 18:58:53 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 18:58:53 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 18:58:53 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 18:58:53 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 18:58:53 INFO - Downloading functools32-3.2.3-2.tar.gz 18:58:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:58:53 INFO - warning: no files found matching '*.txt' 18:58:53 INFO - no previously-included directories found matching 'build' 18:58:53 INFO - no previously-included directories found matching 'dist' 18:58:53 INFO - no previously-included directories found matching '.git*' 18:58:53 INFO - Installing collected packages: jsonschema, functools32 18:58:53 INFO - Running setup.py install for functools32 18:58:53 INFO - warning: no files found matching '*.txt' 18:58:53 INFO - no previously-included directories found matching 'build' 18:58:53 INFO - no previously-included directories found matching 'dist' 18:58:53 INFO - no previously-included directories found matching '.git*' 18:58:53 INFO - Successfully installed jsonschema functools32 18:58:53 INFO - Cleaning up... 18:58:53 INFO - Return code: 0 18:58:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:58:53 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')]} 18:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:53 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')]} 18:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:53 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 0x7f34c55d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1d0>, '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 0x2700750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2700be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', '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 18:58:53 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 18:58:53 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 18:58:53 INFO - Using env: {'DISPLAY': ':0', 18:58:53 INFO - 'HOME': '/home/cltbld', 18:58:53 INFO - 'LANG': 'en_US.UTF-8', 18:58:53 INFO - 'LANGUAGE': 'en_US:en', 18:58:53 INFO - 'LOGNAME': 'cltbld', 18:58:53 INFO - 'MAIL': '/var/mail/cltbld', 18:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:53 INFO - 'MOZ_NO_REMOTE': '1', 18:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:53 INFO - 'NO_EM_RESTART': '1', 18:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:53 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:53 INFO - 'SHELL': '/bin/bash', 18:58:53 INFO - 'SHLVL': '1', 18:58:53 INFO - 'TERM': 'linux', 18:58:53 INFO - 'TMOUT': '86400', 18:58:53 INFO - 'USER': 'cltbld', 18:58:53 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', 18:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:53 INFO - '_': '/tools/buildbot/bin/python'} 18:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:54 INFO - Downloading/unpacking flake8 18:58:54 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 18:58:54 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 18:58:54 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 18:58:54 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 18:58:54 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 18:58:54 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 18:58:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:58:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:58:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:58:56 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 18:58:56 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 18:58:56 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 18:58:56 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 18:58:56 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 18:58:56 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 18:58:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:58:56 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 18:58:56 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 18:58:56 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 18:58:56 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 18:58:56 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 18:58:56 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 18:58:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:58:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:58:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:58:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:58:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:58:56 INFO - no previously-included directories found matching 'docs/_build' 18:58:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:58:56 INFO - Running setup.py install for pep8 18:58:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:58:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:58:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:58:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:58:56 INFO - no previously-included directories found matching 'docs/_build' 18:58:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:58:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:58:56 INFO - Cleaning up... 18:58:56 INFO - Return code: 0 18:58:56 INFO - Running post-action listener: _resource_record_post_action 18:58:56 INFO - Running post-action listener: _start_resource_monitoring 18:58:57 INFO - Starting resource monitoring. 18:58:57 INFO - ##### 18:58:57 INFO - ##### Running install step. 18:58:57 INFO - ##### 18:58:57 INFO - Running pre-action listener: _resource_record_pre_action 18:58:57 INFO - Running main action method: install 18:58:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:58:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:58:57 INFO - Reading from file tmpfile_stdout 18:58:57 INFO - Detecting whether we're running mozinstall >=1.0... 18:58:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:58:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:58:57 INFO - Reading from file tmpfile_stdout 18:58:57 INFO - Output received: 18:58:57 INFO - Usage: mozinstall [options] installer 18:58:57 INFO - Options: 18:58:57 INFO - -h, --help show this help message and exit 18:58:57 INFO - -d DEST, --destination=DEST 18:58:57 INFO - Directory to install application into. [default: 18:58:57 INFO - "/builds/slave/test-pgo"] 18:58:57 INFO - --app=APP Application being installed. [default: firefox] 18:58:57 INFO - mkdir: /builds/slave/test-pgo/build/application 18:58:57 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'] 18:58:57 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 18:59:13 INFO - Reading from file tmpfile_stdout 18:59:13 INFO - Output received: 18:59:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:59:13 INFO - Running post-action listener: _resource_record_post_action 18:59:13 INFO - ##### 18:59:13 INFO - ##### Running run-tests step. 18:59:13 INFO - ##### 18:59:13 INFO - Running pre-action listener: _resource_record_pre_action 18:59:13 INFO - Running main action method: run_tests 18:59:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:59:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:59:13 INFO - Python 2.7.3 18:59:13 INFO - Return code: 0 18:59:13 INFO - grabbing minidump binary from tooltool 18:59:13 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')]} 18:59:13 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 0x26fd1d0>, '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 0x2700750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2700be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:59:13 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 18:59:13 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 18:59:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:59:13 INFO - Return code: 0 18:59:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:59:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:59:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:59:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:59:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:59:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:59:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:59:14 INFO - Return code: 0 18:59:14 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/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 18:59:14 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/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 18:59:14 INFO - Using env: {'DISPLAY': ':0', 18:59:14 INFO - 'HOME': '/home/cltbld', 18:59:14 INFO - 'LANG': 'en_US.UTF-8', 18:59:14 INFO - 'LANGUAGE': 'en_US:en', 18:59:14 INFO - 'LOGNAME': 'cltbld', 18:59:14 INFO - 'MAIL': '/var/mail/cltbld', 18:59:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:59:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:14 INFO - 'MOZ_NO_REMOTE': '1', 18:59:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:14 INFO - 'NO_EM_RESTART': '1', 18:59:14 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:59:14 INFO - 'PWD': '/builds/slave/test-pgo', 18:59:14 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:59:14 INFO - 'SHELL': '/bin/bash', 18:59:14 INFO - 'SHLVL': '1', 18:59:14 INFO - 'TERM': 'linux', 18:59:14 INFO - 'TMOUT': '86400', 18:59:14 INFO - 'USER': 'cltbld', 18:59:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868', 18:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:14 INFO - '_': '/tools/buildbot/bin/python'} 18:59:14 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/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 18:59:15 INFO - mozversion application_buildid: 20160412163035 18:59:15 INFO - mozversion application_changeset: fb921246e2d60f521f83defed54e30a38df1be3e 18:59:15 INFO - mozversion application_display_name: Nightly 18:59:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:59:15 INFO - mozversion application_name: Firefox 18:59:15 INFO - mozversion application_remotingname: firefox 18:59:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:59:15 INFO - mozversion application_vendor: Mozilla 18:59:15 INFO - mozversion application_version: 48.0a1 18:59:15 INFO - mozversion platform_buildid: 20160412163035 18:59:15 INFO - mozversion platform_changeset: fb921246e2d60f521f83defed54e30a38df1be3e 18:59:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:59:15 INFO - mozversion platform_version: 48.0a1 18:59:15 INFO - using testdate: 1460512755 18:59:15 INFO - actual date: 1460512755 18:59:15 INFO - starting webserver on 'localhost:32919' 18:59:15 INFO - SUITE-START | Running 2 tests 18:59:15 INFO - TEST-START | dromaeo_css 18:59:15 INFO - operating with platform_type : linux_ 18:59:15 INFO - Initialising browser for dromaeo_css test... 18:59:15 INFO - TEST-INFO | started process 21864 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2C9hl3/profile http://localhost:32919/getInfo.html) 18:59:18 INFO - PROCESS | 21864 | __metrics Screen width/height:1600/1200 18:59:18 INFO - PROCESS | 21864 | colorDepth:24 18:59:18 INFO - PROCESS | 21864 | Browser inner width/height: 1024/697 18:59:18 INFO - PROCESS | 21864 | __metrics 18:59:19 ERROR - PROCESS | 21864 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:59:20 INFO - TEST-INFO | 21864: exit 0 18:59:20 INFO - Browser initialized. 18:59:20 INFO - Running cycle 1/1 for dromaeo_css test... 18:59:20 INFO - TEST-INFO | started process 21947 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2C9hl3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:59:32 INFO - PROCESS | 21947 | RSS: Main: 153272320 18:59:32 INFO - PROCESS | 21947 | 19:00:23 INFO - PROCESS | 21947 | 1460512823442 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:02:30 INFO - PROCESS | 21947 | Cycle 1(1): loaded http://localhost:32919/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32919/tests/dromaeo/cssquery-ext.html) 19:02:31 INFO - PROCESS | 21947 | RSS: Main: 238751744 19:02:31 INFO - PROCESS | 21947 | 19:05:34 INFO - PROCESS | 21947 | Cycle 1(1): loaded http://localhost:32919/tests/dromaeo/cssquery-ext.html (next: http://localhost:32919/tests/dromaeo/cssquery-jquery.html) 19:05:34 INFO - PROCESS | 21947 | RSS: Main: 236838912 19:05:34 INFO - PROCESS | 21947 | 19:08:36 INFO - PROCESS | 21947 | Cycle 1(1): loaded http://localhost:32919/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32919/tests/dromaeo/cssquery-mootools.html) 19:08:37 INFO - PROCESS | 21947 | RSS: Main: 228003840 19:08:37 INFO - PROCESS | 21947 | 19:11:39 INFO - PROCESS | 21947 | Cycle 1(1): loaded http://localhost:32919/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32919/tests/dromaeo/cssquery-prototype.html) 19:11:39 INFO - PROCESS | 21947 | RSS: Main: 209760256 19:11:39 INFO - PROCESS | 21947 | 19:14:42 INFO - PROCESS | 21947 | Cycle 1(1): loaded http://localhost:32919/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32919/tests/dromaeo/cssquery-yui.html) 19:14:42 INFO - PROCESS | 21947 | RSS: Main: 215412736 19:14:42 INFO - PROCESS | 21947 | 19:17:45 INFO - PROCESS | 21947 | Cycle 1(1): loaded http://localhost:32919/tests/dromaeo/cssquery-yui.html (next: http://localhost:32919/tests/dromaeo/cssquery-dojo.html) 19:17:45 INFO - PROCESS | 21947 | RSS: Main: 265961472 19:17:45 INFO - PROCESS | 21947 | 19:17:45 INFO - PROCESS | 21947 | __start_tp_report 19:17:45 INFO - PROCESS | 21947 | _x_x_mozilla_page_load 19:17:45 INFO - PROCESS | 21947 | _x_x_mozilla_page_load_details 19:17:45 INFO - PROCESS | 21947 | |i|pagename|runs| 19:17:45 INFO - PROCESS | 21947 | |0;dojo.html;3081.32210913599;3154.779165458419;3190.7287880530153;3195.025517217248;3207.6952689494497;5132.794688212476;5316.9202461963105;5341.065313570124;5359.65162264453;5447.373552041517;5361.383440904287;5395.568354531638;5435.646682965605;5451.2640793492865;5457.699826509541;4726.810927562893;4774.092922344761;4890.21756518957;4938.629602779806;4943.802247910097;4854.757262136896;4897.240927656201;4922.138625740499;4931.161702510582;4932.80268789248;4672.672912896099;4801.7839197236035;4806.4712881583;4850.466448690641;4885.145099607572;4841.951580484185;4851.684640498356;4862.270659401082;4868.707877527324;4885.804567817283;4729.858104256843;4795.592374648159;4836.298736683161;4851.466338702739;4879.780409881564;5148.536631703165;5215.6609820361555;5229.816956406507;5257.789688412459;5266.92099618506;5628.352739434977;5653.886922261573;5669.801556945528;5674.120511320752;5676.574256930747;5556.91664625031;5663.801766938137;5700.287464066992;5707.315122185323;5713;5347.759350829222;5355.518003379676;5366.8926621467745;5370.91943620846;5418.241446197496;5827.796027139115;5832.708364581754;5832.708364581838;5832.737526811304;5837.766489340379;5407.270018547446;5568.638038527482;5607.551395888319;5613.635113717677;5646.378898321182;5674.829755107354;5675.829725108253;5677.659340439587;5677.744501497443;5712.542996560265;5635.549156067505;5640.830775076673;5646.915296270559;5650.491455769001;5652.802151924663;5464.672119672753;5618.6628802272;5656.236408084938;5737.684427356536;5740.13897915316;4301.913961720748;4302.65578753699;4307.784610769449;4313.008008158141;4342.5006124296115;3842.423636454554;3865.091703449687;3880.4567360569545;3895.2599006188734;3898.8440462381186;5225.4774522548205;5417.674939503642;5476.069068258405;5515.669059856422;5521.309836270466;5711.742971566289;5719.113537401709;5734.741936612862;5735.4551317624755;5736.6844823534275;5285.445028272053;5403.297571315704;5418.864528386743;5432.782688692487;5434.3498686201065;4792.2811578262845;4815.15734746418;4832.492588278251;4863.878403039952;4868.488808675109;5927.3776253493625;5930.406959304035;5933.2880054393745;5935.910961335583;5939.792107276225;5522.558195344443;5713.457221563945;5737.053386191315;5747.396523365153;5749.998757992333;5906.675132867734;5931.9406805931385;5933.258342707161;5963.582549221686;5995.16067750524;5621.156826476062;5624.437556244343;5627.380988091389;5633.0987042073075;5633.2113504110275;5579.637323573955;5675.801346952837;5721.456461636138;5730;5730.942690573041;5380.704061276668;5448.918266226089;5630.324361076697;5716.314042314949;5738.885222295614;5616.129499927518;5629.380768115586;5633.690147041952;5633.774649013993;5634.6337488063145;5543.6396634218645;5547.33431988164;5553.278073850373;5555.111182210827;5559.305086864142;5406.702631355313;5606.859828504157;5634;5643.971780141073;5693.259876216231;5470.507654311131;5472.179173124063;5473.589480789036;5477.589180811535;5522.3649280333275 19:17:45 INFO - PROCESS | 21947 | |1;ext.html;609.4362714489097;653.4217217762281;662;671.7548094945344;725.2131437390431;36813.44779828305;37676;37692.62307376925;37809.24381512368;37838;42867.35698964518;43806;43806.34290485637;43841.78079109608;43886.34170487445;8635.870461943061;8811.647534098629;8863.468191908507;8865.423747456427;8868.556572171397;8622.35332350073;8740.562971851414;8746.650133994632;8749.606267717936;8754.474731516098;8723.912760872374;8792.07683193265;8828.42615230008;8830.42602230853;8831.735047948572;8716.912830871705;8770.254528365096;8776.166264204921;8780.209781119698;8793.736187914374;8619.65521379144;8697.173768491983;8708.651653933835;8715.433496822687;8724.476531408136;37897.24205515902;38326.80836595799;38380.232395352214;38427.23145537102;38439.8078009611;3213.1003319070696;3311.503274508819;3372.7976321420547;3525.94711079334;3555.6088830228655;30282.091537253917;30510.38979220403;31015.069547913597;31294.530582041287;31474.685253147403;4127.345025988284;4145.7927103645;4191.895202619929;4244.236037513247;4249.745015299061;261815;266630;267487;268013;268813;51006.48993510017;55925;56173.71913140408;56304;58403;56765.43234567684;57014.42985570091;57057.14414283789;57339.71330143406;57472.137917931264;15311.92344038295;15315.61710957235;15342.463013794464;15342.693146137015;15349.462768803038;11497.71255718597;12175.269483830998;12227.449764760608;12645.873541264653;12925.030622703334;18366.724499132524;18436;18472;18494.260229590665;18553.721694174597;6688.3646053624825;7131.607761573163;7195.172555156119;7261.673224704901;7286.48994570375;903.3179949138358;975.2539307429822;1039.656913218636;1214.5263347294563;1226.5461779141774;31481;32040;32045.359092818013;32146.83926580399;32310.515342269886;1122.354646078508;1128.503458478267;1137.113051819582;1139.880312567185;1239.2440611227144;16401.507954761375;16570.420035298946;16713.91643041777;16900;17039;410535;416182;416545;416589;417265;55064.72467637636;57216;57352.13971790426;57428.71285643545;57448.42551574514;1283.826683397748;1317.8682131786936;1345.8855997240148;1367.2753440676458;1399.8810101141314;29948.73425267202;32430.70277188886;32479.18802029968;32819.67180328262;32879.83560082184;45658.54341456543;46111;46240.76879615715;46294.53705462902;46351.07297854091;266396;267727;269008;269211;269259;24520.38699032467;25295.873520632278;28140.85929570339;28252.15243542697;28319.150425487267;41827.7908610455;42077.78961105175;42153.156936861706;42309.36535951902;42577;35967.28065438729;35980;36047.27905441824;36495;37071.443928341636;36125.81937090298;36620.63379366172;36974;37071.25857482889;40148;39309;40040;40251.79874100611;40395.3940690884;40407;32917.50623740694;34513.65486345105;34923.126921827155;34965.300693986486;35472.82263588665;26648.60027099634;26675.733242667324;26893.23494710703;27112.457750845268;27314.317142070813 19:17:45 INFO - PROCESS | 21947 | |2;jquery.html;382.8966179131634;390.1575224510844;391.8981064923121;394.2332163941134;395.5569761866708;13991.580252592414;15064.924675376607;17717.911410442946;18186.99999999998;18244;17710.911445442787;18312.359067432644;18641.254349826024;18789.43631691048;19184.712229316538;5672.432756724335;5813;5823.505002074829;5823.737931793079;5846.09385545239;4010.258102251078;5714.25714657094;5729.0833466645345;6023.427774361428;6364.172657554512;6273.874522509547;6283.59156654816;6319.526035547352;6329.303776584572;6342.524310676695;6194.256689197303;6332.461740752042;6342.556021078526;6342.6511541865175;6364.968175159141;5368.436314187033;5397.217403476474;5559;5572.219889215513;5580.748866301026;21929.671054934188;22205.666914996287;22273.888630556907;22448;22630.547389052128;2571.6014017827265;2597.9348467128575;2623.1868120882586;2695.7573818356245;2789.995601583428;13873.09824861391;13875.583732488041;14186.787198192036;14238.430462781476;14531.346089426;1849.9907500462411;1916.7795703494137;1931.4785008047747;1939.0789375046882;1957.9804201958084;72601.6369918147;76586.6170669143;80233;85928.57035714843;87927.56036219842;8627.137286271449;9151.908480915106;9267.67563135287;9632.47021413815;10632.202584806171;12917.741645167043;12948.482060717653;12957.611271661865;12985.415656295489;12995.545155919497;7501.362384197295;7584.749528483527;7636.31273185416;7683.116441609175;7731.188225236382;7678.1170165431695;7715.151333353327;7734.497257678233;7851.646675899598;7855.33229675484;4047.817848196838;4055.391691246278;4068.5931406859077;4090;4140.60664236897;1880.2666959885655;1888.5656299051295;1922.826945574905;1930.4980705016796;1936.4895381602373;931.2317338196016;964.0985678390728;979.2851218610455;980.2501086668705;1004.3622299839654;17961.281548737905;19316.227350906087;19389.709154362696;19469;19713.310034148737;932.6922115701802;944.8677185194078;988.1156365053381;988.2686811759246;988.3921388346259;10100.646477373404;10345.844812327821;10372.688819335432;10386.688399348031;10449.9477502612;512455;518411;519761;534696;540162;69235;80758.19241807506;81501.59249203716;87369.56315218384;90228.5488572553;1010.1867996262932;1035.8239099353127;1039.740064983754;1043.7495001199657;1067.7490789664423;16174.514764557081;16607;17134.914325428792;17281.222344994254;17498.91250543739;36138.63861361458;37546;37923;38648.42027369535;39020.6097939017;49137.50862491472;49951.75024124856;52416.47583524116;53740.193897090794;54060.459395405545;7423;7710.498817576839;8194.67221311141;8681.652733890574;8820.2061814437;12208.084393670688;12463.127581069239;12630.684232894251;12940.741185176432;13065;10949.014588687056;11049.779004420026;11064.557417703201;11266.493007814832;11583.76832463363;11413;11471.13966452536;11538.82691759641;11611.825822612498;11697.12271579652;11522.76954460923;11749.823752643888;11761.235519691192;11832.408379581158;11930.10524210705;7746.8450630985935;7803.609819508888;7828.960855195687;7861.056673199253;7886.211378862068;8532.658693652433;10528;11425.885741142814;11466.369349685514;11662.300261984308 19:17:45 INFO - PROCESS | 21947 | |3;mootools.html;1317.2096741954822;1499.7979314164259;1511.7430036893727;1655.1558705060415;1813.4468986958973;6871.587704737713;8200.507969521825;8497.872531912011;8512.148785121493;8523.232909038185;8207.466514676556;8342.165783421655;8351.832963340745;8357.28963038141;8362.623681934312;1984.851136164786;2276.1350686739015;2309.3302942146756;2340.1107579119994;2347.495288512969;2354.705661792276;2376.66726658268;2378.203301893868;2378.369732021016;2381.785639292463;2308.0767692922796;2345.7771511706446;2346.8474549154253;2350.059976009593;2351.1888398502488;1953.2382370875298;2262.9660555091605;2326.5230627721276;2328.092044102801;2329.2895666821614;2226.6326056200705;2230.743464501587;2236.016152892722;2236.664500324948;2278.6012447821563;8311;8338.374621903382;8354.665813367457;8360.665573377057;8392.748217553482;4989.57588604969;5137.871553211162;5139.717315547643;5157.432682404932;5179.171332586806;3312.585926759155;3406.148462884279;3409.215880347509;3410.6248312685584;3470.02839205023;1131.2081542919907;1141.680329507739;1156.7108222944264;1160.7562411893512;1171.0690001448868;11300.604478843201;11396.772064558745;11399.430028498542;11410.42947852604;11418.257813242195;4264.808083636244;4316.374125751749;4493.056458143827;4494.280915053576;4506.3916371290115;9277.350585458953;9297.907020929704;9305.25557955362;9316.114969077928;9321.72034838956;4453.621442177451;5164.638475306768;5168.2764412982215;5173.793048278027;5199.844004679866;4700.976495117503;4816.229403295526;4828.396450443694;4830.541098595698;4875.878103047381;3646.08847788053;3679.1905780728734;3754.9061273468383;3761.755485893408;3778.4332350147697;1147.1511081799408;1170.3387586013876;1171.3967306836985;1179.6225207933378;1182.603827717707;1349.190485708567;1351.4526616720243;1360.5782207515701;1365.4606430459912;1412.180935057664;7950.801229969182;8084.8383032339025;8139.511629302261;8140.83718325642;8141.104478507359;481.09313943217285;482.1369748150841;489.06588416125743;492.38943709800304;494.0218367632037;6462.48300135988;6470;6595.8021259362295;6635.601863888182;6648.634325112069;10309.74225644365;10544.578216871392;10721.195910306758;10737.409442480583;10741.140708743282;10224.693259202237;10383.740406489898;10496.265261431627;10568;10614.681559553226;8001.239882211181;8055.838883222303;8082.515049097073;8099.83800324002;8131.471454355448;7913.287804097658;7918.049834019724;8029.51822890605;8046.275835174628;8107.756767296991;9661.420314781135;9712.3201375903;9763.267754918268;9820.361676491006;9828;9799.118079372605;9803.509824508603;9925.801483970135;9955.900440995787;10156;7104.644767761488;7112;7152.249013853679;7494.063242094739;7516.511426757462;8250.504969701837;8275.875861861956;8306.667733290842;8328.916710833057;8374.665013399395;7398;7560.168381478143;7589.316961473494;7710.537367757953;7726.884096738666;7285.890711639436;7392.96303518479;7492.100947886289;7493.550386976799;7503.287187717158;7914.287714105758;7943.563104029103;7985.760427187193;7990.081140668897;7997.800054998672;7042.542234754725;7244.384227340735;7267.890981635174;7359.227281135618;7414.480986330905;7267;7283.562986220843;7320.377767889789;7320.487565870338;7330.706771729285 19:17:45 INFO - PROCESS | 21947 | |4;prototype.html;314.68688654788474;317.923698312405;320.8475973912391;325.29735770735215;325.79149344419574;5525.535733030745;5643.351014633318;5653.773849046039;5655.745491452879;5683.8579035524135;5561.138023606348;5567.805126820562;5580.888382232353;5581;5599.41206173352;3983.601639836022;4121.690873184508;4261.5738426157295;4285.992791693957;4300.720453170534;4253.595908388714;4265.658747300208;4275.486941567016;4294.334378171388;4298.78506074695;4247.766372849492;4259.850905218318;4262.360645903108;4262.786860656955;4273.658107351404;3993.121513267077;4119.2997190477545;4214.7471151731;4215.662746980234;4255.063885945087;3694.612065733113;3742.981285093584;3745.232227393378;3745.9063523412133;3746.2132952080096;5375.086235340002;5383.973080134574;5390;5391.24522566837;5407;4801.591864691505;4822.68652537584;4879.6096312295285;4903.509649035103;4905.117078925792;5800.477956983892;5809.651420914759;5814.738336774855;5825.679587622679;5828.504577110951;4087.017796368759;4089.7137200395982;4099.1596722672075;4101.46680931477;4104.91790164198;5872.677002764846;6036.909446358308;6051.4553690168095;6051.606645568068;6123.387661233885;4178.12259425524;4213.325867861189;4226.852060177879;4228.513720922072;4233.306677329031;4275.3800698898485;4291.2275790358035;4306.655467562588;4306.720063195945;4307.203167414038;4764.4282686077195;4879.951200488021;4928.162212423897;4942.332785073969;4948.307236986825;5849.88300233993;5851.297844258631;5870.530357571384;5875.29496460419;5889.411058894077;1468.7649976003788;1482.5107714454205;1486.9851301487063;1488.3897601983135;1489.4265707702612;908.7728067983004;962.7785609309898;995.4624502768424;1006.3408467453829;1013.3869009249298;5539.833804985857;5634;5664.376918538957;5676.971615141898;5680.943190568041;5934.643921364732;5991.850203744942;5993.280806303184;5999.610025348338;6017.308009578867;5543.695096769636;5655.717214139277;5682.602217844794;5684.772609095672;5694.772209111672;3177.6345720242007;3185.108169712484;3197.984010079981;3207.7273431758094;3209.406259841937;6033.577649564576;6162.784302549389;6163.876722465526;6174.536909731788;6174.8147555573405;5993.820185394445;6049.455549000611;6051.697415129226;6086.239220097488;6086.482648974887;6196.256449226122;6199.473044791153;6212.47193988507;6221.191245138103;6240.095186198067;5806.622569532967;6011.789587364597;6014.8195554133445;6020.217371741645;6025.276966764016;5913.58604897653;5939.732712027882;5949.846581311912;5957.434043765836;5970.611910225822;6012.158297838394;6205.348438414082;6207.410296021871;6214.316425193135;6242.531810114168;4228.365745138254;4249.681273904408;4249.960019190868;4257.70196086271;4260.233158031584;6024.096385542029;6036.336003039574;6045.244344456943;6048.153258543719;6051.183090282755;5662.235598194191;5838.970805145947;5918.733656985532;5939.624150339899;6020.367861374492;5905.704714764159;5943.52451803846;5955.3498693081165;5956.583039187215;5959.22530071088;4913.754312284443;5396.298481197419;5860.589758716849;5867.20792692981;5879.412058794257;5842.766289348378;5901.173835662925;5924.140999555127;6007.879842403215;6015.097735339734;5783.826485205451;5796.362400136066;5802.448767367094;5817.854553636023;5823.82528524145 19:17:45 INFO - PROCESS | 21947 | |5;yui.html;708.174976152782;735.0738070031758;823.5511646152846;833.1252185205534;840.47890308009;14870.33083511242;15137.167455789928;15139.697206055873;15170.772438413433;15171.31729072193;14782.482613108516;15617;15632.921835390836;15639.139847308394;15652.921735391306;648.5460177875483;658.134553062721;665.7669815564562;822.6750433578718;824.7855557555049;657.8552718401968;781.4490783997268;813.4712436915993;815.4251252866715;816.0941355095839;859.3683642522741;861.2076889261863;861.2550144125318;862.0904945282724;862.2756884217256;685.7736946807541;847.3729440214258;851.3955091884739;851.4210336970857;851.9787005324886;607.787274453942;623.2365352443267;624.0202881476084;624.6158612453308;624.8562830548954;14866.182359970197;14875;14995.550133496012;15018.774718379233;15025.624359391102;12829.87170128296;13322.200667959953;13330.133541319783;13342.599722008355;13593.184408935396;11338.886611133865;11773.2936023838;11795.469203885847;11796.29222246668;11909.464074116686;3734;3884.4950156479476;3911.647951684362;3950.2297052074855;3975.6223158799867;53612.195817062384;54084.18873716897;54251;55807.44192558063;58421.12368314521;10232.53953572091;10465.42440165783;10635.893641063645;10642.255042146975;10728.356298622108;17707.822921770618;17744.46766597004;17757.200925958365;17757.644847103245;17768.46694599164;7894.723684671124;7973.322267607318;8040.67837286502;8068.757937261891;8190.180981901762;4527.388802511685;4604.447466304065;4646.395968524071;4737.905241895142;4818.951810481921;3109.7356724678657;3217.8069315841126;3248.561444205002;3254.5118232264876;3257.625373082126;623.1151764494429;631.3686313686313;632.1308201223318;644.4908522267357;649.8635286589869;750.6546988385404;754.8224769359816;768.3430666779823;773.9651715672808;779.5050143159135;9237.584308706124;9442;9578.377405468622;9599.952000240093;9624.807503850025;573.1288441568792;669.4276393683427;708.2563308526027;731.234069721627;763.94270429718;4085.3159962507207;4377;4392.802323895432;4424.513303536608;4443.2224360736745;56850.14724779132;57919;58404.707976459846;58408.4159158403;58543.70728146417;51002;51148.74425627848;51355.7432212844;51749;53453.465465345624;45417.54582454133;45427;47177.76411117991;47600.2859957094;47674.76162619165;8636.222739953435;9308.162265396148;9312.674056407994;9390.718278451657;9468.668596599086;30703.539446908762;30740.69259307378;30785.692143078282;30898.073057808302;31185;40753;40978.59021409748;41305.793471032455;42507.7874610625;42870.78564607157;12047.81928271059;12223;12872.613821585368;12937.741245174855;12987.28569928663;12955.352232388155;13478.663033424244;13543;13941.72116557643;14040.78938815939;9895.802083958424;12613.432395542406;12668.619941401772;13893.722125557635;14133.646658833612;12444.128910976146;12831.358432078172;12870.485180593047;13127.934360328138;13503.45986160582;13095.148815327355;13339.466421343426;13409.597712068653;13517.121387109806;13733.793993090312;10890.836637450602;10951;11172.162087843282;11313.490892909675;11397.145214109141;10358.585656573954;10773.838392424277;10913;10981.560737570408;10988.560457581607 19:17:45 INFO - PROCESS | 21947 | __end_tp_report 19:17:45 INFO - PROCESS | 21947 | __start_cc_report 19:17:45 INFO - PROCESS | 21947 | _x_x_mozilla_cycle_collect,1040 19:17:45 INFO - PROCESS | 21947 | __end_cc_report 19:17:45 INFO - PROCESS | 21947 | __startTimestamp1460513865577__endTimestamp 19:17:45 INFO - PROCESS | 21947 | 19:17:45 INFO - PROCESS | 21947 | ------- Summary: start ------- 19:17:45 INFO - PROCESS | 21947 | Number of tests: 6 19:17:45 INFO - PROCESS | 21947 | 19:17:45 INFO - PROCESS | 21947 | [#0] dojo.html Cycles:165 Average:5295.82 Median:5515.67 stddev:598.60 (10.9%) stddev-sans-first:574.68 19:17:45 INFO - PROCESS | 21947 | Values: 3081.3 3154.8 3190.7 3195.0 3207.7 5132.8 5316.9 5341.1 5359.7 5447.4 5361.4 5395.6 5435.6 5451.3 5457.7 4726.8 4774.1 4890.2 4938.6 4943.8 4854.8 4897.2 4922.1 4931.2 4932.8 4672.7 4801.8 4806.5 4850.5 4885.1 4842.0 4851.7 4862.3 4868.7 4885.8 4729.9 4795.6 4836.3 4851.5 4879.8 5148.5 5215.7 5229.8 5257.8 5266.9 5628.4 5653.9 5669.8 5674.1 5676.6 5556.9 5663.8 5700.3 5707.3 5713.0 5347.8 5355.5 5366.9 5370.9 5418.2 5827.8 5832.7 5832.7 5832.7 5837.8 5407.3 5568.6 5607.6 5613.6 5646.4 5674.8 5675.8 5677.7 5677.7 5712.5 5635.5 5640.8 5646.9 5650.5 5652.8 5464.7 5618.7 5656.2 5737.7 5740.1 4301.9 4302.7 4307.8 4313.0 4342.5 3842.4 3865.1 3880.5 3895.3 3898.8 5225.5 5417.7 5476.1 5515.7 5521.3 5711.7 5719.1 5734.7 5735.5 5736.7 5285.4 5403.3 5418.9 5432.8 5434.3 4792.3 4815.2 4832.5 4863.9 4868.5 5927.4 5930.4 5933.3 5935.9 5939.8 5522.6 5713.5 5737.1 5747.4 5750.0 5906.7 5931.9 5933.3 5963.6 5995.2 5621.2 5624.4 5627.4 5633.1 5633.2 5579.6 5675.8 5721.5 5730.0 5730.9 5380.7 5448.9 5630.3 5716.3 5738.9 5616.1 5629.4 5633.7 5633.8 5634.6 5543.6 5547.3 5553.3 5555.1 5559.3 5406.7 5606.9 5634.0 5644.0 5693.3 5470.5 5472.2 5473.6 5477.6 5522.4 19:17:45 INFO - PROCESS | 21947 | 19:17:45 INFO - PROCESS | 21947 | [#1] ext.html Cycles:180 Average:48623.87 Median:37823.62 stddev:85264.60 (225.4%) stddev-sans-first:85427.58 19:17:45 INFO - PROCESS | 21947 | Values: 609.4 653.4 662.0 671.8 725.2 36813.4 37676.0 37692.6 37809.2 37838.0 42867.4 43806.0 43806.3 43841.8 43886.3 8635.9 8811.6 8863.5 8865.4 8868.6 8622.4 8740.6 8746.7 8749.6 8754.5 8723.9 8792.1 8828.4 8830.4 8831.7 8716.9 8770.3 8776.2 8780.2 8793.7 8619.7 8697.2 8708.7 8715.4 8724.5 37897.2 38326.8 38380.2 38427.2 38439.8 3213.1 3311.5 3372.8 3525.9 3555.6 30282.1 30510.4 31015.1 31294.5 31474.7 4127.3 4145.8 4191.9 4244.2 4249.7 261815.0 266630.0 267487.0 268013.0 268813.0 51006.5 55925.0 56173.7 56304.0 58403.0 56765.4 57014.4 57057.1 57339.7 57472.1 15311.9 15315.6 15342.5 15342.7 15349.5 11497.7 12175.3 12227.4 12645.9 12925.0 18366.7 18436.0 18472.0 18494.3 18553.7 6688.4 7131.6 7195.2 7261.7 7286.5 903.3 975.3 1039.7 1214.5 1226.5 31481.0 32040.0 32045.4 32146.8 32310.5 1122.4 1128.5 1137.1 1139.9 1239.2 16401.5 16570.4 16713.9 16900.0 17039.0 410535.0 416182.0 416545.0 416589.0 417265.0 55064.7 57216.0 57352.1 57428.7 57448.4 1283.8 1317.9 1345.9 1367.3 1399.9 29948.7 32430.7 32479.2 32819.7 32879.8 45658.5 46111.0 46240.8 46294.5 46351.1 266396.0 267727.0 269008.0 269211.0 269259.0 24520.4 25295.9 28140.9 28252.2 28319.2 41827.8 42077.8 42153.2 42309.4 42577.0 35967.3 35980.0 36047.3 36495.0 37071.4 36125.8 36620.6 36974.0 37071.3 40148.0 39309.0 40040.0 40251.8 40395.4 40407.0 32917.5 34513.7 34923.1 34965.3 35472.8 26648.6 26675.7 26893.2 27112.5 27314.3 19:17:45 INFO - PROCESS | 21947 | 19:17:45 INFO - PROCESS | 21947 | [#2] jquery.html Cycles:180 Average:29178.88 Median:19519.29 stddev:86209.54 (441.7%) stddev-sans-first:86424.26 19:17:45 INFO - PROCESS | 21947 | Values: 382.9 390.2 391.9 394.2 395.6 13991.6 15064.9 17717.9 18187.0 18244.0 17710.9 18312.4 18641.3 18789.4 19184.7 5672.4 5813.0 5823.5 5823.7 5846.1 4010.3 5714.3 5729.1 6023.4 6364.2 6273.9 6283.6 6319.5 6329.3 6342.5 6194.3 6332.5 6342.6 6342.7 6365.0 5368.4 5397.2 5559.0 5572.2 5580.7 21929.7 22205.7 22273.9 22448.0 22630.5 2571.6 2597.9 2623.2 2695.8 2790.0 13873.1 13875.6 14186.8 14238.4 14531.3 1850.0 1916.8 1931.5 1939.1 1958.0 72601.6 76586.6 80233.0 85928.6 87927.6 8627.1 9151.9 9267.7 9632.5 10632.2 12917.7 12948.5 12957.6 12985.4 12995.5 7501.4 7584.7 7636.3 7683.1 7731.2 7678.1 7715.2 7734.5 7851.6 7855.3 4047.8 4055.4 4068.6 4090.0 4140.6 1880.3 1888.6 1922.8 1930.5 1936.5 931.2 964.1 979.3 980.3 1004.4 17961.3 19316.2 19389.7 19469.0 19713.3 932.7 944.9 988.1 988.3 988.4 10100.6 10345.8 10372.7 10386.7 10449.9 512455.0 518411.0 519761.0 534696.0 540162.0 69235.0 80758.2 81501.6 87369.6 90228.5 1010.2 1035.8 1039.7 1043.7 1067.7 16174.5 16607.0 17134.9 17281.2 17498.9 36138.6 37546.0 37923.0 38648.4 39020.6 49137.5 49951.8 52416.5 53740.2 54060.5 7423.0 7710.5 8194.7 8681.7 8820.2 12208.1 12463.1 12630.7 12940.7 13065.0 10949.0 11049.8 11064.6 11266.5 11583.8 11413.0 11471.1 11538.8 11611.8 11697.1 11522.8 11749.8 11761.2 11832.4 11930.1 7746.8 7803.6 7829.0 7861.1 7886.2 8532.7 10528.0 11425.9 11466.4 11662.3 19:17:45 INFO - PROCESS | 21947 | 19:17:45 INFO - PROCESS | 21947 | [#3] mootools.html Cycles:180 Average:5939.15 Median:5161.04 stddev:3185.07 (61.7%) stddev-sans-first:3175.05 19:17:45 INFO - PROCESS | 21947 | Values: 1317.2 1499.8 1511.7 1655.2 1813.4 6871.6 8200.5 8497.9 8512.1 8523.2 8207.5 8342.2 8351.8 8357.3 8362.6 1984.9 2276.1 2309.3 2340.1 2347.5 2354.7 2376.7 2378.2 2378.4 2381.8 2308.1 2345.8 2346.8 2350.1 2351.2 1953.2 2263.0 2326.5 2328.1 2329.3 2226.6 2230.7 2236.0 2236.7 2278.6 8311.0 8338.4 8354.7 8360.7 8392.7 4989.6 5137.9 5139.7 5157.4 5179.2 3312.6 3406.1 3409.2 3410.6 3470.0 1131.2 1141.7 1156.7 1160.8 1171.1 11300.6 11396.8 11399.4 11410.4 11418.3 4264.8 4316.4 4493.1 4494.3 4506.4 9277.4 9297.9 9305.3 9316.1 9321.7 4453.6 5164.6 5168.3 5173.8 5199.8 4701.0 4816.2 4828.4 4830.5 4875.9 3646.1 3679.2 3754.9 3761.8 3778.4 1147.2 1170.3 1171.4 1179.6 1182.6 1349.2 1351.5 1360.6 1365.5 1412.2 7950.8 8084.8 8139.5 8140.8 8141.1 481.1 482.1 489.1 492.4 494.0 6462.5 6470.0 6595.8 6635.6 6648.6 10309.7 10544.6 10721.2 10737.4 10741.1 10224.7 10383.7 10496.3 10568.0 10614.7 8001.2 8055.8 8082.5 8099.8 8131.5 7913.3 7918.0 8029.5 8046.3 8107.8 9661.4 9712.3 9763.3 9820.4 9828.0 9799.1 9803.5 9925.8 9955.9 10156.0 7104.6 7112.0 7152.2 7494.1 7516.5 8250.5 8275.9 8306.7 8328.9 8374.7 7398.0 7560.2 7589.3 7710.5 7726.9 7285.9 7393.0 7492.1 7493.6 7503.3 7914.3 7943.6 7985.8 7990.1 7997.8 7042.5 7244.4 7267.9 7359.2 7414.5 7267.0 7283.6 7320.4 7320.5 7330.7 19:17:45 INFO - PROCESS | 21947 | 19:17:45 INFO - PROCESS | 21947 | [#4] prototype.html Cycles:180 Average:4902.77 Median:5655.73 stddev:1466.94 (25.9%) stddev-sans-first:1430.07 19:17:45 INFO - PROCESS | 21947 | Values: 314.7 317.9 320.8 325.3 325.8 5525.5 5643.4 5653.8 5655.7 5683.9 5561.1 5567.8 5580.9 5581.0 5599.4 3983.6 4121.7 4261.6 4286.0 4300.7 4253.6 4265.7 4275.5 4294.3 4298.8 4247.8 4259.9 4262.4 4262.8 4273.7 3993.1 4119.3 4214.7 4215.7 4255.1 3694.6 3743.0 3745.2 3745.9 3746.2 5375.1 5384.0 5390.0 5391.2 5407.0 4801.6 4822.7 4879.6 4903.5 4905.1 5800.5 5809.7 5814.7 5825.7 5828.5 4087.0 4089.7 4099.2 4101.5 4104.9 5872.7 6036.9 6051.5 6051.6 6123.4 4178.1 4213.3 4226.9 4228.5 4233.3 4275.4 4291.2 4306.7 4306.7 4307.2 4764.4 4880.0 4928.2 4942.3 4948.3 5849.9 5851.3 5870.5 5875.3 5889.4 1468.8 1482.5 1487.0 1488.4 1489.4 908.8 962.8 995.5 1006.3 1013.4 5539.8 5634.0 5664.4 5677.0 5680.9 5934.6 5991.9 5993.3 5999.6 6017.3 5543.7 5655.7 5682.6 5684.8 5694.8 3177.6 3185.1 3198.0 3207.7 3209.4 6033.6 6162.8 6163.9 6174.5 6174.8 5993.8 6049.5 6051.7 6086.2 6086.5 6196.3 6199.5 6212.5 6221.2 6240.1 5806.6 6011.8 6014.8 6020.2 6025.3 5913.6 5939.7 5949.8 5957.4 5970.6 6012.2 6205.3 6207.4 6214.3 6242.5 4228.4 4249.7 4250.0 4257.7 4260.2 6024.1 6036.3 6045.2 6048.2 6051.2 5662.2 5839.0 5918.7 5939.6 6020.4 5905.7 5943.5 5955.3 5956.6 5959.2 4913.8 5396.3 5860.6 5867.2 5879.4 5842.8 5901.2 5924.1 6007.9 6015.1 5783.8 5796.4 5802.4 5817.9 5823.8 19:17:45 INFO - PROCESS | 21947 | 19:17:45 INFO - PROCESS | 21947 | [#5] yui.html Cycles:180 Average:14437.31 Median:4384.90 stddev:16119.30 (367.6%) stddev-sans-first:16131.54 19:17:45 INFO - PROCESS | 21947 | Values: 708.2 735.1 823.6 833.1 840.5 14870.3 15137.2 15139.7 15170.8 15171.3 14782.5 15617.0 15632.9 15639.1 15652.9 648.5 658.1 665.8 822.7 824.8 657.9 781.4 813.5 815.4 816.1 859.4 861.2 861.3 862.1 862.3 685.8 847.4 851.4 851.4 852.0 607.8 623.2 624.0 624.6 624.9 14866.2 14875.0 14995.6 15018.8 15025.6 12829.9 13322.2 13330.1 13342.6 13593.2 11338.9 11773.3 11795.5 11796.3 11909.5 3734.0 3884.5 3911.6 3950.2 3975.6 53612.2 54084.2 54251.0 55807.4 58421.1 10232.5 10465.4 10635.9 10642.3 10728.4 17707.8 17744.5 17757.2 17757.6 17768.5 7894.7 7973.3 8040.7 8068.8 8190.2 4527.4 4604.4 4646.4 4737.9 4819.0 3109.7 3217.8 3248.6 3254.5 3257.6 623.1 631.4 632.1 644.5 649.9 750.7 754.8 768.3 774.0 779.5 9237.6 9442.0 9578.4 9600.0 9624.8 573.1 669.4 708.3 731.2 763.9 4085.3 4377.0 4392.8 4424.5 4443.2 56850.1 57919.0 58404.7 58408.4 58543.7 51002.0 51148.7 51355.7 51749.0 53453.5 45417.5 45427.0 47177.8 47600.3 47674.8 8636.2 9308.2 9312.7 9390.7 9468.7 30703.5 30740.7 30785.7 30898.1 31185.0 40753.0 40978.6 41305.8 42507.8 42870.8 12047.8 12223.0 12872.6 12937.7 12987.3 12955.4 13478.7 13543.0 13941.7 14040.8 9895.8 12613.4 12668.6 13893.7 14133.6 12444.1 12831.4 12870.5 13127.9 13503.5 13095.1 13339.5 13409.6 13517.1 13733.8 10890.8 10951.0 11172.2 11313.5 11397.1 10358.6 10773.8 10913.0 10981.6 10988.6 19:17:45 INFO - PROCESS | 21947 | -------- Summary: end -------- 19:17:45 INFO - PROCESS | 21947 | 19:17:46 INFO - TEST-INFO | 21947: exit 0 19:17:46 INFO - TEST-OK | dromaeo_css | took 1111177ms 19:17:46 INFO - TEST-START | kraken 19:17:46 INFO - operating with platform_type : linux_ 19:17:46 INFO - Initialising browser for kraken test... 19:17:46 INFO - TEST-INFO | started process 22141 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1xMYjX/profile http://localhost:32919/getInfo.html) 19:17:49 INFO - PROCESS | 22141 | __metrics Screen width/height:1600/1200 19:17:49 INFO - PROCESS | 22141 | colorDepth:24 19:17:49 INFO - PROCESS | 22141 | Browser inner width/height: 1024/697 19:17:49 INFO - PROCESS | 22141 | __metrics 19:17:50 ERROR - PROCESS | 22141 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:17:51 INFO - TEST-INFO | 22141: exit 0 19:17:51 INFO - Browser initialized. 19:17:51 INFO - Running cycle 1/1 for kraken test... 19:17:51 INFO - TEST-INFO | started process 22225 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1xMYjX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:18:03 INFO - PROCESS | 22225 | RSS: Main: 152350720 19:18:03 INFO - PROCESS | 22225 | 19:18:05 INFO - PROCESS | 22225 | Cycle 1(1): loaded http://localhost:32919/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32919/tests/kraken/driver.html?testName=audio-beat-detection) 19:18:06 INFO - PROCESS | 22225 | RSS: Main: 207998976 19:18:06 INFO - PROCESS | 22225 | 19:18:09 INFO - PROCESS | 22225 | Cycle 1(1): loaded http://localhost:32919/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32919/tests/kraken/driver.html?testName=audio-dft) 19:18:09 INFO - PROCESS | 22225 | RSS: Main: 194027520 19:18:09 INFO - PROCESS | 22225 | 19:18:13 INFO - PROCESS | 22225 | Cycle 1(1): loaded http://localhost:32919/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32919/tests/kraken/driver.html?testName=audio-fft) 19:18:13 INFO - PROCESS | 22225 | RSS: Main: 263380992 19:18:13 INFO - PROCESS | 22225 | 19:18:15 INFO - PROCESS | 22225 | Cycle 1(1): loaded http://localhost:32919/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32919/tests/kraken/driver.html?testName=audio-oscillator) 19:18:16 INFO - PROCESS | 22225 | RSS: Main: 172646400 19:18:16 INFO - PROCESS | 22225 | 19:18:18 INFO - PROCESS | 22225 | Cycle 1(1): loaded http://localhost:32919/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32919/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:18:19 INFO - PROCESS | 22225 | RSS: Main: 177774592 19:18:19 INFO - PROCESS | 22225 | 19:18:22 INFO - PROCESS | 22225 | Cycle 1(1): loaded http://localhost:32919/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32919/tests/kraken/driver.html?testName=imaging-darkroom) 19:18:22 INFO - PROCESS | 22225 | RSS: Main: 213827584 19:18:22 INFO - PROCESS | 22225 | 19:18:25 INFO - PROCESS | 22225 | Cycle 1(1): loaded http://localhost:32919/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32919/tests/kraken/driver.html?testName=imaging-desaturate) 19:18:26 INFO - PROCESS | 22225 | RSS: Main: 215011328 19:18:26 INFO - PROCESS | 22225 | 19:18:29 INFO - PROCESS | 22225 | Cycle 1(1): loaded http://localhost:32919/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32919/tests/kraken/driver.html?testName=json-parse-financial) 19:18:29 INFO - PROCESS | 22225 | RSS: Main: 214953984 19:18:29 INFO - PROCESS | 22225 | 19:18:31 INFO - PROCESS | 22225 | Cycle 1(1): loaded http://localhost:32919/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32919/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:18:32 INFO - PROCESS | 22225 | RSS: Main: 200802304 19:18:32 INFO - PROCESS | 22225 | 19:18:33 INFO - PROCESS | 22225 | Cycle 1(1): loaded http://localhost:32919/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32919/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:18:34 INFO - PROCESS | 22225 | RSS: Main: 203186176 19:18:34 INFO - PROCESS | 22225 | 19:18:36 INFO - PROCESS | 22225 | Cycle 1(1): loaded http://localhost:32919/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32919/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:18:37 INFO - PROCESS | 22225 | RSS: Main: 217088000 19:18:37 INFO - PROCESS | 22225 | 19:18:39 INFO - PROCESS | 22225 | Cycle 1(1): loaded http://localhost:32919/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:18:40 INFO - PROCESS | 22225 | RSS: Main: 218935296 19:18:40 INFO - PROCESS | 22225 | 19:18:43 INFO - PROCESS | 22225 | Cycle 1(1): loaded http://localhost:32919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:18:43 INFO - PROCESS | 22225 | RSS: Main: 217550848 19:18:43 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | Cycle 1(1): loaded http://localhost:32919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32919/tests/kraken/driver.html?testName=ai-astar) 19:18:45 INFO - PROCESS | 22225 | RSS: Main: 281227264 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | __start_tp_report 19:18:45 INFO - PROCESS | 22225 | _x_x_mozilla_page_load 19:18:45 INFO - PROCESS | 22225 | _x_x_mozilla_page_load_details 19:18:45 INFO - PROCESS | 22225 | |i|pagename|runs| 19:18:45 INFO - PROCESS | 22225 | |0;ai-astar;113;110;105;110;110;110;100;112;112;109 19:18:45 INFO - PROCESS | 22225 | |1;audio-beat-detection;157;132;154;182;130;171;163;130;180;132 19:18:45 INFO - PROCESS | 22225 | |2;audio-dft;161;161;160;160;161;160;162;162;162;161 19:18:45 INFO - PROCESS | 22225 | |3;audio-fft;77;75;107;113;73;72;75;123;105;72 19:18:45 INFO - PROCESS | 22225 | |4;audio-oscillator;93;92;145;92;93;93;152;92;92;145 19:18:45 INFO - PROCESS | 22225 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 19:18:45 INFO - PROCESS | 22225 | |6;imaging-darkroom;146;146;145;145;145;145;145;145;146;146 19:18:45 INFO - PROCESS | 22225 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 19:18:45 INFO - PROCESS | 22225 | |8;json-parse-financial;56;58;57;56;57;58;57;75;56;53 19:18:45 INFO - PROCESS | 22225 | |9;json-stringify-tinderbox;60;61;60;60;60;60;61;61;61;62 19:18:45 INFO - PROCESS | 22225 | |10;stanford-crypto-aes;81;92;79;80;81;82;81;81;82;82 19:18:45 INFO - PROCESS | 22225 | |11;stanford-crypto-ccm;133;131;127;134;128;126;132;127;207;132 19:18:45 INFO - PROCESS | 22225 | |12;stanford-crypto-pbkdf2;168;162;163;165;165;173;164;166;167;170 19:18:45 INFO - PROCESS | 22225 | |13;stanford-crypto-sha256-iterative;69;68;67;69;69;67;69;67;67;76 19:18:45 INFO - PROCESS | 22225 | __end_tp_report 19:18:45 INFO - PROCESS | 22225 | __start_cc_report 19:18:45 INFO - PROCESS | 22225 | _x_x_mozilla_cycle_collect,1587 19:18:45 INFO - PROCESS | 22225 | __end_cc_report 19:18:45 INFO - PROCESS | 22225 | __startTimestamp1460513925681__endTimestamp 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | ------- Summary: start ------- 19:18:45 INFO - PROCESS | 22225 | Number of tests: 14 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:3.87 (3.5%) stddev-sans-first:3.84 19:18:45 INFO - PROCESS | 22225 | Values: 113.0 110.0 105.0 110.0 110.0 110.0 100.0 112.0 112.0 109.0 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:160.00 stddev:20.95 (13.1%) stddev-sans-first:22.18 19:18:45 INFO - PROCESS | 22225 | Values: 157.0 132.0 154.0 182.0 130.0 171.0 163.0 130.0 180.0 132.0 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 19:18:45 INFO - PROCESS | 22225 | Values: 161.0 161.0 160.0 160.0 161.0 160.0 162.0 162.0 162.0 161.0 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | [#3] audio-fft Cycles:10 Average:89.20 Median:72.50 stddev:20.23 (27.9%) stddev-sans-first:20.96 19:18:45 INFO - PROCESS | 22225 | Values: 77.0 75.0 107.0 113.0 73.0 72.0 75.0 123.0 105.0 72.0 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:92.00 stddev:26.59 (28.9%) stddev-sans-first:27.58 19:18:45 INFO - PROCESS | 22225 | Values: 93.0 92.0 145.0 92.0 93.0 93.0 152.0 92.0 92.0 145.0 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:18:45 INFO - PROCESS | 22225 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:18:45 INFO - PROCESS | 22225 | Values: 146.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 19:18:45 INFO - PROCESS | 22225 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:57.00 stddev:6.04 (10.6%) stddev-sans-first:6.35 19:18:45 INFO - PROCESS | 22225 | Values: 56.0 58.0 57.0 56.0 57.0 58.0 57.0 75.0 56.0 53.0 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 19:18:45 INFO - PROCESS | 22225 | Values: 60.0 61.0 60.0 60.0 60.0 60.0 61.0 61.0 61.0 62.0 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:81.50 stddev:3.60 (4.4%) stddev-sans-first:3.80 19:18:45 INFO - PROCESS | 22225 | Values: 81.0 92.0 79.0 80.0 81.0 82.0 81.0 81.0 82.0 82.0 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:132.00 stddev:24.51 (18.6%) stddev-sans-first:25.94 19:18:45 INFO - PROCESS | 22225 | Values: 133.0 131.0 127.0 134.0 128.0 126.0 132.0 127.0 207.0 132.0 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.50 stddev:3.33 (2.0%) stddev-sans-first:3.48 19:18:45 INFO - PROCESS | 22225 | Values: 168.0 162.0 163.0 165.0 165.0 173.0 164.0 166.0 167.0 170.0 19:18:45 INFO - PROCESS | 22225 | 19:18:45 INFO - PROCESS | 22225 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:2.70 (3.9%) stddev-sans-first:2.86 19:18:45 INFO - PROCESS | 22225 | Values: 69.0 68.0 67.0 69.0 69.0 67.0 69.0 67.0 67.0 76.0 19:18:45 INFO - PROCESS | 22225 | -------- Summary: end -------- 19:18:45 INFO - PROCESS | 22225 | 19:18:46 INFO - TEST-INFO | 22225: exit 0 19:18:46 INFO - TEST-OK | kraken | took 60394ms 19:18:46 INFO - SUITE-END | took 1171s 19:18:46 INFO - Completed test suite (00:19:31) 19:18:46 INFO - javascript benchmark 19:18:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.32210913599, 3154.779165458419, 3190.7287880530153, 3195.025517217248, 3207.6952689494497, 5132.794688212476, 5316.9202461963105, 5341.065313570124, 5359.65162264453, 5447.373552041517, 5361.383440904287, 5395.568354531638, 5435.646682965605, 5451.2640793492865, 5457.699826509541, 4726.810927562893, 4774.092922344761, 4890.21756518957, 4938.629602779806, 4943.802247910097, 4854.757262136896, 4897.240927656201, 4922.138625740499, 4931.161702510582, 4932.80268789248, 4672.672912896099, 4801.7839197236035, 4806.4712881583, 4850.466448690641, 4885.145099607572, 4841.951580484185, 4851.684640498356, 4862.270659401082, 4868.707877527324, 4885.804567817283, 4729.858104256843, 4795.592374648159, 4836.298736683161, 4851.466338702739, 4879.780409881564, 5148.536631703165, 5215.6609820361555, 5229.816956406507, 5257.789688412459, 5266.92099618506, 5628.352739434977, 5653.886922261573, 5669.801556945528, 5674.120511320752, 5676.574256930747, 5556.91664625031, 5663.801766938137, 5700.287464066992, 5707.315122185323, 5713.0, 5347.759350829222, 5355.518003379676, 5366.8926621467745, 5370.91943620846, 5418.241446197496, 5827.796027139115, 5832.708364581754, 5832.708364581838, 5832.737526811304, 5837.766489340379, 5407.270018547446, 5568.638038527482, 5607.551395888319, 5613.635113717677, 5646.378898321182, 5674.829755107354, 5675.829725108253, 5677.659340439587, 5677.744501497443, 5712.542996560265, 5635.549156067505, 5640.830775076673, 5646.915296270559, 5650.491455769001, 5652.802151924663, 5464.672119672753, 5618.6628802272, 5656.236408084938, 5737.684427356536, 5740.13897915316, 4301.913961720748, 4302.65578753699, 4307.784610769449, 4313.008008158141, 4342.5006124296115, 3842.423636454554, 3865.091703449687, 3880.4567360569545, 3895.2599006188734, 3898.8440462381186, 5225.4774522548205, 5417.674939503642, 5476.069068258405, 5515.669059856422, 5521.309836270466, 5711.742971566289, 5719.113537401709, 5734.741936612862, 5735.4551317624755, 5736.6844823534275, 5285.445028272053, 5403.297571315704, 5418.864528386743, 5432.782688692487, 5434.3498686201065, 4792.2811578262845, 4815.15734746418, 4832.492588278251, 4863.878403039952, 4868.488808675109, 5927.3776253493625, 5930.406959304035, 5933.2880054393745, 5935.910961335583, 5939.792107276225, 5522.558195344443, 5713.457221563945, 5737.053386191315, 5747.396523365153, 5749.998757992333, 5906.675132867734, 5931.9406805931385, 5933.258342707161, 5963.582549221686, 5995.16067750524, 5621.156826476062, 5624.437556244343, 5627.380988091389, 5633.0987042073075, 5633.2113504110275, 5579.637323573955, 5675.801346952837, 5721.456461636138, 5730.0, 5730.942690573041, 5380.704061276668, 5448.918266226089, 5630.324361076697, 5716.314042314949, 5738.885222295614, 5616.129499927518, 5629.380768115586, 5633.690147041952, 5633.774649013993, 5634.6337488063145, 5543.6396634218645, 5547.33431988164, 5553.278073850373, 5555.111182210827, 5559.305086864142, 5406.702631355313, 5606.859828504157, 5634.0, 5643.971780141073, 5693.259876216231, 5470.507654311131, 5472.179173124063, 5473.589480789036, 5477.589180811535, 5522.3649280333275], "value": 5256.177342154023, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.4362714489097, 653.4217217762281, 662.0, 671.7548094945344, 725.2131437390431, 36813.44779828305, 37676.0, 37692.62307376925, 37809.24381512368, 37838.0, 42867.35698964518, 43806.0, 43806.34290485637, 43841.78079109608, 43886.34170487445, 8635.870461943061, 8811.647534098629, 8863.468191908507, 8865.423747456427, 8868.556572171397, 8622.35332350073, 8740.562971851414, 8746.650133994632, 8749.606267717936, 8754.474731516098, 8723.912760872374, 8792.07683193265, 8828.42615230008, 8830.42602230853, 8831.735047948572, 8716.912830871705, 8770.254528365096, 8776.166264204921, 8780.209781119698, 8793.736187914374, 8619.65521379144, 8697.173768491983, 8708.651653933835, 8715.433496822687, 8724.476531408136, 37897.24205515902, 38326.80836595799, 38380.232395352214, 38427.23145537102, 38439.8078009611, 3213.1003319070696, 3311.503274508819, 3372.7976321420547, 3525.94711079334, 3555.6088830228655, 30282.091537253917, 30510.38979220403, 31015.069547913597, 31294.530582041287, 31474.685253147403, 4127.345025988284, 4145.7927103645, 4191.895202619929, 4244.236037513247, 4249.745015299061, 261815.0, 266630.0, 267487.0, 268013.0, 268813.0, 51006.48993510017, 55925.0, 56173.71913140408, 56304.0, 58403.0, 56765.43234567684, 57014.42985570091, 57057.14414283789, 57339.71330143406, 57472.137917931264, 15311.92344038295, 15315.61710957235, 15342.463013794464, 15342.693146137015, 15349.462768803038, 11497.71255718597, 12175.269483830998, 12227.449764760608, 12645.873541264653, 12925.030622703334, 18366.724499132524, 18436.0, 18472.0, 18494.260229590665, 18553.721694174597, 6688.3646053624825, 7131.607761573163, 7195.172555156119, 7261.673224704901, 7286.48994570375, 903.3179949138358, 975.2539307429822, 1039.656913218636, 1214.5263347294563, 1226.5461779141774, 31481.0, 32040.0, 32045.359092818013, 32146.83926580399, 32310.515342269886, 1122.354646078508, 1128.503458478267, 1137.113051819582, 1139.880312567185, 1239.2440611227144, 16401.507954761375, 16570.420035298946, 16713.91643041777, 16900.0, 17039.0, 410535.0, 416182.0, 416545.0, 416589.0, 417265.0, 55064.72467637636, 57216.0, 57352.13971790426, 57428.71285643545, 57448.42551574514, 1283.826683397748, 1317.8682131786936, 1345.8855997240148, 1367.2753440676458, 1399.8810101141314, 29948.73425267202, 32430.70277188886, 32479.18802029968, 32819.67180328262, 32879.83560082184, 45658.54341456543, 46111.0, 46240.76879615715, 46294.53705462902, 46351.07297854091, 266396.0, 267727.0, 269008.0, 269211.0, 269259.0, 24520.38699032467, 25295.873520632278, 28140.85929570339, 28252.15243542697, 28319.150425487267, 41827.7908610455, 42077.78961105175, 42153.156936861706, 42309.36535951902, 42577.0, 35967.28065438729, 35980.0, 36047.27905441824, 36495.0, 37071.443928341636, 36125.81937090298, 36620.63379366172, 36974.0, 37071.25857482889, 40148.0, 39309.0, 40040.0, 40251.79874100611, 40395.3940690884, 40407.0, 32917.50623740694, 34513.65486345105, 34923.126921827155, 34965.300693986486, 35472.82263588665, 26648.60027099634, 26675.733242667324, 26893.23494710703, 27112.457750845268, 27314.317142070813], "value": 18933.178118419688, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.8966179131634, 390.1575224510844, 391.8981064923121, 394.2332163941134, 395.5569761866708, 13991.580252592414, 15064.924675376607, 17717.911410442946, 18186.99999999998, 18244.0, 17710.911445442787, 18312.359067432644, 18641.254349826024, 18789.43631691048, 19184.712229316538, 5672.432756724335, 5813.0, 5823.505002074829, 5823.737931793079, 5846.09385545239, 4010.258102251078, 5714.25714657094, 5729.0833466645345, 6023.427774361428, 6364.172657554512, 6273.874522509547, 6283.59156654816, 6319.526035547352, 6329.303776584572, 6342.524310676695, 6194.256689197303, 6332.461740752042, 6342.556021078526, 6342.6511541865175, 6364.968175159141, 5368.436314187033, 5397.217403476474, 5559.0, 5572.219889215513, 5580.748866301026, 21929.671054934188, 22205.666914996287, 22273.888630556907, 22448.0, 22630.547389052128, 2571.6014017827265, 2597.9348467128575, 2623.1868120882586, 2695.7573818356245, 2789.995601583428, 13873.09824861391, 13875.583732488041, 14186.787198192036, 14238.430462781476, 14531.346089426, 1849.9907500462411, 1916.7795703494137, 1931.4785008047747, 1939.0789375046882, 1957.9804201958084, 72601.6369918147, 76586.6170669143, 80233.0, 85928.57035714843, 87927.56036219842, 8627.137286271449, 9151.908480915106, 9267.67563135287, 9632.47021413815, 10632.202584806171, 12917.741645167043, 12948.482060717653, 12957.611271661865, 12985.415656295489, 12995.545155919497, 7501.362384197295, 7584.749528483527, 7636.31273185416, 7683.116441609175, 7731.188225236382, 7678.1170165431695, 7715.151333353327, 7734.497257678233, 7851.646675899598, 7855.33229675484, 4047.817848196838, 4055.391691246278, 4068.5931406859077, 4090.0, 4140.60664236897, 1880.2666959885655, 1888.5656299051295, 1922.826945574905, 1930.4980705016796, 1936.4895381602373, 931.2317338196016, 964.0985678390728, 979.2851218610455, 980.2501086668705, 1004.3622299839654, 17961.281548737905, 19316.227350906087, 19389.709154362696, 19469.0, 19713.310034148737, 932.6922115701802, 944.8677185194078, 988.1156365053381, 988.2686811759246, 988.3921388346259, 10100.646477373404, 10345.844812327821, 10372.688819335432, 10386.688399348031, 10449.9477502612, 512455.0, 518411.0, 519761.0, 534696.0, 540162.0, 69235.0, 80758.19241807506, 81501.59249203716, 87369.56315218384, 90228.5488572553, 1010.1867996262932, 1035.8239099353127, 1039.740064983754, 1043.7495001199657, 1067.7490789664423, 16174.514764557081, 16607.0, 17134.914325428792, 17281.222344994254, 17498.91250543739, 36138.63861361458, 37546.0, 37923.0, 38648.42027369535, 39020.6097939017, 49137.50862491472, 49951.75024124856, 52416.47583524116, 53740.193897090794, 54060.459395405545, 7423.0, 7710.498817576839, 8194.67221311141, 8681.652733890574, 8820.2061814437, 12208.084393670688, 12463.127581069239, 12630.684232894251, 12940.741185176432, 13065.0, 10949.014588687056, 11049.779004420026, 11064.557417703201, 11266.493007814832, 11583.76832463363, 11413.0, 11471.13966452536, 11538.82691759641, 11611.825822612498, 11697.12271579652, 11522.76954460923, 11749.823752643888, 11761.235519691192, 11832.408379581158, 11930.10524210705, 7746.8450630985935, 7803.609819508888, 7828.960855195687, 7861.056673199253, 7886.211378862068, 8532.658693652433, 10528.0, 11425.885741142814, 11466.369349685514, 11662.300261984308], "value": 9004.646326871953, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.2096741954822, 1499.7979314164259, 1511.7430036893727, 1655.1558705060415, 1813.4468986958973, 6871.587704737713, 8200.507969521825, 8497.872531912011, 8512.148785121493, 8523.232909038185, 8207.466514676556, 8342.165783421655, 8351.832963340745, 8357.28963038141, 8362.623681934312, 1984.851136164786, 2276.1350686739015, 2309.3302942146756, 2340.1107579119994, 2347.495288512969, 2354.705661792276, 2376.66726658268, 2378.203301893868, 2378.369732021016, 2381.785639292463, 2308.0767692922796, 2345.7771511706446, 2346.8474549154253, 2350.059976009593, 2351.1888398502488, 1953.2382370875298, 2262.9660555091605, 2326.5230627721276, 2328.092044102801, 2329.2895666821614, 2226.6326056200705, 2230.743464501587, 2236.016152892722, 2236.664500324948, 2278.6012447821563, 8311.0, 8338.374621903382, 8354.665813367457, 8360.665573377057, 8392.748217553482, 4989.57588604969, 5137.871553211162, 5139.717315547643, 5157.432682404932, 5179.171332586806, 3312.585926759155, 3406.148462884279, 3409.215880347509, 3410.6248312685584, 3470.02839205023, 1131.2081542919907, 1141.680329507739, 1156.7108222944264, 1160.7562411893512, 1171.0690001448868, 11300.604478843201, 11396.772064558745, 11399.430028498542, 11410.42947852604, 11418.257813242195, 4264.808083636244, 4316.374125751749, 4493.056458143827, 4494.280915053576, 4506.3916371290115, 9277.350585458953, 9297.907020929704, 9305.25557955362, 9316.114969077928, 9321.72034838956, 4453.621442177451, 5164.638475306768, 5168.2764412982215, 5173.793048278027, 5199.844004679866, 4700.976495117503, 4816.229403295526, 4828.396450443694, 4830.541098595698, 4875.878103047381, 3646.08847788053, 3679.1905780728734, 3754.9061273468383, 3761.755485893408, 3778.4332350147697, 1147.1511081799408, 1170.3387586013876, 1171.3967306836985, 1179.6225207933378, 1182.603827717707, 1349.190485708567, 1351.4526616720243, 1360.5782207515701, 1365.4606430459912, 1412.180935057664, 7950.801229969182, 8084.8383032339025, 8139.511629302261, 8140.83718325642, 8141.104478507359, 481.09313943217285, 482.1369748150841, 489.06588416125743, 492.38943709800304, 494.0218367632037, 6462.48300135988, 6470.0, 6595.8021259362295, 6635.601863888182, 6648.634325112069, 10309.74225644365, 10544.578216871392, 10721.195910306758, 10737.409442480583, 10741.140708743282, 10224.693259202237, 10383.740406489898, 10496.265261431627, 10568.0, 10614.681559553226, 8001.239882211181, 8055.838883222303, 8082.515049097073, 8099.83800324002, 8131.471454355448, 7913.287804097658, 7918.049834019724, 8029.51822890605, 8046.275835174628, 8107.756767296991, 9661.420314781135, 9712.3201375903, 9763.267754918268, 9820.361676491006, 9828.0, 9799.118079372605, 9803.509824508603, 9925.801483970135, 9955.900440995787, 10156.0, 7104.644767761488, 7112.0, 7152.249013853679, 7494.063242094739, 7516.511426757462, 8250.504969701837, 8275.875861861956, 8306.667733290842, 8328.916710833057, 8374.665013399395, 7398.0, 7560.168381478143, 7589.316961473494, 7710.537367757953, 7726.884096738666, 7285.890711639436, 7392.96303518479, 7492.100947886289, 7493.550386976799, 7503.287187717158, 7914.287714105758, 7943.563104029103, 7985.760427187193, 7990.081140668897, 7997.800054998672, 7042.542234754725, 7244.384227340735, 7267.890981635174, 7359.227281135618, 7414.480986330905, 7267.0, 7283.562986220843, 7320.377767889789, 7320.487565870338, 7330.706771729285], "value": 4728.59141573917, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.68688654788474, 317.923698312405, 320.8475973912391, 325.29735770735215, 325.79149344419574, 5525.535733030745, 5643.351014633318, 5653.773849046039, 5655.745491452879, 5683.8579035524135, 5561.138023606348, 5567.805126820562, 5580.888382232353, 5581.0, 5599.41206173352, 3983.601639836022, 4121.690873184508, 4261.5738426157295, 4285.992791693957, 4300.720453170534, 4253.595908388714, 4265.658747300208, 4275.486941567016, 4294.334378171388, 4298.78506074695, 4247.766372849492, 4259.850905218318, 4262.360645903108, 4262.786860656955, 4273.658107351404, 3993.121513267077, 4119.2997190477545, 4214.7471151731, 4215.662746980234, 4255.063885945087, 3694.612065733113, 3742.981285093584, 3745.232227393378, 3745.9063523412133, 3746.2132952080096, 5375.086235340002, 5383.973080134574, 5390.0, 5391.24522566837, 5407.0, 4801.591864691505, 4822.68652537584, 4879.6096312295285, 4903.509649035103, 4905.117078925792, 5800.477956983892, 5809.651420914759, 5814.738336774855, 5825.679587622679, 5828.504577110951, 4087.017796368759, 4089.7137200395982, 4099.1596722672075, 4101.46680931477, 4104.91790164198, 5872.677002764846, 6036.909446358308, 6051.4553690168095, 6051.606645568068, 6123.387661233885, 4178.12259425524, 4213.325867861189, 4226.852060177879, 4228.513720922072, 4233.306677329031, 4275.3800698898485, 4291.2275790358035, 4306.655467562588, 4306.720063195945, 4307.203167414038, 4764.4282686077195, 4879.951200488021, 4928.162212423897, 4942.332785073969, 4948.307236986825, 5849.88300233993, 5851.297844258631, 5870.530357571384, 5875.29496460419, 5889.411058894077, 1468.7649976003788, 1482.5107714454205, 1486.9851301487063, 1488.3897601983135, 1489.4265707702612, 908.7728067983004, 962.7785609309898, 995.4624502768424, 1006.3408467453829, 1013.3869009249298, 5539.833804985857, 5634.0, 5664.376918538957, 5676.971615141898, 5680.943190568041, 5934.643921364732, 5991.850203744942, 5993.280806303184, 5999.610025348338, 6017.308009578867, 5543.695096769636, 5655.717214139277, 5682.602217844794, 5684.772609095672, 5694.772209111672, 3177.6345720242007, 3185.108169712484, 3197.984010079981, 3207.7273431758094, 3209.406259841937, 6033.577649564576, 6162.784302549389, 6163.876722465526, 6174.536909731788, 6174.8147555573405, 5993.820185394445, 6049.455549000611, 6051.697415129226, 6086.239220097488, 6086.482648974887, 6196.256449226122, 6199.473044791153, 6212.47193988507, 6221.191245138103, 6240.095186198067, 5806.622569532967, 6011.789587364597, 6014.8195554133445, 6020.217371741645, 6025.276966764016, 5913.58604897653, 5939.732712027882, 5949.846581311912, 5957.434043765836, 5970.611910225822, 6012.158297838394, 6205.348438414082, 6207.410296021871, 6214.316425193135, 6242.531810114168, 4228.365745138254, 4249.681273904408, 4249.960019190868, 4257.70196086271, 4260.233158031584, 6024.096385542029, 6036.336003039574, 6045.244344456943, 6048.153258543719, 6051.183090282755, 5662.235598194191, 5838.970805145947, 5918.733656985532, 5939.624150339899, 6020.367861374492, 5905.704714764159, 5943.52451803846, 5955.3498693081165, 5956.583039187215, 5959.22530071088, 4913.754312284443, 5396.298481197419, 5860.589758716849, 5867.20792692981, 5879.412058794257, 5842.766289348378, 5901.173835662925, 5924.140999555127, 6007.879842403215, 6015.097735339734, 5783.826485205451, 5796.362400136066, 5802.448767367094, 5817.854553636023, 5823.82528524145], "value": 4426.841281581341, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.174976152782, 735.0738070031758, 823.5511646152846, 833.1252185205534, 840.47890308009, 14870.33083511242, 15137.167455789928, 15139.697206055873, 15170.772438413433, 15171.31729072193, 14782.482613108516, 15617.0, 15632.921835390836, 15639.139847308394, 15652.921735391306, 648.5460177875483, 658.134553062721, 665.7669815564562, 822.6750433578718, 824.7855557555049, 657.8552718401968, 781.4490783997268, 813.4712436915993, 815.4251252866715, 816.0941355095839, 859.3683642522741, 861.2076889261863, 861.2550144125318, 862.0904945282724, 862.2756884217256, 685.7736946807541, 847.3729440214258, 851.3955091884739, 851.4210336970857, 851.9787005324886, 607.787274453942, 623.2365352443267, 624.0202881476084, 624.6158612453308, 624.8562830548954, 14866.182359970197, 14875.0, 14995.550133496012, 15018.774718379233, 15025.624359391102, 12829.87170128296, 13322.200667959953, 13330.133541319783, 13342.599722008355, 13593.184408935396, 11338.886611133865, 11773.2936023838, 11795.469203885847, 11796.29222246668, 11909.464074116686, 3734.0, 3884.4950156479476, 3911.647951684362, 3950.2297052074855, 3975.6223158799867, 53612.195817062384, 54084.18873716897, 54251.0, 55807.44192558063, 58421.12368314521, 10232.53953572091, 10465.42440165783, 10635.893641063645, 10642.255042146975, 10728.356298622108, 17707.822921770618, 17744.46766597004, 17757.200925958365, 17757.644847103245, 17768.46694599164, 7894.723684671124, 7973.322267607318, 8040.67837286502, 8068.757937261891, 8190.180981901762, 4527.388802511685, 4604.447466304065, 4646.395968524071, 4737.905241895142, 4818.951810481921, 3109.7356724678657, 3217.8069315841126, 3248.561444205002, 3254.5118232264876, 3257.625373082126, 623.1151764494429, 631.3686313686313, 632.1308201223318, 644.4908522267357, 649.8635286589869, 750.6546988385404, 754.8224769359816, 768.3430666779823, 773.9651715672808, 779.5050143159135, 9237.584308706124, 9442.0, 9578.377405468622, 9599.952000240093, 9624.807503850025, 573.1288441568792, 669.4276393683427, 708.2563308526027, 731.234069721627, 763.94270429718, 4085.3159962507207, 4377.0, 4392.802323895432, 4424.513303536608, 4443.2224360736745, 56850.14724779132, 57919.0, 58404.707976459846, 58408.4159158403, 58543.70728146417, 51002.0, 51148.74425627848, 51355.7432212844, 51749.0, 53453.465465345624, 45417.54582454133, 45427.0, 47177.76411117991, 47600.2859957094, 47674.76162619165, 8636.222739953435, 9308.162265396148, 9312.674056407994, 9390.718278451657, 9468.668596599086, 30703.539446908762, 30740.69259307378, 30785.692143078282, 30898.073057808302, 31185.0, 40753.0, 40978.59021409748, 41305.793471032455, 42507.7874610625, 42870.78564607157, 12047.81928271059, 12223.0, 12872.613821585368, 12937.741245174855, 12987.28569928663, 12955.352232388155, 13478.663033424244, 13543.0, 13941.72116557643, 14040.78938815939, 9895.802083958424, 12613.432395542406, 12668.619941401772, 13893.722125557635, 14133.646658833612, 12444.128910976146, 12831.358432078172, 12870.485180593047, 13127.934360328138, 13503.45986160582, 13095.148815327355, 13339.466421343426, 13409.597712068653, 13517.121387109806, 13733.793993090312, 10890.836637450602, 10951.0, 11172.162087843282, 11313.490892909675, 11397.145214109141, 10358.585656573954, 10773.838392424277, 10913.0, 10981.560737570408, 10988.560457581607], "value": 6696.870065192963, "unit": "score"}], "name": "dromaeo_css", "value": 7077.00817730382, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 105.0, 110.0, 110.0, 110.0, 100.0, 112.0, 112.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 132.0, 154.0, 182.0, 130.0, 171.0, 163.0, 130.0, 180.0, 132.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 161.0, 160.0, 162.0, 162.0, 162.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 107.0, 113.0, 73.0, 72.0, 75.0, 123.0, 105.0, 72.0], "value": 89.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 145.0, 92.0, 93.0, 93.0, 152.0, 92.0, 92.0, 145.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 56.0, 57.0, 58.0, 57.0, 75.0, 56.0, 53.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0, 61.0, 61.0, 62.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 92.0, 79.0, 80.0, 81.0, 82.0, 81.0, 81.0, 82.0, 82.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 127.0, 134.0, 128.0, 126.0, 132.0, 127.0, 207.0, 132.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 162.0, 163.0, 165.0, 165.0, 173.0, 164.0, 166.0, 167.0, 170.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 69.0, 69.0, 67.0, 69.0, 67.0, 67.0, 76.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1552.3999999999996, "alertThreshold": 2.0}]} 19:18:46 INFO - Return code: 0 19:18:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:18:46 ERROR - # TBPL SUCCESS # 19:18:46 INFO - Running post-action listener: _resource_record_post_action 19:18:46 INFO - Running post-run listener: _resource_record_post_run 19:18:48 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537788416; Read time: 12; Write time: 405316 19:18:48 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 243699712; Read time: 0; Write time: 236412 19:18:48 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294088704; Read time: 12; Write time: 168904 19:18:48 INFO - Running post-run listener: _upload_blobber_files 19:18:48 INFO - Blob upload gear active. 19:18:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:18:48 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:18:48 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:18:48 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:18:48 INFO - (blobuploader) - INFO - Open directory for files ... 19:18:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:18:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:18:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:49 INFO - (blobuploader) - INFO - Done attempting. 19:18:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:18:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:18:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:50 INFO - (blobuploader) - INFO - Done attempting. 19:18:50 INFO - (blobuploader) - INFO - Iteration through files over. 19:18:50 INFO - Return code: 0 19:18:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:18:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:18:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab144777e6350e6017575d76ee1445b7bb34f657be1d3105d409d45fd598d9b2942aa0e3827c5da65a4ab08bc8d6a6cfa82ba96ab84282371601bca4aaa9c058", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99a3af1be8c3d66b3a6e4c800d30463059a3b34ca08104176d622b1b2c112bb24999f880f5ebec755ce1097885b72e79932ff3c32d3f91a1f35ec9d330cf4da"} 19:18:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:18:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:18:50 INFO - Contents: 19:18:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab144777e6350e6017575d76ee1445b7bb34f657be1d3105d409d45fd598d9b2942aa0e3827c5da65a4ab08bc8d6a6cfa82ba96ab84282371601bca4aaa9c058", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99a3af1be8c3d66b3a6e4c800d30463059a3b34ca08104176d622b1b2c112bb24999f880f5ebec755ce1097885b72e79932ff3c32d3f91a1f35ec9d330cf4da"} 19:18:50 INFO - Running post-run listener: copy_logs_to_upload_dir 19:18:50 INFO - Copying logs to upload dir... 19:18:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:18:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.254502 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-12 19:18:49.909790) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 19:18:49.913658) ========= 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=20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868 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/ab144777e6350e6017575d76ee1445b7bb34f657be1d3105d409d45fd598d9b2942aa0e3827c5da65a4ab08bc8d6a6cfa82ba96ab84282371601bca4aaa9c058", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99a3af1be8c3d66b3a6e4c800d30463059a3b34ca08104176d622b1b2c112bb24999f880f5ebec755ce1097885b72e79932ff3c32d3f91a1f35ec9d330cf4da"} build_url:https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011589 build_url: 'https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/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/ab144777e6350e6017575d76ee1445b7bb34f657be1d3105d409d45fd598d9b2942aa0e3827c5da65a4ab08bc8d6a6cfa82ba96ab84282371601bca4aaa9c058", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99a3af1be8c3d66b3a6e4c800d30463059a3b34ca08104176d622b1b2c112bb24999f880f5ebec755ce1097885b72e79932ff3c32d3f91a1f35ec9d330cf4da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 19:18:49.943645) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 19:18:49.944405) ========= 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=20e666a3d4cfbb71505a330e000001b4-1460510584.164752-105009868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 19:18:50.026842) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 19:18:50.027251) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 19:18:50.027576) ========= ========= Total master_lag: 0.28 =========