builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1459215738.74 results: success (0) buildid: 20160328160731 builduid: 7608809c78ad49e285d8f22c91ee87b9 revision: 9e0bc04410121516f125f411a4450d6072089a90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:18.737373) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:18.737873) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:18.738209) ========= 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=1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006406 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:18.763988) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:18.764387) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:18.779941) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:18.780346) ========= 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=1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004592 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:18.832909) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:18.833247) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:18.833664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:18.833988) ========= 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=1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-28 18:42:19-- 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% 5.71M=0.002s 2016-03-28 18:42:19 (5.71 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161191 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:19.009849) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:19.010208) ========= 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=1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022210 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:19.064526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:19.065115) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9e0bc04410121516f125f411a4450d6072089a90 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9e0bc04410121516f125f411a4450d6072089a90 --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=1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-28 18:42:19,416 truncating revision to first 12 chars 2016-03-28 18:42:19,416 Setting DEBUG logging. 2016-03-28 18:42:19,416 attempt 1/10 2016-03-28 18:42:19,417 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9e0bc0441012?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-28 18:42:19,688 unpacking tar archive at: mozilla-aurora-9e0bc0441012/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655223 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:19.776066) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:19.776474) ========= echo 9e0bc04410121516f125f411a4450d6072089a90 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9e0bc04410121516f125f411a4450d6072089a90'] 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=1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 9e0bc04410121516f125f411a4450d6072089a90 program finished with exit code 0 elapsedTime=0.004886 script_repo_revision: '9e0bc04410121516f125f411a4450d6072089a90' ========= master_lag: 0.03 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:19.814089) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:19.814397) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 18:42:19.843945) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2016-03-28 18:42:19.844244) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:42:20 INFO - MultiFileLogger online at 20160328 18:42:20 in /builds/slave/test-pgo 18:42:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:42:20 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:42:20 INFO - {'append_to_log': False, 18:42:20 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:42:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:42:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:42:20 INFO - 'branch': 'Mozilla-Aurora', 18:42:20 INFO - 'buildbot_json_path': 'buildprops.json', 18:42:20 INFO - 'config_files': ('talos/linux_config.py',), 18:42:20 INFO - 'default_actions': ('clobber', 18:42:20 INFO - 'read-buildbot-config', 18:42:20 INFO - 'download-and-extract', 18:42:20 INFO - 'populate-webroot', 18:42:20 INFO - 'create-virtualenv', 18:42:20 INFO - 'install', 18:42:20 INFO - 'run-tests'), 18:42:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:42:20 INFO - 'download_minidump_stackwalk': True, 18:42:20 INFO - 'download_symbols': 'ondemand', 18:42:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:42:20 INFO - 'tooltool.py': '/tools/tooltool.py', 18:42:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:42:20 INFO - '/tools/misc-python/virtualenv.py')}, 18:42:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:42:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:42:20 INFO - 'installer_path': 'installer.exe', 18:42:20 INFO - 'log_level': 'info', 18:42:20 INFO - 'log_name': 'talos', 18:42:20 INFO - 'log_to_console': True, 18:42:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:42:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:42:20 INFO - 'opt_config_files': (), 18:42:20 INFO - 'pip_index': False, 18:42:20 INFO - 'sps_profile': False, 18:42:20 INFO - 'sps_profile_interval': 0, 18:42:20 INFO - 'suite': 'dromaeojs', 18:42:20 INFO - 'system_bits': '32', 18:42:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:42:20 INFO - 'title': 'talos-linux64-ix-027', 18:42:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:42:20 INFO - 'use_talos_json': True, 18:42:20 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:42:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:42:20 INFO - 'work_dir': 'build'} 18:42:20 INFO - ##### 18:42:20 INFO - ##### Running clobber step. 18:42:20 INFO - ##### 18:42:20 INFO - Running pre-action listener: _resource_record_pre_action 18:42:20 INFO - Running main action method: clobber 18:42:20 INFO - rmtree: /builds/slave/test-pgo/build 18:42:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:42:21 INFO - Running post-action listener: _resource_record_post_action 18:42:21 INFO - ##### 18:42:21 INFO - ##### Running read-buildbot-config step. 18:42:21 INFO - ##### 18:42:21 INFO - Running pre-action listener: _resource_record_pre_action 18:42:21 INFO - Running main action method: read_buildbot_config 18:42:21 INFO - Using buildbot properties: 18:42:21 INFO - { 18:42:21 INFO - "project": "", 18:42:21 INFO - "product": "firefox", 18:42:21 INFO - "script_repo_revision": "production", 18:42:21 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 18:42:21 INFO - "repository": "", 18:42:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 18:42:21 INFO - "buildid": "20160328160731", 18:42:21 INFO - "pgo_build": "True", 18:42:21 INFO - "basedir": "/builds/slave/test-pgo", 18:42:21 INFO - "buildnumber": 388, 18:42:21 INFO - "slavename": "talos-linux64-ix-027", 18:42:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:42:21 INFO - "platform": "ubuntu64_hw", 18:42:21 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:42:21 INFO - "branch": "mozilla-aurora", 18:42:21 INFO - "repo_path": "releases/mozilla-aurora", 18:42:21 INFO - "revision": "9e0bc04410121516f125f411a4450d6072089a90", 18:42:21 INFO - "stage_platform": "linux64-pgo", 18:42:21 INFO - "builduid": "7608809c78ad49e285d8f22c91ee87b9", 18:42:21 INFO - "slavebuilddir": "test" 18:42:21 INFO - } 18:42:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 18:42:21 INFO - Running post-action listener: _resource_record_post_action 18:42:21 INFO - ##### 18:42:21 INFO - ##### Running download-and-extract step. 18:42:21 INFO - ##### 18:42:21 INFO - Running pre-action listener: _resource_record_pre_action 18:42:21 INFO - Running main action method: download_and_extract 18:42:21 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:21 INFO - https://queue.taskcluster.net/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:42:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:42:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:42:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:42:24 INFO - Downloaded 1448 bytes. 18:42:24 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:42:24 INFO - Using the following test package requirements: 18:42:24 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 18:42:24 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:42:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:42:24 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:42:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:42:24 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:42:24 INFO - u'jsshell-linux-x86_64.zip'], 18:42:24 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:42:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:42:24 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 18:42:24 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:42:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:42:24 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:42:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:42:24 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:42:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:42:24 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 18:42:24 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:42:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:42:24 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:42: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')]} 18:42:24 INFO - https://queue.taskcluster.net/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:42:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:42:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:42:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:42:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:42:27 INFO - Downloaded 23344239 bytes. 18:42:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:42:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:42:28 INFO - Return code: 0 18:42:28 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:28 INFO - https://queue.taskcluster.net/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:42:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:42:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:42:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:42:35 INFO - Downloaded 23344239 bytes. 18:42:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:42:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:42:37 INFO - Return code: 0 18:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:37 INFO - https://queue.taskcluster.net/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:42:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 18:42:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 18:42:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 18:42:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:42:39 INFO - Downloaded 10845161 bytes. 18:42:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:42:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 18:42:39 INFO - Return code: 0 18:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:39 INFO - https://queue.taskcluster.net/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:42:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:42:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:42:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:42:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:42:42 INFO - Downloaded 60488544 bytes. 18:42:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:42:42 INFO - mkdir: /builds/slave/test-pgo/properties 18:42:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:42:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:42:42 INFO - Contents: 18:42:42 INFO - build_url:https://queue.taskcluster.net/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:42:43 INFO - Running post-action listener: _resource_record_post_action 18:42:43 INFO - Running post-action listener: set_extra_try_arguments 18:42:43 INFO - ##### 18:42:43 INFO - ##### Running populate-webroot step. 18:42:43 INFO - ##### 18:42:43 INFO - Running pre-action listener: _resource_record_pre_action 18:42:43 INFO - Running main action method: populate_webroot 18:42:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:42:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:42:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:42:43 INFO - '--tppagecycles', 18:42:43 INFO - '7'], 18:42:43 INFO - 'tests': ['tsvgm']}}, 18:42:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:42:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:42:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:42:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:42:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:42:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:42:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:42:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:43 INFO - 'talos_options': ['--e10s'], 18:42:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:42:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:43 INFO - 'tests': ['damp', 'tps']}, 18:42:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:43 INFO - 'talos_options': ['--e10s'], 18:42:43 INFO - 'tests': ['damp', 'tps']}, 18:42:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:42:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:42:43 INFO - 'other': {'tests': ['a11yr', 18:42:43 INFO - 'ts_paint', 18:42:43 INFO - 'tpaint', 18:42:43 INFO - 'sessionrestore', 18:42:43 INFO - 'sessionrestore_no_auto_restore', 18:42:43 INFO - 'tabpaint']}, 18:42:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:42:43 INFO - 'tests': ['a11yr', 18:42:43 INFO - 'ts_paint', 18:42:43 INFO - 'tpaint', 18:42:43 INFO - 'sessionrestore', 18:42:43 INFO - 'sessionrestore_no_auto_restore', 18:42:43 INFO - 'tabpaint']}, 18:42:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:42:43 INFO - 'tests': ['a11yr', 18:42:43 INFO - 'ts_paint', 18:42:43 INFO - 'tpaint', 18:42:43 INFO - 'sessionrestore', 18:42:43 INFO - 'sessionrestore_no_auto_restore', 18:42:43 INFO - 'tabpaint']}, 18:42:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:42:43 INFO - 'tests': ['a11yr', 18:42:43 INFO - 'ts_paint', 18:42:43 INFO - 'tpaint', 18:42:43 INFO - 'sessionrestore', 18:42:43 INFO - 'sessionrestore_no_auto_restore', 18:42:43 INFO - 'tabpaint']}, 18:42:43 INFO - 'other_l64': {'tests': ['a11yr', 18:42:43 INFO - 'ts_paint', 18:42:43 INFO - 'tpaint', 18:42:43 INFO - 'sessionrestore', 18:42:43 INFO - 'sessionrestore_no_auto_restore', 18:42:43 INFO - 'tabpaint']}, 18:42:43 INFO - 'other_nol64': {'tests': ['a11yr', 18:42:43 INFO - 'ts_paint', 18:42:43 INFO - 'tpaint', 18:42:43 INFO - 'sessionrestore', 18:42:43 INFO - 'sessionrestore_no_auto_restore', 18:42:43 INFO - 'tabpaint']}, 18:42:43 INFO - 'svgr': {'tests': ['tsvgx', 18:42:43 INFO - 'tsvgr_opacity', 18:42:43 INFO - 'tart', 18:42:43 INFO - 'tscrollx', 18:42:43 INFO - 'cart']}, 18:42:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:42:43 INFO - 'tests': ['tsvgx', 18:42:43 INFO - 'tsvgr_opacity', 18:42:43 INFO - 'tart', 18:42:43 INFO - 'tscrollx', 18:42:43 INFO - 'cart']}, 18:42:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:43 INFO - 'tests': ['tp5o']}, 18:42:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:43 INFO - 'talos_options': ['--e10s'], 18:42:43 INFO - 'tests': ['tp5o']}, 18:42:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:43 INFO - 'talos_options': ['--xperf_path', 18:42:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:42:43 INFO - 'tests': ['tp5n']}, 18:42:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:43 INFO - 'talos_options': ['--e10s', 18:42:43 INFO - '--xperf_path', 18:42:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:42:43 INFO - 'tests': ['tp5n']}}, 18:42:43 INFO - 'talos.zip': {'path': '', 18:42:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:42:43 INFO - Running post-action listener: _resource_record_post_action 18:42:43 INFO - ##### 18:42:43 INFO - ##### Running create-virtualenv step. 18:42:43 INFO - ##### 18:42:43 INFO - Running pre-action listener: _resource_record_pre_action 18:42:43 INFO - Running main action method: create_virtualenv 18:42:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:42:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 18:42:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:42:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:42:43 INFO - Using real prefix '/usr' 18:42:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:42:44 INFO - Installing distribute.............................................................................................................................................................................................done. 18:42:46 INFO - Installing pip.................done. 18:42:46 INFO - Return code: 0 18:42:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:42: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')]} 18:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42: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')]} 18:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d2a790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9920>, '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 0x15ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cacb0>, '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': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:42: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:42: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 pip>=1.5 18:42:46 INFO - Using env: {'DISPLAY': ':0', 18:42:46 INFO - 'HOME': '/home/cltbld', 18:42:46 INFO - 'LANG': 'en_US.UTF-8', 18:42:46 INFO - 'LANGUAGE': 'en_US:en', 18:42:46 INFO - 'LOGNAME': 'cltbld', 18:42:46 INFO - 'MAIL': '/var/mail/cltbld', 18:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:46 INFO - 'MOZ_NO_REMOTE': '1', 18:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:46 INFO - 'NO_EM_RESTART': '1', 18:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:42:46 INFO - 'PWD': '/builds/slave/test-pgo', 18:42:46 INFO - 'SHELL': '/bin/bash', 18:42:46 INFO - 'SHLVL': '1', 18:42:46 INFO - 'TERM': 'linux', 18:42:46 INFO - 'TMOUT': '86400', 18:42:46 INFO - 'USER': 'cltbld', 18:42:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 18:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:46 INFO - '_': '/tools/buildbot/bin/python'} 18:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:42:46 INFO - Cleaning up... 18:42:46 INFO - Return code: 0 18:42:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:42: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')]} 18:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42: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')]} 18:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42: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', '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 0x7f7d2a790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9920>, '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 0x15ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cacb0>, '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': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:42: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:42: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 psutil>=0.7.1 18:42:46 INFO - Using env: {'DISPLAY': ':0', 18:42:46 INFO - 'HOME': '/home/cltbld', 18:42:46 INFO - 'LANG': 'en_US.UTF-8', 18:42:46 INFO - 'LANGUAGE': 'en_US:en', 18:42:46 INFO - 'LOGNAME': 'cltbld', 18:42:46 INFO - 'MAIL': '/var/mail/cltbld', 18:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:46 INFO - 'MOZ_NO_REMOTE': '1', 18:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:46 INFO - 'NO_EM_RESTART': '1', 18:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:42:46 INFO - 'PWD': '/builds/slave/test-pgo', 18:42:46 INFO - 'SHELL': '/bin/bash', 18:42:46 INFO - 'SHLVL': '1', 18:42:46 INFO - 'TERM': 'linux', 18:42:46 INFO - 'TMOUT': '86400', 18:42:46 INFO - 'USER': 'cltbld', 18:42:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 18:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:46 INFO - '_': '/tools/buildbot/bin/python'} 18:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:46 INFO - Downloading/unpacking psutil>=0.7.1 18:42: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 18:42: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 18:42: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 18:42: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 18:42: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 18:42: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 18:42:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:42:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:42:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:42:48 INFO - Installing collected packages: psutil 18:42:48 INFO - Running setup.py install for psutil 18:42:48 INFO - building 'psutil._psutil_linux' extension 18:42:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:42:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:42:49 INFO - building 'psutil._psutil_posix' extension 18:42:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:42:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:42:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:42:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:42:49 INFO - Successfully installed psutil 18:42:49 INFO - Cleaning up... 18:42:49 INFO - Return code: 0 18:42:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:42: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')]} 18:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42: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')]} 18:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42: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', '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 0x7f7d2a790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9920>, '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 0x15ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cacb0>, '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': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:42: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:42: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 mozsystemmonitor==0.0.0 18:42:49 INFO - Using env: {'DISPLAY': ':0', 18:42:49 INFO - 'HOME': '/home/cltbld', 18:42:49 INFO - 'LANG': 'en_US.UTF-8', 18:42:49 INFO - 'LANGUAGE': 'en_US:en', 18:42:49 INFO - 'LOGNAME': 'cltbld', 18:42:49 INFO - 'MAIL': '/var/mail/cltbld', 18:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:49 INFO - 'MOZ_NO_REMOTE': '1', 18:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:49 INFO - 'NO_EM_RESTART': '1', 18:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:42:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:42:49 INFO - 'SHELL': '/bin/bash', 18:42:49 INFO - 'SHLVL': '1', 18:42:49 INFO - 'TERM': 'linux', 18:42:49 INFO - 'TMOUT': '86400', 18:42:49 INFO - 'USER': 'cltbld', 18:42:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 18:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:49 INFO - '_': '/tools/buildbot/bin/python'} 18:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:42: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 18:42: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 18:42: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 18:42: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 18:42: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 18:42: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 18:42:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:42:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:42:51 INFO - Installing collected packages: mozsystemmonitor 18:42:51 INFO - Running setup.py install for mozsystemmonitor 18:42:52 INFO - Successfully installed mozsystemmonitor 18:42:52 INFO - Cleaning up... 18:42:52 INFO - Return code: 0 18:42:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:52 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 0x7f7d2a790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9920>, '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 0x15ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cacb0>, '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': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:42:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:42:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:42:52 INFO - Using env: {'DISPLAY': ':0', 18:42:52 INFO - 'HOME': '/home/cltbld', 18:42:52 INFO - 'LANG': 'en_US.UTF-8', 18:42:52 INFO - 'LANGUAGE': 'en_US:en', 18:42:52 INFO - 'LOGNAME': 'cltbld', 18:42:52 INFO - 'MAIL': '/var/mail/cltbld', 18:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:52 INFO - 'MOZ_NO_REMOTE': '1', 18:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:52 INFO - 'NO_EM_RESTART': '1', 18:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:42:52 INFO - 'PWD': '/builds/slave/test-pgo', 18:42:52 INFO - 'SHELL': '/bin/bash', 18:42:52 INFO - 'SHLVL': '1', 18:42:52 INFO - 'TERM': 'linux', 18:42:52 INFO - 'TMOUT': '86400', 18:42:52 INFO - 'USER': 'cltbld', 18:42:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 18:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:52 INFO - '_': '/tools/buildbot/bin/python'} 18:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:52 INFO - Downloading/unpacking blobuploader==1.2.4 18:42: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 18:42: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 18:42: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 18:42: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 18:42: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 18:42: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 18:42:54 INFO - Downloading blobuploader-1.2.4.tar.gz 18:42:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:42:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:42:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:55 INFO - Downloading docopt-0.6.1.tar.gz 18:42:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:42:55 INFO - Installing collected packages: blobuploader, requests, docopt 18:42:55 INFO - Running setup.py install for blobuploader 18:42:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:42:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:42:55 INFO - Running setup.py install for requests 18:42:55 INFO - Running setup.py install for docopt 18:42:56 INFO - Successfully installed blobuploader requests docopt 18:42:56 INFO - Cleaning up... 18:42:56 INFO - Return code: 0 18:42:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:56 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 0x7f7d2a790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9920>, '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 0x15ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cacb0>, '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': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:42:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:42:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:42:56 INFO - Using env: {'DISPLAY': ':0', 18:42:56 INFO - 'HOME': '/home/cltbld', 18:42:56 INFO - 'LANG': 'en_US.UTF-8', 18:42:56 INFO - 'LANGUAGE': 'en_US:en', 18:42:56 INFO - 'LOGNAME': 'cltbld', 18:42:56 INFO - 'MAIL': '/var/mail/cltbld', 18:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:56 INFO - 'MOZ_NO_REMOTE': '1', 18:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:56 INFO - 'NO_EM_RESTART': '1', 18:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:42:56 INFO - 'PWD': '/builds/slave/test-pgo', 18:42:56 INFO - 'SHELL': '/bin/bash', 18:42:56 INFO - 'SHLVL': '1', 18:42:56 INFO - 'TERM': 'linux', 18:42:56 INFO - 'TMOUT': '86400', 18:42:56 INFO - 'USER': 'cltbld', 18:42:56 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 18:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:56 INFO - '_': '/tools/buildbot/bin/python'} 18:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:42:56 INFO - Running setup.py (path:/tmp/pip-_7q8O5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:42:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:42:56 INFO - Running setup.py (path:/tmp/pip-P8hm1M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:42:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:42:56 INFO - Running setup.py (path:/tmp/pip-E2pWht-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:42:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:42:56 INFO - Running setup.py (path:/tmp/pip-E0eKx9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:42:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:42:56 INFO - Running setup.py (path:/tmp/pip-4AJNWF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:42:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:42:56 INFO - Running setup.py (path:/tmp/pip-q0X386-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:42:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:42:56 INFO - Running setup.py (path:/tmp/pip-ORvkgO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:42:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:42:56 INFO - Running setup.py (path:/tmp/pip-Fzy6Ba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:42:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:42:56 INFO - Running setup.py (path:/tmp/pip-KHe45W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:42:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:42:56 INFO - Running setup.py (path:/tmp/pip-9u_D4m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:42:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:42:57 INFO - Running setup.py (path:/tmp/pip-GkxuHf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:42:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:42:57 INFO - Running setup.py (path:/tmp/pip-y27Q7R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:42:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:42:57 INFO - Running setup.py (path:/tmp/pip-6K6hSw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:42:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:42:57 INFO - Running setup.py (path:/tmp/pip-qHYgU9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:42:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:42:57 INFO - Running setup.py (path:/tmp/pip-akzFKO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:42:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:42:57 INFO - Running setup.py (path:/tmp/pip-WiK9x5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:42:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:42:57 INFO - Running setup.py (path:/tmp/pip-5qm8sd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:42:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:42:57 INFO - Running setup.py install for manifestparser 18:42:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:42:57 INFO - Running setup.py install for mozcrash 18:42:57 INFO - Running setup.py install for mozdebug 18:42:57 INFO - Running setup.py install for mozdevice 18:42:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:42:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:42:57 INFO - Running setup.py install for mozfile 18:42:58 INFO - Running setup.py install for mozhttpd 18:42:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:42:58 INFO - Running setup.py install for mozinfo 18:42:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:42:58 INFO - Running setup.py install for mozInstall 18:42:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:42:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:42:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:42:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:42:58 INFO - Running setup.py install for mozleak 18:42:58 INFO - Running setup.py install for mozlog 18:42:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:42:58 INFO - Running setup.py install for moznetwork 18:42:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:42:58 INFO - Running setup.py install for mozprocess 18:42:58 INFO - Running setup.py install for mozprofile 18:42:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:42:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:42:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:42:58 INFO - Running setup.py install for mozrunner 18:42:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:42:59 INFO - Running setup.py install for mozscreenshot 18:42:59 INFO - Running setup.py install for moztest 18:42:59 INFO - Running setup.py install for mozversion 18:42:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:42:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:42:59 INFO - Cleaning up... 18:42:59 INFO - Return code: 0 18:42:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:59 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 0x7f7d2a790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9920>, '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 0x15ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cacb0>, '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': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:42:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:42:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:42:59 INFO - Using env: {'DISPLAY': ':0', 18:42:59 INFO - 'HOME': '/home/cltbld', 18:42:59 INFO - 'LANG': 'en_US.UTF-8', 18:42:59 INFO - 'LANGUAGE': 'en_US:en', 18:42:59 INFO - 'LOGNAME': 'cltbld', 18:42:59 INFO - 'MAIL': '/var/mail/cltbld', 18:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:59 INFO - 'MOZ_NO_REMOTE': '1', 18:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:59 INFO - 'NO_EM_RESTART': '1', 18:42:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:42:59 INFO - 'PWD': '/builds/slave/test-pgo', 18:42:59 INFO - 'SHELL': '/bin/bash', 18:42:59 INFO - 'SHLVL': '1', 18:42:59 INFO - 'TERM': 'linux', 18:42:59 INFO - 'TMOUT': '86400', 18:42:59 INFO - 'USER': 'cltbld', 18:42:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 18:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:59 INFO - '_': '/tools/buildbot/bin/python'} 18:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:42:59 INFO - Running setup.py (path:/tmp/pip-aikQH5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:42:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 18:42:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:42:59 INFO - Running setup.py (path:/tmp/pip-yWNOBm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:42:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:42:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:42:59 INFO - Running setup.py (path:/tmp/pip-lVtBlZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:42:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:42:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:42:59 INFO - Running setup.py (path:/tmp/pip-0x7eHQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:43:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:43:00 INFO - Running setup.py (path:/tmp/pip-zdc54q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 18:43:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:43:00 INFO - Running setup.py (path:/tmp/pip-amZ1i4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 18:43:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:43:00 INFO - Running setup.py (path:/tmp/pip-YuVn5I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 18:43:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:43:00 INFO - Running setup.py (path:/tmp/pip-rGYq4R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 18:43:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:43:00 INFO - Running setup.py (path:/tmp/pip-0aqxyn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 18:43:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:43:00 INFO - Running setup.py (path:/tmp/pip-_cpbvz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:43:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:43:00 INFO - Running setup.py (path:/tmp/pip-xU_r6z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 18:43:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:43:00 INFO - Running setup.py (path:/tmp/pip-WjEpnj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 18:43:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:43:00 INFO - Running setup.py (path:/tmp/pip-ORjgCW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 18:43:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:43:00 INFO - Running setup.py (path:/tmp/pip-Q8XB3I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 18:43:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:43:00 INFO - Running setup.py (path:/tmp/pip-Rii2_s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 18:43:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:43:00 INFO - Running setup.py (path:/tmp/pip-wbwSFk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 18:43:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:43:00 INFO - Running setup.py (path:/tmp/pip-BKTuXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:43:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:03 INFO - Downloading blessings-1.6.tar.gz 18:43:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:43:03 INFO - Installing collected packages: blessings 18:43:03 INFO - Running setup.py install for blessings 18:43:03 INFO - Successfully installed blessings 18:43:03 INFO - Cleaning up... 18:43:03 INFO - Return code: 0 18:43:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:43:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:43:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:43:03 INFO - Reading from file tmpfile_stdout 18:43:03 INFO - Current package versions: 18:43:03 INFO - argparse == 1.2.1 18:43:03 INFO - blessings == 1.6 18:43:03 INFO - blobuploader == 1.2.4 18:43:03 INFO - docopt == 0.6.1 18:43:03 INFO - manifestparser == 1.1 18:43:03 INFO - mozInstall == 1.12 18:43:03 INFO - mozcrash == 0.17 18:43:03 INFO - mozdebug == 0.1 18:43:03 INFO - mozdevice == 0.48 18:43:03 INFO - mozfile == 1.2 18:43:03 INFO - mozhttpd == 0.7 18:43:03 INFO - mozinfo == 0.9 18:43:03 INFO - mozleak == 0.1 18:43:03 INFO - mozlog == 3.1 18:43:03 INFO - moznetwork == 0.27 18:43:03 INFO - mozprocess == 0.22 18:43:03 INFO - mozprofile == 0.28 18:43:03 INFO - mozrunner == 6.11 18:43:03 INFO - mozscreenshot == 0.1 18:43:03 INFO - mozsystemmonitor == 0.0 18:43:03 INFO - moztest == 0.7 18:43:03 INFO - mozversion == 1.4 18:43:03 INFO - psutil == 3.1.1 18:43:03 INFO - requests == 1.2.3 18:43:03 INFO - wsgiref == 0.1.2 18:43:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:03 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 0x7f7d2a790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9920>, '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 0x15ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cacb0>, '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': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:43:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 18:43:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:43:03 INFO - Using env: {'DISPLAY': ':0', 18:43:03 INFO - 'HOME': '/home/cltbld', 18:43:03 INFO - 'LANG': 'en_US.UTF-8', 18:43:03 INFO - 'LANGUAGE': 'en_US:en', 18:43:03 INFO - 'LOGNAME': 'cltbld', 18:43:03 INFO - 'MAIL': '/var/mail/cltbld', 18:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:03 INFO - 'MOZ_NO_REMOTE': '1', 18:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:03 INFO - 'NO_EM_RESTART': '1', 18:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:43:03 INFO - 'PWD': '/builds/slave/test-pgo', 18:43:03 INFO - 'SHELL': '/bin/bash', 18:43:03 INFO - 'SHLVL': '1', 18:43:03 INFO - 'TERM': 'linux', 18:43:03 INFO - 'TMOUT': '86400', 18:43:03 INFO - 'USER': 'cltbld', 18:43:03 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 18:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:03 INFO - '_': '/tools/buildbot/bin/python'} 18:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 18:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 18:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 18:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 18:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 18:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 18:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 18:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:43:04 INFO - Cleaning up... 18:43:04 INFO - Return code: 0 18:43:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d2a790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9920>, '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 0x15ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cacb0>, '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': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:43:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 18:43:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:43:04 INFO - Using env: {'DISPLAY': ':0', 18:43:04 INFO - 'HOME': '/home/cltbld', 18:43:04 INFO - 'LANG': 'en_US.UTF-8', 18:43:04 INFO - 'LANGUAGE': 'en_US:en', 18:43:04 INFO - 'LOGNAME': 'cltbld', 18:43:04 INFO - 'MAIL': '/var/mail/cltbld', 18:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:04 INFO - 'MOZ_NO_REMOTE': '1', 18:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:04 INFO - 'NO_EM_RESTART': '1', 18:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:43:04 INFO - 'PWD': '/builds/slave/test-pgo', 18:43:04 INFO - 'SHELL': '/bin/bash', 18:43:04 INFO - 'SHLVL': '1', 18:43:04 INFO - 'TERM': 'linux', 18:43:04 INFO - 'TMOUT': '86400', 18:43:04 INFO - 'USER': 'cltbld', 18:43:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 18:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:04 INFO - '_': '/tools/buildbot/bin/python'} 18:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:04 INFO - Downloading/unpacking jsonschema 18:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:43:06 INFO - Downloading/unpacking functools32 (from jsonschema) 18:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:07 INFO - Downloading functools32-3.2.3-2.tar.gz 18:43:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:43:07 INFO - warning: no files found matching '*.txt' 18:43:07 INFO - no previously-included directories found matching 'build' 18:43:07 INFO - no previously-included directories found matching 'dist' 18:43:07 INFO - no previously-included directories found matching '.git*' 18:43:07 INFO - Installing collected packages: jsonschema, functools32 18:43:07 INFO - Running setup.py install for functools32 18:43:07 INFO - warning: no files found matching '*.txt' 18:43:07 INFO - no previously-included directories found matching 'build' 18:43:07 INFO - no previously-included directories found matching 'dist' 18:43:07 INFO - no previously-included directories found matching '.git*' 18:43:07 INFO - Successfully installed jsonschema functools32 18:43:07 INFO - Cleaning up... 18:43:07 INFO - Return code: 0 18:43:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d2a790f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153a6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c9920>, '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 0x15ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cacb0>, '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': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:43:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 18:43:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:43:07 INFO - Using env: {'DISPLAY': ':0', 18:43:07 INFO - 'HOME': '/home/cltbld', 18:43:07 INFO - 'LANG': 'en_US.UTF-8', 18:43:07 INFO - 'LANGUAGE': 'en_US:en', 18:43:07 INFO - 'LOGNAME': 'cltbld', 18:43:07 INFO - 'MAIL': '/var/mail/cltbld', 18:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:07 INFO - 'MOZ_NO_REMOTE': '1', 18:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:07 INFO - 'NO_EM_RESTART': '1', 18:43:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:43:07 INFO - 'PWD': '/builds/slave/test-pgo', 18:43:07 INFO - 'SHELL': '/bin/bash', 18:43:07 INFO - 'SHLVL': '1', 18:43:07 INFO - 'TERM': 'linux', 18:43:07 INFO - 'TMOUT': '86400', 18:43:07 INFO - 'USER': 'cltbld', 18:43:07 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 18:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:07 INFO - '_': '/tools/buildbot/bin/python'} 18:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:07 INFO - Downloading/unpacking flake8 18:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:43:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:43:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:43:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:43:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:43:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:43:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:43:11 INFO - no previously-included directories found matching 'docs/_build' 18:43:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:43:11 INFO - Running setup.py install for pep8 18:43:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:43:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:43:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:43:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:43:11 INFO - no previously-included directories found matching 'docs/_build' 18:43:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:43:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:43:11 INFO - Cleaning up... 18:43:11 INFO - Return code: 0 18:43:11 INFO - Running post-action listener: _resource_record_post_action 18:43:11 INFO - Running post-action listener: _start_resource_monitoring 18:43:11 INFO - Starting resource monitoring. 18:43:11 INFO - ##### 18:43:11 INFO - ##### Running install step. 18:43:11 INFO - ##### 18:43:11 INFO - Running pre-action listener: _resource_record_pre_action 18:43:11 INFO - Running main action method: install 18:43:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:43:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:43:11 INFO - Reading from file tmpfile_stdout 18:43:11 INFO - Detecting whether we're running mozinstall >=1.0... 18:43:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:43:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:43:11 INFO - Reading from file tmpfile_stdout 18:43:11 INFO - Output received: 18:43:11 INFO - Usage: mozinstall [options] installer 18:43:11 INFO - Options: 18:43:11 INFO - -h, --help show this help message and exit 18:43:11 INFO - -d DEST, --destination=DEST 18:43:11 INFO - Directory to install application into. [default: 18:43:11 INFO - "/builds/slave/test-pgo"] 18:43:11 INFO - --app=APP Application being installed. [default: firefox] 18:43:11 INFO - mkdir: /builds/slave/test-pgo/build/application 18:43:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:43:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:43:26 INFO - Reading from file tmpfile_stdout 18:43:26 INFO - Output received: 18:43:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:43:26 INFO - Running post-action listener: _resource_record_post_action 18:43:26 INFO - ##### 18:43:26 INFO - ##### Running run-tests step. 18:43:26 INFO - ##### 18:43:26 INFO - Running pre-action listener: _resource_record_pre_action 18:43:26 INFO - Running main action method: run_tests 18:43:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:43:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:43:26 INFO - Python 2.7.3 18:43:26 INFO - Return code: 0 18:43:26 INFO - grabbing minidump binary from tooltool 18:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:26 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 0x15c9920>, '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 0x15ca820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cacb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:43:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 18:43:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:43:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:43:27 INFO - Return code: 0 18:43:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:43:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:43:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:43:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:43:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:43:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:43:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:43:28 INFO - Return code: 0 18:43:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 18:43:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 18:43:28 INFO - Using env: {'DISPLAY': ':0', 18:43:28 INFO - 'HOME': '/home/cltbld', 18:43:28 INFO - 'LANG': 'en_US.UTF-8', 18:43:28 INFO - 'LANGUAGE': 'en_US:en', 18:43:28 INFO - 'LOGNAME': 'cltbld', 18:43:28 INFO - 'MAIL': '/var/mail/cltbld', 18:43:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:43:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:28 INFO - 'MOZ_NO_REMOTE': '1', 18:43:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:28 INFO - 'NO_EM_RESTART': '1', 18:43:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:43:28 INFO - 'PWD': '/builds/slave/test-pgo', 18:43:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:43:28 INFO - 'SHELL': '/bin/bash', 18:43:28 INFO - 'SHLVL': '1', 18:43:28 INFO - 'TERM': 'linux', 18:43:28 INFO - 'TMOUT': '86400', 18:43:28 INFO - 'USER': 'cltbld', 18:43:28 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413', 18:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:28 INFO - '_': '/tools/buildbot/bin/python'} 18:43:28 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:43:28 INFO - mozversion application_buildid: 20160328160731 18:43:28 INFO - mozversion application_changeset: 9e0bc04410121516f125f411a4450d6072089a90 18:43:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:43:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:43:28 INFO - mozversion application_name: Firefox 18:43:28 INFO - mozversion application_remotingname: firefox-dev 18:43:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:43:28 INFO - mozversion application_vendor: Mozilla 18:43:28 INFO - mozversion application_version: 47.0a2 18:43:28 INFO - mozversion platform_buildid: 20160328160731 18:43:28 INFO - mozversion platform_changeset: 9e0bc04410121516f125f411a4450d6072089a90 18:43:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:43:28 INFO - mozversion platform_version: 47.0a2 18:43:28 INFO - using testdate: 1459215808 18:43:28 INFO - actual date: 1459215808 18:43:28 INFO - starting webserver on 'localhost:39989' 18:43:28 INFO - SUITE-START | Running 2 tests 18:43:28 INFO - TEST-START | dromaeo_css 18:43:28 INFO - operating with platform_type : linux_ 18:43:28 INFO - Initialising browser for dromaeo_css test... 18:43:28 INFO - TEST-INFO | started process 24619 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbHL3Ah/profile http://localhost:39989/getInfo.html) 18:43:32 INFO - PROCESS | 24619 | __metrics Screen width/height:1600/1200 18:43:32 INFO - PROCESS | 24619 | colorDepth:24 18:43:32 INFO - PROCESS | 24619 | Browser inner width/height: 1024/697 18:43:32 INFO - PROCESS | 24619 | __metrics 18:43:33 INFO - PROCESS | 24619 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:43:33 INFO - PROCESS | 24619 | 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. 18:43:34 INFO - TEST-INFO | 24619: exit 0 18:43:34 INFO - Browser initialized. 18:43:34 INFO - Running cycle 1/1 for dromaeo_css test... 18:43:34 INFO - TEST-INFO | started process 24706 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbHL3Ah/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:43:45 INFO - PROCESS | 24706 | RSS: Main: 145510400 18:43:45 INFO - PROCESS | 24706 | 18:44:36 INFO - PROCESS | 24706 | 1459215876695 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] 18:46:44 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:39989/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39989/tests/dromaeo/cssquery-ext.html) 18:46:45 INFO - PROCESS | 24706 | RSS: Main: 242786304 18:46:45 INFO - PROCESS | 24706 | 18:49:47 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:39989/tests/dromaeo/cssquery-ext.html (next: http://localhost:39989/tests/dromaeo/cssquery-jquery.html) 18:49:48 INFO - PROCESS | 24706 | RSS: Main: 222838784 18:49:48 INFO - PROCESS | 24706 | 18:52:50 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:39989/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39989/tests/dromaeo/cssquery-mootools.html) 18:52:50 INFO - PROCESS | 24706 | RSS: Main: 237510656 18:52:50 INFO - PROCESS | 24706 | 18:55:52 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:39989/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39989/tests/dromaeo/cssquery-prototype.html) 18:55:53 INFO - PROCESS | 24706 | RSS: Main: 201760768 18:55:53 INFO - PROCESS | 24706 | 18:58:55 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:39989/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39989/tests/dromaeo/cssquery-yui.html) 18:58:56 INFO - PROCESS | 24706 | RSS: Main: 208855040 18:58:56 INFO - PROCESS | 24706 | 19:01:58 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:39989/tests/dromaeo/cssquery-yui.html (next: http://localhost:39989/tests/dromaeo/cssquery-dojo.html) 19:01:58 INFO - PROCESS | 24706 | RSS: Main: 253181952 19:01:58 INFO - PROCESS | 24706 | 19:01:58 INFO - PROCESS | 24706 | __start_tp_report 19:01:58 INFO - PROCESS | 24706 | _x_x_mozilla_page_load 19:01:58 INFO - PROCESS | 24706 | _x_x_mozilla_page_load_details 19:01:58 INFO - PROCESS | 24706 | |i|pagename|runs| 19:01:58 INFO - PROCESS | 24706 | |0;dojo.html;3292.7201187899027;3346.882859099932;3376.6116896556905;3383.4924761285806;3411.2154204532962;5422.918656220155;5453.536449401806;5459.290292262005;5469.316335458067;5490.258815059966;5402.702851343174;5461.9453805461935;5481.588880833933;5487.314085739283;5498.257735205746;4826.49321821209;4920.065187614359;5008.148614735485;5032.698038117706;5065.1642478990925;4940.28365886948;4944.283078953549;5021.17150670139;5037.143685573461;5039.974800125994;4975.054739599483;5018.548330650241;5049.444561098295;5057.468965758598;5062.746862656871;4976.477469865648;5029.270755740397;5048.873778155539;5052.9747351263195;5058.822941197059;4886.071646387175;4886.51134886512;4959.773495369218;4961.776720047606;4987.5511203991455;5208.218767184915;5246.422893481714;5246.7901283948595;5257.921131183035;5258.316418865523;5832.445917637818;5838.036723940545;5842.036064049426;5847.8538036549;5853.414658534155;5701.942980570183;5810.680412577307;5919.733611987428;5951.047832346804;5963.075723262901;5476.397596264408;5492.038893193675;5494.340679118532;5496.615236933376;5505.944940550623;5880.176775251468;5940.435658612425;6003.759849606055;6004;6031.24609423822;5748.626339288016;5818.330891947396;5820.563457740686;5831.88336233273;5854.8536286592325;5832.737526811304;5879.706014699248;5886.411358864079;5886.58793884424;5892.263467066617;5672.546196304285;5828.854278643068;5836.095405212199;5836.416358364129;5837.124431335249;5741.8564535886935;5758.3665796762325;5761.337446193741;5776.971115144482;5822.243108395882;4382.101669157815;4405.801738921692;4419.315006174048;4421;4446.73319600825;3989.082511022481;3998.280309544252;4006.579309172553;4011.338129208706;4029.1135950090934;5471.671699698031;5498.092814685612;5535.861603459865;5540.861478463071;5554.50009499147;5887.852803679943;5899;5908.172855800191;5911.556633252523;5916.645001299936;5392.649477783932;5476;5534.557235421237;5536;5542.750576223999;4954.133026720309;4993.226049962262;4997.650164488451;5017.3226614406585;5031.421386540522;5937.881242375129;5993.370696076936;5999.550033747487;6011.669358185254;6012.458878700938;5783.132530120515;5814.796482123105;5830.912536311958;5839.620424672383;5901.439363260483;6100.23747031621;6106;6107.633541987495;6108.205933228652;6109.816705498843;5798.478136967693;5830.096335068071;5846.356900741001;5847.181394604674;5847.26909136358;5757.36668966405;5875.676837773964;5899.734511946886;5948.762049517971;5966.254218222723;5729.427057294237;5731.455511726379;5734.340550836707;5738.655680659173;5751.913721294268;5716.857078573069;5728.914066289092;5730.255066841284;5735.11105778605;5737.713114344183;5568.9443105568425;5582.916256256241;5584.246126772996;5607.271054762855;5668.291463567054;5743.282089738783;5763.769449222152;5769.94230057694;5775.133729940542;5785.190073389813;5627.352854421794;5647.7176141193595;5647.943520564741;5650.3219613646625;5654.236678048411 19:01:58 INFO - PROCESS | 24706 | |1;ext.html;562.356102262909;570.9857253568657;575.7296674365566;626.5551458464487;634.546299395932;38183.42724859126;38343.61656383435;38430.42354364683;38466;38512.807435962815;42690.57309426905;43454.34818477726;43491.34762978558;43512.78243608778;43534.78232608832;8966.193042626179;9158.267338612895;9160.038195989426;9168.633254669838;9173.58718857653;8998.235150012224;9133.132352426543;9139.95430022849;9142.085791420837;9146.908530914672;9232.723018309462;9339.533023348838;9340.766480838;9341.579628916716;9345.626174953028;9132.771680708001;9321.300902432276;9326.1606455419;9329.346945713734;9336.299777516713;9068.954655226682;9193.54032298389;9193.816123677556;9206.631734730603;9207.539623018889;42597.361039584124;43032.569674303486;43084.35373469401;43101;43106.13787724228;2725.7274272572586;3753.5871054184017;3826.540815102178;4093.079057212133;4235.53409124996;28304.71695283062;28941;29726;34307.14232144217;34537.827310863286;3960.940585891214;3980.44273801668;4044.4539987101953;4094.7747873866924;4204.11713540157;319488;320408;323270;323631;324184;63481;71247.64376178086;71347;71744;72477.2752272481;62752;62874;62944;63236.367636323965;63244.68377658082;17915.820841791676;18077.909610452127;18119.094045297683;18120.456386308433;18128.365507207447;13669.589912302647;13837;13840.100393474593;13845.930770346084;13853.099548529313;22530.662040069084;22873.428164296027;22929;22972.885135574215;22974;8853.15894989975;8974.37179397449;9023.954880225558;9066.22937050345;9145;1030.0677886512717;1055.8627378440754;1086.179934149712;1146.7247860513417;1207.885250901163;29118.854405727834;29451.705482945326;29921;30024;30797.384052318826;1127.4419162514444;1158.6697791129488;1164.4177911044478;1207.2997661356392;1238.907081968856;15102.244887755569;15196.316165772345;15245.390184392721;15751;15760.605984850241;375398;375749;378138;379859;380732;55937.72031139818;56656.15015774767;56733.71633141808;56840;56856.71571642115;1352.0468070010618;1493.6415260337658;1504.8043754311868;1509.2076659753718;1516.7497362935212;27544.17367478979;27628.861855690593;27645;28117.71882281151;28177.718222817508;41983.160336793706;50139.74930125472;50929.490705092474;50977.745111274206;50985.74507127589;265954;267789;267924;269816.2073517037;270396;41146.38280425856;45316;46092.53907461017;46103.308450373945;51824;47772.761136194094;48271.27593086177;48918.75540622274;49141.2628810561;49478.75260623674;41846;43606.12787744291;43748.34377484404;44163.337549937416;45064.54935450604;38744.80627596844;39267.41098883576;39868.60131398649;40204.79897600493;40628.79685601553;40094;40868;40938.385924211754;41110.794446027576;41399.37900931428;36101.81949090238;37193.81403092967;37523;37990;38076.04809879775;28444.57333139963;28551;28565.571516427684;28858.567121492775;28885.27786805347 19:01:58 INFO - PROCESS | 24706 | |2;jquery.html;381.2984109239001;382.1287464580755;384.3178358413816;391.1180288449546;392.7820059866773;17597.47207583773;18271.817281827196;18769.436916892515;18773.81226187736;18816.71774923374;13530.120542164752;17389.913050434763;17927;17932.462026139205;17944.192511336987;5146.871328216796;5335.67985920846;5376.435474275204;5378;5379.596530260226;3929.685625149981;5593.888122237553;5800.1299805029375;5824.621399609033;5829.446202610767;5808.157817116516;5810.912836307459;5815.9531284368795;5828.0675091985295;5828.0675091985295;6554.639494827783;6771.882639364499;6783.660816959133;6786.457083433338;6802.761903333384;4527.139843429771;6599.10912026875;6808.761693340709;6816.386525212754;6819.318068193191;23274.418139546477;23293.417664558354;23554;23598.174063907853;23737;2341.519988402373;2546.8853901574475;2564.846109233452;2690.5560582503863;3197.728193103589;14121.223332716696;14739.484118055923;15254;15302.234888255543;15382.461613843574;2146.570685862818;2174.08688350893;2191.934241972743;2211.657193135067;2254.9098036078535;74409;76065;76682.61658691782;76774;78201;16329;17174.91412542929;17198;17200.827991720173;17222.655546888993;26937.595936060974;26982.865085674446;27071;27273.454530909272;27307.590386144224;10096.495175241209;10455.581776728997;10460;10476.842847357295;10577.201875681152;8845.734627961043;8850.601722922484;8856.202941735146;8982;9206.26349892007;8466.111058338909;8524.829503410021;8641.438306510057;8664;8676.8698469523;2845.416689578673;3285.6221534523834;3318.36950979318;3368.545246391755;3433.3648275068695;919.1681528216974;939.3049143633662;956.866038754561;984.8818141823027;1000.3147843726924;16051.835508121687;17145.314187432363;17209.7418538722;17511.124443778015;17947.551311217325;942.2273735536932;953.413650604873;968.3802366485455;1044.1646682653848;1047.1727335405096;9679.612815487302;10005.549750261256;10034;10053.798924021625;10187.337823041627;451771;452826;457303;459530;463047;73983.63008184925;75739;75951;76394.61802691063;77951;1022.3508072374096;1026.1893104447552;1033.9379637221791;1036.76154484469;1051.3271506236167;15493.380264789734;15826.36694532252;16044.197790110215;16045.919770401073;16081.19594020271;33693.15767105842;34241.828790855885;34580.308393832485;34623.65376346204;35522.28955420929;47475.28787068266;49345.25982110343;49458.505414945386;49667;49679.75160124176;8651.091635378447;8796.692115775917;8900.955495222483;8909.777255568662;9018.774530636787;10068;12934.805977910151;13216.339183041002;13290.86709132935;13338.26639534835;11155.163362747664;11413.258138220988;11548.191626586058;11681;11941.82087268709;8713.607887644945;11340.94329528347;11374.886251137383;11550.422478876191;11730.926582529635;11709.824352634547;11845.644630661094;11889.940550297193;11957.760844782882;12047.879521204675;8563.186497282748;8564.48613083217;8695.826083478169;8705.738827835175;8761.649534018823;11523.942380288045;11640.301581905112;11672.358020308964;11691;11703.824442633197 19:01:58 INFO - PROCESS | 24706 | |3;mootools.html;1486.4723023326712;1604.8876578639497;1627.0806994048367;1895.4695481532153;1999.8900060496667;8286.585670716462;8467.872981905277;8474.703385381514;8479;8483.957580212105;8405.41162118652;8552.91447085529;8581.485110893334;8587.270082043035;8595.570221488932;2170.6635471501863;2216.1910902520626;2465.778079972802;2513.258588716324;2541.4281786598053;2518.534071196825;2523.255639586317;2525.911593094242;2527.5703130467864;2534.3157347516158;2283.0867652938873;2288.599495088361;2303.5738388398117;2326.5230627721276;2334.089705015037;2424.127314166916;2472.8516289022627;2473.134402958968;2474.0722229163885;2476.2076135636603;2433.8904749286326;2452.4849781545895;2458.729539750626;2459.4220358215807;2460.3603063203695;8768.517731524764;8794.208521233055;8845.646174153091;8847.115288471166;8877.955610221972;5237.528622423962;5357.705326207057;5405.702686352249;5407.3781515125875;5412.891742165135;3366.848491817874;3367.8316084195935;3421.863125474978;3429.176997520602;3445.3626079175183;1018.4093225929017;1066.6053560182704;1069.9411532365716;1076.7308172956762;1082.978340433187;12121.878781212163;12137.696557586043;12179.695507612292;12182.51269949201;12204.084693648012;4831.806727730922;4864.391951006124;4876.975615121973;4912.656114072052;4921.237208232729;10295.691129266133;10305.896941030644;10308.123809476128;10320.48397580118;10328.845067323997;5381.54256888161;5391.487808658171;5412.810551630674;5431.103867861759;5431.972840135774;4349.739015659071;4775.044991001813;4877.170880950247;4915.36100306965;4932.161532539477;3961.861334853324;4006.959930400659;4019.618136277049;4064.4106604542176;4076.735012224255;1282.1409655530817;1288.1755676367131;1291.0510774580675;1313.507434711983;1323.6293837725452;1483.8219413670429;1488.776683497484;1488.880889528835;1511.0329389190927;1527.2821773766311;8322.042965058974;8504.44721093127;8511.531865747444;8534.487930724052;8565.10066443027;528.4900071431088;535.0609680011555;562.1932526824021;566.0999011571621;566.6826577116746;6239.625622462667;6255.937440625536;6265.4361107500545;6316.2736285326855;6318.336574659686;10666.520006599721;10883.401412922365;10981.17641176915;11018.559257629766;11074.889251107386;10545.789084218273;10735.302205356627;10874.02133807961;10876.72808179786;11009.2843965142;8124.268815806606;8148.918510814935;8190.918090819135;8226.465279756796;8281.337493000545;7997.600119993861;8049.27556519916;8086.312663423675;8090.757277281691;8135.227153420416;9503.66737164196;9567.808643826946;9601.711948641552;9707.951460242653;9771.609135634495;9689.70930872075;9914.900850991686;10030.147437467896;10220.897791021995;10233.334833235816;6668.199816022108;7531.209223031503;7730.497517661334;7765.107012693386;7781.455298129076;8431.578421079044;8480.448770829877;8519.06290308078;8533.061363249913;8552.444091134304;7537.9623101884135;7747.92252077472;7777.261160189773;7825.726099586487;7843.490173138728;7462.403007759474;7492.175860655432;7502.099748030271;7585.772426827204;7595.620218988918;7984.640691169027;8009.399295052778;8045.436819422584;8053.114157442559;8062.274395304451;7066.258042905421;7228.783136505913;7241.746538871325;7244.89132663;7287.052683151156;7346.816329591803;7353.374963128194;7384.667689953858;7384.966104745233;7404.925950740424 19:01:58 INFO - PROCESS | 24706 | |4;prototype.html;354.64535464535464;362.7569528415961;363.38587786640574;365.327796853789;373.9906502337443;5982.551308651847;5985.461308482236;5989.4010598940085;5992.490638295744;6002.159697642333;6002.969985150079;6006.249218847644;6013.699315034252;6013.969930150354;6021.187139736135;4509.030558429937;4610.331501932218;4657.161710892038;4699.459562150345;4745.501722319159;4701.43582770068;4710.5289471052965;4757.881052973668;4758.072175925696;4792.137415265268;4719.882002949937;4722.693024953367;4726.550977657117;4731.881702957437;4733.763311834412;4486.506484286726;4591.081783643268;4704.1767690654;4716.292556116576;4724.984128412408;4195.790210489463;4196.664266858644;4196.748195108273;4200.768957707325;4207.03238255203;5708.80019199326;5738.885222295531;5750.856228594319;5753.913691294592;5761.654300741969;5473.261109750172;5476.507114359687;5478;5486.423925487846;5496.532794712454;6339.968300158515;6353.618782873043;6361.300256971729;6363.427291543783;6368.936310636881;4370;4534.909301813946;4549.294859296781;4549.681522293441;4622.884427889296;6579;6623.768168114093;6648.102506161655;6650.767223147167;6653;4638.165130276515;4661.091087238024;4663.626909847204;4666.230072038075;4667.346571479996;4719.10337035962;4724.126036683225;4729.976350118227;4730.95269047312;4731.053789242165;5392.164214546751;5405.459454054641;5411.594130440154;5416.593755468356;5423.674579525241;6275.717592708339;6404.807855764335;6409.807705768834;6413.166288382574;6442.6778661066755;1631.7226071567861;1636.7135751243484;1640.3520609359236;1642.1624971264503;1643.005981381271;1073.3023534702506;1075.5536452372335;1117.1174771930246;1124.7413094988199;1147.3804145761362;6082.60463069899;6091.8477038073515;6097.115918191837;6097.969510152421;6098.359672234352;6460.773872914426;6556.541042127101;6569.835754106186;6571.2771595124495;6575.112359831457;6184.412480814315;6196.3803619638575;6210.347913469111;6212.316645169028;6220.129181914535;3511.8595256189465;3549.0949807798847;3549.982250088733;3551.8756843510355;3553.697935675445;6591.769288074895;6807.523473356917;6811.386975172259;6826.829329266808;6828.556143850634;6693.698783554752;6715.832104197434;6736.6631668416385;6739.797806065826;6740.696668649923;6793.830154246085;6805.149356330458;6825.624590647462;6881.10545629075;6885;6544.640044797582;6552.705128269335;6561;6564.048213008991;6577.868442631025;6337.524685648503;6468.1889071058295;6471.126397936218;6480.157579514633;6486.772962946275;6750.966245168743;6787.898181527183;6792.592444453348;6794.082798822294;6796.388325050571;4674.275487299474;4680.508546602694;4683.274092515666;4684.203685373563;4687.156311863897;6557.770478033246;6563.803085907431;6581.769638062645;6588.901166482602;6589;6194.287656919331;6345.206849143857;6358.841028974312;6363.904541431974;6383.36166383358;6372.713227904663;6396.744130234739;6402.519811014099;6402.903956440564;6404.391582799627;6291.213598300213;6292.465140463112;6297.811065668037;6303.905441418291;6304.747810087545;6412.583182093149;6414.262359828679;6418.101465794699;6421.903671445026;6424.229092508929;6087.330393656605;6222.688865556614;6234.532410069353;6268.686565671789;6304.05439184126 19:01:58 INFO - PROCESS | 24706 | |5;yui.html;813.7762115418263;825.8719898415744;852.7100785732852;853.5220276645075;943.6838659049216;14411.135331880081;15106.169160696158;15227.923860380697;15316.387344506207;15330.233488325595;14586.708265834677;14621.342039608217;14702.485413010547;14761.92619036906;14830.184339861304;788.3456730913329;906.7234493479486;937.77024628966;939.6194541210821;940.2008292951006;930.0467021303151;930.6370515498961;937.1799675284126;938.5729493080667;949.6913503111516;818.607068607069;983.9950800246024;989.1196834817018;990.7275499237695;1007.6876168387823;932.6176267730232;933.1415098109755;934.7149119518544;935.443411170356;987.9061489158519;683.5112894280563;683.6547543490556;684.0560027162484;701.2111374703459;730.9890351644676;15210.16344101074;15234.923825380802;15251.23743812805;15272.694546109127;15278.694426111526;14041.1575305482;14056.367463464168;14245.78631320531;14765.409383624643;14824;11697.532098716041;11716.70708232301;11756.235844670155;11793.23343982647;11854.525818967231;3941.2314598653275;3959.4456776051375;3985.621365970228;4060.5330387005283;4106.014556506447;52260;52279.47720522822;52367.47632523664;52629.7368513155;52725.472745272826;11402.771944561062;11519.596814111466;11554.306741595532;11628.127890408254;11811.763764724657;20897.477563061046;20926.895365523076;20937.47656308574;21003.894980525;21022.894885525475;8256;8288.254057134765;8383.371247156487;8588.828223435496;8888.37781355312;4734.804007295062;4814.301926220678;4819.084373968934;4928.827491037797;4961.107000739829;3487.5466189395215;3516.771409858351;3517.9824100879846;3521.454174602941;3538.4161613333513;676.1109141478939;738.7968308715147;739.4195556488131;755.5617741709796;771.2172145272552;626.9404406581459;704.8202708309349;743.4238465189521;744.988825167623;747.1221314954906;9117.817643647222;9138.497382643885;9229.676961306322;9310.208632266333;9409.200217981548;654.7806484827636;690.002945743396;690.4683393786756;735.3051366458752;751.4927423988786;4249.150169966019;4446;4494.797734101973;4528.026474307973;4536.070105628404;60404.39595603988;60536.394636053075;60664.69667651634;60750;66790.33209667841;54357;54473.72763136159;55054.72472637691;55306.72346638241;55501.722491387285;47255.763721181174;47588.28617570739;48130.75934620304;48408.27387589189;48589.514104859205;9411.152996230372;9605.47169905634;9620.71137865865;9635.277354198603;9669.178119859891;36048;36332.27335453329;36505;37638;38433.615663843004;50173;50273.24590131078;51765.22352164796;51868.74065629799;51942.74028629833;12281.69295767613;12319.44562494672;12420.441080151595;12513.311767852856;12775.36123193818;13567.59297221085;13626.046176767532;13676.658083547592;13756;14401.855981440052;12752.936235319135;13279.80080298777;13622.114562553403;13762;13802.309884505936;12841.23518558108;12945.611631651065;13231.139975901535;13252.271125088213;13463;11336.319820810448;11686.766264674829;13059.738805224033;13110.475580976654;13196.868031319564;10795.6221532246;10879.673609791718;10932.836007459735;11058.889411106107;11186.496607652512;10516.956182661112;10684.893151068702;10790.946045269724;11005.229633925868;11022.228444008842 19:01:58 INFO - PROCESS | 24706 | __end_tp_report 19:01:58 INFO - PROCESS | 24706 | __start_cc_report 19:01:58 INFO - PROCESS | 24706 | _x_x_mozilla_cycle_collect,827 19:01:58 INFO - PROCESS | 24706 | __end_cc_report 19:01:58 INFO - PROCESS | 24706 | __startTimestamp1459216918608__endTimestamp 19:01:58 INFO - PROCESS | 24706 | 19:01:58 INFO - PROCESS | 24706 | ------- Summary: start ------- 19:01:58 INFO - PROCESS | 24706 | Number of tests: 6 19:01:58 INFO - PROCESS | 24706 | 19:01:58 INFO - PROCESS | 24706 | [#0] dojo.html Cycles:165 Average:5437.01 Median:5650.32 stddev:598.46 (10.6%) stddev-sans-first:576.17 19:01:58 INFO - PROCESS | 24706 | Values: 3292.7 3346.9 3376.6 3383.5 3411.2 5422.9 5453.5 5459.3 5469.3 5490.3 5402.7 5461.9 5481.6 5487.3 5498.3 4826.5 4920.1 5008.1 5032.7 5065.2 4940.3 4944.3 5021.2 5037.1 5040.0 4975.1 5018.5 5049.4 5057.5 5062.7 4976.5 5029.3 5048.9 5053.0 5058.8 4886.1 4886.5 4959.8 4961.8 4987.6 5208.2 5246.4 5246.8 5257.9 5258.3 5832.4 5838.0 5842.0 5847.9 5853.4 5701.9 5810.7 5919.7 5951.0 5963.1 5476.4 5492.0 5494.3 5496.6 5505.9 5880.2 5940.4 6003.8 6004.0 6031.2 5748.6 5818.3 5820.6 5831.9 5854.9 5832.7 5879.7 5886.4 5886.6 5892.3 5672.5 5828.9 5836.1 5836.4 5837.1 5741.9 5758.4 5761.3 5777.0 5822.2 4382.1 4405.8 4419.3 4421.0 4446.7 3989.1 3998.3 4006.6 4011.3 4029.1 5471.7 5498.1 5535.9 5540.9 5554.5 5887.9 5899.0 5908.2 5911.6 5916.6 5392.6 5476.0 5534.6 5536.0 5542.8 4954.1 4993.2 4997.7 5017.3 5031.4 5937.9 5993.4 5999.6 6011.7 6012.5 5783.1 5814.8 5830.9 5839.6 5901.4 6100.2 6106.0 6107.6 6108.2 6109.8 5798.5 5830.1 5846.4 5847.2 5847.3 5757.4 5875.7 5899.7 5948.8 5966.3 5729.4 5731.5 5734.3 5738.7 5751.9 5716.9 5728.9 5730.3 5735.1 5737.7 5568.9 5582.9 5584.2 5607.3 5668.3 5743.3 5763.8 5769.9 5775.1 5785.2 5627.4 5647.7 5647.9 5650.3 5654.2 19:01:58 INFO - PROCESS | 24706 | 19:01:58 INFO - PROCESS | 24706 | [#1] ext.html Cycles:180 Average:51201.75 Median:22336.63 stddev:85285.18 (381.8%) stddev-sans-first:85439.67 19:01:58 INFO - PROCESS | 24706 | Values: 562.4 571.0 575.7 626.6 634.5 38183.4 38343.6 38430.4 38466.0 38512.8 42690.6 43454.3 43491.3 43512.8 43534.8 8966.2 9158.3 9160.0 9168.6 9173.6 8998.2 9133.1 9140.0 9142.1 9146.9 9232.7 9339.5 9340.8 9341.6 9345.6 9132.8 9321.3 9326.2 9329.3 9336.3 9069.0 9193.5 9193.8 9206.6 9207.5 42597.4 43032.6 43084.4 43101.0 43106.1 2725.7 3753.6 3826.5 4093.1 4235.5 28304.7 28941.0 29726.0 34307.1 34537.8 3960.9 3980.4 4044.5 4094.8 4204.1 319488.0 320408.0 323270.0 323631.0 324184.0 63481.0 71247.6 71347.0 71744.0 72477.3 62752.0 62874.0 62944.0 63236.4 63244.7 17915.8 18077.9 18119.1 18120.5 18128.4 13669.6 13837.0 13840.1 13845.9 13853.1 22530.7 22873.4 22929.0 22972.9 22974.0 8853.2 8974.4 9024.0 9066.2 9145.0 1030.1 1055.9 1086.2 1146.7 1207.9 29118.9 29451.7 29921.0 30024.0 30797.4 1127.4 1158.7 1164.4 1207.3 1238.9 15102.2 15196.3 15245.4 15751.0 15760.6 375398.0 375749.0 378138.0 379859.0 380732.0 55937.7 56656.2 56733.7 56840.0 56856.7 1352.0 1493.6 1504.8 1509.2 1516.7 27544.2 27628.9 27645.0 28117.7 28177.7 41983.2 50139.7 50929.5 50977.7 50985.7 265954.0 267789.0 267924.0 269816.2 270396.0 41146.4 45316.0 46092.5 46103.3 51824.0 47772.8 48271.3 48918.8 49141.3 49478.8 41846.0 43606.1 43748.3 44163.3 45064.5 38744.8 39267.4 39868.6 40204.8 40628.8 40094.0 40868.0 40938.4 41110.8 41399.4 36101.8 37193.8 37523.0 37990.0 38076.0 28444.6 28551.0 28565.6 28858.6 28885.3 19:01:58 INFO - PROCESS | 24706 | 19:01:58 INFO - PROCESS | 24706 | [#2] jquery.html Cycles:180 Average:27754.75 Median:3021.57 stddev:74866.16 (2477.7%) stddev-sans-first:75047.97 19:01:58 INFO - PROCESS | 24706 | Values: 381.3 382.1 384.3 391.1 392.8 17597.5 18271.8 18769.4 18773.8 18816.7 13530.1 17389.9 17927.0 17932.5 17944.2 5146.9 5335.7 5376.4 5378.0 5379.6 3929.7 5593.9 5800.1 5824.6 5829.4 5808.2 5810.9 5816.0 5828.1 5828.1 6554.6 6771.9 6783.7 6786.5 6802.8 4527.1 6599.1 6808.8 6816.4 6819.3 23274.4 23293.4 23554.0 23598.2 23737.0 2341.5 2546.9 2564.8 2690.6 3197.7 14121.2 14739.5 15254.0 15302.2 15382.5 2146.6 2174.1 2191.9 2211.7 2254.9 74409.0 76065.0 76682.6 76774.0 78201.0 16329.0 17174.9 17198.0 17200.8 17222.7 26937.6 26982.9 27071.0 27273.5 27307.6 10096.5 10455.6 10460.0 10476.8 10577.2 8845.7 8850.6 8856.2 8982.0 9206.3 8466.1 8524.8 8641.4 8664.0 8676.9 2845.4 3285.6 3318.4 3368.5 3433.4 919.2 939.3 956.9 984.9 1000.3 16051.8 17145.3 17209.7 17511.1 17947.6 942.2 953.4 968.4 1044.2 1047.2 9679.6 10005.5 10034.0 10053.8 10187.3 451771.0 452826.0 457303.0 459530.0 463047.0 73983.6 75739.0 75951.0 76394.6 77951.0 1022.4 1026.2 1033.9 1036.8 1051.3 15493.4 15826.4 16044.2 16045.9 16081.2 33693.2 34241.8 34580.3 34623.7 35522.3 47475.3 49345.3 49458.5 49667.0 49679.8 8651.1 8796.7 8901.0 8909.8 9018.8 10068.0 12934.8 13216.3 13290.9 13338.3 11155.2 11413.3 11548.2 11681.0 11941.8 8713.6 11340.9 11374.9 11550.4 11730.9 11709.8 11845.6 11889.9 11957.8 12047.9 8563.2 8564.5 8695.8 8705.7 8761.6 11523.9 11640.3 11672.4 11691.0 11703.8 19:01:58 INFO - PROCESS | 24706 | 19:01:58 INFO - PROCESS | 24706 | [#3] mootools.html Cycles:180 Average:6131.10 Median:2946.38 stddev:3270.86 (111.0%) stddev-sans-first:3261.40 19:01:58 INFO - PROCESS | 24706 | Values: 1486.5 1604.9 1627.1 1895.5 1999.9 8286.6 8467.9 8474.7 8479.0 8484.0 8405.4 8552.9 8581.5 8587.3 8595.6 2170.7 2216.2 2465.8 2513.3 2541.4 2518.5 2523.3 2525.9 2527.6 2534.3 2283.1 2288.6 2303.6 2326.5 2334.1 2424.1 2472.9 2473.1 2474.1 2476.2 2433.9 2452.5 2458.7 2459.4 2460.4 8768.5 8794.2 8845.6 8847.1 8878.0 5237.5 5357.7 5405.7 5407.4 5412.9 3366.8 3367.8 3421.9 3429.2 3445.4 1018.4 1066.6 1069.9 1076.7 1083.0 12121.9 12137.7 12179.7 12182.5 12204.1 4831.8 4864.4 4877.0 4912.7 4921.2 10295.7 10305.9 10308.1 10320.5 10328.8 5381.5 5391.5 5412.8 5431.1 5432.0 4349.7 4775.0 4877.2 4915.4 4932.2 3961.9 4007.0 4019.6 4064.4 4076.7 1282.1 1288.2 1291.1 1313.5 1323.6 1483.8 1488.8 1488.9 1511.0 1527.3 8322.0 8504.4 8511.5 8534.5 8565.1 528.5 535.1 562.2 566.1 566.7 6239.6 6255.9 6265.4 6316.3 6318.3 10666.5 10883.4 10981.2 11018.6 11074.9 10545.8 10735.3 10874.0 10876.7 11009.3 8124.3 8148.9 8190.9 8226.5 8281.3 7997.6 8049.3 8086.3 8090.8 8135.2 9503.7 9567.8 9601.7 9708.0 9771.6 9689.7 9914.9 10030.1 10220.9 10233.3 6668.2 7531.2 7730.5 7765.1 7781.5 8431.6 8480.4 8519.1 8533.1 8552.4 7538.0 7747.9 7777.3 7825.7 7843.5 7462.4 7492.2 7502.1 7585.8 7595.6 7984.6 8009.4 8045.4 8053.1 8062.3 7066.3 7228.8 7241.7 7244.9 7287.1 7346.8 7353.4 7384.7 7385.0 7404.9 19:01:58 INFO - PROCESS | 24706 | 19:01:58 INFO - PROCESS | 24706 | [#4] prototype.html Cycles:180 Average:5373.25 Median:6084.97 stddev:1582.83 (26.0%) stddev-sans-first:1541.80 19:01:58 INFO - PROCESS | 24706 | Values: 354.6 362.8 363.4 365.3 374.0 5982.6 5985.5 5989.4 5992.5 6002.2 6003.0 6006.2 6013.7 6014.0 6021.2 4509.0 4610.3 4657.2 4699.5 4745.5 4701.4 4710.5 4757.9 4758.1 4792.1 4719.9 4722.7 4726.6 4731.9 4733.8 4486.5 4591.1 4704.2 4716.3 4725.0 4195.8 4196.7 4196.7 4200.8 4207.0 5708.8 5738.9 5750.9 5753.9 5761.7 5473.3 5476.5 5478.0 5486.4 5496.5 6340.0 6353.6 6361.3 6363.4 6368.9 4370.0 4534.9 4549.3 4549.7 4622.9 6579.0 6623.8 6648.1 6650.8 6653.0 4638.2 4661.1 4663.6 4666.2 4667.3 4719.1 4724.1 4730.0 4731.0 4731.1 5392.2 5405.5 5411.6 5416.6 5423.7 6275.7 6404.8 6409.8 6413.2 6442.7 1631.7 1636.7 1640.4 1642.2 1643.0 1073.3 1075.6 1117.1 1124.7 1147.4 6082.6 6091.8 6097.1 6098.0 6098.4 6460.8 6556.5 6569.8 6571.3 6575.1 6184.4 6196.4 6210.3 6212.3 6220.1 3511.9 3549.1 3550.0 3551.9 3553.7 6591.8 6807.5 6811.4 6826.8 6828.6 6693.7 6715.8 6736.7 6739.8 6740.7 6793.8 6805.1 6825.6 6881.1 6885.0 6544.6 6552.7 6561.0 6564.0 6577.9 6337.5 6468.2 6471.1 6480.2 6486.8 6751.0 6787.9 6792.6 6794.1 6796.4 4674.3 4680.5 4683.3 4684.2 4687.2 6557.8 6563.8 6581.8 6588.9 6589.0 6194.3 6345.2 6358.8 6363.9 6383.4 6372.7 6396.7 6402.5 6402.9 6404.4 6291.2 6292.5 6297.8 6303.9 6304.7 6412.6 6414.3 6418.1 6421.9 6424.2 6087.3 6222.7 6234.5 6268.7 6304.1 19:01:58 INFO - PROCESS | 24706 | 19:01:58 INFO - PROCESS | 24706 | [#5] yui.html Cycles:180 Average:15217.57 Median:25895.92 stddev:17185.57 (66.4%) stddev-sans-first:17199.74 19:01:58 INFO - PROCESS | 24706 | Values: 813.8 825.9 852.7 853.5 943.7 14411.1 15106.2 15227.9 15316.4 15330.2 14586.7 14621.3 14702.5 14761.9 14830.2 788.3 906.7 937.8 939.6 940.2 930.0 930.6 937.2 938.6 949.7 818.6 984.0 989.1 990.7 1007.7 932.6 933.1 934.7 935.4 987.9 683.5 683.7 684.1 701.2 731.0 15210.2 15234.9 15251.2 15272.7 15278.7 14041.2 14056.4 14245.8 14765.4 14824.0 11697.5 11716.7 11756.2 11793.2 11854.5 3941.2 3959.4 3985.6 4060.5 4106.0 52260.0 52279.5 52367.5 52629.7 52725.5 11402.8 11519.6 11554.3 11628.1 11811.8 20897.5 20926.9 20937.5 21003.9 21022.9 8256.0 8288.3 8383.4 8588.8 8888.4 4734.8 4814.3 4819.1 4928.8 4961.1 3487.5 3516.8 3518.0 3521.5 3538.4 676.1 738.8 739.4 755.6 771.2 626.9 704.8 743.4 745.0 747.1 9117.8 9138.5 9229.7 9310.2 9409.2 654.8 690.0 690.5 735.3 751.5 4249.2 4446.0 4494.8 4528.0 4536.1 60404.4 60536.4 60664.7 60750.0 66790.3 54357.0 54473.7 55054.7 55306.7 55501.7 47255.8 47588.3 48130.8 48408.3 48589.5 9411.2 9605.5 9620.7 9635.3 9669.2 36048.0 36332.3 36505.0 37638.0 38433.6 50173.0 50273.2 51765.2 51868.7 51942.7 12281.7 12319.4 12420.4 12513.3 12775.4 13567.6 13626.0 13676.7 13756.0 14401.9 12752.9 13279.8 13622.1 13762.0 13802.3 12841.2 12945.6 13231.1 13252.3 13463.0 11336.3 11686.8 13059.7 13110.5 13196.9 10795.6 10879.7 10932.8 11058.9 11186.5 10517.0 10684.9 10790.9 11005.2 11022.2 19:01:58 INFO - PROCESS | 24706 | -------- Summary: end -------- 19:01:58 INFO - PROCESS | 24706 | 19:01:59 INFO - TEST-INFO | 24706: exit 0 19:01:59 INFO - TEST-OK | dromaeo_css | took 1111082ms 19:01:59 INFO - TEST-START | kraken 19:01:59 INFO - operating with platform_type : linux_ 19:01:59 INFO - Initialising browser for kraken test... 19:01:59 INFO - TEST-INFO | started process 24903 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0w3V8E/profile http://localhost:39989/getInfo.html) 19:02:03 INFO - PROCESS | 24903 | __metrics Screen width/height:1600/1200 19:02:03 INFO - PROCESS | 24903 | colorDepth:24 19:02:03 INFO - PROCESS | 24903 | Browser inner width/height: 1024/697 19:02:03 INFO - PROCESS | 24903 | __metrics 19:02:03 INFO - PROCESS | 24903 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:02:03 INFO - PROCESS | 24903 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 19:02:04 INFO - TEST-INFO | 24903: exit 0 19:02:04 INFO - Browser initialized. 19:02:04 INFO - Running cycle 1/1 for kraken test... 19:02:04 INFO - TEST-INFO | started process 24991 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0w3V8E/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:02:16 INFO - PROCESS | 24991 | RSS: Main: 144556032 19:02:16 INFO - PROCESS | 24991 | 19:02:18 INFO - PROCESS | 24991 | Cycle 1(1): loaded http://localhost:39989/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39989/tests/kraken/driver.html?testName=audio-beat-detection) 19:02:19 INFO - PROCESS | 24991 | RSS: Main: 179982336 19:02:19 INFO - PROCESS | 24991 | 19:02:22 INFO - PROCESS | 24991 | Cycle 1(1): loaded http://localhost:39989/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39989/tests/kraken/driver.html?testName=audio-dft) 19:02:22 INFO - PROCESS | 24991 | RSS: Main: 176156672 19:02:22 INFO - PROCESS | 24991 | 19:02:25 INFO - PROCESS | 24991 | Cycle 1(1): loaded http://localhost:39989/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39989/tests/kraken/driver.html?testName=audio-fft) 19:02:26 INFO - PROCESS | 24991 | RSS: Main: 173625344 19:02:26 INFO - PROCESS | 24991 | 19:02:28 INFO - PROCESS | 24991 | Cycle 1(1): loaded http://localhost:39989/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39989/tests/kraken/driver.html?testName=audio-oscillator) 19:02:28 INFO - PROCESS | 24991 | RSS: Main: 175591424 19:02:28 INFO - PROCESS | 24991 | 19:02:30 INFO - PROCESS | 24991 | Cycle 1(1): loaded http://localhost:39989/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39989/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:02:31 INFO - PROCESS | 24991 | RSS: Main: 171921408 19:02:31 INFO - PROCESS | 24991 | 19:02:34 INFO - PROCESS | 24991 | Cycle 1(1): loaded http://localhost:39989/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39989/tests/kraken/driver.html?testName=imaging-darkroom) 19:02:35 INFO - PROCESS | 24991 | RSS: Main: 171421696 19:02:35 INFO - PROCESS | 24991 | 19:02:38 INFO - PROCESS | 24991 | Cycle 1(1): loaded http://localhost:39989/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39989/tests/kraken/driver.html?testName=imaging-desaturate) 19:02:39 INFO - PROCESS | 24991 | RSS: Main: 172916736 19:02:39 INFO - PROCESS | 24991 | 19:02:41 INFO - PROCESS | 24991 | Cycle 1(1): loaded http://localhost:39989/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39989/tests/kraken/driver.html?testName=json-parse-financial) 19:02:42 INFO - PROCESS | 24991 | RSS: Main: 172912640 19:02:42 INFO - PROCESS | 24991 | 19:02:43 INFO - PROCESS | 24991 | Cycle 1(1): loaded http://localhost:39989/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39989/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:02:44 INFO - PROCESS | 24991 | RSS: Main: 177897472 19:02:44 INFO - PROCESS | 24991 | 19:02:46 INFO - PROCESS | 24991 | Cycle 1(1): loaded http://localhost:39989/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39989/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:02:46 INFO - PROCESS | 24991 | RSS: Main: 176279552 19:02:46 INFO - PROCESS | 24991 | 19:02:48 INFO - PROCESS | 24991 | Cycle 1(1): loaded http://localhost:39989/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39989/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:02:49 INFO - PROCESS | 24991 | RSS: Main: 180842496 19:02:49 INFO - PROCESS | 24991 | 19:02:51 INFO - PROCESS | 24991 | Cycle 1(1): loaded http://localhost:39989/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:02:52 INFO - PROCESS | 24991 | RSS: Main: 189857792 19:02:52 INFO - PROCESS | 24991 | 19:02:54 INFO - PROCESS | 24991 | Cycle 1(1): loaded http://localhost:39989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:02:55 INFO - PROCESS | 24991 | RSS: Main: 189255680 19:02:55 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | Cycle 1(1): loaded http://localhost:39989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39989/tests/kraken/driver.html?testName=ai-astar) 19:02:57 INFO - PROCESS | 24991 | RSS: Main: 248827904 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | __start_tp_report 19:02:57 INFO - PROCESS | 24991 | _x_x_mozilla_page_load 19:02:57 INFO - PROCESS | 24991 | _x_x_mozilla_page_load_details 19:02:57 INFO - PROCESS | 24991 | |i|pagename|runs| 19:02:57 INFO - PROCESS | 24991 | |0;ai-astar;109;110;103;108;111;111;98;109;108;109 19:02:57 INFO - PROCESS | 24991 | |1;audio-beat-detection;149;128;157;167;132;156;155;127;170;131 19:02:57 INFO - PROCESS | 24991 | |2;audio-dft;161;161;161;161;163;162;162;164;163;160 19:02:57 INFO - PROCESS | 24991 | |3;audio-fft;75;76;76;160;76;75;73;74;158;74 19:02:57 INFO - PROCESS | 24991 | |4;audio-oscillator;93;93;150;95;92;93;143;92;93;134 19:02:57 INFO - PROCESS | 24991 | |5;imaging-gaussian-blur;116;116;117;116;117;117;116;116;116;116 19:02:57 INFO - PROCESS | 24991 | |6;imaging-darkroom;146;147;147;145;145;145;146;144;145;145 19:02:57 INFO - PROCESS | 24991 | |7;imaging-desaturate;95;96;95;95;95;96;95;95;96;95 19:02:57 INFO - PROCESS | 24991 | |8;json-parse-financial;54;56;54;54;56;56;55;64;53;52 19:02:57 INFO - PROCESS | 24991 | |9;json-stringify-tinderbox;65;65;65;65;66;65;66;66;65;66 19:02:57 INFO - PROCESS | 24991 | |10;stanford-crypto-aes;78;79;78;78;77;77;76;77;85;77 19:02:57 INFO - PROCESS | 24991 | |11;stanford-crypto-ccm;110;113;112;109;113;111;116;110;110;123 19:02:57 INFO - PROCESS | 24991 | |12;stanford-crypto-pbkdf2;143;140;151;144;144;135;145;146;150;144 19:02:57 INFO - PROCESS | 24991 | |13;stanford-crypto-sha256-iterative;67;68;67;65;65;65;67;66;67;66 19:02:57 INFO - PROCESS | 24991 | __end_tp_report 19:02:57 INFO - PROCESS | 24991 | __start_cc_report 19:02:57 INFO - PROCESS | 24991 | _x_x_mozilla_cycle_collect,1044 19:02:57 INFO - PROCESS | 24991 | __end_cc_report 19:02:57 INFO - PROCESS | 24991 | __startTimestamp1459216977305__endTimestamp 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | ------- Summary: start ------- 19:02:57 INFO - PROCESS | 24991 | Number of tests: 14 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | [#0] ai-astar Cycles:10 Average:107.60 Median:109.50 stddev:4.06 (3.7%) stddev-sans-first:4.28 19:02:57 INFO - PROCESS | 24991 | Values: 109.0 110.0 103.0 108.0 111.0 111.0 98.0 109.0 108.0 109.0 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:155.50 stddev:16.40 (10.5%) stddev-sans-first:17.38 19:02:57 INFO - PROCESS | 24991 | Values: 149.0 128.0 157.0 167.0 132.0 156.0 155.0 127.0 170.0 131.0 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 19:02:57 INFO - PROCESS | 24991 | Values: 161.0 161.0 161.0 161.0 163.0 162.0 162.0 164.0 163.0 160.0 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | [#3] audio-fft Cycles:10 Average:91.70 Median:75.00 stddev:35.49 (47.3%) stddev-sans-first:37.12 19:02:57 INFO - PROCESS | 24991 | Values: 75.0 76.0 76.0 160.0 76.0 75.0 73.0 74.0 158.0 74.0 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:93.00 stddev:24.14 (26.0%) stddev-sans-first:25.01 19:02:57 INFO - PROCESS | 24991 | Values: 93.0 93.0 150.0 95.0 92.0 93.0 143.0 92.0 93.0 134.0 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:02:57 INFO - PROCESS | 24991 | Values: 116.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 116.0 116.0 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 19:02:57 INFO - PROCESS | 24991 | Values: 146.0 147.0 147.0 145.0 145.0 145.0 146.0 144.0 145.0 145.0 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:02:57 INFO - PROCESS | 24991 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:3.31 (6.0%) stddev-sans-first:3.47 19:02:57 INFO - PROCESS | 24991 | Values: 54.0 56.0 54.0 54.0 56.0 56.0 55.0 64.0 53.0 52.0 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 19:02:57 INFO - PROCESS | 24991 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 66.0 66.0 65.0 66.0 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:2.53 (3.2%) stddev-sans-first:2.68 19:02:57 INFO - PROCESS | 24991 | Values: 78.0 79.0 78.0 78.0 77.0 77.0 76.0 77.0 85.0 77.0 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | [#11] stanford-crypto-ccm Cycles:10 Average:112.70 Median:112.50 stddev:4.16 (3.7%) stddev-sans-first:4.30 19:02:57 INFO - PROCESS | 24991 | Values: 110.0 113.0 112.0 109.0 113.0 111.0 116.0 110.0 110.0 123.0 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.20 Median:144.50 stddev:4.57 (3.2%) stddev-sans-first:4.82 19:02:57 INFO - PROCESS | 24991 | Values: 143.0 140.0 151.0 144.0 144.0 135.0 145.0 146.0 150.0 144.0 19:02:57 INFO - PROCESS | 24991 | 19:02:57 INFO - PROCESS | 24991 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.06 (1.6%) stddev-sans-first:1.09 19:02:57 INFO - PROCESS | 24991 | Values: 67.0 68.0 67.0 65.0 65.0 65.0 67.0 66.0 67.0 66.0 19:02:57 INFO - PROCESS | 24991 | -------- Summary: end -------- 19:02:57 INFO - PROCESS | 24991 | 19:02:58 INFO - TEST-INFO | 24991: exit 0 19:02:58 INFO - TEST-OK | kraken | took 58908ms 19:02:58 INFO - SUITE-END | took 1169s 19:02:58 INFO - Completed test suite (00:19:30) 19:02:58 INFO - javascript benchmark 19:02:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3292.7201187899027, 3346.882859099932, 3376.6116896556905, 3383.4924761285806, 3411.2154204532962, 5422.918656220155, 5453.536449401806, 5459.290292262005, 5469.316335458067, 5490.258815059966, 5402.702851343174, 5461.9453805461935, 5481.588880833933, 5487.314085739283, 5498.257735205746, 4826.49321821209, 4920.065187614359, 5008.148614735485, 5032.698038117706, 5065.1642478990925, 4940.28365886948, 4944.283078953549, 5021.17150670139, 5037.143685573461, 5039.974800125994, 4975.054739599483, 5018.548330650241, 5049.444561098295, 5057.468965758598, 5062.746862656871, 4976.477469865648, 5029.270755740397, 5048.873778155539, 5052.9747351263195, 5058.822941197059, 4886.071646387175, 4886.51134886512, 4959.773495369218, 4961.776720047606, 4987.5511203991455, 5208.218767184915, 5246.422893481714, 5246.7901283948595, 5257.921131183035, 5258.316418865523, 5832.445917637818, 5838.036723940545, 5842.036064049426, 5847.8538036549, 5853.414658534155, 5701.942980570183, 5810.680412577307, 5919.733611987428, 5951.047832346804, 5963.075723262901, 5476.397596264408, 5492.038893193675, 5494.340679118532, 5496.615236933376, 5505.944940550623, 5880.176775251468, 5940.435658612425, 6003.759849606055, 6004.0, 6031.24609423822, 5748.626339288016, 5818.330891947396, 5820.563457740686, 5831.88336233273, 5854.8536286592325, 5832.737526811304, 5879.706014699248, 5886.411358864079, 5886.58793884424, 5892.263467066617, 5672.546196304285, 5828.854278643068, 5836.095405212199, 5836.416358364129, 5837.124431335249, 5741.8564535886935, 5758.3665796762325, 5761.337446193741, 5776.971115144482, 5822.243108395882, 4382.101669157815, 4405.801738921692, 4419.315006174048, 4421.0, 4446.73319600825, 3989.082511022481, 3998.280309544252, 4006.579309172553, 4011.338129208706, 4029.1135950090934, 5471.671699698031, 5498.092814685612, 5535.861603459865, 5540.861478463071, 5554.50009499147, 5887.852803679943, 5899.0, 5908.172855800191, 5911.556633252523, 5916.645001299936, 5392.649477783932, 5476.0, 5534.557235421237, 5536.0, 5542.750576223999, 4954.133026720309, 4993.226049962262, 4997.650164488451, 5017.3226614406585, 5031.421386540522, 5937.881242375129, 5993.370696076936, 5999.550033747487, 6011.669358185254, 6012.458878700938, 5783.132530120515, 5814.796482123105, 5830.912536311958, 5839.620424672383, 5901.439363260483, 6100.23747031621, 6106.0, 6107.633541987495, 6108.205933228652, 6109.816705498843, 5798.478136967693, 5830.096335068071, 5846.356900741001, 5847.181394604674, 5847.26909136358, 5757.36668966405, 5875.676837773964, 5899.734511946886, 5948.762049517971, 5966.254218222723, 5729.427057294237, 5731.455511726379, 5734.340550836707, 5738.655680659173, 5751.913721294268, 5716.857078573069, 5728.914066289092, 5730.255066841284, 5735.11105778605, 5737.713114344183, 5568.9443105568425, 5582.916256256241, 5584.246126772996, 5607.271054762855, 5668.291463567054, 5743.282089738783, 5763.769449222152, 5769.94230057694, 5775.133729940542, 5785.190073389813, 5627.352854421794, 5647.7176141193595, 5647.943520564741, 5650.3219613646625, 5654.236678048411], "unit": "score", "name": "dojo.html", "value": 5398.82071288433}, {"lowerIsBetter": false, "replicates": [562.356102262909, 570.9857253568657, 575.7296674365566, 626.5551458464487, 634.546299395932, 38183.42724859126, 38343.61656383435, 38430.42354364683, 38466.0, 38512.807435962815, 42690.57309426905, 43454.34818477726, 43491.34762978558, 43512.78243608778, 43534.78232608832, 8966.193042626179, 9158.267338612895, 9160.038195989426, 9168.633254669838, 9173.58718857653, 8998.235150012224, 9133.132352426543, 9139.95430022849, 9142.085791420837, 9146.908530914672, 9232.723018309462, 9339.533023348838, 9340.766480838, 9341.579628916716, 9345.626174953028, 9132.771680708001, 9321.300902432276, 9326.1606455419, 9329.346945713734, 9336.299777516713, 9068.954655226682, 9193.54032298389, 9193.816123677556, 9206.631734730603, 9207.539623018889, 42597.361039584124, 43032.569674303486, 43084.35373469401, 43101.0, 43106.13787724228, 2725.7274272572586, 3753.5871054184017, 3826.540815102178, 4093.079057212133, 4235.53409124996, 28304.71695283062, 28941.0, 29726.0, 34307.14232144217, 34537.827310863286, 3960.940585891214, 3980.44273801668, 4044.4539987101953, 4094.7747873866924, 4204.11713540157, 319488.0, 320408.0, 323270.0, 323631.0, 324184.0, 63481.0, 71247.64376178086, 71347.0, 71744.0, 72477.2752272481, 62752.0, 62874.0, 62944.0, 63236.367636323965, 63244.68377658082, 17915.820841791676, 18077.909610452127, 18119.094045297683, 18120.456386308433, 18128.365507207447, 13669.589912302647, 13837.0, 13840.100393474593, 13845.930770346084, 13853.099548529313, 22530.662040069084, 22873.428164296027, 22929.0, 22972.885135574215, 22974.0, 8853.15894989975, 8974.37179397449, 9023.954880225558, 9066.22937050345, 9145.0, 1030.0677886512717, 1055.8627378440754, 1086.179934149712, 1146.7247860513417, 1207.885250901163, 29118.854405727834, 29451.705482945326, 29921.0, 30024.0, 30797.384052318826, 1127.4419162514444, 1158.6697791129488, 1164.4177911044478, 1207.2997661356392, 1238.907081968856, 15102.244887755569, 15196.316165772345, 15245.390184392721, 15751.0, 15760.605984850241, 375398.0, 375749.0, 378138.0, 379859.0, 380732.0, 55937.72031139818, 56656.15015774767, 56733.71633141808, 56840.0, 56856.71571642115, 1352.0468070010618, 1493.6415260337658, 1504.8043754311868, 1509.2076659753718, 1516.7497362935212, 27544.17367478979, 27628.861855690593, 27645.0, 28117.71882281151, 28177.718222817508, 41983.160336793706, 50139.74930125472, 50929.490705092474, 50977.745111274206, 50985.74507127589, 265954.0, 267789.0, 267924.0, 269816.2073517037, 270396.0, 41146.38280425856, 45316.0, 46092.53907461017, 46103.308450373945, 51824.0, 47772.761136194094, 48271.27593086177, 48918.75540622274, 49141.2628810561, 49478.75260623674, 41846.0, 43606.12787744291, 43748.34377484404, 44163.337549937416, 45064.54935450604, 38744.80627596844, 39267.41098883576, 39868.60131398649, 40204.79897600493, 40628.79685601553, 40094.0, 40868.0, 40938.385924211754, 41110.794446027576, 41399.37900931428, 36101.81949090238, 37193.81403092967, 37523.0, 37990.0, 38076.04809879775, 28444.57333139963, 28551.0, 28565.571516427684, 28858.567121492775, 28885.27786805347], "unit": "score", "name": "ext.html", "value": 20287.2694742308}, {"lowerIsBetter": false, "replicates": [381.2984109239001, 382.1287464580755, 384.3178358413816, 391.1180288449546, 392.7820059866773, 17597.47207583773, 18271.817281827196, 18769.436916892515, 18773.81226187736, 18816.71774923374, 13530.120542164752, 17389.913050434763, 17927.0, 17932.462026139205, 17944.192511336987, 5146.871328216796, 5335.67985920846, 5376.435474275204, 5378.0, 5379.596530260226, 3929.685625149981, 5593.888122237553, 5800.1299805029375, 5824.621399609033, 5829.446202610767, 5808.157817116516, 5810.912836307459, 5815.9531284368795, 5828.0675091985295, 5828.0675091985295, 6554.639494827783, 6771.882639364499, 6783.660816959133, 6786.457083433338, 6802.761903333384, 4527.139843429771, 6599.10912026875, 6808.761693340709, 6816.386525212754, 6819.318068193191, 23274.418139546477, 23293.417664558354, 23554.0, 23598.174063907853, 23737.0, 2341.519988402373, 2546.8853901574475, 2564.846109233452, 2690.5560582503863, 3197.728193103589, 14121.223332716696, 14739.484118055923, 15254.0, 15302.234888255543, 15382.461613843574, 2146.570685862818, 2174.08688350893, 2191.934241972743, 2211.657193135067, 2254.9098036078535, 74409.0, 76065.0, 76682.61658691782, 76774.0, 78201.0, 16329.0, 17174.91412542929, 17198.0, 17200.827991720173, 17222.655546888993, 26937.595936060974, 26982.865085674446, 27071.0, 27273.454530909272, 27307.590386144224, 10096.495175241209, 10455.581776728997, 10460.0, 10476.842847357295, 10577.201875681152, 8845.734627961043, 8850.601722922484, 8856.202941735146, 8982.0, 9206.26349892007, 8466.111058338909, 8524.829503410021, 8641.438306510057, 8664.0, 8676.8698469523, 2845.416689578673, 3285.6221534523834, 3318.36950979318, 3368.545246391755, 3433.3648275068695, 919.1681528216974, 939.3049143633662, 956.866038754561, 984.8818141823027, 1000.3147843726924, 16051.835508121687, 17145.314187432363, 17209.7418538722, 17511.124443778015, 17947.551311217325, 942.2273735536932, 953.413650604873, 968.3802366485455, 1044.1646682653848, 1047.1727335405096, 9679.612815487302, 10005.549750261256, 10034.0, 10053.798924021625, 10187.337823041627, 451771.0, 452826.0, 457303.0, 459530.0, 463047.0, 73983.63008184925, 75739.0, 75951.0, 76394.61802691063, 77951.0, 1022.3508072374096, 1026.1893104447552, 1033.9379637221791, 1036.76154484469, 1051.3271506236167, 15493.380264789734, 15826.36694532252, 16044.197790110215, 16045.919770401073, 16081.19594020271, 33693.15767105842, 34241.828790855885, 34580.308393832485, 34623.65376346204, 35522.28955420929, 47475.28787068266, 49345.25982110343, 49458.505414945386, 49667.0, 49679.75160124176, 8651.091635378447, 8796.692115775917, 8900.955495222483, 8909.777255568662, 9018.774530636787, 10068.0, 12934.805977910151, 13216.339183041002, 13290.86709132935, 13338.26639534835, 11155.163362747664, 11413.258138220988, 11548.191626586058, 11681.0, 11941.82087268709, 8713.607887644945, 11340.94329528347, 11374.886251137383, 11550.422478876191, 11730.926582529635, 11709.824352634547, 11845.644630661094, 11889.940550297193, 11957.760844782882, 12047.879521204675, 8563.186497282748, 8564.48613083217, 8695.826083478169, 8705.738827835175, 8761.649534018823, 11523.942380288045, 11640.301581905112, 11672.358020308964, 11691.0, 11703.824442633197], "unit": "score", "name": "jquery.html", "value": 9771.683690596423}, {"lowerIsBetter": false, "replicates": [1486.4723023326712, 1604.8876578639497, 1627.0806994048367, 1895.4695481532153, 1999.8900060496667, 8286.585670716462, 8467.872981905277, 8474.703385381514, 8479.0, 8483.957580212105, 8405.41162118652, 8552.91447085529, 8581.485110893334, 8587.270082043035, 8595.570221488932, 2170.6635471501863, 2216.1910902520626, 2465.778079972802, 2513.258588716324, 2541.4281786598053, 2518.534071196825, 2523.255639586317, 2525.911593094242, 2527.5703130467864, 2534.3157347516158, 2283.0867652938873, 2288.599495088361, 2303.5738388398117, 2326.5230627721276, 2334.089705015037, 2424.127314166916, 2472.8516289022627, 2473.134402958968, 2474.0722229163885, 2476.2076135636603, 2433.8904749286326, 2452.4849781545895, 2458.729539750626, 2459.4220358215807, 2460.3603063203695, 8768.517731524764, 8794.208521233055, 8845.646174153091, 8847.115288471166, 8877.955610221972, 5237.528622423962, 5357.705326207057, 5405.702686352249, 5407.3781515125875, 5412.891742165135, 3366.848491817874, 3367.8316084195935, 3421.863125474978, 3429.176997520602, 3445.3626079175183, 1018.4093225929017, 1066.6053560182704, 1069.9411532365716, 1076.7308172956762, 1082.978340433187, 12121.878781212163, 12137.696557586043, 12179.695507612292, 12182.51269949201, 12204.084693648012, 4831.806727730922, 4864.391951006124, 4876.975615121973, 4912.656114072052, 4921.237208232729, 10295.691129266133, 10305.896941030644, 10308.123809476128, 10320.48397580118, 10328.845067323997, 5381.54256888161, 5391.487808658171, 5412.810551630674, 5431.103867861759, 5431.972840135774, 4349.739015659071, 4775.044991001813, 4877.170880950247, 4915.36100306965, 4932.161532539477, 3961.861334853324, 4006.959930400659, 4019.618136277049, 4064.4106604542176, 4076.735012224255, 1282.1409655530817, 1288.1755676367131, 1291.0510774580675, 1313.507434711983, 1323.6293837725452, 1483.8219413670429, 1488.776683497484, 1488.880889528835, 1511.0329389190927, 1527.2821773766311, 8322.042965058974, 8504.44721093127, 8511.531865747444, 8534.487930724052, 8565.10066443027, 528.4900071431088, 535.0609680011555, 562.1932526824021, 566.0999011571621, 566.6826577116746, 6239.625622462667, 6255.937440625536, 6265.4361107500545, 6316.2736285326855, 6318.336574659686, 10666.520006599721, 10883.401412922365, 10981.17641176915, 11018.559257629766, 11074.889251107386, 10545.789084218273, 10735.302205356627, 10874.02133807961, 10876.72808179786, 11009.2843965142, 8124.268815806606, 8148.918510814935, 8190.918090819135, 8226.465279756796, 8281.337493000545, 7997.600119993861, 8049.27556519916, 8086.312663423675, 8090.757277281691, 8135.227153420416, 9503.66737164196, 9567.808643826946, 9601.711948641552, 9707.951460242653, 9771.609135634495, 9689.70930872075, 9914.900850991686, 10030.147437467896, 10220.897791021995, 10233.334833235816, 6668.199816022108, 7531.209223031503, 7730.497517661334, 7765.107012693386, 7781.455298129076, 8431.578421079044, 8480.448770829877, 8519.06290308078, 8533.061363249913, 8552.444091134304, 7537.9623101884135, 7747.92252077472, 7777.261160189773, 7825.726099586487, 7843.490173138728, 7462.403007759474, 7492.175860655432, 7502.099748030271, 7585.772426827204, 7595.620218988918, 7984.640691169027, 8009.399295052778, 8045.436819422584, 8053.114157442559, 8062.274395304451, 7066.258042905421, 7228.783136505913, 7241.746538871325, 7244.89132663, 7287.052683151156, 7346.816329591803, 7353.374963128194, 7384.667689953858, 7384.966104745233, 7404.925950740424], "unit": "score", "name": "mootools.html", "value": 4914.452560169516}, {"lowerIsBetter": false, "replicates": [354.64535464535464, 362.7569528415961, 363.38587786640574, 365.327796853789, 373.9906502337443, 5982.551308651847, 5985.461308482236, 5989.4010598940085, 5992.490638295744, 6002.159697642333, 6002.969985150079, 6006.249218847644, 6013.699315034252, 6013.969930150354, 6021.187139736135, 4509.030558429937, 4610.331501932218, 4657.161710892038, 4699.459562150345, 4745.501722319159, 4701.43582770068, 4710.5289471052965, 4757.881052973668, 4758.072175925696, 4792.137415265268, 4719.882002949937, 4722.693024953367, 4726.550977657117, 4731.881702957437, 4733.763311834412, 4486.506484286726, 4591.081783643268, 4704.1767690654, 4716.292556116576, 4724.984128412408, 4195.790210489463, 4196.664266858644, 4196.748195108273, 4200.768957707325, 4207.03238255203, 5708.80019199326, 5738.885222295531, 5750.856228594319, 5753.913691294592, 5761.654300741969, 5473.261109750172, 5476.507114359687, 5478.0, 5486.423925487846, 5496.532794712454, 6339.968300158515, 6353.618782873043, 6361.300256971729, 6363.427291543783, 6368.936310636881, 4370.0, 4534.909301813946, 4549.294859296781, 4549.681522293441, 4622.884427889296, 6579.0, 6623.768168114093, 6648.102506161655, 6650.767223147167, 6653.0, 4638.165130276515, 4661.091087238024, 4663.626909847204, 4666.230072038075, 4667.346571479996, 4719.10337035962, 4724.126036683225, 4729.976350118227, 4730.95269047312, 4731.053789242165, 5392.164214546751, 5405.459454054641, 5411.594130440154, 5416.593755468356, 5423.674579525241, 6275.717592708339, 6404.807855764335, 6409.807705768834, 6413.166288382574, 6442.6778661066755, 1631.7226071567861, 1636.7135751243484, 1640.3520609359236, 1642.1624971264503, 1643.005981381271, 1073.3023534702506, 1075.5536452372335, 1117.1174771930246, 1124.7413094988199, 1147.3804145761362, 6082.60463069899, 6091.8477038073515, 6097.115918191837, 6097.969510152421, 6098.359672234352, 6460.773872914426, 6556.541042127101, 6569.835754106186, 6571.2771595124495, 6575.112359831457, 6184.412480814315, 6196.3803619638575, 6210.347913469111, 6212.316645169028, 6220.129181914535, 3511.8595256189465, 3549.0949807798847, 3549.982250088733, 3551.8756843510355, 3553.697935675445, 6591.769288074895, 6807.523473356917, 6811.386975172259, 6826.829329266808, 6828.556143850634, 6693.698783554752, 6715.832104197434, 6736.6631668416385, 6739.797806065826, 6740.696668649923, 6793.830154246085, 6805.149356330458, 6825.624590647462, 6881.10545629075, 6885.0, 6544.640044797582, 6552.705128269335, 6561.0, 6564.048213008991, 6577.868442631025, 6337.524685648503, 6468.1889071058295, 6471.126397936218, 6480.157579514633, 6486.772962946275, 6750.966245168743, 6787.898181527183, 6792.592444453348, 6794.082798822294, 6796.388325050571, 4674.275487299474, 4680.508546602694, 4683.274092515666, 4684.203685373563, 4687.156311863897, 6557.770478033246, 6563.803085907431, 6581.769638062645, 6588.901166482602, 6589.0, 6194.287656919331, 6345.206849143857, 6358.841028974312, 6363.904541431974, 6383.36166383358, 6372.713227904663, 6396.744130234739, 6402.519811014099, 6402.903956440564, 6404.391582799627, 6291.213598300213, 6292.465140463112, 6297.811065668037, 6303.905441418291, 6304.747810087545, 6412.583182093149, 6414.262359828679, 6418.101465794699, 6421.903671445026, 6424.229092508929, 6087.330393656605, 6222.688865556614, 6234.532410069353, 6268.686565671789, 6304.05439184126], "unit": "score", "name": "prototype.html", "value": 4865.396394975601}, {"lowerIsBetter": false, "replicates": [813.7762115418263, 825.8719898415744, 852.7100785732852, 853.5220276645075, 943.6838659049216, 14411.135331880081, 15106.169160696158, 15227.923860380697, 15316.387344506207, 15330.233488325595, 14586.708265834677, 14621.342039608217, 14702.485413010547, 14761.92619036906, 14830.184339861304, 788.3456730913329, 906.7234493479486, 937.77024628966, 939.6194541210821, 940.2008292951006, 930.0467021303151, 930.6370515498961, 937.1799675284126, 938.5729493080667, 949.6913503111516, 818.607068607069, 983.9950800246024, 989.1196834817018, 990.7275499237695, 1007.6876168387823, 932.6176267730232, 933.1415098109755, 934.7149119518544, 935.443411170356, 987.9061489158519, 683.5112894280563, 683.6547543490556, 684.0560027162484, 701.2111374703459, 730.9890351644676, 15210.16344101074, 15234.923825380802, 15251.23743812805, 15272.694546109127, 15278.694426111526, 14041.1575305482, 14056.367463464168, 14245.78631320531, 14765.409383624643, 14824.0, 11697.532098716041, 11716.70708232301, 11756.235844670155, 11793.23343982647, 11854.525818967231, 3941.2314598653275, 3959.4456776051375, 3985.621365970228, 4060.5330387005283, 4106.014556506447, 52260.0, 52279.47720522822, 52367.47632523664, 52629.7368513155, 52725.472745272826, 11402.771944561062, 11519.596814111466, 11554.306741595532, 11628.127890408254, 11811.763764724657, 20897.477563061046, 20926.895365523076, 20937.47656308574, 21003.894980525, 21022.894885525475, 8256.0, 8288.254057134765, 8383.371247156487, 8588.828223435496, 8888.37781355312, 4734.804007295062, 4814.301926220678, 4819.084373968934, 4928.827491037797, 4961.107000739829, 3487.5466189395215, 3516.771409858351, 3517.9824100879846, 3521.454174602941, 3538.4161613333513, 676.1109141478939, 738.7968308715147, 739.4195556488131, 755.5617741709796, 771.2172145272552, 626.9404406581459, 704.8202708309349, 743.4238465189521, 744.988825167623, 747.1221314954906, 9117.817643647222, 9138.497382643885, 9229.676961306322, 9310.208632266333, 9409.200217981548, 654.7806484827636, 690.002945743396, 690.4683393786756, 735.3051366458752, 751.4927423988786, 4249.150169966019, 4446.0, 4494.797734101973, 4528.026474307973, 4536.070105628404, 60404.39595603988, 60536.394636053075, 60664.69667651634, 60750.0, 66790.33209667841, 54357.0, 54473.72763136159, 55054.72472637691, 55306.72346638241, 55501.722491387285, 47255.763721181174, 47588.28617570739, 48130.75934620304, 48408.27387589189, 48589.514104859205, 9411.152996230372, 9605.47169905634, 9620.71137865865, 9635.277354198603, 9669.178119859891, 36048.0, 36332.27335453329, 36505.0, 37638.0, 38433.615663843004, 50173.0, 50273.24590131078, 51765.22352164796, 51868.74065629799, 51942.74028629833, 12281.69295767613, 12319.44562494672, 12420.441080151595, 12513.311767852856, 12775.36123193818, 13567.59297221085, 13626.046176767532, 13676.658083547592, 13756.0, 14401.855981440052, 12752.936235319135, 13279.80080298777, 13622.114562553403, 13762.0, 13802.309884505936, 12841.23518558108, 12945.611631651065, 13231.139975901535, 13252.271125088213, 13463.0, 11336.319820810448, 11686.766264674829, 13059.738805224033, 13110.475580976654, 13196.868031319564, 10795.6221532246, 10879.673609791718, 10932.836007459735, 11058.889411106107, 11186.496607652512, 10516.956182661112, 10684.893151068702, 10790.946045269724, 11005.229633925868, 11022.228444008842], "unit": "score", "name": "yui.html", "value": 7078.059377604661}], "name": "dromaeo_css", "value": 7522.110755147711}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 103.0, 108.0, 111.0, 111.0, 98.0, 109.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [149.0, 128.0, 157.0, 167.0, 132.0, 156.0, 155.0, 127.0, 170.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 161.0, 163.0, 162.0, 162.0, 164.0, 163.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 76.0, 160.0, 76.0, 75.0, 73.0, 74.0, 158.0, 74.0], "unit": "score", "name": "audio-fft", "value": 91.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 150.0, 95.0, 92.0, 93.0, 143.0, 92.0, 93.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.3}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 145.0, 145.0, 145.0, 146.0, 144.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 54.0, 54.0, 56.0, 56.0, 55.0, 64.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.4}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 78.0, 78.0, 77.0, 77.0, 76.0, 77.0, 85.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.2}, {"lowerIsBetter": true, "replicates": [110.0, 113.0, 112.0, 109.0, 113.0, 111.0, 116.0, 110.0, 110.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.7}, {"lowerIsBetter": true, "replicates": [143.0, 140.0, 151.0, 144.0, 144.0, 135.0, 145.0, 146.0, 150.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 65.0, 65.0, 65.0, 67.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1495.4}]} 19:02:58 INFO - Return code: 0 19:02:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:02:58 INFO - # TBPL SUCCESS # 19:02:58 INFO - Running post-action listener: _resource_record_post_action 19:02:58 INFO - Running post-run listener: _resource_record_post_run 19:02:59 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 318267392; Read time: 0; Write time: 219296 19:02:59 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 75943936; Read time: 0; Write time: 62052 19:02:59 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 242323456; Read time: 0; Write time: 157244 19:02:59 INFO - Running post-run listener: _upload_blobber_files 19:02:59 INFO - Blob upload gear active. 19:02:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:02:59 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:02:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:02:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:03:00 INFO - (blobuploader) - INFO - Open directory for files ... 19:03:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:03:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:03:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:01 INFO - (blobuploader) - INFO - Done attempting. 19:03:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:03:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:03:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:02 INFO - (blobuploader) - INFO - Done attempting. 19:03:02 INFO - (blobuploader) - INFO - Iteration through files over. 19:03:02 INFO - Return code: 0 19:03:02 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:03:02 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:03:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08b367b1beadb8ae0b9c3a12c7107a0a3f932c891ffaed0aa7f339e215189826500e1d312b495c7e2befd092d60080113c8276ee24c81b4a0b845ad050b736ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8bf3ae6a8fdd1ff219a42f4e837d23bab06c9d9e64ef4b250e590e4c9f2c0d73bd7148d350a833da51f86b5431bad07c93abb862938a4b4fc0cd7a841effbed0"} 19:03:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:03:02 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:03:02 INFO - Contents: 19:03:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08b367b1beadb8ae0b9c3a12c7107a0a3f932c891ffaed0aa7f339e215189826500e1d312b495c7e2befd092d60080113c8276ee24c81b4a0b845ad050b736ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8bf3ae6a8fdd1ff219a42f4e837d23bab06c9d9e64ef4b250e590e4c9f2c0d73bd7148d350a833da51f86b5431bad07c93abb862938a4b4fc0cd7a841effbed0"} 19:03:02 INFO - Running post-run listener: copy_logs_to_upload_dir 19:03:02 INFO - Copying logs to upload dir... 19:03:02 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:03:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.923860 ========= master_lag: 60.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2016-03-28 19:04:01.820954) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 19:04:01.822043) ========= 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=1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08b367b1beadb8ae0b9c3a12c7107a0a3f932c891ffaed0aa7f339e215189826500e1d312b495c7e2befd092d60080113c8276ee24c81b4a0b845ad050b736ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8bf3ae6a8fdd1ff219a42f4e837d23bab06c9d9e64ef4b250e590e4c9f2c0d73bd7148d350a833da51f86b5431bad07c93abb862938a4b4fc0cd7a841effbed0"} build_url:https://queue.taskcluster.net/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011458 build_url: 'https://queue.taskcluster.net/v1/task/D1Zj0upITl6qSfLuTy9bwg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08b367b1beadb8ae0b9c3a12c7107a0a3f932c891ffaed0aa7f339e215189826500e1d312b495c7e2befd092d60080113c8276ee24c81b4a0b845ad050b736ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8bf3ae6a8fdd1ff219a42f4e837d23bab06c9d9e64ef4b250e590e4c9f2c0d73bd7148d350a833da51f86b5431bad07c93abb862938a4b4fc0cd7a841effbed0"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 19:04:01.873895) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 21 secs) (at 2016-03-28 19:04:01.874202) ========= 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=1f5564757af27664ca02d71f000001b0-1459212381.168492-435401413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 21.59 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 21 secs) (at 2016-03-28 19:04:23.472387) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 19:04:23.475752) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 19:04:23.648645) ========= ========= Total master_lag: 81.89 =========