builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1460004854.79 results: success (0) buildid: 20160406193137 builduid: ab6eadf99ca64a8a810b7408af20e4db revision: ab62a777c115ca638278771925f27921675b9efd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:14.795347) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:14.796109) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:14.796448) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006393 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:14.819857) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:14.820186) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:14.834750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:14.835058) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:14.884558) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:14.884877) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:14.885266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:14.885577) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-06 21:54:15-- 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% 23.8M=0s 2016-04-06 21:54:15 (23.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168633 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:15.078443) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:15.078777) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016951 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:15.133662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:15.134007) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ab62a777c115ca638278771925f27921675b9efd --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ab62a777c115ca638278771925f27921675b9efd --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=b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-06 21:54:15,332 truncating revision to first 12 chars 2016-04-06 21:54:15,332 Setting DEBUG logging. 2016-04-06 21:54:15,332 attempt 1/10 2016-04-06 21:54:15,332 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ab62a777c115?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-06 21:54:15,559 unpacking tar archive at: mozilla-inbound-ab62a777c115/testing/mozharness/ program finished with exit code 0 elapsedTime=0.504162 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:15.661483) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:15.661892) ========= echo ab62a777c115ca638278771925f27921675b9efd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ab62a777c115ca638278771925f27921675b9efd'] 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=b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ab62a777c115ca638278771925f27921675b9efd program finished with exit code 0 elapsedTime=0.004703 script_repo_revision: 'ab62a777c115ca638278771925f27921675b9efd' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:15.713593) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:15.714002) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 21:54:15.724897) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-06 21:54:15.725383) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:54:16 INFO - MultiFileLogger online at 20160406 21:54:16 in /builds/slave/test-pgo 21:54:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:54:16 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:54:16 INFO - {'append_to_log': False, 21:54:16 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:54:16 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:54:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:54:16 INFO - 'branch': 'Mozilla-Inbound', 21:54:16 INFO - 'buildbot_json_path': 'buildprops.json', 21:54:16 INFO - 'config_files': ('talos/linux_config.py',), 21:54:16 INFO - 'default_actions': ('clobber', 21:54:16 INFO - 'read-buildbot-config', 21:54:16 INFO - 'download-and-extract', 21:54:16 INFO - 'populate-webroot', 21:54:16 INFO - 'create-virtualenv', 21:54:16 INFO - 'install', 21:54:16 INFO - 'run-tests'), 21:54:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:54:16 INFO - 'download_minidump_stackwalk': True, 21:54:16 INFO - 'download_symbols': 'ondemand', 21:54:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:54:16 INFO - 'tooltool.py': '/tools/tooltool.py', 21:54:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:54:16 INFO - '/tools/misc-python/virtualenv.py')}, 21:54:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:54:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:54:16 INFO - 'installer_path': 'installer.exe', 21:54:16 INFO - 'log_level': 'info', 21:54:16 INFO - 'log_name': 'talos', 21:54:16 INFO - 'log_to_console': True, 21:54:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:54:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:54:16 INFO - 'opt_config_files': (), 21:54:16 INFO - 'pip_index': False, 21:54:16 INFO - 'sps_profile': False, 21:54:16 INFO - 'sps_profile_interval': 0, 21:54:16 INFO - 'suite': 'dromaeojs', 21:54:16 INFO - 'system_bits': '32', 21:54:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:54:16 INFO - 'title': 'talos-linux64-ix-007', 21:54:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:54:16 INFO - 'use_talos_json': True, 21:54:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:54:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:54:16 INFO - 'work_dir': 'build'} 21:54:16 INFO - ##### 21:54:16 INFO - ##### Running clobber step. 21:54:16 INFO - ##### 21:54:16 INFO - Running pre-action listener: _resource_record_pre_action 21:54:16 INFO - Running main action method: clobber 21:54:16 INFO - rmtree: /builds/slave/test-pgo/build 21:54:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:54:16 INFO - Running post-action listener: _resource_record_post_action 21:54:16 INFO - ##### 21:54:16 INFO - ##### Running read-buildbot-config step. 21:54:16 INFO - ##### 21:54:16 INFO - Running pre-action listener: _resource_record_pre_action 21:54:16 INFO - Running main action method: read_buildbot_config 21:54:16 INFO - Using buildbot properties: 21:54:16 INFO - { 21:54:16 INFO - "project": "", 21:54:16 INFO - "product": "firefox", 21:54:16 INFO - "script_repo_revision": "production", 21:54:16 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:54:16 INFO - "repository": "", 21:54:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:54:16 INFO - "buildid": "20160406193137", 21:54:16 INFO - "pgo_build": "True", 21:54:16 INFO - "basedir": "/builds/slave/test-pgo", 21:54:16 INFO - "buildnumber": 1680, 21:54:16 INFO - "slavename": "talos-linux64-ix-007", 21:54:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:54:16 INFO - "platform": "ubuntu64_hw", 21:54:16 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:54:16 INFO - "branch": "mozilla-inbound", 21:54:16 INFO - "repo_path": "integration/mozilla-inbound", 21:54:16 INFO - "revision": "ab62a777c115ca638278771925f27921675b9efd", 21:54:16 INFO - "stage_platform": "linux64-pgo", 21:54:16 INFO - "builduid": "ab6eadf99ca64a8a810b7408af20e4db", 21:54:16 INFO - "slavebuilddir": "test" 21:54:16 INFO - } 21:54:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 21:54:16 INFO - Running post-action listener: _resource_record_post_action 21:54:16 INFO - ##### 21:54:16 INFO - ##### Running download-and-extract step. 21:54:16 INFO - ##### 21:54:16 INFO - Running pre-action listener: _resource_record_pre_action 21:54:16 INFO - Running main action method: download_and_extract 21:54:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:16 INFO - https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:54:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:54:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:54:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:20 INFO - Downloaded 1361 bytes. 21:54:20 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:54:20 INFO - Using the following test package requirements: 21:54:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:54:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:54:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:54:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:20 INFO - u'jsshell-linux-x86_64.zip'], 21:54:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:54:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:54:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:54:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:54:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:54:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:54:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:20 INFO - https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:54:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:54:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:54:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:34 INFO - Downloaded 23707416 bytes. 21:54:34 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'] 21:54:34 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 21:54:35 INFO - Return code: 0 21:54:35 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 21:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:35 INFO - https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:54:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:54:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:54:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:37 INFO - Downloaded 23707416 bytes. 21:54:37 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'] 21:54:37 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 21:54:39 INFO - Return code: 0 21:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:39 INFO - https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:54:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:54:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:54:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:40 INFO - Downloaded 10847693 bytes. 21:54:40 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'] 21:54:40 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 21:54:40 INFO - Return code: 0 21:54:40 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')]} 21:54:40 INFO - https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:54:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:54:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:54:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kqwl_m7VTAi5BiueG92VHQ/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 21:54:43 INFO - Downloaded 57855899 bytes. 21:54:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:54:43 INFO - mkdir: /builds/slave/test-pgo/properties 21:54:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:54:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:54:43 INFO - Contents: 21:54:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:54:43 INFO - Running post-action listener: _resource_record_post_action 21:54:43 INFO - Running post-action listener: set_extra_try_arguments 21:54:43 INFO - ##### 21:54:43 INFO - ##### Running populate-webroot step. 21:54:43 INFO - ##### 21:54:43 INFO - Running pre-action listener: _resource_record_pre_action 21:54:43 INFO - Running main action method: populate_webroot 21:54:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:54:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:54:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:54:43 INFO - '--tppagecycles', 21:54:43 INFO - '7'], 21:54:43 INFO - 'tests': ['tsvgm']}}, 21:54:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:54:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:54:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:54:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:54:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:54:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:54:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:43 INFO - 'talos_options': ['--disable-e10s'], 21:54:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:54:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:54:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:43 INFO - 'talos_options': ['--disable-e10s'], 21:54:43 INFO - 'tests': ['damp', 'tps']}, 21:54:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:43 INFO - 'tests': ['damp', 'tps']}, 21:54:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:54:43 INFO - 'tests': ['dromaeo_dom']}, 21:54:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:54:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:54:43 INFO - 'tests': ['a11yr', 21:54:43 INFO - 'ts_paint', 21:54:43 INFO - 'tpaint', 21:54:43 INFO - 'sessionrestore', 21:54:43 INFO - 'sessionrestore_no_auto_restore', 21:54:43 INFO - 'tabpaint']}, 21:54:43 INFO - 'other-e10s': {'tests': ['a11yr', 21:54:43 INFO - 'ts_paint', 21:54:43 INFO - 'tpaint', 21:54:43 INFO - 'sessionrestore', 21:54:43 INFO - 'sessionrestore_no_auto_restore', 21:54:43 INFO - 'tabpaint']}, 21:54:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:54:43 INFO - 'ts_paint', 21:54:43 INFO - 'tpaint', 21:54:43 INFO - 'sessionrestore', 21:54:43 INFO - 'sessionrestore_no_auto_restore', 21:54:43 INFO - 'tabpaint']}, 21:54:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:54:43 INFO - 'ts_paint', 21:54:43 INFO - 'tpaint', 21:54:43 INFO - 'sessionrestore', 21:54:43 INFO - 'sessionrestore_no_auto_restore', 21:54:43 INFO - 'tabpaint']}, 21:54:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:54:43 INFO - 'tests': ['a11yr', 21:54:43 INFO - 'ts_paint', 21:54:43 INFO - 'tpaint', 21:54:43 INFO - 'sessionrestore', 21:54:43 INFO - 'sessionrestore_no_auto_restore', 21:54:43 INFO - 'tabpaint']}, 21:54:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:54:43 INFO - 'tests': ['a11yr', 21:54:43 INFO - 'ts_paint', 21:54:43 INFO - 'tpaint', 21:54:43 INFO - 'sessionrestore', 21:54:43 INFO - 'sessionrestore_no_auto_restore', 21:54:43 INFO - 'tabpaint']}, 21:54:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:54:43 INFO - 'tests': ['tsvgx', 21:54:43 INFO - 'tsvgr_opacity', 21:54:43 INFO - 'tart', 21:54:43 INFO - 'tscrollx', 21:54:43 INFO - 'cart']}, 21:54:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:54:43 INFO - 'tsvgr_opacity', 21:54:43 INFO - 'tart', 21:54:43 INFO - 'tscrollx', 21:54:43 INFO - 'cart']}, 21:54:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:43 INFO - 'talos_options': ['--disable-e10s'], 21:54:43 INFO - 'tests': ['tp5o']}, 21:54:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:43 INFO - 'tests': ['tp5o']}, 21:54:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:43 INFO - 'talos_options': ['--disable-e10s', 21:54:43 INFO - '--xperf_path', 21:54:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:54:43 INFO - 'tests': ['tp5n']}, 21:54:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:43 INFO - 'talos_options': ['--xperf_path', 21:54:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:54:43 INFO - 'tests': ['tp5n']}}, 21:54:43 INFO - 'talos.zip': {'path': '', 21:54:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:54:43 INFO - Running post-action listener: _resource_record_post_action 21:54:43 INFO - ##### 21:54:43 INFO - ##### Running create-virtualenv step. 21:54:43 INFO - ##### 21:54:43 INFO - Running pre-action listener: _resource_record_pre_action 21:54:43 INFO - Running main action method: create_virtualenv 21:54:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:54:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 21:54:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:54:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:54:44 INFO - Using real prefix '/usr' 21:54:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:54:44 INFO - Installing distribute.............................................................................................................................................................................................done. 21:54:46 INFO - Installing pip.................done. 21:54:46 INFO - Return code: 0 21:54:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc9826ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22488d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d78b0>, '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 0x22d87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d8c60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', '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 21:54:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:54:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:54:46 INFO - Using env: {'DISPLAY': ':0', 21:54:46 INFO - 'HOME': '/home/cltbld', 21:54:46 INFO - 'LANG': 'en_US.UTF-8', 21:54:46 INFO - 'LANGUAGE': 'en_US:en', 21:54:46 INFO - 'LOGNAME': 'cltbld', 21:54:46 INFO - 'MAIL': '/var/mail/cltbld', 21:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:46 INFO - 'MOZ_NO_REMOTE': '1', 21:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:46 INFO - 'NO_EM_RESTART': '1', 21:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:46 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:46 INFO - 'SHELL': '/bin/bash', 21:54:46 INFO - 'SHLVL': '1', 21:54:46 INFO - 'TERM': 'linux', 21:54:46 INFO - 'TMOUT': '86400', 21:54:46 INFO - 'USER': 'cltbld', 21:54:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', 21:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:46 INFO - '_': '/tools/buildbot/bin/python'} 21:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:54:46 INFO - Cleaning up... 21:54:46 INFO - Return code: 0 21:54:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc9826ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22488d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d78b0>, '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 0x22d87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d8c60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', '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 21:54:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:54:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:54:46 INFO - Using env: {'DISPLAY': ':0', 21:54:46 INFO - 'HOME': '/home/cltbld', 21:54:46 INFO - 'LANG': 'en_US.UTF-8', 21:54:46 INFO - 'LANGUAGE': 'en_US:en', 21:54:46 INFO - 'LOGNAME': 'cltbld', 21:54:46 INFO - 'MAIL': '/var/mail/cltbld', 21:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:46 INFO - 'MOZ_NO_REMOTE': '1', 21:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:46 INFO - 'NO_EM_RESTART': '1', 21:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:46 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:46 INFO - 'SHELL': '/bin/bash', 21:54:46 INFO - 'SHLVL': '1', 21:54:46 INFO - 'TERM': 'linux', 21:54:46 INFO - 'TMOUT': '86400', 21:54:46 INFO - 'USER': 'cltbld', 21:54:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', 21:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:46 INFO - '_': '/tools/buildbot/bin/python'} 21:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:46 INFO - Downloading/unpacking psutil>=0.7.1 21:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:54:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:54:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:54:48 INFO - Installing collected packages: psutil 21:54:48 INFO - Running setup.py install for psutil 21:54:48 INFO - building 'psutil._psutil_linux' extension 21:54:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:54:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:54:49 INFO - building 'psutil._psutil_posix' extension 21:54:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:54:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:54:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:54:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:54:49 INFO - Successfully installed psutil 21:54:49 INFO - Cleaning up... 21:54:49 INFO - Return code: 0 21:54:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc9826ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22488d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d78b0>, '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 0x22d87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d8c60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', '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 21:54:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 21:54:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:54:49 INFO - Using env: {'DISPLAY': ':0', 21:54:49 INFO - 'HOME': '/home/cltbld', 21:54:49 INFO - 'LANG': 'en_US.UTF-8', 21:54:49 INFO - 'LANGUAGE': 'en_US:en', 21:54:49 INFO - 'LOGNAME': 'cltbld', 21:54:49 INFO - 'MAIL': '/var/mail/cltbld', 21:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:49 INFO - 'MOZ_NO_REMOTE': '1', 21:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:49 INFO - 'NO_EM_RESTART': '1', 21:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:49 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:49 INFO - 'SHELL': '/bin/bash', 21:54:49 INFO - 'SHLVL': '1', 21:54:49 INFO - 'TERM': 'linux', 21:54:49 INFO - 'TMOUT': '86400', 21:54:49 INFO - 'USER': 'cltbld', 21:54:49 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', 21:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:49 INFO - '_': '/tools/buildbot/bin/python'} 21:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:54:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:54:51 INFO - Installing collected packages: mozsystemmonitor 21:54:51 INFO - Running setup.py install for mozsystemmonitor 21:54:52 INFO - Successfully installed mozsystemmonitor 21:54:52 INFO - Cleaning up... 21:54:52 INFO - Return code: 0 21:54:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc9826ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22488d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d78b0>, '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 0x22d87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d8c60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', '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 21:54:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 21:54:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:54:52 INFO - Using env: {'DISPLAY': ':0', 21:54:52 INFO - 'HOME': '/home/cltbld', 21:54:52 INFO - 'LANG': 'en_US.UTF-8', 21:54:52 INFO - 'LANGUAGE': 'en_US:en', 21:54:52 INFO - 'LOGNAME': 'cltbld', 21:54:52 INFO - 'MAIL': '/var/mail/cltbld', 21:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:52 INFO - 'MOZ_NO_REMOTE': '1', 21:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:52 INFO - 'NO_EM_RESTART': '1', 21:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:52 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:52 INFO - 'SHELL': '/bin/bash', 21:54:52 INFO - 'SHLVL': '1', 21:54:52 INFO - 'TERM': 'linux', 21:54:52 INFO - 'TMOUT': '86400', 21:54:52 INFO - 'USER': 'cltbld', 21:54:52 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', 21:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:52 INFO - '_': '/tools/buildbot/bin/python'} 21:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:52 INFO - Downloading/unpacking blobuploader==1.2.4 21:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:54 INFO - Downloading blobuploader-1.2.4.tar.gz 21:54:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:54:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:54:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:55 INFO - Downloading docopt-0.6.1.tar.gz 21:54:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:54:55 INFO - Installing collected packages: blobuploader, requests, docopt 21:54:55 INFO - Running setup.py install for blobuploader 21:54:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:54:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:54:55 INFO - Running setup.py install for requests 21:54:55 INFO - Running setup.py install for docopt 21:54:56 INFO - Successfully installed blobuploader requests docopt 21:54:56 INFO - Cleaning up... 21:54:56 INFO - Return code: 0 21:54:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc9826ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22488d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d78b0>, '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 0x22d87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d8c60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', '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 21:54:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:54:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:54:56 INFO - Using env: {'DISPLAY': ':0', 21:54:56 INFO - 'HOME': '/home/cltbld', 21:54:56 INFO - 'LANG': 'en_US.UTF-8', 21:54:56 INFO - 'LANGUAGE': 'en_US:en', 21:54:56 INFO - 'LOGNAME': 'cltbld', 21:54:56 INFO - 'MAIL': '/var/mail/cltbld', 21:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:56 INFO - 'MOZ_NO_REMOTE': '1', 21:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:56 INFO - 'NO_EM_RESTART': '1', 21:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:56 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:56 INFO - 'SHELL': '/bin/bash', 21:54:56 INFO - 'SHLVL': '1', 21:54:56 INFO - 'TERM': 'linux', 21:54:56 INFO - 'TMOUT': '86400', 21:54:56 INFO - 'USER': 'cltbld', 21:54:56 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', 21:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:56 INFO - '_': '/tools/buildbot/bin/python'} 21:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:56 INFO - Running setup.py (path:/tmp/pip-Rx3KfQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:56 INFO - Running setup.py (path:/tmp/pip-X90c_R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:56 INFO - Running setup.py (path:/tmp/pip-6v9CLa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:56 INFO - Running setup.py (path:/tmp/pip-spm0FG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:56 INFO - Running setup.py (path:/tmp/pip-Vfqrh2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:56 INFO - Running setup.py (path:/tmp/pip-UGpPAy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:54:56 INFO - Running setup.py (path:/tmp/pip-CKjXJ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:54:56 INFO - Running setup.py (path:/tmp/pip-tLNETt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:54:56 INFO - Running setup.py (path:/tmp/pip-CWG01s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:54:56 INFO - Running setup.py (path:/tmp/pip-7wPALe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:54:57 INFO - Running setup.py (path:/tmp/pip-UJ10Kf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:54:57 INFO - Running setup.py (path:/tmp/pip-wzC8fd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:57 INFO - Running setup.py (path:/tmp/pip-nWC5yz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:57 INFO - Running setup.py (path:/tmp/pip-K7qC8S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:57 INFO - Running setup.py (path:/tmp/pip-gS_cyu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:57 INFO - Running setup.py (path:/tmp/pip-qvPLpR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:57 INFO - Running setup.py (path:/tmp/pip-6jmgib-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:54:57 INFO - Running setup.py install for manifestparser 21:54:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:54:57 INFO - Running setup.py install for mozcrash 21:54:57 INFO - Running setup.py install for mozdebug 21:54:57 INFO - Running setup.py install for mozdevice 21:54:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:54:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:54:57 INFO - Running setup.py install for mozfile 21:54:58 INFO - Running setup.py install for mozhttpd 21:54:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:54:58 INFO - Running setup.py install for mozinfo 21:54:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:54:58 INFO - Running setup.py install for mozInstall 21:54:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:54:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:54:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:54:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:54:58 INFO - Running setup.py install for mozleak 21:54:58 INFO - Running setup.py install for mozlog 21:54:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:54:58 INFO - Running setup.py install for moznetwork 21:54:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:54:58 INFO - Running setup.py install for mozprocess 21:54:58 INFO - Running setup.py install for mozprofile 21:54:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:54:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:54:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:54:58 INFO - Running setup.py install for mozrunner 21:54:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:54:58 INFO - Running setup.py install for mozscreenshot 21:54:59 INFO - Running setup.py install for moztest 21:54:59 INFO - Running setup.py install for mozversion 21:54:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:54:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:54:59 INFO - Cleaning up... 21:54:59 INFO - Return code: 0 21:54:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc9826ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22488d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d78b0>, '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 0x22d87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d8c60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', '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 21:54:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:54:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:54:59 INFO - Using env: {'DISPLAY': ':0', 21:54:59 INFO - 'HOME': '/home/cltbld', 21:54:59 INFO - 'LANG': 'en_US.UTF-8', 21:54:59 INFO - 'LANGUAGE': 'en_US:en', 21:54:59 INFO - 'LOGNAME': 'cltbld', 21:54:59 INFO - 'MAIL': '/var/mail/cltbld', 21:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:59 INFO - 'MOZ_NO_REMOTE': '1', 21:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:59 INFO - 'NO_EM_RESTART': '1', 21:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:59 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:59 INFO - 'SHELL': '/bin/bash', 21:54:59 INFO - 'SHLVL': '1', 21:54:59 INFO - 'TERM': 'linux', 21:54:59 INFO - 'TMOUT': '86400', 21:54:59 INFO - 'USER': 'cltbld', 21:54:59 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', 21:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:59 INFO - '_': '/tools/buildbot/bin/python'} 21:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:59 INFO - Running setup.py (path:/tmp/pip-B4q5HB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 21:54:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:59 INFO - Running setup.py (path:/tmp/pip-YT2b_t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:54:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:59 INFO - Running setup.py (path:/tmp/pip-RRLU7C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 21:54:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:59 INFO - Running setup.py (path:/tmp/pip-078dHg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:59 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)) 21:54:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:59 INFO - Running setup.py (path:/tmp/pip-IvG8aZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:59 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)) 21:54:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:59 INFO - Running setup.py (path:/tmp/pip-noP0nh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:59 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)) 21:54:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:54:59 INFO - Running setup.py (path:/tmp/pip-uYt442-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 21:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:55:00 INFO - Running setup.py (path:/tmp/pip-2ePGZs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 21:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:55:00 INFO - Running setup.py (path:/tmp/pip-Is9TF7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 21:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:55:00 INFO - Running setup.py (path:/tmp/pip-58gpSD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:55:00 INFO - Running setup.py (path:/tmp/pip-eVklRX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 21:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:55:00 INFO - Running setup.py (path:/tmp/pip-vd8M6Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 21:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:55:00 INFO - Running setup.py (path:/tmp/pip-IKufnR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 21:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:55:00 INFO - Running setup.py (path:/tmp/pip-UCJcj0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 21:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:55:00 INFO - Running setup.py (path:/tmp/pip-AwrCfg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 21:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:55:00 INFO - Running setup.py (path:/tmp/pip-UlKb6j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 21:55:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:55:00 INFO - Running setup.py (path:/tmp/pip-RIIgYI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:55:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:02 INFO - Downloading blessings-1.6.tar.gz 21:55:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:55:02 INFO - Installing collected packages: blessings 21:55:02 INFO - Running setup.py install for blessings 21:55:02 INFO - Successfully installed blessings 21:55:02 INFO - Cleaning up... 21:55:02 INFO - Return code: 0 21:55:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:55:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:55:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:55:03 INFO - Reading from file tmpfile_stdout 21:55:03 INFO - Current package versions: 21:55:03 INFO - argparse == 1.2.1 21:55:03 INFO - blessings == 1.6 21:55:03 INFO - blobuploader == 1.2.4 21:55:03 INFO - docopt == 0.6.1 21:55:03 INFO - manifestparser == 1.1 21:55:03 INFO - mozInstall == 1.12 21:55:03 INFO - mozcrash == 0.17 21:55:03 INFO - mozdebug == 0.1 21:55:03 INFO - mozdevice == 0.48 21:55:03 INFO - mozfile == 1.2 21:55:03 INFO - mozhttpd == 0.7 21:55:03 INFO - mozinfo == 0.9 21:55:03 INFO - mozleak == 0.1 21:55:03 INFO - mozlog == 3.1 21:55:03 INFO - moznetwork == 0.27 21:55:03 INFO - mozprocess == 0.22 21:55:03 INFO - mozprofile == 0.28 21:55:03 INFO - mozrunner == 6.11 21:55:03 INFO - mozscreenshot == 0.1 21:55:03 INFO - mozsystemmonitor == 0.0 21:55:03 INFO - moztest == 0.7 21:55:03 INFO - mozversion == 1.4 21:55:03 INFO - psutil == 3.1.1 21:55:03 INFO - requests == 1.2.3 21:55:03 INFO - wsgiref == 0.1.2 21:55:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:55: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')]} 21:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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')]} 21:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc9826ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22488d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d78b0>, '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 0x22d87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d8c60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', '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 21:55:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 21:55:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:55:03 INFO - Using env: {'DISPLAY': ':0', 21:55:03 INFO - 'HOME': '/home/cltbld', 21:55:03 INFO - 'LANG': 'en_US.UTF-8', 21:55:03 INFO - 'LANGUAGE': 'en_US:en', 21:55:03 INFO - 'LOGNAME': 'cltbld', 21:55:03 INFO - 'MAIL': '/var/mail/cltbld', 21:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:03 INFO - 'MOZ_NO_REMOTE': '1', 21:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:03 INFO - 'NO_EM_RESTART': '1', 21:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:03 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:03 INFO - 'SHELL': '/bin/bash', 21:55:03 INFO - 'SHLVL': '1', 21:55:03 INFO - 'TERM': 'linux', 21:55:03 INFO - 'TMOUT': '86400', 21:55:03 INFO - 'USER': 'cltbld', 21:55:03 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', 21:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:03 INFO - '_': '/tools/buildbot/bin/python'} 21:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:03 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)) 21:55:03 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)) 21:55:03 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)) 21:55:03 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)) 21:55:03 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)) 21:55:03 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)) 21:55:03 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)) 21:55:03 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)) 21:55:03 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)) 21:55:03 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)) 21:55:03 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)) 21:55:03 INFO - Cleaning up... 21:55:03 INFO - Return code: 0 21:55:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:55: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')]} 21:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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')]} 21:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:03 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 0x7fcc9826ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22488d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d78b0>, '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 0x22d87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d8c60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', '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 21:55:03 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 21:55:03 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 21:55:03 INFO - Using env: {'DISPLAY': ':0', 21:55:03 INFO - 'HOME': '/home/cltbld', 21:55:03 INFO - 'LANG': 'en_US.UTF-8', 21:55:03 INFO - 'LANGUAGE': 'en_US:en', 21:55:03 INFO - 'LOGNAME': 'cltbld', 21:55:03 INFO - 'MAIL': '/var/mail/cltbld', 21:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:03 INFO - 'MOZ_NO_REMOTE': '1', 21:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:03 INFO - 'NO_EM_RESTART': '1', 21:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:03 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:03 INFO - 'SHELL': '/bin/bash', 21:55:03 INFO - 'SHLVL': '1', 21:55:03 INFO - 'TERM': 'linux', 21:55:03 INFO - 'TMOUT': '86400', 21:55:03 INFO - 'USER': 'cltbld', 21:55:03 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', 21:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:03 INFO - '_': '/tools/buildbot/bin/python'} 21:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:03 INFO - Downloading/unpacking jsonschema 21:55:03 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 21:55:03 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 21:55:03 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 21:55:03 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 21:55:03 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 21:55:03 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 21:55:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:55:05 INFO - Downloading/unpacking functools32 (from jsonschema) 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55:05 INFO - Downloading functools32-3.2.3-2.tar.gz 21:55:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:55:05 INFO - warning: no files found matching '*.txt' 21:55:05 INFO - no previously-included directories found matching 'build' 21:55:05 INFO - no previously-included directories found matching 'dist' 21:55:05 INFO - no previously-included directories found matching '.git*' 21:55:05 INFO - Installing collected packages: jsonschema, functools32 21:55:05 INFO - Running setup.py install for functools32 21:55:05 INFO - warning: no files found matching '*.txt' 21:55:05 INFO - no previously-included directories found matching 'build' 21:55:05 INFO - no previously-included directories found matching 'dist' 21:55:05 INFO - no previously-included directories found matching '.git*' 21:55:05 INFO - Successfully installed jsonschema functools32 21:55:05 INFO - Cleaning up... 21:55:05 INFO - Return code: 0 21:55:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc9826ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22488d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d78b0>, '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 0x22d87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d8c60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', '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 21:55:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 21:55:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:55:05 INFO - Using env: {'DISPLAY': ':0', 21:55:05 INFO - 'HOME': '/home/cltbld', 21:55:05 INFO - 'LANG': 'en_US.UTF-8', 21:55:05 INFO - 'LANGUAGE': 'en_US:en', 21:55:05 INFO - 'LOGNAME': 'cltbld', 21:55:05 INFO - 'MAIL': '/var/mail/cltbld', 21:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:05 INFO - 'MOZ_NO_REMOTE': '1', 21:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:05 INFO - 'NO_EM_RESTART': '1', 21:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:05 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:05 INFO - 'SHELL': '/bin/bash', 21:55:05 INFO - 'SHLVL': '1', 21:55:05 INFO - 'TERM': 'linux', 21:55:05 INFO - 'TMOUT': '86400', 21:55:05 INFO - 'USER': 'cltbld', 21:55:05 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', 21:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:05 INFO - '_': '/tools/buildbot/bin/python'} 21:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:06 INFO - Downloading/unpacking flake8 21:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:55:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:55:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:55:08 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 21:55:08 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 21:55:08 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 21:55:08 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 21:55:08 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 21:55:08 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 21:55:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:55:08 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 21:55:08 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 21:55:08 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 21:55:08 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 21:55:08 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 21:55:08 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 21:55:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:55:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:55:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:55:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:55:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:55:08 INFO - no previously-included directories found matching 'docs/_build' 21:55:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:55:08 INFO - Running setup.py install for pep8 21:55:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:55:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:55:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:55:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:55:08 INFO - no previously-included directories found matching 'docs/_build' 21:55:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:55:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:55:08 INFO - Cleaning up... 21:55:09 INFO - Return code: 0 21:55:09 INFO - Running post-action listener: _resource_record_post_action 21:55:09 INFO - Running post-action listener: _start_resource_monitoring 21:55:09 INFO - Starting resource monitoring. 21:55:09 INFO - ##### 21:55:09 INFO - ##### Running install step. 21:55:09 INFO - ##### 21:55:09 INFO - Running pre-action listener: _resource_record_pre_action 21:55:09 INFO - Running main action method: install 21:55:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:55:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:55:09 INFO - Reading from file tmpfile_stdout 21:55:09 INFO - Detecting whether we're running mozinstall >=1.0... 21:55:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:55:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:55:09 INFO - Reading from file tmpfile_stdout 21:55:09 INFO - Output received: 21:55:09 INFO - Usage: mozinstall [options] installer 21:55:09 INFO - Options: 21:55:09 INFO - -h, --help show this help message and exit 21:55:09 INFO - -d DEST, --destination=DEST 21:55:09 INFO - Directory to install application into. [default: 21:55:09 INFO - "/builds/slave/test-pgo"] 21:55:09 INFO - --app=APP Application being installed. [default: firefox] 21:55:09 INFO - mkdir: /builds/slave/test-pgo/build/application 21:55:09 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'] 21:55:09 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 21:55:25 INFO - Reading from file tmpfile_stdout 21:55:25 INFO - Output received: 21:55:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:55:25 INFO - Running post-action listener: _resource_record_post_action 21:55:25 INFO - ##### 21:55:25 INFO - ##### Running run-tests step. 21:55:25 INFO - ##### 21:55:25 INFO - Running pre-action listener: _resource_record_pre_action 21:55:25 INFO - Running main action method: run_tests 21:55:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:55:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:55:25 INFO - Python 2.7.3 21:55:25 INFO - Return code: 0 21:55:25 INFO - grabbing minidump binary from tooltool 21:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:25 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 0x22d78b0>, '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 0x22d87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d8c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:55:25 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 21:55:25 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 21:55:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:55:25 INFO - Return code: 0 21:55:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:55:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:55:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:55:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:55:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:55:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:55:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:55:26 INFO - Return code: 0 21:55:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 21:55:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 21:55:26 INFO - Using env: {'DISPLAY': ':0', 21:55:26 INFO - 'HOME': '/home/cltbld', 21:55:26 INFO - 'LANG': 'en_US.UTF-8', 21:55:26 INFO - 'LANGUAGE': 'en_US:en', 21:55:26 INFO - 'LOGNAME': 'cltbld', 21:55:26 INFO - 'MAIL': '/var/mail/cltbld', 21:55:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:55:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:26 INFO - 'MOZ_NO_REMOTE': '1', 21:55:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:55:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:26 INFO - 'NO_EM_RESTART': '1', 21:55:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:26 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:55:26 INFO - 'SHELL': '/bin/bash', 21:55:26 INFO - 'SHLVL': '1', 21:55:26 INFO - 'TERM': 'linux', 21:55:26 INFO - 'TMOUT': '86400', 21:55:26 INFO - 'USER': 'cltbld', 21:55:26 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363', 21:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:26 INFO - '_': '/tools/buildbot/bin/python'} 21:55:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:55:27 INFO - mozversion application_buildid: 20160406193137 21:55:27 INFO - mozversion application_changeset: ab62a777c115ca638278771925f27921675b9efd 21:55:27 INFO - mozversion application_display_name: Nightly 21:55:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:55:27 INFO - mozversion application_name: Firefox 21:55:27 INFO - mozversion application_remotingname: firefox 21:55:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:55:27 INFO - mozversion application_vendor: Mozilla 21:55:27 INFO - mozversion application_version: 48.0a1 21:55:27 INFO - mozversion platform_buildid: 20160406193137 21:55:27 INFO - mozversion platform_changeset: ab62a777c115ca638278771925f27921675b9efd 21:55:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:55:27 INFO - mozversion platform_version: 48.0a1 21:55:27 INFO - using testdate: 1460004927 21:55:27 INFO - actual date: 1460004927 21:55:27 INFO - starting webserver on 'localhost:42279' 21:55:27 INFO - SUITE-START | Running 2 tests 21:55:27 INFO - TEST-START | dromaeo_css 21:55:27 INFO - operating with platform_type : linux_ 21:55:27 INFO - Initialising browser for dromaeo_css test... 21:55:27 INFO - TEST-INFO | started process 4561 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxblcML/profile http://localhost:42279/getInfo.html) 21:55:31 INFO - PROCESS | 4561 | __metrics Screen width/height:1600/1200 21:55:31 INFO - PROCESS | 4561 | colorDepth:24 21:55:31 INFO - PROCESS | 4561 | Browser inner width/height: 1024/697 21:55:31 INFO - PROCESS | 4561 | __metrics 21:55:32 ERROR - PROCESS | 4561 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:55:33 INFO - TEST-INFO | 4561: exit 0 21:55:33 INFO - Browser initialized. 21:55:33 INFO - Running cycle 1/1 for dromaeo_css test... 21:55:33 INFO - TEST-INFO | started process 4644 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxblcML/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:55:45 INFO - PROCESS | 4644 | RSS: Main: 151810048 21:55:45 INFO - PROCESS | 4644 | 21:56:35 INFO - PROCESS | 4644 | 1460004995789 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] 21:58:43 INFO - PROCESS | 4644 | Cycle 1(1): loaded http://localhost:42279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42279/tests/dromaeo/cssquery-ext.html) 21:58:44 INFO - PROCESS | 4644 | RSS: Main: 253571072 21:58:44 INFO - PROCESS | 4644 | 22:01:46 INFO - PROCESS | 4644 | Cycle 1(1): loaded http://localhost:42279/tests/dromaeo/cssquery-ext.html (next: http://localhost:42279/tests/dromaeo/cssquery-jquery.html) 22:01:46 INFO - PROCESS | 4644 | RSS: Main: 230154240 22:01:46 INFO - PROCESS | 4644 | 22:04:48 INFO - PROCESS | 4644 | Cycle 1(1): loaded http://localhost:42279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42279/tests/dromaeo/cssquery-mootools.html) 22:04:49 INFO - PROCESS | 4644 | RSS: Main: 235720704 22:04:49 INFO - PROCESS | 4644 | 22:07:50 INFO - PROCESS | 4644 | Cycle 1(1): loaded http://localhost:42279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42279/tests/dromaeo/cssquery-prototype.html) 22:07:51 INFO - PROCESS | 4644 | RSS: Main: 212733952 22:07:51 INFO - PROCESS | 4644 | 22:10:53 INFO - PROCESS | 4644 | Cycle 1(1): loaded http://localhost:42279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42279/tests/dromaeo/cssquery-yui.html) 22:10:54 INFO - PROCESS | 4644 | RSS: Main: 219033600 22:10:54 INFO - PROCESS | 4644 | 22:13:56 INFO - PROCESS | 4644 | Cycle 1(1): loaded http://localhost:42279/tests/dromaeo/cssquery-yui.html (next: http://localhost:42279/tests/dromaeo/cssquery-dojo.html) 22:13:57 INFO - PROCESS | 4644 | RSS: Main: 257650688 22:13:57 INFO - PROCESS | 4644 | 22:13:57 INFO - PROCESS | 4644 | __start_tp_report 22:13:57 INFO - PROCESS | 4644 | _x_x_mozilla_page_load 22:13:57 INFO - PROCESS | 4644 | _x_x_mozilla_page_load_details 22:13:57 INFO - PROCESS | 4644 | |i|pagename|runs| 22:13:57 INFO - PROCESS | 4644 | |0;dojo.html;3059.0822753174048;3063.2188791858075;3112.828794416309;3129.04564107947;3149.433102041632;5102.107131252034;5116.334876466063;5117.3091632629585;5189.455107213745;5193.480651934805;5072.619553533491;5084.669496482726;5101.668391554546;5108.438071812097;5192.247124166994;4594.9540504595025;4653.8371157009515;4690.648201384893;4745.786439610209;4817.494163112875;4751;4755.976220118894;4783.402074740658;4809.5911847492835;4817.855464336076;4652.534746525354;4718.221493453593;4743.691660042121;4746.762661866893;4789.688670236441;4682.157211701892;4742.454617718972;4752.643551733634;4758.238681810928;4781.258904869751;4630.513796051433;4683.578477936968;4712.929306060412;4719.905601887943;4768.356271903283;5109.642325037249;5119.436861945183;5124;5142.202958541432;5171.01750667372;5531.032069387841;5531.529819965308;5537.224788529609;5538.169274608801;5593.496585307301;5358.2498450217;5479.424660410679;5484.177373393983;5576.1356989666665;5624.775008999635;5237.659552129137;5258.789648414059;5265.052290587731;5273.103572392741;5274.868128296785;5670.574706896917;5691.658500489983;5695.658260504383;5699.059655156852;5700.828975130753;5368.651037682538;5456.890862182734;5510.669359838423;5517.144842549411;5520.089185284463;5537.307836520435;5561.694106824163;5561.972190139104;5562.332520097614;5568.805091821848;5508.366537848199;5532.5020748132865;5534.778608855681;5535.723213839292;5584.301962254718;5320.654157479828;5528.226048353234;5550.805721799798;5573.69344686038;5584.664920104807;4192.832286708497;4205.894852628648;4209.368594710818;4211.284081706117;4247.723897946624;3700.9814950925074;3761.0597350662333;3768.9057773555883;3793.336166170909;3810.009397556655;5190.065788158092;5219.42586315505;5226.529612334908;5269.525742683177;5270.10408230594;5495.2856128703015;5509.256250406224;5509.779608815683;5511.724413779295;5518.172274158828;5146.408163061295;5157.432682404932;5177.8446646599905;5184.040952423738;5226.8954620908125;4603.17142914272;4618.769061546909;4626.83806066786;4627.421572303462;4663.976680116578;5633.746481408347;5643.830685079454;5644.971775141098;5647;5689.175069614883;5441.374241962067;5473.534749546333;5516.696581687966;5526.889462210814;5550.583706221969;5691.060974939089;5701.743421545957;5706.629069110494;5711.8857622848145;5735;5468.043092458884;5475.069238229431;5475.123980163155;5477.698726570077;5480.342358916955;5427.348718153847;5458.61789674719;5532.0595498766115;5536.584756143225;5573.665580065209;5365.785368585369;5372.382176049648;5373.946260537345;5379.65032272901;5380.112281473513;5362.570994320367;5383.461653834742;5385.2460655507475;5392.245085687929;5441.156620723794;5139.074966506065;5199.688018718889;5220.634555581073;5280.234366016983;5305.495977882095;5371.086915224343;5372.382176049804;5375;5376.946230537645;5384.515393614593;5188.818391356284;5190.55880250183;5240.266362709148;5240.2663627093;5278.340207474066 22:13:57 INFO - PROCESS | 4644 | |1;ext.html;520.274217466634;565.0732798210934;569.9259096317478;583.1020228847575;593.92575928009;31609.68390316096;38673.41989870154;38944.80527597365;39245.41131883017;39319.21361572767;41356.793216033875;42018.369724454154;42094.57905420945;42099.78950105253;42116.57883421172;7854.214578542157;8654.350923680733;8843.77890552738;8857.95571022144;10356.689299321033;9972.6509572165;10602.522886470128;10607.416592087433;10607.628732994346;10617.150627949746;10370.740731481697;10505.31715438494;10505.369677819317;10508;10517.631882884101;8152.307053900456;10750.892491075067;10795.29830561011;11028.99999999992;11039.889601103967;10366.896331036669;10477.79044419115;10482.63310784119;10485.68542943713;10495.212859035526;41426.1714765703;41808.37287440691;42011.36982945258;42182.78908605468;42222.57777422217;3725.292194483067;3738.5700644425697;3797.829097690583;3852.9036774080873;3967.8809635710977;32172.678273217436;32204.194895127574;32267.19332016695;32491.51262731061;32956.6704332956;4270.893227669302;4301.935470967938;4317.11499142675;4350.6736994725525;4412.271975124133;319166;319202;319510;319663;320341;63151.684241579416;63228;63323.36676633267;63574;63761.36238637554;68475.65762171158;68676;68902;69022.65488672625;69032;16529.504114876574;16866;16887.07121108351;16905.15474226284;16981;13165.407556659973;13203.933980330037;13236.602901912958;13239.073264871367;13245.20528768277;20998.685019724715;21297.574048519255;21301.14795408166;21341.78658213429;21351;6451.870962580722;7193.9280607194305;7275.67259473325;7298.56208627484;7496.962515187389;1065.616378103882;1083.5480456188745;1153.2849633227452;1170.9695467988286;1216.355331674214;30280;30918.227044323623;31104.533431998538;31557.684423155933;31566.36867262688;1130.5760339872547;1156.3697784707354;1165.452237448398;1192.952281908714;1266.9809952850715;15872.365105395886;17216.569585760204;17218.827811721723;17260.654786904193;17265.309387624606;372889;377480;379948;381291;381518;56336;56839.71580142155;57004.144937825964;57011;57106;1276.44474653526;1349.2241960872539;1398.741232871922;1414.130309859429;1417.121384741467;30513.084607461813;31714.365712685154;32108.518372224902;32297.35405291928;32823.83588082044;45169.77415112904;45701.314480282155;45771.542284576724;45861.31208031815;45870.77064614656;249961;255393;255739.88520229864;255791;256925;34395;34410;34689.306213875076;34711.826440868645;34760.30479390347;44627.55372446234;45205.32192017188;45421.54578454173;45730.31404528868;46287.53712462967;37606.62393376031;38353.616463835;38453.80773096117;38572.2285554293;38869;37664.62335376611;37781.622183777814;38195.809020954715;38419.231615366974;38974.41538376983;38460.230795384494;38586.42120368253;38722.41916371313;39348.409773853986;39846.60153398429;33101.33797324088;34007;34458.310833782685;34531.136721581155;34565.48151777675;27283.454330912875;27474.862625686743;27626.171214863585;27652.44695106127;27688.58467123035 22:13:57 INFO - PROCESS | 4644 | |2;jquery.html;349.92826470573533;353.803638980366;364.70458928268107;375.9022654109932;376.6403085053774;17370;17400.91299543502;19104.808951910476;19106.522336941547;19118.13968371425;18190.454286371398;18884.828244751825;19120.521986950334;19144.329948451807;19151.616967660637;5407.107827208516;5638.267025286707;5664.886702265952;5673.8581535461735;5675.3757086720425;5372.623916325859;5520.337559492867;5628.352739434956;5629.6340737852115;5631.2960879890015;5536.307961504812;5565.332160140789;5568.52667523261;5571.804986825462;5572.192032155335;5349.438308977579;5520.641158324716;5521.337439507245;5531.3915469298345;5531.640443371168;4877.658563900528;4918.5573298403315;4926.5812405945535;4944.35723355965;4950.851474455772;12897.742045159044;13311.001674874326;13314.733705325936;22052.77947220523;22105.557888842133;2262.5814224368546;2357.2574638988835;2463.027104293812;2467.987660061688;2608.3479130217447;9751.122398984126;10134.949325253327;10279.948600257025;10446.373217606968;10464.110550603207;1970.0740651893586;2037.5211825221209;2059.7528296604355;2066.638338290793;2071.1301253473425;66034.66982665056;66544.3345566543;66744.6662766683;67362.32637673659;70019.64990175016;10154.289199756095;10159.542820573091;10291.94854025725;10396.16830653561;10449.738756531147;14187.290635468185;14316.355763990645;14333;14346.354414051393;14351.210683412304;7755.30202281786;8015.639296231683;8066.11272759996;8128.918710812816;8138.470999385021;7874.527528348317;7902.7234046809235;8038;8059.234372734581;8062.55655938929;4443.955560444419;4511.887202819956;4514.81940722374;4518.751468669255;4592.88517787058;1822.7357033230373;1873.6721073812027;1886.735856980024;1888.8488920886296;1912.1490936533387;992.3648864726581;997.8253805583994;1016.3343010328247;1029.2846471702096;1126;18376;19026.809731902504;19394.612107757766;19511;19542.804571954384;1001.4441984698562;1002.2032484175098;1072.7371793910386;1117.3016864459712;1125.2179735084037;10563.735906602396;10962.287451315638;11101.666949991513;11103.888961110448;11128.109751219883;499835;515372;515650;521264;521572;73752;74539.25460745323;75490.62254688691;76442.6177869107;76735.23264767393;1060.2101434431397;1106.87824339321;1107.4020029184312;1114.2200459678259;1121.1087185687397;16841.578960526083;16911;17127.57181070483;17241.65516689634;17347.56631084233;36901;38194.236115278094;38259;38562.2287554253;38772.612273878025;53148.73425632847;53313.73343133259;53565;53939.46060539344;54052.18921716256;8087.353011759163;8240.587970601566;8318.875216871873;8371.62327695243;8471.703490377808;12013.63959081229;13092.934535327262;13129.803052954405;13226.272555009182;13245.337733113498;11202.15983801202;11395.886041139482;11460.19778615489;11734;12046.879531204575;11298.322100673986;11404.144689148514;11429.771404572028;11622.244554103956;11858.407079646156;11628.418579071182;11814.350210738492;11936.28382297065;12254.693632659255;12447.315397653216;8290.170982901662;8344.457610255315;8397.622107005322;8439.451435656663;8492.363072769444;11753.260359811984;12090.093243006633;12125;12214.816777748163;12301.261924284572 22:13:57 INFO - PROCESS | 4644 | |3;mootools.html;1357.5248662967956;1496.1920562896037;1510.5166346769035;1679.52133641912;1809.6018875847317;7679.92320076799;7890.8816367754525;7896.842063158733;7898.170692077335;7906;7542.622868856549;7698.7690369288875;7710.228977102287;7718.421118416127;7718.614069296526;2025.4126303372004;2276.692646492727;2307.5846347657457;2330.8951097200584;2336.707911511061;2368.3723813189517;2385.105585405473;2385.439421735891;2386.3556839653284;2386.7613238676167;2243.2148747938254;2298.287530865429;2298.4368829636765;2300.424893776556;2302;2253.9887300563555;2271.1029143488313;2311.295055008222;2313.1556981701724;2316.9884150579137;2168.327818376308;2183.465051062484;2189.9452513687124;2194.2868567715554;2199.3511913985412;7779.33875620573;7844.882326765103;7846.960765196194;7858.921410785876;7874.330681892046;4962.826301079445;5049.545540901337;5071.112555302807;5080.263361812516;5083.974580127113;3326.850291736878;3361.5125806757883;3441.6730410610953;3452.8273586320583;3467.323871844991;1137.687136037588;1147.8450409194818;1163.8021536338842;1172.437230129534;1189.8274750161265;10809.297395669257;10842.457877106192;10905.945470272678;10906.34561926287;10912.181586381053;4460.219461594273;4536.523665015192;4546.909061818745;4623.791929363187;4631.814727410933;9369.718908432758;9387.10822471864;9393.530323483936;9397.248220142372;9410.294227932933;4602.3786788783755;5118.309028281209;5123.87190320245;5124.487551244845;5132.948670513247;4589.724616523019;4608;4635.513271106553;4637.582617564368;4662.6269898408045;3811.123441608446;3879.1078052048188;3886.145048089416;3907.96092039076;3928.096537796323;1259.4647274908311;1260.1619922751452;1263.829383033297;1267.8922291605131;1288.7164823738763;1386.8751812336939;1414.5473448496382;1415.8725714685727;1439.3163247457583;1448.630599197219;7385.778426647209;7543.0948286206;7544.622768861535;7544.698212071566;7546.132194797558;1105.8894110588876;1147.1740346950182;1156.5373850459882;1178.5580407347245;1188.4354931407686;5894.8821023579285;5910.290765108214;5940.257467816523;5951.5238780897425;5960.5827592068135;8797.340199485065;9242.907570924339;9253.861192082124;9264.629414823332;9482.95258523703;9402.200812930978;9446.149846513847;9459.148676619;9485.098915603006;9492.288078394009;7343.449241306924;7709.229077092358;7820.374370050382;7872.291493765589;7878;7393.371563417169;7422.1835598085245;7422.4433167513735;7423.554586724814;7433.516821406592;8549.444286121383;8719.52042637661;8815.867761983447;8818.29453643694;8954.28365730727;8607.870881936651;8855.468671879707;8976.910230897607;8990.28077753765;8995.640174392951;6117.632942023492;6276.027215781562;6590.472762178918;6738.966305168443;6889.035535025;7478.5138965967035;7495.213002634645;7560.395168386626;7575.659095340613;7684.65419056155;6696.464282857457;6748.257691654012;6794.184697836291;6799.898001529882;6986.510944234058;6508.544401892012;6565.376289252514;6790.083338749403;6845.383915447634;6851.040854280305;6683.331666833278;6721.966390168018;6737.29258427858;6739.05653208561;6908.48186386013;6371.04434334835;6410.1987251593555;6411.839704007437;6420.6468644225015;6422.357764223727;6206.844828879314;6247.937520624918;6257.030160325156;6259.78090766821;6271.937280627135 22:13:57 INFO - PROCESS | 4644 | |4;prototype.html;339.28580338387695;340.2480518055098;343.1233199176105;344.7414439170622;350.78602052747834;6162.661053642048;6174.382561743823;6181.1037399577035;6209.254889413277;6222.222222222216;6094.17728606638;6096.481799047076;6111.083337499377;6120.785772497963;6127.754889804413;4714.057188562301;4725.031368569435;4726.574608285254;4727.22000869856;4743.857684269477;4738.336632871401;4739.85780426586;4748.4301883774;4748.857534273978;4752.192127338343;4501.617362524189;4653.976730116345;4656.883577910546;4671.906561868761;4703.858884233478;4618.630509559227;4631.027484228333;4637.397138372024;4653.046125544255;4656.185167595674;3792.6586607205486;4027.496562929634;4028.053407449247;4029.3351596986463;4033.7176397652174;5701.344345400249;5768.942310576883;5778.27771528559;5780.046292361755;5785.045467497858;5235.869103272448;5240.8689782755355;5242.580593552507;5246.396664383607;5248.81629142982;6179.845503862394;6261.968690156566;6358.300586935434;6358.427741503287;6361.173047503795;4450.376947227391;4454.465464144291;4456.799444025027;4457.8439754608435;4463.129689710508;6643.23602785681;6712.697928593225;6713.597184168917;6718.328167183291;6722.361375669304;4522.547745225517;4523.163214805271;4527.0493196429115;4527.411436513298;4527.705699129612;4565.315202719618;4567.566081222279;4569.383133277031;4570.314452832102;4571.679982401267;5154.407243167084;5333.439988801198;5337.706426146521;5342.171963345688;5346.599005074557;6533.150690410312;6563.278039415661;6568.6058836469965;6591.472682185414;6594.406503414716;1588.968220635604;1608.6541393600432;1610.8389161083799;1611.0011792688608;1611.299084898073;1025.2413214221422;1037.123630532199;1039.8284283093205;1050.7058023753361;1070.464767616192;6184.319724830265;6203;6204.410580994799;6209.161763162006;6211.875762484725;6642.535022548472;6646.933530664728;6647.169103862017;6655.201375834834;6658.4673226141795;6183.258009038944;6187.443130118221;6194.907076393858;6195.172424134891;6204.844878877974;3567.2865426914723;3587.1390866191928;3601.3517566837695;3602.7117830573493;3605.2248766515327;6779.966100169468;6871.4502839772695;6957.547759395623;7013.509054366247;7026.26224246457;6879;6916.374651956786;6931.0643063186835;6931.514793964475;6934.098567186234;6980.650967451607;6983.057287266256;6992.405645520188;6994.300569943067;6997.510174287852;6732.528722989344;6735.326467353226;6737.831554211184;6750.898736519054;6753.898691519533;6532.9346706534225;6668.833279167866;6696.263411024881;6696.430803381572;6704.262531121671;6950.235474097744;6977.895331569929;6979.616121113388;6991.755288564876;7001.054857594363;4526.502084770606;4551;4576.58810707038;4578.725276483422;4579;6721.495887808336;6725.697343619451;6730.899036514358;6733.528652994243;6735.6968936397;6388.174679598439;6454.483641308778;6495.9025614614875;6509.251436084911;6522.380373864476;6450.354964503512;6473.77341793035;6478.773242936474;6483.092367068709;6487.967560162169;6343.5876668016435;6352.142460767737;6365.809025729235;6367.968160159169;6367.981123020295;6479.287278399278;6551.80344589663;6557.803265902031;6570.375814297634;6571.080048793268;5933.910991335047;6130.448259656652;6342.175517182736;6379.075034119934;6396.136521569529 22:13:57 INFO - PROCESS | 4644 | |5;yui.html;806.4677312973439;826.1366871619157;827.185222555782;868.045150334632;898.6944438890778;14226.28868556572;14362.066465679736;14442.350094245758;16255;16671.49985500434;15126.697466050673;15156.924215378935;15169.393224271016;15184.240787960613;15184.924075379608;719.6653556096414;838.7861095420675;843.0641987394018;855.243109847783;861.5218553702692;843.6372359885247;856.6316483911916;859.9914000860006;866.4238281542766;866.8266346730647;875.9605817738185;886.3751055505853;891.9866202006975;894.0880302091863;894.4901406198469;745.7427187620262;873.3668090634271;884.1335491218578;898.2230370729272;899.6131663384742;643.9001954697029;648.1023782061831;651.8728847874667;653.1443808610687;654.46334006115;14129.081609695337;14178.929105354511;14186.290685465685;14227.50203742864;14267.215303158322;12902.483900643963;12946.48214071436;13137.671558211026;13235.13971591853;13319.134256273312;11304.37825919574;11323.377214253213;11332.773344533145;11451.026662733595;11613.18707690462;3698.907527311812;3719.4234893591265;3762.811859407046;3775.377062784637;3794.6015668354703;58040.41959580393;58337.7083114586;58610.413895860926;58638;58858.41141588572;9610.615575377047;9640.517974101267;9692.127708506268;9721.951390243003;10196.18430525571;18590.721139182922;18906.527336816416;18920.33778817762;18930.053497325353;18950.52623684419;7374.52065615744;7466.887996680054;7469.14104877946;7575.772726818204;7785.221477852283;4614;4766.499517550607;4809.158397280462;4810.903781924412;4902.754862256873;3150.6534281229046;3176.269458024667;3191.1064901827526;3257.397381484433;3260.1034715452965;585.6749504025307;609.9939000610026;646.8221239159269;650.5056157320471;656.2223764838682;724.9021382113348;731.1226528166222;739.3235189801379;785.4148659248896;787.4369825574627;8825.823483530421;9106.499142547224;9256.352055356196;9876.87326412098;9978.101970822516;722.0072400449382;736.2674139231499;769;769.9730509432255;801.2748462641318;4209.431726716854;4281.935770963438;4341.611577630846;4415.183191109655;4486.932696009562;62038.37961620416;62507.37492625016;62932.68533657303;63049.054264186074;63230.36769632245;52669.736651316496;53426.198607020924;54017.45982540203;54020.729896351055;54557.1816422754;50078.49921500738;50705.23942140871;51287.74356128195;52046.99999999924;52105;9303.162715355651;9606.375585586915;9614.278929080487;9688.660896868576;9717.56270967794;36994.63005369912;37306.81346593249;38149.23701526009;38812.41781373225;39013.29373709493;42347.15305693931;45363.54636453725;48551.786205345146;49087.26369104395;50728;11423.714407139889;11510.884891150981;11975.76048479008;12077.39613019363;12351.876481235073;12813.423395947018;13049.673758156123;13506.729865402833;13643.454261829416;13689.931550342582;11599;11774.764504710029;12223.694407639525;12260.26438413698;12547.18443301219;12570.182938108994;12804.10371274002;12869.099163058496;12904.741905161656;13255.801162982756;11978.64064078079;12091.939540302243;12094;12192.451339689913;12337.753244935231;10481.580736770444;10560.366378017343;10837.566497340333;10868.293560918515;10891.292066015683;10824.891751082703;10834.295770774874;10844.457777110954;10913.126949843834;11021.228514003942 22:13:57 INFO - PROCESS | 4644 | __end_tp_report 22:13:57 INFO - PROCESS | 4644 | __start_cc_report 22:13:57 INFO - PROCESS | 4644 | _x_x_mozilla_cycle_collect,776 22:13:57 INFO - PROCESS | 4644 | __end_cc_report 22:13:57 INFO - PROCESS | 4644 | __startTimestamp1460006037238__endTimestamp 22:13:57 INFO - PROCESS | 4644 | 22:13:57 INFO - PROCESS | 4644 | ------- Summary: start ------- 22:13:57 INFO - PROCESS | 4644 | Number of tests: 6 22:13:57 INFO - PROCESS | 4644 | 22:13:57 INFO - PROCESS | 4644 | [#0] dojo.html Cycles:165 Average:5127.73 Median:5278.34 stddev:566.98 (10.7%) stddev-sans-first:545.00 22:13:57 INFO - PROCESS | 4644 | Values: 3059.1 3063.2 3112.8 3129.0 3149.4 5102.1 5116.3 5117.3 5189.5 5193.5 5072.6 5084.7 5101.7 5108.4 5192.2 4595.0 4653.8 4690.6 4745.8 4817.5 4751.0 4756.0 4783.4 4809.6 4817.9 4652.5 4718.2 4743.7 4746.8 4789.7 4682.2 4742.5 4752.6 4758.2 4781.3 4630.5 4683.6 4712.9 4719.9 4768.4 5109.6 5119.4 5124.0 5142.2 5171.0 5531.0 5531.5 5537.2 5538.2 5593.5 5358.2 5479.4 5484.2 5576.1 5624.8 5237.7 5258.8 5265.1 5273.1 5274.9 5670.6 5691.7 5695.7 5699.1 5700.8 5368.7 5456.9 5510.7 5517.1 5520.1 5537.3 5561.7 5562.0 5562.3 5568.8 5508.4 5532.5 5534.8 5535.7 5584.3 5320.7 5528.2 5550.8 5573.7 5584.7 4192.8 4205.9 4209.4 4211.3 4247.7 3701.0 3761.1 3768.9 3793.3 3810.0 5190.1 5219.4 5226.5 5269.5 5270.1 5495.3 5509.3 5509.8 5511.7 5518.2 5146.4 5157.4 5177.8 5184.0 5226.9 4603.2 4618.8 4626.8 4627.4 4664.0 5633.7 5643.8 5645.0 5647.0 5689.2 5441.4 5473.5 5516.7 5526.9 5550.6 5691.1 5701.7 5706.6 5711.9 5735.0 5468.0 5475.1 5475.1 5477.7 5480.3 5427.3 5458.6 5532.1 5536.6 5573.7 5365.8 5372.4 5373.9 5379.7 5380.1 5362.6 5383.5 5385.2 5392.2 5441.2 5139.1 5199.7 5220.6 5280.2 5305.5 5371.1 5372.4 5375.0 5376.9 5384.5 5188.8 5190.6 5240.3 5240.3 5278.3 22:13:57 INFO - PROCESS | 4644 | 22:13:57 INFO - PROCESS | 4644 | [#1] ext.html Cycles:180 Average:50010.04 Median:34548.31 stddev:84209.13 (243.7%) stddev-sans-first:84363.38 22:13:57 INFO - PROCESS | 4644 | Values: 520.3 565.1 569.9 583.1 593.9 31609.7 38673.4 38944.8 39245.4 39319.2 41356.8 42018.4 42094.6 42099.8 42116.6 7854.2 8654.4 8843.8 8858.0 10356.7 9972.7 10602.5 10607.4 10607.6 10617.2 10370.7 10505.3 10505.4 10508.0 10517.6 8152.3 10750.9 10795.3 11029.0 11039.9 10366.9 10477.8 10482.6 10485.7 10495.2 41426.2 41808.4 42011.4 42182.8 42222.6 3725.3 3738.6 3797.8 3852.9 3967.9 32172.7 32204.2 32267.2 32491.5 32956.7 4270.9 4301.9 4317.1 4350.7 4412.3 319166.0 319202.0 319510.0 319663.0 320341.0 63151.7 63228.0 63323.4 63574.0 63761.4 68475.7 68676.0 68902.0 69022.7 69032.0 16529.5 16866.0 16887.1 16905.2 16981.0 13165.4 13203.9 13236.6 13239.1 13245.2 20998.7 21297.6 21301.1 21341.8 21351.0 6451.9 7193.9 7275.7 7298.6 7497.0 1065.6 1083.5 1153.3 1171.0 1216.4 30280.0 30918.2 31104.5 31557.7 31566.4 1130.6 1156.4 1165.5 1193.0 1267.0 15872.4 17216.6 17218.8 17260.7 17265.3 372889.0 377480.0 379948.0 381291.0 381518.0 56336.0 56839.7 57004.1 57011.0 57106.0 1276.4 1349.2 1398.7 1414.1 1417.1 30513.1 31714.4 32108.5 32297.4 32823.8 45169.8 45701.3 45771.5 45861.3 45870.8 249961.0 255393.0 255739.9 255791.0 256925.0 34395.0 34410.0 34689.3 34711.8 34760.3 44627.6 45205.3 45421.5 45730.3 46287.5 37606.6 38353.6 38453.8 38572.2 38869.0 37664.6 37781.6 38195.8 38419.2 38974.4 38460.2 38586.4 38722.4 39348.4 39846.6 33101.3 34007.0 34458.3 34531.1 34565.5 27283.5 27474.9 27626.2 27652.4 27688.6 22:13:57 INFO - PROCESS | 4644 | 22:13:57 INFO - PROCESS | 4644 | [#2] jquery.html Cycles:180 Average:28325.97 Median:22079.17 stddev:84240.55 (381.5%) stddev-sans-first:84450.68 22:13:57 INFO - PROCESS | 4644 | Values: 349.9 353.8 364.7 375.9 376.6 17370.0 17400.9 19104.8 19106.5 19118.1 18190.5 18884.8 19120.5 19144.3 19151.6 5407.1 5638.3 5664.9 5673.9 5675.4 5372.6 5520.3 5628.4 5629.6 5631.3 5536.3 5565.3 5568.5 5571.8 5572.2 5349.4 5520.6 5521.3 5531.4 5531.6 4877.7 4918.6 4926.6 4944.4 4950.9 12897.7 13311.0 13314.7 22052.8 22105.6 2262.6 2357.3 2463.0 2468.0 2608.3 9751.1 10134.9 10279.9 10446.4 10464.1 1970.1 2037.5 2059.8 2066.6 2071.1 66034.7 66544.3 66744.7 67362.3 70019.6 10154.3 10159.5 10291.9 10396.2 10449.7 14187.3 14316.4 14333.0 14346.4 14351.2 7755.3 8015.6 8066.1 8128.9 8138.5 7874.5 7902.7 8038.0 8059.2 8062.6 4444.0 4511.9 4514.8 4518.8 4592.9 1822.7 1873.7 1886.7 1888.8 1912.1 992.4 997.8 1016.3 1029.3 1126.0 18376.0 19026.8 19394.6 19511.0 19542.8 1001.4 1002.2 1072.7 1117.3 1125.2 10563.7 10962.3 11101.7 11103.9 11128.1 499835.0 515372.0 515650.0 521264.0 521572.0 73752.0 74539.3 75490.6 76442.6 76735.2 1060.2 1106.9 1107.4 1114.2 1121.1 16841.6 16911.0 17127.6 17241.7 17347.6 36901.0 38194.2 38259.0 38562.2 38772.6 53148.7 53313.7 53565.0 53939.5 54052.2 8087.4 8240.6 8318.9 8371.6 8471.7 12013.6 13092.9 13129.8 13226.3 13245.3 11202.2 11395.9 11460.2 11734.0 12046.9 11298.3 11404.1 11429.8 11622.2 11858.4 11628.4 11814.4 11936.3 12254.7 12447.3 8290.2 8344.5 8397.6 8439.5 8492.4 11753.3 12090.1 12125.0 12214.8 12301.3 22:13:57 INFO - PROCESS | 4644 | 22:13:57 INFO - PROCESS | 4644 | [#3] mootools.html Cycles:180 Average:5558.21 Median:6162.24 stddev:2818.93 (45.7%) stddev-sans-first:2809.15 22:13:57 INFO - PROCESS | 4644 | Values: 1357.5 1496.2 1510.5 1679.5 1809.6 7679.9 7890.9 7896.8 7898.2 7906.0 7542.6 7698.8 7710.2 7718.4 7718.6 2025.4 2276.7 2307.6 2330.9 2336.7 2368.4 2385.1 2385.4 2386.4 2386.8 2243.2 2298.3 2298.4 2300.4 2302.0 2254.0 2271.1 2311.3 2313.2 2317.0 2168.3 2183.5 2189.9 2194.3 2199.4 7779.3 7844.9 7847.0 7858.9 7874.3 4962.8 5049.5 5071.1 5080.3 5084.0 3326.9 3361.5 3441.7 3452.8 3467.3 1137.7 1147.8 1163.8 1172.4 1189.8 10809.3 10842.5 10905.9 10906.3 10912.2 4460.2 4536.5 4546.9 4623.8 4631.8 9369.7 9387.1 9393.5 9397.2 9410.3 4602.4 5118.3 5123.9 5124.5 5132.9 4589.7 4608.0 4635.5 4637.6 4662.6 3811.1 3879.1 3886.1 3908.0 3928.1 1259.5 1260.2 1263.8 1267.9 1288.7 1386.9 1414.5 1415.9 1439.3 1448.6 7385.8 7543.1 7544.6 7544.7 7546.1 1105.9 1147.2 1156.5 1178.6 1188.4 5894.9 5910.3 5940.3 5951.5 5960.6 8797.3 9242.9 9253.9 9264.6 9483.0 9402.2 9446.1 9459.1 9485.1 9492.3 7343.4 7709.2 7820.4 7872.3 7878.0 7393.4 7422.2 7422.4 7423.6 7433.5 8549.4 8719.5 8815.9 8818.3 8954.3 8607.9 8855.5 8976.9 8990.3 8995.6 6117.6 6276.0 6590.5 6739.0 6889.0 7478.5 7495.2 7560.4 7575.7 7684.7 6696.5 6748.3 6794.2 6799.9 6986.5 6508.5 6565.4 6790.1 6845.4 6851.0 6683.3 6722.0 6737.3 6739.1 6908.5 6371.0 6410.2 6411.8 6420.6 6422.4 6206.8 6247.9 6257.0 6259.8 6271.9 22:13:57 INFO - PROCESS | 4644 | 22:13:57 INFO - PROCESS | 4644 | [#4] prototype.html Cycles:180 Average:5408.41 Median:6182.18 stddev:1649.85 (26.7%) stddev-sans-first:1610.01 22:13:57 INFO - PROCESS | 4644 | Values: 339.3 340.2 343.1 344.7 350.8 6162.7 6174.4 6181.1 6209.3 6222.2 6094.2 6096.5 6111.1 6120.8 6127.8 4714.1 4725.0 4726.6 4727.2 4743.9 4738.3 4739.9 4748.4 4748.9 4752.2 4501.6 4654.0 4656.9 4671.9 4703.9 4618.6 4631.0 4637.4 4653.0 4656.2 3792.7 4027.5 4028.1 4029.3 4033.7 5701.3 5768.9 5778.3 5780.0 5785.0 5235.9 5240.9 5242.6 5246.4 5248.8 6179.8 6262.0 6358.3 6358.4 6361.2 4450.4 4454.5 4456.8 4457.8 4463.1 6643.2 6712.7 6713.6 6718.3 6722.4 4522.5 4523.2 4527.0 4527.4 4527.7 4565.3 4567.6 4569.4 4570.3 4571.7 5154.4 5333.4 5337.7 5342.2 5346.6 6533.2 6563.3 6568.6 6591.5 6594.4 1589.0 1608.7 1610.8 1611.0 1611.3 1025.2 1037.1 1039.8 1050.7 1070.5 6184.3 6203.0 6204.4 6209.2 6211.9 6642.5 6646.9 6647.2 6655.2 6658.5 6183.3 6187.4 6194.9 6195.2 6204.8 3567.3 3587.1 3601.4 3602.7 3605.2 6780.0 6871.5 6957.5 7013.5 7026.3 6879.0 6916.4 6931.1 6931.5 6934.1 6980.7 6983.1 6992.4 6994.3 6997.5 6732.5 6735.3 6737.8 6750.9 6753.9 6532.9 6668.8 6696.3 6696.4 6704.3 6950.2 6977.9 6979.6 6991.8 7001.1 4526.5 4551.0 4576.6 4578.7 4579.0 6721.5 6725.7 6730.9 6733.5 6735.7 6388.2 6454.5 6495.9 6509.3 6522.4 6450.4 6473.8 6478.8 6483.1 6488.0 6343.6 6352.1 6365.8 6368.0 6368.0 6479.3 6551.8 6557.8 6570.4 6571.1 5933.9 6130.4 6342.2 6379.1 6396.1 22:13:57 INFO - PROCESS | 4644 | 22:13:57 INFO - PROCESS | 4644 | [#5] yui.html Cycles:180 Average:15078.05 Median:4810.03 stddev:17620.50 (366.3%) stddev-sans-first:17637.34 22:13:57 INFO - PROCESS | 4644 | Values: 806.5 826.1 827.2 868.0 898.7 14226.3 14362.1 14442.4 16255.0 16671.5 15126.7 15156.9 15169.4 15184.2 15184.9 719.7 838.8 843.1 855.2 861.5 843.6 856.6 860.0 866.4 866.8 876.0 886.4 892.0 894.1 894.5 745.7 873.4 884.1 898.2 899.6 643.9 648.1 651.9 653.1 654.5 14129.1 14178.9 14186.3 14227.5 14267.2 12902.5 12946.5 13137.7 13235.1 13319.1 11304.4 11323.4 11332.8 11451.0 11613.2 3698.9 3719.4 3762.8 3775.4 3794.6 58040.4 58337.7 58610.4 58638.0 58858.4 9610.6 9640.5 9692.1 9722.0 10196.2 18590.7 18906.5 18920.3 18930.1 18950.5 7374.5 7466.9 7469.1 7575.8 7785.2 4614.0 4766.5 4809.2 4810.9 4902.8 3150.7 3176.3 3191.1 3257.4 3260.1 585.7 610.0 646.8 650.5 656.2 724.9 731.1 739.3 785.4 787.4 8825.8 9106.5 9256.4 9876.9 9978.1 722.0 736.3 769.0 770.0 801.3 4209.4 4281.9 4341.6 4415.2 4486.9 62038.4 62507.4 62932.7 63049.1 63230.4 52669.7 53426.2 54017.5 54020.7 54557.2 50078.5 50705.2 51287.7 52047.0 52105.0 9303.2 9606.4 9614.3 9688.7 9717.6 36994.6 37306.8 38149.2 38812.4 39013.3 42347.2 45363.5 48551.8 49087.3 50728.0 11423.7 11510.9 11975.8 12077.4 12351.9 12813.4 13049.7 13506.7 13643.5 13689.9 11599.0 11774.8 12223.7 12260.3 12547.2 12570.2 12804.1 12869.1 12904.7 13255.8 11978.6 12091.9 12094.0 12192.5 12337.8 10481.6 10560.4 10837.6 10868.3 10891.3 10824.9 10834.3 10844.5 10913.1 11021.2 22:13:57 INFO - PROCESS | 4644 | -------- Summary: end -------- 22:13:57 INFO - PROCESS | 4644 | 22:13:57 INFO - TEST-INFO | 4644: exit 0 22:13:57 INFO - TEST-OK | dromaeo_css | took 1110748ms 22:13:57 INFO - TEST-START | kraken 22:13:57 INFO - operating with platform_type : linux_ 22:13:57 INFO - Initialising browser for kraken test... 22:13:57 INFO - TEST-INFO | started process 4829 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOlxTQg/profile http://localhost:42279/getInfo.html) 22:14:02 INFO - PROCESS | 4829 | __metrics Screen width/height:1600/1200 22:14:02 INFO - PROCESS | 4829 | colorDepth:24 22:14:02 INFO - PROCESS | 4829 | Browser inner width/height: 1024/697 22:14:02 INFO - PROCESS | 4829 | __metrics 22:14:03 ERROR - PROCESS | 4829 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:14:03 INFO - TEST-INFO | 4829: exit 0 22:14:03 INFO - Browser initialized. 22:14:03 INFO - Running cycle 1/1 for kraken test... 22:14:03 INFO - TEST-INFO | started process 4911 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOlxTQg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:15 INFO - PROCESS | 4911 | RSS: Main: 151613440 22:14:15 INFO - PROCESS | 4911 | 22:14:18 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:42279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42279/tests/kraken/driver.html?testName=audio-beat-detection) 22:14:18 INFO - PROCESS | 4911 | RSS: Main: 194379776 22:14:18 INFO - PROCESS | 4911 | 22:14:21 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:42279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42279/tests/kraken/driver.html?testName=audio-dft) 22:14:22 INFO - PROCESS | 4911 | RSS: Main: 182640640 22:14:22 INFO - PROCESS | 4911 | 22:14:24 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:42279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42279/tests/kraken/driver.html?testName=audio-fft) 22:14:25 INFO - PROCESS | 4911 | RSS: Main: 166559744 22:14:25 INFO - PROCESS | 4911 | 22:14:27 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:42279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42279/tests/kraken/driver.html?testName=audio-oscillator) 22:14:28 INFO - PROCESS | 4911 | RSS: Main: 169533440 22:14:28 INFO - PROCESS | 4911 | 22:14:30 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:42279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:14:30 INFO - PROCESS | 4911 | RSS: Main: 171499520 22:14:30 INFO - PROCESS | 4911 | 22:14:33 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:42279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42279/tests/kraken/driver.html?testName=imaging-darkroom) 22:14:34 INFO - PROCESS | 4911 | RSS: Main: 171724800 22:14:34 INFO - PROCESS | 4911 | 22:14:37 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:42279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42279/tests/kraken/driver.html?testName=imaging-desaturate) 22:14:38 INFO - PROCESS | 4911 | RSS: Main: 172224512 22:14:38 INFO - PROCESS | 4911 | 22:14:40 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:42279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42279/tests/kraken/driver.html?testName=json-parse-financial) 22:14:41 INFO - PROCESS | 4911 | RSS: Main: 173060096 22:14:41 INFO - PROCESS | 4911 | 22:14:43 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:42279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:14:43 INFO - PROCESS | 4911 | RSS: Main: 180490240 22:14:43 INFO - PROCESS | 4911 | 22:14:45 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:42279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42279/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:14:46 INFO - PROCESS | 4911 | RSS: Main: 178139136 22:14:46 INFO - PROCESS | 4911 | 22:14:48 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:42279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:14:48 INFO - PROCESS | 4911 | RSS: Main: 190038016 22:14:48 INFO - PROCESS | 4911 | 22:14:50 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:42279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:14:51 INFO - PROCESS | 4911 | RSS: Main: 193732608 22:14:51 INFO - PROCESS | 4911 | 22:14:54 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:42279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:14:54 INFO - PROCESS | 4911 | RSS: Main: 194023424 22:14:54 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:42279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42279/tests/kraken/driver.html?testName=ai-astar) 22:14:56 INFO - PROCESS | 4911 | RSS: Main: 256421888 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | __start_tp_report 22:14:56 INFO - PROCESS | 4911 | _x_x_mozilla_page_load 22:14:56 INFO - PROCESS | 4911 | _x_x_mozilla_page_load_details 22:14:56 INFO - PROCESS | 4911 | |i|pagename|runs| 22:14:56 INFO - PROCESS | 4911 | |0;ai-astar;107;110;104;109;109;111;99;108;109;109 22:14:56 INFO - PROCESS | 4911 | |1;audio-beat-detection;155;124;154;173;126;151;155;131;181;127 22:14:56 INFO - PROCESS | 4911 | |2;audio-dft;161;159;160;158;162;163;160;165;161;160 22:14:56 INFO - PROCESS | 4911 | |3;audio-fft;73;72;102;96;73;76;73;116;95;76 22:14:56 INFO - PROCESS | 4911 | |4;audio-oscillator;92;92;140;93;92;92;141;92;92;135 22:14:56 INFO - PROCESS | 4911 | |5;imaging-gaussian-blur;117;117;117;117;116;117;116;117;118;117 22:14:56 INFO - PROCESS | 4911 | |6;imaging-darkroom;145;146;145;145;145;145;145;147;145;145 22:14:56 INFO - PROCESS | 4911 | |7;imaging-desaturate;96;97;96;96;96;96;95;96;95;94 22:14:56 INFO - PROCESS | 4911 | |8;json-parse-financial;57;56;55;56;56;55;56;65;55;54 22:14:56 INFO - PROCESS | 4911 | |9;json-stringify-tinderbox;61;60;60;61;61;60;61;61;61;61 22:14:56 INFO - PROCESS | 4911 | |10;stanford-crypto-aes;79;80;80;80;81;80;87;80;81;79 22:14:56 INFO - PROCESS | 4911 | |11;stanford-crypto-ccm;117;113;114;109;118;131;113;110;109;116 22:14:56 INFO - PROCESS | 4911 | |12;stanford-crypto-pbkdf2;146;144;143;144;146;134;143;151;143;150 22:14:56 INFO - PROCESS | 4911 | |13;stanford-crypto-sha256-iterative;65;67;65;65;64;64;66;66;63;66 22:14:56 INFO - PROCESS | 4911 | __end_tp_report 22:14:56 INFO - PROCESS | 4911 | __start_cc_report 22:14:56 INFO - PROCESS | 4911 | _x_x_mozilla_cycle_collect,1082 22:14:56 INFO - PROCESS | 4911 | __end_cc_report 22:14:56 INFO - PROCESS | 4911 | __startTimestamp1460006096599__endTimestamp 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | ------- Summary: start ------- 22:14:56 INFO - PROCESS | 4911 | Number of tests: 14 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | [#0] ai-astar Cycles:10 Average:107.50 Median:109.00 stddev:3.54 (3.2%) stddev-sans-first:3.75 22:14:56 INFO - PROCESS | 4911 | Values: 107.0 110.0 104.0 109.0 109.0 111.0 99.0 108.0 109.0 109.0 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:154.50 stddev:20.13 (13.0%) stddev-sans-first:21.17 22:14:56 INFO - PROCESS | 4911 | Values: 155.0 124.0 154.0 173.0 126.0 151.0 155.0 131.0 181.0 127.0 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:2.02 (1.3%) stddev-sans-first:2.15 22:14:56 INFO - PROCESS | 4911 | Values: 161.0 159.0 160.0 158.0 162.0 163.0 160.0 165.0 161.0 160.0 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | [#3] audio-fft Cycles:10 Average:85.20 Median:74.50 stddev:15.75 (21.1%) stddev-sans-first:16.08 22:14:56 INFO - PROCESS | 4911 | Values: 73.0 72.0 102.0 96.0 73.0 76.0 73.0 116.0 95.0 76.0 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | [#4] audio-oscillator Cycles:10 Average:106.10 Median:92.00 stddev:22.53 (24.5%) stddev-sans-first:23.31 22:14:56 INFO - PROCESS | 4911 | Values: 92.0 92.0 140.0 93.0 92.0 92.0 141.0 92.0 92.0 135.0 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 22:14:56 INFO - PROCESS | 4911 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 118.0 117.0 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 22:14:56 INFO - PROCESS | 4911 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 145.0 147.0 145.0 145.0 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 22:14:56 INFO - PROCESS | 4911 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 94.0 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:3.10 (5.5%) stddev-sans-first:3.28 22:14:56 INFO - PROCESS | 4911 | Values: 57.0 56.0 55.0 56.0 56.0 55.0 56.0 65.0 55.0 54.0 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 22:14:56 INFO - PROCESS | 4911 | Values: 61.0 60.0 60.0 61.0 61.0 60.0 61.0 61.0 61.0 61.0 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:2.31 (2.9%) stddev-sans-first:2.37 22:14:56 INFO - PROCESS | 4911 | Values: 79.0 80.0 80.0 80.0 81.0 80.0 87.0 80.0 81.0 79.0 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:115.00 stddev:6.46 (5.6%) stddev-sans-first:6.82 22:14:56 INFO - PROCESS | 4911 | Values: 117.0 113.0 114.0 109.0 118.0 131.0 113.0 110.0 109.0 116.0 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.40 Median:145.00 stddev:4.65 (3.2%) stddev-sans-first:4.89 22:14:56 INFO - PROCESS | 4911 | Values: 146.0 144.0 143.0 144.0 146.0 134.0 143.0 151.0 143.0 150.0 22:14:56 INFO - PROCESS | 4911 | 22:14:56 INFO - PROCESS | 4911 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.50 stddev:1.20 (1.8%) stddev-sans-first:1.27 22:14:56 INFO - PROCESS | 4911 | Values: 65.0 67.0 65.0 65.0 64.0 64.0 66.0 66.0 63.0 66.0 22:14:56 INFO - PROCESS | 4911 | -------- Summary: end -------- 22:14:56 INFO - PROCESS | 4911 | 22:14:57 INFO - TEST-INFO | 4911: exit 0 22:14:57 INFO - TEST-OK | kraken | took 59568ms 22:14:57 INFO - SUITE-END | took 1170s 22:14:57 INFO - Completed test suite (00:19:30) 22:14:57 INFO - javascript benchmark 22:14:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.0822753174048, 3063.2188791858075, 3112.828794416309, 3129.04564107947, 3149.433102041632, 5102.107131252034, 5116.334876466063, 5117.3091632629585, 5189.455107213745, 5193.480651934805, 5072.619553533491, 5084.669496482726, 5101.668391554546, 5108.438071812097, 5192.247124166994, 4594.9540504595025, 4653.8371157009515, 4690.648201384893, 4745.786439610209, 4817.494163112875, 4751.0, 4755.976220118894, 4783.402074740658, 4809.5911847492835, 4817.855464336076, 4652.534746525354, 4718.221493453593, 4743.691660042121, 4746.762661866893, 4789.688670236441, 4682.157211701892, 4742.454617718972, 4752.643551733634, 4758.238681810928, 4781.258904869751, 4630.513796051433, 4683.578477936968, 4712.929306060412, 4719.905601887943, 4768.356271903283, 5109.642325037249, 5119.436861945183, 5124.0, 5142.202958541432, 5171.01750667372, 5531.032069387841, 5531.529819965308, 5537.224788529609, 5538.169274608801, 5593.496585307301, 5358.2498450217, 5479.424660410679, 5484.177373393983, 5576.1356989666665, 5624.775008999635, 5237.659552129137, 5258.789648414059, 5265.052290587731, 5273.103572392741, 5274.868128296785, 5670.574706896917, 5691.658500489983, 5695.658260504383, 5699.059655156852, 5700.828975130753, 5368.651037682538, 5456.890862182734, 5510.669359838423, 5517.144842549411, 5520.089185284463, 5537.307836520435, 5561.694106824163, 5561.972190139104, 5562.332520097614, 5568.805091821848, 5508.366537848199, 5532.5020748132865, 5534.778608855681, 5535.723213839292, 5584.301962254718, 5320.654157479828, 5528.226048353234, 5550.805721799798, 5573.69344686038, 5584.664920104807, 4192.832286708497, 4205.894852628648, 4209.368594710818, 4211.284081706117, 4247.723897946624, 3700.9814950925074, 3761.0597350662333, 3768.9057773555883, 3793.336166170909, 3810.009397556655, 5190.065788158092, 5219.42586315505, 5226.529612334908, 5269.525742683177, 5270.10408230594, 5495.2856128703015, 5509.256250406224, 5509.779608815683, 5511.724413779295, 5518.172274158828, 5146.408163061295, 5157.432682404932, 5177.8446646599905, 5184.040952423738, 5226.8954620908125, 4603.17142914272, 4618.769061546909, 4626.83806066786, 4627.421572303462, 4663.976680116578, 5633.746481408347, 5643.830685079454, 5644.971775141098, 5647.0, 5689.175069614883, 5441.374241962067, 5473.534749546333, 5516.696581687966, 5526.889462210814, 5550.583706221969, 5691.060974939089, 5701.743421545957, 5706.629069110494, 5711.8857622848145, 5735.0, 5468.043092458884, 5475.069238229431, 5475.123980163155, 5477.698726570077, 5480.342358916955, 5427.348718153847, 5458.61789674719, 5532.0595498766115, 5536.584756143225, 5573.665580065209, 5365.785368585369, 5372.382176049648, 5373.946260537345, 5379.65032272901, 5380.112281473513, 5362.570994320367, 5383.461653834742, 5385.2460655507475, 5392.245085687929, 5441.156620723794, 5139.074966506065, 5199.688018718889, 5220.634555581073, 5280.234366016983, 5305.495977882095, 5371.086915224343, 5372.382176049804, 5375.0, 5376.946230537645, 5384.515393614593, 5188.818391356284, 5190.55880250183, 5240.266362709148, 5240.2663627093, 5278.340207474066], "value": 5090.971430343774, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.274217466634, 565.0732798210934, 569.9259096317478, 583.1020228847575, 593.92575928009, 31609.68390316096, 38673.41989870154, 38944.80527597365, 39245.41131883017, 39319.21361572767, 41356.793216033875, 42018.369724454154, 42094.57905420945, 42099.78950105253, 42116.57883421172, 7854.214578542157, 8654.350923680733, 8843.77890552738, 8857.95571022144, 10356.689299321033, 9972.6509572165, 10602.522886470128, 10607.416592087433, 10607.628732994346, 10617.150627949746, 10370.740731481697, 10505.31715438494, 10505.369677819317, 10508.0, 10517.631882884101, 8152.307053900456, 10750.892491075067, 10795.29830561011, 11028.99999999992, 11039.889601103967, 10366.896331036669, 10477.79044419115, 10482.63310784119, 10485.68542943713, 10495.212859035526, 41426.1714765703, 41808.37287440691, 42011.36982945258, 42182.78908605468, 42222.57777422217, 3725.292194483067, 3738.5700644425697, 3797.829097690583, 3852.9036774080873, 3967.8809635710977, 32172.678273217436, 32204.194895127574, 32267.19332016695, 32491.51262731061, 32956.6704332956, 4270.893227669302, 4301.935470967938, 4317.11499142675, 4350.6736994725525, 4412.271975124133, 319166.0, 319202.0, 319510.0, 319663.0, 320341.0, 63151.684241579416, 63228.0, 63323.36676633267, 63574.0, 63761.36238637554, 68475.65762171158, 68676.0, 68902.0, 69022.65488672625, 69032.0, 16529.504114876574, 16866.0, 16887.07121108351, 16905.15474226284, 16981.0, 13165.407556659973, 13203.933980330037, 13236.602901912958, 13239.073264871367, 13245.20528768277, 20998.685019724715, 21297.574048519255, 21301.14795408166, 21341.78658213429, 21351.0, 6451.870962580722, 7193.9280607194305, 7275.67259473325, 7298.56208627484, 7496.962515187389, 1065.616378103882, 1083.5480456188745, 1153.2849633227452, 1170.9695467988286, 1216.355331674214, 30280.0, 30918.227044323623, 31104.533431998538, 31557.684423155933, 31566.36867262688, 1130.5760339872547, 1156.3697784707354, 1165.452237448398, 1192.952281908714, 1266.9809952850715, 15872.365105395886, 17216.569585760204, 17218.827811721723, 17260.654786904193, 17265.309387624606, 372889.0, 377480.0, 379948.0, 381291.0, 381518.0, 56336.0, 56839.71580142155, 57004.144937825964, 57011.0, 57106.0, 1276.44474653526, 1349.2241960872539, 1398.741232871922, 1414.130309859429, 1417.121384741467, 30513.084607461813, 31714.365712685154, 32108.518372224902, 32297.35405291928, 32823.83588082044, 45169.77415112904, 45701.314480282155, 45771.542284576724, 45861.31208031815, 45870.77064614656, 249961.0, 255393.0, 255739.88520229864, 255791.0, 256925.0, 34395.0, 34410.0, 34689.306213875076, 34711.826440868645, 34760.30479390347, 44627.55372446234, 45205.32192017188, 45421.54578454173, 45730.31404528868, 46287.53712462967, 37606.62393376031, 38353.616463835, 38453.80773096117, 38572.2285554293, 38869.0, 37664.62335376611, 37781.622183777814, 38195.809020954715, 38419.231615366974, 38974.41538376983, 38460.230795384494, 38586.42120368253, 38722.41916371313, 39348.409773853986, 39846.60153398429, 33101.33797324088, 34007.0, 34458.310833782685, 34531.136721581155, 34565.48151777675, 27283.454330912875, 27474.862625686743, 27626.171214863585, 27652.44695106127, 27688.58467123035], "value": 19978.411231460086, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.92826470573533, 353.803638980366, 364.70458928268107, 375.9022654109932, 376.6403085053774, 17370.0, 17400.91299543502, 19104.808951910476, 19106.522336941547, 19118.13968371425, 18190.454286371398, 18884.828244751825, 19120.521986950334, 19144.329948451807, 19151.616967660637, 5407.107827208516, 5638.267025286707, 5664.886702265952, 5673.8581535461735, 5675.3757086720425, 5372.623916325859, 5520.337559492867, 5628.352739434956, 5629.6340737852115, 5631.2960879890015, 5536.307961504812, 5565.332160140789, 5568.52667523261, 5571.804986825462, 5572.192032155335, 5349.438308977579, 5520.641158324716, 5521.337439507245, 5531.3915469298345, 5531.640443371168, 4877.658563900528, 4918.5573298403315, 4926.5812405945535, 4944.35723355965, 4950.851474455772, 12897.742045159044, 13311.001674874326, 13314.733705325936, 22052.77947220523, 22105.557888842133, 2262.5814224368546, 2357.2574638988835, 2463.027104293812, 2467.987660061688, 2608.3479130217447, 9751.122398984126, 10134.949325253327, 10279.948600257025, 10446.373217606968, 10464.110550603207, 1970.0740651893586, 2037.5211825221209, 2059.7528296604355, 2066.638338290793, 2071.1301253473425, 66034.66982665056, 66544.3345566543, 66744.6662766683, 67362.32637673659, 70019.64990175016, 10154.289199756095, 10159.542820573091, 10291.94854025725, 10396.16830653561, 10449.738756531147, 14187.290635468185, 14316.355763990645, 14333.0, 14346.354414051393, 14351.210683412304, 7755.30202281786, 8015.639296231683, 8066.11272759996, 8128.918710812816, 8138.470999385021, 7874.527528348317, 7902.7234046809235, 8038.0, 8059.234372734581, 8062.55655938929, 4443.955560444419, 4511.887202819956, 4514.81940722374, 4518.751468669255, 4592.88517787058, 1822.7357033230373, 1873.6721073812027, 1886.735856980024, 1888.8488920886296, 1912.1490936533387, 992.3648864726581, 997.8253805583994, 1016.3343010328247, 1029.2846471702096, 1126.0, 18376.0, 19026.809731902504, 19394.612107757766, 19511.0, 19542.804571954384, 1001.4441984698562, 1002.2032484175098, 1072.7371793910386, 1117.3016864459712, 1125.2179735084037, 10563.735906602396, 10962.287451315638, 11101.666949991513, 11103.888961110448, 11128.109751219883, 499835.0, 515372.0, 515650.0, 521264.0, 521572.0, 73752.0, 74539.25460745323, 75490.62254688691, 76442.6177869107, 76735.23264767393, 1060.2101434431397, 1106.87824339321, 1107.4020029184312, 1114.2200459678259, 1121.1087185687397, 16841.578960526083, 16911.0, 17127.57181070483, 17241.65516689634, 17347.56631084233, 36901.0, 38194.236115278094, 38259.0, 38562.2287554253, 38772.612273878025, 53148.73425632847, 53313.73343133259, 53565.0, 53939.46060539344, 54052.18921716256, 8087.353011759163, 8240.587970601566, 8318.875216871873, 8371.62327695243, 8471.703490377808, 12013.63959081229, 13092.934535327262, 13129.803052954405, 13226.272555009182, 13245.337733113498, 11202.15983801202, 11395.886041139482, 11460.19778615489, 11734.0, 12046.879531204575, 11298.322100673986, 11404.144689148514, 11429.771404572028, 11622.244554103956, 11858.407079646156, 11628.418579071182, 11814.350210738492, 11936.28382297065, 12254.693632659255, 12447.315397653216, 8290.170982901662, 8344.457610255315, 8397.622107005322, 8439.451435656663, 8492.363072769444, 11753.260359811984, 12090.093243006633, 12125.0, 12214.816777748163, 12301.261924284572], "value": 8922.000193287884, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.5248662967956, 1496.1920562896037, 1510.5166346769035, 1679.52133641912, 1809.6018875847317, 7679.92320076799, 7890.8816367754525, 7896.842063158733, 7898.170692077335, 7906.0, 7542.622868856549, 7698.7690369288875, 7710.228977102287, 7718.421118416127, 7718.614069296526, 2025.4126303372004, 2276.692646492727, 2307.5846347657457, 2330.8951097200584, 2336.707911511061, 2368.3723813189517, 2385.105585405473, 2385.439421735891, 2386.3556839653284, 2386.7613238676167, 2243.2148747938254, 2298.287530865429, 2298.4368829636765, 2300.424893776556, 2302.0, 2253.9887300563555, 2271.1029143488313, 2311.295055008222, 2313.1556981701724, 2316.9884150579137, 2168.327818376308, 2183.465051062484, 2189.9452513687124, 2194.2868567715554, 2199.3511913985412, 7779.33875620573, 7844.882326765103, 7846.960765196194, 7858.921410785876, 7874.330681892046, 4962.826301079445, 5049.545540901337, 5071.112555302807, 5080.263361812516, 5083.974580127113, 3326.850291736878, 3361.5125806757883, 3441.6730410610953, 3452.8273586320583, 3467.323871844991, 1137.687136037588, 1147.8450409194818, 1163.8021536338842, 1172.437230129534, 1189.8274750161265, 10809.297395669257, 10842.457877106192, 10905.945470272678, 10906.34561926287, 10912.181586381053, 4460.219461594273, 4536.523665015192, 4546.909061818745, 4623.791929363187, 4631.814727410933, 9369.718908432758, 9387.10822471864, 9393.530323483936, 9397.248220142372, 9410.294227932933, 4602.3786788783755, 5118.309028281209, 5123.87190320245, 5124.487551244845, 5132.948670513247, 4589.724616523019, 4608.0, 4635.513271106553, 4637.582617564368, 4662.6269898408045, 3811.123441608446, 3879.1078052048188, 3886.145048089416, 3907.96092039076, 3928.096537796323, 1259.4647274908311, 1260.1619922751452, 1263.829383033297, 1267.8922291605131, 1288.7164823738763, 1386.8751812336939, 1414.5473448496382, 1415.8725714685727, 1439.3163247457583, 1448.630599197219, 7385.778426647209, 7543.0948286206, 7544.622768861535, 7544.698212071566, 7546.132194797558, 1105.8894110588876, 1147.1740346950182, 1156.5373850459882, 1178.5580407347245, 1188.4354931407686, 5894.8821023579285, 5910.290765108214, 5940.257467816523, 5951.5238780897425, 5960.5827592068135, 8797.340199485065, 9242.907570924339, 9253.861192082124, 9264.629414823332, 9482.95258523703, 9402.200812930978, 9446.149846513847, 9459.148676619, 9485.098915603006, 9492.288078394009, 7343.449241306924, 7709.229077092358, 7820.374370050382, 7872.291493765589, 7878.0, 7393.371563417169, 7422.1835598085245, 7422.4433167513735, 7423.554586724814, 7433.516821406592, 8549.444286121383, 8719.52042637661, 8815.867761983447, 8818.29453643694, 8954.28365730727, 8607.870881936651, 8855.468671879707, 8976.910230897607, 8990.28077753765, 8995.640174392951, 6117.632942023492, 6276.027215781562, 6590.472762178918, 6738.966305168443, 6889.035535025, 7478.5138965967035, 7495.213002634645, 7560.395168386626, 7575.659095340613, 7684.65419056155, 6696.464282857457, 6748.257691654012, 6794.184697836291, 6799.898001529882, 6986.510944234058, 6508.544401892012, 6565.376289252514, 6790.083338749403, 6845.383915447634, 6851.040854280305, 6683.331666833278, 6721.966390168018, 6737.29258427858, 6739.05653208561, 6908.48186386013, 6371.04434334835, 6410.1987251593555, 6411.839704007437, 6420.6468644225015, 6422.357764223727, 6206.844828879314, 6247.937520624918, 6257.030160325156, 6259.78090766821, 6271.937280627135], "value": 4620.449287121186, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.28580338387695, 340.2480518055098, 343.1233199176105, 344.7414439170622, 350.78602052747834, 6162.661053642048, 6174.382561743823, 6181.1037399577035, 6209.254889413277, 6222.222222222216, 6094.17728606638, 6096.481799047076, 6111.083337499377, 6120.785772497963, 6127.754889804413, 4714.057188562301, 4725.031368569435, 4726.574608285254, 4727.22000869856, 4743.857684269477, 4738.336632871401, 4739.85780426586, 4748.4301883774, 4748.857534273978, 4752.192127338343, 4501.617362524189, 4653.976730116345, 4656.883577910546, 4671.906561868761, 4703.858884233478, 4618.630509559227, 4631.027484228333, 4637.397138372024, 4653.046125544255, 4656.185167595674, 3792.6586607205486, 4027.496562929634, 4028.053407449247, 4029.3351596986463, 4033.7176397652174, 5701.344345400249, 5768.942310576883, 5778.27771528559, 5780.046292361755, 5785.045467497858, 5235.869103272448, 5240.8689782755355, 5242.580593552507, 5246.396664383607, 5248.81629142982, 6179.845503862394, 6261.968690156566, 6358.300586935434, 6358.427741503287, 6361.173047503795, 4450.376947227391, 4454.465464144291, 4456.799444025027, 4457.8439754608435, 4463.129689710508, 6643.23602785681, 6712.697928593225, 6713.597184168917, 6718.328167183291, 6722.361375669304, 4522.547745225517, 4523.163214805271, 4527.0493196429115, 4527.411436513298, 4527.705699129612, 4565.315202719618, 4567.566081222279, 4569.383133277031, 4570.314452832102, 4571.679982401267, 5154.407243167084, 5333.439988801198, 5337.706426146521, 5342.171963345688, 5346.599005074557, 6533.150690410312, 6563.278039415661, 6568.6058836469965, 6591.472682185414, 6594.406503414716, 1588.968220635604, 1608.6541393600432, 1610.8389161083799, 1611.0011792688608, 1611.299084898073, 1025.2413214221422, 1037.123630532199, 1039.8284283093205, 1050.7058023753361, 1070.464767616192, 6184.319724830265, 6203.0, 6204.410580994799, 6209.161763162006, 6211.875762484725, 6642.535022548472, 6646.933530664728, 6647.169103862017, 6655.201375834834, 6658.4673226141795, 6183.258009038944, 6187.443130118221, 6194.907076393858, 6195.172424134891, 6204.844878877974, 3567.2865426914723, 3587.1390866191928, 3601.3517566837695, 3602.7117830573493, 3605.2248766515327, 6779.966100169468, 6871.4502839772695, 6957.547759395623, 7013.509054366247, 7026.26224246457, 6879.0, 6916.374651956786, 6931.0643063186835, 6931.514793964475, 6934.098567186234, 6980.650967451607, 6983.057287266256, 6992.405645520188, 6994.300569943067, 6997.510174287852, 6732.528722989344, 6735.326467353226, 6737.831554211184, 6750.898736519054, 6753.898691519533, 6532.9346706534225, 6668.833279167866, 6696.263411024881, 6696.430803381572, 6704.262531121671, 6950.235474097744, 6977.895331569929, 6979.616121113388, 6991.755288564876, 7001.054857594363, 4526.502084770606, 4551.0, 4576.58810707038, 4578.725276483422, 4579.0, 6721.495887808336, 6725.697343619451, 6730.899036514358, 6733.528652994243, 6735.6968936397, 6388.174679598439, 6454.483641308778, 6495.9025614614875, 6509.251436084911, 6522.380373864476, 6450.354964503512, 6473.77341793035, 6478.773242936474, 6483.092367068709, 6487.967560162169, 6343.5876668016435, 6352.142460767737, 6365.809025729235, 6367.968160159169, 6367.981123020295, 6479.287278399278, 6551.80344589663, 6557.803265902031, 6570.375814297634, 6571.080048793268, 5933.910991335047, 6130.448259656652, 6342.175517182736, 6379.075034119934, 6396.136521569529], "value": 4867.861968488493, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.4677312973439, 826.1366871619157, 827.185222555782, 868.045150334632, 898.6944438890778, 14226.28868556572, 14362.066465679736, 14442.350094245758, 16255.0, 16671.49985500434, 15126.697466050673, 15156.924215378935, 15169.393224271016, 15184.240787960613, 15184.924075379608, 719.6653556096414, 838.7861095420675, 843.0641987394018, 855.243109847783, 861.5218553702692, 843.6372359885247, 856.6316483911916, 859.9914000860006, 866.4238281542766, 866.8266346730647, 875.9605817738185, 886.3751055505853, 891.9866202006975, 894.0880302091863, 894.4901406198469, 745.7427187620262, 873.3668090634271, 884.1335491218578, 898.2230370729272, 899.6131663384742, 643.9001954697029, 648.1023782061831, 651.8728847874667, 653.1443808610687, 654.46334006115, 14129.081609695337, 14178.929105354511, 14186.290685465685, 14227.50203742864, 14267.215303158322, 12902.483900643963, 12946.48214071436, 13137.671558211026, 13235.13971591853, 13319.134256273312, 11304.37825919574, 11323.377214253213, 11332.773344533145, 11451.026662733595, 11613.18707690462, 3698.907527311812, 3719.4234893591265, 3762.811859407046, 3775.377062784637, 3794.6015668354703, 58040.41959580393, 58337.7083114586, 58610.413895860926, 58638.0, 58858.41141588572, 9610.615575377047, 9640.517974101267, 9692.127708506268, 9721.951390243003, 10196.18430525571, 18590.721139182922, 18906.527336816416, 18920.33778817762, 18930.053497325353, 18950.52623684419, 7374.52065615744, 7466.887996680054, 7469.14104877946, 7575.772726818204, 7785.221477852283, 4614.0, 4766.499517550607, 4809.158397280462, 4810.903781924412, 4902.754862256873, 3150.6534281229046, 3176.269458024667, 3191.1064901827526, 3257.397381484433, 3260.1034715452965, 585.6749504025307, 609.9939000610026, 646.8221239159269, 650.5056157320471, 656.2223764838682, 724.9021382113348, 731.1226528166222, 739.3235189801379, 785.4148659248896, 787.4369825574627, 8825.823483530421, 9106.499142547224, 9256.352055356196, 9876.87326412098, 9978.101970822516, 722.0072400449382, 736.2674139231499, 769.0, 769.9730509432255, 801.2748462641318, 4209.431726716854, 4281.935770963438, 4341.611577630846, 4415.183191109655, 4486.932696009562, 62038.37961620416, 62507.37492625016, 62932.68533657303, 63049.054264186074, 63230.36769632245, 52669.736651316496, 53426.198607020924, 54017.45982540203, 54020.729896351055, 54557.1816422754, 50078.49921500738, 50705.23942140871, 51287.74356128195, 52046.99999999924, 52105.0, 9303.162715355651, 9606.375585586915, 9614.278929080487, 9688.660896868576, 9717.56270967794, 36994.63005369912, 37306.81346593249, 38149.23701526009, 38812.41781373225, 39013.29373709493, 42347.15305693931, 45363.54636453725, 48551.786205345146, 49087.26369104395, 50728.0, 11423.714407139889, 11510.884891150981, 11975.76048479008, 12077.39613019363, 12351.876481235073, 12813.423395947018, 13049.673758156123, 13506.729865402833, 13643.454261829416, 13689.931550342582, 11599.0, 11774.764504710029, 12223.694407639525, 12260.26438413698, 12547.18443301219, 12570.182938108994, 12804.10371274002, 12869.099163058496, 12904.741905161656, 13255.801162982756, 11978.64064078079, 12091.939540302243, 12094.0, 12192.451339689913, 12337.753244935231, 10481.580736770444, 10560.366378017343, 10837.566497340333, 10868.293560918515, 10891.292066015683, 10824.891751082703, 10834.295770774874, 10844.457777110954, 10913.126949843834, 11021.228514003942], "value": 6822.173698669777, "unit": "score"}], "name": "dromaeo_css", "value": 7199.488117518162, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 104.0, 109.0, 109.0, 111.0, 99.0, 108.0, 109.0, 109.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 154.0, 173.0, 126.0, 151.0, 155.0, 131.0, 181.0, 127.0], "value": 147.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 158.0, 162.0, 163.0, 160.0, 165.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 102.0, 96.0, 73.0, 76.0, 73.0, 116.0, 95.0, 76.0], "value": 85.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 140.0, 93.0, 92.0, 92.0, 141.0, 92.0, 92.0, 135.0], "value": 106.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 118.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 147.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 94.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 56.0, 56.0, 55.0, 56.0, 65.0, 55.0, 54.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 80.0, 81.0, 80.0, 87.0, 80.0, 81.0, 79.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 114.0, 109.0, 118.0, 131.0, 113.0, 110.0, 109.0, 116.0], "value": 115.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 144.0, 143.0, 144.0, 146.0, 134.0, 143.0, 151.0, 143.0, 150.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 65.0, 64.0, 64.0, 66.0, 66.0, 63.0, 66.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1487.7, "alertThreshold": 2.0}]} 22:14:57 INFO - Return code: 0 22:14:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:14:57 ERROR - # TBPL SUCCESS # 22:14:57 INFO - Running post-action listener: _resource_record_post_action 22:14:57 INFO - Running post-run listener: _resource_record_post_run 22:14:58 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 430080; Write bytes: 297332736; Read time: 56; Write time: 291552 22:14:58 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5267456; Read time: 0; Write time: 568 22:14:59 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 430080; Write bytes: 292065280; Read time: 56; Write time: 290984 22:14:59 INFO - Running post-run listener: _upload_blobber_files 22:14:59 INFO - Blob upload gear active. 22:14:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:14:59 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:14:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:14:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:14:59 INFO - (blobuploader) - INFO - Open directory for files ... 22:14:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:14:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:14:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:15:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:15:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:15:00 INFO - (blobuploader) - INFO - Done attempting. 22:15:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:15:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:15:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:15:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:15:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:15:01 INFO - (blobuploader) - INFO - Done attempting. 22:15:01 INFO - (blobuploader) - INFO - Iteration through files over. 22:15:01 INFO - Return code: 0 22:15:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:15:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:15:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/82875f0d0c195a22bcdc5f698531aadc75f94ab2b12da705092d8e0e08b27ffc37c8b81adfdbf64e3da5cdc7222e7e9942e455385241d7eaece46e6ae331ac0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2243f53f02568b172496696e4314a49aedf8bed7221a3ce18dcf788ecbe29138836da9a0077ae8eb8f96844ab706d04f4d124d19ce8a4e4e785708fe90fcb562"} 22:15:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:15:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:15:01 INFO - Contents: 22:15:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/82875f0d0c195a22bcdc5f698531aadc75f94ab2b12da705092d8e0e08b27ffc37c8b81adfdbf64e3da5cdc7222e7e9942e455385241d7eaece46e6ae331ac0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2243f53f02568b172496696e4314a49aedf8bed7221a3ce18dcf788ecbe29138836da9a0077ae8eb8f96844ab706d04f4d124d19ce8a4e4e785708fe90fcb562"} 22:15:01 INFO - Running post-run listener: copy_logs_to_upload_dir 22:15:01 INFO - Copying logs to upload dir... 22:15:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:15:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.316213 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-06 22:15:01.061307) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 22:15:01.065129) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/82875f0d0c195a22bcdc5f698531aadc75f94ab2b12da705092d8e0e08b27ffc37c8b81adfdbf64e3da5cdc7222e7e9942e455385241d7eaece46e6ae331ac0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2243f53f02568b172496696e4314a49aedf8bed7221a3ce18dcf788ecbe29138836da9a0077ae8eb8f96844ab706d04f4d124d19ce8a4e4e785708fe90fcb562"} build_url:https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011627 build_url: 'https://queue.taskcluster.net/v1/task/Kqwl_m7VTAi5BiueG92VHQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/82875f0d0c195a22bcdc5f698531aadc75f94ab2b12da705092d8e0e08b27ffc37c8b81adfdbf64e3da5cdc7222e7e9942e455385241d7eaece46e6ae331ac0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2243f53f02568b172496696e4314a49aedf8bed7221a3ce18dcf788ecbe29138836da9a0077ae8eb8f96844ab706d04f4d124d19ce8a4e4e785708fe90fcb562"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 22:15:01.090865) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 22:15:01.091228) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1459999149.270208-272515363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 22:15:01.179515) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 22:15:01.179899) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 22:15:01.180219) ========= ========= Total master_lag: 0.31 =========