builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1460495235.85 results: success (0) buildid: 20160412113030 builduid: 91be027e6fff4fb6a067484edc1c38d8 revision: 8f675b36081a924282dfb4d1d156e06736657f1a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:15.854488) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:15.855261) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:15.855622) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004380 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:15.897002) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:15.897342) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:15.932608) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:15.933315) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016388 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:15.985757) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:15.986479) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:15.987401) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:15.988103) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-12 14:07:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 97.3M=0s 2016-04-12 14:07:16 (97.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.256634 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:16.261063) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:16.261433) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.135312 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:16.411608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:16.412482) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8f675b36081a924282dfb4d1d156e06736657f1a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8f675b36081a924282dfb4d1d156e06736657f1a --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=7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-12 14:07:16,480 truncating revision to first 12 chars 2016-04-12 14:07:16,480 Setting DEBUG logging. 2016-04-12 14:07:16,480 attempt 1/10 2016-04-12 14:07:16,480 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8f675b36081a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 14:07:16,737 unpacking tar archive at: fx-team-8f675b36081a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543914 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:16.973706) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:16.974554) ========= echo 8f675b36081a924282dfb4d1d156e06736657f1a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8f675b36081a924282dfb4d1d156e06736657f1a'] 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=7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8f675b36081a924282dfb4d1d156e06736657f1a program finished with exit code 0 elapsedTime=0.004609 script_repo_revision: '8f675b36081a924282dfb4d1d156e06736657f1a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:17.030721) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:17.031337) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 14:07:17.042797) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2016-04-12 14:07:17.043142) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:07:17 INFO - MultiFileLogger online at 20160412 14:07:17 in /builds/slave/test-pgo 14:07:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:07:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:07:17 INFO - {'append_to_log': False, 14:07:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:07:17 INFO - 'blob_upload_branch': 'Fx-Team', 14:07:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:07:17 INFO - 'branch': 'Fx-Team', 14:07:17 INFO - 'buildbot_json_path': 'buildprops.json', 14:07:17 INFO - 'config_files': ('talos/linux_config.py',), 14:07:17 INFO - 'default_actions': ('clobber', 14:07:17 INFO - 'read-buildbot-config', 14:07:17 INFO - 'download-and-extract', 14:07:17 INFO - 'populate-webroot', 14:07:17 INFO - 'create-virtualenv', 14:07:17 INFO - 'install', 14:07:17 INFO - 'run-tests'), 14:07:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:07:17 INFO - 'download_minidump_stackwalk': True, 14:07:17 INFO - 'download_symbols': 'ondemand', 14:07:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:07:17 INFO - 'tooltool.py': '/tools/tooltool.py', 14:07:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:07:17 INFO - '/tools/misc-python/virtualenv.py')}, 14:07:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:07:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:07:17 INFO - 'installer_path': 'installer.exe', 14:07:17 INFO - 'log_level': 'info', 14:07:17 INFO - 'log_name': 'talos', 14:07:17 INFO - 'log_to_console': True, 14:07:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:07:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:07:17 INFO - 'opt_config_files': (), 14:07:17 INFO - 'pip_index': False, 14:07:17 INFO - 'sps_profile': False, 14:07:17 INFO - 'sps_profile_interval': 0, 14:07:17 INFO - 'suite': 'dromaeojs-e10s', 14:07:17 INFO - 'system_bits': '32', 14:07:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:07:17 INFO - 'title': 'talos-linux64-ix-005', 14:07:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:07:17 INFO - 'use_talos_json': True, 14:07:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:07:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:07:17 INFO - 'work_dir': 'build'} 14:07:17 INFO - ##### 14:07:17 INFO - ##### Running clobber step. 14:07:17 INFO - ##### 14:07:17 INFO - Running pre-action listener: _resource_record_pre_action 14:07:17 INFO - Running main action method: clobber 14:07:17 INFO - rmtree: /builds/slave/test-pgo/build 14:07:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:07:21 INFO - Running post-action listener: _resource_record_post_action 14:07:21 INFO - ##### 14:07:21 INFO - ##### Running read-buildbot-config step. 14:07:21 INFO - ##### 14:07:21 INFO - Running pre-action listener: _resource_record_pre_action 14:07:21 INFO - Running main action method: read_buildbot_config 14:07:21 INFO - Using buildbot properties: 14:07:21 INFO - { 14:07:21 INFO - "project": "", 14:07:21 INFO - "product": "firefox", 14:07:21 INFO - "script_repo_revision": "production", 14:07:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:07:21 INFO - "repository": "", 14:07:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:07:21 INFO - "buildid": "20160412113030", 14:07:21 INFO - "pgo_build": "True", 14:07:21 INFO - "basedir": "/builds/slave/test-pgo", 14:07:21 INFO - "buildnumber": 386, 14:07:21 INFO - "slavename": "talos-linux64-ix-005", 14:07:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:07:21 INFO - "platform": "ubuntu64_hw", 14:07:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:07:21 INFO - "branch": "fx-team", 14:07:21 INFO - "repo_path": "integration/fx-team", 14:07:21 INFO - "revision": "8f675b36081a924282dfb4d1d156e06736657f1a", 14:07:21 INFO - "stage_platform": "linux64-pgo", 14:07:21 INFO - "builduid": "91be027e6fff4fb6a067484edc1c38d8", 14:07:21 INFO - "slavebuilddir": "test" 14:07:21 INFO - } 14:07:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:07:21 INFO - Running post-action listener: _resource_record_post_action 14:07:21 INFO - ##### 14:07:21 INFO - ##### Running download-and-extract step. 14:07:21 INFO - ##### 14:07:21 INFO - Running pre-action listener: _resource_record_pre_action 14:07:21 INFO - Running main action method: download_and_extract 14:07:21 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:21 INFO - https://queue.taskcluster.net/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:07:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:07:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:07:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:07:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:07:23 INFO - Downloaded 1361 bytes. 14:07:23 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:07:23 INFO - Using the following test package requirements: 14:07:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:07:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:07:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:07:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'jsshell-linux-x86_64.zip'], 14:07:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:07:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:07:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:07:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:07:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:07:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:07:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:23 INFO - https://queue.taskcluster.net/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:07:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:07:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:07:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:07:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:07:31 INFO - Downloaded 23764665 bytes. 14:07:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:07:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:07:32 INFO - Return code: 0 14:07:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:07:32 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')]} 14:07:32 INFO - https://queue.taskcluster.net/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:07:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:07:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:07:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:07:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:07:40 INFO - Downloaded 23764665 bytes. 14:07:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:07:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:07:41 INFO - Return code: 0 14:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:41 INFO - https://queue.taskcluster.net/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:07:43 INFO - Downloaded 10841076 bytes. 14:07:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:07:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 14:07:43 INFO - Return code: 0 14:07:43 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')]} 14:07:43 INFO - https://queue.taskcluster.net/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:07:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:07:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:07:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:08:15 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2: The read operation timed out 14:08:15 INFO - retry: attempt #1 caught exception: The read operation timed out 14:08:15 INFO - retry: Failed, sleeping 30 seconds before retrying 14:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #2 14:08:47 INFO - Downloaded 57839393 bytes. 14:08:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:08:47 INFO - mkdir: /builds/slave/test-pgo/properties 14:08:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:08:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:08:47 INFO - Contents: 14:08:47 INFO - build_url:https://queue.taskcluster.net/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:08:47 INFO - Running post-action listener: _resource_record_post_action 14:08:47 INFO - Running post-action listener: set_extra_try_arguments 14:08:47 INFO - ##### 14:08:47 INFO - ##### Running populate-webroot step. 14:08:47 INFO - ##### 14:08:47 INFO - Running pre-action listener: _resource_record_pre_action 14:08:47 INFO - Running main action method: populate_webroot 14:08:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:08:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:08:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:08:47 INFO - '--tppagecycles', 14:08:47 INFO - '7'], 14:08:47 INFO - 'tests': ['tsvgm']}}, 14:08:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:08:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:08:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:08:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:08:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:08:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:08:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:47 INFO - 'talos_options': ['--disable-e10s'], 14:08:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:47 INFO - 'talos_options': ['--disable-e10s'], 14:08:47 INFO - 'tests': ['damp', 'tps']}, 14:08:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:47 INFO - 'tests': ['damp', 'tps']}, 14:08:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:08:47 INFO - 'tests': ['dromaeo_dom']}, 14:08:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:08:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:08:47 INFO - 'tests': ['a11yr', 14:08:47 INFO - 'ts_paint', 14:08:47 INFO - 'tpaint', 14:08:47 INFO - 'sessionrestore', 14:08:47 INFO - 'sessionrestore_no_auto_restore', 14:08:47 INFO - 'tabpaint']}, 14:08:47 INFO - 'other-e10s': {'tests': ['a11yr', 14:08:47 INFO - 'ts_paint', 14:08:47 INFO - 'tpaint', 14:08:47 INFO - 'sessionrestore', 14:08:47 INFO - 'sessionrestore_no_auto_restore', 14:08:47 INFO - 'tabpaint']}, 14:08:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:08:47 INFO - 'ts_paint', 14:08:47 INFO - 'tpaint', 14:08:47 INFO - 'sessionrestore', 14:08:47 INFO - 'sessionrestore_no_auto_restore', 14:08:47 INFO - 'tabpaint']}, 14:08:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:08:47 INFO - 'ts_paint', 14:08:47 INFO - 'tpaint', 14:08:47 INFO - 'sessionrestore', 14:08:47 INFO - 'sessionrestore_no_auto_restore', 14:08:47 INFO - 'tabpaint']}, 14:08:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:08:47 INFO - 'tests': ['a11yr', 14:08:47 INFO - 'ts_paint', 14:08:47 INFO - 'tpaint', 14:08:47 INFO - 'sessionrestore', 14:08:47 INFO - 'sessionrestore_no_auto_restore', 14:08:47 INFO - 'tabpaint']}, 14:08:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:08:47 INFO - 'tests': ['a11yr', 14:08:47 INFO - 'ts_paint', 14:08:47 INFO - 'tpaint', 14:08:47 INFO - 'sessionrestore', 14:08:47 INFO - 'sessionrestore_no_auto_restore', 14:08:47 INFO - 'tabpaint']}, 14:08:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:08:47 INFO - 'tests': ['tsvgx', 14:08:47 INFO - 'tsvgr_opacity', 14:08:47 INFO - 'tart', 14:08:47 INFO - 'tscrollx', 14:08:47 INFO - 'cart']}, 14:08:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:08:47 INFO - 'tsvgr_opacity', 14:08:47 INFO - 'tart', 14:08:47 INFO - 'tscrollx', 14:08:47 INFO - 'cart']}, 14:08:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:47 INFO - 'talos_options': ['--disable-e10s'], 14:08:47 INFO - 'tests': ['tp5o']}, 14:08:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:47 INFO - 'tests': ['tp5o']}, 14:08:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:47 INFO - 'talos_options': ['--disable-e10s', 14:08:47 INFO - '--xperf_path', 14:08:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:47 INFO - 'tests': ['tp5n']}, 14:08:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:47 INFO - 'talos_options': ['--xperf_path', 14:08:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:47 INFO - 'tests': ['tp5n']}}, 14:08:47 INFO - 'talos.zip': {'path': '', 14:08:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:08:47 INFO - Running post-action listener: _resource_record_post_action 14:08:47 INFO - ##### 14:08:47 INFO - ##### Running create-virtualenv step. 14:08:47 INFO - ##### 14:08:47 INFO - Running pre-action listener: _resource_record_pre_action 14:08:47 INFO - Running main action method: create_virtualenv 14:08:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:08:47 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 14:08:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:08:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:08:48 INFO - Using real prefix '/usr' 14:08:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:08:48 INFO - Installing distribute.............................................................................................................................................................................................done. 14:08:50 INFO - Installing pip.................done. 14:08:50 INFO - Return code: 0 14:08:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:08:50 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')]} 14:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:50 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')]} 14:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:50 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 0x7ff0086f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e58b0>, '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 0x15e67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6c60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', '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 14:08:50 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 14:08:50 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 14:08:50 INFO - Using env: {'DISPLAY': ':0', 14:08:50 INFO - 'HOME': '/home/cltbld', 14:08:50 INFO - 'LANG': 'en_US.UTF-8', 14:08:50 INFO - 'LANGUAGE': 'en_US:en', 14:08:50 INFO - 'LOGNAME': 'cltbld', 14:08:50 INFO - 'MAIL': '/var/mail/cltbld', 14:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:50 INFO - 'MOZ_NO_REMOTE': '1', 14:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:50 INFO - 'NO_EM_RESTART': '1', 14:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:08:50 INFO - 'PWD': '/builds/slave/test-pgo', 14:08:50 INFO - 'SHELL': '/bin/bash', 14:08:50 INFO - 'SHLVL': '1', 14:08:50 INFO - 'TERM': 'linux', 14:08:50 INFO - 'TMOUT': '86400', 14:08:50 INFO - 'USER': 'cltbld', 14:08:50 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', 14:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:50 INFO - '_': '/tools/buildbot/bin/python'} 14:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:51 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 14:08:51 INFO - Cleaning up... 14:08:51 INFO - Return code: 0 14:08:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff0086f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e58b0>, '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 0x15e67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6c60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', '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 14:08:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:08:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:08:51 INFO - Using env: {'DISPLAY': ':0', 14:08:51 INFO - 'HOME': '/home/cltbld', 14:08:51 INFO - 'LANG': 'en_US.UTF-8', 14:08:51 INFO - 'LANGUAGE': 'en_US:en', 14:08:51 INFO - 'LOGNAME': 'cltbld', 14:08:51 INFO - 'MAIL': '/var/mail/cltbld', 14:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:51 INFO - 'MOZ_NO_REMOTE': '1', 14:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:51 INFO - 'NO_EM_RESTART': '1', 14:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:08:51 INFO - 'PWD': '/builds/slave/test-pgo', 14:08:51 INFO - 'SHELL': '/bin/bash', 14:08:51 INFO - 'SHLVL': '1', 14:08:51 INFO - 'TERM': 'linux', 14:08:51 INFO - 'TMOUT': '86400', 14:08:51 INFO - 'USER': 'cltbld', 14:08:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', 14:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:51 INFO - '_': '/tools/buildbot/bin/python'} 14:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:51 INFO - Downloading/unpacking psutil>=0.7.1 14:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:08:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:53 INFO - Installing collected packages: psutil 14:08:53 INFO - Running setup.py install for psutil 14:08:53 INFO - building 'psutil._psutil_linux' extension 14:08:53 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 14:08:54 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 14:08:54 INFO - building 'psutil._psutil_posix' extension 14:08:54 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 14:08:54 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 14:08:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:54 INFO - Successfully installed psutil 14:08:54 INFO - Cleaning up... 14:08:54 INFO - Return code: 0 14:08:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:54 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 0x7ff0086f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e58b0>, '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 0x15e67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6c60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', '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 14:08:54 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 14:08:54 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 14:08:54 INFO - Using env: {'DISPLAY': ':0', 14:08:54 INFO - 'HOME': '/home/cltbld', 14:08:54 INFO - 'LANG': 'en_US.UTF-8', 14:08:54 INFO - 'LANGUAGE': 'en_US:en', 14:08:54 INFO - 'LOGNAME': 'cltbld', 14:08:54 INFO - 'MAIL': '/var/mail/cltbld', 14:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:54 INFO - 'MOZ_NO_REMOTE': '1', 14:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:54 INFO - 'NO_EM_RESTART': '1', 14:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:08:54 INFO - 'PWD': '/builds/slave/test-pgo', 14:08:54 INFO - 'SHELL': '/bin/bash', 14:08:54 INFO - 'SHLVL': '1', 14:08:54 INFO - 'TERM': 'linux', 14:08:54 INFO - 'TMOUT': '86400', 14:08:54 INFO - 'USER': 'cltbld', 14:08:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', 14:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:54 INFO - '_': '/tools/buildbot/bin/python'} 14:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:08:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:08:56 INFO - Installing collected packages: mozsystemmonitor 14:08:56 INFO - Running setup.py install for mozsystemmonitor 14:08:56 INFO - Successfully installed mozsystemmonitor 14:08:56 INFO - Cleaning up... 14:08:57 INFO - Return code: 0 14:08:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:08:57 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')]} 14:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:57 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')]} 14:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:57 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 0x7ff0086f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e58b0>, '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 0x15e67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6c60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', '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 14:08:57 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 14:08:57 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 14:08:57 INFO - Using env: {'DISPLAY': ':0', 14:08:57 INFO - 'HOME': '/home/cltbld', 14:08:57 INFO - 'LANG': 'en_US.UTF-8', 14:08:57 INFO - 'LANGUAGE': 'en_US:en', 14:08:57 INFO - 'LOGNAME': 'cltbld', 14:08:57 INFO - 'MAIL': '/var/mail/cltbld', 14:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:57 INFO - 'MOZ_NO_REMOTE': '1', 14:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:57 INFO - 'NO_EM_RESTART': '1', 14:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:08:57 INFO - 'PWD': '/builds/slave/test-pgo', 14:08:57 INFO - 'SHELL': '/bin/bash', 14:08:57 INFO - 'SHLVL': '1', 14:08:57 INFO - 'TERM': 'linux', 14:08:57 INFO - 'TMOUT': '86400', 14:08:57 INFO - 'USER': 'cltbld', 14:08:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', 14:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:57 INFO - '_': '/tools/buildbot/bin/python'} 14:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:57 INFO - Downloading/unpacking blobuploader==1.2.4 14:08:57 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 14:08:57 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 14:08:57 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 14:08:57 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 14:08:57 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 14:08:57 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 14:08:59 INFO - Downloading blobuploader-1.2.4.tar.gz 14:08:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:08:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:08:59 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 14:08:59 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 14:08:59 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 14:08:59 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 14:08:59 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 14:08:59 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 14:08:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:08:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:08:59 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 14:08:59 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 14:08:59 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 14:08:59 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 14:08:59 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 14:08:59 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 14:08:59 INFO - Downloading docopt-0.6.1.tar.gz 14:08:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:08:59 INFO - Installing collected packages: blobuploader, requests, docopt 14:08:59 INFO - Running setup.py install for blobuploader 14:08:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:08:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:08:59 INFO - Running setup.py install for requests 14:09:00 INFO - Running setup.py install for docopt 14:09:00 INFO - Successfully installed blobuploader requests docopt 14:09:00 INFO - Cleaning up... 14:09:00 INFO - Return code: 0 14:09:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:00 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 0x7ff0086f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e58b0>, '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 0x15e67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6c60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', '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 14:09:00 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 14:09:00 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 14:09:00 INFO - Using env: {'DISPLAY': ':0', 14:09:00 INFO - 'HOME': '/home/cltbld', 14:09:00 INFO - 'LANG': 'en_US.UTF-8', 14:09:00 INFO - 'LANGUAGE': 'en_US:en', 14:09:00 INFO - 'LOGNAME': 'cltbld', 14:09:00 INFO - 'MAIL': '/var/mail/cltbld', 14:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:00 INFO - 'MOZ_NO_REMOTE': '1', 14:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:00 INFO - 'NO_EM_RESTART': '1', 14:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:00 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:00 INFO - 'SHELL': '/bin/bash', 14:09:00 INFO - 'SHLVL': '1', 14:09:00 INFO - 'TERM': 'linux', 14:09:00 INFO - 'TMOUT': '86400', 14:09:00 INFO - 'USER': 'cltbld', 14:09:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', 14:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:00 INFO - '_': '/tools/buildbot/bin/python'} 14:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:09:00 INFO - Running setup.py (path:/tmp/pip-vcvQoV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:09:00 INFO - Running setup.py (path:/tmp/pip-dtAKS4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:09:00 INFO - Running setup.py (path:/tmp/pip-792UAD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:09:00 INFO - Running setup.py (path:/tmp/pip-YU6BL7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:09:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:09:00 INFO - Running setup.py (path:/tmp/pip-kGU1KW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:09:01 INFO - Running setup.py (path:/tmp/pip-2HksFR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:09:01 INFO - Running setup.py (path:/tmp/pip-0yF5Vd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:09:01 INFO - Running setup.py (path:/tmp/pip-DXRv0w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:09:01 INFO - Running setup.py (path:/tmp/pip-dunQcR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:09:01 INFO - Running setup.py (path:/tmp/pip-MK0hx7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:09:01 INFO - Running setup.py (path:/tmp/pip-zk6Y0d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:09:01 INFO - Running setup.py (path:/tmp/pip-CIXfaQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:09:01 INFO - Running setup.py (path:/tmp/pip-TgfxT0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:09:01 INFO - Running setup.py (path:/tmp/pip-5V9Sqp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:09:01 INFO - Running setup.py (path:/tmp/pip-sxABew-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:09:01 INFO - Running setup.py (path:/tmp/pip-qFgQ95-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:09:01 INFO - Running setup.py (path:/tmp/pip-GN461X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:09:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:09:01 INFO - Running setup.py install for manifestparser 14:09:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:09:02 INFO - Running setup.py install for mozcrash 14:09:02 INFO - Running setup.py install for mozdebug 14:09:02 INFO - Running setup.py install for mozdevice 14:09:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:09:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:09:02 INFO - Running setup.py install for mozfile 14:09:02 INFO - Running setup.py install for mozhttpd 14:09:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:09:02 INFO - Running setup.py install for mozinfo 14:09:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:09:02 INFO - Running setup.py install for mozInstall 14:09:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:09:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:09:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:09:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:09:02 INFO - Running setup.py install for mozleak 14:09:02 INFO - Running setup.py install for mozlog 14:09:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:09:02 INFO - Running setup.py install for moznetwork 14:09:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:09:03 INFO - Running setup.py install for mozprocess 14:09:03 INFO - Running setup.py install for mozprofile 14:09:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:09:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:09:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:09:03 INFO - Running setup.py install for mozrunner 14:09:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:09:03 INFO - Running setup.py install for mozscreenshot 14:09:03 INFO - Running setup.py install for moztest 14:09:03 INFO - Running setup.py install for mozversion 14:09:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:09:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:09:03 INFO - Cleaning up... 14:09:03 INFO - Return code: 0 14:09:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:09: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')]} 14:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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/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 0x7ff0086f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e58b0>, '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 0x15e67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6c60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', '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 14:09:03 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 14:09:03 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 14:09:03 INFO - Using env: {'DISPLAY': ':0', 14:09:03 INFO - 'HOME': '/home/cltbld', 14:09:03 INFO - 'LANG': 'en_US.UTF-8', 14:09:03 INFO - 'LANGUAGE': 'en_US:en', 14:09:03 INFO - 'LOGNAME': 'cltbld', 14:09:03 INFO - 'MAIL': '/var/mail/cltbld', 14:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:03 INFO - 'MOZ_NO_REMOTE': '1', 14:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:03 INFO - 'NO_EM_RESTART': '1', 14:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:03 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:03 INFO - 'SHELL': '/bin/bash', 14:09:03 INFO - 'SHLVL': '1', 14:09:03 INFO - 'TERM': 'linux', 14:09:03 INFO - 'TMOUT': '86400', 14:09:03 INFO - 'USER': 'cltbld', 14:09:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', 14:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:03 INFO - '_': '/tools/buildbot/bin/python'} 14:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:09:03 INFO - Running setup.py (path:/tmp/pip-MpLkpD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:09:03 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)) 14:09:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:09:03 INFO - Running setup.py (path:/tmp/pip-0zn_0X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:09:04 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)) 14:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:09:04 INFO - Running setup.py (path:/tmp/pip-GTxgF7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:09:04 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)) 14:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:09:04 INFO - Running setup.py (path:/tmp/pip-baNvEl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:09:04 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)) 14:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:09:04 INFO - Running setup.py (path:/tmp/pip-dWnOod-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:09:04 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)) 14:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:09:04 INFO - Running setup.py (path:/tmp/pip-SO_gLs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:09:04 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)) 14:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:09:04 INFO - Running setup.py (path:/tmp/pip-DoCjZk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:09:04 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)) 14:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:09:04 INFO - Running setup.py (path:/tmp/pip-Rb3iCm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:09:04 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)) 14:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:09:04 INFO - Running setup.py (path:/tmp/pip-RYUGkx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:09:04 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)) 14:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:09:04 INFO - Running setup.py (path:/tmp/pip-RFg6Lu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:09:04 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)) 14:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:09:04 INFO - Running setup.py (path:/tmp/pip-cP3XMJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:09:04 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)) 14:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:09:04 INFO - Running setup.py (path:/tmp/pip-1j1D32-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:09:04 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)) 14:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:09:04 INFO - Running setup.py (path:/tmp/pip-uav3Y2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:09:04 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)) 14:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:09:04 INFO - Running setup.py (path:/tmp/pip-e0b1lL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:09:04 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)) 14:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:09:04 INFO - Running setup.py (path:/tmp/pip-MHWGPe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:09:04 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)) 14:09:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:09:04 INFO - Running setup.py (path:/tmp/pip-tfCyzM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:09:05 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)) 14:09:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:09:05 INFO - Running setup.py (path:/tmp/pip-1hdUOV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:09:05 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)) 14:09:05 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)) 14:09:05 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)) 14:09:05 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)) 14:09:05 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)) 14:09:05 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)) 14:09:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:07 INFO - Downloading blessings-1.6.tar.gz 14:09:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:09:07 INFO - Installing collected packages: blessings 14:09:07 INFO - Running setup.py install for blessings 14:09:07 INFO - Successfully installed blessings 14:09:07 INFO - Cleaning up... 14:09:07 INFO - Return code: 0 14:09:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:09:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:09:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:09:07 INFO - Reading from file tmpfile_stdout 14:09:07 INFO - Current package versions: 14:09:07 INFO - argparse == 1.2.1 14:09:07 INFO - blessings == 1.6 14:09:07 INFO - blobuploader == 1.2.4 14:09:07 INFO - docopt == 0.6.1 14:09:07 INFO - manifestparser == 1.1 14:09:07 INFO - mozInstall == 1.12 14:09:07 INFO - mozcrash == 0.17 14:09:07 INFO - mozdebug == 0.1 14:09:07 INFO - mozdevice == 0.48 14:09:07 INFO - mozfile == 1.2 14:09:07 INFO - mozhttpd == 0.7 14:09:07 INFO - mozinfo == 0.9 14:09:07 INFO - mozleak == 0.1 14:09:07 INFO - mozlog == 3.1 14:09:07 INFO - moznetwork == 0.27 14:09:07 INFO - mozprocess == 0.22 14:09:07 INFO - mozprofile == 0.28 14:09:07 INFO - mozrunner == 6.11 14:09:07 INFO - mozscreenshot == 0.1 14:09:07 INFO - mozsystemmonitor == 0.0 14:09:07 INFO - moztest == 0.7 14:09:07 INFO - mozversion == 1.4 14:09:07 INFO - psutil == 3.1.1 14:09:07 INFO - requests == 1.2.3 14:09:07 INFO - wsgiref == 0.1.2 14:09:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:09: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')]} 14:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:07 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 0x7ff0086f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e58b0>, '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 0x15e67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6c60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', '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 14:09:07 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 14:09:07 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 14:09:07 INFO - Using env: {'DISPLAY': ':0', 14:09:07 INFO - 'HOME': '/home/cltbld', 14:09:07 INFO - 'LANG': 'en_US.UTF-8', 14:09:07 INFO - 'LANGUAGE': 'en_US:en', 14:09:07 INFO - 'LOGNAME': 'cltbld', 14:09:07 INFO - 'MAIL': '/var/mail/cltbld', 14:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:07 INFO - 'MOZ_NO_REMOTE': '1', 14:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:07 INFO - 'NO_EM_RESTART': '1', 14:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:07 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:07 INFO - 'SHELL': '/bin/bash', 14:09:07 INFO - 'SHLVL': '1', 14:09:07 INFO - 'TERM': 'linux', 14:09:07 INFO - 'TMOUT': '86400', 14:09:07 INFO - 'USER': 'cltbld', 14:09:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', 14:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:07 INFO - '_': '/tools/buildbot/bin/python'} 14:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:07 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)) 14:09:07 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)) 14:09:07 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)) 14:09:07 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)) 14:09:07 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)) 14:09:07 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)) 14:09:07 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)) 14:09:07 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)) 14:09:07 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)) 14:09:07 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)) 14:09:07 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)) 14:09:07 INFO - Cleaning up... 14:09:07 INFO - Return code: 0 14:09:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:09: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')]} 14:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0086f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e58b0>, '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 0x15e67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6c60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', '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 14:09: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', 'jsonschema'] in /builds/slave/test-pgo/build 14:09: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 jsonschema 14:09:07 INFO - Using env: {'DISPLAY': ':0', 14:09:07 INFO - 'HOME': '/home/cltbld', 14:09:07 INFO - 'LANG': 'en_US.UTF-8', 14:09:07 INFO - 'LANGUAGE': 'en_US:en', 14:09:07 INFO - 'LOGNAME': 'cltbld', 14:09:07 INFO - 'MAIL': '/var/mail/cltbld', 14:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:07 INFO - 'MOZ_NO_REMOTE': '1', 14:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:07 INFO - 'NO_EM_RESTART': '1', 14:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:07 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:07 INFO - 'SHELL': '/bin/bash', 14:09:07 INFO - 'SHLVL': '1', 14:09:07 INFO - 'TERM': 'linux', 14:09:07 INFO - 'TMOUT': '86400', 14:09:07 INFO - 'USER': 'cltbld', 14:09:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', 14:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:07 INFO - '_': '/tools/buildbot/bin/python'} 14:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:07 INFO - Downloading/unpacking jsonschema 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:09:09 INFO - Downloading/unpacking functools32 (from jsonschema) 14:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:10 INFO - Downloading functools32-3.2.3-2.tar.gz 14:09:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:09:10 INFO - warning: no files found matching '*.txt' 14:09:10 INFO - no previously-included directories found matching 'build' 14:09:10 INFO - no previously-included directories found matching 'dist' 14:09:10 INFO - no previously-included directories found matching '.git*' 14:09:10 INFO - Installing collected packages: jsonschema, functools32 14:09:10 INFO - Running setup.py install for functools32 14:09:10 INFO - warning: no files found matching '*.txt' 14:09:10 INFO - no previously-included directories found matching 'build' 14:09:10 INFO - no previously-included directories found matching 'dist' 14:09:10 INFO - no previously-included directories found matching '.git*' 14:09:10 INFO - Successfully installed jsonschema functools32 14:09:10 INFO - Cleaning up... 14:09:10 INFO - Return code: 0 14:09:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0086f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e58b0>, '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 0x15e67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6c60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', '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 14:09:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:09:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:09:10 INFO - Using env: {'DISPLAY': ':0', 14:09:10 INFO - 'HOME': '/home/cltbld', 14:09:10 INFO - 'LANG': 'en_US.UTF-8', 14:09:10 INFO - 'LANGUAGE': 'en_US:en', 14:09:10 INFO - 'LOGNAME': 'cltbld', 14:09:10 INFO - 'MAIL': '/var/mail/cltbld', 14:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:10 INFO - 'MOZ_NO_REMOTE': '1', 14:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:10 INFO - 'NO_EM_RESTART': '1', 14:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:10 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:10 INFO - 'SHELL': '/bin/bash', 14:09:10 INFO - 'SHLVL': '1', 14:09:10 INFO - 'TERM': 'linux', 14:09:10 INFO - 'TMOUT': '86400', 14:09:10 INFO - 'USER': 'cltbld', 14:09:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', 14:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:10 INFO - '_': '/tools/buildbot/bin/python'} 14:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:10 INFO - Downloading/unpacking flake8 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:09:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:09:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:09:13 INFO - no previously-included directories found matching 'docs/_build' 14:09:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:09:13 INFO - Running setup.py install for pep8 14:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:09:13 INFO - no previously-included directories found matching 'docs/_build' 14:09:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:09:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:09:13 INFO - Cleaning up... 14:09:13 INFO - Return code: 0 14:09:13 INFO - Running post-action listener: _resource_record_post_action 14:09:13 INFO - Running post-action listener: _start_resource_monitoring 14:09:13 INFO - Starting resource monitoring. 14:09:13 INFO - ##### 14:09:13 INFO - ##### Running install step. 14:09:13 INFO - ##### 14:09:13 INFO - Running pre-action listener: _resource_record_pre_action 14:09:13 INFO - Running main action method: install 14:09:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:09:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:09:13 INFO - Reading from file tmpfile_stdout 14:09:13 INFO - Detecting whether we're running mozinstall >=1.0... 14:09:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:09:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:09:13 INFO - Reading from file tmpfile_stdout 14:09:13 INFO - Output received: 14:09:13 INFO - Usage: mozinstall [options] installer 14:09:13 INFO - Options: 14:09:13 INFO - -h, --help show this help message and exit 14:09:13 INFO - -d DEST, --destination=DEST 14:09:13 INFO - Directory to install application into. [default: 14:09:13 INFO - "/builds/slave/test-pgo"] 14:09:13 INFO - --app=APP Application being installed. [default: firefox] 14:09:13 INFO - mkdir: /builds/slave/test-pgo/build/application 14:09:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:09:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:09:30 INFO - Reading from file tmpfile_stdout 14:09:30 INFO - Output received: 14:09:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:09:30 INFO - Running post-action listener: _resource_record_post_action 14:09:30 INFO - ##### 14:09:30 INFO - ##### Running run-tests step. 14:09:30 INFO - ##### 14:09:30 INFO - Running pre-action listener: _resource_record_pre_action 14:09:30 INFO - Running main action method: run_tests 14:09:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:09:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:09:30 INFO - Python 2.7.3 14:09:30 INFO - Return code: 0 14:09:30 INFO - grabbing minidump binary from tooltool 14:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:30 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 0x15e58b0>, '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 0x15e67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e6c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:09:30 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 14:09:30 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 14:09:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:09:30 INFO - Return code: 0 14:09:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:09:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:09:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:09:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:09:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:09:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:09:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:09:31 INFO - Return code: 0 14:09:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 14:09:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:09:31 INFO - Using env: {'DISPLAY': ':0', 14:09:31 INFO - 'HOME': '/home/cltbld', 14:09:31 INFO - 'LANG': 'en_US.UTF-8', 14:09:31 INFO - 'LANGUAGE': 'en_US:en', 14:09:31 INFO - 'LOGNAME': 'cltbld', 14:09:31 INFO - 'MAIL': '/var/mail/cltbld', 14:09:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:09:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:31 INFO - 'MOZ_NO_REMOTE': '1', 14:09:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:31 INFO - 'NO_EM_RESTART': '1', 14:09:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:31 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:09:31 INFO - 'SHELL': '/bin/bash', 14:09:31 INFO - 'SHLVL': '1', 14:09:31 INFO - 'TERM': 'linux', 14:09:31 INFO - 'TMOUT': '86400', 14:09:31 INFO - 'USER': 'cltbld', 14:09:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758', 14:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:31 INFO - '_': '/tools/buildbot/bin/python'} 14:09:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:09:31 INFO - mozversion application_buildid: 20160412113030 14:09:31 INFO - mozversion application_changeset: 8f675b36081a924282dfb4d1d156e06736657f1a 14:09:31 INFO - mozversion application_display_name: Nightly 14:09:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:09:31 INFO - mozversion application_name: Firefox 14:09:31 INFO - mozversion application_remotingname: firefox 14:09:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:09:31 INFO - mozversion application_vendor: Mozilla 14:09:31 INFO - mozversion application_version: 48.0a1 14:09:31 INFO - mozversion platform_buildid: 20160412113030 14:09:31 INFO - mozversion platform_changeset: 8f675b36081a924282dfb4d1d156e06736657f1a 14:09:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:09:31 INFO - mozversion platform_version: 48.0a1 14:09:31 INFO - using testdate: 1460495371 14:09:31 INFO - actual date: 1460495371 14:09:31 INFO - starting webserver on 'localhost:59428' 14:09:31 INFO - SUITE-START | Running 2 tests 14:09:31 INFO - TEST-START | dromaeo_css 14:09:31 INFO - operating with platform_type : linux_ 14:09:31 INFO - Initialising browser for dromaeo_css test... 14:09:31 INFO - TEST-INFO | started process 3259 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXw8qw6/profile http://localhost:59428/getInfo.html) 14:09:36 INFO - PROCESS | 3259 | 14:09:36 INFO - PROCESS | 3259 | (process:3327): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:09:36 INFO - PROCESS | 3259 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 14:09:37 INFO - PROCESS | 3259 | __metrics Screen width/height:1600/1200 14:09:37 INFO - PROCESS | 3259 | colorDepth:24 14:09:37 INFO - PROCESS | 3259 | Browser inner width/height: 1024/697 14:09:37 INFO - PROCESS | 3259 | __metrics 14:09:37 ERROR - PROCESS | 3259 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 14:09:39 INFO - TEST-INFO | 3259: exit 0 14:09:39 INFO - Browser initialized. 14:09:39 INFO - Running cycle 1/1 for dromaeo_css test... 14:09:39 INFO - TEST-INFO | started process 3378 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXw8qw6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:41 INFO - PROCESS | 3378 | 14:09:41 INFO - PROCESS | 3378 | (process:3436): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:09:51 INFO - PROCESS | 3378 | RSS: Main: 162865152 14:09:51 INFO - PROCESS | 3378 | 14:10:41 INFO - PROCESS | 3378 | 1460495441062 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] 14:12:47 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:59428/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59428/tests/dromaeo/cssquery-ext.html) 14:12:49 INFO - PROCESS | 3378 | RSS: Main: 167960576 14:12:49 INFO - PROCESS | 3378 | 14:15:51 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:59428/tests/dromaeo/cssquery-ext.html (next: http://localhost:59428/tests/dromaeo/cssquery-jquery.html) 14:15:51 INFO - PROCESS | 3378 | RSS: Main: 167731200 14:15:51 INFO - PROCESS | 3378 | 14:18:53 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:59428/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59428/tests/dromaeo/cssquery-mootools.html) 14:18:54 INFO - PROCESS | 3378 | RSS: Main: 166264832 14:18:54 INFO - PROCESS | 3378 | 14:21:55 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:59428/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59428/tests/dromaeo/cssquery-prototype.html) 14:21:56 INFO - PROCESS | 3378 | RSS: Main: 164167680 14:21:56 INFO - PROCESS | 3378 | 14:24:58 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:59428/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59428/tests/dromaeo/cssquery-yui.html) 14:24:59 INFO - PROCESS | 3378 | RSS: Main: 165793792 14:24:59 INFO - PROCESS | 3378 | 14:28:01 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:59428/tests/dromaeo/cssquery-yui.html (next: http://localhost:59428/tests/dromaeo/cssquery-dojo.html) 14:28:01 INFO - PROCESS | 3378 | RSS: Main: 167669760 14:28:01 INFO - PROCESS | 3378 | 14:28:01 INFO - PROCESS | 3378 | __start_tp_report 14:28:01 INFO - PROCESS | 3378 | _x_x_mozilla_page_load 14:28:01 INFO - PROCESS | 3378 | _x_x_mozilla_page_load_details 14:28:01 INFO - PROCESS | 3378 | |i|pagename|runs| 14:28:01 INFO - PROCESS | 3378 | |0;dojo.html;3118.8596513156904;3184.1721152500345;3190.808551486911;3193.0740085375255;3196.408664397088;5378.031954248238;5416;5429.239906413105;5431.185322201672;5434.972825135878;5328.094223981922;5425.213344065118;5471.452854714526;5506.504414602685;5507.284053073095;4893.657443978923;4953.083679519283;4995.600351971833;5010.073136469747;5036.974815125937;753.3939017413934;4922.950770492303;4925.679830810986;5030.5975521958335;5049.722265275408;4986.4514903360605;5007.799688012475;5015.398152221738;5016.222485514732;5052.216906379499;4830.444498882638;5080.720560369178;5082.390113186404;5085.160948443502;5088.2622019807295;4951.3810773653295;4953.0341583391255;4955.4548999610015;4968.776405061781;5006.424261209934;5318.414974352857;5351.117065684158;5355.946440535623;5363.168708850135;5382.1657643065;5621.128725047624;5857.209276747627;5866.882662346772;5887.116932460122;5927.347991720907;5872.677002764889;5873.588848780587;5884.352721200665;5890.941090589082;5916.408359164092;5448.073827449303;5475.972620136914;5482.451754824526;5492.176173573956;5492.835214943558;5777.537796976232;5957.523398128139;5960.403959604005;5998.25021872266;6017.06735456005;5603.831885043455;5654.491095801398;5654.9151762723595;5656.151577263443;5681.57388195887;5730;5739.741711622987;5741.19623252745;5742.081266997344;5761.88476230473;5581.776728930879;5710.5146062585145;5748.626339287933;5764.567657425626;5804.390538993345;5653.067243904792;5752.884942301131;5754.827355179351;5767.740451679684;5834.912476312858;4386.429764130707;4422.226110430726;4425.048614547888;4427.8228870844805;4439.4228750262255;3863.942040869333;3932.803359831997;3936.4292177634084;3946.033221860605;3982.482277303932;5536.141898005815;5567.693776842312;5592.7762889484775;5606.411326810708;5606.943930560724;5760.711964401847;5897.5871688982215;5903.321118071391;5909.674967876808;5932.0508718604815;5346.759395827197;5590.888182236333;5613.214150019001;5642.802501912413;5672.12082127271;4801.831935882227;4847.636427267969;4851.345068415719;4860.052289803525;4877.024595080998;5917.467427931507;6002.039673652194;6011.158437818709;6013.278406591149;6023.608465449732;5807.983602869481;5821.359650438533;5861.824145275734;5862.530997520103;5874.089516125007;5937.198478205387;5967.134765459071;5985.820425387245;5993.520518358608;6000.789972350947;5584.972075139598;5724.227229323988;5731.684757338387;5742.1673857289625;5742.827715168552;5861.560382971209;5869.559783016205;5896.056630939029;5897.882042359214;5948.315943666534;5699.629524080921;5712.200291959046;5712.228849105318;5713.342965559014;5719.456651618256;5540.168974653673;5642.351129620146;5659.518940890071;5691.8292451226525;5715.771369145187;5436.483534064258;5492.368377636623;5531.834044978657;5627.915581266202;5664.207011018543;5625.409332020079;5628.155776633538;5655.915161272502;5667.2349232854685;5677.914831277617;5569.498745112959;5570.972145139248;5581.079121944834;5605.327360716577;5655.066913959151 14:28:01 INFO - PROCESS | 3378 | |1;ext.html;602.7709470401247;644.6937704590321;656.2387630348796;668.1025886482389;684.1243208692869;34740.478892816594;36018.2796344073;36291.81854090729;36430;36577.08557286066;36213.45679814805;36360.81819590905;36380.63619363812;36543;36555.26889462216;8268.83462330753;8469.32245420365;8481.703140390087;8487.490750554956;8506.36202284828;8559.315254779634;8716.128387161296;8716.302695784321;8719;8735.43219690718;8679.435836670627;10145.746356341077;10520.78958420831;10541.525631346569;10571.260011799177;10078.697639070802;10231.334963227366;10240.129588984872;10259.743506412326;10285.485725713721;9961.850572241423;10169.847452288222;10190.082892539707;10241.846372304346;10253.43606101664;39799.20401591952;39855.80072099621;40319.7984010081;40409.19181616351;40412.393814092815;3376.6960973512255;3495.685388315064;3809.29528037314;3882.9710126816417;4108.897277568055;30315.848420757975;30522.694773052208;30627.693723062708;30738.38523229523;31051;4008.979955100235;4124.628783409477;4137.13120244749;4199.529955385612;4277.144571085795;287887.9999999979;291296;294394.99999999785;295673;297057;59419.40580594139;59621;59636;59776.402235977956;59949.70025149934;61815.381846180964;62096;62128.689356552924;62208.68895655583;62379.68810156011;16318.428854990017;16471.752923706154;16485.91757041207;16521.6695666086;16528.75206871898;10979.670609881716;12328.445219965122;12760.489580416865;12768.744625107445;12854.678633034062;18340;19094.61810763805;19558.70661940072;19624.90187549053;19628.41114766531;7093.82265443368;7164;7232.92767072333;7420.406367490587;7490.550566966;1040.1107053469327;1051.8264486359817;1109.8557187565564;1111.899929006377;1197.5928184417166;30144.698553014627;30268.394632107236;30476;30776;31083.378332433225;1061.9734506637242;1068.9091427228773;1080.5461706083463;1091.770728147082;1135.7387800805861;15952.680946381239;16144.919275403783;16231.51305460838;16353.754693679604;16383.754243686355;400000;405677;408080;409138;409171;51874.22188667173;52295.73852130715;52353;52640.473595264324;52702.472975270524;1379.1449301432974;1392.3386391463973;1419.2477986667288;1422.50923431416;1440.5462279381961;29963.400731984802;30591.54112688267;30983.535246971765;30989.225269368446;31060;48709;48817.755911220214;48945.265821013425;49142.262866057754;49258;361425;364562;367682;368273;369164;27090.72909270882;27356.589651155646;27566.310842229104;28080.578791317737;28291.57562636521;41027;41151.794241028605;41299.793501032305;41475;42239.788801055794;34993.12517187091;35380.46929296011;35394;35570.82214589014;35733.64266357303;34821;35633.82183089068;35762.463563047095;35762.82118589494;35879;38025;38091.23817523578;38383.23233535369;38434.6156538431;38533.807330964286;32612;34151.146221344665;34289.48565771565;34360.82819585886;34639.826800865834;27074.864625676746;27252.863735681196;27344.453110938066;27354.726452735216;27592.862035689694 14:28:01 INFO - PROCESS | 3378 | |2;jquery.html;394.63496265953984;395.60439560439556;401.0915276897829;401.9758814471132;414.86724248240574;13506.864931350683;14790.852091479082;17431.82568174318;18161.727574086384;18168.727469087975;14718.190499522521;17371.305147794104;17480;17622.76640635153;18733.90633046833;5516.613837031409;5570.498655121049;5706.600537962344;5733.741981610838;5741;5554.361248456418;5650.9152362714385;5658.886822263552;5689.374168841445;5705.48650621444;5424.891502169974;5636.18275350074;5645.096784514479;5648.519875810561;5672.376038635747;5573.052581061229;5628.915566266509;5632.859178520529;5635.267415236034;5651.8304450866535;4868.610511159099;4982.17794063979;5001.17480615698;5062.215356619693;5095.617828662828;21692.56614867694;22159;22440.66339004916;22635.54728905429;22716.091356345893;2400.2559206645997;2614.555525560659;2694.90567830125;2783.1650504848462;2789.9721002789915;14206.786898196535;14304.356303966346;14428.711425771531;14450.660989255852;14626.634334141625;1907.5898681783483;1930.1700268884374;1935.2742721479444;1943.7861835198116;2009.2164056018164;76733.61633191854;79659.20340796576;79776.60111699405;80183.79724304081;80901.59549202275;10139.746506337253;10280.485975701185;10503.422311772925;10590.417527036087;10686.0916822071;14725.116493010453;14739.041962272418;14799.96400251972;14811.555653330417;14822.703545929236;8003.279704826594;8109.797255068553;8120.431569790058;8192;8214.096449390563;7652.005239318964;7780.844383112306;7821.921780782233;7957.880631790527;7979.3217576505485;6332.968335158294;6389.520785941073;6440.742370305135;6501.154849869581;6616.86766264672;1894.4979580411202;1900.0879577802732;1923.2210954563425;1929.6623090959026;1974.8518861085477;969.4522594733953;970.4953424219366;1028.5268776362807;1044.6813721814767;1120.2606279855256;18307;18656.160472778756;18787.436376908714;19162.520936976685;19285;878.6134100995541;1021.8671572695501;1063.6436793674206;1076.1767248055244;1092.7322805912443;9794.265430092772;10049.547770350351;10113.292069555207;10184.083432491112;10196.235282353704;536731;542642;546940;554075;554349;74646;80067.59966200248;84076.57961710152;92297;97704;1090.7164137324353;1097.2922465010024;1114.0419239454225;1136.2954967919943;1153.6193056291404;16842.326306947583;16882.577935551708;17295;17317.30730770755;17327.306907724054;35952.82023589865;36705.44941825821;37201.44197837089;37330.81334593309;37516.81241593775;49905.25142122943;51360.48639513557;51689.741551292005;52069;52997.20504192363;7273.454490913097;7799.688012479437;8335.833283334421;8487.91512084896;8616.741497755078;12358;12549.62351129431;12644.114911956074;12847.486100555872;13244.337783110614;5648.802291919763;9585.376950498196;10072.395656260647;11389.145814064144;11600.30398176112;10618.415987120783;10954.507047182737;11015.779684406427;11410.714732131763;11435.714107147387;10515.158787296845;10908.836367454653;11248.718782030515;11350.336426163074;11768;7266.309700578437;7583.58290294017;8360.87458688108;8543.658253669784;8546.529940853312;10563;10869.456527173768;11151.888481115086;11156.497957591766;11184.608538701106 14:28:01 INFO - PROCESS | 3378 | |3;mootools.html;1481.2889812889816;1524.9085054896705;1661.4434164554873;1782.1356642028607;1813.3834496271265;7455.254474552542;7888.566128862924;8048.758537243884;8256.876146857794;8298.087210406851;8045.074816396116;8056.355491560676;8123.390745694067;8142.95928520358;8152.062512811029;2336.9250144933353;2356.5051339218785;2371.537550177716;2376.584097782881;2376.786089251967;2302.781235782598;2339.333290012347;2340.9297721068397;2347.6361164019518;2351.882405879699;2288.061894623205;2313.4332088638307;2336.5210131923;2344.6131388320905;2346.9295921122393;2266.988665056664;2276.1805749930013;2282.018731945263;2284.6573014047945;2288.0504590594883;2262.468319944812;2291.2897001929455;2296.322584837477;2308.734495533002;2309.642005489152;8161.143079976577;8175.7138500152805;8219.465734727224;8226.62980165888;8246.05170405399;5093.8471845844315;5209.843704688866;5233.790648374061;5257.684538927677;5263.131583288753;3405.6083550391772;3426.194844211608;3473.1490784757643;3523.94714079289;3596.1728802375337;1132.943352832355;1137.5961533655598;1155.9017483513912;1155.9942200288945;1176.0356507663719;10756.354618722824;10900.836487452694;10945.945270273678;11068.778624427547;11197.944010279978;4384.298512238027;4422;4497.482789479186;4550.567696068868;4550.613197878218;8631.223189912938;8767;8802.86795698065;8809.515476648847;8823.911760882438;5101.489851014869;5109.029284435946;5128.282040514331;5148.3564554430695;5165.173572228426;4422.425084738963;4787.61699064074;4846.878828029327;4886.315915771795;4906.386701662293;3605.6214097519905;3658.634136586373;3709.1654377764785;3732.720045996561;3743.344914639927;1097.3415950429837;1118.7538741476862;1123.2754873106965;1134.5291703942771;1136.903363214136;1360.4830164537414;1379.8137251471123;1396.3576754692956;1435.612384656158;1444.335605621405;8154.8776768348525;8358.080611132771;8367.790805229795;8373.07896131425;8379.036410812712;1169.3101070368523;1173.9823902641467;1179.9705007374885;1182.2079206931376;1186.851643544557;6231.813045608639;6264.906026409608;6387.616742995435;6414.326495717975;6419.582727122722;9763.707088787347;10113.129071121719;10194.43930583825;10390.740231494123;10403.94798026005;10355.534000969974;10382.013708697812;10435.478226088666;10444.895551044545;10454.163666906781;7937.761867143995;8087.5551844647935;8102.311303539147;8113.594320283963;8131.83736325282;7868.173841746763;7916.485428447132;7951.960240198762;7957.363410926996;8051.275385215359;9503;9609.855852162364;9645.614175432904;9680.419174849532;9838.06538378853;9681.951590242004;9717.22262219035;9778.706638800562;9876.950615246878;9902.356346837432;6415.101885736094;6823.351781580742;6932.272111428228;7006.439484841302;7037.507374483737;7949.682012719427;8013.639386227517;8049.798755031171;8077.313428358655;8113;7097.538659987084;7359.153697324876;7429.665665044978;7474.887876681963;7495.287947644965;7185;7329.890051649336;7342.632868356454;7390.556566606021;7391.704331826667;7684.577348245676;7774;7795.142534321107;7812.453128281193;7862.803429914298;6689.331066893272;7150.177729561167;7190.820229494305;7197.568145911262;7235.565866048054;7047.7180912762915;7125.964370178116;7130.893036604559;7142.392896603847;7144.035555200189 14:28:01 INFO - PROCESS | 3378 | |4;prototype.html;323.705428060465;323.7458595002923;326.0463145299997;329.02444252790474;332.50456819339195;6053.667048312341;6060.939390606092;6096.329403765582;6120.449159575632;6168.074788781685;6004.489618382443;6025.186599809024;6036.245469316335;6058.242719660043;6058.6061905976085;4099.651529619971;4583.427071616048;4622.86131416058;4646.442426908776;4657.55753203446;4640.791164397593;4652.116097941381;4673.228917228653;4681.157391669515;4692.108499385123;4613.746243956581;4621.699589526686;4622.58396744293;4639.512851150631;4651.906961860761;4538.115067561826;4587.977060114711;4624.815007399734;4633.142868569309;4637.744924029177;3965.861194858166;3995.200959808021;3998.8800335989968;4014.096828213658;4021.8190181441905;5773.740181691834;5786.508146807527;5804.332501762267;5827.329857066449;5864.384239654817;5184.507471790174;5224.686518808883;5256.553192978563;5261.5264626183825;5307.097793375136;6279.497640188774;6286.937130628681;6290.276618188921;6343.27052388972;6344.33384494626;4385.232584297735;4389.846355377578;4393.802278897458;4395.846145384896;4415.801288942005;6404.839879003016;6485.124508191381;6618.121117313935;6636.767713130017;6683.398494135551;4422.977885110554;4437.134758722018;4463.12968971054;4480.39514665516;4490.326451032372;4497.437820272466;4501.054778496552;4534.614557762561;4541.659375546781;4556.794944227518;4979.613862573485;5264.210368444764;5278.208268759717;5282.577393808563;5287.973560132252;6343.365663433619;6367.840803979938;6389.616623002542;6401.135846660642;6425.967870160619;1544.714227867848;1564.9139297338527;1567.4278888205722;1572.5296847447673;1580.865626421744;976.6484065736329;990.9941409469394;1003.7139415266614;1013.3615822032073;1019.1642852860583;5968.582199246011;5989.101634754822;6053.182820319289;6069.575129740876;6075.939240607626;6480.416762491398;6519.055971137488;6551.213854337415;6553.41019308255;6590.110335104795;5917.230760001173;6067.666278354733;6123.295820980555;6125.173101631222;6138.815835524942;3464;3507.4563442666426;3511.877084302037;3518.612952575215;3526.2771131917893;6530.216374035146;6705.09481220029;6750.628715420699;6789.524733268624;6829.282925292773;6609;6655.73377064912;6682.799516014527;6703.463722902254;6729.798106056826;6485;6663.833404164935;6698.5980841149685;6722.865542689119;6736.955771855371;6454.257760357619;6473.255575608677;6483;6528.510361722795;6554.115194448688;6303.905441418474;6374.362563743774;6431.196100487439;6445.61512240474;6451.677396137481;6682.365175308338;6717.093192418961;6734;6755.4257888080065;6793.252742198453;4453.1093781243235;4487.955120448753;4499.34759459883;4500.459944806644;4501.324801279834;6339.175907132043;6490.123833282447;6555.901661475177;6557.180352455943;6569.605823650596;6288.371162883675;6288.65412402304;6322.241331040304;6327.90508142369;6327.96836015817;6132.693365331626;6230.59501132425;6286.968565157145;6309.179806625109;6352.269489008639;6177.96911015442;6191.535634827496;6199.690015499297;6218.284897236695;6227.688615569113;6228.688565571794;6368.64972426521;6379.553431259953;6384.265809431789;6413.615183089029;6166.1983942087245;6198.659073750987;6202;6208.3791620839365;6262.843428914313 14:28:01 INFO - PROCESS | 3378 | |5;yui.html;725.9310365515274;806.6531391501654;841.650714953294;842.3177226446578;865.1694373401531;14857.925710371446;15084.849151508482;15114.924425377858;15141.470048548303;15157.621059473518;14201.857981420182;14259.786103208435;14268.500602478915;14348.856511434882;14383.280835958187;694.552013951;803.4857691077715;830.1656834880936;830.1947111302057;830.9210624990616;811.419834818105;818.8157664525494;818.8239528501371;820.3150369441494;820.9055958564752;870.3081050564784;875.3172525430175;875.8335916175938;880.3133555826465;883.9646414143459;865.5326123893153;873.3668090634303;874.3398733955854;874.715717391847;877.1842186766305;630.7350912616712;635.4281146967766;637.1653134393913;637.7672149665385;638.3903372279462;13871.583852484442;13892.861071389258;13933.721325573431;13950.162990220519;13960.650983725387;13796.172229666252;13799.862001379957;13810.65473363164;13843.584692459242;13875.028747987644;10626.256162068657;10893.945530272376;10951.970547648358;11007.449627518592;11044;3744.9063773405883;3746.737728359016;3783.7540559863796;3794.90512737181;3888.6889048876023;49722.25416618754;49966;50819;50890;51682.74158629258;9921.25590580695;9999.3000489965;10008.949955250177;10063.345882517613;10155;19610;19747.901260493607;19905.303314383927;19945;19993.500162496053;7579.052618422697;7625.923740762632;7681;7701.998740163743;7834.373250139975;4541.841035563805;4547.454305483363;4623.260278355447;4667.323238130452;4736.573708366263;3453.60283567393;3528.947065794015;3550.8934731958084;3553.857845686195;3558.0749005258817;638.3456956619409;655.2104713819836;657.6317262333109;667.0661074495648;672.5057083043959;745.8471013442231;747.196763479262;750.5084169868745;771.5332224004396;781.9569923654253;9082.682106126254;9166.26669866409;9253.167214950687;9368.308884307766;9468.857967130498;673.3434900971612;676.4216594811365;711.5695004522292;728.8797348437555;733.8899165125274;4273.67947403946;4276.2516559601945;4279.486461624625;4320.330348795942;4359.106383191438;56348.43651563514;56921;56940.14589781156;57196.71401642965;58328.41671583315;50851;51377.229341559905;51391;52478;53272;44384.11231775411;45205.54794452079;45267.32099018517;45281.77359113183;45689.543104569195;8331.54176520273;8658.523781191843;8702.559311788584;8733.432326898732;9266.44401335922;31376;31895.840520797246;32161.356772863943;32562.511562327058;33314.5002824953;41865.37201941913;44228.557714422444;44255;44802.327965081204;45289.32066019078;11584.247023943417;11999.220050696676;12187.451564679433;12239.510419583117;12435.564755233523;11978.820317695066;12235.204711693712;12545.749085018431;12651.683707907376;12890.355482225663;11651.88348116508;12474.812877806658;12720.618381448572;12786.232826030468;13416.865831341562;12313.753724925631;12377;12712.555060572835;12716.936415317865;13135.540256090992;12315.568955086528;12536.185147965352;12538.749225015632;12734.745305094031;12959.870401296244;10050.296479246383;10763.677089687322;10765.730856728644;10830.67507974762;11025.228234023542;10613.681589552325;10635.787284254426;10725.08836748885;10749.785004299714;11354.091672666002 14:28:01 INFO - PROCESS | 3378 | __end_tp_report 14:28:01 INFO - PROCESS | 3378 | __start_cc_report 14:28:01 INFO - PROCESS | 3378 | _x_x_mozilla_cycle_collect,324 14:28:01 INFO - PROCESS | 3378 | __end_cc_report 14:28:01 INFO - PROCESS | 3378 | __startTimestamp1460496481887__endTimestamp 14:28:01 INFO - PROCESS | 3378 | 14:28:01 INFO - PROCESS | 3378 | ------- Summary: start ------- 14:28:01 INFO - PROCESS | 3378 | Number of tests: 6 14:28:01 INFO - PROCESS | 3378 | 14:28:01 INFO - PROCESS | 3378 | [#0] dojo.html Cycles:165 Average:5374.11 Median:5613.21 stddev:708.71 (12.6%) stddev-sans-first:688.45 14:28:01 INFO - PROCESS | 3378 | Values: 3118.9 3184.2 3190.8 3193.1 3196.4 5378.0 5416.0 5429.2 5431.2 5435.0 5328.1 5425.2 5471.5 5506.5 5507.3 4893.7 4953.1 4995.6 5010.1 5037.0 753.4 4923.0 4925.7 5030.6 5049.7 4986.5 5007.8 5015.4 5016.2 5052.2 4830.4 5080.7 5082.4 5085.2 5088.3 4951.4 4953.0 4955.5 4968.8 5006.4 5318.4 5351.1 5355.9 5363.2 5382.2 5621.1 5857.2 5866.9 5887.1 5927.3 5872.7 5873.6 5884.4 5890.9 5916.4 5448.1 5476.0 5482.5 5492.2 5492.8 5777.5 5957.5 5960.4 5998.3 6017.1 5603.8 5654.5 5654.9 5656.2 5681.6 5730.0 5739.7 5741.2 5742.1 5761.9 5581.8 5710.5 5748.6 5764.6 5804.4 5653.1 5752.9 5754.8 5767.7 5834.9 4386.4 4422.2 4425.0 4427.8 4439.4 3863.9 3932.8 3936.4 3946.0 3982.5 5536.1 5567.7 5592.8 5606.4 5606.9 5760.7 5897.6 5903.3 5909.7 5932.1 5346.8 5590.9 5613.2 5642.8 5672.1 4801.8 4847.6 4851.3 4860.1 4877.0 5917.5 6002.0 6011.2 6013.3 6023.6 5808.0 5821.4 5861.8 5862.5 5874.1 5937.2 5967.1 5985.8 5993.5 6000.8 5585.0 5724.2 5731.7 5742.2 5742.8 5861.6 5869.6 5896.1 5897.9 5948.3 5699.6 5712.2 5712.2 5713.3 5719.5 5540.2 5642.4 5659.5 5691.8 5715.8 5436.5 5492.4 5531.8 5627.9 5664.2 5625.4 5628.2 5655.9 5667.2 5677.9 5569.5 5571.0 5581.1 5605.3 5655.1 14:28:01 INFO - PROCESS | 3378 | 14:28:01 INFO - PROCESS | 3378 | [#1] ext.html Cycles:180 Average:51793.59 Median:35602.32 stddev:94298.79 (264.9%) stddev-sans-first:94485.00 14:28:01 INFO - PROCESS | 3378 | Values: 602.8 644.7 656.2 668.1 684.1 34740.5 36018.3 36291.8 36430.0 36577.1 36213.5 36360.8 36380.6 36543.0 36555.3 8268.8 8469.3 8481.7 8487.5 8506.4 8559.3 8716.1 8716.3 8719.0 8735.4 8679.4 10145.7 10520.8 10541.5 10571.3 10078.7 10231.3 10240.1 10259.7 10285.5 9961.9 10169.8 10190.1 10241.8 10253.4 39799.2 39855.8 40319.8 40409.2 40412.4 3376.7 3495.7 3809.3 3883.0 4108.9 30315.8 30522.7 30627.7 30738.4 31051.0 4009.0 4124.6 4137.1 4199.5 4277.1 287888.0 291296.0 294395.0 295673.0 297057.0 59419.4 59621.0 59636.0 59776.4 59949.7 61815.4 62096.0 62128.7 62208.7 62379.7 16318.4 16471.8 16485.9 16521.7 16528.8 10979.7 12328.4 12760.5 12768.7 12854.7 18340.0 19094.6 19558.7 19624.9 19628.4 7093.8 7164.0 7232.9 7420.4 7490.6 1040.1 1051.8 1109.9 1111.9 1197.6 30144.7 30268.4 30476.0 30776.0 31083.4 1062.0 1068.9 1080.5 1091.8 1135.7 15952.7 16144.9 16231.5 16353.8 16383.8 400000.0 405677.0 408080.0 409138.0 409171.0 51874.2 52295.7 52353.0 52640.5 52702.5 1379.1 1392.3 1419.2 1422.5 1440.5 29963.4 30591.5 30983.5 30989.2 31060.0 48709.0 48817.8 48945.3 49142.3 49258.0 361425.0 364562.0 367682.0 368273.0 369164.0 27090.7 27356.6 27566.3 28080.6 28291.6 41027.0 41151.8 41299.8 41475.0 42239.8 34993.1 35380.5 35394.0 35570.8 35733.6 34821.0 35633.8 35762.5 35762.8 35879.0 38025.0 38091.2 38383.2 38434.6 38533.8 32612.0 34151.1 34289.5 34360.8 34639.8 27074.9 27252.9 27344.5 27354.7 27592.9 14:28:01 INFO - PROCESS | 3378 | 14:28:01 INFO - PROCESS | 3378 | [#2] jquery.html Cycles:180 Average:29837.00 Median:2654.73 stddev:89749.46 (3380.7%) stddev-sans-first:89974.01 14:28:01 INFO - PROCESS | 3378 | Values: 394.6 395.6 401.1 402.0 414.9 13506.9 14790.9 17431.8 18161.7 18168.7 14718.2 17371.3 17480.0 17622.8 18733.9 5516.6 5570.5 5706.6 5733.7 5741.0 5554.4 5650.9 5658.9 5689.4 5705.5 5424.9 5636.2 5645.1 5648.5 5672.4 5573.1 5628.9 5632.9 5635.3 5651.8 4868.6 4982.2 5001.2 5062.2 5095.6 21692.6 22159.0 22440.7 22635.5 22716.1 2400.3 2614.6 2694.9 2783.2 2790.0 14206.8 14304.4 14428.7 14450.7 14626.6 1907.6 1930.2 1935.3 1943.8 2009.2 76733.6 79659.2 79776.6 80183.8 80901.6 10139.7 10280.5 10503.4 10590.4 10686.1 14725.1 14739.0 14800.0 14811.6 14822.7 8003.3 8109.8 8120.4 8192.0 8214.1 7652.0 7780.8 7821.9 7957.9 7979.3 6333.0 6389.5 6440.7 6501.2 6616.9 1894.5 1900.1 1923.2 1929.7 1974.9 969.5 970.5 1028.5 1044.7 1120.3 18307.0 18656.2 18787.4 19162.5 19285.0 878.6 1021.9 1063.6 1076.2 1092.7 9794.3 10049.5 10113.3 10184.1 10196.2 536731.0 542642.0 546940.0 554075.0 554349.0 74646.0 80067.6 84076.6 92297.0 97704.0 1090.7 1097.3 1114.0 1136.3 1153.6 16842.3 16882.6 17295.0 17317.3 17327.3 35952.8 36705.4 37201.4 37330.8 37516.8 49905.3 51360.5 51689.7 52069.0 52997.2 7273.5 7799.7 8335.8 8487.9 8616.7 12358.0 12549.6 12644.1 12847.5 13244.3 5648.8 9585.4 10072.4 11389.1 11600.3 10618.4 10954.5 11015.8 11410.7 11435.7 10515.2 10908.8 11248.7 11350.3 11768.0 7266.3 7583.6 8360.9 8543.7 8546.5 10563.0 10869.5 11151.9 11156.5 11184.6 14:28:01 INFO - PROCESS | 3378 | 14:28:01 INFO - PROCESS | 3378 | [#3] mootools.html Cycles:180 Average:5867.32 Median:5221.82 stddev:3049.92 (58.4%) stddev-sans-first:3040.66 14:28:01 INFO - PROCESS | 3378 | Values: 1481.3 1524.9 1661.4 1782.1 1813.4 7455.3 7888.6 8048.8 8256.9 8298.1 8045.1 8056.4 8123.4 8143.0 8152.1 2336.9 2356.5 2371.5 2376.6 2376.8 2302.8 2339.3 2340.9 2347.6 2351.9 2288.1 2313.4 2336.5 2344.6 2346.9 2267.0 2276.2 2282.0 2284.7 2288.1 2262.5 2291.3 2296.3 2308.7 2309.6 8161.1 8175.7 8219.5 8226.6 8246.1 5093.8 5209.8 5233.8 5257.7 5263.1 3405.6 3426.2 3473.1 3523.9 3596.2 1132.9 1137.6 1155.9 1156.0 1176.0 10756.4 10900.8 10945.9 11068.8 11197.9 4384.3 4422.0 4497.5 4550.6 4550.6 8631.2 8767.0 8802.9 8809.5 8823.9 5101.5 5109.0 5128.3 5148.4 5165.2 4422.4 4787.6 4846.9 4886.3 4906.4 3605.6 3658.6 3709.2 3732.7 3743.3 1097.3 1118.8 1123.3 1134.5 1136.9 1360.5 1379.8 1396.4 1435.6 1444.3 8154.9 8358.1 8367.8 8373.1 8379.0 1169.3 1174.0 1180.0 1182.2 1186.9 6231.8 6264.9 6387.6 6414.3 6419.6 9763.7 10113.1 10194.4 10390.7 10403.9 10355.5 10382.0 10435.5 10444.9 10454.2 7937.8 8087.6 8102.3 8113.6 8131.8 7868.2 7916.5 7952.0 7957.4 8051.3 9503.0 9609.9 9645.6 9680.4 9838.1 9682.0 9717.2 9778.7 9877.0 9902.4 6415.1 6823.4 6932.3 7006.4 7037.5 7949.7 8013.6 8049.8 8077.3 8113.0 7097.5 7359.2 7429.7 7474.9 7495.3 7185.0 7329.9 7342.6 7390.6 7391.7 7684.6 7774.0 7795.1 7812.5 7862.8 6689.3 7150.2 7190.8 7197.6 7235.6 7047.7 7126.0 7130.9 7142.4 7144.0 14:28:01 INFO - PROCESS | 3378 | 14:28:01 INFO - PROCESS | 3378 | [#4] prototype.html Cycles:180 Average:5292.96 Median:6072.76 stddev:1598.44 (26.3%) stddev-sans-first:1558.80 14:28:01 INFO - PROCESS | 3378 | Values: 323.7 323.7 326.0 329.0 332.5 6053.7 6060.9 6096.3 6120.4 6168.1 6004.5 6025.2 6036.2 6058.2 6058.6 4099.7 4583.4 4622.9 4646.4 4657.6 4640.8 4652.1 4673.2 4681.2 4692.1 4613.7 4621.7 4622.6 4639.5 4651.9 4538.1 4588.0 4624.8 4633.1 4637.7 3965.9 3995.2 3998.9 4014.1 4021.8 5773.7 5786.5 5804.3 5827.3 5864.4 5184.5 5224.7 5256.6 5261.5 5307.1 6279.5 6286.9 6290.3 6343.3 6344.3 4385.2 4389.8 4393.8 4395.8 4415.8 6404.8 6485.1 6618.1 6636.8 6683.4 4423.0 4437.1 4463.1 4480.4 4490.3 4497.4 4501.1 4534.6 4541.7 4556.8 4979.6 5264.2 5278.2 5282.6 5288.0 6343.4 6367.8 6389.6 6401.1 6426.0 1544.7 1564.9 1567.4 1572.5 1580.9 976.6 991.0 1003.7 1013.4 1019.2 5968.6 5989.1 6053.2 6069.6 6075.9 6480.4 6519.1 6551.2 6553.4 6590.1 5917.2 6067.7 6123.3 6125.2 6138.8 3464.0 3507.5 3511.9 3518.6 3526.3 6530.2 6705.1 6750.6 6789.5 6829.3 6609.0 6655.7 6682.8 6703.5 6729.8 6485.0 6663.8 6698.6 6722.9 6737.0 6454.3 6473.3 6483.0 6528.5 6554.1 6303.9 6374.4 6431.2 6445.6 6451.7 6682.4 6717.1 6734.0 6755.4 6793.3 4453.1 4488.0 4499.3 4500.5 4501.3 6339.2 6490.1 6555.9 6557.2 6569.6 6288.4 6288.7 6322.2 6327.9 6328.0 6132.7 6230.6 6287.0 6309.2 6352.3 6178.0 6191.5 6199.7 6218.3 6227.7 6228.7 6368.6 6379.6 6384.3 6413.6 6166.2 6198.7 6202.0 6208.4 6262.8 14:28:01 INFO - PROCESS | 3378 | 14:28:01 INFO - PROCESS | 3378 | [#5] yui.html Cycles:180 Average:14217.95 Median:44319.56 stddev:15859.29 (35.8%) stddev-sans-first:15871.41 14:28:01 INFO - PROCESS | 3378 | Values: 725.9 806.7 841.7 842.3 865.2 14857.9 15084.8 15114.9 15141.5 15157.6 14201.9 14259.8 14268.5 14348.9 14383.3 694.6 803.5 830.2 830.2 830.9 811.4 818.8 818.8 820.3 820.9 870.3 875.3 875.8 880.3 884.0 865.5 873.4 874.3 874.7 877.2 630.7 635.4 637.2 637.8 638.4 13871.6 13892.9 13933.7 13950.2 13960.7 13796.2 13799.9 13810.7 13843.6 13875.0 10626.3 10893.9 10952.0 11007.4 11044.0 3744.9 3746.7 3783.8 3794.9 3888.7 49722.3 49966.0 50819.0 50890.0 51682.7 9921.3 9999.3 10008.9 10063.3 10155.0 19610.0 19747.9 19905.3 19945.0 19993.5 7579.1 7625.9 7681.0 7702.0 7834.4 4541.8 4547.5 4623.3 4667.3 4736.6 3453.6 3528.9 3550.9 3553.9 3558.1 638.3 655.2 657.6 667.1 672.5 745.8 747.2 750.5 771.5 782.0 9082.7 9166.3 9253.2 9368.3 9468.9 673.3 676.4 711.6 728.9 733.9 4273.7 4276.3 4279.5 4320.3 4359.1 56348.4 56921.0 56940.1 57196.7 58328.4 50851.0 51377.2 51391.0 52478.0 53272.0 44384.1 45205.5 45267.3 45281.8 45689.5 8331.5 8658.5 8702.6 8733.4 9266.4 31376.0 31895.8 32161.4 32562.5 33314.5 41865.4 44228.6 44255.0 44802.3 45289.3 11584.2 11999.2 12187.5 12239.5 12435.6 11978.8 12235.2 12545.7 12651.7 12890.4 11651.9 12474.8 12720.6 12786.2 13416.9 12313.8 12377.0 12712.6 12716.9 13135.5 12315.6 12536.2 12538.7 12734.7 12959.9 10050.3 10763.7 10765.7 10830.7 11025.2 10613.7 10635.8 10725.1 10749.8 11354.1 14:28:01 INFO - PROCESS | 3378 | -------- Summary: end -------- 14:28:01 INFO - PROCESS | 3378 | 14:28:02 INFO - TEST-INFO | 3378: exit 0 14:28:02 INFO - TEST-OK | dromaeo_css | took 1111001ms 14:28:02 INFO - TEST-START | kraken 14:28:02 INFO - operating with platform_type : linux_ 14:28:02 INFO - Initialising browser for kraken test... 14:28:02 INFO - TEST-INFO | started process 3616 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjw2Ux0/profile http://localhost:59428/getInfo.html) 14:28:05 INFO - PROCESS | 3616 | 14:28:05 INFO - PROCESS | 3616 | (process:3682): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:28:06 INFO - PROCESS | 3616 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 14:28:06 INFO - PROCESS | 3616 | __metrics Screen width/height:1600/1200 14:28:06 INFO - PROCESS | 3616 | colorDepth:24 14:28:06 INFO - PROCESS | 3616 | Browser inner width/height: 1024/697 14:28:06 INFO - PROCESS | 3616 | __metrics 14:28:07 ERROR - PROCESS | 3616 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 14:28:08 INFO - TEST-INFO | 3616: exit 0 14:28:08 INFO - Browser initialized. 14:28:08 INFO - Running cycle 1/1 for kraken test... 14:28:08 INFO - TEST-INFO | started process 3733 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjw2Ux0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:10 INFO - PROCESS | 3733 | 14:28:10 INFO - PROCESS | 3733 | (process:3794): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:28:20 INFO - PROCESS | 3733 | RSS: Main: 163110912 14:28:20 INFO - PROCESS | 3733 | 14:28:22 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:59428/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59428/tests/kraken/driver.html?testName=audio-beat-detection) 14:28:23 INFO - PROCESS | 3733 | RSS: Main: 168112128 14:28:23 INFO - PROCESS | 3733 | 14:28:26 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:59428/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59428/tests/kraken/driver.html?testName=audio-dft) 14:28:26 INFO - PROCESS | 3733 | RSS: Main: 171737088 14:28:26 INFO - PROCESS | 3733 | 14:28:29 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:59428/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59428/tests/kraken/driver.html?testName=audio-fft) 14:28:30 INFO - PROCESS | 3733 | RSS: Main: 162889728 14:28:30 INFO - PROCESS | 3733 | 14:28:32 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:59428/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59428/tests/kraken/driver.html?testName=audio-oscillator) 14:28:33 INFO - PROCESS | 3733 | RSS: Main: 163328000 14:28:33 INFO - PROCESS | 3733 | 14:28:35 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:59428/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59428/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:28:35 INFO - PROCESS | 3733 | RSS: Main: 164306944 14:28:35 INFO - PROCESS | 3733 | 14:28:38 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:59428/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59428/tests/kraken/driver.html?testName=imaging-darkroom) 14:28:39 INFO - PROCESS | 3733 | RSS: Main: 164753408 14:28:39 INFO - PROCESS | 3733 | 14:28:43 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:59428/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59428/tests/kraken/driver.html?testName=imaging-desaturate) 14:28:43 INFO - PROCESS | 3733 | RSS: Main: 166440960 14:28:43 INFO - PROCESS | 3733 | 14:28:46 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:59428/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59428/tests/kraken/driver.html?testName=json-parse-financial) 14:28:47 INFO - PROCESS | 3733 | RSS: Main: 166379520 14:28:47 INFO - PROCESS | 3733 | 14:28:48 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:59428/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59428/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:28:49 INFO - PROCESS | 3733 | RSS: Main: 166301696 14:28:49 INFO - PROCESS | 3733 | 14:28:51 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:59428/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59428/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:28:51 INFO - PROCESS | 3733 | RSS: Main: 166899712 14:28:51 INFO - PROCESS | 3733 | 14:28:53 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:59428/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59428/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:28:54 INFO - PROCESS | 3733 | RSS: Main: 166838272 14:28:54 INFO - PROCESS | 3733 | 14:28:57 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:59428/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59428/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:28:57 INFO - PROCESS | 3733 | RSS: Main: 167530496 14:28:57 INFO - PROCESS | 3733 | 14:29:00 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:59428/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59428/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:29:01 INFO - PROCESS | 3733 | RSS: Main: 167133184 14:29:01 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:59428/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59428/tests/kraken/driver.html?testName=ai-astar) 14:29:03 INFO - PROCESS | 3733 | RSS: Main: 168615936 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | __start_tp_report 14:29:03 INFO - PROCESS | 3733 | _x_x_mozilla_page_load 14:29:03 INFO - PROCESS | 3733 | _x_x_mozilla_page_load_details 14:29:03 INFO - PROCESS | 3733 | |i|pagename|runs| 14:29:03 INFO - PROCESS | 3733 | |0;ai-astar;112;107;114;111;114;124;110;110;111;111 14:29:03 INFO - PROCESS | 3733 | |1;audio-beat-detection;158;131;160;186;130;156;159;137;181;133 14:29:03 INFO - PROCESS | 3733 | |2;audio-dft;165;163;165;165;164;165;166;162;165;165 14:29:03 INFO - PROCESS | 3733 | |3;audio-fft;72;76;76;174;77;76;72;76;156;76 14:29:03 INFO - PROCESS | 3733 | |4;audio-oscillator;93;94;148;94;94;94;145;92;94;145 14:29:03 INFO - PROCESS | 3733 | |5;imaging-gaussian-blur;117;117;118;117;119;118;118;117;117;117 14:29:03 INFO - PROCESS | 3733 | |6;imaging-darkroom;146;146;146;147;147;146;147;147;148;147 14:29:03 INFO - PROCESS | 3733 | |7;imaging-desaturate;96;97;96;96;97;96;96;96;97;97 14:29:03 INFO - PROCESS | 3733 | |8;json-parse-financial;60;59;62;59;60;59;60;76;56;62 14:29:03 INFO - PROCESS | 3733 | |9;json-stringify-tinderbox;62;61;62;64;62;62;62;62;67;63 14:29:03 INFO - PROCESS | 3733 | |10;stanford-crypto-aes;80;89;81;82;85;90;88;82;82;81 14:29:03 INFO - PROCESS | 3733 | |11;stanford-crypto-ccm;145;139;137;132;128;142;135;133;162;145 14:29:03 INFO - PROCESS | 3733 | |12;stanford-crypto-pbkdf2;165;167;168;171;165;163;165;163;164;162 14:29:03 INFO - PROCESS | 3733 | |13;stanford-crypto-sha256-iterative;70;68;69;67;67;69;70;69;67;69 14:29:03 INFO - PROCESS | 3733 | __end_tp_report 14:29:03 INFO - PROCESS | 3733 | __start_cc_report 14:29:03 INFO - PROCESS | 3733 | _x_x_mozilla_cycle_collect,847 14:29:03 INFO - PROCESS | 3733 | __end_cc_report 14:29:03 INFO - PROCESS | 3733 | __startTimestamp1460496543390__endTimestamp 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | ------- Summary: start ------- 14:29:03 INFO - PROCESS | 3733 | Number of tests: 14 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | [#0] ai-astar Cycles:10 Average:112.40 Median:111.50 stddev:4.55 (4.1%) stddev-sans-first:4.82 14:29:03 INFO - PROCESS | 3733 | Values: 112.0 107.0 114.0 111.0 114.0 124.0 110.0 110.0 111.0 111.0 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:158.50 stddev:20.17 (12.7%) stddev-sans-first:21.31 14:29:03 INFO - PROCESS | 3733 | Values: 158.0 131.0 160.0 186.0 130.0 156.0 159.0 137.0 181.0 133.0 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | [#2] audio-dft Cycles:10 Average:164.50 Median:165.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 14:29:03 INFO - PROCESS | 3733 | Values: 165.0 163.0 165.0 165.0 164.0 165.0 166.0 162.0 165.0 165.0 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.00 stddev:38.17 (50.2%) stddev-sans-first:39.71 14:29:03 INFO - PROCESS | 3733 | Values: 72.0 76.0 76.0 174.0 77.0 76.0 72.0 76.0 156.0 76.0 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:94.00 stddev:25.35 (27.0%) stddev-sans-first:26.19 14:29:03 INFO - PROCESS | 3733 | Values: 93.0 94.0 148.0 94.0 94.0 94.0 145.0 92.0 94.0 145.0 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 14:29:03 INFO - PROCESS | 3733 | Values: 117.0 117.0 118.0 117.0 119.0 118.0 118.0 117.0 117.0 117.0 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 14:29:03 INFO - PROCESS | 3733 | Values: 146.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 148.0 147.0 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:29:03 INFO - PROCESS | 3733 | Values: 96.0 97.0 96.0 96.0 97.0 96.0 96.0 96.0 97.0 97.0 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:60.00 stddev:5.44 (9.1%) stddev-sans-first:5.75 14:29:03 INFO - PROCESS | 3733 | Values: 60.0 59.0 62.0 59.0 60.0 59.0 60.0 76.0 56.0 62.0 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:62.00 stddev:1.70 (2.7%) stddev-sans-first:1.79 14:29:03 INFO - PROCESS | 3733 | Values: 62.0 61.0 62.0 64.0 62.0 62.0 62.0 62.0 67.0 63.0 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.50 stddev:3.71 (4.4%) stddev-sans-first:3.64 14:29:03 INFO - PROCESS | 3733 | Values: 80.0 89.0 81.0 82.0 85.0 90.0 88.0 82.0 82.0 81.0 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:140.50 stddev:9.60 (6.8%) stddev-sans-first:10.00 14:29:03 INFO - PROCESS | 3733 | Values: 145.0 139.0 137.0 132.0 128.0 142.0 135.0 133.0 162.0 145.0 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:165.00 stddev:2.71 (1.6%) stddev-sans-first:2.87 14:29:03 INFO - PROCESS | 3733 | Values: 165.0 167.0 168.0 171.0 165.0 163.0 165.0 163.0 164.0 162.0 14:29:03 INFO - PROCESS | 3733 | 14:29:03 INFO - PROCESS | 3733 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.18 (1.7%) stddev-sans-first:1.12 14:29:03 INFO - PROCESS | 3733 | Values: 70.0 68.0 69.0 67.0 67.0 69.0 70.0 69.0 67.0 69.0 14:29:03 INFO - PROCESS | 3733 | -------- Summary: end -------- 14:29:03 INFO - PROCESS | 3733 | 14:29:04 INFO - TEST-INFO | 3733: exit 0 14:29:04 INFO - TEST-OK | kraken | took 61821ms 14:29:04 INFO - SUITE-END | took 1172s 14:29:04 INFO - Completed test suite (00:19:33) 14:29:04 INFO - javascript benchmark 14:29:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3118.8596513156904, 3184.1721152500345, 3190.808551486911, 3193.0740085375255, 3196.408664397088, 5378.031954248238, 5416.0, 5429.239906413105, 5431.185322201672, 5434.972825135878, 5328.094223981922, 5425.213344065118, 5471.452854714526, 5506.504414602685, 5507.284053073095, 4893.657443978923, 4953.083679519283, 4995.600351971833, 5010.073136469747, 5036.974815125937, 753.3939017413934, 4922.950770492303, 4925.679830810986, 5030.5975521958335, 5049.722265275408, 4986.4514903360605, 5007.799688012475, 5015.398152221738, 5016.222485514732, 5052.216906379499, 4830.444498882638, 5080.720560369178, 5082.390113186404, 5085.160948443502, 5088.2622019807295, 4951.3810773653295, 4953.0341583391255, 4955.4548999610015, 4968.776405061781, 5006.424261209934, 5318.414974352857, 5351.117065684158, 5355.946440535623, 5363.168708850135, 5382.1657643065, 5621.128725047624, 5857.209276747627, 5866.882662346772, 5887.116932460122, 5927.347991720907, 5872.677002764889, 5873.588848780587, 5884.352721200665, 5890.941090589082, 5916.408359164092, 5448.073827449303, 5475.972620136914, 5482.451754824526, 5492.176173573956, 5492.835214943558, 5777.537796976232, 5957.523398128139, 5960.403959604005, 5998.25021872266, 6017.06735456005, 5603.831885043455, 5654.491095801398, 5654.9151762723595, 5656.151577263443, 5681.57388195887, 5730.0, 5739.741711622987, 5741.19623252745, 5742.081266997344, 5761.88476230473, 5581.776728930879, 5710.5146062585145, 5748.626339287933, 5764.567657425626, 5804.390538993345, 5653.067243904792, 5752.884942301131, 5754.827355179351, 5767.740451679684, 5834.912476312858, 4386.429764130707, 4422.226110430726, 4425.048614547888, 4427.8228870844805, 4439.4228750262255, 3863.942040869333, 3932.803359831997, 3936.4292177634084, 3946.033221860605, 3982.482277303932, 5536.141898005815, 5567.693776842312, 5592.7762889484775, 5606.411326810708, 5606.943930560724, 5760.711964401847, 5897.5871688982215, 5903.321118071391, 5909.674967876808, 5932.0508718604815, 5346.759395827197, 5590.888182236333, 5613.214150019001, 5642.802501912413, 5672.12082127271, 4801.831935882227, 4847.636427267969, 4851.345068415719, 4860.052289803525, 4877.024595080998, 5917.467427931507, 6002.039673652194, 6011.158437818709, 6013.278406591149, 6023.608465449732, 5807.983602869481, 5821.359650438533, 5861.824145275734, 5862.530997520103, 5874.089516125007, 5937.198478205387, 5967.134765459071, 5985.820425387245, 5993.520518358608, 6000.789972350947, 5584.972075139598, 5724.227229323988, 5731.684757338387, 5742.1673857289625, 5742.827715168552, 5861.560382971209, 5869.559783016205, 5896.056630939029, 5897.882042359214, 5948.315943666534, 5699.629524080921, 5712.200291959046, 5712.228849105318, 5713.342965559014, 5719.456651618256, 5540.168974653673, 5642.351129620146, 5659.518940890071, 5691.8292451226525, 5715.771369145187, 5436.483534064258, 5492.368377636623, 5531.834044978657, 5627.915581266202, 5664.207011018543, 5625.409332020079, 5628.155776633538, 5655.915161272502, 5667.2349232854685, 5677.914831277617, 5569.498745112959, 5570.972145139248, 5581.079121944834, 5605.327360716577, 5655.066913959151], "value": 5328.677272309417, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.7709470401247, 644.6937704590321, 656.2387630348796, 668.1025886482389, 684.1243208692869, 34740.478892816594, 36018.2796344073, 36291.81854090729, 36430.0, 36577.08557286066, 36213.45679814805, 36360.81819590905, 36380.63619363812, 36543.0, 36555.26889462216, 8268.83462330753, 8469.32245420365, 8481.703140390087, 8487.490750554956, 8506.36202284828, 8559.315254779634, 8716.128387161296, 8716.302695784321, 8719.0, 8735.43219690718, 8679.435836670627, 10145.746356341077, 10520.78958420831, 10541.525631346569, 10571.260011799177, 10078.697639070802, 10231.334963227366, 10240.129588984872, 10259.743506412326, 10285.485725713721, 9961.850572241423, 10169.847452288222, 10190.082892539707, 10241.846372304346, 10253.43606101664, 39799.20401591952, 39855.80072099621, 40319.7984010081, 40409.19181616351, 40412.393814092815, 3376.6960973512255, 3495.685388315064, 3809.29528037314, 3882.9710126816417, 4108.897277568055, 30315.848420757975, 30522.694773052208, 30627.693723062708, 30738.38523229523, 31051.0, 4008.979955100235, 4124.628783409477, 4137.13120244749, 4199.529955385612, 4277.144571085795, 287887.9999999979, 291296.0, 294394.99999999785, 295673.0, 297057.0, 59419.40580594139, 59621.0, 59636.0, 59776.402235977956, 59949.70025149934, 61815.381846180964, 62096.0, 62128.689356552924, 62208.68895655583, 62379.68810156011, 16318.428854990017, 16471.752923706154, 16485.91757041207, 16521.6695666086, 16528.75206871898, 10979.670609881716, 12328.445219965122, 12760.489580416865, 12768.744625107445, 12854.678633034062, 18340.0, 19094.61810763805, 19558.70661940072, 19624.90187549053, 19628.41114766531, 7093.82265443368, 7164.0, 7232.92767072333, 7420.406367490587, 7490.550566966, 1040.1107053469327, 1051.8264486359817, 1109.8557187565564, 1111.899929006377, 1197.5928184417166, 30144.698553014627, 30268.394632107236, 30476.0, 30776.0, 31083.378332433225, 1061.9734506637242, 1068.9091427228773, 1080.5461706083463, 1091.770728147082, 1135.7387800805861, 15952.680946381239, 16144.919275403783, 16231.51305460838, 16353.754693679604, 16383.754243686355, 400000.0, 405677.0, 408080.0, 409138.0, 409171.0, 51874.22188667173, 52295.73852130715, 52353.0, 52640.473595264324, 52702.472975270524, 1379.1449301432974, 1392.3386391463973, 1419.2477986667288, 1422.50923431416, 1440.5462279381961, 29963.400731984802, 30591.54112688267, 30983.535246971765, 30989.225269368446, 31060.0, 48709.0, 48817.755911220214, 48945.265821013425, 49142.262866057754, 49258.0, 361425.0, 364562.0, 367682.0, 368273.0, 369164.0, 27090.72909270882, 27356.589651155646, 27566.310842229104, 28080.578791317737, 28291.57562636521, 41027.0, 41151.794241028605, 41299.793501032305, 41475.0, 42239.788801055794, 34993.12517187091, 35380.46929296011, 35394.0, 35570.82214589014, 35733.64266357303, 34821.0, 35633.82183089068, 35762.463563047095, 35762.82118589494, 35879.0, 38025.0, 38091.23817523578, 38383.23233535369, 38434.6156538431, 38533.807330964286, 32612.0, 34151.146221344665, 34289.48565771565, 34360.82819585886, 34639.826800865834, 27074.864625676746, 27252.863735681196, 27344.453110938066, 27354.726452735216, 27592.862035689694], "value": 19316.854722986303, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.63496265953984, 395.60439560439556, 401.0915276897829, 401.9758814471132, 414.86724248240574, 13506.864931350683, 14790.852091479082, 17431.82568174318, 18161.727574086384, 18168.727469087975, 14718.190499522521, 17371.305147794104, 17480.0, 17622.76640635153, 18733.90633046833, 5516.613837031409, 5570.498655121049, 5706.600537962344, 5733.741981610838, 5741.0, 5554.361248456418, 5650.9152362714385, 5658.886822263552, 5689.374168841445, 5705.48650621444, 5424.891502169974, 5636.18275350074, 5645.096784514479, 5648.519875810561, 5672.376038635747, 5573.052581061229, 5628.915566266509, 5632.859178520529, 5635.267415236034, 5651.8304450866535, 4868.610511159099, 4982.17794063979, 5001.17480615698, 5062.215356619693, 5095.617828662828, 21692.56614867694, 22159.0, 22440.66339004916, 22635.54728905429, 22716.091356345893, 2400.2559206645997, 2614.555525560659, 2694.90567830125, 2783.1650504848462, 2789.9721002789915, 14206.786898196535, 14304.356303966346, 14428.711425771531, 14450.660989255852, 14626.634334141625, 1907.5898681783483, 1930.1700268884374, 1935.2742721479444, 1943.7861835198116, 2009.2164056018164, 76733.61633191854, 79659.20340796576, 79776.60111699405, 80183.79724304081, 80901.59549202275, 10139.746506337253, 10280.485975701185, 10503.422311772925, 10590.417527036087, 10686.0916822071, 14725.116493010453, 14739.041962272418, 14799.96400251972, 14811.555653330417, 14822.703545929236, 8003.279704826594, 8109.797255068553, 8120.431569790058, 8192.0, 8214.096449390563, 7652.005239318964, 7780.844383112306, 7821.921780782233, 7957.880631790527, 7979.3217576505485, 6332.968335158294, 6389.520785941073, 6440.742370305135, 6501.154849869581, 6616.86766264672, 1894.4979580411202, 1900.0879577802732, 1923.2210954563425, 1929.6623090959026, 1974.8518861085477, 969.4522594733953, 970.4953424219366, 1028.5268776362807, 1044.6813721814767, 1120.2606279855256, 18307.0, 18656.160472778756, 18787.436376908714, 19162.520936976685, 19285.0, 878.6134100995541, 1021.8671572695501, 1063.6436793674206, 1076.1767248055244, 1092.7322805912443, 9794.265430092772, 10049.547770350351, 10113.292069555207, 10184.083432491112, 10196.235282353704, 536731.0, 542642.0, 546940.0, 554075.0, 554349.0, 74646.0, 80067.59966200248, 84076.57961710152, 92297.0, 97704.0, 1090.7164137324353, 1097.2922465010024, 1114.0419239454225, 1136.2954967919943, 1153.6193056291404, 16842.326306947583, 16882.577935551708, 17295.0, 17317.30730770755, 17327.306907724054, 35952.82023589865, 36705.44941825821, 37201.44197837089, 37330.81334593309, 37516.81241593775, 49905.25142122943, 51360.48639513557, 51689.741551292005, 52069.0, 52997.20504192363, 7273.454490913097, 7799.688012479437, 8335.833283334421, 8487.91512084896, 8616.741497755078, 12358.0, 12549.62351129431, 12644.114911956074, 12847.486100555872, 13244.337783110614, 5648.802291919763, 9585.376950498196, 10072.395656260647, 11389.145814064144, 11600.30398176112, 10618.415987120783, 10954.507047182737, 11015.779684406427, 11410.714732131763, 11435.714107147387, 10515.158787296845, 10908.836367454653, 11248.718782030515, 11350.336426163074, 11768.0, 7266.309700578437, 7583.58290294017, 8360.87458688108, 8543.658253669784, 8546.529940853312, 10563.0, 10869.456527173768, 11151.888481115086, 11156.497957591766, 11184.608538701106], "value": 9107.894730754451, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.2889812889816, 1524.9085054896705, 1661.4434164554873, 1782.1356642028607, 1813.3834496271265, 7455.254474552542, 7888.566128862924, 8048.758537243884, 8256.876146857794, 8298.087210406851, 8045.074816396116, 8056.355491560676, 8123.390745694067, 8142.95928520358, 8152.062512811029, 2336.9250144933353, 2356.5051339218785, 2371.537550177716, 2376.584097782881, 2376.786089251967, 2302.781235782598, 2339.333290012347, 2340.9297721068397, 2347.6361164019518, 2351.882405879699, 2288.061894623205, 2313.4332088638307, 2336.5210131923, 2344.6131388320905, 2346.9295921122393, 2266.988665056664, 2276.1805749930013, 2282.018731945263, 2284.6573014047945, 2288.0504590594883, 2262.468319944812, 2291.2897001929455, 2296.322584837477, 2308.734495533002, 2309.642005489152, 8161.143079976577, 8175.7138500152805, 8219.465734727224, 8226.62980165888, 8246.05170405399, 5093.8471845844315, 5209.843704688866, 5233.790648374061, 5257.684538927677, 5263.131583288753, 3405.6083550391772, 3426.194844211608, 3473.1490784757643, 3523.94714079289, 3596.1728802375337, 1132.943352832355, 1137.5961533655598, 1155.9017483513912, 1155.9942200288945, 1176.0356507663719, 10756.354618722824, 10900.836487452694, 10945.945270273678, 11068.778624427547, 11197.944010279978, 4384.298512238027, 4422.0, 4497.482789479186, 4550.567696068868, 4550.613197878218, 8631.223189912938, 8767.0, 8802.86795698065, 8809.515476648847, 8823.911760882438, 5101.489851014869, 5109.029284435946, 5128.282040514331, 5148.3564554430695, 5165.173572228426, 4422.425084738963, 4787.61699064074, 4846.878828029327, 4886.315915771795, 4906.386701662293, 3605.6214097519905, 3658.634136586373, 3709.1654377764785, 3732.720045996561, 3743.344914639927, 1097.3415950429837, 1118.7538741476862, 1123.2754873106965, 1134.5291703942771, 1136.903363214136, 1360.4830164537414, 1379.8137251471123, 1396.3576754692956, 1435.612384656158, 1444.335605621405, 8154.8776768348525, 8358.080611132771, 8367.790805229795, 8373.07896131425, 8379.036410812712, 1169.3101070368523, 1173.9823902641467, 1179.9705007374885, 1182.2079206931376, 1186.851643544557, 6231.813045608639, 6264.906026409608, 6387.616742995435, 6414.326495717975, 6419.582727122722, 9763.707088787347, 10113.129071121719, 10194.43930583825, 10390.740231494123, 10403.94798026005, 10355.534000969974, 10382.013708697812, 10435.478226088666, 10444.895551044545, 10454.163666906781, 7937.761867143995, 8087.5551844647935, 8102.311303539147, 8113.594320283963, 8131.83736325282, 7868.173841746763, 7916.485428447132, 7951.960240198762, 7957.363410926996, 8051.275385215359, 9503.0, 9609.855852162364, 9645.614175432904, 9680.419174849532, 9838.06538378853, 9681.951590242004, 9717.22262219035, 9778.706638800562, 9876.950615246878, 9902.356346837432, 6415.101885736094, 6823.351781580742, 6932.272111428228, 7006.439484841302, 7037.507374483737, 7949.682012719427, 8013.639386227517, 8049.798755031171, 8077.313428358655, 8113.0, 7097.538659987084, 7359.153697324876, 7429.665665044978, 7474.887876681963, 7495.287947644965, 7185.0, 7329.890051649336, 7342.632868356454, 7390.556566606021, 7391.704331826667, 7684.577348245676, 7774.0, 7795.142534321107, 7812.453128281193, 7862.803429914298, 6689.331066893272, 7150.177729561167, 7190.820229494305, 7197.568145911262, 7235.565866048054, 7047.7180912762915, 7125.964370178116, 7130.893036604559, 7142.392896603847, 7144.035555200189], "value": 4807.629845207469, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.705428060465, 323.7458595002923, 326.0463145299997, 329.02444252790474, 332.50456819339195, 6053.667048312341, 6060.939390606092, 6096.329403765582, 6120.449159575632, 6168.074788781685, 6004.489618382443, 6025.186599809024, 6036.245469316335, 6058.242719660043, 6058.6061905976085, 4099.651529619971, 4583.427071616048, 4622.86131416058, 4646.442426908776, 4657.55753203446, 4640.791164397593, 4652.116097941381, 4673.228917228653, 4681.157391669515, 4692.108499385123, 4613.746243956581, 4621.699589526686, 4622.58396744293, 4639.512851150631, 4651.906961860761, 4538.115067561826, 4587.977060114711, 4624.815007399734, 4633.142868569309, 4637.744924029177, 3965.861194858166, 3995.200959808021, 3998.8800335989968, 4014.096828213658, 4021.8190181441905, 5773.740181691834, 5786.508146807527, 5804.332501762267, 5827.329857066449, 5864.384239654817, 5184.507471790174, 5224.686518808883, 5256.553192978563, 5261.5264626183825, 5307.097793375136, 6279.497640188774, 6286.937130628681, 6290.276618188921, 6343.27052388972, 6344.33384494626, 4385.232584297735, 4389.846355377578, 4393.802278897458, 4395.846145384896, 4415.801288942005, 6404.839879003016, 6485.124508191381, 6618.121117313935, 6636.767713130017, 6683.398494135551, 4422.977885110554, 4437.134758722018, 4463.12968971054, 4480.39514665516, 4490.326451032372, 4497.437820272466, 4501.054778496552, 4534.614557762561, 4541.659375546781, 4556.794944227518, 4979.613862573485, 5264.210368444764, 5278.208268759717, 5282.577393808563, 5287.973560132252, 6343.365663433619, 6367.840803979938, 6389.616623002542, 6401.135846660642, 6425.967870160619, 1544.714227867848, 1564.9139297338527, 1567.4278888205722, 1572.5296847447673, 1580.865626421744, 976.6484065736329, 990.9941409469394, 1003.7139415266614, 1013.3615822032073, 1019.1642852860583, 5968.582199246011, 5989.101634754822, 6053.182820319289, 6069.575129740876, 6075.939240607626, 6480.416762491398, 6519.055971137488, 6551.213854337415, 6553.41019308255, 6590.110335104795, 5917.230760001173, 6067.666278354733, 6123.295820980555, 6125.173101631222, 6138.815835524942, 3464.0, 3507.4563442666426, 3511.877084302037, 3518.612952575215, 3526.2771131917893, 6530.216374035146, 6705.09481220029, 6750.628715420699, 6789.524733268624, 6829.282925292773, 6609.0, 6655.73377064912, 6682.799516014527, 6703.463722902254, 6729.798106056826, 6485.0, 6663.833404164935, 6698.5980841149685, 6722.865542689119, 6736.955771855371, 6454.257760357619, 6473.255575608677, 6483.0, 6528.510361722795, 6554.115194448688, 6303.905441418474, 6374.362563743774, 6431.196100487439, 6445.61512240474, 6451.677396137481, 6682.365175308338, 6717.093192418961, 6734.0, 6755.4257888080065, 6793.252742198453, 4453.1093781243235, 4487.955120448753, 4499.34759459883, 4500.459944806644, 4501.324801279834, 6339.175907132043, 6490.123833282447, 6555.901661475177, 6557.180352455943, 6569.605823650596, 6288.371162883675, 6288.65412402304, 6322.241331040304, 6327.90508142369, 6327.96836015817, 6132.693365331626, 6230.59501132425, 6286.968565157145, 6309.179806625109, 6352.269489008639, 6177.96911015442, 6191.535634827496, 6199.690015499297, 6218.284897236695, 6227.688615569113, 6228.688565571794, 6368.64972426521, 6379.553431259953, 6384.265809431789, 6413.615183089029, 6166.1983942087245, 6198.659073750987, 6202.0, 6208.3791620839365, 6262.843428914313], "value": 4762.601726068926, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.9310365515274, 806.6531391501654, 841.650714953294, 842.3177226446578, 865.1694373401531, 14857.925710371446, 15084.849151508482, 15114.924425377858, 15141.470048548303, 15157.621059473518, 14201.857981420182, 14259.786103208435, 14268.500602478915, 14348.856511434882, 14383.280835958187, 694.552013951, 803.4857691077715, 830.1656834880936, 830.1947111302057, 830.9210624990616, 811.419834818105, 818.8157664525494, 818.8239528501371, 820.3150369441494, 820.9055958564752, 870.3081050564784, 875.3172525430175, 875.8335916175938, 880.3133555826465, 883.9646414143459, 865.5326123893153, 873.3668090634303, 874.3398733955854, 874.715717391847, 877.1842186766305, 630.7350912616712, 635.4281146967766, 637.1653134393913, 637.7672149665385, 638.3903372279462, 13871.583852484442, 13892.861071389258, 13933.721325573431, 13950.162990220519, 13960.650983725387, 13796.172229666252, 13799.862001379957, 13810.65473363164, 13843.584692459242, 13875.028747987644, 10626.256162068657, 10893.945530272376, 10951.970547648358, 11007.449627518592, 11044.0, 3744.9063773405883, 3746.737728359016, 3783.7540559863796, 3794.90512737181, 3888.6889048876023, 49722.25416618754, 49966.0, 50819.0, 50890.0, 51682.74158629258, 9921.25590580695, 9999.3000489965, 10008.949955250177, 10063.345882517613, 10155.0, 19610.0, 19747.901260493607, 19905.303314383927, 19945.0, 19993.500162496053, 7579.052618422697, 7625.923740762632, 7681.0, 7701.998740163743, 7834.373250139975, 4541.841035563805, 4547.454305483363, 4623.260278355447, 4667.323238130452, 4736.573708366263, 3453.60283567393, 3528.947065794015, 3550.8934731958084, 3553.857845686195, 3558.0749005258817, 638.3456956619409, 655.2104713819836, 657.6317262333109, 667.0661074495648, 672.5057083043959, 745.8471013442231, 747.196763479262, 750.5084169868745, 771.5332224004396, 781.9569923654253, 9082.682106126254, 9166.26669866409, 9253.167214950687, 9368.308884307766, 9468.857967130498, 673.3434900971612, 676.4216594811365, 711.5695004522292, 728.8797348437555, 733.8899165125274, 4273.67947403946, 4276.2516559601945, 4279.486461624625, 4320.330348795942, 4359.106383191438, 56348.43651563514, 56921.0, 56940.14589781156, 57196.71401642965, 58328.41671583315, 50851.0, 51377.229341559905, 51391.0, 52478.0, 53272.0, 44384.11231775411, 45205.54794452079, 45267.32099018517, 45281.77359113183, 45689.543104569195, 8331.54176520273, 8658.523781191843, 8702.559311788584, 8733.432326898732, 9266.44401335922, 31376.0, 31895.840520797246, 32161.356772863943, 32562.511562327058, 33314.5002824953, 41865.37201941913, 44228.557714422444, 44255.0, 44802.327965081204, 45289.32066019078, 11584.247023943417, 11999.220050696676, 12187.451564679433, 12239.510419583117, 12435.564755233523, 11978.820317695066, 12235.204711693712, 12545.749085018431, 12651.683707907376, 12890.355482225663, 11651.88348116508, 12474.812877806658, 12720.618381448572, 12786.232826030468, 13416.865831341562, 12313.753724925631, 12377.0, 12712.555060572835, 12716.936415317865, 13135.540256090992, 12315.568955086528, 12536.185147965352, 12538.749225015632, 12734.745305094031, 12959.870401296244, 10050.296479246383, 10763.677089687322, 10765.730856728644, 10830.67507974762, 11025.228234023542, 10613.681589552325, 10635.787284254426, 10725.08836748885, 10749.785004299714, 11354.091672666002], "value": 6669.246010265301, "unit": "score"}], "name": "dromaeo_css", "value": 7232.86982060031, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 114.0, 111.0, 114.0, 124.0, 110.0, 110.0, 111.0, 111.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 160.0, 186.0, 130.0, 156.0, 159.0, 137.0, 181.0, 133.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 165.0, 165.0, 164.0, 165.0, 166.0, 162.0, 165.0, 165.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 76.0, 174.0, 77.0, 76.0, 72.0, 76.0, 156.0, 76.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 148.0, 94.0, 94.0, 94.0, 145.0, 92.0, 94.0, 145.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 119.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 97.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 62.0, 59.0, 60.0, 59.0, 60.0, 76.0, 56.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 64.0, 62.0, 62.0, 62.0, 62.0, 67.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 89.0, 81.0, 82.0, 85.0, 90.0, 88.0, 82.0, 82.0, 81.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 139.0, 137.0, 132.0, 128.0, 142.0, 135.0, 133.0, 162.0, 145.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 168.0, 171.0, 165.0, 163.0, 165.0, 163.0, 164.0, 162.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 67.0, 67.0, 69.0, 70.0, 69.0, 67.0, 69.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1574.6, "alertThreshold": 2.0}]} 14:29:04 INFO - Return code: 0 14:29:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:29:04 ERROR - # TBPL SUCCESS # 14:29:04 INFO - Running post-action listener: _resource_record_post_action 14:29:04 INFO - Running post-run listener: _resource_record_post_run 14:29:05 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 7708672; Write bytes: 466968576; Read time: 1112; Write time: 325928 14:29:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 15462400; Read time: 0; Write time: 12176 14:29:05 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 5947392; Write bytes: 451506176; Read time: 1064; Write time: 313752 14:29:05 INFO - Running post-run listener: _upload_blobber_files 14:29:05 INFO - Blob upload gear active. 14:29:05 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:29:05 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 14:29:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:29:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:29:06 INFO - (blobuploader) - INFO - Open directory for files ... 14:29:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:29:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:29:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:06 INFO - (blobuploader) - INFO - Done attempting. 14:29:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:29:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:07 INFO - (blobuploader) - INFO - Done attempting. 14:29:07 INFO - (blobuploader) - INFO - Iteration through files over. 14:29:07 INFO - Return code: 0 14:29:07 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:29:07 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:29:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7001e9c73641278e2ddcfc16c5c3945614730b6f942c8fcd4e7b6388ee358caab6357ca3f226804d09257572610b1f5b1ac727278028f998aa2311216ee1d81c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7f22edf688b65475980a5e603cf5710222dd9fc6b3cd5dae032f381df95150667d1abada673a6de67a52d74a45acec96bb8719619ad307baa1720d161803d73"} 14:29:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:29:07 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:29:07 INFO - Contents: 14:29:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7001e9c73641278e2ddcfc16c5c3945614730b6f942c8fcd4e7b6388ee358caab6357ca3f226804d09257572610b1f5b1ac727278028f998aa2311216ee1d81c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7f22edf688b65475980a5e603cf5710222dd9fc6b3cd5dae032f381df95150667d1abada673a6de67a52d74a45acec96bb8719619ad307baa1720d161803d73"} 14:29:07 INFO - Running post-run listener: copy_logs_to_upload_dir 14:29:07 INFO - Copying logs to upload dir... 14:29:07 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:29:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1310.708275 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2016-04-12 14:29:07.767532) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 14:29:07.770660) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7001e9c73641278e2ddcfc16c5c3945614730b6f942c8fcd4e7b6388ee358caab6357ca3f226804d09257572610b1f5b1ac727278028f998aa2311216ee1d81c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7f22edf688b65475980a5e603cf5710222dd9fc6b3cd5dae032f381df95150667d1abada673a6de67a52d74a45acec96bb8719619ad307baa1720d161803d73"} build_url:https://queue.taskcluster.net/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/RITB1lCwQZq0sZGi0XlwTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7001e9c73641278e2ddcfc16c5c3945614730b6f942c8fcd4e7b6388ee358caab6357ca3f226804d09257572610b1f5b1ac727278028f998aa2311216ee1d81c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7f22edf688b65475980a5e603cf5710222dd9fc6b3cd5dae032f381df95150667d1abada673a6de67a52d74a45acec96bb8719619ad307baa1720d161803d73"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 14:29:07.795397) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 14:29:07.795721) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460493705.490412-1327242758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004683 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 14:29:07.879233) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 14:29:07.879542) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 14:29:07.879841) ========= ========= Total master_lag: 0.28 =========