builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1458778075.24 results: success (0) buildid: 20160323143013 builduid: cb69af4d9d1246659388b9aa58a08ca5 revision: 16aaf4cd418c2c26b27967f2940a31937590f646 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:55.240349) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:55.240829) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:55.241160) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006431 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:55.266373) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:55.266656) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:55.289604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:55.289911) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027100 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:55.336731) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:55.336996) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:55.337359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:55.337632) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-23 17:07:55-- 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% 34.8M=0s 2016-03-23 17:07:55 (34.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119977 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:55.469493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:55.469779) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.105164 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:55.586066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:55.586395) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 16aaf4cd418c2c26b27967f2940a31937590f646 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 16aaf4cd418c2c26b27967f2940a31937590f646 --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=e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-23 17:07:55,815 truncating revision to first 12 chars 2016-03-23 17:07:55,815 Setting DEBUG logging. 2016-03-23 17:07:55,815 attempt 1/10 2016-03-23 17:07:55,815 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/16aaf4cd418c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-23 17:07:56,070 unpacking tar archive at: fx-team-16aaf4cd418c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.785440 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:56.383254) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:56.383565) ========= echo 16aaf4cd418c2c26b27967f2940a31937590f646 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'16aaf4cd418c2c26b27967f2940a31937590f646'] 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=e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16aaf4cd418c2c26b27967f2940a31937590f646 program finished with exit code 0 elapsedTime=0.004724 script_repo_revision: '16aaf4cd418c2c26b27967f2940a31937590f646' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:56.433514) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:56.433803) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 17:07:56.445183) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-03-23 17:07:56.445464) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:07:56 INFO - MultiFileLogger online at 20160323 17:07:56 in /builds/slave/test-pgo 17:07:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:07:56 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:07:56 INFO - {'append_to_log': False, 17:07:56 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:07:56 INFO - 'blob_upload_branch': 'Fx-Team', 17:07:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:07:56 INFO - 'branch': 'Fx-Team', 17:07:56 INFO - 'buildbot_json_path': 'buildprops.json', 17:07:56 INFO - 'config_files': ('talos/linux_config.py',), 17:07:56 INFO - 'default_actions': ('clobber', 17:07:56 INFO - 'read-buildbot-config', 17:07:56 INFO - 'download-and-extract', 17:07:56 INFO - 'populate-webroot', 17:07:56 INFO - 'create-virtualenv', 17:07:56 INFO - 'install', 17:07:56 INFO - 'run-tests'), 17:07:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:07:56 INFO - 'download_minidump_stackwalk': True, 17:07:56 INFO - 'download_symbols': 'ondemand', 17:07:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:07:56 INFO - 'tooltool.py': '/tools/tooltool.py', 17:07:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:07:56 INFO - '/tools/misc-python/virtualenv.py')}, 17:07:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:07:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:07:56 INFO - 'installer_path': 'installer.exe', 17:07:56 INFO - 'log_level': 'info', 17:07:56 INFO - 'log_name': 'talos', 17:07:56 INFO - 'log_to_console': True, 17:07:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:07:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:07:56 INFO - 'opt_config_files': (), 17:07:56 INFO - 'pip_index': False, 17:07:56 INFO - 'sps_profile': False, 17:07:56 INFO - 'sps_profile_interval': 0, 17:07:56 INFO - 'suite': 'dromaeojs', 17:07:56 INFO - 'system_bits': '32', 17:07:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:07:56 INFO - 'title': 'talos-linux64-ix-067', 17:07:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:07:56 INFO - 'use_talos_json': True, 17:07:56 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:07:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:07:56 INFO - 'work_dir': 'build'} 17:07:56 INFO - ##### 17:07:56 INFO - ##### Running clobber step. 17:07:56 INFO - ##### 17:07:56 INFO - Running pre-action listener: _resource_record_pre_action 17:07:56 INFO - Running main action method: clobber 17:07:56 INFO - rmtree: /builds/slave/test-pgo/build 17:07:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:08:01 INFO - Running post-action listener: _resource_record_post_action 17:08:01 INFO - ##### 17:08:01 INFO - ##### Running read-buildbot-config step. 17:08:01 INFO - ##### 17:08:01 INFO - Running pre-action listener: _resource_record_pre_action 17:08:01 INFO - Running main action method: read_buildbot_config 17:08:01 INFO - Using buildbot properties: 17:08:01 INFO - { 17:08:01 INFO - "project": "", 17:08:01 INFO - "product": "firefox", 17:08:01 INFO - "script_repo_revision": "production", 17:08:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:08:01 INFO - "repository": "", 17:08:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:08:01 INFO - "buildid": "20160323143013", 17:08:01 INFO - "pgo_build": "True", 17:08:01 INFO - "basedir": "/builds/slave/test-pgo", 17:08:01 INFO - "buildnumber": 560, 17:08:01 INFO - "slavename": "talos-linux64-ix-067", 17:08:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:08:01 INFO - "platform": "ubuntu64_hw", 17:08:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:08:01 INFO - "branch": "fx-team", 17:08:01 INFO - "repo_path": "integration/fx-team", 17:08:01 INFO - "revision": "16aaf4cd418c2c26b27967f2940a31937590f646", 17:08:01 INFO - "stage_platform": "linux64-pgo", 17:08:01 INFO - "builduid": "cb69af4d9d1246659388b9aa58a08ca5", 17:08:01 INFO - "slavebuilddir": "test" 17:08:01 INFO - } 17:08:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:08:01 INFO - Running post-action listener: _resource_record_post_action 17:08:01 INFO - ##### 17:08:01 INFO - ##### Running download-and-extract step. 17:08:01 INFO - ##### 17:08:01 INFO - Running pre-action listener: _resource_record_pre_action 17:08:01 INFO - Running main action method: download_and_extract 17:08:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:08:01 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')]} 17:08:01 INFO - https://queue.taskcluster.net/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:08:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:08:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:08:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:08:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:08:06 INFO - Downloaded 1361 bytes. 17:08:06 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:08:06 INFO - Using the following test package requirements: 17:08:06 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:06 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:08:06 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:08:06 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:06 INFO - u'jsshell-linux-x86_64.zip'], 17:08:06 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:08:06 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:06 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:08:06 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:08:06 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:08:06 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:08:06 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:08:06 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')]} 17:08:06 INFO - https://queue.taskcluster.net/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:08:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:08:12 INFO - Downloaded 23631398 bytes. 17:08:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:08:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:08:13 INFO - Return code: 0 17:08:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:13 INFO - https://queue.taskcluster.net/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:08:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:08:15 INFO - Downloaded 23631398 bytes. 17:08:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:08:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:08:16 INFO - Return code: 0 17:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:16 INFO - https://queue.taskcluster.net/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:08:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:08:23 INFO - Downloaded 10847187 bytes. 17:08:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:08:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 17:08:24 INFO - Return code: 0 17:08: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')]} 17:08:24 INFO - https://queue.taskcluster.net/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:08:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:08:26 INFO - Downloaded 57715848 bytes. 17:08:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:26 INFO - mkdir: /builds/slave/test-pgo/properties 17:08:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:08:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:08:26 INFO - Contents: 17:08:26 INFO - build_url:https://queue.taskcluster.net/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:27 INFO - Running post-action listener: _resource_record_post_action 17:08:27 INFO - Running post-action listener: set_extra_try_arguments 17:08:27 INFO - ##### 17:08:27 INFO - ##### Running populate-webroot step. 17:08:27 INFO - ##### 17:08:27 INFO - Running pre-action listener: _resource_record_pre_action 17:08:27 INFO - Running main action method: populate_webroot 17:08:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:08:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:08:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:08:27 INFO - '--tppagecycles', 17:08:27 INFO - '7'], 17:08:27 INFO - 'tests': ['tsvgm']}}, 17:08:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:08:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:08:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:08:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:08:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:08:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:08:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:27 INFO - 'talos_options': ['--e10s'], 17:08:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:27 INFO - 'tests': ['damp', 'tps']}, 17:08:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:27 INFO - 'talos_options': ['--e10s'], 17:08:27 INFO - 'tests': ['damp', 'tps']}, 17:08:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:08:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:08:27 INFO - 'other': {'tests': ['a11yr', 17:08:27 INFO - 'ts_paint', 17:08:27 INFO - 'tpaint', 17:08:27 INFO - 'sessionrestore', 17:08:27 INFO - 'sessionrestore_no_auto_restore', 17:08:27 INFO - 'tabpaint']}, 17:08:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:08:27 INFO - 'tests': ['a11yr', 17:08:27 INFO - 'ts_paint', 17:08:27 INFO - 'tpaint', 17:08:27 INFO - 'sessionrestore', 17:08:27 INFO - 'sessionrestore_no_auto_restore', 17:08:27 INFO - 'tabpaint']}, 17:08:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:08:27 INFO - 'tests': ['a11yr', 17:08:27 INFO - 'ts_paint', 17:08:27 INFO - 'tpaint', 17:08:27 INFO - 'sessionrestore', 17:08:27 INFO - 'sessionrestore_no_auto_restore', 17:08:27 INFO - 'tabpaint']}, 17:08:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:08:27 INFO - 'tests': ['a11yr', 17:08:27 INFO - 'ts_paint', 17:08:27 INFO - 'tpaint', 17:08:27 INFO - 'sessionrestore', 17:08:27 INFO - 'sessionrestore_no_auto_restore', 17:08:27 INFO - 'tabpaint']}, 17:08:27 INFO - 'other_l64': {'tests': ['a11yr', 17:08:27 INFO - 'ts_paint', 17:08:27 INFO - 'tpaint', 17:08:27 INFO - 'sessionrestore', 17:08:27 INFO - 'sessionrestore_no_auto_restore', 17:08:27 INFO - 'tabpaint']}, 17:08:27 INFO - 'other_nol64': {'tests': ['a11yr', 17:08:27 INFO - 'ts_paint', 17:08:27 INFO - 'tpaint', 17:08:27 INFO - 'sessionrestore', 17:08:27 INFO - 'sessionrestore_no_auto_restore', 17:08:27 INFO - 'tabpaint']}, 17:08:27 INFO - 'svgr': {'tests': ['tsvgx', 17:08:27 INFO - 'tsvgr_opacity', 17:08:27 INFO - 'tart', 17:08:27 INFO - 'tscrollx', 17:08:27 INFO - 'cart']}, 17:08:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:08:27 INFO - 'tests': ['tsvgx', 17:08:27 INFO - 'tsvgr_opacity', 17:08:27 INFO - 'tart', 17:08:27 INFO - 'tscrollx', 17:08:27 INFO - 'cart']}, 17:08:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:27 INFO - 'tests': ['tp5o']}, 17:08:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:27 INFO - 'talos_options': ['--e10s'], 17:08:27 INFO - 'tests': ['tp5o']}, 17:08:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:27 INFO - 'talos_options': ['--xperf_path', 17:08:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:27 INFO - 'tests': ['tp5n']}, 17:08:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:27 INFO - 'talos_options': ['--e10s', 17:08:27 INFO - '--xperf_path', 17:08:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:27 INFO - 'tests': ['tp5n']}}, 17:08:27 INFO - 'talos.zip': {'path': '', 17:08:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:08:27 INFO - Running post-action listener: _resource_record_post_action 17:08:27 INFO - ##### 17:08:27 INFO - ##### Running create-virtualenv step. 17:08:27 INFO - ##### 17:08:27 INFO - Running pre-action listener: _resource_record_pre_action 17:08:27 INFO - Running main action method: create_virtualenv 17:08:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:08:27 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 17:08:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:08:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:08:27 INFO - Using real prefix '/usr' 17:08:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:08:28 INFO - Installing distribute.............................................................................................................................................................................................done. 17:08:30 INFO - Installing pip.................done. 17:08:30 INFO - Return code: 0 17:08:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cbd8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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 0x152b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bbe0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', '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 17:08:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 17:08:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:08:30 INFO - Using env: {'DISPLAY': ':0', 17:08:30 INFO - 'HOME': '/home/cltbld', 17:08:30 INFO - 'LANG': 'en_US.UTF-8', 17:08:30 INFO - 'LANGUAGE': 'en_US:en', 17:08:30 INFO - 'LOGNAME': 'cltbld', 17:08:30 INFO - 'MAIL': '/var/mail/cltbld', 17:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:30 INFO - 'MOZ_NO_REMOTE': '1', 17:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:30 INFO - 'NO_EM_RESTART': '1', 17:08:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:08:30 INFO - 'PWD': '/builds/slave/test-pgo', 17:08:30 INFO - 'SHELL': '/bin/bash', 17:08:30 INFO - 'SHLVL': '1', 17:08:30 INFO - 'TERM': 'linux', 17:08:30 INFO - 'TMOUT': '86400', 17:08:30 INFO - 'USER': 'cltbld', 17:08:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', 17:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:30 INFO - '_': '/tools/buildbot/bin/python'} 17:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:30 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 17:08:30 INFO - Cleaning up... 17:08:30 INFO - Return code: 0 17:08:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6cbd8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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 0x152b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bbe0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', '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 17:08:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 17:08:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:08:30 INFO - Using env: {'DISPLAY': ':0', 17:08:30 INFO - 'HOME': '/home/cltbld', 17:08:30 INFO - 'LANG': 'en_US.UTF-8', 17:08:30 INFO - 'LANGUAGE': 'en_US:en', 17:08:30 INFO - 'LOGNAME': 'cltbld', 17:08:30 INFO - 'MAIL': '/var/mail/cltbld', 17:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:30 INFO - 'MOZ_NO_REMOTE': '1', 17:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:30 INFO - 'NO_EM_RESTART': '1', 17:08:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:08:30 INFO - 'PWD': '/builds/slave/test-pgo', 17:08:30 INFO - 'SHELL': '/bin/bash', 17:08:30 INFO - 'SHLVL': '1', 17:08:30 INFO - 'TERM': 'linux', 17:08:30 INFO - 'TMOUT': '86400', 17:08:30 INFO - 'USER': 'cltbld', 17:08:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', 17:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:30 INFO - '_': '/tools/buildbot/bin/python'} 17:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:30 INFO - Downloading/unpacking psutil>=0.7.1 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:08:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:32 INFO - Installing collected packages: psutil 17:08:32 INFO - Running setup.py install for psutil 17:08:32 INFO - building 'psutil._psutil_linux' extension 17:08:32 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 17:08:32 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 17:08:32 INFO - building 'psutil._psutil_posix' extension 17:08:32 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 17:08:32 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 17:08:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:33 INFO - Successfully installed psutil 17:08:33 INFO - Cleaning up... 17:08:33 INFO - Return code: 0 17:08:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6cbd8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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 0x152b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bbe0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', '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 17:08:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:08:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:08:33 INFO - Using env: {'DISPLAY': ':0', 17:08:33 INFO - 'HOME': '/home/cltbld', 17:08:33 INFO - 'LANG': 'en_US.UTF-8', 17:08:33 INFO - 'LANGUAGE': 'en_US:en', 17:08:33 INFO - 'LOGNAME': 'cltbld', 17:08:33 INFO - 'MAIL': '/var/mail/cltbld', 17:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:33 INFO - 'MOZ_NO_REMOTE': '1', 17:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:33 INFO - 'NO_EM_RESTART': '1', 17:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:08:33 INFO - 'PWD': '/builds/slave/test-pgo', 17:08:33 INFO - 'SHELL': '/bin/bash', 17:08:33 INFO - 'SHLVL': '1', 17:08:33 INFO - 'TERM': 'linux', 17:08:33 INFO - 'TMOUT': '86400', 17:08:33 INFO - 'USER': 'cltbld', 17:08:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', 17:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:33 INFO - '_': '/tools/buildbot/bin/python'} 17:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:08:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:08:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:08:35 INFO - Installing collected packages: mozsystemmonitor 17:08:35 INFO - Running setup.py install for mozsystemmonitor 17:08:35 INFO - Successfully installed mozsystemmonitor 17:08:35 INFO - Cleaning up... 17:08:35 INFO - Return code: 0 17:08:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6cbd8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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 0x152b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bbe0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', '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 17:08:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:08:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:08:35 INFO - Using env: {'DISPLAY': ':0', 17:08:35 INFO - 'HOME': '/home/cltbld', 17:08:35 INFO - 'LANG': 'en_US.UTF-8', 17:08:35 INFO - 'LANGUAGE': 'en_US:en', 17:08:35 INFO - 'LOGNAME': 'cltbld', 17:08:35 INFO - 'MAIL': '/var/mail/cltbld', 17:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:35 INFO - 'MOZ_NO_REMOTE': '1', 17:08:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:35 INFO - 'NO_EM_RESTART': '1', 17:08:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:08:35 INFO - 'PWD': '/builds/slave/test-pgo', 17:08:35 INFO - 'SHELL': '/bin/bash', 17:08:35 INFO - 'SHLVL': '1', 17:08:35 INFO - 'TERM': 'linux', 17:08:35 INFO - 'TMOUT': '86400', 17:08:35 INFO - 'USER': 'cltbld', 17:08:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', 17:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:35 INFO - '_': '/tools/buildbot/bin/python'} 17:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:35 INFO - Downloading/unpacking blobuploader==1.2.4 17:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:37 INFO - Downloading blobuploader-1.2.4.tar.gz 17:08:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:08:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:08:37 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 17:08:37 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 17:08:37 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 17:08:37 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 17:08:37 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 17:08:37 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 17:08:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:08:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:08:37 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 17:08:37 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 17:08:37 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 17:08:37 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 17:08:37 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 17:08:37 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 17:08:38 INFO - Downloading docopt-0.6.1.tar.gz 17:08:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:08:38 INFO - Installing collected packages: blobuploader, requests, docopt 17:08:38 INFO - Running setup.py install for blobuploader 17:08:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:08:38 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:08:38 INFO - Running setup.py install for requests 17:08:38 INFO - Running setup.py install for docopt 17:08:38 INFO - Successfully installed blobuploader requests docopt 17:08:38 INFO - Cleaning up... 17:08:38 INFO - Return code: 0 17:08:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:38 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 0x7f6cbd8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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 0x152b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bbe0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', '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 17:08:38 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 17:08:38 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 17:08:38 INFO - Using env: {'DISPLAY': ':0', 17:08:38 INFO - 'HOME': '/home/cltbld', 17:08:38 INFO - 'LANG': 'en_US.UTF-8', 17:08:38 INFO - 'LANGUAGE': 'en_US:en', 17:08:38 INFO - 'LOGNAME': 'cltbld', 17:08:38 INFO - 'MAIL': '/var/mail/cltbld', 17:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:38 INFO - 'MOZ_NO_REMOTE': '1', 17:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:38 INFO - 'NO_EM_RESTART': '1', 17:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:08:38 INFO - 'PWD': '/builds/slave/test-pgo', 17:08:38 INFO - 'SHELL': '/bin/bash', 17:08:38 INFO - 'SHLVL': '1', 17:08:38 INFO - 'TERM': 'linux', 17:08:38 INFO - 'TMOUT': '86400', 17:08:38 INFO - 'USER': 'cltbld', 17:08:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', 17:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:38 INFO - '_': '/tools/buildbot/bin/python'} 17:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:08:39 INFO - Running setup.py (path:/tmp/pip-x8i40g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:08:39 INFO - Running setup.py (path:/tmp/pip-onvXG9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:08:39 INFO - Running setup.py (path:/tmp/pip-wwwGiH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:08:39 INFO - Running setup.py (path:/tmp/pip-4ksSPl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:08:39 INFO - Running setup.py (path:/tmp/pip-YpMiya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:08:39 INFO - Running setup.py (path:/tmp/pip-Q2kiJf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:08:39 INFO - Running setup.py (path:/tmp/pip-FNMaC3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:08:39 INFO - Running setup.py (path:/tmp/pip-TVhggL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:08:39 INFO - Running setup.py (path:/tmp/pip-nM0ZqH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:08:39 INFO - Running setup.py (path:/tmp/pip-gGX1EQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:08:39 INFO - Running setup.py (path:/tmp/pip-0AtZRM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:08:39 INFO - Running setup.py (path:/tmp/pip-YDzvz9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:08:39 INFO - Running setup.py (path:/tmp/pip-HcGFLC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:08:39 INFO - Running setup.py (path:/tmp/pip-YuZ3Y_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:08:40 INFO - Running setup.py (path:/tmp/pip-3xIRyA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:08:40 INFO - Running setup.py (path:/tmp/pip-EC6aFe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:08:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:08:40 INFO - Running setup.py (path:/tmp/pip-kXM0RW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:08:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:08:40 INFO - Running setup.py install for manifestparser 17:08:40 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:08:40 INFO - Running setup.py install for mozcrash 17:08:40 INFO - Running setup.py install for mozdebug 17:08:40 INFO - Running setup.py install for mozdevice 17:08:40 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:08:40 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:08:40 INFO - Running setup.py install for mozfile 17:08:40 INFO - Running setup.py install for mozhttpd 17:08:40 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:08:40 INFO - Running setup.py install for mozinfo 17:08:40 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:08:40 INFO - Running setup.py install for mozInstall 17:08:41 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:08:41 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:08:41 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:08:41 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:08:41 INFO - Running setup.py install for mozleak 17:08:41 INFO - Running setup.py install for mozlog 17:08:41 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:08:41 INFO - Running setup.py install for moznetwork 17:08:41 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:08:41 INFO - Running setup.py install for mozprocess 17:08:41 INFO - Running setup.py install for mozprofile 17:08:41 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:08:41 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:08:41 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:08:41 INFO - Running setup.py install for mozrunner 17:08:41 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:08:41 INFO - Running setup.py install for mozscreenshot 17:08:41 INFO - Running setup.py install for moztest 17:08:41 INFO - Running setup.py install for mozversion 17:08:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:08:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:08:41 INFO - Cleaning up... 17:08:41 INFO - Return code: 0 17:08:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:08:41 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')]} 17:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:41 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')]} 17:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:41 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 0x7f6cbd8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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 0x152b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bbe0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', '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 17:08:41 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 17:08:41 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 17:08:41 INFO - Using env: {'DISPLAY': ':0', 17:08:41 INFO - 'HOME': '/home/cltbld', 17:08:41 INFO - 'LANG': 'en_US.UTF-8', 17:08:41 INFO - 'LANGUAGE': 'en_US:en', 17:08:42 INFO - 'LOGNAME': 'cltbld', 17:08:42 INFO - 'MAIL': '/var/mail/cltbld', 17:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:42 INFO - 'MOZ_NO_REMOTE': '1', 17:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:42 INFO - 'NO_EM_RESTART': '1', 17:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:08:42 INFO - 'PWD': '/builds/slave/test-pgo', 17:08:42 INFO - 'SHELL': '/bin/bash', 17:08:42 INFO - 'SHLVL': '1', 17:08:42 INFO - 'TERM': 'linux', 17:08:42 INFO - 'TMOUT': '86400', 17:08:42 INFO - 'USER': 'cltbld', 17:08:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', 17:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:42 INFO - '_': '/tools/buildbot/bin/python'} 17:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:08:42 INFO - Running setup.py (path:/tmp/pip-XEPplN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:08:42 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)) 17:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:08:42 INFO - Running setup.py (path:/tmp/pip-88qBJd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:08:42 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)) 17:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:08:42 INFO - Running setup.py (path:/tmp/pip-b_ZHOn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:08:42 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)) 17:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:08:42 INFO - Running setup.py (path:/tmp/pip-hCbfg4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:08:42 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)) 17:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:08:42 INFO - Running setup.py (path:/tmp/pip-bOXDAD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:08:42 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)) 17:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:08:42 INFO - Running setup.py (path:/tmp/pip-iTxDB7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:08:42 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)) 17:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:08:42 INFO - Running setup.py (path:/tmp/pip-hpVMh2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:08:42 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)) 17:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:08:42 INFO - Running setup.py (path:/tmp/pip-FfxLFA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:08:42 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)) 17:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:08:42 INFO - Running setup.py (path:/tmp/pip-fHVPS9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:08:42 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)) 17:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:08:42 INFO - Running setup.py (path:/tmp/pip-rqCLU4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:08:42 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)) 17:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:08:42 INFO - Running setup.py (path:/tmp/pip-M_jnD8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:08:42 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)) 17:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:08:43 INFO - Running setup.py (path:/tmp/pip-ZBaMa8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:08:43 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)) 17:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:08:43 INFO - Running setup.py (path:/tmp/pip-M6IdJh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:08:43 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)) 17:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:08:43 INFO - Running setup.py (path:/tmp/pip-oycyxJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:08:43 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)) 17:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:08:43 INFO - Running setup.py (path:/tmp/pip-oZw_ND-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:08:43 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)) 17:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:08:43 INFO - Running setup.py (path:/tmp/pip-Ueszia-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:08:43 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)) 17:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:08:43 INFO - Running setup.py (path:/tmp/pip-YtGglm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:08:43 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)) 17:08:43 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)) 17:08:43 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)) 17:08:43 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)) 17:08:43 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)) 17:08:43 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)) 17:08:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:45 INFO - Downloading blessings-1.6.tar.gz 17:08:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:08:45 INFO - Installing collected packages: blessings 17:08:45 INFO - Running setup.py install for blessings 17:08:45 INFO - Successfully installed blessings 17:08:45 INFO - Cleaning up... 17:08:45 INFO - Return code: 0 17:08:45 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:08:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:08:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:08:45 INFO - Reading from file tmpfile_stdout 17:08:45 INFO - Current package versions: 17:08:45 INFO - argparse == 1.2.1 17:08:45 INFO - blessings == 1.6 17:08:45 INFO - blobuploader == 1.2.4 17:08:45 INFO - docopt == 0.6.1 17:08:45 INFO - manifestparser == 1.1 17:08:45 INFO - mozInstall == 1.12 17:08:45 INFO - mozcrash == 0.17 17:08:45 INFO - mozdebug == 0.1 17:08:45 INFO - mozdevice == 0.48 17:08:45 INFO - mozfile == 1.2 17:08:45 INFO - mozhttpd == 0.7 17:08:45 INFO - mozinfo == 0.9 17:08:45 INFO - mozleak == 0.1 17:08:45 INFO - mozlog == 3.1 17:08:45 INFO - moznetwork == 0.27 17:08:45 INFO - mozprocess == 0.22 17:08:45 INFO - mozprofile == 0.28 17:08:45 INFO - mozrunner == 6.11 17:08:45 INFO - mozscreenshot == 0.1 17:08:45 INFO - mozsystemmonitor == 0.0 17:08:45 INFO - moztest == 0.7 17:08:45 INFO - mozversion == 1.4 17:08:45 INFO - psutil == 3.1.1 17:08:45 INFO - requests == 1.2.3 17:08:45 INFO - wsgiref == 0.1.2 17:08:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:08:45 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')]} 17:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:45 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')]} 17:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:45 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 0x7f6cbd8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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 0x152b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bbe0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', '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 17:08:45 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 17:08:45 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 17:08:45 INFO - Using env: {'DISPLAY': ':0', 17:08:45 INFO - 'HOME': '/home/cltbld', 17:08:45 INFO - 'LANG': 'en_US.UTF-8', 17:08:45 INFO - 'LANGUAGE': 'en_US:en', 17:08:45 INFO - 'LOGNAME': 'cltbld', 17:08:45 INFO - 'MAIL': '/var/mail/cltbld', 17:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:45 INFO - 'MOZ_NO_REMOTE': '1', 17:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:45 INFO - 'NO_EM_RESTART': '1', 17:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:08:45 INFO - 'PWD': '/builds/slave/test-pgo', 17:08:45 INFO - 'SHELL': '/bin/bash', 17:08:45 INFO - 'SHLVL': '1', 17:08:45 INFO - 'TERM': 'linux', 17:08:45 INFO - 'TMOUT': '86400', 17:08:45 INFO - 'USER': 'cltbld', 17:08:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', 17:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:45 INFO - '_': '/tools/buildbot/bin/python'} 17:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:46 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)) 17:08:46 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)) 17:08:46 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)) 17:08:46 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)) 17:08:46 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)) 17:08:46 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)) 17:08:46 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)) 17:08:46 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)) 17:08:46 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)) 17:08:46 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)) 17:08:46 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)) 17:08:46 INFO - Cleaning up... 17:08:46 INFO - Return code: 0 17:08:46 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:08: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')]} 17:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:46 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 0x7f6cbd8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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 0x152b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bbe0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', '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 17:08:46 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 17:08:46 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 17:08:46 INFO - Using env: {'DISPLAY': ':0', 17:08:46 INFO - 'HOME': '/home/cltbld', 17:08:46 INFO - 'LANG': 'en_US.UTF-8', 17:08:46 INFO - 'LANGUAGE': 'en_US:en', 17:08:46 INFO - 'LOGNAME': 'cltbld', 17:08:46 INFO - 'MAIL': '/var/mail/cltbld', 17:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:46 INFO - 'MOZ_NO_REMOTE': '1', 17:08:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:46 INFO - 'NO_EM_RESTART': '1', 17:08:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:08:46 INFO - 'PWD': '/builds/slave/test-pgo', 17:08:46 INFO - 'SHELL': '/bin/bash', 17:08:46 INFO - 'SHLVL': '1', 17:08:46 INFO - 'TERM': 'linux', 17:08:46 INFO - 'TMOUT': '86400', 17:08:46 INFO - 'USER': 'cltbld', 17:08:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', 17:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:46 INFO - '_': '/tools/buildbot/bin/python'} 17:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:46 INFO - Downloading/unpacking jsonschema 17:08:46 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 17:08:46 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 17:08:46 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 17:08:46 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 17:08:46 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 17:08:46 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 17:08:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:08:48 INFO - Downloading/unpacking functools32 (from jsonschema) 17:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:49 INFO - Downloading functools32-3.2.3-2.tar.gz 17:08:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:08:49 INFO - warning: no files found matching '*.txt' 17:08:49 INFO - no previously-included directories found matching 'build' 17:08:49 INFO - no previously-included directories found matching 'dist' 17:08:49 INFO - no previously-included directories found matching '.git*' 17:08:49 INFO - Installing collected packages: jsonschema, functools32 17:08:49 INFO - Running setup.py install for functools32 17:08:49 INFO - warning: no files found matching '*.txt' 17:08:49 INFO - no previously-included directories found matching 'build' 17:08:49 INFO - no previously-included directories found matching 'dist' 17:08:49 INFO - no previously-included directories found matching '.git*' 17:08:49 INFO - Successfully installed jsonschema functools32 17:08:49 INFO - Cleaning up... 17:08:49 INFO - Return code: 0 17:08:49 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:49 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 0x7f6cbd8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15281d0>, '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 0x152b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bbe0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', '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 17:08:49 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 17:08:49 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 17:08:49 INFO - Using env: {'DISPLAY': ':0', 17:08:49 INFO - 'HOME': '/home/cltbld', 17:08:49 INFO - 'LANG': 'en_US.UTF-8', 17:08:49 INFO - 'LANGUAGE': 'en_US:en', 17:08:49 INFO - 'LOGNAME': 'cltbld', 17:08:49 INFO - 'MAIL': '/var/mail/cltbld', 17:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:49 INFO - 'MOZ_NO_REMOTE': '1', 17:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:49 INFO - 'NO_EM_RESTART': '1', 17:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:08:49 INFO - 'PWD': '/builds/slave/test-pgo', 17:08:49 INFO - 'SHELL': '/bin/bash', 17:08:49 INFO - 'SHLVL': '1', 17:08:49 INFO - 'TERM': 'linux', 17:08:49 INFO - 'TMOUT': '86400', 17:08:49 INFO - 'USER': 'cltbld', 17:08:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', 17:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:49 INFO - '_': '/tools/buildbot/bin/python'} 17:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:49 INFO - Downloading/unpacking flake8 17:08:49 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 17:08:49 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 17:08:49 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 17:08:49 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 17:08:49 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 17:08:49 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 17:08:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:08:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:08:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:08:52 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 17:08:52 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 17:08:52 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 17:08:52 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 17:08:52 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 17:08:52 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 17:08:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:08:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:08:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:08:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:08:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:08:52 INFO - no previously-included directories found matching 'docs/_build' 17:08:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:08:52 INFO - Running setup.py install for pep8 17:08:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:08:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:08:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:08:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:08:52 INFO - no previously-included directories found matching 'docs/_build' 17:08:52 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:08:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:08:52 INFO - Cleaning up... 17:08:52 INFO - Return code: 0 17:08:52 INFO - Running post-action listener: _resource_record_post_action 17:08:52 INFO - Running post-action listener: _start_resource_monitoring 17:08:52 INFO - Starting resource monitoring. 17:08:52 INFO - ##### 17:08:52 INFO - ##### Running install step. 17:08:52 INFO - ##### 17:08:52 INFO - Running pre-action listener: _resource_record_pre_action 17:08:52 INFO - Running main action method: install 17:08:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:08:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:08:52 INFO - Reading from file tmpfile_stdout 17:08:52 INFO - Detecting whether we're running mozinstall >=1.0... 17:08:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:08:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:08:52 INFO - Reading from file tmpfile_stdout 17:08:52 INFO - Output received: 17:08:52 INFO - Usage: mozinstall [options] installer 17:08:52 INFO - Options: 17:08:52 INFO - -h, --help show this help message and exit 17:08:52 INFO - -d DEST, --destination=DEST 17:08:52 INFO - Directory to install application into. [default: 17:08:52 INFO - "/builds/slave/test-pgo"] 17:08:52 INFO - --app=APP Application being installed. [default: firefox] 17:08:52 INFO - mkdir: /builds/slave/test-pgo/build/application 17:08:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 17:08:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 17:09:09 INFO - Reading from file tmpfile_stdout 17:09:09 INFO - Output received: 17:09:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:09:09 INFO - Running post-action listener: _resource_record_post_action 17:09:09 INFO - ##### 17:09:09 INFO - ##### Running run-tests step. 17:09:09 INFO - ##### 17:09:09 INFO - Running pre-action listener: _resource_record_pre_action 17:09:09 INFO - Running main action method: run_tests 17:09:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:09:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:09:09 INFO - Python 2.7.3 17:09:09 INFO - Return code: 0 17:09:09 INFO - grabbing minidump binary from tooltool 17:09: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')]} 17:09:09 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 0x15281d0>, '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 0x152b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x152bbe0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:09:09 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 17:09:09 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 17:09:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:09:09 INFO - Return code: 0 17:09:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:09:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:09:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:09:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:09:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:09:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:09:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:09:10 INFO - Return code: 0 17:09:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 17:09:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 17:09:10 INFO - Using env: {'DISPLAY': ':0', 17:09:10 INFO - 'HOME': '/home/cltbld', 17:09:10 INFO - 'LANG': 'en_US.UTF-8', 17:09:10 INFO - 'LANGUAGE': 'en_US:en', 17:09:10 INFO - 'LOGNAME': 'cltbld', 17:09:10 INFO - 'MAIL': '/var/mail/cltbld', 17:09:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:09:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:10 INFO - 'MOZ_NO_REMOTE': '1', 17:09:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:10 INFO - 'NO_EM_RESTART': '1', 17:09:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:10 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:09:10 INFO - 'SHELL': '/bin/bash', 17:09:10 INFO - 'SHLVL': '1', 17:09:10 INFO - 'TERM': 'linux', 17:09:10 INFO - 'TMOUT': '86400', 17:09:10 INFO - 'USER': 'cltbld', 17:09:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964', 17:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:10 INFO - '_': '/tools/buildbot/bin/python'} 17:09:10 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 17:09:10 INFO - mozversion application_buildid: 20160323143013 17:09:10 INFO - mozversion application_changeset: 16aaf4cd418c2c26b27967f2940a31937590f646 17:09:10 INFO - mozversion application_display_name: Nightly 17:09:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:09:10 INFO - mozversion application_name: Firefox 17:09:10 INFO - mozversion application_remotingname: firefox 17:09:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:09:10 INFO - mozversion application_vendor: Mozilla 17:09:10 INFO - mozversion application_version: 48.0a1 17:09:10 INFO - mozversion platform_buildid: 20160323143013 17:09:10 INFO - mozversion platform_changeset: 16aaf4cd418c2c26b27967f2940a31937590f646 17:09:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:09:10 INFO - mozversion platform_version: 48.0a1 17:09:10 INFO - using testdate: 1458778150 17:09:10 INFO - actual date: 1458778150 17:09:10 INFO - starting webserver on 'localhost:51593' 17:09:10 INFO - SUITE-START | Running 2 tests 17:09:10 INFO - TEST-START | dromaeo_css 17:09:10 INFO - operating with platform_type : linux_ 17:09:10 INFO - Initialising browser for dromaeo_css test... 17:09:10 INFO - TEST-INFO | started process 15221 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQTCQEV/profile http://localhost:51593/getInfo.html) 17:09:14 INFO - PROCESS | 15221 | __metrics Screen width/height:1600/1200 17:09:14 INFO - PROCESS | 15221 | colorDepth:24 17:09:14 INFO - PROCESS | 15221 | Browser inner width/height: 1024/697 17:09:14 INFO - PROCESS | 15221 | __metrics 17:09:15 ERROR - PROCESS | 15221 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:09:15 INFO - PROCESS | 15221 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:09:16 INFO - TEST-INFO | 15221: exit 0 17:09:16 INFO - Browser initialized. 17:09:16 INFO - Running cycle 1/1 for dromaeo_css test... 17:09:16 INFO - TEST-INFO | started process 15315 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQTCQEV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:27 INFO - PROCESS | 15315 | RSS: Main: 156049408 17:09:27 INFO - PROCESS | 15315 | 17:10:18 INFO - PROCESS | 15315 | 1458778218717 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:12:26 INFO - PROCESS | 15315 | Cycle 1(1): loaded http://localhost:51593/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51593/tests/dromaeo/cssquery-ext.html) 17:12:27 INFO - PROCESS | 15315 | RSS: Main: 251379712 17:12:27 INFO - PROCESS | 15315 | 17:15:29 INFO - PROCESS | 15315 | Cycle 1(1): loaded http://localhost:51593/tests/dromaeo/cssquery-ext.html (next: http://localhost:51593/tests/dromaeo/cssquery-jquery.html) 17:15:29 INFO - PROCESS | 15315 | RSS: Main: 237056000 17:15:29 INFO - PROCESS | 15315 | 17:18:31 INFO - PROCESS | 15315 | Cycle 1(1): loaded http://localhost:51593/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51593/tests/dromaeo/cssquery-mootools.html) 17:18:32 INFO - PROCESS | 15315 | RSS: Main: 233517056 17:18:32 INFO - PROCESS | 15315 | 17:21:34 INFO - PROCESS | 15315 | Cycle 1(1): loaded http://localhost:51593/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51593/tests/dromaeo/cssquery-prototype.html) 17:21:34 INFO - PROCESS | 15315 | RSS: Main: 224010240 17:21:34 INFO - PROCESS | 15315 | 17:24:37 INFO - PROCESS | 15315 | Cycle 1(1): loaded http://localhost:51593/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51593/tests/dromaeo/cssquery-yui.html) 17:24:37 INFO - PROCESS | 15315 | RSS: Main: 222904320 17:24:37 INFO - PROCESS | 15315 | 17:27:40 INFO - PROCESS | 15315 | Cycle 1(1): loaded http://localhost:51593/tests/dromaeo/cssquery-yui.html (next: http://localhost:51593/tests/dromaeo/cssquery-dojo.html) 17:27:40 INFO - PROCESS | 15315 | RSS: Main: 268165120 17:27:40 INFO - PROCESS | 15315 | 17:27:40 INFO - PROCESS | 15315 | __start_tp_report 17:27:40 INFO - PROCESS | 15315 | _x_x_mozilla_page_load 17:27:40 INFO - PROCESS | 15315 | _x_x_mozilla_page_load_details 17:27:40 INFO - PROCESS | 15315 | |i|pagename|runs| 17:27:40 INFO - PROCESS | 15315 | |0;dojo.html;3058.373033528126;3093.984530077349;3117;3133.7649676274273;3156.4318422683914;5332.760025798839;5359.67841929484;5390.568754499641;5404.270423492837;5420.945790542093;5347.465253474651;5363.785448582062;5364.946350536494;5384.811531596395;5415.972920135394;4866.707997520142;4874.220124780036;4875.122477953967;4891.217405215166;5007.424146223177;4920.655554111214;4989.251612258172;4999.8000079996755;5003.2245002024565;5007.899842003158;4830.565249127578;4876.219804831246;4944.233643785219;4969.850904472872;4982.451930287665;4863.975680121577;4894.853154405374;4898.412190537123;4931.3835770528685;4946.282788995575;4843.903121937541;4857.368542089541;4863.683860549053;4868.78090485929;4922.212446008657;5262.342207224097;5311.946880531223;5338.27933229013;5398.352197736258;5402.297701298845;5740.024195886709;5766.221560089376;5773.9422605773825;5778.826635200909;5782.392848750863;5780.53755699543;5787.855303617401;5800.622959507618;5801.187833703243;5801.593888427812;5266.631335806495;5375.784968601251;5397.3523177218985;5444.646098003656;5464.26232458621;5862.12068189775;5868.501177399883;5870.706464676749;5892.116182572563;5940.495057920039;5575.721213939287;5648.406917273627;5660.405657405995;5668.489835914787;5669.4047125051275;5734.856628584319;5762.625429347163;5782.537397008229;5834.533237341003;5836.124581312837;5534.7786088556;5567.749451274703;5569.10894256917;5579.107342825128;5581.916271255935;5511.311086114236;5522.723863806794;5587.832365029056;5609.046462101453;5624.072028115315;4341.674374421931;4353.455818022747;4356.760378179167;4383.539728328479;4396.384506169139;3853.7495062820826;3858.401947698111;3877.268057176507;3877.922441551153;3917.1578110706337;5217.556507696812;5333.226682131147;5373.220882972026;5426.9185962210595;5434.456554344534;5606.523445507096;5617.550595952314;5636.126400407943;5647.124695672177;5696.601237913306;5238.188080847474;5245.6852588844795;5247.895042099137;5256.342957130359;5323.946760532423;4685.180093483695;4733.006068725606;4781.521847815191;4862.610991120702;4875.293082503017;5803.6807975560905;5819.883602328015;5820.068788993825;5825;5826.504747096459;5667.518260947865;5671.971640141773;5676.886462270814;5678.914816277676;5680.829575112753;5848.122781582797;5884.735186916513;5950.7917222896995;5951.256092988377;5972.850678732892;5557.36090349615;5558.805441809517;5562.082256427644;5569.19246709233;5570.303712035996;5572.4706152915405;5676.659400435987;5680.289963754531;5685.033544297562;5686.829395118153;5530.198121272473;5621.269234999424;5622.606417550732;5631.380548139619;5636.2954630671165;5589;5614.326280846324;5614.9719251403485;5616.69108199053;5627.971860140673;5359.705216213146;5517.586181036358;5547.44525547442;5547.667139971614;5555.972220138873;5544.861378465571;5551.805686800943;5574.442555744393;5585.776568937197;5626.071698169756;5358.732063396893;5422.186671999231;5423.29497165366;5449.700266485382;5507.339119305549 17:27:40 INFO - PROCESS | 15315 | |1;ext.html;526.3447008474448;569.2628046679549;572.7193675099202;579.1341943794029;589.9233099697038;30864.691353086462;31369;38846.41730374047;39256.60743392565;39311.606883931156;41532.58467415325;41886;41911.16177676445;41929.7903510482;41979.79010104945;8631.093735157796;8829.60266787996;8829.911700882973;8832.381733278673;8852.336074794417;8132.064812546544;10431.791364172712;10657.893421065806;10694;10706.036456718894;10432.165426765878;10462;10492.895071049306;10515.158787296998;10533.315334503272;10327;10394.22043346752;10398.168146548258;10406.375617462938;10410.531526081344;10205.897941020568;10309.79380412395;10328.690139295833;10333.896661033368;10336.79326413475;41039.794801025804;41765;41833.1633367334;41880.79059604713;41900.79049604763;3285.950710739317;3327.218103745618;3330.283988942365;3386.0857568456377;3946.605339466059;31845.363092738015;31889.202769930936;32096.197595060075;33027.83486082578;33041.66958330434;4155.31437312843;4206.3690446432975;4207.221663992172;4264.699266723648;4285.035866929947;282434;282846;282999;284323;285309;61494;62220.37779622146;62402.0639690405;62432.375676243566;62608.37391626117;65714.34285657178;65725.67137164283;65799.34200657932;65835;65894.34105658978;16431.835681643268;16685.83314166867;16688.83311166873;16705.081220532986;16705.582360440843;11752.823707644393;12498.562550310877;12677.87322126767;13040.869591303965;13056.804147937788;18894.716579251322;19123.90438047829;19139.521511962314;19153.904230478758;19181;7380.667869945865;7738.187490313549;7762;7801.94673719052;7819.960900195462;1000.4185017636843;1006.2453160129902;1048.051513380392;1081.2593373538994;1134.7163209197702;32135.678643213738;32231;32566.720329576703;32708.509372359433;32776.180595485304;1174.3599738142732;1179.4515550269166;1211.0553768060927;1211.2006075989805;1218.7318789866215;16196.595085122966;16751.748723769153;16862.91568542174;16973.575660608338;17129.657406851795;377622;381073;381343;382433;382572;56267.718661406434;57394;57421.13868291979;57439.71280143656;57441.42558574361;1231.2489381477292;1327.9070465067546;1395.818543589327;1422.9359678814478;1430.7281616493042;28697.708603113326;28939.85530072336;29096.127116186548;29546.704532954394;29654.851725742097;42059.369109463994;42223.78888105663;42571.3614295792;42710;42783.7860810694;185894;187101;199167;199912;200267;30681.8465907669;34611.65388346185;35460.822695887386;35886;35951.46072808962;44839;45748.54251457576;46250.30624540702;46548.53451465442;46847.53152468568;38906.61093389143;39492;39496.01259968524;39672.80163599164;39848.612867905395;37798.43302350522;38326;39319.41020884632;39793.80103099466;40426.39360409537;39762.40356394714;40385.59614403819;40429.1914161721;40941;40981.590184097775;34867.4769878447;35756.46365304574;36226;36387;36620.084497887765;27484.312892177855;27662.86168569144;27858.442831143668;27943.301417464725;27949.720502794713 17:27:40 INFO - PROCESS | 15315 | |2;jquery.html;369.9186179040612;370.22807446474116;371.68088965537737;375.87596093289216;379.97530160539543;17154;17567.73648395275;18598.721019184704;19089;19101.331453399132;16655.750163747554;17066.743998839996;17681.292748290085;17691.557711057198;17692.557686057855;5590.496855283024;5744.79893203738;5750.252467179261;5760.596758226926;5782;4201.684873634475;5629.577781666371;6013.909791353133;6250.968590182614;6285.9057114143325;6169.537284703665;6231.750729970796;6231.906521402183;6233.345498722637;6239.968800156015;6055.152278680988;6147.907781383283;6179.38206179383;6196.845078873064;6211.782587609435;3686.1153323202507;5279.656822306538;5430.131179011379;5455.1544510600925;5466.207399927028;20077.899610502;20662;20767.8961605191;20794.48013799652;20819.37541873746;2271.3299576624936;2327.301809457156;2345.5074434368803;2630.710621831597;2674.6121812337296;13256.40346184424;13275.53535626258;13308.534201302908;13769.242691651954;13787.793183102262;1890.376175861976;1919.577692907558;1931.6909294512811;1967.9901600491905;2023.0896096756371;69295.25674716968;70480.29519704789;71377.64311178462;71578.2842171582;71693.641531792;10893.400862952456;10907.83638245427;10919.39943303126;10989.61536346224;11132.165087618461;13995.580132596038;14042.1574705518;14070.226137562327;14070.366833492517;14070.366833492517;8073.19268073188;8264.958675206586;8331.708390206435;8404.07555168931;8434.831303374021;8186.222308880647;8256.25693687571;8328.66685332592;8383.664653413916;8429.157084291523;4547.840300723361;4630.490646028934;4647.326137710013;4704.717716936994;4713.363695901078;1742.5208067781462;1810.0081067138278;1832.560185555457;1834.7247912812918;1852.2776117314258;979.7942432089199;983.1250187333279;994.1549682769588;1025.6512785652915;1078.4769386847372;17537.210825512884;17545.29818807259;17955.820441795415;18100.18549165291;18414.35549755752;974.2692980264801;990.2078337330252;992.4442312305132;993.0288377570516;1028.2545154762738;9947.55236014381;10054.245931555017;10318.742031449274;10393.740156496147;10507.00183482568;456144;457225.8525781114;462557;466651;472960;81331;82270.58864705639;86834.56582717046;87080.1291987072;87274;1012.8278192707257;1015.1523477896039;1028.043919155193;1030.3457304611475;1031.865857438528;15747.606309842346;15969.121698306704;16081.195940203177;16100.516984490485;16166.757498637766;35468.61027990196;35608.46587301244;36875.631243688294;37098.25803483861;37561.2487750238;53038.73480632572;53091.734541327045;53126.20310695266;53597;53658.19512707391;7693.153753087267;7888.526688398714;8011.278984891388;8013.519188848688;8083.070446898447;11605.883941160819;11627.59303424376;11781.469833857325;12008.759824803281;12259.69350766238;10297.53661085238;11148.665540033811;11280.774384512428;11470.541178353105;11700.414979250832;11102.222844401138;11421.458103155968;11682.47428865686;11876.346800925687;11968.76062478728;11086.113110951266;11176.944115279372;11583.305001699924;11828.23116497425;12220.51117955272;7983.481073730189;8213.83572328562;8308.626111824862;8397.034341050858;8498.575071246536;10235.590576376862;11725.120615954009;11892.643220703392;11968.16222864426;11977.281363118242 17:27:40 INFO - PROCESS | 15315 | |3;mootools.html;1402.3899603672396;1499.6550793317538;1509.4113295814632;1681.6720739455802;1832.9541761455962;7940.682372705092;8154.959225203873;8163.5918204089785;8167.428280020386;8171.632276547555;8008.439409241356;8118.512889226636;8131.674733010673;8136.064352599453;8177.304929081035;2028.898555072248;2252.8986195621237;2257.345369842744;2279.8290128240365;2305.227748704186;2313.5835549601065;2349.3656712687566;2350.059976009593;2350.1539445799585;2351.341624345186;2243.461569223391;2331.1258278145697;2332.125452955142;2334.6848175496343;2336.9766302337016;2042.5302180498495;2290.473191166033;2339.508703172336;2340.520193360357;2340.6957095577636;2245.517213799041;2273.1248469339257;2280.2589158523547;2286.9937227619794;2288.336382449088;8307.335413166933;8382.916170838274;8397.748067557983;8399.790005249857;8405.369597280229;5009;5127.102757017507;5166.225066240057;5168.3539557555305;5170.379554453452;3427.880024199141;3444.8794292199905;3501.9474707879403;3540.522029526007;3557.7153827693724;1075.8816530181673;1090.2095980414215;1091.5197313182175;1117.1677100560134;1169.8011338072547;11663.883361166365;11682.299062056303;11708.536432945883;11715.179937404386;11720.472578733892;4534.161180181677;4643.048175124091;4658.440987081572;4664.930026049612;4683.906321873544;9875.209983201326;9889.505524723734;9893.060159285;9915.702528924145;9947.403155810529;4638.652101092432;5122.718250496184;5152.845414637567;5156.1750119980625;5161.664491808096;4629.25931850909;4699.2481203007355;4709.882252943704;4754.904901901942;4756.571908528249;3890.513685789276;3977.8607748728655;4001.3997900315185;4003.459532963071;4030.153667729751;1195.6831439668495;1201.381288636353;1206.7465832175167;1209.2683926224684;1256.0265794009533;1371.8490965993733;1379.834419869622;1393.5610282760897;1411.2731943049337;1414.370605080729;7628.389728821681;7775.105862825847;7784.2215778421705;7798.454108212371;7806.297433231037;486.95373939475695;494.03169787217456;498.5637567128762;498.89273806131854;499.1564256406661;5940.732667029994;5959.28488581373;5991.7603295867675;6035.547333949971;6037.184980027728;9647.758806029906;10364.740881477872;10461.26771126029;10563.94718026405;10565.04914557678;10102.949485252673;10250.38497690141;10301;10397.636082737068;10444.164466842634;7897.3287270581495;7919.643616037177;7966.601669916597;8039.276465118168;8074.798130046678;7707.884381734167;7737.381009519112;7739.419543534144;7742.458027938215;7836.529808211526;9101.453912765255;9198.540072996457;9274.860877086983;9277.350585458953;9348.298877584344;9480.478573678514;9611.279154063614;9711.5144242789;9729.124378805942;9805.117539421486;6578.28964469251;6761.797146085625;7110.928890711233;7259.564426134238;7390.482666213314;7990.520568765893;7997.320227780704;8036.718714845187;8039.758807235792;8041.758747237593;6855.348741869514;7041.3310735480045;7043.894341584778;7165.964170179116;7181.928180718335;7014.263502332182;7060.929390706027;7113.928860711327;7198.172210195895;7233.240509746612;7212.531185472927;7594.392448603988;7613.9238607613215;7622.618869056636;7632.084149901825;6766.4248538874745;6789.762358317435;6796.694148763417;6800.6599670017295;6820.215675197416;6966.512344135862;7032.789016329519;7055.2944705529035;7063.540869843444;7075.646217689198 17:27:40 INFO - PROCESS | 15315 | |4;prototype.html;332.8335832083958;339.7825391749281;341.4979979430237;342.85942763466977;350.09151252499754;5904.793332233373;5941.821745347635;5956.553258505619;5957.6127551709105;5964.284285885695;5892.970535147329;5896.646201227919;5912.379200183983;5926.792562260322;5932.1991531143285;4406.5373135820755;4491.663125265602;4549.158405694957;4603.5166307537565;4635.8841028974375;4598.954010459903;4615.584597386234;4627.282771170457;4628.976855115719;4635.397398338228;4565.817367305303;4568.5431456854385;4574.4510658721;4577.450705915295;4599.747013914233;4375.190589740908;4465.821367145327;4546.249868771682;4585.426821647294;4585.624312706208;4005.499312585927;4020.839166433339;4029.214303210875;4029.435878976946;4029.9194016119513;5782.421757824226;5789.07374820031;5796.710164491801;5796.927568399859;5813.360530341659;5332.413434522199;5350.197470379474;5352.57179425645;5353.491418315254;5356.491133342326;6321.589096708745;6325.304216536178;6326.145970293997;6331.651759153245;6334.208223972004;4247.256730072225;4385.6710746694125;4386.912261754747;4391.187630288407;4471.932921006188;6579.407853293226;6630.834229144261;6648.036034774979;6656.966715166442;6657.334266573353;4444.866654000385;4465.419495465569;4470.284754439274;4471.396361491222;4472.463304403493;4530.252508336153;4535.455745310518;4569.885752856138;4570.131674981742;4571.519990401027;5262.184361423985;5264;5267.552258058031;5269.762860671202;5270.472952704776;6170.136180934673;6377.7767778127545;6403.903941440882;6405.679716014274;6407.391297826699;1573.4099712607772;1574.7716581095906;1575.196649708634;1584.6830633873271;1591.785109010292;978.7846673731767;1030.2221822523945;1046.3930920066343;1048.910842578374;1060.9522571484301;6067.635941843503;6094.360092190256;6118.663473508911;6119;6132.080187971751;6538.542302038812;6557.934420655828;6561.770338038145;6563.409293163638;6574.3754343337305;6077.088436734437;6084.361142080106;6085.269767627825;6085.695715214221;6089.360617135226;3515.771474854126;3542.946855797165;3546.733994950389;3548.183917698892;3549.9290014200087;6643.272557728683;6734.0572319875255;6774.356436138559;6783.694733736994;6793.150856142982;6642.236142843538;6644.103046088813;6661.1007513985;6667.766628167991;6668.433183179484;6741.258461569223;6744.730210791611;6755.932440675629;6760.290169532128;6770.458363330922;6526.543141980016;6531.11829902976;6532.314107018695;6533.836654083686;6539.444147247347;6360.650164241011;6495.967520162369;6524.9021264682015;6546.5417420782;6607.174103237096;6836.863262734817;6887;6893.482988775761;6902.171739391305;6911.827204319932;4472.575105364985;4518.615917647036;4524.615407690251;4527.0493196429115;4530.932036019528;6662.400383965466;6663.600183988976;6669.933300667125;6672.4328432081875;6674.499412544175;6378.138951241523;6497.18785151856;6501.73993040292;6507.12153859223;6527.086207930798;6514.902276465762;6525.7063432146615;6530.8040758777315;6552.24649165333;6553.4101930824545;6314.305426403183;6338.11266422692;6339;6340.9365906340345;6365.61806291624;6464.0627109069865;6475.546711730133;6481.902771458526;6482.513811464065;6485.416312531895;6032;6162.722677479434;6177.567570270038;6298.1812364392335;6307.96846015767 17:27:40 INFO - PROCESS | 15315 | |5;yui.html;639.7728806273769;668.3984414027375;673.5453568841031;776.343989329017;782.9451938364314;12768.297743624096;13067.869321306807;13074.869251307484;13077.34613269335;13084.476620935164;12056.51773929044;12151.939240303807;12155.149139560235;12158.878411215885;13382.263975481344;792.5759718550577;799.1449149410133;804.1717031457608;804.5213098206558;804.8671969125087;795.5067857928093;802.3541049455187;802.542550746075;802.7872613757359;804.4127786715701;838.5513750143674;844.5608283692476;846.6105591427951;848.4654667559429;848.4909054567272;836.2557323981631;836.8953880764905;837.9413441059128;838.0069617503278;838.0153319849184;611.5932904618423;612.2163630552855;612.9601575897597;613.1079279648102;613.1691557938973;12608;12681.682957926034;12735.044871634573;12772.936135319356;12782.808257876139;13161.078724489289;13304.13523120994;13313.104494595169;13320.533781317607;13350.666233344147;10665.733356666067;10673.146148308117;10805.729856753565;10928.50821713017;11088.722781930435;3667.449882517617;3699.445083237509;3771.0949372150485;3813.694904407641;3817.8091095445116;46200;50959;51942.74028629833;53008.204876926495;53023.20465193025;10497.9475102624;10554.683359499228;10575;10644.627438039632;10677;15946.60133496672;17769.11154442273;17999.19003644839;18001.09994500296;18007.189676464328;7991.200879911962;8007.83984320322;8022.197780221931;8176;8199.631016604268;4454.220511410555;4460.420145381079;4484.148011877733;4567.4062371892105;4683.7892294846815;3335.533025376449;3387.1024178592693;3388.288459423549;3390.881319153818;3395.6095049069672;622.5237693164732;628.1959092361784;636.395424346863;637.209859773877;647.9676016199171;498.4890487250597;590.4420322795004;610.0270069239556;680.9114815074008;708.4438715608326;8704.477731336141;8814.338924580683;8939.463632182089;9166.009837472115;9294.628214871329;686.2691233835949;696.4115322552435;704.8097013806243;741.6254791330343;746.9551826890404;4050.797460126982;4165.75005499671;4176.248275310473;4308.655307575386;4463.709858859163;56604.43395566074;57446;58155.709221453624;58202.708986454796;59028;48859.51140488621;49170.26244606334;52363.738181309614;53711.46288537143;53775.73112134414;41937.58062419337;46936.53063469322;51979.74010129925;52870.47129528732;56950.715246423504;8785.692500762443;8833;9004.459732416077;9026.903205973706;9460.526973651153;37450.8127459361;37699.62300377071;37907.62092379041;38290.42564361481;38715.80642096772;44261;46126;47021.76489117533;47424.28863567118;47808.760956194994;10971.561137554409;11004.889951100387;11432.314061156358;11448.084153267886;11475.081993440672;12456.31490268044;12990;13012.869871301165;13056;13413.262270575213;11549.82675259855;11710.297382157098;11933.940330298294;12285.324307163191;12859.16415432994;11910.880891191324;12051.638450846489;12117.394130293625;12175;12576.559820406608;11582.073434125417;11644.708882278012;11693.239939403911;11848.052155827685;12037.97677197448;9568.186704130227;9763.707088787347;9769;9995.650152244636;10032.498375081072;10257.794844103226;10352.637657681946;10449.320794148356;10487.94756026215;10502.632407865687 17:27:40 INFO - PROCESS | 15315 | __end_tp_report 17:27:40 INFO - PROCESS | 15315 | __start_cc_report 17:27:40 INFO - PROCESS | 15315 | _x_x_mozilla_cycle_collect,772 17:27:40 INFO - PROCESS | 15315 | __end_cc_report 17:27:40 INFO - PROCESS | 15315 | __startTimestamp1458779260513__endTimestamp 17:27:40 INFO - PROCESS | 15315 | 17:27:40 INFO - PROCESS | 15315 | ------- Summary: start ------- 17:27:40 INFO - PROCESS | 15315 | Number of tests: 6 17:27:40 INFO - PROCESS | 15315 | 17:27:40 INFO - PROCESS | 15315 | [#0] dojo.html Cycles:165 Average:5299.24 Median:5517.59 stddev:592.65 (10.7%) stddev-sans-first:567.80 17:27:40 INFO - PROCESS | 15315 | Values: 3058.4 3094.0 3117.0 3133.8 3156.4 5332.8 5359.7 5390.6 5404.3 5420.9 5347.5 5363.8 5364.9 5384.8 5416.0 4866.7 4874.2 4875.1 4891.2 5007.4 4920.7 4989.3 4999.8 5003.2 5007.9 4830.6 4876.2 4944.2 4969.9 4982.5 4864.0 4894.9 4898.4 4931.4 4946.3 4843.9 4857.4 4863.7 4868.8 4922.2 5262.3 5311.9 5338.3 5398.4 5402.3 5740.0 5766.2 5773.9 5778.8 5782.4 5780.5 5787.9 5800.6 5801.2 5801.6 5266.6 5375.8 5397.4 5444.6 5464.3 5862.1 5868.5 5870.7 5892.1 5940.5 5575.7 5648.4 5660.4 5668.5 5669.4 5734.9 5762.6 5782.5 5834.5 5836.1 5534.8 5567.7 5569.1 5579.1 5581.9 5511.3 5522.7 5587.8 5609.0 5624.1 4341.7 4353.5 4356.8 4383.5 4396.4 3853.7 3858.4 3877.3 3877.9 3917.2 5217.6 5333.2 5373.2 5426.9 5434.5 5606.5 5617.6 5636.1 5647.1 5696.6 5238.2 5245.7 5247.9 5256.3 5323.9 4685.2 4733.0 4781.5 4862.6 4875.3 5803.7 5819.9 5820.1 5825.0 5826.5 5667.5 5672.0 5676.9 5678.9 5680.8 5848.1 5884.7 5950.8 5951.3 5972.9 5557.4 5558.8 5562.1 5569.2 5570.3 5572.5 5676.7 5680.3 5685.0 5686.8 5530.2 5621.3 5622.6 5631.4 5636.3 5589.0 5614.3 5615.0 5616.7 5628.0 5359.7 5517.6 5547.4 5547.7 5556.0 5544.9 5551.8 5574.4 5585.8 5626.1 5358.7 5422.2 5423.3 5449.7 5507.3 17:27:40 INFO - PROCESS | 15315 | 17:27:40 INFO - PROCESS | 15315 | [#1] ext.html Cycles:180 Average:47180.00 Median:18998.87 stddev:77701.01 (409.0%) stddev-sans-first:77840.03 17:27:40 INFO - PROCESS | 15315 | Values: 526.3 569.3 572.7 579.1 589.9 30864.7 31369.0 38846.4 39256.6 39311.6 41532.6 41886.0 41911.2 41929.8 41979.8 8631.1 8829.6 8829.9 8832.4 8852.3 8132.1 10431.8 10657.9 10694.0 10706.0 10432.2 10462.0 10492.9 10515.2 10533.3 10327.0 10394.2 10398.2 10406.4 10410.5 10205.9 10309.8 10328.7 10333.9 10336.8 41039.8 41765.0 41833.2 41880.8 41900.8 3286.0 3327.2 3330.3 3386.1 3946.6 31845.4 31889.2 32096.2 33027.8 33041.7 4155.3 4206.4 4207.2 4264.7 4285.0 282434.0 282846.0 282999.0 284323.0 285309.0 61494.0 62220.4 62402.1 62432.4 62608.4 65714.3 65725.7 65799.3 65835.0 65894.3 16431.8 16685.8 16688.8 16705.1 16705.6 11752.8 12498.6 12677.9 13040.9 13056.8 18894.7 19123.9 19139.5 19153.9 19181.0 7380.7 7738.2 7762.0 7801.9 7820.0 1000.4 1006.2 1048.1 1081.3 1134.7 32135.7 32231.0 32566.7 32708.5 32776.2 1174.4 1179.5 1211.1 1211.2 1218.7 16196.6 16751.7 16862.9 16973.6 17129.7 377622.0 381073.0 381343.0 382433.0 382572.0 56267.7 57394.0 57421.1 57439.7 57441.4 1231.2 1327.9 1395.8 1422.9 1430.7 28697.7 28939.9 29096.1 29546.7 29654.9 42059.4 42223.8 42571.4 42710.0 42783.8 185894.0 187101.0 199167.0 199912.0 200267.0 30681.8 34611.7 35460.8 35886.0 35951.5 44839.0 45748.5 46250.3 46548.5 46847.5 38906.6 39492.0 39496.0 39672.8 39848.6 37798.4 38326.0 39319.4 39793.8 40426.4 39762.4 40385.6 40429.2 40941.0 40981.6 34867.5 35756.5 36226.0 36387.0 36620.1 27484.3 27662.9 27858.4 27943.3 27949.7 17:27:40 INFO - PROCESS | 15315 | 17:27:40 INFO - PROCESS | 15315 | [#2] jquery.html Cycles:180 Average:27262.69 Median:2652.66 stddev:76144.05 (2870.5%) stddev-sans-first:76330.88 17:27:40 INFO - PROCESS | 15315 | Values: 369.9 370.2 371.7 375.9 380.0 17154.0 17567.7 18598.7 19089.0 19101.3 16655.8 17066.7 17681.3 17691.6 17692.6 5590.5 5744.8 5750.3 5760.6 5782.0 4201.7 5629.6 6013.9 6251.0 6285.9 6169.5 6231.8 6231.9 6233.3 6240.0 6055.2 6147.9 6179.4 6196.8 6211.8 3686.1 5279.7 5430.1 5455.2 5466.2 20077.9 20662.0 20767.9 20794.5 20819.4 2271.3 2327.3 2345.5 2630.7 2674.6 13256.4 13275.5 13308.5 13769.2 13787.8 1890.4 1919.6 1931.7 1968.0 2023.1 69295.3 70480.3 71377.6 71578.3 71693.6 10893.4 10907.8 10919.4 10989.6 11132.2 13995.6 14042.2 14070.2 14070.4 14070.4 8073.2 8265.0 8331.7 8404.1 8434.8 8186.2 8256.3 8328.7 8383.7 8429.2 4547.8 4630.5 4647.3 4704.7 4713.4 1742.5 1810.0 1832.6 1834.7 1852.3 979.8 983.1 994.2 1025.7 1078.5 17537.2 17545.3 17955.8 18100.2 18414.4 974.3 990.2 992.4 993.0 1028.3 9947.6 10054.2 10318.7 10393.7 10507.0 456144.0 457225.9 462557.0 466651.0 472960.0 81331.0 82270.6 86834.6 87080.1 87274.0 1012.8 1015.2 1028.0 1030.3 1031.9 15747.6 15969.1 16081.2 16100.5 16166.8 35468.6 35608.5 36875.6 37098.3 37561.2 53038.7 53091.7 53126.2 53597.0 53658.2 7693.2 7888.5 8011.3 8013.5 8083.1 11605.9 11627.6 11781.5 12008.8 12259.7 10297.5 11148.7 11280.8 11470.5 11700.4 11102.2 11421.5 11682.5 11876.3 11968.8 11086.1 11176.9 11583.3 11828.2 12220.5 7983.5 8213.8 8308.6 8397.0 8498.6 10235.6 11725.1 11892.6 11968.2 11977.3 17:27:40 INFO - PROCESS | 15315 | 17:27:40 INFO - PROCESS | 15315 | [#3] mootools.html Cycles:180 Average:5834.48 Median:5163.94 stddev:3112.84 (60.3%) stddev-sans-first:3103.75 17:27:40 INFO - PROCESS | 15315 | Values: 1402.4 1499.7 1509.4 1681.7 1833.0 7940.7 8155.0 8163.6 8167.4 8171.6 8008.4 8118.5 8131.7 8136.1 8177.3 2028.9 2252.9 2257.3 2279.8 2305.2 2313.6 2349.4 2350.1 2350.2 2351.3 2243.5 2331.1 2332.1 2334.7 2337.0 2042.5 2290.5 2339.5 2340.5 2340.7 2245.5 2273.1 2280.3 2287.0 2288.3 8307.3 8382.9 8397.7 8399.8 8405.4 5009.0 5127.1 5166.2 5168.4 5170.4 3427.9 3444.9 3501.9 3540.5 3557.7 1075.9 1090.2 1091.5 1117.2 1169.8 11663.9 11682.3 11708.5 11715.2 11720.5 4534.2 4643.0 4658.4 4664.9 4683.9 9875.2 9889.5 9893.1 9915.7 9947.4 4638.7 5122.7 5152.8 5156.2 5161.7 4629.3 4699.2 4709.9 4754.9 4756.6 3890.5 3977.9 4001.4 4003.5 4030.2 1195.7 1201.4 1206.7 1209.3 1256.0 1371.8 1379.8 1393.6 1411.3 1414.4 7628.4 7775.1 7784.2 7798.5 7806.3 487.0 494.0 498.6 498.9 499.2 5940.7 5959.3 5991.8 6035.5 6037.2 9647.8 10364.7 10461.3 10563.9 10565.0 10102.9 10250.4 10301.0 10397.6 10444.2 7897.3 7919.6 7966.6 8039.3 8074.8 7707.9 7737.4 7739.4 7742.5 7836.5 9101.5 9198.5 9274.9 9277.4 9348.3 9480.5 9611.3 9711.5 9729.1 9805.1 6578.3 6761.8 7110.9 7259.6 7390.5 7990.5 7997.3 8036.7 8039.8 8041.8 6855.3 7041.3 7043.9 7166.0 7181.9 7014.3 7060.9 7113.9 7198.2 7233.2 7212.5 7594.4 7613.9 7622.6 7632.1 6766.4 6789.8 6796.7 6800.7 6820.2 6966.5 7032.8 7055.3 7063.5 7075.6 17:27:40 INFO - PROCESS | 15315 | 17:27:40 INFO - PROCESS | 15315 | [#4] prototype.html Cycles:180 Average:5327.60 Median:6072.36 stddev:1618.15 (26.6%) stddev-sans-first:1578.66 17:27:40 INFO - PROCESS | 15315 | Values: 332.8 339.8 341.5 342.9 350.1 5904.8 5941.8 5956.6 5957.6 5964.3 5893.0 5896.6 5912.4 5926.8 5932.2 4406.5 4491.7 4549.2 4603.5 4635.9 4599.0 4615.6 4627.3 4629.0 4635.4 4565.8 4568.5 4574.5 4577.5 4599.7 4375.2 4465.8 4546.2 4585.4 4585.6 4005.5 4020.8 4029.2 4029.4 4029.9 5782.4 5789.1 5796.7 5796.9 5813.4 5332.4 5350.2 5352.6 5353.5 5356.5 6321.6 6325.3 6326.1 6331.7 6334.2 4247.3 4385.7 4386.9 4391.2 4471.9 6579.4 6630.8 6648.0 6657.0 6657.3 4444.9 4465.4 4470.3 4471.4 4472.5 4530.3 4535.5 4569.9 4570.1 4571.5 5262.2 5264.0 5267.6 5269.8 5270.5 6170.1 6377.8 6403.9 6405.7 6407.4 1573.4 1574.8 1575.2 1584.7 1591.8 978.8 1030.2 1046.4 1048.9 1061.0 6067.6 6094.4 6118.7 6119.0 6132.1 6538.5 6557.9 6561.8 6563.4 6574.4 6077.1 6084.4 6085.3 6085.7 6089.4 3515.8 3542.9 3546.7 3548.2 3549.9 6643.3 6734.1 6774.4 6783.7 6793.2 6642.2 6644.1 6661.1 6667.8 6668.4 6741.3 6744.7 6755.9 6760.3 6770.5 6526.5 6531.1 6532.3 6533.8 6539.4 6360.7 6496.0 6524.9 6546.5 6607.2 6836.9 6887.0 6893.5 6902.2 6911.8 4472.6 4518.6 4524.6 4527.0 4530.9 6662.4 6663.6 6669.9 6672.4 6674.5 6378.1 6497.2 6501.7 6507.1 6527.1 6514.9 6525.7 6530.8 6552.2 6553.4 6314.3 6338.1 6339.0 6340.9 6365.6 6464.1 6475.5 6481.9 6482.5 6485.4 6032.0 6162.7 6177.6 6298.2 6308.0 17:27:40 INFO - PROCESS | 15315 | 17:27:40 INFO - PROCESS | 15315 | [#5] yui.html Cycles:180 Average:14293.70 Median:4525.78 stddev:16589.01 (366.5%) stddev-sans-first:16603.85 17:27:40 INFO - PROCESS | 15315 | Values: 639.8 668.4 673.5 776.3 782.9 12768.3 13067.9 13074.9 13077.3 13084.5 12056.5 12151.9 12155.1 12158.9 13382.3 792.6 799.1 804.2 804.5 804.9 795.5 802.4 802.5 802.8 804.4 838.6 844.6 846.6 848.5 848.5 836.3 836.9 837.9 838.0 838.0 611.6 612.2 613.0 613.1 613.2 12608.0 12681.7 12735.0 12772.9 12782.8 13161.1 13304.1 13313.1 13320.5 13350.7 10665.7 10673.1 10805.7 10928.5 11088.7 3667.4 3699.4 3771.1 3813.7 3817.8 46200.0 50959.0 51942.7 53008.2 53023.2 10497.9 10554.7 10575.0 10644.6 10677.0 15946.6 17769.1 17999.2 18001.1 18007.2 7991.2 8007.8 8022.2 8176.0 8199.6 4454.2 4460.4 4484.1 4567.4 4683.8 3335.5 3387.1 3388.3 3390.9 3395.6 622.5 628.2 636.4 637.2 648.0 498.5 590.4 610.0 680.9 708.4 8704.5 8814.3 8939.5 9166.0 9294.6 686.3 696.4 704.8 741.6 747.0 4050.8 4165.8 4176.2 4308.7 4463.7 56604.4 57446.0 58155.7 58202.7 59028.0 48859.5 49170.3 52363.7 53711.5 53775.7 41937.6 46936.5 51979.7 52870.5 56950.7 8785.7 8833.0 9004.5 9026.9 9460.5 37450.8 37699.6 37907.6 38290.4 38715.8 44261.0 46126.0 47021.8 47424.3 47808.8 10971.6 11004.9 11432.3 11448.1 11475.1 12456.3 12990.0 13012.9 13056.0 13413.3 11549.8 11710.3 11933.9 12285.3 12859.2 11910.9 12051.6 12117.4 12175.0 12576.6 11582.1 11644.7 11693.2 11848.1 12038.0 9568.2 9763.7 9769.0 9995.7 10032.5 10257.8 10352.6 10449.3 10487.9 10502.6 17:27:40 INFO - PROCESS | 15315 | -------- Summary: end -------- 17:27:40 INFO - PROCESS | 15315 | 17:27:41 INFO - TEST-INFO | 15315: exit 0 17:27:41 INFO - TEST-OK | dromaeo_css | took 1110544ms 17:27:41 INFO - TEST-START | kraken 17:27:41 INFO - operating with platform_type : linux_ 17:27:41 INFO - Initialising browser for kraken test... 17:27:41 INFO - TEST-INFO | started process 15503 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaZYD9F/profile http://localhost:51593/getInfo.html) 17:27:44 INFO - PROCESS | 15503 | __metrics Screen width/height:1600/1200 17:27:44 INFO - PROCESS | 15503 | colorDepth:24 17:27:44 INFO - PROCESS | 15503 | Browser inner width/height: 1024/697 17:27:44 INFO - PROCESS | 15503 | __metrics 17:27:45 ERROR - PROCESS | 15503 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:27:46 INFO - TEST-INFO | 15503: exit 0 17:27:46 INFO - Browser initialized. 17:27:46 INFO - Running cycle 1/1 for kraken test... 17:27:46 INFO - TEST-INFO | started process 15590 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaZYD9F/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:58 INFO - PROCESS | 15590 | RSS: Main: 157085696 17:27:58 INFO - PROCESS | 15590 | 17:28:00 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:51593/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51593/tests/kraken/driver.html?testName=audio-beat-detection) 17:28:01 INFO - PROCESS | 15590 | RSS: Main: 195452928 17:28:01 INFO - PROCESS | 15590 | 17:28:03 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:51593/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51593/tests/kraken/driver.html?testName=audio-dft) 17:28:04 INFO - PROCESS | 15590 | RSS: Main: 186392576 17:28:04 INFO - PROCESS | 15590 | 17:28:07 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:51593/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51593/tests/kraken/driver.html?testName=audio-fft) 17:28:07 INFO - PROCESS | 15590 | RSS: Main: 170995712 17:28:07 INFO - PROCESS | 15590 | 17:28:09 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:51593/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51593/tests/kraken/driver.html?testName=audio-oscillator) 17:28:10 INFO - PROCESS | 15590 | RSS: Main: 172560384 17:28:10 INFO - PROCESS | 15590 | 17:28:12 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:51593/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51593/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:28:13 INFO - PROCESS | 15590 | RSS: Main: 174071808 17:28:13 INFO - PROCESS | 15590 | 17:28:16 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:51593/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51593/tests/kraken/driver.html?testName=imaging-darkroom) 17:28:16 INFO - PROCESS | 15590 | RSS: Main: 176033792 17:28:16 INFO - PROCESS | 15590 | 17:28:19 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:51593/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51593/tests/kraken/driver.html?testName=imaging-desaturate) 17:28:20 INFO - PROCESS | 15590 | RSS: Main: 175714304 17:28:20 INFO - PROCESS | 15590 | 17:28:23 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:51593/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51593/tests/kraken/driver.html?testName=json-parse-financial) 17:28:23 INFO - PROCESS | 15590 | RSS: Main: 176443392 17:28:23 INFO - PROCESS | 15590 | 17:28:25 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:51593/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51593/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:28:26 INFO - PROCESS | 15590 | RSS: Main: 187498496 17:28:26 INFO - PROCESS | 15590 | 17:28:27 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:51593/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51593/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:28:28 INFO - PROCESS | 15590 | RSS: Main: 184094720 17:28:28 INFO - PROCESS | 15590 | 17:28:30 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:51593/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51593/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:28:30 INFO - PROCESS | 15590 | RSS: Main: 195678208 17:28:30 INFO - PROCESS | 15590 | 17:28:33 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:51593/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:28:33 INFO - PROCESS | 15590 | RSS: Main: 201424896 17:28:33 INFO - PROCESS | 15590 | 17:28:36 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:51593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:28:36 INFO - PROCESS | 15590 | RSS: Main: 201666560 17:28:36 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:51593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51593/tests/kraken/driver.html?testName=ai-astar) 17:28:38 INFO - PROCESS | 15590 | RSS: Main: 260653056 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | __start_tp_report 17:28:38 INFO - PROCESS | 15590 | _x_x_mozilla_page_load 17:28:38 INFO - PROCESS | 15590 | _x_x_mozilla_page_load_details 17:28:38 INFO - PROCESS | 15590 | |i|pagename|runs| 17:28:38 INFO - PROCESS | 15590 | |0;ai-astar;118;109;104;110;110;110;99;109;109;109 17:28:38 INFO - PROCESS | 15590 | |1;audio-beat-detection;162;125;148;177;122;149;155;125;165;124 17:28:38 INFO - PROCESS | 15590 | |2;audio-dft;160;162;161;161;159;159;162;162;161;160 17:28:38 INFO - PROCESS | 15590 | |3;audio-fft;76;74;121;96;75;75;75;114;95;72 17:28:38 INFO - PROCESS | 15590 | |4;audio-oscillator;92;92;146;92;92;93;141;93;92;140 17:28:38 INFO - PROCESS | 15590 | |5;imaging-gaussian-blur;116;117;117;117;117;117;116;117;119;118 17:28:38 INFO - PROCESS | 15590 | |6;imaging-darkroom;146;145;144;146;145;145;146;145;146;146 17:28:38 INFO - PROCESS | 15590 | |7;imaging-desaturate;95;95;96;96;95;96;95;95;95;95 17:28:38 INFO - PROCESS | 15590 | |8;json-parse-financial;56;57;55;56;55;56;57;64;55;54 17:28:38 INFO - PROCESS | 15590 | |9;json-stringify-tinderbox;59;60;60;59;60;59;59;59;59;60 17:28:38 INFO - PROCESS | 15590 | |10;stanford-crypto-aes;76;78;78;77;87;78;85;78;78;79 17:28:38 INFO - PROCESS | 15590 | |11;stanford-crypto-ccm;111;117;107;114;118;107;110;109;109;108 17:28:38 INFO - PROCESS | 15590 | |12;stanford-crypto-pbkdf2;143;131;141;141;143;132;147;143;141;153 17:28:38 INFO - PROCESS | 15590 | |13;stanford-crypto-sha256-iterative;64;63;65;64;64;63;62;64;64;62 17:28:38 INFO - PROCESS | 15590 | __end_tp_report 17:28:38 INFO - PROCESS | 15590 | __start_cc_report 17:28:38 INFO - PROCESS | 15590 | _x_x_mozilla_cycle_collect,1039 17:28:38 INFO - PROCESS | 15590 | __end_cc_report 17:28:38 INFO - PROCESS | 15590 | __startTimestamp1458779318842__endTimestamp 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | ------- Summary: start ------- 17:28:38 INFO - PROCESS | 15590 | Number of tests: 14 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:4.81 (4.4%) stddev-sans-first:3.74 17:28:38 INFO - PROCESS | 15590 | Values: 118.0 109.0 104.0 110.0 110.0 110.0 99.0 109.0 109.0 109.0 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:152.00 stddev:20.02 (13.2%) stddev-sans-first:20.29 17:28:38 INFO - PROCESS | 15590 | Values: 162.0 125.0 148.0 177.0 122.0 149.0 155.0 125.0 165.0 124.0 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 17:28:38 INFO - PROCESS | 15590 | Values: 160.0 162.0 161.0 161.0 159.0 159.0 162.0 162.0 161.0 160.0 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | [#3] audio-fft Cycles:10 Average:87.30 Median:75.00 stddev:18.18 (24.2%) stddev-sans-first:18.82 17:28:38 INFO - PROCESS | 15590 | Values: 76.0 74.0 121.0 96.0 75.0 75.0 75.0 114.0 95.0 72.0 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:92.00 stddev:24.23 (26.3%) stddev-sans-first:25.05 17:28:38 INFO - PROCESS | 15590 | Values: 92.0 92.0 146.0 92.0 92.0 93.0 141.0 93.0 92.0 140.0 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.83 17:28:38 INFO - PROCESS | 15590 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 119.0 118.0 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 17:28:38 INFO - PROCESS | 15590 | Values: 146.0 145.0 144.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:28:38 INFO - PROCESS | 15590 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:2.80 (5.0%) stddev-sans-first:2.96 17:28:38 INFO - PROCESS | 15590 | Values: 56.0 57.0 55.0 56.0 55.0 56.0 57.0 64.0 55.0 54.0 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 17:28:38 INFO - PROCESS | 15590 | Values: 59.0 60.0 60.0 59.0 60.0 59.0 59.0 59.0 59.0 60.0 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:78.00 stddev:3.60 (4.6%) stddev-sans-first:3.60 17:28:38 INFO - PROCESS | 15590 | Values: 76.0 78.0 78.0 77.0 87.0 78.0 85.0 78.0 78.0 79.0 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | [#11] stanford-crypto-ccm Cycles:10 Average:111.00 Median:110.50 stddev:4.00 (3.6%) stddev-sans-first:4.24 17:28:38 INFO - PROCESS | 15590 | Values: 111.0 117.0 107.0 114.0 118.0 107.0 110.0 109.0 109.0 108.0 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.50 Median:143.00 stddev:6.42 (4.5%) stddev-sans-first:6.78 17:28:38 INFO - PROCESS | 15590 | Values: 143.0 131.0 141.0 141.0 143.0 132.0 147.0 143.0 141.0 153.0 17:28:38 INFO - PROCESS | 15590 | 17:28:38 INFO - PROCESS | 15590 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 17:28:38 INFO - PROCESS | 15590 | Values: 64.0 63.0 65.0 64.0 64.0 63.0 62.0 64.0 64.0 62.0 17:28:38 INFO - PROCESS | 15590 | -------- Summary: end -------- 17:28:38 INFO - PROCESS | 15590 | 17:28:39 INFO - TEST-INFO | 15590: exit 0 17:28:39 INFO - TEST-OK | kraken | took 58521ms 17:28:39 INFO - SUITE-END | took 1169s 17:28:40 INFO - Completed test suite (00:19:29) 17:28:40 INFO - javascript benchmark 17:28:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3058.373033528126, 3093.984530077349, 3117.0, 3133.7649676274273, 3156.4318422683914, 5332.760025798839, 5359.67841929484, 5390.568754499641, 5404.270423492837, 5420.945790542093, 5347.465253474651, 5363.785448582062, 5364.946350536494, 5384.811531596395, 5415.972920135394, 4866.707997520142, 4874.220124780036, 4875.122477953967, 4891.217405215166, 5007.424146223177, 4920.655554111214, 4989.251612258172, 4999.8000079996755, 5003.2245002024565, 5007.899842003158, 4830.565249127578, 4876.219804831246, 4944.233643785219, 4969.850904472872, 4982.451930287665, 4863.975680121577, 4894.853154405374, 4898.412190537123, 4931.3835770528685, 4946.282788995575, 4843.903121937541, 4857.368542089541, 4863.683860549053, 4868.78090485929, 4922.212446008657, 5262.342207224097, 5311.946880531223, 5338.27933229013, 5398.352197736258, 5402.297701298845, 5740.024195886709, 5766.221560089376, 5773.9422605773825, 5778.826635200909, 5782.392848750863, 5780.53755699543, 5787.855303617401, 5800.622959507618, 5801.187833703243, 5801.593888427812, 5266.631335806495, 5375.784968601251, 5397.3523177218985, 5444.646098003656, 5464.26232458621, 5862.12068189775, 5868.501177399883, 5870.706464676749, 5892.116182572563, 5940.495057920039, 5575.721213939287, 5648.406917273627, 5660.405657405995, 5668.489835914787, 5669.4047125051275, 5734.856628584319, 5762.625429347163, 5782.537397008229, 5834.533237341003, 5836.124581312837, 5534.7786088556, 5567.749451274703, 5569.10894256917, 5579.107342825128, 5581.916271255935, 5511.311086114236, 5522.723863806794, 5587.832365029056, 5609.046462101453, 5624.072028115315, 4341.674374421931, 4353.455818022747, 4356.760378179167, 4383.539728328479, 4396.384506169139, 3853.7495062820826, 3858.401947698111, 3877.268057176507, 3877.922441551153, 3917.1578110706337, 5217.556507696812, 5333.226682131147, 5373.220882972026, 5426.9185962210595, 5434.456554344534, 5606.523445507096, 5617.550595952314, 5636.126400407943, 5647.124695672177, 5696.601237913306, 5238.188080847474, 5245.6852588844795, 5247.895042099137, 5256.342957130359, 5323.946760532423, 4685.180093483695, 4733.006068725606, 4781.521847815191, 4862.610991120702, 4875.293082503017, 5803.6807975560905, 5819.883602328015, 5820.068788993825, 5825.0, 5826.504747096459, 5667.518260947865, 5671.971640141773, 5676.886462270814, 5678.914816277676, 5680.829575112753, 5848.122781582797, 5884.735186916513, 5950.7917222896995, 5951.256092988377, 5972.850678732892, 5557.36090349615, 5558.805441809517, 5562.082256427644, 5569.19246709233, 5570.303712035996, 5572.4706152915405, 5676.659400435987, 5680.289963754531, 5685.033544297562, 5686.829395118153, 5530.198121272473, 5621.269234999424, 5622.606417550732, 5631.380548139619, 5636.2954630671165, 5589.0, 5614.326280846324, 5614.9719251403485, 5616.69108199053, 5627.971860140673, 5359.705216213146, 5517.586181036358, 5547.44525547442, 5547.667139971614, 5555.972220138873, 5544.861378465571, 5551.805686800943, 5574.442555744393, 5585.776568937197, 5626.071698169756, 5358.732063396893, 5422.186671999231, 5423.29497165366, 5449.700266485382, 5507.339119305549], "unit": "score", "name": "dojo.html", "value": 5259.720132171541}, {"lowerIsBetter": false, "replicates": [526.3447008474448, 569.2628046679549, 572.7193675099202, 579.1341943794029, 589.9233099697038, 30864.691353086462, 31369.0, 38846.41730374047, 39256.60743392565, 39311.606883931156, 41532.58467415325, 41886.0, 41911.16177676445, 41929.7903510482, 41979.79010104945, 8631.093735157796, 8829.60266787996, 8829.911700882973, 8832.381733278673, 8852.336074794417, 8132.064812546544, 10431.791364172712, 10657.893421065806, 10694.0, 10706.036456718894, 10432.165426765878, 10462.0, 10492.895071049306, 10515.158787296998, 10533.315334503272, 10327.0, 10394.22043346752, 10398.168146548258, 10406.375617462938, 10410.531526081344, 10205.897941020568, 10309.79380412395, 10328.690139295833, 10333.896661033368, 10336.79326413475, 41039.794801025804, 41765.0, 41833.1633367334, 41880.79059604713, 41900.79049604763, 3285.950710739317, 3327.218103745618, 3330.283988942365, 3386.0857568456377, 3946.605339466059, 31845.363092738015, 31889.202769930936, 32096.197595060075, 33027.83486082578, 33041.66958330434, 4155.31437312843, 4206.3690446432975, 4207.221663992172, 4264.699266723648, 4285.035866929947, 282434.0, 282846.0, 282999.0, 284323.0, 285309.0, 61494.0, 62220.37779622146, 62402.0639690405, 62432.375676243566, 62608.37391626117, 65714.34285657178, 65725.67137164283, 65799.34200657932, 65835.0, 65894.34105658978, 16431.835681643268, 16685.83314166867, 16688.83311166873, 16705.081220532986, 16705.582360440843, 11752.823707644393, 12498.562550310877, 12677.87322126767, 13040.869591303965, 13056.804147937788, 18894.716579251322, 19123.90438047829, 19139.521511962314, 19153.904230478758, 19181.0, 7380.667869945865, 7738.187490313549, 7762.0, 7801.94673719052, 7819.960900195462, 1000.4185017636843, 1006.2453160129902, 1048.051513380392, 1081.2593373538994, 1134.7163209197702, 32135.678643213738, 32231.0, 32566.720329576703, 32708.509372359433, 32776.180595485304, 1174.3599738142732, 1179.4515550269166, 1211.0553768060927, 1211.2006075989805, 1218.7318789866215, 16196.595085122966, 16751.748723769153, 16862.91568542174, 16973.575660608338, 17129.657406851795, 377622.0, 381073.0, 381343.0, 382433.0, 382572.0, 56267.718661406434, 57394.0, 57421.13868291979, 57439.71280143656, 57441.42558574361, 1231.2489381477292, 1327.9070465067546, 1395.818543589327, 1422.9359678814478, 1430.7281616493042, 28697.708603113326, 28939.85530072336, 29096.127116186548, 29546.704532954394, 29654.851725742097, 42059.369109463994, 42223.78888105663, 42571.3614295792, 42710.0, 42783.7860810694, 185894.0, 187101.0, 199167.0, 199912.0, 200267.0, 30681.8465907669, 34611.65388346185, 35460.822695887386, 35886.0, 35951.46072808962, 44839.0, 45748.54251457576, 46250.30624540702, 46548.53451465442, 46847.53152468568, 38906.61093389143, 39492.0, 39496.01259968524, 39672.80163599164, 39848.612867905395, 37798.43302350522, 38326.0, 39319.41020884632, 39793.80103099466, 40426.39360409537, 39762.40356394714, 40385.59614403819, 40429.1914161721, 40941.0, 40981.590184097775, 34867.4769878447, 35756.46365304574, 36226.0, 36387.0, 36620.084497887765, 27484.312892177855, 27662.86168569144, 27858.442831143668, 27943.301417464725, 27949.720502794713], "unit": "score", "name": "ext.html", "value": 19537.569744679717}, {"lowerIsBetter": false, "replicates": [369.9186179040612, 370.22807446474116, 371.68088965537737, 375.87596093289216, 379.97530160539543, 17154.0, 17567.73648395275, 18598.721019184704, 19089.0, 19101.331453399132, 16655.750163747554, 17066.743998839996, 17681.292748290085, 17691.557711057198, 17692.557686057855, 5590.496855283024, 5744.79893203738, 5750.252467179261, 5760.596758226926, 5782.0, 4201.684873634475, 5629.577781666371, 6013.909791353133, 6250.968590182614, 6285.9057114143325, 6169.537284703665, 6231.750729970796, 6231.906521402183, 6233.345498722637, 6239.968800156015, 6055.152278680988, 6147.907781383283, 6179.38206179383, 6196.845078873064, 6211.782587609435, 3686.1153323202507, 5279.656822306538, 5430.131179011379, 5455.1544510600925, 5466.207399927028, 20077.899610502, 20662.0, 20767.8961605191, 20794.48013799652, 20819.37541873746, 2271.3299576624936, 2327.301809457156, 2345.5074434368803, 2630.710621831597, 2674.6121812337296, 13256.40346184424, 13275.53535626258, 13308.534201302908, 13769.242691651954, 13787.793183102262, 1890.376175861976, 1919.577692907558, 1931.6909294512811, 1967.9901600491905, 2023.0896096756371, 69295.25674716968, 70480.29519704789, 71377.64311178462, 71578.2842171582, 71693.641531792, 10893.400862952456, 10907.83638245427, 10919.39943303126, 10989.61536346224, 11132.165087618461, 13995.580132596038, 14042.1574705518, 14070.226137562327, 14070.366833492517, 14070.366833492517, 8073.19268073188, 8264.958675206586, 8331.708390206435, 8404.07555168931, 8434.831303374021, 8186.222308880647, 8256.25693687571, 8328.66685332592, 8383.664653413916, 8429.157084291523, 4547.840300723361, 4630.490646028934, 4647.326137710013, 4704.717716936994, 4713.363695901078, 1742.5208067781462, 1810.0081067138278, 1832.560185555457, 1834.7247912812918, 1852.2776117314258, 979.7942432089199, 983.1250187333279, 994.1549682769588, 1025.6512785652915, 1078.4769386847372, 17537.210825512884, 17545.29818807259, 17955.820441795415, 18100.18549165291, 18414.35549755752, 974.2692980264801, 990.2078337330252, 992.4442312305132, 993.0288377570516, 1028.2545154762738, 9947.55236014381, 10054.245931555017, 10318.742031449274, 10393.740156496147, 10507.00183482568, 456144.0, 457225.8525781114, 462557.0, 466651.0, 472960.0, 81331.0, 82270.58864705639, 86834.56582717046, 87080.1291987072, 87274.0, 1012.8278192707257, 1015.1523477896039, 1028.043919155193, 1030.3457304611475, 1031.865857438528, 15747.606309842346, 15969.121698306704, 16081.195940203177, 16100.516984490485, 16166.757498637766, 35468.61027990196, 35608.46587301244, 36875.631243688294, 37098.25803483861, 37561.2487750238, 53038.73480632572, 53091.734541327045, 53126.20310695266, 53597.0, 53658.19512707391, 7693.153753087267, 7888.526688398714, 8011.278984891388, 8013.519188848688, 8083.070446898447, 11605.883941160819, 11627.59303424376, 11781.469833857325, 12008.759824803281, 12259.69350766238, 10297.53661085238, 11148.665540033811, 11280.774384512428, 11470.541178353105, 11700.414979250832, 11102.222844401138, 11421.458103155968, 11682.47428865686, 11876.346800925687, 11968.76062478728, 11086.113110951266, 11176.944115279372, 11583.305001699924, 11828.23116497425, 12220.51117955272, 7983.481073730189, 8213.83572328562, 8308.626111824862, 8397.034341050858, 8498.575071246536, 10235.590576376862, 11725.120615954009, 11892.643220703392, 11968.16222864426, 11977.281363118242], "unit": "score", "name": "jquery.html", "value": 8969.668881293253}, {"lowerIsBetter": false, "replicates": [1402.3899603672396, 1499.6550793317538, 1509.4113295814632, 1681.6720739455802, 1832.9541761455962, 7940.682372705092, 8154.959225203873, 8163.5918204089785, 8167.428280020386, 8171.632276547555, 8008.439409241356, 8118.512889226636, 8131.674733010673, 8136.064352599453, 8177.304929081035, 2028.898555072248, 2252.8986195621237, 2257.345369842744, 2279.8290128240365, 2305.227748704186, 2313.5835549601065, 2349.3656712687566, 2350.059976009593, 2350.1539445799585, 2351.341624345186, 2243.461569223391, 2331.1258278145697, 2332.125452955142, 2334.6848175496343, 2336.9766302337016, 2042.5302180498495, 2290.473191166033, 2339.508703172336, 2340.520193360357, 2340.6957095577636, 2245.517213799041, 2273.1248469339257, 2280.2589158523547, 2286.9937227619794, 2288.336382449088, 8307.335413166933, 8382.916170838274, 8397.748067557983, 8399.790005249857, 8405.369597280229, 5009.0, 5127.102757017507, 5166.225066240057, 5168.3539557555305, 5170.379554453452, 3427.880024199141, 3444.8794292199905, 3501.9474707879403, 3540.522029526007, 3557.7153827693724, 1075.8816530181673, 1090.2095980414215, 1091.5197313182175, 1117.1677100560134, 1169.8011338072547, 11663.883361166365, 11682.299062056303, 11708.536432945883, 11715.179937404386, 11720.472578733892, 4534.161180181677, 4643.048175124091, 4658.440987081572, 4664.930026049612, 4683.906321873544, 9875.209983201326, 9889.505524723734, 9893.060159285, 9915.702528924145, 9947.403155810529, 4638.652101092432, 5122.718250496184, 5152.845414637567, 5156.1750119980625, 5161.664491808096, 4629.25931850909, 4699.2481203007355, 4709.882252943704, 4754.904901901942, 4756.571908528249, 3890.513685789276, 3977.8607748728655, 4001.3997900315185, 4003.459532963071, 4030.153667729751, 1195.6831439668495, 1201.381288636353, 1206.7465832175167, 1209.2683926224684, 1256.0265794009533, 1371.8490965993733, 1379.834419869622, 1393.5610282760897, 1411.2731943049337, 1414.370605080729, 7628.389728821681, 7775.105862825847, 7784.2215778421705, 7798.454108212371, 7806.297433231037, 486.95373939475695, 494.03169787217456, 498.5637567128762, 498.89273806131854, 499.1564256406661, 5940.732667029994, 5959.28488581373, 5991.7603295867675, 6035.547333949971, 6037.184980027728, 9647.758806029906, 10364.740881477872, 10461.26771126029, 10563.94718026405, 10565.04914557678, 10102.949485252673, 10250.38497690141, 10301.0, 10397.636082737068, 10444.164466842634, 7897.3287270581495, 7919.643616037177, 7966.601669916597, 8039.276465118168, 8074.798130046678, 7707.884381734167, 7737.381009519112, 7739.419543534144, 7742.458027938215, 7836.529808211526, 9101.453912765255, 9198.540072996457, 9274.860877086983, 9277.350585458953, 9348.298877584344, 9480.478573678514, 9611.279154063614, 9711.5144242789, 9729.124378805942, 9805.117539421486, 6578.28964469251, 6761.797146085625, 7110.928890711233, 7259.564426134238, 7390.482666213314, 7990.520568765893, 7997.320227780704, 8036.718714845187, 8039.758807235792, 8041.758747237593, 6855.348741869514, 7041.3310735480045, 7043.894341584778, 7165.964170179116, 7181.928180718335, 7014.263502332182, 7060.929390706027, 7113.928860711327, 7198.172210195895, 7233.240509746612, 7212.531185472927, 7594.392448603988, 7613.9238607613215, 7622.618869056636, 7632.084149901825, 6766.4248538874745, 6789.762358317435, 6796.694148763417, 6800.6599670017295, 6820.215675197416, 6966.512344135862, 7032.789016329519, 7055.2944705529035, 7063.540869843444, 7075.646217689198], "unit": "score", "name": "mootools.html", "value": 4674.776285719871}, {"lowerIsBetter": false, "replicates": [332.8335832083958, 339.7825391749281, 341.4979979430237, 342.85942763466977, 350.09151252499754, 5904.793332233373, 5941.821745347635, 5956.553258505619, 5957.6127551709105, 5964.284285885695, 5892.970535147329, 5896.646201227919, 5912.379200183983, 5926.792562260322, 5932.1991531143285, 4406.5373135820755, 4491.663125265602, 4549.158405694957, 4603.5166307537565, 4635.8841028974375, 4598.954010459903, 4615.584597386234, 4627.282771170457, 4628.976855115719, 4635.397398338228, 4565.817367305303, 4568.5431456854385, 4574.4510658721, 4577.450705915295, 4599.747013914233, 4375.190589740908, 4465.821367145327, 4546.249868771682, 4585.426821647294, 4585.624312706208, 4005.499312585927, 4020.839166433339, 4029.214303210875, 4029.435878976946, 4029.9194016119513, 5782.421757824226, 5789.07374820031, 5796.710164491801, 5796.927568399859, 5813.360530341659, 5332.413434522199, 5350.197470379474, 5352.57179425645, 5353.491418315254, 5356.491133342326, 6321.589096708745, 6325.304216536178, 6326.145970293997, 6331.651759153245, 6334.208223972004, 4247.256730072225, 4385.6710746694125, 4386.912261754747, 4391.187630288407, 4471.932921006188, 6579.407853293226, 6630.834229144261, 6648.036034774979, 6656.966715166442, 6657.334266573353, 4444.866654000385, 4465.419495465569, 4470.284754439274, 4471.396361491222, 4472.463304403493, 4530.252508336153, 4535.455745310518, 4569.885752856138, 4570.131674981742, 4571.519990401027, 5262.184361423985, 5264.0, 5267.552258058031, 5269.762860671202, 5270.472952704776, 6170.136180934673, 6377.7767778127545, 6403.903941440882, 6405.679716014274, 6407.391297826699, 1573.4099712607772, 1574.7716581095906, 1575.196649708634, 1584.6830633873271, 1591.785109010292, 978.7846673731767, 1030.2221822523945, 1046.3930920066343, 1048.910842578374, 1060.9522571484301, 6067.635941843503, 6094.360092190256, 6118.663473508911, 6119.0, 6132.080187971751, 6538.542302038812, 6557.934420655828, 6561.770338038145, 6563.409293163638, 6574.3754343337305, 6077.088436734437, 6084.361142080106, 6085.269767627825, 6085.695715214221, 6089.360617135226, 3515.771474854126, 3542.946855797165, 3546.733994950389, 3548.183917698892, 3549.9290014200087, 6643.272557728683, 6734.0572319875255, 6774.356436138559, 6783.694733736994, 6793.150856142982, 6642.236142843538, 6644.103046088813, 6661.1007513985, 6667.766628167991, 6668.433183179484, 6741.258461569223, 6744.730210791611, 6755.932440675629, 6760.290169532128, 6770.458363330922, 6526.543141980016, 6531.11829902976, 6532.314107018695, 6533.836654083686, 6539.444147247347, 6360.650164241011, 6495.967520162369, 6524.9021264682015, 6546.5417420782, 6607.174103237096, 6836.863262734817, 6887.0, 6893.482988775761, 6902.171739391305, 6911.827204319932, 4472.575105364985, 4518.615917647036, 4524.615407690251, 4527.0493196429115, 4530.932036019528, 6662.400383965466, 6663.600183988976, 6669.933300667125, 6672.4328432081875, 6674.499412544175, 6378.138951241523, 6497.18785151856, 6501.73993040292, 6507.12153859223, 6527.086207930798, 6514.902276465762, 6525.7063432146615, 6530.8040758777315, 6552.24649165333, 6553.4101930824545, 6314.305426403183, 6338.11266422692, 6339.0, 6340.9365906340345, 6365.61806291624, 6464.0627109069865, 6475.546711730133, 6481.902771458526, 6482.513811464065, 6485.416312531895, 6032.0, 6162.722677479434, 6177.567570270038, 6298.1812364392335, 6307.96846015767], "unit": "score", "name": "prototype.html", "value": 4798.030660325695}, {"lowerIsBetter": false, "replicates": [639.7728806273769, 668.3984414027375, 673.5453568841031, 776.343989329017, 782.9451938364314, 12768.297743624096, 13067.869321306807, 13074.869251307484, 13077.34613269335, 13084.476620935164, 12056.51773929044, 12151.939240303807, 12155.149139560235, 12158.878411215885, 13382.263975481344, 792.5759718550577, 799.1449149410133, 804.1717031457608, 804.5213098206558, 804.8671969125087, 795.5067857928093, 802.3541049455187, 802.542550746075, 802.7872613757359, 804.4127786715701, 838.5513750143674, 844.5608283692476, 846.6105591427951, 848.4654667559429, 848.4909054567272, 836.2557323981631, 836.8953880764905, 837.9413441059128, 838.0069617503278, 838.0153319849184, 611.5932904618423, 612.2163630552855, 612.9601575897597, 613.1079279648102, 613.1691557938973, 12608.0, 12681.682957926034, 12735.044871634573, 12772.936135319356, 12782.808257876139, 13161.078724489289, 13304.13523120994, 13313.104494595169, 13320.533781317607, 13350.666233344147, 10665.733356666067, 10673.146148308117, 10805.729856753565, 10928.50821713017, 11088.722781930435, 3667.449882517617, 3699.445083237509, 3771.0949372150485, 3813.694904407641, 3817.8091095445116, 46200.0, 50959.0, 51942.74028629833, 53008.204876926495, 53023.20465193025, 10497.9475102624, 10554.683359499228, 10575.0, 10644.627438039632, 10677.0, 15946.60133496672, 17769.11154442273, 17999.19003644839, 18001.09994500296, 18007.189676464328, 7991.200879911962, 8007.83984320322, 8022.197780221931, 8176.0, 8199.631016604268, 4454.220511410555, 4460.420145381079, 4484.148011877733, 4567.4062371892105, 4683.7892294846815, 3335.533025376449, 3387.1024178592693, 3388.288459423549, 3390.881319153818, 3395.6095049069672, 622.5237693164732, 628.1959092361784, 636.395424346863, 637.209859773877, 647.9676016199171, 498.4890487250597, 590.4420322795004, 610.0270069239556, 680.9114815074008, 708.4438715608326, 8704.477731336141, 8814.338924580683, 8939.463632182089, 9166.009837472115, 9294.628214871329, 686.2691233835949, 696.4115322552435, 704.8097013806243, 741.6254791330343, 746.9551826890404, 4050.797460126982, 4165.75005499671, 4176.248275310473, 4308.655307575386, 4463.709858859163, 56604.43395566074, 57446.0, 58155.709221453624, 58202.708986454796, 59028.0, 48859.51140488621, 49170.26244606334, 52363.738181309614, 53711.46288537143, 53775.73112134414, 41937.58062419337, 46936.53063469322, 51979.74010129925, 52870.47129528732, 56950.715246423504, 8785.692500762443, 8833.0, 9004.459732416077, 9026.903205973706, 9460.526973651153, 37450.8127459361, 37699.62300377071, 37907.62092379041, 38290.42564361481, 38715.80642096772, 44261.0, 46126.0, 47021.76489117533, 47424.28863567118, 47808.760956194994, 10971.561137554409, 11004.889951100387, 11432.314061156358, 11448.084153267886, 11475.081993440672, 12456.31490268044, 12990.0, 13012.869871301165, 13056.0, 13413.262270575213, 11549.82675259855, 11710.297382157098, 11933.940330298294, 12285.324307163191, 12859.16415432994, 11910.880891191324, 12051.638450846489, 12117.394130293625, 12175.0, 12576.559820406608, 11582.073434125417, 11644.708882278012, 11693.239939403911, 11848.052155827685, 12037.97677197448, 9568.186704130227, 9763.707088787347, 9769.0, 9995.650152244636, 10032.498375081072, 10257.794844103226, 10352.637657681946, 10449.320794148356, 10487.94756026215, 10502.632407865687], "unit": "score", "name": "yui.html", "value": 6485.774656262275}], "name": "dromaeo_css", "value": 7154.387242958529}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [118.0, 109.0, 104.0, 110.0, 110.0, 110.0, 99.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [162.0, 125.0, 148.0, 177.0, 122.0, 149.0, 155.0, 125.0, 165.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 161.0, 159.0, 159.0, 162.0, 162.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 121.0, 96.0, 75.0, 75.0, 75.0, 114.0, 95.0, 72.0], "unit": "score", "name": "audio-fft", "value": 87.3}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 146.0, 92.0, 92.0, 93.0, 141.0, 93.0, 92.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 119.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 144.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 55.0, 56.0, 55.0, 56.0, 57.0, 64.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 59.4}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 78.0, 77.0, 87.0, 78.0, 85.0, 78.0, 78.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.4}, {"lowerIsBetter": true, "replicates": [111.0, 117.0, 107.0, 114.0, 118.0, 107.0, 110.0, 109.0, 109.0, 108.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.0}, {"lowerIsBetter": true, "replicates": [143.0, 131.0, 141.0, 141.0, 143.0, 132.0, 147.0, 143.0, 141.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.5}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 65.0, 64.0, 64.0, 63.0, 62.0, 64.0, 64.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.5}], "name": "kraken", "value": 1478.3}]} 17:28:40 INFO - Return code: 0 17:28:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:28:40 ERROR - # TBPL SUCCESS # 17:28:40 INFO - Running post-action listener: _resource_record_post_action 17:28:40 INFO - Running post-run listener: _resource_record_post_run 17:28:41 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 20480; Write bytes: 394792960; Read time: 32; Write time: 295384 17:28:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108695552; Read time: 0; Write time: 110160 17:28:41 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 20480; Write bytes: 283779072; Read time: 32; Write time: 185108 17:28:41 INFO - Running post-run listener: _upload_blobber_files 17:28:41 INFO - Blob upload gear active. 17:28:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:28:41 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:28:41 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:28:41 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:28:41 INFO - (blobuploader) - INFO - Open directory for files ... 17:28:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:42 INFO - (blobuploader) - INFO - Done attempting. 17:28:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:28:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:28:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:43 INFO - (blobuploader) - INFO - Done attempting. 17:28:43 INFO - (blobuploader) - INFO - Iteration through files over. 17:28:43 INFO - Return code: 0 17:28:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:28:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:28:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15822cc75bd92a137b732a92ead125d0174a5fed46362a889ae1dc00c1836e10e11d7ae68fc1244da352a022db950b7c35d43a52efa249d207e2f7f00603882e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fafe9675c8b7deec4ba6cd0ce2b4d8643f5cd250247c19c3c334452474ea056fbe8590ed41149078975b9fe2bad125dfa6d9f83f1811e1a9e31dba95063aaeee"} 17:28:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:28:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:28:43 INFO - Contents: 17:28:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15822cc75bd92a137b732a92ead125d0174a5fed46362a889ae1dc00c1836e10e11d7ae68fc1244da352a022db950b7c35d43a52efa249d207e2f7f00603882e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fafe9675c8b7deec4ba6cd0ce2b4d8643f5cd250247c19c3c334452474ea056fbe8590ed41149078975b9fe2bad125dfa6d9f83f1811e1a9e31dba95063aaeee"} 17:28:43 INFO - Running post-run listener: copy_logs_to_upload_dir 17:28:43 INFO - Copying logs to upload dir... 17:28:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:28:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.800029 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-03-23 17:28:43.242698) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 17:28:43.248630) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15822cc75bd92a137b732a92ead125d0174a5fed46362a889ae1dc00c1836e10e11d7ae68fc1244da352a022db950b7c35d43a52efa249d207e2f7f00603882e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fafe9675c8b7deec4ba6cd0ce2b4d8643f5cd250247c19c3c334452474ea056fbe8590ed41149078975b9fe2bad125dfa6d9f83f1811e1a9e31dba95063aaeee"} build_url:https://queue.taskcluster.net/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/JSBvTYm_TbG-yhNDzRtujQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15822cc75bd92a137b732a92ead125d0174a5fed46362a889ae1dc00c1836e10e11d7ae68fc1244da352a022db950b7c35d43a52efa249d207e2f7f00603882e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fafe9675c8b7deec4ba6cd0ce2b4d8643f5cd250247c19c3c334452474ea056fbe8590ed41149078975b9fe2bad125dfa6d9f83f1811e1a9e31dba95063aaeee"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 17:28:43.273994) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 17:28:43.274333) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1458778016.965605-2030569964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 17:28:43.326863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 17:28:43.327183) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 17:28:43.327478) ========= ========= Total master_lag: 0.18 =========