builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1458428314.89 results: success (0) buildid: 20160319133030 builduid: 2da01fc9bef043c5aeb09a29ba759752 revision: 577b8fb1479a8a10ecec8276a6b3be942500e946 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:34.889352) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:34.889807) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:34.890096) ========= 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=a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006362 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:34.920103) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:34.920365) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:34.977992) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:34.978238) ========= 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=a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:35.030316) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:35.030583) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:35.030919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:35.031232) ========= 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=a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-19 15:58:35-- 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% 42.6M=0s 2016-03-19 15:58:35 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095448 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:35.140197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:35.140522) ========= 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=a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022467 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:35.190357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:35.190699) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 577b8fb1479a8a10ecec8276a6b3be942500e946 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 577b8fb1479a8a10ecec8276a6b3be942500e946 --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=a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-19 15:58:36,069 truncating revision to first 12 chars 2016-03-19 15:58:36,070 Setting DEBUG logging. 2016-03-19 15:58:36,070 attempt 1/10 2016-03-19 15:58:36,070 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/577b8fb1479a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-19 15:58:36,296 unpacking tar archive at: mozilla-inbound-577b8fb1479a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.480070 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:35.682901) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:35.683200) ========= echo 577b8fb1479a8a10ecec8276a6b3be942500e946 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'577b8fb1479a8a10ecec8276a6b3be942500e946'] 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=a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 577b8fb1479a8a10ecec8276a6b3be942500e946 program finished with exit code 0 elapsedTime=0.003767 script_repo_revision: '577b8fb1479a8a10ecec8276a6b3be942500e946' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:35.730730) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:35.731067) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-19 15:58:35.740670) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-03-19 15:58:35.741123) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:58:36 INFO - MultiFileLogger online at 20160319 15:58:36 in /builds/slave/test-pgo 15:58:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:58:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:58:36 INFO - {'append_to_log': False, 15:58:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:58:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:58:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:58:36 INFO - 'branch': 'Mozilla-Inbound', 15:58:36 INFO - 'buildbot_json_path': 'buildprops.json', 15:58:36 INFO - 'config_files': ('talos/linux_config.py',), 15:58:36 INFO - 'default_actions': ('clobber', 15:58:36 INFO - 'read-buildbot-config', 15:58:36 INFO - 'download-and-extract', 15:58:36 INFO - 'populate-webroot', 15:58:36 INFO - 'create-virtualenv', 15:58:36 INFO - 'install', 15:58:36 INFO - 'run-tests'), 15:58:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:58:36 INFO - 'download_minidump_stackwalk': True, 15:58:36 INFO - 'download_symbols': 'ondemand', 15:58:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:58:36 INFO - 'tooltool.py': '/tools/tooltool.py', 15:58:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:58:36 INFO - '/tools/misc-python/virtualenv.py')}, 15:58:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:58:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:58:36 INFO - 'installer_path': 'installer.exe', 15:58:36 INFO - 'log_level': 'info', 15:58:36 INFO - 'log_name': 'talos', 15:58:36 INFO - 'log_to_console': True, 15:58:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:58:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:58:36 INFO - 'opt_config_files': (), 15:58:36 INFO - 'pip_index': False, 15:58:36 INFO - 'sps_profile': False, 15:58:36 INFO - 'sps_profile_interval': 0, 15:58:36 INFO - 'suite': 'dromaeojs', 15:58:36 INFO - 'system_bits': '32', 15:58:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:58:36 INFO - 'title': 'talos-linux64-ix-002', 15:58:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:58:36 INFO - 'use_talos_json': True, 15:58:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:58:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:58:36 INFO - 'work_dir': 'build'} 15:58:36 INFO - ##### 15:58:36 INFO - ##### Running clobber step. 15:58:36 INFO - ##### 15:58:36 INFO - Running pre-action listener: _resource_record_pre_action 15:58:36 INFO - Running main action method: clobber 15:58:36 INFO - rmtree: /builds/slave/test-pgo/build 15:58:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:58:37 INFO - Running post-action listener: _resource_record_post_action 15:58:37 INFO - ##### 15:58:37 INFO - ##### Running read-buildbot-config step. 15:58:37 INFO - ##### 15:58:37 INFO - Running pre-action listener: _resource_record_pre_action 15:58:37 INFO - Running main action method: read_buildbot_config 15:58:37 INFO - Using buildbot properties: 15:58:37 INFO - { 15:58:37 INFO - "project": "", 15:58:37 INFO - "product": "firefox", 15:58:37 INFO - "script_repo_revision": "production", 15:58:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:58:37 INFO - "repository": "", 15:58:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 15:58:37 INFO - "buildid": "20160319133030", 15:58:37 INFO - "pgo_build": "True", 15:58:37 INFO - "basedir": "/builds/slave/test-pgo", 15:58:37 INFO - "buildnumber": 812, 15:58:37 INFO - "slavename": "talos-linux64-ix-002", 15:58:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:58:37 INFO - "platform": "ubuntu64_hw", 15:58:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:58:37 INFO - "branch": "mozilla-inbound", 15:58:37 INFO - "repo_path": "integration/mozilla-inbound", 15:58:37 INFO - "revision": "577b8fb1479a8a10ecec8276a6b3be942500e946", 15:58:37 INFO - "stage_platform": "linux64-pgo", 15:58:37 INFO - "builduid": "2da01fc9bef043c5aeb09a29ba759752", 15:58:37 INFO - "slavebuilddir": "test" 15:58:37 INFO - } 15:58:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:58:37 INFO - Running post-action listener: _resource_record_post_action 15:58:37 INFO - ##### 15:58:37 INFO - ##### Running download-and-extract step. 15:58:37 INFO - ##### 15:58:37 INFO - Running pre-action listener: _resource_record_pre_action 15:58:37 INFO - Running main action method: download_and_extract 15:58:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:58:37 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')]} 15:58:37 INFO - https://queue.taskcluster.net/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/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 15:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/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 15:58:46 INFO - Downloaded 1361 bytes. 15:58:46 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:58:46 INFO - Using the following test package requirements: 15:58:46 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:46 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:58:46 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:58:46 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:46 INFO - u'jsshell-linux-x86_64.zip'], 15:58:46 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:58:46 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:46 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:58:46 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:58:46 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:58:46 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:58:46 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:46 INFO - https://queue.taskcluster.net/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:58:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:58:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:58:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/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 15:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/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 15:58:52 INFO - Downloaded 23585331 bytes. 15:58:52 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'] 15:58:52 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 15:58:54 INFO - Return code: 0 15:58:54 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 15:58:54 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')]} 15:58:54 INFO - https://queue.taskcluster.net/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:58:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:58:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:58:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/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 15:58:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/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 15:58:56 INFO - Downloaded 23585331 bytes. 15:58:56 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'] 15:58:56 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 15:58:58 INFO - Return code: 0 15:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:58 INFO - https://queue.taskcluster.net/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:58:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:58:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:58:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/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 15:58:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/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 15:58:59 INFO - Downloaded 10847637 bytes. 15:58:59 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'] 15:58:59 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 15:58:59 INFO - Return code: 0 15:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:59 INFO - https://queue.taskcluster.net/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:58:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:58:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:58:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/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 15:58:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dY-ccSBGT-OYnpUYKf5y_g/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 15:59:01 INFO - Downloaded 57765109 bytes. 15:59:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:01 INFO - mkdir: /builds/slave/test-pgo/properties 15:59:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:59:01 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:59:01 INFO - Contents: 15:59:01 INFO - build_url:https://queue.taskcluster.net/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:02 INFO - Running post-action listener: _resource_record_post_action 15:59:02 INFO - Running post-action listener: set_extra_try_arguments 15:59:02 INFO - ##### 15:59:02 INFO - ##### Running populate-webroot step. 15:59:02 INFO - ##### 15:59:02 INFO - Running pre-action listener: _resource_record_pre_action 15:59:02 INFO - Running main action method: populate_webroot 15:59:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:59:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:59:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:59:02 INFO - '--tppagecycles', 15:59:02 INFO - '7'], 15:59:02 INFO - 'tests': ['tsvgm']}}, 15:59:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:59:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:59:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:59:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:59:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:59:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:59:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:02 INFO - 'talos_options': ['--e10s'], 15:59:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:02 INFO - 'tests': ['damp', 'tps']}, 15:59:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:02 INFO - 'talos_options': ['--e10s'], 15:59:02 INFO - 'tests': ['damp', 'tps']}, 15:59:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:59:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:59:02 INFO - 'other': {'tests': ['a11yr', 15:59:02 INFO - 'ts_paint', 15:59:02 INFO - 'tpaint', 15:59:02 INFO - 'sessionrestore', 15:59:02 INFO - 'sessionrestore_no_auto_restore', 15:59:02 INFO - 'tabpaint']}, 15:59:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:59:02 INFO - 'tests': ['a11yr', 15:59:02 INFO - 'ts_paint', 15:59:02 INFO - 'tpaint', 15:59:02 INFO - 'sessionrestore', 15:59:02 INFO - 'sessionrestore_no_auto_restore', 15:59:02 INFO - 'tabpaint']}, 15:59:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:59:02 INFO - 'tests': ['a11yr', 15:59:02 INFO - 'ts_paint', 15:59:02 INFO - 'tpaint', 15:59:02 INFO - 'sessionrestore', 15:59:02 INFO - 'sessionrestore_no_auto_restore', 15:59:02 INFO - 'tabpaint']}, 15:59:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:59:02 INFO - 'tests': ['a11yr', 15:59:02 INFO - 'ts_paint', 15:59:02 INFO - 'tpaint', 15:59:02 INFO - 'sessionrestore', 15:59:02 INFO - 'sessionrestore_no_auto_restore', 15:59:02 INFO - 'tabpaint']}, 15:59:02 INFO - 'other_l64': {'tests': ['a11yr', 15:59:02 INFO - 'ts_paint', 15:59:02 INFO - 'tpaint', 15:59:02 INFO - 'sessionrestore', 15:59:02 INFO - 'sessionrestore_no_auto_restore', 15:59:02 INFO - 'tabpaint']}, 15:59:02 INFO - 'other_nol64': {'tests': ['a11yr', 15:59:02 INFO - 'ts_paint', 15:59:02 INFO - 'tpaint', 15:59:02 INFO - 'sessionrestore', 15:59:02 INFO - 'sessionrestore_no_auto_restore', 15:59:02 INFO - 'tabpaint']}, 15:59:02 INFO - 'svgr': {'tests': ['tsvgx', 15:59:02 INFO - 'tsvgr_opacity', 15:59:02 INFO - 'tart', 15:59:02 INFO - 'tscrollx', 15:59:02 INFO - 'cart']}, 15:59:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:59:02 INFO - 'tests': ['tsvgx', 15:59:02 INFO - 'tsvgr_opacity', 15:59:02 INFO - 'tart', 15:59:02 INFO - 'tscrollx', 15:59:02 INFO - 'cart']}, 15:59:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:02 INFO - 'tests': ['tp5o']}, 15:59:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:02 INFO - 'talos_options': ['--e10s'], 15:59:02 INFO - 'tests': ['tp5o']}, 15:59:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:02 INFO - 'talos_options': ['--xperf_path', 15:59:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:02 INFO - 'tests': ['tp5n']}, 15:59:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:02 INFO - 'talos_options': ['--e10s', 15:59:02 INFO - '--xperf_path', 15:59:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:02 INFO - 'tests': ['tp5n']}}, 15:59:02 INFO - 'talos.zip': {'path': '', 15:59:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:59:02 INFO - Running post-action listener: _resource_record_post_action 15:59:02 INFO - ##### 15:59:02 INFO - ##### Running create-virtualenv step. 15:59:02 INFO - ##### 15:59:02 INFO - Running pre-action listener: _resource_record_pre_action 15:59:02 INFO - Running main action method: create_virtualenv 15:59:02 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:59:02 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 15:59:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:59:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:59:02 INFO - Using real prefix '/usr' 15:59:02 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:59:02 INFO - Installing distribute.............................................................................................................................................................................................done. 15:59:04 INFO - Installing pip.................done. 15:59:04 INFO - Return code: 0 15:59:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:59:04 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')]} 15:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:04 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')]} 15:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:04 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 0x7f9be7a10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23898d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24188b0>, '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 0x24197b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419c60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', '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 15:59:04 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 15:59:04 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 15:59:04 INFO - Using env: {'DISPLAY': ':0', 15:59:04 INFO - 'HOME': '/home/cltbld', 15:59:04 INFO - 'LANG': 'en_US.UTF-8', 15:59:04 INFO - 'LANGUAGE': 'en_US:en', 15:59:04 INFO - 'LOGNAME': 'cltbld', 15:59:04 INFO - 'MAIL': '/var/mail/cltbld', 15:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:04 INFO - 'MOZ_NO_REMOTE': '1', 15:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:04 INFO - 'NO_EM_RESTART': '1', 15:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:04 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:04 INFO - 'SHELL': '/bin/bash', 15:59:04 INFO - 'SHLVL': '1', 15:59:04 INFO - 'TERM': 'linux', 15:59:04 INFO - 'TMOUT': '86400', 15:59:04 INFO - 'USER': 'cltbld', 15:59:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', 15:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:04 INFO - '_': '/tools/buildbot/bin/python'} 15:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:05 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 15:59:05 INFO - Cleaning up... 15:59:05 INFO - Return code: 0 15:59:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9be7a10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23898d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24188b0>, '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 0x24197b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419c60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', '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 15:59:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:59:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:59:05 INFO - Using env: {'DISPLAY': ':0', 15:59:05 INFO - 'HOME': '/home/cltbld', 15:59:05 INFO - 'LANG': 'en_US.UTF-8', 15:59:05 INFO - 'LANGUAGE': 'en_US:en', 15:59:05 INFO - 'LOGNAME': 'cltbld', 15:59:05 INFO - 'MAIL': '/var/mail/cltbld', 15:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:05 INFO - 'MOZ_NO_REMOTE': '1', 15:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:05 INFO - 'NO_EM_RESTART': '1', 15:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:05 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:05 INFO - 'SHELL': '/bin/bash', 15:59:05 INFO - 'SHLVL': '1', 15:59:05 INFO - 'TERM': 'linux', 15:59:05 INFO - 'TMOUT': '86400', 15:59:05 INFO - 'USER': 'cltbld', 15:59:05 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', 15:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:05 INFO - '_': '/tools/buildbot/bin/python'} 15:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:05 INFO - Downloading/unpacking psutil>=0.7.1 15:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:59:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:07 INFO - Installing collected packages: psutil 15:59:07 INFO - Running setup.py install for psutil 15:59:07 INFO - building 'psutil._psutil_linux' extension 15:59:07 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 15:59:07 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 15:59:07 INFO - building 'psutil._psutil_posix' extension 15:59:07 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 15:59:07 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 15:59:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:07 INFO - Successfully installed psutil 15:59:07 INFO - Cleaning up... 15:59:07 INFO - Return code: 0 15:59:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:59:07 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')]} 15:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:07 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')]} 15:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:07 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 0x7f9be7a10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23898d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24188b0>, '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 0x24197b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419c60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', '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 15:59:07 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 15:59:07 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 15:59:07 INFO - Using env: {'DISPLAY': ':0', 15:59:07 INFO - 'HOME': '/home/cltbld', 15:59:07 INFO - 'LANG': 'en_US.UTF-8', 15:59:07 INFO - 'LANGUAGE': 'en_US:en', 15:59:07 INFO - 'LOGNAME': 'cltbld', 15:59:07 INFO - 'MAIL': '/var/mail/cltbld', 15:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:07 INFO - 'MOZ_NO_REMOTE': '1', 15:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:07 INFO - 'NO_EM_RESTART': '1', 15:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:07 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:07 INFO - 'SHELL': '/bin/bash', 15:59:07 INFO - 'SHLVL': '1', 15:59:07 INFO - 'TERM': 'linux', 15:59:07 INFO - 'TMOUT': '86400', 15:59:07 INFO - 'USER': 'cltbld', 15:59:07 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', 15:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:07 INFO - '_': '/tools/buildbot/bin/python'} 15:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:59:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:59:09 INFO - Installing collected packages: mozsystemmonitor 15:59:09 INFO - Running setup.py install for mozsystemmonitor 15:59:09 INFO - Successfully installed mozsystemmonitor 15:59:09 INFO - Cleaning up... 15:59:10 INFO - Return code: 0 15:59:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:10 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 0x7f9be7a10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23898d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24188b0>, '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 0x24197b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419c60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', '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 15:59:10 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 15:59:10 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 15:59:10 INFO - Using env: {'DISPLAY': ':0', 15:59:10 INFO - 'HOME': '/home/cltbld', 15:59:10 INFO - 'LANG': 'en_US.UTF-8', 15:59:10 INFO - 'LANGUAGE': 'en_US:en', 15:59:10 INFO - 'LOGNAME': 'cltbld', 15:59:10 INFO - 'MAIL': '/var/mail/cltbld', 15:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:10 INFO - 'MOZ_NO_REMOTE': '1', 15:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:10 INFO - 'NO_EM_RESTART': '1', 15:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:10 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:10 INFO - 'SHELL': '/bin/bash', 15:59:10 INFO - 'SHLVL': '1', 15:59:10 INFO - 'TERM': 'linux', 15:59:10 INFO - 'TMOUT': '86400', 15:59:10 INFO - 'USER': 'cltbld', 15:59:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', 15:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:10 INFO - '_': '/tools/buildbot/bin/python'} 15:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:10 INFO - Downloading/unpacking blobuploader==1.2.4 15:59:10 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 15:59:10 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 15:59:10 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 15:59:10 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 15:59:10 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 15:59:10 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 15:59:12 INFO - Downloading blobuploader-1.2.4.tar.gz 15:59:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:59:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:59:12 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 15:59:12 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 15:59:12 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 15:59:12 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 15:59:12 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 15:59:12 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 15:59:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:59:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:59:12 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 15:59:12 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 15:59:12 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 15:59:12 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 15:59:12 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 15:59:12 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 15:59:12 INFO - Downloading docopt-0.6.1.tar.gz 15:59:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:12 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:12 INFO - Running setup.py install for blobuploader 15:59:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:12 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:59:12 INFO - Running setup.py install for requests 15:59:13 INFO - Running setup.py install for docopt 15:59:13 INFO - Successfully installed blobuploader requests docopt 15:59:13 INFO - Cleaning up... 15:59:13 INFO - Return code: 0 15:59:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15: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')]} 15:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:13 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 0x7f9be7a10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23898d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24188b0>, '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 0x24197b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419c60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', '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 15:59:13 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 15:59:13 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 15:59:13 INFO - Using env: {'DISPLAY': ':0', 15:59:13 INFO - 'HOME': '/home/cltbld', 15:59:13 INFO - 'LANG': 'en_US.UTF-8', 15:59:13 INFO - 'LANGUAGE': 'en_US:en', 15:59:13 INFO - 'LOGNAME': 'cltbld', 15:59:13 INFO - 'MAIL': '/var/mail/cltbld', 15:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:13 INFO - 'MOZ_NO_REMOTE': '1', 15:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:13 INFO - 'NO_EM_RESTART': '1', 15:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:13 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:13 INFO - 'SHELL': '/bin/bash', 15:59:13 INFO - 'SHLVL': '1', 15:59:13 INFO - 'TERM': 'linux', 15:59:13 INFO - 'TMOUT': '86400', 15:59:13 INFO - 'USER': 'cltbld', 15:59:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', 15:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:13 INFO - '_': '/tools/buildbot/bin/python'} 15:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:59:13 INFO - Running setup.py (path:/tmp/pip-f0IX5y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:59:13 INFO - Running setup.py (path:/tmp/pip-WhMdh6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:59:13 INFO - Running setup.py (path:/tmp/pip-LENInB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:59:13 INFO - Running setup.py (path:/tmp/pip-ONLP3M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:59:13 INFO - Running setup.py (path:/tmp/pip-kU86bP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:59:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:59:14 INFO - Running setup.py (path:/tmp/pip-WfcWrk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:59:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:59:14 INFO - Running setup.py (path:/tmp/pip-vpyKEo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:59:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:59:14 INFO - Running setup.py (path:/tmp/pip-p6N9De-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:59:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:59:14 INFO - Running setup.py (path:/tmp/pip-8yKYn2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:59:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:59:14 INFO - Running setup.py (path:/tmp/pip-lu6kDB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:59:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:59:14 INFO - Running setup.py (path:/tmp/pip-SVedJL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:59:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:59:14 INFO - Running setup.py (path:/tmp/pip-W0RlR3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:59:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:59:14 INFO - Running setup.py (path:/tmp/pip-fIdQZE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:59:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:59:14 INFO - Running setup.py (path:/tmp/pip-rjR3H3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:59:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:59:14 INFO - Running setup.py (path:/tmp/pip-g_tV_L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:59:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:59:14 INFO - Running setup.py (path:/tmp/pip-RE6iIg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:59:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:59:14 INFO - Running setup.py (path:/tmp/pip-LNoYxK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:59:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:14 INFO - Running setup.py install for manifestparser 15:59:14 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:59:14 INFO - Running setup.py install for mozcrash 15:59:15 INFO - Running setup.py install for mozdebug 15:59:15 INFO - Running setup.py install for mozdevice 15:59:15 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:59:15 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:59:15 INFO - Running setup.py install for mozfile 15:59:15 INFO - Running setup.py install for mozhttpd 15:59:15 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:59:15 INFO - Running setup.py install for mozinfo 15:59:15 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:59:15 INFO - Running setup.py install for mozInstall 15:59:15 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:59:15 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:59:15 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:59:15 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:59:15 INFO - Running setup.py install for mozleak 15:59:15 INFO - Running setup.py install for mozlog 15:59:15 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:59:15 INFO - Running setup.py install for moznetwork 15:59:15 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:59:15 INFO - Running setup.py install for mozprocess 15:59:16 INFO - Running setup.py install for mozprofile 15:59:16 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:59:16 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:59:16 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:59:16 INFO - Running setup.py install for mozrunner 15:59:16 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:59:16 INFO - Running setup.py install for mozscreenshot 15:59:16 INFO - Running setup.py install for moztest 15:59:16 INFO - Running setup.py install for mozversion 15:59:16 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:59:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:16 INFO - Cleaning up... 15:59:16 INFO - Return code: 0 15:59:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:16 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 0x7f9be7a10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23898d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24188b0>, '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 0x24197b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419c60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', '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 15:59:16 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 15:59:16 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 15:59:16 INFO - Using env: {'DISPLAY': ':0', 15:59:16 INFO - 'HOME': '/home/cltbld', 15:59:16 INFO - 'LANG': 'en_US.UTF-8', 15:59:16 INFO - 'LANGUAGE': 'en_US:en', 15:59:16 INFO - 'LOGNAME': 'cltbld', 15:59:16 INFO - 'MAIL': '/var/mail/cltbld', 15:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:16 INFO - 'MOZ_NO_REMOTE': '1', 15:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:16 INFO - 'NO_EM_RESTART': '1', 15:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:16 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:16 INFO - 'SHELL': '/bin/bash', 15:59:16 INFO - 'SHLVL': '1', 15:59:16 INFO - 'TERM': 'linux', 15:59:16 INFO - 'TMOUT': '86400', 15:59:16 INFO - 'USER': 'cltbld', 15:59:16 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', 15:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:16 INFO - '_': '/tools/buildbot/bin/python'} 15:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:59:16 INFO - Running setup.py (path:/tmp/pip-DDYFmv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:59:16 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)) 15:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:59:16 INFO - Running setup.py (path:/tmp/pip-b_3Dfg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:59:16 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)) 15:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:59:17 INFO - Running setup.py (path:/tmp/pip-O0D3vn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:59:17 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)) 15:59:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:59:17 INFO - Running setup.py (path:/tmp/pip-l7y2FD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:59:17 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)) 15:59:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:59:17 INFO - Running setup.py (path:/tmp/pip-p7IVTt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:59:17 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)) 15:59:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:59:17 INFO - Running setup.py (path:/tmp/pip-oaH5JB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:59:17 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)) 15:59:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:59:17 INFO - Running setup.py (path:/tmp/pip-sDYJ2t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:59:17 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)) 15:59:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:59:17 INFO - Running setup.py (path:/tmp/pip-_XV8bH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:59:17 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)) 15:59:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:59:17 INFO - Running setup.py (path:/tmp/pip-43HeVN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:59:17 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)) 15:59:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:59:17 INFO - Running setup.py (path:/tmp/pip-ZRt7t2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:59:17 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)) 15:59:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:59:17 INFO - Running setup.py (path:/tmp/pip-xled0v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:59:17 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)) 15:59:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:59:17 INFO - Running setup.py (path:/tmp/pip-89W35Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:59:17 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)) 15:59:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:59:17 INFO - Running setup.py (path:/tmp/pip-gFcdJc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:59:17 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)) 15:59:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:59:17 INFO - Running setup.py (path:/tmp/pip-DAAZES-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:59:17 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)) 15:59:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:59:17 INFO - Running setup.py (path:/tmp/pip-6f7VGV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:59:17 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)) 15:59:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:59:17 INFO - Running setup.py (path:/tmp/pip-qDBc1t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:59:18 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)) 15:59:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:59:18 INFO - Running setup.py (path:/tmp/pip-TZJ2Rs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:59:18 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)) 15:59:18 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)) 15:59:18 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)) 15:59:18 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)) 15:59:18 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)) 15:59:18 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)) 15:59:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:19 INFO - Downloading blessings-1.6.tar.gz 15:59:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:20 INFO - Installing collected packages: blessings 15:59:20 INFO - Running setup.py install for blessings 15:59:20 INFO - Successfully installed blessings 15:59:20 INFO - Cleaning up... 15:59:20 INFO - Return code: 0 15:59:20 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:59:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:59:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:59:20 INFO - Reading from file tmpfile_stdout 15:59:20 INFO - Current package versions: 15:59:20 INFO - argparse == 1.2.1 15:59:20 INFO - blessings == 1.6 15:59:20 INFO - blobuploader == 1.2.4 15:59:20 INFO - docopt == 0.6.1 15:59:20 INFO - manifestparser == 1.1 15:59:20 INFO - mozInstall == 1.12 15:59:20 INFO - mozcrash == 0.17 15:59:20 INFO - mozdebug == 0.1 15:59:20 INFO - mozdevice == 0.48 15:59:20 INFO - mozfile == 1.2 15:59:20 INFO - mozhttpd == 0.7 15:59:20 INFO - mozinfo == 0.9 15:59:20 INFO - mozleak == 0.1 15:59:20 INFO - mozlog == 3.1 15:59:20 INFO - moznetwork == 0.27 15:59:20 INFO - mozprocess == 0.22 15:59:20 INFO - mozprofile == 0.28 15:59:20 INFO - mozrunner == 6.11 15:59:20 INFO - mozscreenshot == 0.1 15:59:20 INFO - mozsystemmonitor == 0.0 15:59:20 INFO - moztest == 0.7 15:59:20 INFO - mozversion == 1.4 15:59:20 INFO - psutil == 3.1.1 15:59:20 INFO - requests == 1.2.3 15:59:20 INFO - wsgiref == 0.1.2 15:59:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:20 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 0x7f9be7a10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23898d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24188b0>, '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 0x24197b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419c60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', '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 15:59:20 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 15:59:20 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 15:59:20 INFO - Using env: {'DISPLAY': ':0', 15:59:20 INFO - 'HOME': '/home/cltbld', 15:59:20 INFO - 'LANG': 'en_US.UTF-8', 15:59:20 INFO - 'LANGUAGE': 'en_US:en', 15:59:20 INFO - 'LOGNAME': 'cltbld', 15:59:20 INFO - 'MAIL': '/var/mail/cltbld', 15:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:20 INFO - 'MOZ_NO_REMOTE': '1', 15:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:20 INFO - 'NO_EM_RESTART': '1', 15:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:20 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:20 INFO - 'SHELL': '/bin/bash', 15:59:20 INFO - 'SHLVL': '1', 15:59:20 INFO - 'TERM': 'linux', 15:59:20 INFO - 'TMOUT': '86400', 15:59:20 INFO - 'USER': 'cltbld', 15:59:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', 15:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:20 INFO - '_': '/tools/buildbot/bin/python'} 15:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:20 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)) 15:59:20 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)) 15:59:20 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)) 15:59:20 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)) 15:59:20 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)) 15:59:20 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)) 15:59:20 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)) 15:59:20 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)) 15:59:20 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)) 15:59:20 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)) 15:59:20 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)) 15:59:20 INFO - Cleaning up... 15:59:20 INFO - Return code: 0 15:59:20 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9be7a10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23898d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24188b0>, '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 0x24197b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419c60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', '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 15:59:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 15:59:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:59:20 INFO - Using env: {'DISPLAY': ':0', 15:59:20 INFO - 'HOME': '/home/cltbld', 15:59:20 INFO - 'LANG': 'en_US.UTF-8', 15:59:20 INFO - 'LANGUAGE': 'en_US:en', 15:59:20 INFO - 'LOGNAME': 'cltbld', 15:59:20 INFO - 'MAIL': '/var/mail/cltbld', 15:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:20 INFO - 'MOZ_NO_REMOTE': '1', 15:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:20 INFO - 'NO_EM_RESTART': '1', 15:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:20 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:20 INFO - 'SHELL': '/bin/bash', 15:59:20 INFO - 'SHLVL': '1', 15:59:20 INFO - 'TERM': 'linux', 15:59:20 INFO - 'TMOUT': '86400', 15:59:20 INFO - 'USER': 'cltbld', 15:59:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', 15:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:20 INFO - '_': '/tools/buildbot/bin/python'} 15:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:20 INFO - Downloading/unpacking jsonschema 15:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:59:22 INFO - Downloading/unpacking functools32 (from jsonschema) 15:59:22 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 15:59:22 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 15:59:22 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 15:59:22 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 15:59:22 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 15:59:22 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 15:59:22 INFO - Downloading functools32-3.2.3-2.tar.gz 15:59:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:59:22 INFO - warning: no files found matching '*.txt' 15:59:22 INFO - no previously-included directories found matching 'build' 15:59:22 INFO - no previously-included directories found matching 'dist' 15:59:22 INFO - no previously-included directories found matching '.git*' 15:59:22 INFO - Installing collected packages: jsonschema, functools32 15:59:23 INFO - Running setup.py install for functools32 15:59:23 INFO - warning: no files found matching '*.txt' 15:59:23 INFO - no previously-included directories found matching 'build' 15:59:23 INFO - no previously-included directories found matching 'dist' 15:59:23 INFO - no previously-included directories found matching '.git*' 15:59:23 INFO - Successfully installed jsonschema functools32 15:59:23 INFO - Cleaning up... 15:59:23 INFO - Return code: 0 15:59:23 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9be7a10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23898d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24188b0>, '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 0x24197b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419c60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', '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 15:59:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 15:59:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:59:23 INFO - Using env: {'DISPLAY': ':0', 15:59:23 INFO - 'HOME': '/home/cltbld', 15:59:23 INFO - 'LANG': 'en_US.UTF-8', 15:59:23 INFO - 'LANGUAGE': 'en_US:en', 15:59:23 INFO - 'LOGNAME': 'cltbld', 15:59:23 INFO - 'MAIL': '/var/mail/cltbld', 15:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:23 INFO - 'MOZ_NO_REMOTE': '1', 15:59:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:23 INFO - 'NO_EM_RESTART': '1', 15:59:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:23 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:23 INFO - 'SHELL': '/bin/bash', 15:59:23 INFO - 'SHLVL': '1', 15:59:23 INFO - 'TERM': 'linux', 15:59:23 INFO - 'TMOUT': '86400', 15:59:23 INFO - 'USER': 'cltbld', 15:59:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', 15:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:23 INFO - '_': '/tools/buildbot/bin/python'} 15:59:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:23 INFO - Downloading/unpacking flake8 15:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:59:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:59:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:59:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:25 INFO - no previously-included directories found matching 'docs/_build' 15:59:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:59:25 INFO - Running setup.py install for pep8 15:59:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:26 INFO - no previously-included directories found matching 'docs/_build' 15:59:26 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:59:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:59:26 INFO - Cleaning up... 15:59:26 INFO - Return code: 0 15:59:26 INFO - Running post-action listener: _resource_record_post_action 15:59:26 INFO - Running post-action listener: _start_resource_monitoring 15:59:26 INFO - Starting resource monitoring. 15:59:26 INFO - ##### 15:59:26 INFO - ##### Running install step. 15:59:26 INFO - ##### 15:59:26 INFO - Running pre-action listener: _resource_record_pre_action 15:59:26 INFO - Running main action method: install 15:59:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:59:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:59:26 INFO - Reading from file tmpfile_stdout 15:59:26 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:59:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:59:26 INFO - Reading from file tmpfile_stdout 15:59:26 INFO - Output received: 15:59:26 INFO - Usage: mozinstall [options] installer 15:59:26 INFO - Options: 15:59:26 INFO - -h, --help show this help message and exit 15:59:26 INFO - -d DEST, --destination=DEST 15:59:26 INFO - Directory to install application into. [default: 15:59:26 INFO - "/builds/slave/test-pgo"] 15:59:26 INFO - --app=APP Application being installed. [default: firefox] 15:59:26 INFO - mkdir: /builds/slave/test-pgo/build/application 15:59:26 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'] 15:59:26 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 15:59:42 INFO - Reading from file tmpfile_stdout 15:59:42 INFO - Output received: 15:59:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:59:42 INFO - Running post-action listener: _resource_record_post_action 15:59:42 INFO - ##### 15:59:42 INFO - ##### Running run-tests step. 15:59:42 INFO - ##### 15:59:42 INFO - Running pre-action listener: _resource_record_pre_action 15:59:42 INFO - Running main action method: run_tests 15:59:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:59:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:59:42 INFO - Python 2.7.3 15:59:42 INFO - Return code: 0 15:59:42 INFO - grabbing minidump binary from tooltool 15:59:42 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')]} 15:59:42 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 0x24188b0>, '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 0x24197b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:59:42 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 15:59:42 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 15:59:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:59:42 INFO - Return code: 0 15:59:42 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:59:42 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:59:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:59:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:59:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:59:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:59:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:59:43 INFO - Return code: 0 15:59:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 15:59:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 15:59:43 INFO - Using env: {'DISPLAY': ':0', 15:59:43 INFO - 'HOME': '/home/cltbld', 15:59:43 INFO - 'LANG': 'en_US.UTF-8', 15:59:43 INFO - 'LANGUAGE': 'en_US:en', 15:59:43 INFO - 'LOGNAME': 'cltbld', 15:59:43 INFO - 'MAIL': '/var/mail/cltbld', 15:59:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:59:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:43 INFO - 'MOZ_NO_REMOTE': '1', 15:59:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:43 INFO - 'NO_EM_RESTART': '1', 15:59:43 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:43 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:43 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:59:43 INFO - 'SHELL': '/bin/bash', 15:59:43 INFO - 'SHLVL': '1', 15:59:43 INFO - 'TERM': 'linux', 15:59:43 INFO - 'TMOUT': '86400', 15:59:43 INFO - 'USER': 'cltbld', 15:59:43 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610', 15:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:43 INFO - '_': '/tools/buildbot/bin/python'} 15:59:43 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 15:59:44 INFO - mozversion application_buildid: 20160319133030 15:59:44 INFO - mozversion application_changeset: 577b8fb1479a8a10ecec8276a6b3be942500e946 15:59:44 INFO - mozversion application_display_name: Nightly 15:59:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:59:44 INFO - mozversion application_name: Firefox 15:59:44 INFO - mozversion application_remotingname: firefox 15:59:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:59:44 INFO - mozversion application_vendor: Mozilla 15:59:44 INFO - mozversion application_version: 48.0a1 15:59:44 INFO - mozversion platform_buildid: 20160319133030 15:59:44 INFO - mozversion platform_changeset: 577b8fb1479a8a10ecec8276a6b3be942500e946 15:59:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:59:44 INFO - mozversion platform_version: 48.0a1 15:59:44 INFO - using testdate: 1458428384 15:59:44 INFO - actual date: 1458428384 15:59:44 INFO - starting webserver on 'localhost:41858' 15:59:44 INFO - SUITE-START | Running 2 tests 15:59:44 INFO - TEST-START | dromaeo_css 15:59:44 INFO - operating with platform_type : linux_ 15:59:44 INFO - Initialising browser for dromaeo_css test... 15:59:44 INFO - TEST-INFO | started process 3598 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDtB0eP/profile http://localhost:41858/getInfo.html) 15:59:48 INFO - PROCESS | 3598 | __metrics Screen width/height:1600/1200 15:59:48 INFO - PROCESS | 3598 | colorDepth:24 15:59:48 INFO - PROCESS | 3598 | Browser inner width/height: 1024/697 15:59:48 INFO - PROCESS | 3598 | __metrics 15:59:49 ERROR - PROCESS | 3598 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:59:50 INFO - TEST-INFO | 3598: exit 0 15:59:50 INFO - Browser initialized. 15:59:50 INFO - Running cycle 1/1 for dromaeo_css test... 15:59:50 INFO - TEST-INFO | started process 3689 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDtB0eP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:00:02 INFO - PROCESS | 3689 | RSS: Main: 155426816 16:00:02 INFO - PROCESS | 3689 | 16:00:53 INFO - PROCESS | 3689 | 1458428453050 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] 16:03:00 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:41858/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41858/tests/dromaeo/cssquery-ext.html) 16:03:01 INFO - PROCESS | 3689 | RSS: Main: 254881792 16:03:01 INFO - PROCESS | 3689 | 16:06:03 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:41858/tests/dromaeo/cssquery-ext.html (next: http://localhost:41858/tests/dromaeo/cssquery-jquery.html) 16:06:04 INFO - PROCESS | 3689 | RSS: Main: 235393024 16:06:04 INFO - PROCESS | 3689 | 16:09:06 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:41858/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41858/tests/dromaeo/cssquery-mootools.html) 16:09:06 INFO - PROCESS | 3689 | RSS: Main: 227954688 16:09:06 INFO - PROCESS | 3689 | 16:12:08 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:41858/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41858/tests/dromaeo/cssquery-prototype.html) 16:12:09 INFO - PROCESS | 3689 | RSS: Main: 222646272 16:12:09 INFO - PROCESS | 3689 | 16:15:11 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:41858/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41858/tests/dromaeo/cssquery-yui.html) 16:15:12 INFO - PROCESS | 3689 | RSS: Main: 221728768 16:15:12 INFO - PROCESS | 3689 | 16:18:14 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:41858/tests/dromaeo/cssquery-yui.html (next: http://localhost:41858/tests/dromaeo/cssquery-dojo.html) 16:18:15 INFO - PROCESS | 3689 | RSS: Main: 255332352 16:18:15 INFO - PROCESS | 3689 | 16:18:15 INFO - PROCESS | 3689 | __start_tp_report 16:18:15 INFO - PROCESS | 3689 | _x_x_mozilla_page_load 16:18:15 INFO - PROCESS | 3689 | _x_x_mozilla_page_load_details 16:18:15 INFO - PROCESS | 3689 | |i|pagename|runs| 16:18:15 INFO - PROCESS | 3689 | |0;dojo.html;3040.6047213862194;3058.9235269118285;3063.4026364858832;3106.068179546137;3134.5298205269205;5110.693358398498;5236.895262094756;5254.57963362931;5269.2886460327845;5307.2569840222395;5246.396664383597;5323.520883120518;5334.066538355792;5355.08963476209;5390.865228369293;4708.364370809931;4716.716996980175;4722.97638511807;4724.078804633098;4825.252085926687;4768.070226305872;4773.832915847946;4797.520247975192;4819.4939531349055;4860.222364421693;4674.883127921795;4751.358566593518;4757.0723708876785;4783.4499032611175;4820.758962051884;4705.9294110588025;4706.035262771158;4716.882077948045;4724.126036683225;4740.454847692525;4642.117997580449;4702.6473014524045;4705.694129881581;4727.267273572567;4754.857354279377;5204.9219261711105;5222.97388513055;5242.030224408497;5271.130263506517;5290.656107353048;5507.284053073115;5516.448355164492;5529.585281103933;5530.142827861688;5544.390117087117;5399.865003374908;5548.91676624851;5559.471850174227;5578.330600327987;5623.9437605623825;5204.297419848348;5219.269302297681;5221.55616772571;5246.291750613656;5262.05283049051;5701.800436984686;5710.172025056344;5716.628419152742;5716.742746576414;5720.42795720433;5279.973600131974;5447.836564903059;5488.835334939959;5501.284832971768;5505.834824955257;5627.971860140673;5629.549636029108;5634.971825140848;5648.181013752983;5651.576131790132;5568.6658800472105;5592.97203513988;5599.636023658449;5611.7755289788765;5624.71876406178;5430.647007944471;5504;5538.6399884007415;5582.720863956867;5602.467765562265;4271.636910862611;4277;4277.828886844553;4285.4648407293525;4312.935305970413;3801.5058042454857;3830.8467661293234;3833.6549710526187;3855.4216867469545;3868.400397938324;5117.513836185556;5327.200919862052;5383.569314454834;5416.214648875891;5441.129419292894;5732.197492351074;5734.655920644775;5735.967525845304;5742.511886489695;5761.193432919395;5088.720120393414;5439.728013599304;5453.047364610154;5457.727113644302;5460.399356070829;4932.8520144395725;4949.084419382426;4951.282064100686;4991.425986011583;4999.150144475448;5890.911636325459;5904.321003084614;5906;5913.793017244462;5917.171595976567;5568.526675232651;5696.401877802854;5702.2016917630735;5709.8287051388525;5726.169705392778;5858.326292476249;5862.149988251765;5862.296524417097;5867.32525759526;5896.086106653304;5558.555315574825;5565.276514053147;5572.247746554325;5572.442755724557;5573.7770489179975;5538.86152846166;5644;5669.092945128759;5671.376148623731;5724.971375143097;5474.945250547444;5486.670799752028;5489.313835770528;5491.956528259778;5547.7780888764;5412.052890744183;5416;5416.901731910819;5420.403755586961;5464.262324586289;5202.921956170585;5266.210068489757;5278.841634750964;5299.973500132474;5374.865628359323;5492.340919089735;5500.9174862377895;5509.3664228614225;5511.448855114457;5521.420250873601;5332.733363331896;5395.028894798974;5395.865103372447;5396.487333703292;5444.292242008513 16:18:15 INFO - PROCESS | 3689 | |1;ext.html;544.103031496604;561.0378201384627;566.603377635655;585.5900869391422;590.1325052173305;29858.402831943375;30297;38783;39050.80474597623;39253;41853.58146418535;42431;42455.36316955248;42491.78754106225;42555.14889702204;8655.783605409852;8850.424722393023;8852.203301702846;8853.911460885405;8859.114088591154;8510.617022234015;8660.307175425982;8660.783480412978;8662.566871656423;8671.219590236877;8671.479711217347;8736.737897863075;8821.470711757314;8913.955430222839;8939.865902011476;8787.560621968907;8853.955730221373;8872.600732967032;8873.334499912533;8880.06759290275;8842.027376988526;8943;8960.731178064669;8970.147835955573;8973.596188171483;41464.79267603643;41782.582174178475;41788.58211417908;41902.580974190176;41921.79039104785;3173.254285242966;3291.4569096099117;3410.113370523657;3633.6729694327373;3803.5435747710176;31258.687413125805;31719.52420713691;31886;32048.523575368887;32075.198120046953;3191.345774116324;3202.727768139711;3240.4491236489853;3245.5618491503583;3267.18320419895;306398;308526;315207;316036;316754.4162279197;52251;58799;59661.70169149127;59793;59887;64218.35781642124;65092.34907650863;65532.67233663896;65534.344656553774;65575.34424655788;14282.500112496013;14390.42438302477;14399.280035998368;14460.927695361455;14543.41826326935;9933.304668673269;10127.898721012843;10731.40977246259;10867.40229287381;10891.727706807234;19622.62641615073;19950.20199192045;20200.49498762543;20269;20304;7477.7008919643695;7557.886631700529;7605.809854753676;7650.8087297818;7726.922730772732;996.6262651505685;1016.1515134862325;1074.887136850635;1121.2145330096662;1216.9574064907686;31989.200269993435;32249;32680.673193268238;32703.672963270063;32746;1117.692634525512;1141.3209140561353;1146.3007565385108;1149.1955631058293;1160.7968605494004;16431.1784410779;16615.584610384838;16672.749908751135;16799.09985263076;16877.578060548338;387336;391677;393759.15602110175;394014;394456;56307.15539266914;56743.432565674644;56790;56796.43203567994;56810;1235.32057368447;1257.937103144839;1375.9724805504034;1377.2906952919254;1382.8617138286293;28406.715932841234;31216;31236.245502497426;31783.84108079445;32040;47259.76370118265;47367;47762;47788.5221147798;47804.28293575669;265508;266212;267897;267911;268917;29419.264518386357;34156.31687366189;36476.63523364838;37035.81482092572;37124.62875371212;45139.32291015703;45483;45614.77192614148;46017.76991115023;46793.06413871772;38624.42063368995;38753;39182.6081739179;39616;40656.59343406646;38110.80944595259;38514;38825.223495530496;39121.804390979;39252.60747392604;39645.405318919664;40529.392059118545;40775;40913.1817363657;40981.1803763929;33782.662173378936;34763.826180869946;34855.82572087123;35392.46911296281;35471;27374.5893811589;27575.862120689268;27663.450644119443;27694.169174924784;27902.44195116127 16:18:15 INFO - PROCESS | 3689 | |2;jquery.html;368.7400382730175;371.77879161898693;371.90390003223155;376.5199370802227;381.66222892739916;17732.73400898986;18488.90755546222;18736.344227952042;19092.33176838811;19144.808551914477;17289.48131556055;17437.651246975052;18141.546461338472;18165;18202.635947281047;5459.426760190173;5631.7184140793;5635.267415236013;5666.320041594994;5697.6011679182475;4070.715049946505;5565.805196818113;6006.849828754294;6222.0666899965145;6222.595531290474;6148.477379422754;6191.226096737908;6214.440700336969;6215.254169499666;6216.378362163793;5966.224390829165;6085.817425477243;6123.112148738408;6140.171076904628;6148.508119350464;3645.5078564393734;5273.314469119028;5337.226102215157;5470.7264636768405;5481.588880833953;21208.681869771965;21253.256136035165;21313.57372852534;22972.54054918892;23028.884855575783;2342.320726989171;2357.0571771291447;2397.724261709891;2399.928002159938;2516.6225066240027;14049.578512644637;14093.224872632001;14166;14314.570562883026;14435.350409231505;1977.3968939473455;2017.2939471185114;2050.5181282398626;2051.200031987526;2064.834813214939;67445.32554674489;70205;70540.94188587226;70578;71878.64060679663;10426.113780328606;10492.842607360895;10701.411422371688;10810.35137891729;10963.83554246687;13806.723865522834;13828.723425531432;13886.77811550147;13896.16623002623;13917.095388799695;7729.768106956801;7939.523628582304;7943.960280198562;8045.275925166763;8067.919320806835;7726.9613651932505;7772.300492955661;7801.393676082584;7920.207979202034;7921.405894557931;6465;6513.544051916415;6530.902036469457;6534.183227096613;6550.3449655035065;1731.4201839259413;1793.390247315919;1827.4976958068662;1830.8077651846631;1848.5286252005922;451.3703383779609;468.9882752931204;471.6085648911395;989.8663680403054;1097.9121670266359;11245.493952771982;11482.425878706032;11986.700332491757;12124.75750485003;12350.938245308716;453.82981381981756;455.17158771036395;457.1246063787876;460.3715927758652;467.7544289248104;6353.618782873043;6551.639659818756;6622.238442579069;6710.463162946952;6756.83107922296;470174;471031.0278280556;483670;491810;506992;82899;85696.57151714202;87296;87365.56317218373;88719.55640221758;499.17885079044765;1038.984415233772;1077.095239998405;1080.6001779341693;1082.3614067699937;16553.255103520612;16741.162941852614;17166.828331716522;17332.480025599252;17333.56666083358;36875.81562092173;38587.6141238584;38590.614093858705;39966.80016599898;40683.389749154376;54700;55031;55051.724741376034;55131.44868551263;55283.44716552783;8252;8322.378450787983;8368.87446688288;8541.701040463555;8572.142785721378;9521.523923803921;12959;13377.130486518734;13412.195268283935;13504.729905402033;11318.377489238172;11606.187566870576;11911.463984120908;11944.581939632071;12039.277643341427;10514.842277365693;11346.716332091433;11636.825447618123;11708.063354931755;11892.881071189177;11687.240329378563;11790.292582445081;11816.291022538675;12169.20900141488;12559.372031398576;8202.302804261466;8505.91494085076;8577.95711021441;8593.785155370915;8667.479951202948;11055.05067896348;11598.420078995847;11749.706257343634;11798.174127811315;11830.231034982698 16:18:15 INFO - PROCESS | 3689 | |3;mootools.html;1343.6036369271064;1510.1316742872848;1515.0379509011775;1706.1213475060347;1837.3293747782054;7933.960330198348;8144.470609410391;8147.75556733299;8152.347812175027;8156.836863262731;8014.4790588611695;8159.061707903593;8163.959180204106;8168.469049511792;8177.223163799445;1993.6311782320245;2034.0846619021424;2239.3282015395357;2280.646499792535;2350.612148995414;2268.3648578398074;2270.625346817773;2271.636538153896;2271.852329598579;2272.2501574480466;2260.163739416418;2280.851744636602;2322.1175953137868;2322.1175953137868;2323.9070437182577;2279.4495403692063;2305.227748704178;2305.6195727704994;2335.2643917166038;2349.42439102421;2289.6336586146303;2302.412884714387;2316.5714342846627;2320.953580928372;2323.268170526279;8311.085780564134;8370.079291277954;8374.49753014815;8375.246227839463;8378.958105209496;5105.132127538291;5241.68549887008;5257.605679574047;5264.815731449419;5272.367315922075;3333.2666813301034;3376.1559610097474;3383.441732114198;3405.0465869556565;3407.931841363159;1033.8709197783628;1045.7072019834459;1045.7594753206804;1048.09863517375;1059.2796898109282;11799.056075513938;11896.226745261616;11900.523979040829;11901.761964760743;11906.523739050428;4684.718916864999;4797.968436786107;4828.758562071883;4833.685810422311;4841.467438581753;9877.456739879231;10085.49572521371;10128.797424051625;10132;10142.087212150795;5230.503102205284;5277.393099793573;5281.947180528223;5288;5294.41761406245;4048.4939382577177;4636.374089497875;4679;4724.385829842098;4746.8101275948575;3889.8638547651262;3983.900402489961;3987.142764305688;4007.7996100194873;4034.899127521777;1256.4597223194114;1260.0738457233927;1262.7727009138443;1270.3775150176348;1270.9491620335268;1344.522694443478;1378.4348417148922;1391.930403479822;1393.7630602797549;1428.1145689672262;7701.961490192625;7861.331786798072;7871.645775940096;7889.132195458495;7890.210978902064;496.1936852614501;498.29988865643827;499.20127795526867;501.1230346892937;507.0594048040905;6215.81352559424;6223.284322302902;6265.498760099181;6346.048092786119;6346.143270658495;10211.846822297672;10375.429351385746;10511.1591072714;10546.367217966947;10549.314294570828;9597.47213903242;10347.741306467247;10349.482525873676;10377.584896604203;10424.32241904289;7732.6133693315105;7757.922420775946;7898.526088434713;7920.643571039317;7921.841563168704;7757.983460086492;7764;7844.176361481962;8007.83984320322;8019.278264956182;8587;9029.819403612022;9117.772055698395;9358.298127640319;9418.57616407277;8955.104489550993;9094.226990705863;9207.309451791276;9252.583633736633;9266.44401335922;6038.879222415615;7083.079199704005;7273.272672732684;7297.124345078624;7408.6666100026705;7848.2151784823345;7864.331531819631;7869.84260314779;7894.565798881116;7914.643841027283;6977.406920411822;7159.57042577447;7200.315969982843;7258;7299.963500182677;7108.964455177691;7112.03987461686;7163.964180179066;7197.49617526789;7228.4578656599915;7359.8160045999275;7651.885221721567;7653.119891212582;7665.310122088816;7677.424193185645;7076.398506127037;7101.2898710128575;7104.005439238614;7105.9289407107335;7120.857582848417;6913;7071.646417679199;7073.434125269863;7085.858282834418;7124.287571243041 16:18:15 INFO - PROCESS | 3689 | |4;prototype.html;343.328792211227;344.28045385145043;344.3423061951671;350.3588433167301;356.37812018028546;5885.970570147154;5944.702764861756;5947.643141411519;5950.345461999187;5983.16235726998;5854.941450585493;5901.970490147543;5931.88136237275;5936.465718085371;5947.286325640918;4332.91334173318;4465.866024019285;4547.386102876102;4579.519150489193;4583.449986001668;4562.338460923164;4570.862874113782;4598.448186217642;4608.930866036995;4618.5381461853885;4555.430571178603;4557.544245575449;4568.314752787075;4576.336431217472;4582.450105987286;4317.481902171744;4431.645468362523;4514.503404625489;4515.277555591089;4531.660125490602;4012.4382586437923;4013.8595149169637;4014.9197016059807;4021.97989010056;4028.5971402859773;5722.771089156428;5732.426757324234;5733.741981610838;5734.569907256972;5737.7131143443075;5300.363956325227;5305.681659100428;5309.840704778863;5310.8141215057285;5311.920321195185;6230.470410015154;6245.937540624581;6246.781362652286;6247.468965137969;6249.218847644044;4161.126163505667;4283.1433713257475;4284.2074216269775;4475.1049790042125;4476.880779805048;6533.052707357407;6551.639659818708;6593.175853018372;6605.9669701651665;6664.466842652528;4443.577860103285;4450.732956022649;4451.955480445219;4452.265376212888;4464.843730469418;4502.054568540578;4502.887427814266;4504.189245935763;4506.053728717006;4506.639468842484;5209.244659524347;5214.504622060898;5219.634625576249;5222.216667499905;5223.085959956992;6074.51403887688;6350.142730731384;6354.841128971812;6361.9045714314325;6362.236531616236;1563.4137198550543;1577.5030865277631;1588.7219736546058;1589.570815879706;1590.2446337989363;963.6627180486773;987.8913319534845;1037.1754455208127;1055.1453322808395;1066.914646828252;5935.73289201987;5936.287645482484;5993.790217342372;6169.691515424211;6170.444659980623;6551.4103730664465;6558.704858281389;6562.278149403562;6564.7374105036215;6576.86846263072;6094.756209751649;6099.329073801879;6105.877882442326;6106.145139680449;6106.877862442726;3477.2871561329866;3513.508108864761;3519;3522.1546828761425;3523.3129539739502;6552.42741741988;6754.088198093293;6775.898361524581;6786.59280443175;6815.693293801791;6668.066470694107;6712.832179195461;6727.058211850345;6735.124433823572;6736.124303840469;6787.728490860409;6792.762253321209;6804.251532331538;6804.298925268683;6808.285130061371;6537.7058032389605;6543.509236807164;6552;6603.867922641424;6615.206175258807;6307.274663413767;6464.612123272619;6492.513061520499;6496.545241833026;6540.215174179129;6806.8638627228165;6814.352636499525;6829.52193346461;6837.453003759588;6842.315768423118;4340.761258130833;4373.103513779731;4373.212821691999;4373.868783936487;4380.6057454829215;6511.804645860631;6554.2462616797775;6557.049227862029;6567.770128045496;6586.110875031809;6380.9042864358;6381;6386.87226255463;6390.648514331757;6392.360763923571;6176;6352.110704501466;6355.078513615407;6368.840778980562;6371.490280777434;6171.259448866164;6182.567220294536;6188.164597779422;6189.845253868509;6192.659403732838;6384.585001974857;6402;6404.807855764335;6413.262474815456;6413.807585772434;5961.552883533839;6034.909476357946;6253.843653908689;6258.718357674006;6259.78090766821 16:18:15 INFO - PROCESS | 3689 | |5;yui.html;791.2680770287486;826.8759686047092;833.6373677450314;839.2572573272654;866.6663334616175;14668.11991280524;14869.256537173153;14911.25443727812;14948.551543453686;14968.700625987474;13758.931205343984;14471.42114315426;14492.492762753305;14519.346629401676;14537.200453975027;662.4534758823966;825.8430898129351;829.9170082991712;840.9032961209448;847.0047693959573;846.289117141601;846.9026062002856;847.4830353484369;853.7481442974306;853.8335024670192;877.2674816528206;884.0673089890163;884.1158841158841;885.1281487734608;885.3404213860683;694.6526736631685;705.8552996635703;866.8353012927523;873.057098333798;887.3566664168426;640.276487569044;642.2389468479867;642.2581917884851;648.4974145037586;651.934806519349;14716.926415367961;14793.852061479354;14794.778078328834;14803.851961480355;14819.110853348726;14050.227237501933;14617.78073328901;14665.780013299809;14738.263086845722;14746.336414861249;11243;11611.535538578446;11629.941850290694;11720.648380548597;11792.823107653392;3814.3896976483907;3840.9423858642144;3866.8839934801717;3892.766434013968;3979.9602003980167;52170.21744673833;53019;53966.46033539693;54689.453105468834;55061.31978781768;10960.835587466194;11040.171987101;11048.558057677603;11213.943930280297;11349.205555611028;17951.461456156074;17967.910160449115;17979.550511237325;18010;18270.54323641893;7963.442559020813;8013.639386227634;8160.5103693778565;8167.142450042778;8508.574571271536;4740.19416699162;4764.094821983812;4771.66598338113;4784.832530861403;4817.78319975602;3403.387390269775;3457.3085382923514;3469.063352894704;3472.70482009027;3483.2162763378037;616.6331033035336;622.6450922973861;622.6575383539035;640.4620119099978;643.469137961184;583.9633903700689;671.7279501801778;730.7579500996659;742.3726950726627;756.9810754731176;9340.859887101698;9566.234701224024;9599.952000239955;9605.719859578217;9723.562439690231;566.2355819643531;658.3646780856496;662.1392190152782;664.707528687376;700.6531766775479;4321.438213032348;4360.738355698668;4543.295789152687;4547.75590433929;4612.677112602086;60941;63480;64131.35868641347;65222;65763.67118164379;55742.72128639331;55899;56902.43097569054;58051.70974145102;58816.411835881096;51097.233541496906;52007;52267.47732522626;52388.95222095537;52850.207246891325;8730.301575874042;8916.766565358635;9009.774755631162;9017.143371379709;9048.457092574467;38654.80672596619;39074.413883791196;39552.2089558213;39585.2082958345;40988;46988.7650561745;50878.74560627173;50960.235596466824;51323;51560.74219629028;11631.709207269885;11829.962938089402;11857.34784586856;11957.521699131938;12021.398930053287;12048.036157107586;12442.937785311016;12652.186183301845;12695.873041269839;12704.618861434172;10840.403777792297;12500.437480313589;12551.372431378577;12700.428480718205;12842.743145136857;11555.711107222387;11686.18196726221;12053.51785928553;12075.154739168525;12772.48910043625;12303.815442768544;12327.50689972391;12383.566575170185;12465.5013799447;12617.87382126167;10708.946455267675;10914.399708016135;10944.890551094706;11073.144901038244;11472.31166130035;11044.282121662067;11110.61112861046;11146.554137834395;11199.496022679163;11274.267172633752 16:18:15 INFO - PROCESS | 3689 | __end_tp_report 16:18:15 INFO - PROCESS | 3689 | __start_cc_report 16:18:15 INFO - PROCESS | 3689 | _x_x_mozilla_cycle_collect,824 16:18:15 INFO - PROCESS | 3689 | __end_cc_report 16:18:15 INFO - PROCESS | 3689 | __startTimestamp1458429495124__endTimestamp 16:18:15 INFO - PROCESS | 3689 | 16:18:15 INFO - PROCESS | 3689 | ------- Summary: start ------- 16:18:15 INFO - PROCESS | 3689 | Number of tests: 6 16:18:15 INFO - PROCESS | 3689 | 16:18:15 INFO - PROCESS | 3689 | [#0] dojo.html Cycles:165 Average:5217.39 Median:5416.21 stddev:592.63 (10.9%) stddev-sans-first:569.32 16:18:15 INFO - PROCESS | 3689 | Values: 3040.6 3058.9 3063.4 3106.1 3134.5 5110.7 5236.9 5254.6 5269.3 5307.3 5246.4 5323.5 5334.1 5355.1 5390.9 4708.4 4716.7 4723.0 4724.1 4825.3 4768.1 4773.8 4797.5 4819.5 4860.2 4674.9 4751.4 4757.1 4783.4 4820.8 4705.9 4706.0 4716.9 4724.1 4740.5 4642.1 4702.6 4705.7 4727.3 4754.9 5204.9 5223.0 5242.0 5271.1 5290.7 5507.3 5516.4 5529.6 5530.1 5544.4 5399.9 5548.9 5559.5 5578.3 5623.9 5204.3 5219.3 5221.6 5246.3 5262.1 5701.8 5710.2 5716.6 5716.7 5720.4 5280.0 5447.8 5488.8 5501.3 5505.8 5628.0 5629.5 5635.0 5648.2 5651.6 5568.7 5593.0 5599.6 5611.8 5624.7 5430.6 5504.0 5538.6 5582.7 5602.5 4271.6 4277.0 4277.8 4285.5 4312.9 3801.5 3830.8 3833.7 3855.4 3868.4 5117.5 5327.2 5383.6 5416.2 5441.1 5732.2 5734.7 5736.0 5742.5 5761.2 5088.7 5439.7 5453.0 5457.7 5460.4 4932.9 4949.1 4951.3 4991.4 4999.2 5890.9 5904.3 5906.0 5913.8 5917.2 5568.5 5696.4 5702.2 5709.8 5726.2 5858.3 5862.1 5862.3 5867.3 5896.1 5558.6 5565.3 5572.2 5572.4 5573.8 5538.9 5644.0 5669.1 5671.4 5725.0 5474.9 5486.7 5489.3 5492.0 5547.8 5412.1 5416.0 5416.9 5420.4 5464.3 5202.9 5266.2 5278.8 5300.0 5374.9 5492.3 5500.9 5509.4 5511.4 5521.4 5332.7 5395.0 5395.9 5396.5 5444.3 16:18:15 INFO - PROCESS | 3689 | 16:18:15 INFO - PROCESS | 3689 | [#1] ext.html Cycles:180 Average:50012.74 Median:38804.11 stddev:86103.58 (221.9%) stddev-sans-first:86265.01 16:18:15 INFO - PROCESS | 3689 | Values: 544.1 561.0 566.6 585.6 590.1 29858.4 30297.0 38783.0 39050.8 39253.0 41853.6 42431.0 42455.4 42491.8 42555.1 8655.8 8850.4 8852.2 8853.9 8859.1 8510.6 8660.3 8660.8 8662.6 8671.2 8671.5 8736.7 8821.5 8914.0 8939.9 8787.6 8854.0 8872.6 8873.3 8880.1 8842.0 8943.0 8960.7 8970.1 8973.6 41464.8 41782.6 41788.6 41902.6 41921.8 3173.3 3291.5 3410.1 3633.7 3803.5 31258.7 31719.5 31886.0 32048.5 32075.2 3191.3 3202.7 3240.4 3245.6 3267.2 306398.0 308526.0 315207.0 316036.0 316754.4 52251.0 58799.0 59661.7 59793.0 59887.0 64218.4 65092.3 65532.7 65534.3 65575.3 14282.5 14390.4 14399.3 14460.9 14543.4 9933.3 10127.9 10731.4 10867.4 10891.7 19622.6 19950.2 20200.5 20269.0 20304.0 7477.7 7557.9 7605.8 7650.8 7726.9 996.6 1016.2 1074.9 1121.2 1217.0 31989.2 32249.0 32680.7 32703.7 32746.0 1117.7 1141.3 1146.3 1149.2 1160.8 16431.2 16615.6 16672.7 16799.1 16877.6 387336.0 391677.0 393759.2 394014.0 394456.0 56307.2 56743.4 56790.0 56796.4 56810.0 1235.3 1257.9 1376.0 1377.3 1382.9 28406.7 31216.0 31236.2 31783.8 32040.0 47259.8 47367.0 47762.0 47788.5 47804.3 265508.0 266212.0 267897.0 267911.0 268917.0 29419.3 34156.3 36476.6 37035.8 37124.6 45139.3 45483.0 45614.8 46017.8 46793.1 38624.4 38753.0 39182.6 39616.0 40656.6 38110.8 38514.0 38825.2 39121.8 39252.6 39645.4 40529.4 40775.0 40913.2 40981.2 33782.7 34763.8 34855.8 35392.5 35471.0 27374.6 27575.9 27663.5 27694.2 27902.4 16:18:15 INFO - PROCESS | 3689 | 16:18:15 INFO - PROCESS | 3689 | [#2] jquery.html Cycles:180 Average:27882.19 Median:19484.64 stddev:79705.54 (409.1%) stddev-sans-first:79902.36 16:18:15 INFO - PROCESS | 3689 | Values: 368.7 371.8 371.9 376.5 381.7 17732.7 18488.9 18736.3 19092.3 19144.8 17289.5 17437.7 18141.5 18165.0 18202.6 5459.4 5631.7 5635.3 5666.3 5697.6 4070.7 5565.8 6006.8 6222.1 6222.6 6148.5 6191.2 6214.4 6215.3 6216.4 5966.2 6085.8 6123.1 6140.2 6148.5 3645.5 5273.3 5337.2 5470.7 5481.6 21208.7 21253.3 21313.6 22972.5 23028.9 2342.3 2357.1 2397.7 2399.9 2516.6 14049.6 14093.2 14166.0 14314.6 14435.4 1977.4 2017.3 2050.5 2051.2 2064.8 67445.3 70205.0 70540.9 70578.0 71878.6 10426.1 10492.8 10701.4 10810.4 10963.8 13806.7 13828.7 13886.8 13896.2 13917.1 7729.8 7939.5 7944.0 8045.3 8067.9 7727.0 7772.3 7801.4 7920.2 7921.4 6465.0 6513.5 6530.9 6534.2 6550.3 1731.4 1793.4 1827.5 1830.8 1848.5 451.4 469.0 471.6 989.9 1097.9 11245.5 11482.4 11986.7 12124.8 12350.9 453.8 455.2 457.1 460.4 467.8 6353.6 6551.6 6622.2 6710.5 6756.8 470174.0 471031.0 483670.0 491810.0 506992.0 82899.0 85696.6 87296.0 87365.6 88719.6 499.2 1039.0 1077.1 1080.6 1082.4 16553.3 16741.2 17166.8 17332.5 17333.6 36875.8 38587.6 38590.6 39966.8 40683.4 54700.0 55031.0 55051.7 55131.4 55283.4 8252.0 8322.4 8368.9 8541.7 8572.1 9521.5 12959.0 13377.1 13412.2 13504.7 11318.4 11606.2 11911.5 11944.6 12039.3 10514.8 11346.7 11636.8 11708.1 11892.9 11687.2 11790.3 11816.3 12169.2 12559.4 8202.3 8505.9 8578.0 8593.8 8667.5 11055.1 11598.4 11749.7 11798.2 11830.2 16:18:15 INFO - PROCESS | 3689 | 16:18:15 INFO - PROCESS | 3689 | [#3] mootools.html Cycles:180 Average:5852.97 Median:5249.65 stddev:3119.10 (59.4%) stddev-sans-first:3109.43 16:18:15 INFO - PROCESS | 3689 | Values: 1343.6 1510.1 1515.0 1706.1 1837.3 7934.0 8144.5 8147.8 8152.3 8156.8 8014.5 8159.1 8164.0 8168.5 8177.2 1993.6 2034.1 2239.3 2280.6 2350.6 2268.4 2270.6 2271.6 2271.9 2272.3 2260.2 2280.9 2322.1 2322.1 2323.9 2279.4 2305.2 2305.6 2335.3 2349.4 2289.6 2302.4 2316.6 2321.0 2323.3 8311.1 8370.1 8374.5 8375.2 8379.0 5105.1 5241.7 5257.6 5264.8 5272.4 3333.3 3376.2 3383.4 3405.0 3407.9 1033.9 1045.7 1045.8 1048.1 1059.3 11799.1 11896.2 11900.5 11901.8 11906.5 4684.7 4798.0 4828.8 4833.7 4841.5 9877.5 10085.5 10128.8 10132.0 10142.1 5230.5 5277.4 5281.9 5288.0 5294.4 4048.5 4636.4 4679.0 4724.4 4746.8 3889.9 3983.9 3987.1 4007.8 4034.9 1256.5 1260.1 1262.8 1270.4 1270.9 1344.5 1378.4 1391.9 1393.8 1428.1 7702.0 7861.3 7871.6 7889.1 7890.2 496.2 498.3 499.2 501.1 507.1 6215.8 6223.3 6265.5 6346.0 6346.1 10211.8 10375.4 10511.2 10546.4 10549.3 9597.5 10347.7 10349.5 10377.6 10424.3 7732.6 7757.9 7898.5 7920.6 7921.8 7758.0 7764.0 7844.2 8007.8 8019.3 8587.0 9029.8 9117.8 9358.3 9418.6 8955.1 9094.2 9207.3 9252.6 9266.4 6038.9 7083.1 7273.3 7297.1 7408.7 7848.2 7864.3 7869.8 7894.6 7914.6 6977.4 7159.6 7200.3 7258.0 7300.0 7109.0 7112.0 7164.0 7197.5 7228.5 7359.8 7651.9 7653.1 7665.3 7677.4 7076.4 7101.3 7104.0 7105.9 7120.9 6913.0 7071.6 7073.4 7085.9 7124.3 16:18:15 INFO - PROCESS | 3689 | 16:18:15 INFO - PROCESS | 3689 | [#4] prototype.html Cycles:180 Average:5287.22 Median:5988.48 stddev:1608.15 (26.9%) stddev-sans-first:1569.27 16:18:15 INFO - PROCESS | 3689 | Values: 343.3 344.3 344.3 350.4 356.4 5886.0 5944.7 5947.6 5950.3 5983.2 5854.9 5902.0 5931.9 5936.5 5947.3 4332.9 4465.9 4547.4 4579.5 4583.4 4562.3 4570.9 4598.4 4608.9 4618.5 4555.4 4557.5 4568.3 4576.3 4582.5 4317.5 4431.6 4514.5 4515.3 4531.7 4012.4 4013.9 4014.9 4022.0 4028.6 5722.8 5732.4 5733.7 5734.6 5737.7 5300.4 5305.7 5309.8 5310.8 5311.9 6230.5 6245.9 6246.8 6247.5 6249.2 4161.1 4283.1 4284.2 4475.1 4476.9 6533.1 6551.6 6593.2 6606.0 6664.5 4443.6 4450.7 4452.0 4452.3 4464.8 4502.1 4502.9 4504.2 4506.1 4506.6 5209.2 5214.5 5219.6 5222.2 5223.1 6074.5 6350.1 6354.8 6361.9 6362.2 1563.4 1577.5 1588.7 1589.6 1590.2 963.7 987.9 1037.2 1055.1 1066.9 5935.7 5936.3 5993.8 6169.7 6170.4 6551.4 6558.7 6562.3 6564.7 6576.9 6094.8 6099.3 6105.9 6106.1 6106.9 3477.3 3513.5 3519.0 3522.2 3523.3 6552.4 6754.1 6775.9 6786.6 6815.7 6668.1 6712.8 6727.1 6735.1 6736.1 6787.7 6792.8 6804.3 6804.3 6808.3 6537.7 6543.5 6552.0 6603.9 6615.2 6307.3 6464.6 6492.5 6496.5 6540.2 6806.9 6814.4 6829.5 6837.5 6842.3 4340.8 4373.1 4373.2 4373.9 4380.6 6511.8 6554.2 6557.0 6567.8 6586.1 6380.9 6381.0 6386.9 6390.6 6392.4 6176.0 6352.1 6355.1 6368.8 6371.5 6171.3 6182.6 6188.2 6189.8 6192.7 6384.6 6402.0 6404.8 6413.3 6413.8 5961.6 6034.9 6253.8 6258.7 6259.8 16:18:15 INFO - PROCESS | 3689 | 16:18:15 INFO - PROCESS | 3689 | [#5] yui.html Cycles:180 Average:15263.36 Median:25864.48 stddev:17862.94 (69.1%) stddev-sans-first:17879.99 16:18:15 INFO - PROCESS | 3689 | Values: 791.3 826.9 833.6 839.3 866.7 14668.1 14869.3 14911.3 14948.6 14968.7 13758.9 14471.4 14492.5 14519.3 14537.2 662.5 825.8 829.9 840.9 847.0 846.3 846.9 847.5 853.7 853.8 877.3 884.1 884.1 885.1 885.3 694.7 705.9 866.8 873.1 887.4 640.3 642.2 642.3 648.5 651.9 14716.9 14793.9 14794.8 14803.9 14819.1 14050.2 14617.8 14665.8 14738.3 14746.3 11243.0 11611.5 11629.9 11720.6 11792.8 3814.4 3840.9 3866.9 3892.8 3980.0 52170.2 53019.0 53966.5 54689.5 55061.3 10960.8 11040.2 11048.6 11213.9 11349.2 17951.5 17967.9 17979.6 18010.0 18270.5 7963.4 8013.6 8160.5 8167.1 8508.6 4740.2 4764.1 4771.7 4784.8 4817.8 3403.4 3457.3 3469.1 3472.7 3483.2 616.6 622.6 622.7 640.5 643.5 584.0 671.7 730.8 742.4 757.0 9340.9 9566.2 9600.0 9605.7 9723.6 566.2 658.4 662.1 664.7 700.7 4321.4 4360.7 4543.3 4547.8 4612.7 60941.0 63480.0 64131.4 65222.0 65763.7 55742.7 55899.0 56902.4 58051.7 58816.4 51097.2 52007.0 52267.5 52389.0 52850.2 8730.3 8916.8 9009.8 9017.1 9048.5 38654.8 39074.4 39552.2 39585.2 40988.0 46988.8 50878.7 50960.2 51323.0 51560.7 11631.7 11830.0 11857.3 11957.5 12021.4 12048.0 12442.9 12652.2 12695.9 12704.6 10840.4 12500.4 12551.4 12700.4 12842.7 11555.7 11686.2 12053.5 12075.2 12772.5 12303.8 12327.5 12383.6 12465.5 12617.9 10708.9 10914.4 10944.9 11073.1 11472.3 11044.3 11110.6 11146.6 11199.5 11274.3 16:18:15 INFO - PROCESS | 3689 | -------- Summary: end -------- 16:18:15 INFO - PROCESS | 3689 | 16:18:15 INFO - TEST-INFO | 3689: exit 0 16:18:15 INFO - TEST-OK | dromaeo_css | took 1111661ms 16:18:15 INFO - TEST-START | kraken 16:18:15 INFO - operating with platform_type : linux_ 16:18:15 INFO - Initialising browser for kraken test... 16:18:15 INFO - TEST-INFO | started process 3870 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcbrjo3/profile http://localhost:41858/getInfo.html) 16:18:20 INFO - PROCESS | 3870 | __metrics Screen width/height:1600/1200 16:18:20 INFO - PROCESS | 3870 | colorDepth:24 16:18:20 INFO - PROCESS | 3870 | Browser inner width/height: 1024/697 16:18:20 INFO - PROCESS | 3870 | __metrics 16:18:20 ERROR - PROCESS | 3870 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:18:21 INFO - TEST-INFO | 3870: exit 0 16:18:21 INFO - Browser initialized. 16:18:21 INFO - Running cycle 1/1 for kraken test... 16:18:21 INFO - TEST-INFO | started process 3953 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcbrjo3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:33 INFO - PROCESS | 3953 | RSS: Main: 155963392 16:18:33 INFO - PROCESS | 3953 | 16:18:36 INFO - PROCESS | 3953 | Cycle 1(1): loaded http://localhost:41858/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41858/tests/kraken/driver.html?testName=audio-beat-detection) 16:18:36 INFO - PROCESS | 3953 | RSS: Main: 198914048 16:18:36 INFO - PROCESS | 3953 | 16:18:39 INFO - PROCESS | 3953 | Cycle 1(1): loaded http://localhost:41858/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41858/tests/kraken/driver.html?testName=audio-dft) 16:18:39 INFO - PROCESS | 3953 | RSS: Main: 186068992 16:18:39 INFO - PROCESS | 3953 | 16:18:42 INFO - PROCESS | 3953 | Cycle 1(1): loaded http://localhost:41858/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41858/tests/kraken/driver.html?testName=audio-fft) 16:18:43 INFO - PROCESS | 3953 | RSS: Main: 171888640 16:18:43 INFO - PROCESS | 3953 | 16:18:45 INFO - PROCESS | 3953 | Cycle 1(1): loaded http://localhost:41858/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41858/tests/kraken/driver.html?testName=audio-oscillator) 16:18:45 INFO - PROCESS | 3953 | RSS: Main: 173166592 16:18:45 INFO - PROCESS | 3953 | 16:18:48 INFO - PROCESS | 3953 | Cycle 1(1): loaded http://localhost:41858/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41858/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:18:48 INFO - PROCESS | 3953 | RSS: Main: 176009216 16:18:48 INFO - PROCESS | 3953 | 16:18:51 INFO - PROCESS | 3953 | Cycle 1(1): loaded http://localhost:41858/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41858/tests/kraken/driver.html?testName=imaging-darkroom) 16:18:52 INFO - PROCESS | 3953 | RSS: Main: 176750592 16:18:52 INFO - PROCESS | 3953 | 16:18:55 INFO - PROCESS | 3953 | Cycle 1(1): loaded http://localhost:41858/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41858/tests/kraken/driver.html?testName=imaging-desaturate) 16:18:56 INFO - PROCESS | 3953 | RSS: Main: 177426432 16:18:56 INFO - PROCESS | 3953 | 16:18:59 INFO - PROCESS | 3953 | Cycle 1(1): loaded http://localhost:41858/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41858/tests/kraken/driver.html?testName=json-parse-financial) 16:18:59 INFO - PROCESS | 3953 | RSS: Main: 177512448 16:18:59 INFO - PROCESS | 3953 | 16:19:01 INFO - PROCESS | 3953 | Cycle 1(1): loaded http://localhost:41858/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41858/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:19:01 INFO - PROCESS | 3953 | RSS: Main: 187228160 16:19:01 INFO - PROCESS | 3953 | 16:19:03 INFO - PROCESS | 3953 | Cycle 1(1): loaded http://localhost:41858/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41858/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:19:04 INFO - PROCESS | 3953 | RSS: Main: 185622528 16:19:04 INFO - PROCESS | 3953 | 16:19:06 INFO - PROCESS | 3953 | Cycle 1(1): loaded http://localhost:41858/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41858/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:19:06 INFO - PROCESS | 3953 | RSS: Main: 194453504 16:19:06 INFO - PROCESS | 3953 | 16:19:09 INFO - PROCESS | 3953 | Cycle 1(1): loaded http://localhost:41858/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:19:09 INFO - PROCESS | 3953 | RSS: Main: 199737344 16:19:09 INFO - PROCESS | 3953 | 16:19:12 INFO - PROCESS | 3953 | Cycle 1(1): loaded http://localhost:41858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:19:12 INFO - PROCESS | 3953 | RSS: Main: 199753728 16:19:12 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | Cycle 1(1): loaded http://localhost:41858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41858/tests/kraken/driver.html?testName=ai-astar) 16:19:14 INFO - PROCESS | 3953 | RSS: Main: 258502656 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | __start_tp_report 16:19:14 INFO - PROCESS | 3953 | _x_x_mozilla_page_load 16:19:14 INFO - PROCESS | 3953 | _x_x_mozilla_page_load_details 16:19:14 INFO - PROCESS | 3953 | |i|pagename|runs| 16:19:14 INFO - PROCESS | 3953 | |0;ai-astar;108;110;107;111;109;110;98;109;109;109 16:19:14 INFO - PROCESS | 3953 | |1;audio-beat-detection;155;131;149;170;123;149;154;121;178;127 16:19:14 INFO - PROCESS | 3953 | |2;audio-dft;161;160;161;161;161;162;160;164;163;162 16:19:14 INFO - PROCESS | 3953 | |3;audio-fft;72;75;100;95;72;72;76;118;94;72 16:19:14 INFO - PROCESS | 3953 | |4;audio-oscillator;91;94;138;92;93;93;147;92;93;135 16:19:14 INFO - PROCESS | 3953 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;116;117 16:19:14 INFO - PROCESS | 3953 | |6;imaging-darkroom;145;145;145;145;145;145;146;145;146;145 16:19:14 INFO - PROCESS | 3953 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;94 16:19:14 INFO - PROCESS | 3953 | |8;json-parse-financial;56;55;57;55;55;55;54;64;54;52 16:19:14 INFO - PROCESS | 3953 | |9;json-stringify-tinderbox;60;61;60;60;61;60;60;60;60;61 16:19:14 INFO - PROCESS | 3953 | |10;stanford-crypto-aes;78;78;87;80;78;80;79;79;79;78 16:19:14 INFO - PROCESS | 3953 | |11;stanford-crypto-ccm;109;114;117;117;109;109;114;115;121;109 16:19:14 INFO - PROCESS | 3953 | |12;stanford-crypto-pbkdf2;141;141;140;140;149;139;140;139;140;148 16:19:14 INFO - PROCESS | 3953 | |13;stanford-crypto-sha256-iterative;65;65;65;64;68;67;69;64;64;66 16:19:14 INFO - PROCESS | 3953 | __end_tp_report 16:19:14 INFO - PROCESS | 3953 | __start_cc_report 16:19:14 INFO - PROCESS | 3953 | _x_x_mozilla_cycle_collect,1060 16:19:14 INFO - PROCESS | 3953 | __end_cc_report 16:19:14 INFO - PROCESS | 3953 | __startTimestamp1458429554612__endTimestamp 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | ------- Summary: start ------- 16:19:14 INFO - PROCESS | 3953 | Number of tests: 14 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | [#0] ai-astar Cycles:10 Average:108.00 Median:109.50 stddev:3.68 (3.4%) stddev-sans-first:3.91 16:19:14 INFO - PROCESS | 3953 | Values: 108.0 110.0 107.0 111.0 109.0 110.0 98.0 109.0 109.0 109.0 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:151.50 stddev:19.73 (13.0%) stddev-sans-first:20.63 16:19:14 INFO - PROCESS | 3953 | Values: 155.0 131.0 149.0 170.0 123.0 149.0 154.0 121.0 178.0 127.0 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.27 (0.8%) stddev-sans-first:1.33 16:19:14 INFO - PROCESS | 3953 | Values: 161.0 160.0 161.0 161.0 161.0 162.0 160.0 164.0 163.0 162.0 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | [#3] audio-fft Cycles:10 Average:84.60 Median:73.50 stddev:16.16 (22.0%) stddev-sans-first:16.48 16:19:14 INFO - PROCESS | 3953 | Values: 72.0 75.0 100.0 95.0 72.0 72.0 76.0 118.0 94.0 72.0 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:92.50 stddev:23.11 (25.0%) stddev-sans-first:23.80 16:19:14 INFO - PROCESS | 3953 | Values: 91.0 94.0 138.0 92.0 93.0 93.0 147.0 92.0 93.0 135.0 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:19:14 INFO - PROCESS | 3953 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 16:19:14 INFO - PROCESS | 3953 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 16:19:14 INFO - PROCESS | 3953 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:3.20 (5.8%) stddev-sans-first:3.39 16:19:14 INFO - PROCESS | 3953 | Values: 56.0 55.0 57.0 55.0 55.0 55.0 54.0 64.0 54.0 52.0 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 16:19:14 INFO - PROCESS | 3953 | Values: 60.0 61.0 60.0 60.0 61.0 60.0 60.0 60.0 60.0 61.0 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:2.72 (3.4%) stddev-sans-first:2.82 16:19:14 INFO - PROCESS | 3953 | Values: 78.0 78.0 87.0 80.0 78.0 80.0 79.0 79.0 79.0 78.0 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | [#11] stanford-crypto-ccm Cycles:10 Average:113.40 Median:114.50 stddev:4.27 (3.7%) stddev-sans-first:4.23 16:19:14 INFO - PROCESS | 3953 | Values: 109.0 114.0 117.0 117.0 109.0 109.0 114.0 115.0 121.0 109.0 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.70 Median:140.50 stddev:3.65 (2.6%) stddev-sans-first:3.87 16:19:14 INFO - PROCESS | 3953 | Values: 141.0 141.0 140.0 140.0 149.0 139.0 140.0 139.0 140.0 148.0 16:19:14 INFO - PROCESS | 3953 | 16:19:14 INFO - PROCESS | 3953 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.50 stddev:1.77 (2.7%) stddev-sans-first:1.86 16:19:14 INFO - PROCESS | 3953 | Values: 65.0 65.0 65.0 64.0 68.0 67.0 69.0 64.0 64.0 66.0 16:19:14 INFO - PROCESS | 3953 | -------- Summary: end -------- 16:19:14 INFO - PROCESS | 3953 | 16:19:15 INFO - TEST-INFO | 3953: exit 0 16:19:15 INFO - TEST-OK | kraken | took 59854ms 16:19:15 INFO - SUITE-END | took 1171s 16:19:15 INFO - Completed test suite (00:19:31) 16:19:15 INFO - javascript benchmark 16:19:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3040.6047213862194, 3058.9235269118285, 3063.4026364858832, 3106.068179546137, 3134.5298205269205, 5110.693358398498, 5236.895262094756, 5254.57963362931, 5269.2886460327845, 5307.2569840222395, 5246.396664383597, 5323.520883120518, 5334.066538355792, 5355.08963476209, 5390.865228369293, 4708.364370809931, 4716.716996980175, 4722.97638511807, 4724.078804633098, 4825.252085926687, 4768.070226305872, 4773.832915847946, 4797.520247975192, 4819.4939531349055, 4860.222364421693, 4674.883127921795, 4751.358566593518, 4757.0723708876785, 4783.4499032611175, 4820.758962051884, 4705.9294110588025, 4706.035262771158, 4716.882077948045, 4724.126036683225, 4740.454847692525, 4642.117997580449, 4702.6473014524045, 4705.694129881581, 4727.267273572567, 4754.857354279377, 5204.9219261711105, 5222.97388513055, 5242.030224408497, 5271.130263506517, 5290.656107353048, 5507.284053073115, 5516.448355164492, 5529.585281103933, 5530.142827861688, 5544.390117087117, 5399.865003374908, 5548.91676624851, 5559.471850174227, 5578.330600327987, 5623.9437605623825, 5204.297419848348, 5219.269302297681, 5221.55616772571, 5246.291750613656, 5262.05283049051, 5701.800436984686, 5710.172025056344, 5716.628419152742, 5716.742746576414, 5720.42795720433, 5279.973600131974, 5447.836564903059, 5488.835334939959, 5501.284832971768, 5505.834824955257, 5627.971860140673, 5629.549636029108, 5634.971825140848, 5648.181013752983, 5651.576131790132, 5568.6658800472105, 5592.97203513988, 5599.636023658449, 5611.7755289788765, 5624.71876406178, 5430.647007944471, 5504.0, 5538.6399884007415, 5582.720863956867, 5602.467765562265, 4271.636910862611, 4277.0, 4277.828886844553, 4285.4648407293525, 4312.935305970413, 3801.5058042454857, 3830.8467661293234, 3833.6549710526187, 3855.4216867469545, 3868.400397938324, 5117.513836185556, 5327.200919862052, 5383.569314454834, 5416.214648875891, 5441.129419292894, 5732.197492351074, 5734.655920644775, 5735.967525845304, 5742.511886489695, 5761.193432919395, 5088.720120393414, 5439.728013599304, 5453.047364610154, 5457.727113644302, 5460.399356070829, 4932.8520144395725, 4949.084419382426, 4951.282064100686, 4991.425986011583, 4999.150144475448, 5890.911636325459, 5904.321003084614, 5906.0, 5913.793017244462, 5917.171595976567, 5568.526675232651, 5696.401877802854, 5702.2016917630735, 5709.8287051388525, 5726.169705392778, 5858.326292476249, 5862.149988251765, 5862.296524417097, 5867.32525759526, 5896.086106653304, 5558.555315574825, 5565.276514053147, 5572.247746554325, 5572.442755724557, 5573.7770489179975, 5538.86152846166, 5644.0, 5669.092945128759, 5671.376148623731, 5724.971375143097, 5474.945250547444, 5486.670799752028, 5489.313835770528, 5491.956528259778, 5547.7780888764, 5412.052890744183, 5416.0, 5416.901731910819, 5420.403755586961, 5464.262324586289, 5202.921956170585, 5266.210068489757, 5278.841634750964, 5299.973500132474, 5374.865628359323, 5492.340919089735, 5500.9174862377895, 5509.3664228614225, 5511.448855114457, 5521.420250873601, 5332.733363331896, 5395.028894798974, 5395.865103372447, 5396.487333703292, 5444.292242008513], "unit": "score", "name": "dojo.html", "value": 5177.7429779280865}, {"lowerIsBetter": false, "replicates": [544.103031496604, 561.0378201384627, 566.603377635655, 585.5900869391422, 590.1325052173305, 29858.402831943375, 30297.0, 38783.0, 39050.80474597623, 39253.0, 41853.58146418535, 42431.0, 42455.36316955248, 42491.78754106225, 42555.14889702204, 8655.783605409852, 8850.424722393023, 8852.203301702846, 8853.911460885405, 8859.114088591154, 8510.617022234015, 8660.307175425982, 8660.783480412978, 8662.566871656423, 8671.219590236877, 8671.479711217347, 8736.737897863075, 8821.470711757314, 8913.955430222839, 8939.865902011476, 8787.560621968907, 8853.955730221373, 8872.600732967032, 8873.334499912533, 8880.06759290275, 8842.027376988526, 8943.0, 8960.731178064669, 8970.147835955573, 8973.596188171483, 41464.79267603643, 41782.582174178475, 41788.58211417908, 41902.580974190176, 41921.79039104785, 3173.254285242966, 3291.4569096099117, 3410.113370523657, 3633.6729694327373, 3803.5435747710176, 31258.687413125805, 31719.52420713691, 31886.0, 32048.523575368887, 32075.198120046953, 3191.345774116324, 3202.727768139711, 3240.4491236489853, 3245.5618491503583, 3267.18320419895, 306398.0, 308526.0, 315207.0, 316036.0, 316754.4162279197, 52251.0, 58799.0, 59661.70169149127, 59793.0, 59887.0, 64218.35781642124, 65092.34907650863, 65532.67233663896, 65534.344656553774, 65575.34424655788, 14282.500112496013, 14390.42438302477, 14399.280035998368, 14460.927695361455, 14543.41826326935, 9933.304668673269, 10127.898721012843, 10731.40977246259, 10867.40229287381, 10891.727706807234, 19622.62641615073, 19950.20199192045, 20200.49498762543, 20269.0, 20304.0, 7477.7008919643695, 7557.886631700529, 7605.809854753676, 7650.8087297818, 7726.922730772732, 996.6262651505685, 1016.1515134862325, 1074.887136850635, 1121.2145330096662, 1216.9574064907686, 31989.200269993435, 32249.0, 32680.673193268238, 32703.672963270063, 32746.0, 1117.692634525512, 1141.3209140561353, 1146.3007565385108, 1149.1955631058293, 1160.7968605494004, 16431.1784410779, 16615.584610384838, 16672.749908751135, 16799.09985263076, 16877.578060548338, 387336.0, 391677.0, 393759.15602110175, 394014.0, 394456.0, 56307.15539266914, 56743.432565674644, 56790.0, 56796.43203567994, 56810.0, 1235.32057368447, 1257.937103144839, 1375.9724805504034, 1377.2906952919254, 1382.8617138286293, 28406.715932841234, 31216.0, 31236.245502497426, 31783.84108079445, 32040.0, 47259.76370118265, 47367.0, 47762.0, 47788.5221147798, 47804.28293575669, 265508.0, 266212.0, 267897.0, 267911.0, 268917.0, 29419.264518386357, 34156.31687366189, 36476.63523364838, 37035.81482092572, 37124.62875371212, 45139.32291015703, 45483.0, 45614.77192614148, 46017.76991115023, 46793.06413871772, 38624.42063368995, 38753.0, 39182.6081739179, 39616.0, 40656.59343406646, 38110.80944595259, 38514.0, 38825.223495530496, 39121.804390979, 39252.60747392604, 39645.405318919664, 40529.392059118545, 40775.0, 40913.1817363657, 40981.1803763929, 33782.662173378936, 34763.826180869946, 34855.82572087123, 35392.46911296281, 35471.0, 27374.5893811589, 27575.862120689268, 27663.450644119443, 27694.169174924784, 27902.44195116127], "unit": "score", "name": "ext.html", "value": 19125.933317661737}, {"lowerIsBetter": false, "replicates": [368.7400382730175, 371.77879161898693, 371.90390003223155, 376.5199370802227, 381.66222892739916, 17732.73400898986, 18488.90755546222, 18736.344227952042, 19092.33176838811, 19144.808551914477, 17289.48131556055, 17437.651246975052, 18141.546461338472, 18165.0, 18202.635947281047, 5459.426760190173, 5631.7184140793, 5635.267415236013, 5666.320041594994, 5697.6011679182475, 4070.715049946505, 5565.805196818113, 6006.849828754294, 6222.0666899965145, 6222.595531290474, 6148.477379422754, 6191.226096737908, 6214.440700336969, 6215.254169499666, 6216.378362163793, 5966.224390829165, 6085.817425477243, 6123.112148738408, 6140.171076904628, 6148.508119350464, 3645.5078564393734, 5273.314469119028, 5337.226102215157, 5470.7264636768405, 5481.588880833953, 21208.681869771965, 21253.256136035165, 21313.57372852534, 22972.54054918892, 23028.884855575783, 2342.320726989171, 2357.0571771291447, 2397.724261709891, 2399.928002159938, 2516.6225066240027, 14049.578512644637, 14093.224872632001, 14166.0, 14314.570562883026, 14435.350409231505, 1977.3968939473455, 2017.2939471185114, 2050.5181282398626, 2051.200031987526, 2064.834813214939, 67445.32554674489, 70205.0, 70540.94188587226, 70578.0, 71878.64060679663, 10426.113780328606, 10492.842607360895, 10701.411422371688, 10810.35137891729, 10963.83554246687, 13806.723865522834, 13828.723425531432, 13886.77811550147, 13896.16623002623, 13917.095388799695, 7729.768106956801, 7939.523628582304, 7943.960280198562, 8045.275925166763, 8067.919320806835, 7726.9613651932505, 7772.300492955661, 7801.393676082584, 7920.207979202034, 7921.405894557931, 6465.0, 6513.544051916415, 6530.902036469457, 6534.183227096613, 6550.3449655035065, 1731.4201839259413, 1793.390247315919, 1827.4976958068662, 1830.8077651846631, 1848.5286252005922, 451.3703383779609, 468.9882752931204, 471.6085648911395, 989.8663680403054, 1097.9121670266359, 11245.493952771982, 11482.425878706032, 11986.700332491757, 12124.75750485003, 12350.938245308716, 453.82981381981756, 455.17158771036395, 457.1246063787876, 460.3715927758652, 467.7544289248104, 6353.618782873043, 6551.639659818756, 6622.238442579069, 6710.463162946952, 6756.83107922296, 470174.0, 471031.0278280556, 483670.0, 491810.0, 506992.0, 82899.0, 85696.57151714202, 87296.0, 87365.56317218373, 88719.55640221758, 499.17885079044765, 1038.984415233772, 1077.095239998405, 1080.6001779341693, 1082.3614067699937, 16553.255103520612, 16741.162941852614, 17166.828331716522, 17332.480025599252, 17333.56666083358, 36875.81562092173, 38587.6141238584, 38590.614093858705, 39966.80016599898, 40683.389749154376, 54700.0, 55031.0, 55051.724741376034, 55131.44868551263, 55283.44716552783, 8252.0, 8322.378450787983, 8368.87446688288, 8541.701040463555, 8572.142785721378, 9521.523923803921, 12959.0, 13377.130486518734, 13412.195268283935, 13504.729905402033, 11318.377489238172, 11606.187566870576, 11911.463984120908, 11944.581939632071, 12039.277643341427, 10514.842277365693, 11346.716332091433, 11636.825447618123, 11708.063354931755, 11892.881071189177, 11687.240329378563, 11790.292582445081, 11816.291022538675, 12169.20900141488, 12559.372031398576, 8202.302804261466, 8505.91494085076, 8577.95711021441, 8593.785155370915, 8667.479951202948, 11055.05067896348, 11598.420078995847, 11749.706257343634, 11798.174127811315, 11830.231034982698], "unit": "score", "name": "jquery.html", "value": 8647.609287211053}, {"lowerIsBetter": false, "replicates": [1343.6036369271064, 1510.1316742872848, 1515.0379509011775, 1706.1213475060347, 1837.3293747782054, 7933.960330198348, 8144.470609410391, 8147.75556733299, 8152.347812175027, 8156.836863262731, 8014.4790588611695, 8159.061707903593, 8163.959180204106, 8168.469049511792, 8177.223163799445, 1993.6311782320245, 2034.0846619021424, 2239.3282015395357, 2280.646499792535, 2350.612148995414, 2268.3648578398074, 2270.625346817773, 2271.636538153896, 2271.852329598579, 2272.2501574480466, 2260.163739416418, 2280.851744636602, 2322.1175953137868, 2322.1175953137868, 2323.9070437182577, 2279.4495403692063, 2305.227748704178, 2305.6195727704994, 2335.2643917166038, 2349.42439102421, 2289.6336586146303, 2302.412884714387, 2316.5714342846627, 2320.953580928372, 2323.268170526279, 8311.085780564134, 8370.079291277954, 8374.49753014815, 8375.246227839463, 8378.958105209496, 5105.132127538291, 5241.68549887008, 5257.605679574047, 5264.815731449419, 5272.367315922075, 3333.2666813301034, 3376.1559610097474, 3383.441732114198, 3405.0465869556565, 3407.931841363159, 1033.8709197783628, 1045.7072019834459, 1045.7594753206804, 1048.09863517375, 1059.2796898109282, 11799.056075513938, 11896.226745261616, 11900.523979040829, 11901.761964760743, 11906.523739050428, 4684.718916864999, 4797.968436786107, 4828.758562071883, 4833.685810422311, 4841.467438581753, 9877.456739879231, 10085.49572521371, 10128.797424051625, 10132.0, 10142.087212150795, 5230.503102205284, 5277.393099793573, 5281.947180528223, 5288.0, 5294.41761406245, 4048.4939382577177, 4636.374089497875, 4679.0, 4724.385829842098, 4746.8101275948575, 3889.8638547651262, 3983.900402489961, 3987.142764305688, 4007.7996100194873, 4034.899127521777, 1256.4597223194114, 1260.0738457233927, 1262.7727009138443, 1270.3775150176348, 1270.9491620335268, 1344.522694443478, 1378.4348417148922, 1391.930403479822, 1393.7630602797549, 1428.1145689672262, 7701.961490192625, 7861.331786798072, 7871.645775940096, 7889.132195458495, 7890.210978902064, 496.1936852614501, 498.29988865643827, 499.20127795526867, 501.1230346892937, 507.0594048040905, 6215.81352559424, 6223.284322302902, 6265.498760099181, 6346.048092786119, 6346.143270658495, 10211.846822297672, 10375.429351385746, 10511.1591072714, 10546.367217966947, 10549.314294570828, 9597.47213903242, 10347.741306467247, 10349.482525873676, 10377.584896604203, 10424.32241904289, 7732.6133693315105, 7757.922420775946, 7898.526088434713, 7920.643571039317, 7921.841563168704, 7757.983460086492, 7764.0, 7844.176361481962, 8007.83984320322, 8019.278264956182, 8587.0, 9029.819403612022, 9117.772055698395, 9358.298127640319, 9418.57616407277, 8955.104489550993, 9094.226990705863, 9207.309451791276, 9252.583633736633, 9266.44401335922, 6038.879222415615, 7083.079199704005, 7273.272672732684, 7297.124345078624, 7408.6666100026705, 7848.2151784823345, 7864.331531819631, 7869.84260314779, 7894.565798881116, 7914.643841027283, 6977.406920411822, 7159.57042577447, 7200.315969982843, 7258.0, 7299.963500182677, 7108.964455177691, 7112.03987461686, 7163.964180179066, 7197.49617526789, 7228.4578656599915, 7359.8160045999275, 7651.885221721567, 7653.119891212582, 7665.310122088816, 7677.424193185645, 7076.398506127037, 7101.2898710128575, 7104.005439238614, 7105.9289407107335, 7120.857582848417, 6913.0, 7071.646417679199, 7073.434125269863, 7085.858282834418, 7124.287571243041], "unit": "score", "name": "mootools.html", "value": 4685.011652833821}, {"lowerIsBetter": false, "replicates": [343.328792211227, 344.28045385145043, 344.3423061951671, 350.3588433167301, 356.37812018028546, 5885.970570147154, 5944.702764861756, 5947.643141411519, 5950.345461999187, 5983.16235726998, 5854.941450585493, 5901.970490147543, 5931.88136237275, 5936.465718085371, 5947.286325640918, 4332.91334173318, 4465.866024019285, 4547.386102876102, 4579.519150489193, 4583.449986001668, 4562.338460923164, 4570.862874113782, 4598.448186217642, 4608.930866036995, 4618.5381461853885, 4555.430571178603, 4557.544245575449, 4568.314752787075, 4576.336431217472, 4582.450105987286, 4317.481902171744, 4431.645468362523, 4514.503404625489, 4515.277555591089, 4531.660125490602, 4012.4382586437923, 4013.8595149169637, 4014.9197016059807, 4021.97989010056, 4028.5971402859773, 5722.771089156428, 5732.426757324234, 5733.741981610838, 5734.569907256972, 5737.7131143443075, 5300.363956325227, 5305.681659100428, 5309.840704778863, 5310.8141215057285, 5311.920321195185, 6230.470410015154, 6245.937540624581, 6246.781362652286, 6247.468965137969, 6249.218847644044, 4161.126163505667, 4283.1433713257475, 4284.2074216269775, 4475.1049790042125, 4476.880779805048, 6533.052707357407, 6551.639659818708, 6593.175853018372, 6605.9669701651665, 6664.466842652528, 4443.577860103285, 4450.732956022649, 4451.955480445219, 4452.265376212888, 4464.843730469418, 4502.054568540578, 4502.887427814266, 4504.189245935763, 4506.053728717006, 4506.639468842484, 5209.244659524347, 5214.504622060898, 5219.634625576249, 5222.216667499905, 5223.085959956992, 6074.51403887688, 6350.142730731384, 6354.841128971812, 6361.9045714314325, 6362.236531616236, 1563.4137198550543, 1577.5030865277631, 1588.7219736546058, 1589.570815879706, 1590.2446337989363, 963.6627180486773, 987.8913319534845, 1037.1754455208127, 1055.1453322808395, 1066.914646828252, 5935.73289201987, 5936.287645482484, 5993.790217342372, 6169.691515424211, 6170.444659980623, 6551.4103730664465, 6558.704858281389, 6562.278149403562, 6564.7374105036215, 6576.86846263072, 6094.756209751649, 6099.329073801879, 6105.877882442326, 6106.145139680449, 6106.877862442726, 3477.2871561329866, 3513.508108864761, 3519.0, 3522.1546828761425, 3523.3129539739502, 6552.42741741988, 6754.088198093293, 6775.898361524581, 6786.59280443175, 6815.693293801791, 6668.066470694107, 6712.832179195461, 6727.058211850345, 6735.124433823572, 6736.124303840469, 6787.728490860409, 6792.762253321209, 6804.251532331538, 6804.298925268683, 6808.285130061371, 6537.7058032389605, 6543.509236807164, 6552.0, 6603.867922641424, 6615.206175258807, 6307.274663413767, 6464.612123272619, 6492.513061520499, 6496.545241833026, 6540.215174179129, 6806.8638627228165, 6814.352636499525, 6829.52193346461, 6837.453003759588, 6842.315768423118, 4340.761258130833, 4373.103513779731, 4373.212821691999, 4373.868783936487, 4380.6057454829215, 6511.804645860631, 6554.2462616797775, 6557.049227862029, 6567.770128045496, 6586.110875031809, 6380.9042864358, 6381.0, 6386.87226255463, 6390.648514331757, 6392.360763923571, 6176.0, 6352.110704501466, 6355.078513615407, 6368.840778980562, 6371.490280777434, 6171.259448866164, 6182.567220294536, 6188.164597779422, 6189.845253868509, 6192.659403732838, 6384.585001974857, 6402.0, 6404.807855764335, 6413.262474815456, 6413.807585772434, 5961.552883533839, 6034.909476357946, 6253.843653908689, 6258.718357674006, 6259.78090766821], "unit": "score", "name": "prototype.html", "value": 4764.584800862705}, {"lowerIsBetter": false, "replicates": [791.2680770287486, 826.8759686047092, 833.6373677450314, 839.2572573272654, 866.6663334616175, 14668.11991280524, 14869.256537173153, 14911.25443727812, 14948.551543453686, 14968.700625987474, 13758.931205343984, 14471.42114315426, 14492.492762753305, 14519.346629401676, 14537.200453975027, 662.4534758823966, 825.8430898129351, 829.9170082991712, 840.9032961209448, 847.0047693959573, 846.289117141601, 846.9026062002856, 847.4830353484369, 853.7481442974306, 853.8335024670192, 877.2674816528206, 884.0673089890163, 884.1158841158841, 885.1281487734608, 885.3404213860683, 694.6526736631685, 705.8552996635703, 866.8353012927523, 873.057098333798, 887.3566664168426, 640.276487569044, 642.2389468479867, 642.2581917884851, 648.4974145037586, 651.934806519349, 14716.926415367961, 14793.852061479354, 14794.778078328834, 14803.851961480355, 14819.110853348726, 14050.227237501933, 14617.78073328901, 14665.780013299809, 14738.263086845722, 14746.336414861249, 11243.0, 11611.535538578446, 11629.941850290694, 11720.648380548597, 11792.823107653392, 3814.3896976483907, 3840.9423858642144, 3866.8839934801717, 3892.766434013968, 3979.9602003980167, 52170.21744673833, 53019.0, 53966.46033539693, 54689.453105468834, 55061.31978781768, 10960.835587466194, 11040.171987101, 11048.558057677603, 11213.943930280297, 11349.205555611028, 17951.461456156074, 17967.910160449115, 17979.550511237325, 18010.0, 18270.54323641893, 7963.442559020813, 8013.639386227634, 8160.5103693778565, 8167.142450042778, 8508.574571271536, 4740.19416699162, 4764.094821983812, 4771.66598338113, 4784.832530861403, 4817.78319975602, 3403.387390269775, 3457.3085382923514, 3469.063352894704, 3472.70482009027, 3483.2162763378037, 616.6331033035336, 622.6450922973861, 622.6575383539035, 640.4620119099978, 643.469137961184, 583.9633903700689, 671.7279501801778, 730.7579500996659, 742.3726950726627, 756.9810754731176, 9340.859887101698, 9566.234701224024, 9599.952000239955, 9605.719859578217, 9723.562439690231, 566.2355819643531, 658.3646780856496, 662.1392190152782, 664.707528687376, 700.6531766775479, 4321.438213032348, 4360.738355698668, 4543.295789152687, 4547.75590433929, 4612.677112602086, 60941.0, 63480.0, 64131.35868641347, 65222.0, 65763.67118164379, 55742.72128639331, 55899.0, 56902.43097569054, 58051.70974145102, 58816.411835881096, 51097.233541496906, 52007.0, 52267.47732522626, 52388.95222095537, 52850.207246891325, 8730.301575874042, 8916.766565358635, 9009.774755631162, 9017.143371379709, 9048.457092574467, 38654.80672596619, 39074.413883791196, 39552.2089558213, 39585.2082958345, 40988.0, 46988.7650561745, 50878.74560627173, 50960.235596466824, 51323.0, 51560.74219629028, 11631.709207269885, 11829.962938089402, 11857.34784586856, 11957.521699131938, 12021.398930053287, 12048.036157107586, 12442.937785311016, 12652.186183301845, 12695.873041269839, 12704.618861434172, 10840.403777792297, 12500.437480313589, 12551.372431378577, 12700.428480718205, 12842.743145136857, 11555.711107222387, 11686.18196726221, 12053.51785928553, 12075.154739168525, 12772.48910043625, 12303.815442768544, 12327.50689972391, 12383.566575170185, 12465.5013799447, 12617.87382126167, 10708.946455267675, 10914.399708016135, 10944.890551094706, 11073.144901038244, 11472.31166130035, 11044.282121662067, 11110.61112861046, 11146.554137834395, 11199.496022679163, 11274.267172633752], "unit": "score", "name": "yui.html", "value": 6829.846086400935}], "name": "dromaeo_css", "value": 7122.635248244979}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 107.0, 111.0, 109.0, 110.0, 98.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [155.0, 131.0, 149.0, 170.0, 123.0, 149.0, 154.0, 121.0, 178.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 160.0, 164.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 100.0, 95.0, 72.0, 72.0, 76.0, 118.0, 94.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [91.0, 94.0, 138.0, 92.0, 93.0, 93.0, 147.0, 92.0, 93.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 57.0, 55.0, 55.0, 55.0, 54.0, 64.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.3}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 87.0, 80.0, 78.0, 80.0, 79.0, 79.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.6}, {"lowerIsBetter": true, "replicates": [109.0, 114.0, 117.0, 117.0, 109.0, 109.0, 114.0, 115.0, 121.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.4}, {"lowerIsBetter": true, "replicates": [141.0, 141.0, 140.0, 140.0, 149.0, 139.0, 140.0, 139.0, 140.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.7}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 64.0, 68.0, 67.0, 69.0, 64.0, 64.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.7}], "name": "kraken", "value": 1479.9}]} 16:19:15 INFO - Return code: 0 16:19:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:19:15 ERROR - # TBPL SUCCESS # 16:19:15 INFO - Running post-action listener: _resource_record_post_action 16:19:15 INFO - Running post-run listener: _resource_record_post_run 16:19:17 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 538382336; Read time: 0; Write time: 568880 16:19:17 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 242683904; Read time: 0; Write time: 345492 16:19:17 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 295448576; Read time: 0; Write time: 223388 16:19:17 INFO - Running post-run listener: _upload_blobber_files 16:19:17 INFO - Blob upload gear active. 16:19:17 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:19:17 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 16:19:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:19:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:19:17 INFO - (blobuploader) - INFO - Open directory for files ... 16:19:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:19:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:19:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:18 INFO - (blobuploader) - INFO - Done attempting. 16:19:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 16:19:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:19:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:18 INFO - (blobuploader) - INFO - Done attempting. 16:19:18 INFO - (blobuploader) - INFO - Iteration through files over. 16:19:18 INFO - Return code: 0 16:19:18 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:19:18 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:19:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c5df7e0f1f4c0648f1b7740c01f5057812ed54aa789a9d774658cefc0f2065888c1c5eb2ea4888899f4e53c5f1dca6265a277d230f513eb7c12966fc9dbf2f5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9b3ed1f1e22883080b630123079353df3dde32e7710982a9f51717918d8252d3e3addd1c8d99862f59f2d08cbfe4c0c5852fb609106b24f370ffd84260c6b0e6"} 16:19:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:19:18 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:19:18 INFO - Contents: 16:19:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c5df7e0f1f4c0648f1b7740c01f5057812ed54aa789a9d774658cefc0f2065888c1c5eb2ea4888899f4e53c5f1dca6265a277d230f513eb7c12966fc9dbf2f5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9b3ed1f1e22883080b630123079353df3dde32e7710982a9f51717918d8252d3e3addd1c8d99862f59f2d08cbfe4c0c5852fb609106b24f370ffd84260c6b0e6"} 16:19:18 INFO - Running post-run listener: copy_logs_to_upload_dir 16:19:18 INFO - Copying logs to upload dir... 16:19:18 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:19:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.414835 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-03-19 16:19:18.187568) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-19 16:19:18.191527) ========= 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=a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c5df7e0f1f4c0648f1b7740c01f5057812ed54aa789a9d774658cefc0f2065888c1c5eb2ea4888899f4e53c5f1dca6265a277d230f513eb7c12966fc9dbf2f5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9b3ed1f1e22883080b630123079353df3dde32e7710982a9f51717918d8252d3e3addd1c8d99862f59f2d08cbfe4c0c5852fb609106b24f370ffd84260c6b0e6"} build_url:https://queue.taskcluster.net/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/dY-ccSBGT-OYnpUYKf5y_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c5df7e0f1f4c0648f1b7740c01f5057812ed54aa789a9d774658cefc0f2065888c1c5eb2ea4888899f4e53c5f1dca6265a277d230f513eb7c12966fc9dbf2f5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9b3ed1f1e22883080b630123079353df3dde32e7710982a9f51717918d8252d3e3addd1c8d99862f59f2d08cbfe4c0c5852fb609106b24f370ffd84260c6b0e6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-19 16:19:18.217386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 16:19:18.217744) ========= 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=a0d2d2de893abaa8702a9954000001a7-1458428208.474919-1255578610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 16:19:18.302398) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-19 16:19:18.302769) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-19 16:19:18.303122) ========= ========= Total master_lag: 0.29 =========