builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1460588811.14 results: success (0) buildid: 20160413134847 builduid: 7560f199a0fe423089fda179a84a5605 revision: c9962404eb5dfc4c8fed45a1fc964072c1a783e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:51.144713) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:51.145217) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:51.145533) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006475 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:51.169954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:51.170238) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:51.212766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:51.213061) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.17 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:51.388530) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:51.388792) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:51.389113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:51.389591) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 16:06:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.8M=0s 2016-04-13 16:06:52 (39.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132643 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:51.534398) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:51.534693) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015882 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:51.584650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 16:06:51.584993) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c9962404eb5dfc4c8fed45a1fc964072c1a783e6 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c9962404eb5dfc4c8fed45a1fc964072c1a783e6 --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=516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 16:06:52,455 truncating revision to first 12 chars 2016-04-13 16:06:52,455 Setting DEBUG logging. 2016-04-13 16:06:52,455 attempt 1/10 2016-04-13 16:06:52,455 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c9962404eb5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 16:06:53,890 unpacking tar archive at: mozilla-aurora-c9962404eb5d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.717072 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 16:06:53.315295) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:53.315656) ========= echo c9962404eb5dfc4c8fed45a1fc964072c1a783e6 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c9962404eb5dfc4c8fed45a1fc964072c1a783e6'] 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=516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c9962404eb5dfc4c8fed45a1fc964072c1a783e6 program finished with exit code 0 elapsedTime=0.003784 script_repo_revision: 'c9962404eb5dfc4c8fed45a1fc964072c1a783e6' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:53.363869) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:53.364171) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 16:06:53.373772) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-04-13 16:06:53.374047) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:06:54 INFO - MultiFileLogger online at 20160413 16:06:54 in /builds/slave/test-pgo 16:06:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:06:54 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:06:54 INFO - {'append_to_log': False, 16:06:54 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:06:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:06:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:06:54 INFO - 'branch': 'Mozilla-Aurora', 16:06:54 INFO - 'buildbot_json_path': 'buildprops.json', 16:06:54 INFO - 'config_files': ('talos/linux_config.py',), 16:06:54 INFO - 'default_actions': ('clobber', 16:06:54 INFO - 'read-buildbot-config', 16:06:54 INFO - 'download-and-extract', 16:06:54 INFO - 'populate-webroot', 16:06:54 INFO - 'create-virtualenv', 16:06:54 INFO - 'install', 16:06:54 INFO - 'run-tests'), 16:06:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:06:54 INFO - 'download_minidump_stackwalk': True, 16:06:54 INFO - 'download_symbols': 'ondemand', 16:06:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:06:54 INFO - 'tooltool.py': '/tools/tooltool.py', 16:06:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:06:54 INFO - '/tools/misc-python/virtualenv.py')}, 16:06:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:06:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:06:54 INFO - 'installer_path': 'installer.exe', 16:06:54 INFO - 'log_level': 'info', 16:06:54 INFO - 'log_name': 'talos', 16:06:54 INFO - 'log_to_console': True, 16:06:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:06:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:06:54 INFO - 'opt_config_files': (), 16:06:54 INFO - 'pip_index': False, 16:06:54 INFO - 'sps_profile': False, 16:06:54 INFO - 'sps_profile_interval': 0, 16:06:54 INFO - 'suite': 'dromaeojs', 16:06:54 INFO - 'system_bits': '32', 16:06:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:06:54 INFO - 'title': 'talos-linux64-ix-061', 16:06:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:06:54 INFO - 'use_talos_json': True, 16:06:54 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:06:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:06:54 INFO - 'work_dir': 'build'} 16:06:54 INFO - ##### 16:06:54 INFO - ##### Running clobber step. 16:06:54 INFO - ##### 16:06:54 INFO - Running pre-action listener: _resource_record_pre_action 16:06:54 INFO - Running main action method: clobber 16:06:54 INFO - rmtree: /builds/slave/test-pgo/build 16:06:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:06:55 INFO - Running post-action listener: _resource_record_post_action 16:06:55 INFO - ##### 16:06:55 INFO - ##### Running read-buildbot-config step. 16:06:55 INFO - ##### 16:06:55 INFO - Running pre-action listener: _resource_record_pre_action 16:06:55 INFO - Running main action method: read_buildbot_config 16:06:55 INFO - Using buildbot properties: 16:06:55 INFO - { 16:06:55 INFO - "project": "", 16:06:55 INFO - "product": "firefox", 16:06:55 INFO - "script_repo_revision": "production", 16:06:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:06:55 INFO - "repository": "", 16:06:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:06:55 INFO - "buildid": "20160413134847", 16:06:55 INFO - "pgo_build": "True", 16:06:55 INFO - "basedir": "/builds/slave/test-pgo", 16:06:55 INFO - "buildnumber": 164, 16:06:55 INFO - "slavename": "talos-linux64-ix-061", 16:06:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:06:55 INFO - "platform": "ubuntu64_hw", 16:06:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:06:55 INFO - "branch": "mozilla-aurora", 16:06:55 INFO - "repo_path": "releases/mozilla-aurora", 16:06:55 INFO - "revision": "c9962404eb5dfc4c8fed45a1fc964072c1a783e6", 16:06:55 INFO - "stage_platform": "linux64-pgo", 16:06:55 INFO - "builduid": "7560f199a0fe423089fda179a84a5605", 16:06:55 INFO - "slavebuilddir": "test" 16:06:55 INFO - } 16:06:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 16:06:55 INFO - Running post-action listener: _resource_record_post_action 16:06:55 INFO - ##### 16:06:55 INFO - ##### Running download-and-extract step. 16:06:55 INFO - ##### 16:06:55 INFO - Running pre-action listener: _resource_record_pre_action 16:06:55 INFO - Running main action method: download_and_extract 16:06:55 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:55 INFO - https://queue.taskcluster.net/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:06:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:06:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:06:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:06:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:06:58 INFO - Downloaded 1448 bytes. 16:06:58 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:06:58 INFO - Using the following test package requirements: 16:06:58 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:06:58 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:06:58 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:06:58 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:06:58 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:06:58 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:06:58 INFO - u'jsshell-linux-x86_64.zip'], 16:06:58 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:06:58 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:06:58 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:06:58 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:06:58 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:06:58 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:06:58 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:06:58 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:06:58 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:06:58 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:06:58 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:06:58 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:06:58 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:58 INFO - https://queue.taskcluster.net/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:06:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:06:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:06:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:06:59 INFO - Downloaded 23352256 bytes. 16:06:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:06:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:07:00 INFO - Return code: 0 16:07:00 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:00 INFO - https://queue.taskcluster.net/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:07:01 INFO - Downloaded 23352256 bytes. 16:07:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:07:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:07:03 INFO - Return code: 0 16:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:03 INFO - https://queue.taskcluster.net/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:07:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:07:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:07:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:07:04 INFO - Downloaded 10845168 bytes. 16:07:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:07:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 16:07:04 INFO - Return code: 0 16:07: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')]} 16:07:04 INFO - https://queue.taskcluster.net/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:07:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:07:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:07:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:07:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:07:05 INFO - Downloaded 60568730 bytes. 16:07:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:07:05 INFO - mkdir: /builds/slave/test-pgo/properties 16:07:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:07:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:07:05 INFO - Contents: 16:07:05 INFO - build_url:https://queue.taskcluster.net/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:07:06 INFO - Running post-action listener: _resource_record_post_action 16:07:06 INFO - Running post-action listener: set_extra_try_arguments 16:07:06 INFO - ##### 16:07:06 INFO - ##### Running populate-webroot step. 16:07:06 INFO - ##### 16:07:06 INFO - Running pre-action listener: _resource_record_pre_action 16:07:06 INFO - Running main action method: populate_webroot 16:07:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:07:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:07:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:07:06 INFO - '--tppagecycles', 16:07:06 INFO - '7'], 16:07:06 INFO - 'tests': ['tsvgm']}}, 16:07:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:07:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:07:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:07:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:07:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:07:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:07:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:06 INFO - 'talos_options': ['--e10s'], 16:07:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:06 INFO - 'tests': ['damp', 'tps']}, 16:07:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:06 INFO - 'talos_options': ['--e10s'], 16:07:06 INFO - 'tests': ['damp', 'tps']}, 16:07:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:07:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:07:06 INFO - 'other': {'tests': ['a11yr', 16:07:06 INFO - 'ts_paint', 16:07:06 INFO - 'tpaint', 16:07:06 INFO - 'sessionrestore', 16:07:06 INFO - 'sessionrestore_no_auto_restore', 16:07:06 INFO - 'tabpaint']}, 16:07:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:07:06 INFO - 'tests': ['a11yr', 16:07:06 INFO - 'ts_paint', 16:07:06 INFO - 'tpaint', 16:07:06 INFO - 'sessionrestore', 16:07:06 INFO - 'sessionrestore_no_auto_restore', 16:07:06 INFO - 'tabpaint']}, 16:07:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:07:06 INFO - 'tests': ['a11yr', 16:07:06 INFO - 'ts_paint', 16:07:06 INFO - 'tpaint', 16:07:06 INFO - 'sessionrestore', 16:07:06 INFO - 'sessionrestore_no_auto_restore', 16:07:06 INFO - 'tabpaint']}, 16:07:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:07:06 INFO - 'tests': ['a11yr', 16:07:06 INFO - 'ts_paint', 16:07:06 INFO - 'tpaint', 16:07:06 INFO - 'sessionrestore', 16:07:06 INFO - 'sessionrestore_no_auto_restore', 16:07:06 INFO - 'tabpaint']}, 16:07:06 INFO - 'other_l64': {'tests': ['a11yr', 16:07:06 INFO - 'ts_paint', 16:07:06 INFO - 'tpaint', 16:07:06 INFO - 'sessionrestore', 16:07:06 INFO - 'sessionrestore_no_auto_restore', 16:07:06 INFO - 'tabpaint']}, 16:07:06 INFO - 'other_nol64': {'tests': ['a11yr', 16:07:06 INFO - 'ts_paint', 16:07:06 INFO - 'tpaint', 16:07:06 INFO - 'sessionrestore', 16:07:06 INFO - 'sessionrestore_no_auto_restore', 16:07:06 INFO - 'tabpaint']}, 16:07:06 INFO - 'svgr': {'tests': ['tsvgx', 16:07:06 INFO - 'tsvgr_opacity', 16:07:06 INFO - 'tart', 16:07:06 INFO - 'tscrollx', 16:07:06 INFO - 'cart']}, 16:07:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:07:06 INFO - 'tests': ['tsvgx', 16:07:06 INFO - 'tsvgr_opacity', 16:07:06 INFO - 'tart', 16:07:06 INFO - 'tscrollx', 16:07:06 INFO - 'cart']}, 16:07:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:06 INFO - 'tests': ['tp5o']}, 16:07:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:06 INFO - 'talos_options': ['--e10s'], 16:07:06 INFO - 'tests': ['tp5o']}, 16:07:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:06 INFO - 'talos_options': ['--xperf_path', 16:07:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:06 INFO - 'tests': ['tp5n']}, 16:07:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:06 INFO - 'talos_options': ['--e10s', 16:07:06 INFO - '--xperf_path', 16:07:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:06 INFO - 'tests': ['tp5n']}}, 16:07:06 INFO - 'talos.zip': {'path': '', 16:07:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:07:06 INFO - Running post-action listener: _resource_record_post_action 16:07:06 INFO - ##### 16:07:06 INFO - ##### Running create-virtualenv step. 16:07:06 INFO - ##### 16:07:06 INFO - Running pre-action listener: _resource_record_pre_action 16:07:06 INFO - Running main action method: create_virtualenv 16:07:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:07:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 16:07:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:07:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:07:06 INFO - Using real prefix '/usr' 16:07:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:07:07 INFO - Installing distribute.............................................................................................................................................................................................done. 16:07:09 INFO - Installing pip.................done. 16:07:09 INFO - Return code: 0 16:07:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:09 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 0x7f53b2e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d920>, '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 0x1c4e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ecb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:07:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:07:09 INFO - Using env: {'DISPLAY': ':0', 16:07:09 INFO - 'HOME': '/home/cltbld', 16:07:09 INFO - 'LANG': 'en_US.UTF-8', 16:07:09 INFO - 'LANGUAGE': 'en_US:en', 16:07:09 INFO - 'LOGNAME': 'cltbld', 16:07:09 INFO - 'MAIL': '/var/mail/cltbld', 16:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:09 INFO - 'MOZ_NO_REMOTE': '1', 16:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:09 INFO - 'NO_EM_RESTART': '1', 16:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:07:09 INFO - 'PWD': '/builds/slave/test-pgo', 16:07:09 INFO - 'SHELL': '/bin/bash', 16:07:09 INFO - 'SHLVL': '1', 16:07:09 INFO - 'TERM': 'linux', 16:07:09 INFO - 'TMOUT': '86400', 16:07:09 INFO - 'USER': 'cltbld', 16:07:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 16:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:09 INFO - '_': '/tools/buildbot/bin/python'} 16:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:07:09 INFO - Cleaning up... 16:07:09 INFO - Return code: 0 16:07:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:09 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 0x7f53b2e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d920>, '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 0x1c4e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ecb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:07:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:07:09 INFO - Using env: {'DISPLAY': ':0', 16:07:09 INFO - 'HOME': '/home/cltbld', 16:07:09 INFO - 'LANG': 'en_US.UTF-8', 16:07:09 INFO - 'LANGUAGE': 'en_US:en', 16:07:09 INFO - 'LOGNAME': 'cltbld', 16:07:09 INFO - 'MAIL': '/var/mail/cltbld', 16:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:09 INFO - 'MOZ_NO_REMOTE': '1', 16:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:09 INFO - 'NO_EM_RESTART': '1', 16:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:07:09 INFO - 'PWD': '/builds/slave/test-pgo', 16:07:09 INFO - 'SHELL': '/bin/bash', 16:07:09 INFO - 'SHLVL': '1', 16:07:09 INFO - 'TERM': 'linux', 16:07:09 INFO - 'TMOUT': '86400', 16:07:09 INFO - 'USER': 'cltbld', 16:07:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 16:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:09 INFO - '_': '/tools/buildbot/bin/python'} 16:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:09 INFO - Downloading/unpacking psutil>=0.7.1 16:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:07:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:11 INFO - Installing collected packages: psutil 16:07:11 INFO - Running setup.py install for psutil 16:07:11 INFO - building 'psutil._psutil_linux' extension 16:07:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:07:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:07:11 INFO - building 'psutil._psutil_posix' extension 16:07:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:07:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:07:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:12 INFO - Successfully installed psutil 16:07:12 INFO - Cleaning up... 16:07:12 INFO - Return code: 0 16:07:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:12 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 0x7f53b2e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d920>, '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 0x1c4e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ecb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:07:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:07:12 INFO - Using env: {'DISPLAY': ':0', 16:07:12 INFO - 'HOME': '/home/cltbld', 16:07:12 INFO - 'LANG': 'en_US.UTF-8', 16:07:12 INFO - 'LANGUAGE': 'en_US:en', 16:07:12 INFO - 'LOGNAME': 'cltbld', 16:07:12 INFO - 'MAIL': '/var/mail/cltbld', 16:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:12 INFO - 'MOZ_NO_REMOTE': '1', 16:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:12 INFO - 'NO_EM_RESTART': '1', 16:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:07:12 INFO - 'PWD': '/builds/slave/test-pgo', 16:07:12 INFO - 'SHELL': '/bin/bash', 16:07:12 INFO - 'SHLVL': '1', 16:07:12 INFO - 'TERM': 'linux', 16:07:12 INFO - 'TMOUT': '86400', 16:07:12 INFO - 'USER': 'cltbld', 16:07:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 16:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:12 INFO - '_': '/tools/buildbot/bin/python'} 16:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:07: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 16:07: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 16:07: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 16:07: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 16:07: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 16:07: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 16:07:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:07:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:07:14 INFO - Installing collected packages: mozsystemmonitor 16:07:14 INFO - Running setup.py install for mozsystemmonitor 16:07:14 INFO - Successfully installed mozsystemmonitor 16:07:14 INFO - Cleaning up... 16:07:14 INFO - Return code: 0 16:07:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:14 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 0x7f53b2e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d920>, '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 0x1c4e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ecb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:07:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:07:14 INFO - Using env: {'DISPLAY': ':0', 16:07:14 INFO - 'HOME': '/home/cltbld', 16:07:14 INFO - 'LANG': 'en_US.UTF-8', 16:07:14 INFO - 'LANGUAGE': 'en_US:en', 16:07:14 INFO - 'LOGNAME': 'cltbld', 16:07:14 INFO - 'MAIL': '/var/mail/cltbld', 16:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:14 INFO - 'MOZ_NO_REMOTE': '1', 16:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:14 INFO - 'NO_EM_RESTART': '1', 16:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:07:14 INFO - 'PWD': '/builds/slave/test-pgo', 16:07:14 INFO - 'SHELL': '/bin/bash', 16:07:14 INFO - 'SHLVL': '1', 16:07:14 INFO - 'TERM': 'linux', 16:07:14 INFO - 'TMOUT': '86400', 16:07:14 INFO - 'USER': 'cltbld', 16:07:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 16:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:14 INFO - '_': '/tools/buildbot/bin/python'} 16:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:14 INFO - Downloading/unpacking blobuploader==1.2.4 16:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:16 INFO - Downloading blobuploader-1.2.4.tar.gz 16:07:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:07:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:07:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:17 INFO - Downloading docopt-0.6.1.tar.gz 16:07:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:07:17 INFO - Installing collected packages: blobuploader, requests, docopt 16:07:17 INFO - Running setup.py install for blobuploader 16:07:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:07:17 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:07:17 INFO - Running setup.py install for requests 16:07:17 INFO - Running setup.py install for docopt 16:07:17 INFO - Successfully installed blobuploader requests docopt 16:07:17 INFO - Cleaning up... 16:07:17 INFO - Return code: 0 16:07:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:17 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 0x7f53b2e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d920>, '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 0x1c4e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ecb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:07:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:07:17 INFO - Using env: {'DISPLAY': ':0', 16:07:17 INFO - 'HOME': '/home/cltbld', 16:07:17 INFO - 'LANG': 'en_US.UTF-8', 16:07:17 INFO - 'LANGUAGE': 'en_US:en', 16:07:17 INFO - 'LOGNAME': 'cltbld', 16:07:17 INFO - 'MAIL': '/var/mail/cltbld', 16:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:17 INFO - 'MOZ_NO_REMOTE': '1', 16:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:17 INFO - 'NO_EM_RESTART': '1', 16:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:07:17 INFO - 'PWD': '/builds/slave/test-pgo', 16:07:17 INFO - 'SHELL': '/bin/bash', 16:07:17 INFO - 'SHLVL': '1', 16:07:17 INFO - 'TERM': 'linux', 16:07:17 INFO - 'TMOUT': '86400', 16:07:17 INFO - 'USER': 'cltbld', 16:07:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 16:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:17 INFO - '_': '/tools/buildbot/bin/python'} 16:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:07:18 INFO - Running setup.py (path:/tmp/pip-1mPp0h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:07:18 INFO - Running setup.py (path:/tmp/pip-CgoAtS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:07:18 INFO - Running setup.py (path:/tmp/pip-aVs80P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:07:18 INFO - Running setup.py (path:/tmp/pip-Cw3JFD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:07:18 INFO - Running setup.py (path:/tmp/pip-9P5SpL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:07:18 INFO - Running setup.py (path:/tmp/pip-Mk7RBT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:07:18 INFO - Running setup.py (path:/tmp/pip-f7PXLI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:07:18 INFO - Running setup.py (path:/tmp/pip-is7S7I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:07:18 INFO - Running setup.py (path:/tmp/pip-0qrXaH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:07:18 INFO - Running setup.py (path:/tmp/pip-36ruef-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:07:18 INFO - Running setup.py (path:/tmp/pip-jEKYSB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:07:18 INFO - Running setup.py (path:/tmp/pip-oId6Vn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:07:19 INFO - Running setup.py (path:/tmp/pip-JLLxwv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:07:19 INFO - Running setup.py (path:/tmp/pip-ZpvoIq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:07:19 INFO - Running setup.py (path:/tmp/pip-f3C6I4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:07:19 INFO - Running setup.py (path:/tmp/pip-Em3lzC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:07:19 INFO - Running setup.py (path:/tmp/pip-ww3Av3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:07:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:07:19 INFO - Running setup.py install for manifestparser 16:07:19 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:07:19 INFO - Running setup.py install for mozcrash 16:07:19 INFO - Running setup.py install for mozdebug 16:07:19 INFO - Running setup.py install for mozdevice 16:07:19 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:07:19 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:07:19 INFO - Running setup.py install for mozfile 16:07:19 INFO - Running setup.py install for mozhttpd 16:07:19 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:07:19 INFO - Running setup.py install for mozinfo 16:07:20 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:07:20 INFO - Running setup.py install for mozInstall 16:07:20 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:07:20 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:07:20 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:07:20 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:07:20 INFO - Running setup.py install for mozleak 16:07:20 INFO - Running setup.py install for mozlog 16:07:20 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:07:20 INFO - Running setup.py install for moznetwork 16:07:20 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:07:20 INFO - Running setup.py install for mozprocess 16:07:20 INFO - Running setup.py install for mozprofile 16:07:20 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:07:20 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:07:20 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:07:20 INFO - Running setup.py install for mozrunner 16:07:20 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:07:20 INFO - Running setup.py install for mozscreenshot 16:07:20 INFO - Running setup.py install for moztest 16:07:21 INFO - Running setup.py install for mozversion 16:07:21 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:07:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:07:21 INFO - Cleaning up... 16:07:21 INFO - Return code: 0 16:07:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:21 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 0x7f53b2e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d920>, '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 0x1c4e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ecb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:07:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:07:21 INFO - Using env: {'DISPLAY': ':0', 16:07:21 INFO - 'HOME': '/home/cltbld', 16:07:21 INFO - 'LANG': 'en_US.UTF-8', 16:07:21 INFO - 'LANGUAGE': 'en_US:en', 16:07:21 INFO - 'LOGNAME': 'cltbld', 16:07:21 INFO - 'MAIL': '/var/mail/cltbld', 16:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:21 INFO - 'MOZ_NO_REMOTE': '1', 16:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:21 INFO - 'NO_EM_RESTART': '1', 16:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:07:21 INFO - 'PWD': '/builds/slave/test-pgo', 16:07:21 INFO - 'SHELL': '/bin/bash', 16:07:21 INFO - 'SHLVL': '1', 16:07:21 INFO - 'TERM': 'linux', 16:07:21 INFO - 'TMOUT': '86400', 16:07:21 INFO - 'USER': 'cltbld', 16:07:21 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 16:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:21 INFO - '_': '/tools/buildbot/bin/python'} 16:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:07:21 INFO - Running setup.py (path:/tmp/pip-GMnlmi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 16:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:07:21 INFO - Running setup.py (path:/tmp/pip-_6L5xW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:07:21 INFO - Running setup.py (path:/tmp/pip-w1Abmm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:07:21 INFO - Running setup.py (path:/tmp/pip-BpMA0q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:07:21 INFO - Running setup.py (path:/tmp/pip-fNeBpj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 16:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:07:21 INFO - Running setup.py (path:/tmp/pip-AdPJeO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 16:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:07:21 INFO - Running setup.py (path:/tmp/pip-y5juGL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 16:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:07:21 INFO - Running setup.py (path:/tmp/pip-uldrYp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 16:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:07:21 INFO - Running setup.py (path:/tmp/pip-vobu2H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 16:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:07:22 INFO - Running setup.py (path:/tmp/pip-2tOazd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:07:22 INFO - Running setup.py (path:/tmp/pip-1M6btG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 16:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:07:22 INFO - Running setup.py (path:/tmp/pip-9OS3re-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 16:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:07:22 INFO - Running setup.py (path:/tmp/pip-gJoqaD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 16:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:07:22 INFO - Running setup.py (path:/tmp/pip-71ZCyS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 16:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:07:22 INFO - Running setup.py (path:/tmp/pip-jfyL38-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 16:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:07:22 INFO - Running setup.py (path:/tmp/pip-O0X1HY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 16:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:07:22 INFO - Running setup.py (path:/tmp/pip-RXaoHm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 16:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:07:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:07: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 16:07: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 16:07: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 16:07: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 16:07: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 16:07: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 16:07:24 INFO - Downloading blessings-1.6.tar.gz 16:07:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:07:24 INFO - Installing collected packages: blessings 16:07:24 INFO - Running setup.py install for blessings 16:07:24 INFO - Successfully installed blessings 16:07:24 INFO - Cleaning up... 16:07:24 INFO - Return code: 0 16:07:24 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:07:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:07:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:07:24 INFO - Reading from file tmpfile_stdout 16:07:24 INFO - Current package versions: 16:07:24 INFO - argparse == 1.2.1 16:07:24 INFO - blessings == 1.6 16:07:24 INFO - blobuploader == 1.2.4 16:07:24 INFO - docopt == 0.6.1 16:07:24 INFO - manifestparser == 1.1 16:07:24 INFO - mozInstall == 1.12 16:07:24 INFO - mozcrash == 0.17 16:07:24 INFO - mozdebug == 0.1 16:07:24 INFO - mozdevice == 0.48 16:07:24 INFO - mozfile == 1.2 16:07:24 INFO - mozhttpd == 0.7 16:07:24 INFO - mozinfo == 0.9 16:07:24 INFO - mozleak == 0.1 16:07:24 INFO - mozlog == 3.1 16:07:24 INFO - moznetwork == 0.27 16:07:24 INFO - mozprocess == 0.22 16:07:24 INFO - mozprofile == 0.28 16:07:24 INFO - mozrunner == 6.11 16:07:24 INFO - mozscreenshot == 0.1 16:07:24 INFO - mozsystemmonitor == 0.0 16:07:24 INFO - moztest == 0.7 16:07:24 INFO - mozversion == 1.4 16:07:24 INFO - psutil == 3.1.1 16:07:24 INFO - requests == 1.2.3 16:07:24 INFO - wsgiref == 0.1.2 16:07:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:24 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 0x7f53b2e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d920>, '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 0x1c4e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ecb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 16:07:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:07:24 INFO - Using env: {'DISPLAY': ':0', 16:07:24 INFO - 'HOME': '/home/cltbld', 16:07:24 INFO - 'LANG': 'en_US.UTF-8', 16:07:24 INFO - 'LANGUAGE': 'en_US:en', 16:07:24 INFO - 'LOGNAME': 'cltbld', 16:07:24 INFO - 'MAIL': '/var/mail/cltbld', 16:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:24 INFO - 'MOZ_NO_REMOTE': '1', 16:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:24 INFO - 'NO_EM_RESTART': '1', 16:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:07:24 INFO - 'PWD': '/builds/slave/test-pgo', 16:07:24 INFO - 'SHELL': '/bin/bash', 16:07:24 INFO - 'SHLVL': '1', 16:07:24 INFO - 'TERM': 'linux', 16:07:24 INFO - 'TMOUT': '86400', 16:07:24 INFO - 'USER': 'cltbld', 16:07:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 16:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:24 INFO - '_': '/tools/buildbot/bin/python'} 16:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 16:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 16:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 16:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 16:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 16:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 16:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:07:25 INFO - Cleaning up... 16:07:25 INFO - Return code: 0 16:07:25 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53b2e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d920>, '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 0x1c4e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ecb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:07:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:07:25 INFO - Using env: {'DISPLAY': ':0', 16:07:25 INFO - 'HOME': '/home/cltbld', 16:07:25 INFO - 'LANG': 'en_US.UTF-8', 16:07:25 INFO - 'LANGUAGE': 'en_US:en', 16:07:25 INFO - 'LOGNAME': 'cltbld', 16:07:25 INFO - 'MAIL': '/var/mail/cltbld', 16:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:25 INFO - 'MOZ_NO_REMOTE': '1', 16:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:25 INFO - 'NO_EM_RESTART': '1', 16:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:07:25 INFO - 'PWD': '/builds/slave/test-pgo', 16:07:25 INFO - 'SHELL': '/bin/bash', 16:07:25 INFO - 'SHLVL': '1', 16:07:25 INFO - 'TERM': 'linux', 16:07:25 INFO - 'TMOUT': '86400', 16:07:25 INFO - 'USER': 'cltbld', 16:07:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 16:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:25 INFO - '_': '/tools/buildbot/bin/python'} 16:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:25 INFO - Downloading/unpacking jsonschema 16:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:07:27 INFO - Downloading/unpacking functools32 (from jsonschema) 16:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:27 INFO - Downloading functools32-3.2.3-2.tar.gz 16:07:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:07:27 INFO - warning: no files found matching '*.txt' 16:07:27 INFO - no previously-included directories found matching 'build' 16:07:27 INFO - no previously-included directories found matching 'dist' 16:07:27 INFO - no previously-included directories found matching '.git*' 16:07:27 INFO - Installing collected packages: jsonschema, functools32 16:07:27 INFO - Running setup.py install for functools32 16:07:27 INFO - warning: no files found matching '*.txt' 16:07:27 INFO - no previously-included directories found matching 'build' 16:07:27 INFO - no previously-included directories found matching 'dist' 16:07:27 INFO - no previously-included directories found matching '.git*' 16:07:27 INFO - Successfully installed jsonschema functools32 16:07:27 INFO - Cleaning up... 16:07:27 INFO - Return code: 0 16:07:27 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:27 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 0x7f53b2e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbe6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d920>, '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 0x1c4e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ecb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:07:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:07:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:07:27 INFO - Using env: {'DISPLAY': ':0', 16:07:27 INFO - 'HOME': '/home/cltbld', 16:07:27 INFO - 'LANG': 'en_US.UTF-8', 16:07:27 INFO - 'LANGUAGE': 'en_US:en', 16:07:27 INFO - 'LOGNAME': 'cltbld', 16:07:27 INFO - 'MAIL': '/var/mail/cltbld', 16:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:27 INFO - 'MOZ_NO_REMOTE': '1', 16:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:27 INFO - 'NO_EM_RESTART': '1', 16:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:07:27 INFO - 'PWD': '/builds/slave/test-pgo', 16:07:27 INFO - 'SHELL': '/bin/bash', 16:07:27 INFO - 'SHLVL': '1', 16:07:27 INFO - 'TERM': 'linux', 16:07:27 INFO - 'TMOUT': '86400', 16:07:27 INFO - 'USER': 'cltbld', 16:07:27 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 16:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:27 INFO - '_': '/tools/buildbot/bin/python'} 16:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:28 INFO - Downloading/unpacking flake8 16:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:07:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:07:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:07:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:07:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:07:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:07:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:07:30 INFO - no previously-included directories found matching 'docs/_build' 16:07:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:07:30 INFO - Running setup.py install for pep8 16:07:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:07:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:07:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:07:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:07:30 INFO - no previously-included directories found matching 'docs/_build' 16:07:30 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:07:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:07:30 INFO - Cleaning up... 16:07:30 INFO - Return code: 0 16:07:30 INFO - Running post-action listener: _resource_record_post_action 16:07:30 INFO - Running post-action listener: _start_resource_monitoring 16:07:30 INFO - Starting resource monitoring. 16:07:30 INFO - ##### 16:07:30 INFO - ##### Running install step. 16:07:30 INFO - ##### 16:07:30 INFO - Running pre-action listener: _resource_record_pre_action 16:07:30 INFO - Running main action method: install 16:07:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:07:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:07:31 INFO - Reading from file tmpfile_stdout 16:07:31 INFO - Detecting whether we're running mozinstall >=1.0... 16:07:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:07:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:07:31 INFO - Reading from file tmpfile_stdout 16:07:31 INFO - Output received: 16:07:31 INFO - Usage: mozinstall [options] installer 16:07:31 INFO - Options: 16:07:31 INFO - -h, --help show this help message and exit 16:07:31 INFO - -d DEST, --destination=DEST 16:07:31 INFO - Directory to install application into. [default: 16:07:31 INFO - "/builds/slave/test-pgo"] 16:07:31 INFO - --app=APP Application being installed. [default: firefox] 16:07:31 INFO - mkdir: /builds/slave/test-pgo/build/application 16:07:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:07:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:07:46 INFO - Reading from file tmpfile_stdout 16:07:46 INFO - Output received: 16:07:46 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:07:46 INFO - Running post-action listener: _resource_record_post_action 16:07:46 INFO - ##### 16:07:46 INFO - ##### Running run-tests step. 16:07:46 INFO - ##### 16:07:46 INFO - Running pre-action listener: _resource_record_pre_action 16:07:46 INFO - Running main action method: run_tests 16:07:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:07:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:07:46 INFO - Python 2.7.3 16:07:46 INFO - Return code: 0 16:07:46 INFO - grabbing minidump binary from tooltool 16:07: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')]} 16:07:46 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 0x1c4d920>, '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 0x1c4e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4ecb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:07:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 16:07:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:07:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:07:46 INFO - Return code: 0 16:07:46 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:07:46 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:07:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:07:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:07:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:07:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:07:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:07:47 INFO - Return code: 0 16:07:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 16:07:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 16:07:47 INFO - Using env: {'DISPLAY': ':0', 16:07:47 INFO - 'HOME': '/home/cltbld', 16:07:47 INFO - 'LANG': 'en_US.UTF-8', 16:07:47 INFO - 'LANGUAGE': 'en_US:en', 16:07:47 INFO - 'LOGNAME': 'cltbld', 16:07:47 INFO - 'MAIL': '/var/mail/cltbld', 16:07:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:07:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:47 INFO - 'MOZ_NO_REMOTE': '1', 16:07:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:47 INFO - 'NO_EM_RESTART': '1', 16:07:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:07:47 INFO - 'PWD': '/builds/slave/test-pgo', 16:07:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:07:47 INFO - 'SHELL': '/bin/bash', 16:07:47 INFO - 'SHLVL': '1', 16:07:47 INFO - 'TERM': 'linux', 16:07:47 INFO - 'TMOUT': '86400', 16:07:47 INFO - 'USER': 'cltbld', 16:07:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621', 16:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:47 INFO - '_': '/tools/buildbot/bin/python'} 16:07:47 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:07:47 INFO - mozversion application_buildid: 20160413134847 16:07:47 INFO - mozversion application_changeset: c9962404eb5dfc4c8fed45a1fc964072c1a783e6 16:07:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:07:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:07:47 INFO - mozversion application_name: Firefox 16:07:47 INFO - mozversion application_remotingname: firefox-dev 16:07:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:07:47 INFO - mozversion application_vendor: Mozilla 16:07:47 INFO - mozversion application_version: 47.0a2 16:07:47 INFO - mozversion platform_buildid: 20160413134847 16:07:47 INFO - mozversion platform_changeset: c9962404eb5dfc4c8fed45a1fc964072c1a783e6 16:07:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:07:47 INFO - mozversion platform_version: 47.0a2 16:07:47 INFO - using testdate: 1460588867 16:07:47 INFO - actual date: 1460588867 16:07:47 INFO - starting webserver on 'localhost:42347' 16:07:47 INFO - SUITE-START | Running 2 tests 16:07:47 INFO - TEST-START | dromaeo_css 16:07:47 INFO - operating with platform_type : linux_ 16:07:47 INFO - Initialising browser for dromaeo_css test... 16:07:47 INFO - TEST-INFO | started process 11649 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVrSzuC/profile http://localhost:42347/getInfo.html) 16:07:52 INFO - PROCESS | 11649 | __metrics Screen width/height:1600/1200 16:07:52 INFO - PROCESS | 11649 | colorDepth:24 16:07:52 INFO - PROCESS | 11649 | Browser inner width/height: 1024/697 16:07:52 INFO - PROCESS | 11649 | __metrics 16:07:53 INFO - PROCESS | 11649 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:07:54 INFO - TEST-INFO | 11649: exit 0 16:07:54 INFO - Browser initialized. 16:07:54 INFO - Running cycle 1/1 for dromaeo_css test... 16:07:54 INFO - TEST-INFO | started process 11742 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVrSzuC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:05 INFO - PROCESS | 11742 | RSS: Main: 141856768 16:08:05 INFO - PROCESS | 11742 | 16:08:56 INFO - PROCESS | 11742 | 1460588936885 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:11:04 INFO - PROCESS | 11742 | Cycle 1(1): loaded http://localhost:42347/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42347/tests/dromaeo/cssquery-ext.html) 16:11:05 INFO - PROCESS | 11742 | RSS: Main: 250105856 16:11:05 INFO - PROCESS | 11742 | 16:14:07 INFO - PROCESS | 11742 | Cycle 1(1): loaded http://localhost:42347/tests/dromaeo/cssquery-ext.html (next: http://localhost:42347/tests/dromaeo/cssquery-jquery.html) 16:14:08 INFO - PROCESS | 11742 | RSS: Main: 217755648 16:14:08 INFO - PROCESS | 11742 | 16:17:10 INFO - PROCESS | 11742 | Cycle 1(1): loaded http://localhost:42347/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42347/tests/dromaeo/cssquery-mootools.html) 16:17:10 INFO - PROCESS | 11742 | RSS: Main: 212332544 16:17:10 INFO - PROCESS | 11742 | 16:20:12 INFO - PROCESS | 11742 | Cycle 1(1): loaded http://localhost:42347/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42347/tests/dromaeo/cssquery-prototype.html) 16:20:13 INFO - PROCESS | 11742 | RSS: Main: 204791808 16:20:13 INFO - PROCESS | 11742 | 16:23:15 INFO - PROCESS | 11742 | Cycle 1(1): loaded http://localhost:42347/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42347/tests/dromaeo/cssquery-yui.html) 16:23:16 INFO - PROCESS | 11742 | RSS: Main: 205807616 16:23:16 INFO - PROCESS | 11742 | 16:26:18 INFO - PROCESS | 11742 | Cycle 1(1): loaded http://localhost:42347/tests/dromaeo/cssquery-yui.html (next: http://localhost:42347/tests/dromaeo/cssquery-dojo.html) 16:26:18 INFO - PROCESS | 11742 | RSS: Main: 262836224 16:26:18 INFO - PROCESS | 11742 | 16:26:18 INFO - PROCESS | 11742 | __start_tp_report 16:26:18 INFO - PROCESS | 11742 | _x_x_mozilla_page_load 16:26:18 INFO - PROCESS | 11742 | _x_x_mozilla_page_load_details 16:26:18 INFO - PROCESS | 11742 | |i|pagename|runs| 16:26:18 INFO - PROCESS | 11742 | |0;dojo.html;3241.4813629819228;3248.1230067881675;3267.9346413071753;3293.687099725525;3320.2529430878058;5315.8405247842575;5368.651037682553;5393.164059570773;5397.4062853086225;5417.972910135449;5350.5184533391985;5370.570354371651;5378.811741589036;5397.568194544427;5402.189671549259;4854.271859221128;4937.802487900498;4961.875953101175;4992.625553083515;5013.398392192942;4916.139675556763;4962.60299176065;4968.677035992649;5030;5032.597392208614;4959.156943319626;4973.701577905337;4979.751012449381;4987.501249875002;4999.500049995007;4876.122297986361;4915.5821755150855;4945.653804233705;4977.452480227172;4979.078870408968;4912.508749125094;4950.628702847265;4972.204447288453;4976.825811096631;4981.701097934099;5227.60792940531;5229.660072095339;5287.920681189786;5291.682499050069;5337.092694241988;5741.081426971707;5749.281339832521;5790.826275211751;5792;5821.8253452396075;5806.332271788756;5812.476877081041;5825.679587622679;5838.095095260242;5847.44449277318;5423.810166644227;5423.972880135613;5428.321459817563;5429.918551221735;5433.483819037185;5856.912146317723;5887.911681324784;5914.319853216935;5917.7928772493615;5960.433758792908;5732.71336433185;5735.569832262597;5747.942520574825;5763.567732420085;5764.048931926185;5773.855653608609;5825.4174582542255;5828.708564571754;5832.445917637818;5835.533157347402;5674.829755107354;5791.942080579141;5808.30300363959;5835.883282334329;5914.2311499504785;5755.767700875066;5811.15738217956;5815.2149459822385;5816.894789989973;5825.50483208932;4441.800118994653;4452.799624016927;4455.309427038814;4457.977710111429;4479.440069991251;3949.8420063197723;3983.980080099581;4001.959980400217;4052.65552428041;4073.961139909304;5476.972615136979;5480.287562616914;5485.369182544058;5497.038018346853;5500.037493438632;5842.269716285465;5855.560832937462;5856.619319744203;5861.648301101947;5891.764329426775;5325.840224793263;5403.297571315704;5475.698836564027;5492.890142197213;5529.060059789846;5014.122528557488;5043.167877300204;5046.798128074909;5048.8232911848645;5080.542751152414;5971.223740913653;6016.849578760566;6056.606320589148;6074.75700971965;6079.544034197453;5798.217240672455;5859.179714839841;5869.413058694096;5870.735816888336;5876.41235876409;6023.27720673522;6027.21646185993;6034.39656034393;6042.305134909541;6043.214382130295;5607.046802043744;5747.252857128547;5784.190213370048;5787.623804452697;5792.333881603501;5802.187693722966;5831.387704291158;5851.765929362778;5854.765809367577;5885.323187833454;5680.091185410314;5682.318121825242;5686.886262274648;5689.630174038674;5689.971550142222;5606.6916319602815;5679.290088738908;5679.432056794288;5701.344345400166;5764.625299355528;5577.079781836114;5591.916121258266;5593.384727679871;5605.915911261252;5610.102383618601;5706.743196556248;5725.828225153252;5726.141078838207;5735.3977832327;5736.4550367715;5489.807856724996;5559.555235581063;5575.637583557056;5582.3859375467855;5639.407862174413 16:26:18 INFO - PROCESS | 11742 | |1;ext.html;534.2867272191621;547.3404547520239;580.1124279851825;590.4597293476469;640.65404681472;40268.597314026854;40597.78206653798;40655.59344406555;40698;40699.186016279695;44078.33882491757;44729;44764.552354476444;44793.55206447934;44854.10291794162;8714.477131372121;8917.375783695144;8919.375643704943;8924.910750892506;8929.687460938869;8806.471611703286;8932.687355942511;8952.641894324252;9121.771955701095;9138.77153071172;9086.50024248666;9166.816663666723;9176.632934682604;9187.127222913847;9189.770255743593;8994.145556172152;9074.500902450363;9086.454812711225;9094.09059094092;9097.727068187965;8786.121387861227;8897.955510222473;8912.331575131826;9112.453252804853;9128.634854605807;43348.133037339394;43777.56222437767;43818.342724859154;43894.34158487625;43957.340639890426;3713.3316003119426;4241.215375155575;4330.17726631939;4415.094905544356;4449.9555004450185;32787.50818737721;32944.83527582371;33519.83240083808;34194.316113677836;34969.82515087408;3743.5320584926885;3766.2589788390615;3766.7174961877968;3823.4073718573663;3861.864834730771;288128;288766;289556;289570;289912;46056.309155362695;63650;63925;64062;64110;45208.77395613001;45448.318275225894;45522;45578;45618.77190614092;13248.072634915656;13538.661533461742;13559.864401356057;13578.049536532546;13600.455981760817;12132.211406258564;12155.878441215651;12161.939190303992;12187.232851236698;12212.267263964013;15436.845631543765;15549.844501555066;15595.532134035997;15624.296906639229;15711.743060555129;5677;5736.512396446349;5790.36306006339;5791.362950075489;5862.339440145095;971.8542218667257;1092.5575142067476;1145.894212085325;1162.3955543117531;1196.5991392883307;30888.382232355227;31653.20866978344;31839.52240716391;31984.680153198635;32577.674223257938;1111.5664890692635;1132.2810015640127;1172.5778719660916;1178.750524444092;1258.6098309524077;16668.999720033673;16719.498415047325;16833.242504087102;16834;16909;323647;325585;325587;327263;327881;58389.4161058384;59753.10370344448;59759.70120149371;59786.70106649439;59864;1302.6743314171458;1416.525463969561;1425.308725268244;1450.2241300903966;1451.1945870042016;27751.583726244527;29083.7091629081;29188.124356268498;29762.851185743933;29890.70109298879;56458.43541564532;57751.1337329932;57967.71016144892;57994.4200557989;58182;245137;247949;248030;248696;248925;40555;43524.347134793636;47996.280055798496;48177.75911120422;49402.50597493979;48157.5184248153;48178.27732583944;48262.276065858336;48880.26679599738;49772.751136244086;39531.2093758129;39790.60209397985;40406.39390409205;40408;40657.79671101626;38688.80655596704;39657.29494265793;40506.79746601248;40508.392374115;40885.59114408937;39464.80267598759;40580;40640;40824.38763418492;41167.588324116376;35338;36259;36388;36707.26585468329;36931.26137477181;27489.17532474029;27552.586711198946;27631;27902.581461277692;27905.720942791126 16:26:18 INFO - PROCESS | 11742 | |2;jquery.html;388.57451091055293;389.2348200908875;392.7113571524929;393.21553500765975;402.7221217360021;14407.567772966828;15540.922295388535;17356.392526261585;17881.82118178818;17900.64198716025;17161.914190429063;17432.825671743278;17485.475435736917;17539.73690394645;18380.17289221985;5544.972275138619;5761.596688231825;5773.162891380747;5805.274340707411;5827.213326200972;5533.778648854041;5698.7435565399655;5768.855778605526;5781.739821708034;5783.2481777368885;5708.686022268774;5729.885402291951;5730.36965933747;5739.368669446358;5747.33905600855;5503.284573005503;5709.77160913563;5715.428457154272;5729.369769325371;5745.396733343023;5137.974310128463;5139.049275883974;5144.485551444863;5155.329807125087;5161.225816127573;20858.5828283435;21262.787372126237;21283.14867405302;21620.459488512755;21647.783522164733;2311.341267738703;2433.367324495644;2461.79074778644;2503.8873250703764;2696.312440327704;12760.617181484571;12964.416601252966;13021.348932553428;13068.803967940488;13085.345732713422;1703.846653801164;1722.3024675006518;1736.9044702541355;1744.877858549902;1798.910054497283;60506.69746651283;62369.68815155941;63495.6825215871;63799.36200637981;65142.02286965699;9774.951125244328;10103.64637237708;10409.386545085372;10504.791948925818;10507;14515.129092254498;14686.55940321792;14697.632559186106;14709.117452952856;14717.55847324582;7330.7171245031905;7840.372770178372;7852.725154619561;7856.135825059353;7958.129839487716;7291.781246562506;7312.561246325237;7342.632868356561;7389.371903388273;7411;4706.317583950308;4755.381800366;4771.904561908743;4814.735189564608;4830.686005409637;1720.5612568795127;1875.896825674601;1934.6324198402258;1955.9119839606967;1960.5098725318671;913.2511340700695;1012.3571532077037;1034.4569101221769;1082.5940272397852;1160.3038177093845;16856.494305170865;16878.74681879773;16978.830211697972;17209.7418538722;19244;1021.1575450253571;1023.5649848814224;1072.0940805019745;1115.537052123376;1118.2842980492492;9917.504124793732;10143.797124057624;10150.441725705157;10196;10242.795144097076;498540;503662;504617;530907;531229;80114;81651.59174204091;82931.5853420729;83044;84461;1092.0771947704177;1112.6606385052476;1126.245415571569;1132.3432409202642;1149.7757937202332;15503.457378991681;15710.842891571396;15859.762103568224;15970.8402915974;16017.439389621308;34725.1318717024;35217;35400.46899296461;35578.8221058893;37022.074448139014;45623;45966;46524;46633.766831166984;50730.239046415074;8255.958720206361;8397.370197235354;8456.577171141542;8723.956380218058;8823.823523529622;6889.035535025;9715.465649389069;11169.553217871195;11973.76052478928;12584.937075314565;6725.899111513233;10509.894901050891;10832.512536936014;11034.117270618492;11163.218574699693;11249.49377278008;11267.380294083903;11499.827502587636;11736.589219377622;11982.460789264678;11108.833367499332;11166.162537809534;11215.214934954474;11330.093592512743;11409.201355905006;8457.830843382975;8542.35932305092;8843.380963332762;8887.333449991147;8939.865902011605;8816.338774591803;10731.248812583044;10918.23572349928;10999.835002475129;11235.269707468988 16:26:18 INFO - PROCESS | 11742 | |3;mootools.html;1252.07346563543;1528.3198976455474;1528.7630417285318;1754.9561260968474;1899.2213192591041;8369.748907532776;8576.14238576142;8578.142185781426;8585.91414085859;8591.398602097855;8441.198086181817;8614.095519970391;8635.654573817039;8636.13638636136;8643.697470588531;2164.8809315487642;2209.834262430316;2427.9150229741963;2474.7896428803574;2496.0390249753796;2492.289697436231;2498.9875050624814;2502.699676038878;2503.7996960243136;2504.136073054802;2349.8707571083582;2441.292025312657;2447.070113356931;2449.0326321103153;2462.1382516119393;2378.8405768215016;2387.868667223302;2431.7932975697177;2473.356927198923;2485.7141428735567;2471.147454128323;2475.6905386826647;2481.2556233130167;2488.1042824583137;2500.224930271622;8713.477191368474;8800.559972001374;8801.955990220073;8802.823943521094;8813.07462716412;5271.077561426735;5356.223347614613;5400.891982160335;5410.431904649994;5412.539934105605;3123.1879711275005;3235.4014507316224;3236.417444859924;3244.610646722385;3291.6214635316765;1039.4023436524028;1049.9317544359592;1058.4178701714027;1883.1714045819795;1909.9522511937173;11579.478923448465;11653.475593598223;11685.065194784396;11686.357250351228;11686.357250351228;4373.562643735665;4535.138323718483;4557.134144512598;4586.449626044896;4641.234196357631;9114.680986165453;9130.863037054449;9132.908670913206;9138.68014619485;9143.54282285883;5103.106956282636;5116;5119.1553393690365;5122.410922743858;5123.487651234846;4311.784410779448;4632.2819962905805;4656.068786242765;4670.042641258534;4730.739809310521;3718.7396882218527;3768.2086761780333;3789.5642001169667;3809.8285577149095;3812.561555421162;1135.840982262484;1140.4639819284923;1142.440204299887;1144.3248483394837;1146.1518476327624;1434.8923830712738;1458.6572155543438;1476.4610917015427;1491.6867457833976;1499.9700005999819;8388.8741668875;8399.62201700925;8454.957725211458;8455.239028487465;8460.238578527838;520.1547485336329;527.3882296536;531.2164557277985;558.5447859994092;562.0809975689776;6537.705803238866;6544.640044797582;6606.900896486556;6608.438282745924;6670.166229221348;10394.948025259826;10746.623868164577;10862.402567858686;10901.34591924487;10904.127669786398;9822.312438129406;10041.64854230113;10871.945640271748;10919.945400272947;10928.726781830517;8194.631241594143;8240.62917168729;8256.669733210605;8288.627011784483;8326.12575679557;7922.286994170552;7936.166702496154;8246.793830154294;8283.917160828556;8339.374546909128;9517.733607129396;9666;9824.361416507903;9827.901720982698;9880.40717556949;9710.563024664048;9886.406815591088;9975.002499749968;10146.746331341776;10180.898191018292;7299.489035767445;7340.889886651597;7732.265434783687;7804.180561041009;7815.804604884924;8120;8140.470869393471;8170.468919520212;8181.959090204511;8212.46618969765;7492.438067145095;7551.207123251979;7594.088709354913;7921.762347129596;7970.601469926364;7702.922970770444;7742.187070357757;7777.494462859896;7848.9215107848195;7897;7959.124496305518;8000.359971202173;8026.036875574969;8027.598620068857;8032.63853126599;7339.4862359636445;7507.436942229246;7509.812254693457;7517.398608111447;7522.322990930843;7566.35685966699;7569.621518924142;7582.848343033219;7588.354989825927;7588.924110759042 16:26:18 INFO - PROCESS | 11742 | |4;prototype.html;370.5904975002622;370.9109813644726;372.9608391118934;374.1544110310698;383.1322055544193;5978.970105149474;5998.580099393044;6073.9392606073925;6077.149199112122;6109.755609775615;5989.161517387558;5990.101484777286;6000.5499587531;6006.489448396892;6022.066579680157;4467.642588592905;4616.076784643068;4688.179568575502;4753.833615823447;4759.428868535781;4738.384010078685;4752.619790416758;4753.643476739241;4755.0489902019735;4761.381020467335;4650.930286034214;4673.275642275453;4675.8363457279;4682.204025315687;4718.032803275338;4461.08547747711;4597.333386658933;4679.74261415622;4687.039156972813;4713.434387873477;4100.6924480664065;4136.110736191703;4140.296149654566;4160.646345060673;4179.038821071171;5642.181883626892;5659.5755318350875;5669.40471250521;5771.538276937877;5834.941650583482;5493.835184944418;5494.313210848644;5500.58745594078;5502.2296878437055;5508.779648814043;6291.056341548759;6342.460890824285;6354.459870910978;6354.904676429857;6360.55476116672;4380.649548036149;4535.63714902807;4539.4779600346055;4547.931781023287;4648.209804333272;6617;6649.667516624149;6674.966625166891;6678.43233325168;6683.799486015476;4653.348531205634;4655.86032419028;4657.953420465752;4659.534046595313;4668;4729.125111854318;4732.02993386355;4732.100900828831;4734.810607575659;4740.19416699162;5393;5409.729513524387;5416.0792665247;5420.430854760272;5425.159100339453;6289.119523266746;6406.807795766134;6424.614523128534;6429.903551446732;6438.6136831790245;1642.4005238088012;1658.278648787781;1661.202622741067;1665.758465022565;1666.033700453734;1029.2229366828146;1085.92398532102;1104.045001074065;1124.241137232365;1125.4429057616533;6088.726007329681;6112.877742445126;6251.374862513803;6253.78111766086;6260.123582698426;6534.934650653528;6538.411542961061;6542.672866356663;6543.378379053982;6558.245801732862;6147.784827531104;6158.076288556752;6165.8458538536;6168.444839964424;6180.721867515973;3491.266833964845;3506.4915587239707;3517.2262102337445;3519.102628829632;3523.3834079036064;6608.240052394036;6770.32296770319;6775.22084960226;6785.59286442815;6796.694148763318;6626.9337306627285;6679.165104361955;6686.431653309426;6691.866162676719;6692.564983276072;6764.898526522106;6772.729090836311;6784.762533311409;6788.355106264897;6792.117024786845;6504.707288172138;6516.087747715229;6532.83667908287;6533.18335208099;6540.83647908787;6280.403361680633;6431.549791514549;6440.0983862260255;6549.410553050248;6558.114654521769;6866.519343645897;6904.4131248844415;6904.585724856524;6905.585664860125;6917.13535808024;4580.587747102777;4610.585047345755;4620.561046700558;4622.607078398374;4627.514111018295;6647.401733843977;6648.135742353463;6651;6660.333966603301;6666.699998499982;6329.430351268408;6448.9032664511005;6456.096146539394;6464.4828413725845;6467.741290348334;6386.776462823779;6426.389492998158;6439.839004024937;6448.387403196689;6455.935440645533;6313.842153946188;6318.526110541636;6325.240971083499;6325.620462772248;6343.492520598434;6463.741450341934;6473;6476.773312934025;6477.384648458577;6484;6054.091886217103;6145.907811382744;6242.188515492957;6338.904916426165;6339.049142628643 16:26:18 INFO - PROCESS | 11742 | |5;yui.html;789.6446599030436;861.8836457078293;889.8976617688968;904.7195369435475;915.5193523400218;12598.685032874182;12638.747225055493;12676.176048556861;12712.809307860389;12731.61805145846;13414;13534.052616316862;13672.384742686578;13684.726305473885;13689.247091409969;802.7270727952495;936.8594710793367;948.2319321349694;951.3150531617224;970.7379007667926;946.1390134977172;947.5357075033219;947.5735918836517;948.2982592881287;948.900365461627;1017.3590637898151;1017.4912543728136;1017.7201269650868;1018.0328687746634;1019.0980981831059;821.4208982667205;842.1662554071456;976.3946353260952;982.9655962041365;1010.3533738407389;724.9492535522515;730.4740586777511;734.5372415378331;734.8787450070786;736.0578459571757;13624.591262262049;13625.386857591433;13719.931400342934;13747.793783093262;13758.31208439584;12153.331566763825;12565.74868502634;12580.937095314464;12615.116941814076;12698.42857071434;9938.503074846229;9938.652147174815;10047.296689231756;10165.89834101657;10199.4390308533;3338.6661333866664;3377.206356506219;3378.3074469733647;3414.214730611973;3507.7895326280504;55682.16476752852;55839.99999999959;56255.71872140654;56594;57114.714426428014;9723.805523889483;9786.706398808046;9872.802543949081;9887.80224395508;10080.798384032278;19564.804351956584;19667.704984425243;19751.308704195286;19793.901030494755;19814;7312.707491700273;7374.225706300761;7531.397488200931;7569.924300756922;7588.582627955516;3798.4287183173265;3890.1247219375414;3907.296686596383;3926.705497087673;3966.5835087315995;3288.1615188126875;3321.850516726753;3324.966750332514;3328.7004169624365;3332.1169889979174;582.860113572748;592.2005292854698;596.1445325957266;597.4115496236204;610.7434877351523;489.3149590573226;666.7866282789557;666.8199586111723;671.4427025568766;680.8127764864702;7986.840263194704;8061.395395345373;8070.314023308085;8100.149484304063;8298.294644955125;577.5899111630705;598.5839841310335;627.8963970944834;687.4225650453643;694.8992396102536;3688.2992231475932;3865.323568375523;3876.6898648108086;3959.920801583952;3968.861089861841;61253.38746612477;61752.69123654353;61784.38215617876;61913;63354;52864.207036893706;52974.73512632412;53199;53408.46591534113;54716;48296.75851620719;48466.818993145396;48506.51493485091;48739.5126048735;49139.96812661468;7780.49426787257;7967.721129760431;8124.83750325002;8211.096779354386;8282.71010514629;37119;37964;38150.23699525939;38607.80696096614;38681.41977870391;46556.30165547587;47213.763931180125;47612.2858157121;48045.75977120092;48334.758326208146;10797.352158870493;10973.890261097287;11039.282446641264;11070.335779853234;11151.330920144817;10573.4713264338;11124.721881953015;11168.609098681507;11194.432779411052;11269.436528173723;10842.24104312722;10842.403667798031;10885.564577416815;11129.833052504056;11504.827427588425;10648.680539583826;11022.889771102507;11088.279261847954;11579.822975349016;11618.0705543558;9743.415395076318;10429.478526073817;10461.26771126014;10519.94740026295;10526;8773.517456539952;8905.73282801517;8981.685641002534;9016.2786977043;9349;8912.108789121035;8943.552822358986;8986.910130898606;9076;9078.409903356262 16:26:18 INFO - PROCESS | 11742 | __end_tp_report 16:26:18 INFO - PROCESS | 11742 | __start_cc_report 16:26:18 INFO - PROCESS | 11742 | _x_x_mozilla_cycle_collect,882 16:26:18 INFO - PROCESS | 11742 | __end_cc_report 16:26:18 INFO - PROCESS | 11742 | __startTimestamp1460589978811__endTimestamp 16:26:18 INFO - PROCESS | 11742 | 16:26:18 INFO - PROCESS | 11742 | ------- Summary: start ------- 16:26:18 INFO - PROCESS | 11742 | Number of tests: 6 16:26:18 INFO - PROCESS | 11742 | 16:26:18 INFO - PROCESS | 11742 | [#0] dojo.html Cycles:165 Average:5403.93 Median:5605.92 stddev:594.13 (10.6%) stddev-sans-first:571.22 16:26:18 INFO - PROCESS | 11742 | Values: 3241.5 3248.1 3267.9 3293.7 3320.3 5315.8 5368.7 5393.2 5397.4 5418.0 5350.5 5370.6 5378.8 5397.6 5402.2 4854.3 4937.8 4961.9 4992.6 5013.4 4916.1 4962.6 4968.7 5030.0 5032.6 4959.2 4973.7 4979.8 4987.5 4999.5 4876.1 4915.6 4945.7 4977.5 4979.1 4912.5 4950.6 4972.2 4976.8 4981.7 5227.6 5229.7 5287.9 5291.7 5337.1 5741.1 5749.3 5790.8 5792.0 5821.8 5806.3 5812.5 5825.7 5838.1 5847.4 5423.8 5424.0 5428.3 5429.9 5433.5 5856.9 5887.9 5914.3 5917.8 5960.4 5732.7 5735.6 5747.9 5763.6 5764.0 5773.9 5825.4 5828.7 5832.4 5835.5 5674.8 5791.9 5808.3 5835.9 5914.2 5755.8 5811.2 5815.2 5816.9 5825.5 4441.8 4452.8 4455.3 4458.0 4479.4 3949.8 3984.0 4002.0 4052.7 4074.0 5477.0 5480.3 5485.4 5497.0 5500.0 5842.3 5855.6 5856.6 5861.6 5891.8 5325.8 5403.3 5475.7 5492.9 5529.1 5014.1 5043.2 5046.8 5048.8 5080.5 5971.2 6016.8 6056.6 6074.8 6079.5 5798.2 5859.2 5869.4 5870.7 5876.4 6023.3 6027.2 6034.4 6042.3 6043.2 5607.0 5747.3 5784.2 5787.6 5792.3 5802.2 5831.4 5851.8 5854.8 5885.3 5680.1 5682.3 5686.9 5689.6 5690.0 5606.7 5679.3 5679.4 5701.3 5764.6 5577.1 5591.9 5593.4 5605.9 5610.1 5706.7 5725.8 5726.1 5735.4 5736.5 5489.8 5559.6 5575.6 5582.4 5639.4 16:26:18 INFO - PROCESS | 11742 | 16:26:18 INFO - PROCESS | 11742 | [#1] ext.html Cycles:180 Average:47501.98 Median:40567.50 stddev:75487.44 (186.1%) stddev-sans-first:75616.83 16:26:18 INFO - PROCESS | 11742 | Values: 534.3 547.3 580.1 590.5 640.7 40268.6 40597.8 40655.6 40698.0 40699.2 44078.3 44729.0 44764.6 44793.6 44854.1 8714.5 8917.4 8919.4 8924.9 8929.7 8806.5 8932.7 8952.6 9121.8 9138.8 9086.5 9166.8 9176.6 9187.1 9189.8 8994.1 9074.5 9086.5 9094.1 9097.7 8786.1 8898.0 8912.3 9112.5 9128.6 43348.1 43777.6 43818.3 43894.3 43957.3 3713.3 4241.2 4330.2 4415.1 4450.0 32787.5 32944.8 33519.8 34194.3 34969.8 3743.5 3766.3 3766.7 3823.4 3861.9 288128.0 288766.0 289556.0 289570.0 289912.0 46056.3 63650.0 63925.0 64062.0 64110.0 45208.8 45448.3 45522.0 45578.0 45618.8 13248.1 13538.7 13559.9 13578.0 13600.5 12132.2 12155.9 12161.9 12187.2 12212.3 15436.8 15549.8 15595.5 15624.3 15711.7 5677.0 5736.5 5790.4 5791.4 5862.3 971.9 1092.6 1145.9 1162.4 1196.6 30888.4 31653.2 31839.5 31984.7 32577.7 1111.6 1132.3 1172.6 1178.8 1258.6 16669.0 16719.5 16833.2 16834.0 16909.0 323647.0 325585.0 325587.0 327263.0 327881.0 58389.4 59753.1 59759.7 59786.7 59864.0 1302.7 1416.5 1425.3 1450.2 1451.2 27751.6 29083.7 29188.1 29762.9 29890.7 56458.4 57751.1 57967.7 57994.4 58182.0 245137.0 247949.0 248030.0 248696.0 248925.0 40555.0 43524.3 47996.3 48177.8 49402.5 48157.5 48178.3 48262.3 48880.3 49772.8 39531.2 39790.6 40406.4 40408.0 40657.8 38688.8 39657.3 40506.8 40508.4 40885.6 39464.8 40580.0 40640.0 40824.4 41167.6 35338.0 36259.0 36388.0 36707.3 36931.3 27489.2 27552.6 27631.0 27902.6 27905.7 16:26:18 INFO - PROCESS | 11742 | 16:26:18 INFO - PROCESS | 11742 | [#2] jquery.html Cycles:180 Average:27988.25 Median:2482.84 stddev:84146.99 (3389.1%) stddev-sans-first:84357.53 16:26:18 INFO - PROCESS | 11742 | Values: 388.6 389.2 392.7 393.2 402.7 14407.6 15540.9 17356.4 17881.8 17900.6 17161.9 17432.8 17485.5 17539.7 18380.2 5545.0 5761.6 5773.2 5805.3 5827.2 5533.8 5698.7 5768.9 5781.7 5783.2 5708.7 5729.9 5730.4 5739.4 5747.3 5503.3 5709.8 5715.4 5729.4 5745.4 5138.0 5139.0 5144.5 5155.3 5161.2 20858.6 21262.8 21283.1 21620.5 21647.8 2311.3 2433.4 2461.8 2503.9 2696.3 12760.6 12964.4 13021.3 13068.8 13085.3 1703.8 1722.3 1736.9 1744.9 1798.9 60506.7 62369.7 63495.7 63799.4 65142.0 9775.0 10103.6 10409.4 10504.8 10507.0 14515.1 14686.6 14697.6 14709.1 14717.6 7330.7 7840.4 7852.7 7856.1 7958.1 7291.8 7312.6 7342.6 7389.4 7411.0 4706.3 4755.4 4771.9 4814.7 4830.7 1720.6 1875.9 1934.6 1955.9 1960.5 913.3 1012.4 1034.5 1082.6 1160.3 16856.5 16878.7 16978.8 17209.7 19244.0 1021.2 1023.6 1072.1 1115.5 1118.3 9917.5 10143.8 10150.4 10196.0 10242.8 498540.0 503662.0 504617.0 530907.0 531229.0 80114.0 81651.6 82931.6 83044.0 84461.0 1092.1 1112.7 1126.2 1132.3 1149.8 15503.5 15710.8 15859.8 15970.8 16017.4 34725.1 35217.0 35400.5 35578.8 37022.1 45623.0 45966.0 46524.0 46633.8 50730.2 8256.0 8397.4 8456.6 8724.0 8823.8 6889.0 9715.5 11169.6 11973.8 12584.9 6725.9 10509.9 10832.5 11034.1 11163.2 11249.5 11267.4 11499.8 11736.6 11982.5 11108.8 11166.2 11215.2 11330.1 11409.2 8457.8 8542.4 8843.4 8887.3 8939.9 8816.3 10731.2 10918.2 10999.8 11235.3 16:26:18 INFO - PROCESS | 11742 | 16:26:18 INFO - PROCESS | 11742 | [#3] mootools.html Cycles:180 Average:6067.86 Median:5378.56 stddev:3215.94 (59.8%) stddev-sans-first:3204.58 16:26:18 INFO - PROCESS | 11742 | Values: 1252.1 1528.3 1528.8 1755.0 1899.2 8369.7 8576.1 8578.1 8585.9 8591.4 8441.2 8614.1 8635.7 8636.1 8643.7 2164.9 2209.8 2427.9 2474.8 2496.0 2492.3 2499.0 2502.7 2503.8 2504.1 2349.9 2441.3 2447.1 2449.0 2462.1 2378.8 2387.9 2431.8 2473.4 2485.7 2471.1 2475.7 2481.3 2488.1 2500.2 8713.5 8800.6 8802.0 8802.8 8813.1 5271.1 5356.2 5400.9 5410.4 5412.5 3123.2 3235.4 3236.4 3244.6 3291.6 1039.4 1049.9 1058.4 1883.2 1910.0 11579.5 11653.5 11685.1 11686.4 11686.4 4373.6 4535.1 4557.1 4586.4 4641.2 9114.7 9130.9 9132.9 9138.7 9143.5 5103.1 5116.0 5119.2 5122.4 5123.5 4311.8 4632.3 4656.1 4670.0 4730.7 3718.7 3768.2 3789.6 3809.8 3812.6 1135.8 1140.5 1142.4 1144.3 1146.2 1434.9 1458.7 1476.5 1491.7 1500.0 8388.9 8399.6 8455.0 8455.2 8460.2 520.2 527.4 531.2 558.5 562.1 6537.7 6544.6 6606.9 6608.4 6670.2 10394.9 10746.6 10862.4 10901.3 10904.1 9822.3 10041.6 10871.9 10919.9 10928.7 8194.6 8240.6 8256.7 8288.6 8326.1 7922.3 7936.2 8246.8 8283.9 8339.4 9517.7 9666.0 9824.4 9827.9 9880.4 9710.6 9886.4 9975.0 10146.7 10180.9 7299.5 7340.9 7732.3 7804.2 7815.8 8120.0 8140.5 8170.5 8182.0 8212.5 7492.4 7551.2 7594.1 7921.8 7970.6 7702.9 7742.2 7777.5 7848.9 7897.0 7959.1 8000.4 8026.0 8027.6 8032.6 7339.5 7507.4 7509.8 7517.4 7522.3 7566.4 7569.6 7582.8 7588.4 7588.9 16:26:18 INFO - PROCESS | 11742 | 16:26:18 INFO - PROCESS | 11742 | [#4] prototype.html Cycles:180 Average:5378.79 Median:6099.24 stddev:1591.82 (26.1%) stddev-sans-first:1551.27 16:26:18 INFO - PROCESS | 11742 | Values: 370.6 370.9 373.0 374.2 383.1 5979.0 5998.6 6073.9 6077.1 6109.8 5989.2 5990.1 6000.5 6006.5 6022.1 4467.6 4616.1 4688.2 4753.8 4759.4 4738.4 4752.6 4753.6 4755.0 4761.4 4650.9 4673.3 4675.8 4682.2 4718.0 4461.1 4597.3 4679.7 4687.0 4713.4 4100.7 4136.1 4140.3 4160.6 4179.0 5642.2 5659.6 5669.4 5771.5 5834.9 5493.8 5494.3 5500.6 5502.2 5508.8 6291.1 6342.5 6354.5 6354.9 6360.6 4380.6 4535.6 4539.5 4547.9 4648.2 6617.0 6649.7 6675.0 6678.4 6683.8 4653.3 4655.9 4658.0 4659.5 4668.0 4729.1 4732.0 4732.1 4734.8 4740.2 5393.0 5409.7 5416.1 5420.4 5425.2 6289.1 6406.8 6424.6 6429.9 6438.6 1642.4 1658.3 1661.2 1665.8 1666.0 1029.2 1085.9 1104.0 1124.2 1125.4 6088.7 6112.9 6251.4 6253.8 6260.1 6534.9 6538.4 6542.7 6543.4 6558.2 6147.8 6158.1 6165.8 6168.4 6180.7 3491.3 3506.5 3517.2 3519.1 3523.4 6608.2 6770.3 6775.2 6785.6 6796.7 6626.9 6679.2 6686.4 6691.9 6692.6 6764.9 6772.7 6784.8 6788.4 6792.1 6504.7 6516.1 6532.8 6533.2 6540.8 6280.4 6431.5 6440.1 6549.4 6558.1 6866.5 6904.4 6904.6 6905.6 6917.1 4580.6 4610.6 4620.6 4622.6 4627.5 6647.4 6648.1 6651.0 6660.3 6666.7 6329.4 6448.9 6456.1 6464.5 6467.7 6386.8 6426.4 6439.8 6448.4 6455.9 6313.8 6318.5 6325.2 6325.6 6343.5 6463.7 6473.0 6476.8 6477.4 6484.0 6054.1 6145.9 6242.2 6338.9 6339.0 16:26:18 INFO - PROCESS | 11742 | 16:26:18 INFO - PROCESS | 11742 | [#5] yui.html Cycles:180 Average:14340.01 Median:48486.67 stddev:17393.07 (35.9%) stddev-sans-first:17412.10 16:26:18 INFO - PROCESS | 11742 | Values: 789.6 861.9 889.9 904.7 915.5 12598.7 12638.7 12676.2 12712.8 12731.6 13414.0 13534.1 13672.4 13684.7 13689.2 802.7 936.9 948.2 951.3 970.7 946.1 947.5 947.6 948.3 948.9 1017.4 1017.5 1017.7 1018.0 1019.1 821.4 842.2 976.4 983.0 1010.4 724.9 730.5 734.5 734.9 736.1 13624.6 13625.4 13719.9 13747.8 13758.3 12153.3 12565.7 12580.9 12615.1 12698.4 9938.5 9938.7 10047.3 10165.9 10199.4 3338.7 3377.2 3378.3 3414.2 3507.8 55682.2 55840.0 56255.7 56594.0 57114.7 9723.8 9786.7 9872.8 9887.8 10080.8 19564.8 19667.7 19751.3 19793.9 19814.0 7312.7 7374.2 7531.4 7569.9 7588.6 3798.4 3890.1 3907.3 3926.7 3966.6 3288.2 3321.9 3325.0 3328.7 3332.1 582.9 592.2 596.1 597.4 610.7 489.3 666.8 666.8 671.4 680.8 7986.8 8061.4 8070.3 8100.1 8298.3 577.6 598.6 627.9 687.4 694.9 3688.3 3865.3 3876.7 3959.9 3968.9 61253.4 61752.7 61784.4 61913.0 63354.0 52864.2 52974.7 53199.0 53408.5 54716.0 48296.8 48466.8 48506.5 48739.5 49140.0 7780.5 7967.7 8124.8 8211.1 8282.7 37119.0 37964.0 38150.2 38607.8 38681.4 46556.3 47213.8 47612.3 48045.8 48334.8 10797.4 10973.9 11039.3 11070.3 11151.3 10573.5 11124.7 11168.6 11194.4 11269.4 10842.2 10842.4 10885.6 11129.8 11504.8 10648.7 11022.9 11088.3 11579.8 11618.1 9743.4 10429.5 10461.3 10519.9 10526.0 8773.5 8905.7 8981.7 9016.3 9349.0 8912.1 8943.6 8986.9 9076.0 9078.4 16:26:18 INFO - PROCESS | 11742 | -------- Summary: end -------- 16:26:18 INFO - PROCESS | 11742 | 16:26:19 INFO - TEST-INFO | 11742: exit 0 16:26:19 INFO - TEST-OK | dromaeo_css | took 1111751ms 16:26:19 INFO - TEST-START | kraken 16:26:19 INFO - operating with platform_type : linux_ 16:26:19 INFO - Initialising browser for kraken test... 16:26:19 INFO - TEST-INFO | started process 11938 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpy43E19/profile http://localhost:42347/getInfo.html) 16:26:23 INFO - PROCESS | 11938 | __metrics Screen width/height:1600/1200 16:26:23 INFO - PROCESS | 11938 | colorDepth:24 16:26:23 INFO - PROCESS | 11938 | Browser inner width/height: 1024/697 16:26:23 INFO - PROCESS | 11938 | __metrics 16:26:25 INFO - PROCESS | 11938 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:26:25 INFO - TEST-INFO | 11938: exit 0 16:26:25 INFO - Browser initialized. 16:26:25 INFO - Running cycle 1/1 for kraken test... 16:26:26 INFO - TEST-INFO | started process 12033 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpy43E19/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:26:37 INFO - PROCESS | 12033 | RSS: Main: 141783040 16:26:37 INFO - PROCESS | 12033 | 16:26:40 INFO - PROCESS | 12033 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42347/tests/kraken/driver.html?testName=audio-beat-detection) 16:26:40 INFO - PROCESS | 12033 | RSS: Main: 177971200 16:26:40 INFO - PROCESS | 12033 | 16:26:43 INFO - PROCESS | 12033 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42347/tests/kraken/driver.html?testName=audio-dft) 16:26:44 INFO - PROCESS | 12033 | RSS: Main: 176070656 16:26:44 INFO - PROCESS | 12033 | 16:26:46 INFO - PROCESS | 12033 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42347/tests/kraken/driver.html?testName=audio-fft) 16:26:47 INFO - PROCESS | 12033 | RSS: Main: 173436928 16:26:47 INFO - PROCESS | 12033 | 16:26:49 INFO - PROCESS | 12033 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42347/tests/kraken/driver.html?testName=audio-oscillator) 16:26:50 INFO - PROCESS | 12033 | RSS: Main: 173645824 16:26:50 INFO - PROCESS | 12033 | 16:26:52 INFO - PROCESS | 12033 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42347/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:26:52 INFO - PROCESS | 12033 | RSS: Main: 171421696 16:26:52 INFO - PROCESS | 12033 | 16:26:55 INFO - PROCESS | 12033 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42347/tests/kraken/driver.html?testName=imaging-darkroom) 16:26:56 INFO - PROCESS | 12033 | RSS: Main: 171188224 16:26:56 INFO - PROCESS | 12033 | 16:26:59 INFO - PROCESS | 12033 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42347/tests/kraken/driver.html?testName=imaging-desaturate) 16:27:00 INFO - PROCESS | 12033 | RSS: Main: 172011520 16:27:00 INFO - PROCESS | 12033 | 16:27:03 INFO - PROCESS | 12033 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42347/tests/kraken/driver.html?testName=json-parse-financial) 16:27:03 INFO - PROCESS | 12033 | RSS: Main: 172097536 16:27:03 INFO - PROCESS | 12033 | 16:27:05 INFO - PROCESS | 12033 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42347/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:27:05 INFO - PROCESS | 12033 | RSS: Main: 175759360 16:27:05 INFO - PROCESS | 12033 | 16:27:07 INFO - PROCESS | 12033 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:27:08 INFO - PROCESS | 12033 | RSS: Main: 174329856 16:27:08 INFO - PROCESS | 12033 | 16:27:10 INFO - PROCESS | 12033 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:27:10 INFO - PROCESS | 12033 | RSS: Main: 180109312 16:27:10 INFO - PROCESS | 12033 | 16:27:13 INFO - PROCESS | 12033 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:27:13 INFO - PROCESS | 12033 | RSS: Main: 186990592 16:27:13 INFO - PROCESS | 12033 | 16:27:16 INFO - PROCESS | 12033 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:27:16 INFO - PROCESS | 12033 | RSS: Main: 187273216 16:27:16 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | Cycle 1(1): loaded http://localhost:42347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42347/tests/kraken/driver.html?testName=ai-astar) 16:27:18 INFO - PROCESS | 12033 | RSS: Main: 249430016 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | __start_tp_report 16:27:18 INFO - PROCESS | 12033 | _x_x_mozilla_page_load 16:27:18 INFO - PROCESS | 12033 | _x_x_mozilla_page_load_details 16:27:18 INFO - PROCESS | 12033 | |i|pagename|runs| 16:27:18 INFO - PROCESS | 12033 | |0;ai-astar;110;110;105;110;108;110;100;109;108;108 16:27:18 INFO - PROCESS | 12033 | |1;audio-beat-detection;167;127;150;167;129;158;155;129;180;128 16:27:18 INFO - PROCESS | 12033 | |2;audio-dft;163;162;161;160;163;161;164;166;161;161 16:27:18 INFO - PROCESS | 12033 | |3;audio-fft;76;75;74;175;76;76;77;77;166;77 16:27:18 INFO - PROCESS | 12033 | |4;audio-oscillator;93;93;141;93;93;93;139;93;93;140 16:27:18 INFO - PROCESS | 12033 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 16:27:18 INFO - PROCESS | 12033 | |6;imaging-darkroom;146;146;147;147;147;146;146;146;147;147 16:27:18 INFO - PROCESS | 12033 | |7;imaging-desaturate;95;95;96;96;96;96;96;96;95;96 16:27:18 INFO - PROCESS | 12033 | |8;json-parse-financial;53;55;55;55;58;55;56;66;53;54 16:27:18 INFO - PROCESS | 12033 | |9;json-stringify-tinderbox;63;64;64;64;66;64;63;64;67;64 16:27:18 INFO - PROCESS | 12033 | |10;stanford-crypto-aes;77;78;79;79;79;78;79;79;79;79 16:27:18 INFO - PROCESS | 12033 | |11;stanford-crypto-ccm;112;113;115;112;112;117;113;111;112;125 16:27:18 INFO - PROCESS | 12033 | |12;stanford-crypto-pbkdf2;149;127;135;138;137;132;138;138;138;137 16:27:18 INFO - PROCESS | 12033 | |13;stanford-crypto-sha256-iterative;66;75;66;68;65;65;68;67;64;64 16:27:18 INFO - PROCESS | 12033 | __end_tp_report 16:27:18 INFO - PROCESS | 12033 | __start_cc_report 16:27:18 INFO - PROCESS | 12033 | _x_x_mozilla_cycle_collect,1079 16:27:18 INFO - PROCESS | 12033 | __end_cc_report 16:27:18 INFO - PROCESS | 12033 | __startTimestamp1460590038713__endTimestamp 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | ------- Summary: start ------- 16:27:18 INFO - PROCESS | 12033 | Number of tests: 14 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | [#0] ai-astar Cycles:10 Average:107.80 Median:109.50 stddev:3.16 (2.9%) stddev-sans-first:3.24 16:27:18 INFO - PROCESS | 12033 | Values: 110.0 110.0 105.0 110.0 108.0 110.0 100.0 109.0 108.0 108.0 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:156.50 stddev:19.58 (12.5%) stddev-sans-first:19.66 16:27:18 INFO - PROCESS | 12033 | Values: 167.0 127.0 150.0 167.0 129.0 158.0 155.0 129.0 180.0 128.0 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.81 (1.1%) stddev-sans-first:1.90 16:27:18 INFO - PROCESS | 12033 | Values: 163.0 162.0 161.0 160.0 163.0 161.0 164.0 166.0 161.0 161.0 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.00 stddev:39.91 (52.5%) stddev-sans-first:41.74 16:27:18 INFO - PROCESS | 12033 | Values: 76.0 75.0 74.0 175.0 76.0 76.0 77.0 77.0 166.0 77.0 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | [#4] audio-oscillator Cycles:10 Average:107.10 Median:93.00 stddev:22.71 (24.4%) stddev-sans-first:23.51 16:27:18 INFO - PROCESS | 12033 | Values: 93.0 93.0 141.0 93.0 93.0 93.0 139.0 93.0 93.0 140.0 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:27:18 INFO - PROCESS | 12033 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 16:27:18 INFO - PROCESS | 12033 | Values: 146.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 147.0 147.0 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 16:27:18 INFO - PROCESS | 12033 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:55.00 stddev:3.80 (6.9%) stddev-sans-first:3.87 16:27:18 INFO - PROCESS | 12033 | Values: 53.0 55.0 55.0 55.0 58.0 55.0 56.0 66.0 53.0 54.0 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:1.25 (2.0%) stddev-sans-first:1.24 16:27:18 INFO - PROCESS | 12033 | Values: 63.0 64.0 64.0 64.0 66.0 64.0 63.0 64.0 67.0 64.0 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:0.70 (0.9%) stddev-sans-first:0.44 16:27:18 INFO - PROCESS | 12033 | Values: 77.0 78.0 79.0 79.0 79.0 78.0 79.0 79.0 79.0 79.0 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | [#11] stanford-crypto-ccm Cycles:10 Average:114.20 Median:113.00 stddev:4.18 (3.7%) stddev-sans-first:4.36 16:27:18 INFO - PROCESS | 12033 | Values: 112.0 113.0 115.0 112.0 112.0 117.0 113.0 111.0 112.0 125.0 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.90 Median:138.00 stddev:5.55 (4.0%) stddev-sans-first:3.78 16:27:18 INFO - PROCESS | 12033 | Values: 149.0 127.0 135.0 138.0 137.0 132.0 138.0 138.0 138.0 137.0 16:27:18 INFO - PROCESS | 12033 | 16:27:18 INFO - PROCESS | 12033 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:3.22 (4.8%) stddev-sans-first:3.41 16:27:18 INFO - PROCESS | 12033 | Values: 66.0 75.0 66.0 68.0 65.0 65.0 68.0 67.0 64.0 64.0 16:27:18 INFO - PROCESS | 12033 | -------- Summary: end -------- 16:27:18 INFO - PROCESS | 12033 | 16:27:19 INFO - TEST-INFO | 12033: exit 0 16:27:19 INFO - TEST-OK | kraken | took 60177ms 16:27:19 INFO - SUITE-END | took 1171s 16:27:19 INFO - Completed test suite (00:19:32) 16:27:19 INFO - javascript benchmark 16:27:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3241.4813629819228, 3248.1230067881675, 3267.9346413071753, 3293.687099725525, 3320.2529430878058, 5315.8405247842575, 5368.651037682553, 5393.164059570773, 5397.4062853086225, 5417.972910135449, 5350.5184533391985, 5370.570354371651, 5378.811741589036, 5397.568194544427, 5402.189671549259, 4854.271859221128, 4937.802487900498, 4961.875953101175, 4992.625553083515, 5013.398392192942, 4916.139675556763, 4962.60299176065, 4968.677035992649, 5030.0, 5032.597392208614, 4959.156943319626, 4973.701577905337, 4979.751012449381, 4987.501249875002, 4999.500049995007, 4876.122297986361, 4915.5821755150855, 4945.653804233705, 4977.452480227172, 4979.078870408968, 4912.508749125094, 4950.628702847265, 4972.204447288453, 4976.825811096631, 4981.701097934099, 5227.60792940531, 5229.660072095339, 5287.920681189786, 5291.682499050069, 5337.092694241988, 5741.081426971707, 5749.281339832521, 5790.826275211751, 5792.0, 5821.8253452396075, 5806.332271788756, 5812.476877081041, 5825.679587622679, 5838.095095260242, 5847.44449277318, 5423.810166644227, 5423.972880135613, 5428.321459817563, 5429.918551221735, 5433.483819037185, 5856.912146317723, 5887.911681324784, 5914.319853216935, 5917.7928772493615, 5960.433758792908, 5732.71336433185, 5735.569832262597, 5747.942520574825, 5763.567732420085, 5764.048931926185, 5773.855653608609, 5825.4174582542255, 5828.708564571754, 5832.445917637818, 5835.533157347402, 5674.829755107354, 5791.942080579141, 5808.30300363959, 5835.883282334329, 5914.2311499504785, 5755.767700875066, 5811.15738217956, 5815.2149459822385, 5816.894789989973, 5825.50483208932, 4441.800118994653, 4452.799624016927, 4455.309427038814, 4457.977710111429, 4479.440069991251, 3949.8420063197723, 3983.980080099581, 4001.959980400217, 4052.65552428041, 4073.961139909304, 5476.972615136979, 5480.287562616914, 5485.369182544058, 5497.038018346853, 5500.037493438632, 5842.269716285465, 5855.560832937462, 5856.619319744203, 5861.648301101947, 5891.764329426775, 5325.840224793263, 5403.297571315704, 5475.698836564027, 5492.890142197213, 5529.060059789846, 5014.122528557488, 5043.167877300204, 5046.798128074909, 5048.8232911848645, 5080.542751152414, 5971.223740913653, 6016.849578760566, 6056.606320589148, 6074.75700971965, 6079.544034197453, 5798.217240672455, 5859.179714839841, 5869.413058694096, 5870.735816888336, 5876.41235876409, 6023.27720673522, 6027.21646185993, 6034.39656034393, 6042.305134909541, 6043.214382130295, 5607.046802043744, 5747.252857128547, 5784.190213370048, 5787.623804452697, 5792.333881603501, 5802.187693722966, 5831.387704291158, 5851.765929362778, 5854.765809367577, 5885.323187833454, 5680.091185410314, 5682.318121825242, 5686.886262274648, 5689.630174038674, 5689.971550142222, 5606.6916319602815, 5679.290088738908, 5679.432056794288, 5701.344345400166, 5764.625299355528, 5577.079781836114, 5591.916121258266, 5593.384727679871, 5605.915911261252, 5610.102383618601, 5706.743196556248, 5725.828225153252, 5726.141078838207, 5735.3977832327, 5736.4550367715, 5489.807856724996, 5559.555235581063, 5575.637583557056, 5582.3859375467855, 5639.407862174413], "unit": "score", "name": "dojo.html", "value": 5365.714364712927}, {"lowerIsBetter": false, "replicates": [534.2867272191621, 547.3404547520239, 580.1124279851825, 590.4597293476469, 640.65404681472, 40268.597314026854, 40597.78206653798, 40655.59344406555, 40698.0, 40699.186016279695, 44078.33882491757, 44729.0, 44764.552354476444, 44793.55206447934, 44854.10291794162, 8714.477131372121, 8917.375783695144, 8919.375643704943, 8924.910750892506, 8929.687460938869, 8806.471611703286, 8932.687355942511, 8952.641894324252, 9121.771955701095, 9138.77153071172, 9086.50024248666, 9166.816663666723, 9176.632934682604, 9187.127222913847, 9189.770255743593, 8994.145556172152, 9074.500902450363, 9086.454812711225, 9094.09059094092, 9097.727068187965, 8786.121387861227, 8897.955510222473, 8912.331575131826, 9112.453252804853, 9128.634854605807, 43348.133037339394, 43777.56222437767, 43818.342724859154, 43894.34158487625, 43957.340639890426, 3713.3316003119426, 4241.215375155575, 4330.17726631939, 4415.094905544356, 4449.9555004450185, 32787.50818737721, 32944.83527582371, 33519.83240083808, 34194.316113677836, 34969.82515087408, 3743.5320584926885, 3766.2589788390615, 3766.7174961877968, 3823.4073718573663, 3861.864834730771, 288128.0, 288766.0, 289556.0, 289570.0, 289912.0, 46056.309155362695, 63650.0, 63925.0, 64062.0, 64110.0, 45208.77395613001, 45448.318275225894, 45522.0, 45578.0, 45618.77190614092, 13248.072634915656, 13538.661533461742, 13559.864401356057, 13578.049536532546, 13600.455981760817, 12132.211406258564, 12155.878441215651, 12161.939190303992, 12187.232851236698, 12212.267263964013, 15436.845631543765, 15549.844501555066, 15595.532134035997, 15624.296906639229, 15711.743060555129, 5677.0, 5736.512396446349, 5790.36306006339, 5791.362950075489, 5862.339440145095, 971.8542218667257, 1092.5575142067476, 1145.894212085325, 1162.3955543117531, 1196.5991392883307, 30888.382232355227, 31653.20866978344, 31839.52240716391, 31984.680153198635, 32577.674223257938, 1111.5664890692635, 1132.2810015640127, 1172.5778719660916, 1178.750524444092, 1258.6098309524077, 16668.999720033673, 16719.498415047325, 16833.242504087102, 16834.0, 16909.0, 323647.0, 325585.0, 325587.0, 327263.0, 327881.0, 58389.4161058384, 59753.10370344448, 59759.70120149371, 59786.70106649439, 59864.0, 1302.6743314171458, 1416.525463969561, 1425.308725268244, 1450.2241300903966, 1451.1945870042016, 27751.583726244527, 29083.7091629081, 29188.124356268498, 29762.851185743933, 29890.70109298879, 56458.43541564532, 57751.1337329932, 57967.71016144892, 57994.4200557989, 58182.0, 245137.0, 247949.0, 248030.0, 248696.0, 248925.0, 40555.0, 43524.347134793636, 47996.280055798496, 48177.75911120422, 49402.50597493979, 48157.5184248153, 48178.27732583944, 48262.276065858336, 48880.26679599738, 49772.751136244086, 39531.2093758129, 39790.60209397985, 40406.39390409205, 40408.0, 40657.79671101626, 38688.80655596704, 39657.29494265793, 40506.79746601248, 40508.392374115, 40885.59114408937, 39464.80267598759, 40580.0, 40640.0, 40824.38763418492, 41167.588324116376, 35338.0, 36259.0, 36388.0, 36707.26585468329, 36931.26137477181, 27489.17532474029, 27552.586711198946, 27631.0, 27902.581461277692, 27905.720942791126], "unit": "score", "name": "ext.html", "value": 19330.60774851739}, {"lowerIsBetter": false, "replicates": [388.57451091055293, 389.2348200908875, 392.7113571524929, 393.21553500765975, 402.7221217360021, 14407.567772966828, 15540.922295388535, 17356.392526261585, 17881.82118178818, 17900.64198716025, 17161.914190429063, 17432.825671743278, 17485.475435736917, 17539.73690394645, 18380.17289221985, 5544.972275138619, 5761.596688231825, 5773.162891380747, 5805.274340707411, 5827.213326200972, 5533.778648854041, 5698.7435565399655, 5768.855778605526, 5781.739821708034, 5783.2481777368885, 5708.686022268774, 5729.885402291951, 5730.36965933747, 5739.368669446358, 5747.33905600855, 5503.284573005503, 5709.77160913563, 5715.428457154272, 5729.369769325371, 5745.396733343023, 5137.974310128463, 5139.049275883974, 5144.485551444863, 5155.329807125087, 5161.225816127573, 20858.5828283435, 21262.787372126237, 21283.14867405302, 21620.459488512755, 21647.783522164733, 2311.341267738703, 2433.367324495644, 2461.79074778644, 2503.8873250703764, 2696.312440327704, 12760.617181484571, 12964.416601252966, 13021.348932553428, 13068.803967940488, 13085.345732713422, 1703.846653801164, 1722.3024675006518, 1736.9044702541355, 1744.877858549902, 1798.910054497283, 60506.69746651283, 62369.68815155941, 63495.6825215871, 63799.36200637981, 65142.02286965699, 9774.951125244328, 10103.64637237708, 10409.386545085372, 10504.791948925818, 10507.0, 14515.129092254498, 14686.55940321792, 14697.632559186106, 14709.117452952856, 14717.55847324582, 7330.7171245031905, 7840.372770178372, 7852.725154619561, 7856.135825059353, 7958.129839487716, 7291.781246562506, 7312.561246325237, 7342.632868356561, 7389.371903388273, 7411.0, 4706.317583950308, 4755.381800366, 4771.904561908743, 4814.735189564608, 4830.686005409637, 1720.5612568795127, 1875.896825674601, 1934.6324198402258, 1955.9119839606967, 1960.5098725318671, 913.2511340700695, 1012.3571532077037, 1034.4569101221769, 1082.5940272397852, 1160.3038177093845, 16856.494305170865, 16878.74681879773, 16978.830211697972, 17209.7418538722, 19244.0, 1021.1575450253571, 1023.5649848814224, 1072.0940805019745, 1115.537052123376, 1118.2842980492492, 9917.504124793732, 10143.797124057624, 10150.441725705157, 10196.0, 10242.795144097076, 498540.0, 503662.0, 504617.0, 530907.0, 531229.0, 80114.0, 81651.59174204091, 82931.5853420729, 83044.0, 84461.0, 1092.0771947704177, 1112.6606385052476, 1126.245415571569, 1132.3432409202642, 1149.7757937202332, 15503.457378991681, 15710.842891571396, 15859.762103568224, 15970.8402915974, 16017.439389621308, 34725.1318717024, 35217.0, 35400.46899296461, 35578.8221058893, 37022.074448139014, 45623.0, 45966.0, 46524.0, 46633.766831166984, 50730.239046415074, 8255.958720206361, 8397.370197235354, 8456.577171141542, 8723.956380218058, 8823.823523529622, 6889.035535025, 9715.465649389069, 11169.553217871195, 11973.76052478928, 12584.937075314565, 6725.899111513233, 10509.894901050891, 10832.512536936014, 11034.117270618492, 11163.218574699693, 11249.49377278008, 11267.380294083903, 11499.827502587636, 11736.589219377622, 11982.460789264678, 11108.833367499332, 11166.162537809534, 11215.214934954474, 11330.093592512743, 11409.201355905006, 8457.830843382975, 8542.35932305092, 8843.380963332762, 8887.333449991147, 8939.865902011605, 8816.338774591803, 10731.248812583044, 10918.23572349928, 10999.835002475129, 11235.269707468988], "unit": "score", "name": "jquery.html", "value": 8796.597716779204}, {"lowerIsBetter": false, "replicates": [1252.07346563543, 1528.3198976455474, 1528.7630417285318, 1754.9561260968474, 1899.2213192591041, 8369.748907532776, 8576.14238576142, 8578.142185781426, 8585.91414085859, 8591.398602097855, 8441.198086181817, 8614.095519970391, 8635.654573817039, 8636.13638636136, 8643.697470588531, 2164.8809315487642, 2209.834262430316, 2427.9150229741963, 2474.7896428803574, 2496.0390249753796, 2492.289697436231, 2498.9875050624814, 2502.699676038878, 2503.7996960243136, 2504.136073054802, 2349.8707571083582, 2441.292025312657, 2447.070113356931, 2449.0326321103153, 2462.1382516119393, 2378.8405768215016, 2387.868667223302, 2431.7932975697177, 2473.356927198923, 2485.7141428735567, 2471.147454128323, 2475.6905386826647, 2481.2556233130167, 2488.1042824583137, 2500.224930271622, 8713.477191368474, 8800.559972001374, 8801.955990220073, 8802.823943521094, 8813.07462716412, 5271.077561426735, 5356.223347614613, 5400.891982160335, 5410.431904649994, 5412.539934105605, 3123.1879711275005, 3235.4014507316224, 3236.417444859924, 3244.610646722385, 3291.6214635316765, 1039.4023436524028, 1049.9317544359592, 1058.4178701714027, 1883.1714045819795, 1909.9522511937173, 11579.478923448465, 11653.475593598223, 11685.065194784396, 11686.357250351228, 11686.357250351228, 4373.562643735665, 4535.138323718483, 4557.134144512598, 4586.449626044896, 4641.234196357631, 9114.680986165453, 9130.863037054449, 9132.908670913206, 9138.68014619485, 9143.54282285883, 5103.106956282636, 5116.0, 5119.1553393690365, 5122.410922743858, 5123.487651234846, 4311.784410779448, 4632.2819962905805, 4656.068786242765, 4670.042641258534, 4730.739809310521, 3718.7396882218527, 3768.2086761780333, 3789.5642001169667, 3809.8285577149095, 3812.561555421162, 1135.840982262484, 1140.4639819284923, 1142.440204299887, 1144.3248483394837, 1146.1518476327624, 1434.8923830712738, 1458.6572155543438, 1476.4610917015427, 1491.6867457833976, 1499.9700005999819, 8388.8741668875, 8399.62201700925, 8454.957725211458, 8455.239028487465, 8460.238578527838, 520.1547485336329, 527.3882296536, 531.2164557277985, 558.5447859994092, 562.0809975689776, 6537.705803238866, 6544.640044797582, 6606.900896486556, 6608.438282745924, 6670.166229221348, 10394.948025259826, 10746.623868164577, 10862.402567858686, 10901.34591924487, 10904.127669786398, 9822.312438129406, 10041.64854230113, 10871.945640271748, 10919.945400272947, 10928.726781830517, 8194.631241594143, 8240.62917168729, 8256.669733210605, 8288.627011784483, 8326.12575679557, 7922.286994170552, 7936.166702496154, 8246.793830154294, 8283.917160828556, 8339.374546909128, 9517.733607129396, 9666.0, 9824.361416507903, 9827.901720982698, 9880.40717556949, 9710.563024664048, 9886.406815591088, 9975.002499749968, 10146.746331341776, 10180.898191018292, 7299.489035767445, 7340.889886651597, 7732.265434783687, 7804.180561041009, 7815.804604884924, 8120.0, 8140.470869393471, 8170.468919520212, 8181.959090204511, 8212.46618969765, 7492.438067145095, 7551.207123251979, 7594.088709354913, 7921.762347129596, 7970.601469926364, 7702.922970770444, 7742.187070357757, 7777.494462859896, 7848.9215107848195, 7897.0, 7959.124496305518, 8000.359971202173, 8026.036875574969, 8027.598620068857, 8032.63853126599, 7339.4862359636445, 7507.436942229246, 7509.812254693457, 7517.398608111447, 7522.322990930843, 7566.35685966699, 7569.621518924142, 7582.848343033219, 7588.354989825927, 7588.924110759042], "unit": "score", "name": "mootools.html", "value": 4874.285550503552}, {"lowerIsBetter": false, "replicates": [370.5904975002622, 370.9109813644726, 372.9608391118934, 374.1544110310698, 383.1322055544193, 5978.970105149474, 5998.580099393044, 6073.9392606073925, 6077.149199112122, 6109.755609775615, 5989.161517387558, 5990.101484777286, 6000.5499587531, 6006.489448396892, 6022.066579680157, 4467.642588592905, 4616.076784643068, 4688.179568575502, 4753.833615823447, 4759.428868535781, 4738.384010078685, 4752.619790416758, 4753.643476739241, 4755.0489902019735, 4761.381020467335, 4650.930286034214, 4673.275642275453, 4675.8363457279, 4682.204025315687, 4718.032803275338, 4461.08547747711, 4597.333386658933, 4679.74261415622, 4687.039156972813, 4713.434387873477, 4100.6924480664065, 4136.110736191703, 4140.296149654566, 4160.646345060673, 4179.038821071171, 5642.181883626892, 5659.5755318350875, 5669.40471250521, 5771.538276937877, 5834.941650583482, 5493.835184944418, 5494.313210848644, 5500.58745594078, 5502.2296878437055, 5508.779648814043, 6291.056341548759, 6342.460890824285, 6354.459870910978, 6354.904676429857, 6360.55476116672, 4380.649548036149, 4535.63714902807, 4539.4779600346055, 4547.931781023287, 4648.209804333272, 6617.0, 6649.667516624149, 6674.966625166891, 6678.43233325168, 6683.799486015476, 4653.348531205634, 4655.86032419028, 4657.953420465752, 4659.534046595313, 4668.0, 4729.125111854318, 4732.02993386355, 4732.100900828831, 4734.810607575659, 4740.19416699162, 5393.0, 5409.729513524387, 5416.0792665247, 5420.430854760272, 5425.159100339453, 6289.119523266746, 6406.807795766134, 6424.614523128534, 6429.903551446732, 6438.6136831790245, 1642.4005238088012, 1658.278648787781, 1661.202622741067, 1665.758465022565, 1666.033700453734, 1029.2229366828146, 1085.92398532102, 1104.045001074065, 1124.241137232365, 1125.4429057616533, 6088.726007329681, 6112.877742445126, 6251.374862513803, 6253.78111766086, 6260.123582698426, 6534.934650653528, 6538.411542961061, 6542.672866356663, 6543.378379053982, 6558.245801732862, 6147.784827531104, 6158.076288556752, 6165.8458538536, 6168.444839964424, 6180.721867515973, 3491.266833964845, 3506.4915587239707, 3517.2262102337445, 3519.102628829632, 3523.3834079036064, 6608.240052394036, 6770.32296770319, 6775.22084960226, 6785.59286442815, 6796.694148763318, 6626.9337306627285, 6679.165104361955, 6686.431653309426, 6691.866162676719, 6692.564983276072, 6764.898526522106, 6772.729090836311, 6784.762533311409, 6788.355106264897, 6792.117024786845, 6504.707288172138, 6516.087747715229, 6532.83667908287, 6533.18335208099, 6540.83647908787, 6280.403361680633, 6431.549791514549, 6440.0983862260255, 6549.410553050248, 6558.114654521769, 6866.519343645897, 6904.4131248844415, 6904.585724856524, 6905.585664860125, 6917.13535808024, 4580.587747102777, 4610.585047345755, 4620.561046700558, 4622.607078398374, 4627.514111018295, 6647.401733843977, 6648.135742353463, 6651.0, 6660.333966603301, 6666.699998499982, 6329.430351268408, 6448.9032664511005, 6456.096146539394, 6464.4828413725845, 6467.741290348334, 6386.776462823779, 6426.389492998158, 6439.839004024937, 6448.387403196689, 6455.935440645533, 6313.842153946188, 6318.526110541636, 6325.240971083499, 6325.620462772248, 6343.492520598434, 6463.741450341934, 6473.0, 6476.773312934025, 6477.384648458577, 6484.0, 6054.091886217103, 6145.907811382744, 6242.188515492957, 6338.904916426165, 6339.049142628643], "unit": "score", "name": "prototype.html", "value": 4871.058255671955}, {"lowerIsBetter": false, "replicates": [789.6446599030436, 861.8836457078293, 889.8976617688968, 904.7195369435475, 915.5193523400218, 12598.685032874182, 12638.747225055493, 12676.176048556861, 12712.809307860389, 12731.61805145846, 13414.0, 13534.052616316862, 13672.384742686578, 13684.726305473885, 13689.247091409969, 802.7270727952495, 936.8594710793367, 948.2319321349694, 951.3150531617224, 970.7379007667926, 946.1390134977172, 947.5357075033219, 947.5735918836517, 948.2982592881287, 948.900365461627, 1017.3590637898151, 1017.4912543728136, 1017.7201269650868, 1018.0328687746634, 1019.0980981831059, 821.4208982667205, 842.1662554071456, 976.3946353260952, 982.9655962041365, 1010.3533738407389, 724.9492535522515, 730.4740586777511, 734.5372415378331, 734.8787450070786, 736.0578459571757, 13624.591262262049, 13625.386857591433, 13719.931400342934, 13747.793783093262, 13758.31208439584, 12153.331566763825, 12565.74868502634, 12580.937095314464, 12615.116941814076, 12698.42857071434, 9938.503074846229, 9938.652147174815, 10047.296689231756, 10165.89834101657, 10199.4390308533, 3338.6661333866664, 3377.206356506219, 3378.3074469733647, 3414.214730611973, 3507.7895326280504, 55682.16476752852, 55839.99999999959, 56255.71872140654, 56594.0, 57114.714426428014, 9723.805523889483, 9786.706398808046, 9872.802543949081, 9887.80224395508, 10080.798384032278, 19564.804351956584, 19667.704984425243, 19751.308704195286, 19793.901030494755, 19814.0, 7312.707491700273, 7374.225706300761, 7531.397488200931, 7569.924300756922, 7588.582627955516, 3798.4287183173265, 3890.1247219375414, 3907.296686596383, 3926.705497087673, 3966.5835087315995, 3288.1615188126875, 3321.850516726753, 3324.966750332514, 3328.7004169624365, 3332.1169889979174, 582.860113572748, 592.2005292854698, 596.1445325957266, 597.4115496236204, 610.7434877351523, 489.3149590573226, 666.7866282789557, 666.8199586111723, 671.4427025568766, 680.8127764864702, 7986.840263194704, 8061.395395345373, 8070.314023308085, 8100.149484304063, 8298.294644955125, 577.5899111630705, 598.5839841310335, 627.8963970944834, 687.4225650453643, 694.8992396102536, 3688.2992231475932, 3865.323568375523, 3876.6898648108086, 3959.920801583952, 3968.861089861841, 61253.38746612477, 61752.69123654353, 61784.38215617876, 61913.0, 63354.0, 52864.207036893706, 52974.73512632412, 53199.0, 53408.46591534113, 54716.0, 48296.75851620719, 48466.818993145396, 48506.51493485091, 48739.5126048735, 49139.96812661468, 7780.49426787257, 7967.721129760431, 8124.83750325002, 8211.096779354386, 8282.71010514629, 37119.0, 37964.0, 38150.23699525939, 38607.80696096614, 38681.41977870391, 46556.30165547587, 47213.763931180125, 47612.2858157121, 48045.75977120092, 48334.758326208146, 10797.352158870493, 10973.890261097287, 11039.282446641264, 11070.335779853234, 11151.330920144817, 10573.4713264338, 11124.721881953015, 11168.609098681507, 11194.432779411052, 11269.436528173723, 10842.24104312722, 10842.403667798031, 10885.564577416815, 11129.833052504056, 11504.827427588425, 10648.680539583826, 11022.889771102507, 11088.279261847954, 11579.822975349016, 11618.0705543558, 9743.415395076318, 10429.478526073817, 10461.26771126014, 10519.94740026295, 10526.0, 8773.517456539952, 8905.73282801517, 8981.685641002534, 9016.2786977043, 9349.0, 8912.108789121035, 8943.552822358986, 8986.910130898606, 9076.0, 9078.409903356262], "unit": "score", "name": "yui.html", "value": 6434.76286595213}], "name": "dromaeo_css", "value": 7200.818738784626}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 110.0, 108.0, 110.0, 100.0, 109.0, 108.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [167.0, 127.0, 150.0, 167.0, 129.0, 158.0, 155.0, 129.0, 180.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 160.0, 163.0, 161.0, 164.0, 166.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 74.0, 175.0, 76.0, 76.0, 77.0, 77.0, 166.0, 77.0], "unit": "score", "name": "audio-fft", "value": 94.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 141.0, 93.0, 93.0, 93.0, 139.0, 93.0, 93.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 55.0, 55.0, 58.0, 55.0, 56.0, 66.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 64.0, 66.0, 64.0, 63.0, 64.0, 67.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 79.0, 79.0, 79.0, 78.0, 79.0, 79.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.6}, {"lowerIsBetter": true, "replicates": [112.0, 113.0, 115.0, 112.0, 112.0, 117.0, 113.0, 111.0, 112.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.2}, {"lowerIsBetter": true, "replicates": [149.0, 127.0, 135.0, 138.0, 137.0, 132.0, 138.0, 138.0, 138.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.9}, {"lowerIsBetter": true, "replicates": [66.0, 75.0, 66.0, 68.0, 65.0, 65.0, 68.0, 67.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1497.0}]} 16:27:19 INFO - Return code: 0 16:27:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:27:20 INFO - # TBPL SUCCESS # 16:27:20 INFO - Running post-action listener: _resource_record_post_action 16:27:20 INFO - Running post-run listener: _resource_record_post_run 16:27:21 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 12288; Write bytes: 514433024; Read time: 36; Write time: 520412 16:27:21 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 250179584; Read time: 0; Write time: 314388 16:27:21 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 12288; Write bytes: 251629568; Read time: 36; Write time: 201036 16:27:21 INFO - Running post-run listener: _upload_blobber_files 16:27:21 INFO - Blob upload gear active. 16:27:21 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:27:21 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:27:21 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-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:27:21 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-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:27:21 INFO - (blobuploader) - INFO - Open directory for files ... 16:27:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 16:27:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:27:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:22 INFO - (blobuploader) - INFO - Done attempting. 16:27:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:27:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:27:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:23 INFO - (blobuploader) - INFO - Done attempting. 16:27:23 INFO - (blobuploader) - INFO - Iteration through files over. 16:27:23 INFO - Return code: 0 16:27:23 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:27:23 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:27:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca8961f59958fe851115d0c54d5ec6da3a3ec0bc5b95b327a533051fb5202c37b6ca325cf131143aaf2c89b8c20ba5192c25efa5b893848fc37aa727354858c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/371f266e982f24452292450560186ebb72e98969cfe25b12701eb91eb56a715ffaf31788371cb3f9ba98fad26b850bbf955dfb2c2ecb91440f8a58ec5657c61a"} 16:27:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:27:23 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:27:23 INFO - Contents: 16:27:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca8961f59958fe851115d0c54d5ec6da3a3ec0bc5b95b327a533051fb5202c37b6ca325cf131143aaf2c89b8c20ba5192c25efa5b893848fc37aa727354858c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/371f266e982f24452292450560186ebb72e98969cfe25b12701eb91eb56a715ffaf31788371cb3f9ba98fad26b850bbf955dfb2c2ecb91440f8a58ec5657c61a"} 16:27:23 INFO - Running post-run listener: copy_logs_to_upload_dir 16:27:23 INFO - Copying logs to upload dir... 16:27:23 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:27:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.952765 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-04-13 16:27:22.331900) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 16:27:22.335596) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621 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-Aurora/sha512/ca8961f59958fe851115d0c54d5ec6da3a3ec0bc5b95b327a533051fb5202c37b6ca325cf131143aaf2c89b8c20ba5192c25efa5b893848fc37aa727354858c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/371f266e982f24452292450560186ebb72e98969cfe25b12701eb91eb56a715ffaf31788371cb3f9ba98fad26b850bbf955dfb2c2ecb91440f8a58ec5657c61a"} build_url:https://queue.taskcluster.net/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011164 build_url: 'https://queue.taskcluster.net/v1/task/SQnXtAaIRyiH9z-xLG85Ng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca8961f59958fe851115d0c54d5ec6da3a3ec0bc5b95b327a533051fb5202c37b6ca325cf131143aaf2c89b8c20ba5192c25efa5b893848fc37aa727354858c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/371f266e982f24452292450560186ebb72e98969cfe25b12701eb91eb56a715ffaf31788371cb3f9ba98fad26b850bbf955dfb2c2ecb91440f8a58ec5657c61a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 16:27:22.360392) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 16:27:22.360711) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1460588418.165137-1088293621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 16:27:22.448941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 16:27:22.449665) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 16:27:22.450316) ========= ========= Total master_lag: 0.40 =========