builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1459907979.98 results: success (0) buildid: 20160405163015 builduid: 2d5ddd00412b4fcab27e96139a08b460 revision: 5fbeb35adff19fade0778136de16f82dce0a4579 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:39.975682) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:39.976210) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:39.976773) ========= 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=8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006358 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.000928) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.001282) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.018260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.018670) ========= 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=8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004675 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.068014) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.068367) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.068810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.069125) ========= 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=8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-05 18:59:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.6M=0s 2016-04-05 18:59:40 (66.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146334 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.229276) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.229833) ========= 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=8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018894 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.280244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.280735) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5fbeb35adff19fade0778136de16f82dce0a4579 --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 5fbeb35adff19fade0778136de16f82dce0a4579 --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=8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-05 18:59:40,509 truncating revision to first 12 chars 2016-04-05 18:59:40,509 Setting DEBUG logging. 2016-04-05 18:59:40,509 attempt 1/10 2016-04-05 18:59:40,509 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5fbeb35adff1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 18:59:40,820 unpacking tar archive at: mozilla-inbound-5fbeb35adff1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633368 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.927856) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.928241) ========= echo 5fbeb35adff19fade0778136de16f82dce0a4579 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5fbeb35adff19fade0778136de16f82dce0a4579'] 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=8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5fbeb35adff19fade0778136de16f82dce0a4579 program finished with exit code 0 elapsedTime=0.004752 script_repo_revision: '5fbeb35adff19fade0778136de16f82dce0a4579' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.979540) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.979908) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 18:59:40.993360) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-05 18:59:40.993694) ========= /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=8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:59:41 INFO - MultiFileLogger online at 20160405 18:59:41 in /builds/slave/test-pgo 18:59:41 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 18:59:41 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:59:41 INFO - {'append_to_log': False, 18:59:41 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:59:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:59:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:59:41 INFO - 'branch': 'Mozilla-Inbound', 18:59:41 INFO - 'buildbot_json_path': 'buildprops.json', 18:59:41 INFO - 'config_files': ('talos/linux_config.py',), 18:59:41 INFO - 'default_actions': ('clobber', 18:59:41 INFO - 'read-buildbot-config', 18:59:41 INFO - 'download-and-extract', 18:59:41 INFO - 'populate-webroot', 18:59:41 INFO - 'create-virtualenv', 18:59:41 INFO - 'install', 18:59:41 INFO - 'run-tests'), 18:59:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:59:41 INFO - 'download_minidump_stackwalk': True, 18:59:41 INFO - 'download_symbols': 'ondemand', 18:59:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:59:41 INFO - 'tooltool.py': '/tools/tooltool.py', 18:59:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:59:41 INFO - '/tools/misc-python/virtualenv.py')}, 18:59:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:59:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:59:41 INFO - 'installer_path': 'installer.exe', 18:59:41 INFO - 'log_level': 'info', 18:59:41 INFO - 'log_name': 'talos', 18:59:41 INFO - 'log_to_console': True, 18:59:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:59:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:59:41 INFO - 'opt_config_files': (), 18:59:41 INFO - 'pip_index': False, 18:59:41 INFO - 'sps_profile': False, 18:59:41 INFO - 'sps_profile_interval': 0, 18:59:41 INFO - 'suite': 'dromaeojs', 18:59:41 INFO - 'system_bits': '32', 18:59:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:59:41 INFO - 'title': 'talos-linux64-ix-001', 18:59:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:59:41 INFO - 'use_talos_json': True, 18:59:41 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:59:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:59:41 INFO - 'work_dir': 'build'} 18:59:41 INFO - ##### 18:59:41 INFO - ##### Running clobber step. 18:59:41 INFO - ##### 18:59:41 INFO - Running pre-action listener: _resource_record_pre_action 18:59:41 INFO - Running main action method: clobber 18:59:41 INFO - rmtree: /builds/slave/test-pgo/build 18:59:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:59:42 INFO - Running post-action listener: _resource_record_post_action 18:59:42 INFO - ##### 18:59:42 INFO - ##### Running read-buildbot-config step. 18:59:42 INFO - ##### 18:59:42 INFO - Running pre-action listener: _resource_record_pre_action 18:59:42 INFO - Running main action method: read_buildbot_config 18:59:42 INFO - Using buildbot properties: 18:59:42 INFO - { 18:59:42 INFO - "project": "", 18:59:42 INFO - "product": "firefox", 18:59:42 INFO - "script_repo_revision": "production", 18:59:42 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 18:59:42 INFO - "repository": "", 18:59:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 18:59:42 INFO - "buildid": "20160405163015", 18:59:42 INFO - "pgo_build": "True", 18:59:42 INFO - "basedir": "/builds/slave/test-pgo", 18:59:42 INFO - "buildnumber": 1676, 18:59:42 INFO - "slavename": "talos-linux64-ix-001", 18:59:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:59:42 INFO - "platform": "ubuntu64_hw", 18:59:42 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:59:42 INFO - "branch": "mozilla-inbound", 18:59:42 INFO - "repo_path": "integration/mozilla-inbound", 18:59:42 INFO - "revision": "5fbeb35adff19fade0778136de16f82dce0a4579", 18:59:42 INFO - "stage_platform": "linux64-pgo", 18:59:42 INFO - "builduid": "2d5ddd00412b4fcab27e96139a08b460", 18:59:42 INFO - "slavebuilddir": "test" 18:59:42 INFO - } 18:59:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:59:42 INFO - Running post-action listener: _resource_record_post_action 18:59:42 INFO - ##### 18:59:42 INFO - ##### Running download-and-extract step. 18:59:42 INFO - ##### 18:59:42 INFO - Running pre-action listener: _resource_record_pre_action 18:59:42 INFO - Running main action method: download_and_extract 18:59:42 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:42 INFO - https://queue.taskcluster.net/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/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 18:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/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 18:59:44 INFO - Downloaded 1361 bytes. 18:59:44 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:59:44 INFO - Using the following test package requirements: 18:59:44 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:59:44 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:59:44 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:59:44 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:44 INFO - u'jsshell-linux-x86_64.zip'], 18:59:44 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:59:44 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:59:44 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:59:44 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:59:44 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:59:44 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:59:44 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:44 INFO - https://queue.taskcluster.net/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:59:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:59:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:59:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/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 18:59:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/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 18:59:46 INFO - Downloaded 23701112 bytes. 18:59:46 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'] 18:59:46 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 18:59:47 INFO - Return code: 0 18:59:47 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 18:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:47 INFO - https://queue.taskcluster.net/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:59:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:59:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:59:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/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 18:59:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/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 18:59:50 INFO - Downloaded 23701112 bytes. 18:59:50 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'] 18:59:50 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 18:59:52 INFO - Return code: 0 18:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:52 INFO - https://queue.taskcluster.net/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:59:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:59:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:59:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/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 18:59:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/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 18:59:53 INFO - Downloaded 10847617 bytes. 18:59:53 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'] 18:59:53 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 18:59:53 INFO - Return code: 0 18:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:53 INFO - https://queue.taskcluster.net/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:59:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:59:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:59:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/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 18:59:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZK8WdIDcRMidwsd8j5p8uw/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 18:59:54 INFO - Downloaded 57812047 bytes. 18:59:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:59:54 INFO - mkdir: /builds/slave/test-pgo/properties 18:59:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:59:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:59:54 INFO - Contents: 18:59:54 INFO - build_url:https://queue.taskcluster.net/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:59:55 INFO - Running post-action listener: _resource_record_post_action 18:59:55 INFO - Running post-action listener: set_extra_try_arguments 18:59:55 INFO - ##### 18:59:55 INFO - ##### Running populate-webroot step. 18:59:55 INFO - ##### 18:59:55 INFO - Running pre-action listener: _resource_record_pre_action 18:59:55 INFO - Running main action method: populate_webroot 18:59:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:59:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:59:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:59:55 INFO - '--tppagecycles', 18:59:55 INFO - '7'], 18:59:55 INFO - 'tests': ['tsvgm']}}, 18:59:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:59:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:59:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:59:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:59:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:59:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:59:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:55 INFO - 'talos_options': ['--disable-e10s'], 18:59:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:55 INFO - 'talos_options': ['--disable-e10s'], 18:59:55 INFO - 'tests': ['damp', 'tps']}, 18:59:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:55 INFO - 'tests': ['damp', 'tps']}, 18:59:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:59:55 INFO - 'tests': ['dromaeo_dom']}, 18:59:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:59:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:59:55 INFO - 'tests': ['a11yr', 18:59:55 INFO - 'ts_paint', 18:59:55 INFO - 'tpaint', 18:59:55 INFO - 'sessionrestore', 18:59:55 INFO - 'sessionrestore_no_auto_restore', 18:59:55 INFO - 'tabpaint']}, 18:59:55 INFO - 'other-e10s': {'tests': ['a11yr', 18:59:55 INFO - 'ts_paint', 18:59:55 INFO - 'tpaint', 18:59:55 INFO - 'sessionrestore', 18:59:55 INFO - 'sessionrestore_no_auto_restore', 18:59:55 INFO - 'tabpaint']}, 18:59:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:59:55 INFO - 'ts_paint', 18:59:55 INFO - 'tpaint', 18:59:55 INFO - 'sessionrestore', 18:59:55 INFO - 'sessionrestore_no_auto_restore', 18:59:55 INFO - 'tabpaint']}, 18:59:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:59:55 INFO - 'ts_paint', 18:59:55 INFO - 'tpaint', 18:59:55 INFO - 'sessionrestore', 18:59:55 INFO - 'sessionrestore_no_auto_restore', 18:59:55 INFO - 'tabpaint']}, 18:59:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:59:55 INFO - 'tests': ['a11yr', 18:59:55 INFO - 'ts_paint', 18:59:55 INFO - 'tpaint', 18:59:55 INFO - 'sessionrestore', 18:59:55 INFO - 'sessionrestore_no_auto_restore', 18:59:55 INFO - 'tabpaint']}, 18:59:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:59:55 INFO - 'tests': ['a11yr', 18:59:55 INFO - 'ts_paint', 18:59:55 INFO - 'tpaint', 18:59:55 INFO - 'sessionrestore', 18:59:55 INFO - 'sessionrestore_no_auto_restore', 18:59:55 INFO - 'tabpaint']}, 18:59:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:59:55 INFO - 'tests': ['tsvgx', 18:59:55 INFO - 'tsvgr_opacity', 18:59:55 INFO - 'tart', 18:59:55 INFO - 'tscrollx', 18:59:55 INFO - 'cart']}, 18:59:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:59:55 INFO - 'tsvgr_opacity', 18:59:55 INFO - 'tart', 18:59:55 INFO - 'tscrollx', 18:59:55 INFO - 'cart']}, 18:59:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:55 INFO - 'talos_options': ['--disable-e10s'], 18:59:55 INFO - 'tests': ['tp5o']}, 18:59:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:55 INFO - 'tests': ['tp5o']}, 18:59:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:55 INFO - 'talos_options': ['--disable-e10s', 18:59:55 INFO - '--xperf_path', 18:59:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:55 INFO - 'tests': ['tp5n']}, 18:59:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:55 INFO - 'talos_options': ['--xperf_path', 18:59:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:55 INFO - 'tests': ['tp5n']}}, 18:59:55 INFO - 'talos.zip': {'path': '', 18:59:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:59:55 INFO - Running post-action listener: _resource_record_post_action 18:59:55 INFO - ##### 18:59:55 INFO - ##### Running create-virtualenv step. 18:59:55 INFO - ##### 18:59:55 INFO - Running pre-action listener: _resource_record_pre_action 18:59:55 INFO - Running main action method: create_virtualenv 18:59:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:59:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 18:59:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:59:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:59:55 INFO - Using real prefix '/usr' 18:59:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:59:56 INFO - Installing distribute.............................................................................................................................................................................................done. 18:59:58 INFO - Installing pip.................done. 18:59:58 INFO - Return code: 0 18:59:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:58 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 0x7fd203e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16118d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08b0>, '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 0x16a17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a1c60>, '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': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:59:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:59:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:59:58 INFO - Using env: {'DISPLAY': ':0', 18:59:58 INFO - 'HOME': '/home/cltbld', 18:59:58 INFO - 'LANG': 'en_US.UTF-8', 18:59:58 INFO - 'LANGUAGE': 'en_US:en', 18:59:58 INFO - 'LOGNAME': 'cltbld', 18:59:58 INFO - 'MAIL': '/var/mail/cltbld', 18:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:58 INFO - 'MOZ_NO_REMOTE': '1', 18:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:58 INFO - 'NO_EM_RESTART': '1', 18:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:59:58 INFO - 'PWD': '/builds/slave/test-pgo', 18:59:58 INFO - 'SHELL': '/bin/bash', 18:59:58 INFO - 'SHLVL': '1', 18:59:58 INFO - 'TERM': 'linux', 18:59:58 INFO - 'TMOUT': '86400', 18:59:58 INFO - 'USER': 'cltbld', 18:59:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', 18:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:58 INFO - '_': '/tools/buildbot/bin/python'} 18:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:59:58 INFO - Cleaning up... 18:59:58 INFO - Return code: 0 18:59:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:58 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 0x7fd203e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16118d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08b0>, '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 0x16a17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a1c60>, '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': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:59:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:59:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:59:58 INFO - Using env: {'DISPLAY': ':0', 18:59:58 INFO - 'HOME': '/home/cltbld', 18:59:58 INFO - 'LANG': 'en_US.UTF-8', 18:59:58 INFO - 'LANGUAGE': 'en_US:en', 18:59:58 INFO - 'LOGNAME': 'cltbld', 18:59:58 INFO - 'MAIL': '/var/mail/cltbld', 18:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:58 INFO - 'MOZ_NO_REMOTE': '1', 18:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:58 INFO - 'NO_EM_RESTART': '1', 18:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:59:58 INFO - 'PWD': '/builds/slave/test-pgo', 18:59:58 INFO - 'SHELL': '/bin/bash', 18:59:58 INFO - 'SHLVL': '1', 18:59:58 INFO - 'TERM': 'linux', 18:59:58 INFO - 'TMOUT': '86400', 18:59:58 INFO - 'USER': 'cltbld', 18:59:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', 18:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:58 INFO - '_': '/tools/buildbot/bin/python'} 18:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:58 INFO - Downloading/unpacking psutil>=0.7.1 18:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:58 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 19:00:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:00:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:00 INFO - Installing collected packages: psutil 19:00:00 INFO - Running setup.py install for psutil 19:00:00 INFO - building 'psutil._psutil_linux' extension 19:00:00 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 19:00:00 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 19:00:00 INFO - building 'psutil._psutil_posix' extension 19:00:00 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 19:00:00 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 19:00:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:01 INFO - Successfully installed psutil 19:00:01 INFO - Cleaning up... 19:00:01 INFO - Return code: 0 19:00:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:01 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 0x7fd203e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16118d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08b0>, '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 0x16a17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a1c60>, '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': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', '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 19:00:01 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 19:00:01 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 19:00:01 INFO - Using env: {'DISPLAY': ':0', 19:00:01 INFO - 'HOME': '/home/cltbld', 19:00:01 INFO - 'LANG': 'en_US.UTF-8', 19:00:01 INFO - 'LANGUAGE': 'en_US:en', 19:00:01 INFO - 'LOGNAME': 'cltbld', 19:00:01 INFO - 'MAIL': '/var/mail/cltbld', 19:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:01 INFO - 'MOZ_NO_REMOTE': '1', 19:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:01 INFO - 'NO_EM_RESTART': '1', 19:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:01 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:01 INFO - 'SHELL': '/bin/bash', 19:00:01 INFO - 'SHLVL': '1', 19:00:01 INFO - 'TERM': 'linux', 19:00:01 INFO - 'TMOUT': '86400', 19:00:01 INFO - 'USER': 'cltbld', 19:00:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', 19:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:01 INFO - '_': '/tools/buildbot/bin/python'} 19:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:00:01 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 19:00:01 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 19:00:01 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 19:00:01 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 19:00:01 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 19:00:01 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 19:00:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:00:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:00:03 INFO - Installing collected packages: mozsystemmonitor 19:00:03 INFO - Running setup.py install for mozsystemmonitor 19:00:03 INFO - Successfully installed mozsystemmonitor 19:00:03 INFO - Cleaning up... 19:00:03 INFO - Return code: 0 19:00:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:00: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')]} 19:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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')]} 19:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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', '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 0x7fd203e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16118d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08b0>, '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 0x16a17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a1c60>, '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': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', '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 19:00: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:00: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 blobuploader==1.2.4 19:00:03 INFO - Using env: {'DISPLAY': ':0', 19:00:03 INFO - 'HOME': '/home/cltbld', 19:00:03 INFO - 'LANG': 'en_US.UTF-8', 19:00:03 INFO - 'LANGUAGE': 'en_US:en', 19:00:03 INFO - 'LOGNAME': 'cltbld', 19:00:03 INFO - 'MAIL': '/var/mail/cltbld', 19:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:03 INFO - 'MOZ_NO_REMOTE': '1', 19:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:03 INFO - 'NO_EM_RESTART': '1', 19:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:03 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:03 INFO - 'SHELL': '/bin/bash', 19:00:03 INFO - 'SHLVL': '1', 19:00:03 INFO - 'TERM': 'linux', 19:00:03 INFO - 'TMOUT': '86400', 19:00:03 INFO - 'USER': 'cltbld', 19:00:03 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', 19:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:03 INFO - '_': '/tools/buildbot/bin/python'} 19:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:03 INFO - Downloading/unpacking blobuploader==1.2.4 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00:05 INFO - Downloading blobuploader-1.2.4.tar.gz 19:00:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:00:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:00:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00:06 INFO - Downloading docopt-0.6.1.tar.gz 19:00:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:00:06 INFO - Installing collected packages: blobuploader, requests, docopt 19:00:06 INFO - Running setup.py install for blobuploader 19:00:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:00:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:00:06 INFO - Running setup.py install for requests 19:00:06 INFO - Running setup.py install for docopt 19:00:06 INFO - Successfully installed blobuploader requests docopt 19:00:06 INFO - Cleaning up... 19:00:06 INFO - Return code: 0 19:00:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:06 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 0x7fd203e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16118d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08b0>, '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 0x16a17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a1c60>, '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': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', '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 19:00:06 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 19:00:06 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 19:00:06 INFO - Using env: {'DISPLAY': ':0', 19:00:06 INFO - 'HOME': '/home/cltbld', 19:00:06 INFO - 'LANG': 'en_US.UTF-8', 19:00:06 INFO - 'LANGUAGE': 'en_US:en', 19:00:06 INFO - 'LOGNAME': 'cltbld', 19:00:06 INFO - 'MAIL': '/var/mail/cltbld', 19:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:06 INFO - 'MOZ_NO_REMOTE': '1', 19:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:06 INFO - 'NO_EM_RESTART': '1', 19:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:06 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:06 INFO - 'SHELL': '/bin/bash', 19:00:06 INFO - 'SHLVL': '1', 19:00:06 INFO - 'TERM': 'linux', 19:00:06 INFO - 'TMOUT': '86400', 19:00:06 INFO - 'USER': 'cltbld', 19:00:06 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', 19:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:06 INFO - '_': '/tools/buildbot/bin/python'} 19:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:00:07 INFO - Running setup.py (path:/tmp/pip-kJzw11-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:00:07 INFO - Running setup.py (path:/tmp/pip-pesCWv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:00:07 INFO - Running setup.py (path:/tmp/pip-8nBx9P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:00:07 INFO - Running setup.py (path:/tmp/pip-_xyZm5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:00:07 INFO - Running setup.py (path:/tmp/pip-ZU5Dlv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:00:07 INFO - Running setup.py (path:/tmp/pip-Q38ZkX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:00:07 INFO - Running setup.py (path:/tmp/pip-g8RqJX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:00:07 INFO - Running setup.py (path:/tmp/pip-qsc_rV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:00:07 INFO - Running setup.py (path:/tmp/pip-utgP6t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:00:07 INFO - Running setup.py (path:/tmp/pip-DdIHKc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:00:07 INFO - Running setup.py (path:/tmp/pip-QJRJsz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:00:07 INFO - Running setup.py (path:/tmp/pip-veX9Sy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:00:08 INFO - Running setup.py (path:/tmp/pip-EihXhJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:00:08 INFO - Running setup.py (path:/tmp/pip-6CveYY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:00:08 INFO - Running setup.py (path:/tmp/pip-o3Rwr_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:00:08 INFO - Running setup.py (path:/tmp/pip-Y6LjEO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:00:08 INFO - Running setup.py (path:/tmp/pip-Y1bPJ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:00:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:00:08 INFO - Running setup.py install for manifestparser 19:00:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:00:08 INFO - Running setup.py install for mozcrash 19:00:08 INFO - Running setup.py install for mozdebug 19:00:08 INFO - Running setup.py install for mozdevice 19:00:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:00:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:00:08 INFO - Running setup.py install for mozfile 19:00:08 INFO - Running setup.py install for mozhttpd 19:00:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:00:09 INFO - Running setup.py install for mozinfo 19:00:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:00:09 INFO - Running setup.py install for mozInstall 19:00:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:00:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:00:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:00:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:00:09 INFO - Running setup.py install for mozleak 19:00:09 INFO - Running setup.py install for mozlog 19:00:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:00:09 INFO - Running setup.py install for moznetwork 19:00:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:00:09 INFO - Running setup.py install for mozprocess 19:00:09 INFO - Running setup.py install for mozprofile 19:00:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:00:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:00:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:00:09 INFO - Running setup.py install for mozrunner 19:00:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:00:09 INFO - Running setup.py install for mozscreenshot 19:00:09 INFO - Running setup.py install for moztest 19:00:10 INFO - Running setup.py install for mozversion 19:00:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:00:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:00:10 INFO - Cleaning up... 19:00:10 INFO - Return code: 0 19:00:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:10 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 0x7fd203e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16118d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08b0>, '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 0x16a17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a1c60>, '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': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', '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 19:00:10 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 19:00:10 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 19:00:10 INFO - Using env: {'DISPLAY': ':0', 19:00:10 INFO - 'HOME': '/home/cltbld', 19:00:10 INFO - 'LANG': 'en_US.UTF-8', 19:00:10 INFO - 'LANGUAGE': 'en_US:en', 19:00:10 INFO - 'LOGNAME': 'cltbld', 19:00:10 INFO - 'MAIL': '/var/mail/cltbld', 19:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:10 INFO - 'MOZ_NO_REMOTE': '1', 19:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:10 INFO - 'NO_EM_RESTART': '1', 19:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:10 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:10 INFO - 'SHELL': '/bin/bash', 19:00:10 INFO - 'SHLVL': '1', 19:00:10 INFO - 'TERM': 'linux', 19:00:10 INFO - 'TMOUT': '86400', 19:00:10 INFO - 'USER': 'cltbld', 19:00:10 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', 19:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:10 INFO - '_': '/tools/buildbot/bin/python'} 19:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:00:10 INFO - Running setup.py (path:/tmp/pip-zdcXRZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:00:10 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)) 19:00:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:00:10 INFO - Running setup.py (path:/tmp/pip-UvqZQI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:00:10 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)) 19:00:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:00:10 INFO - Running setup.py (path:/tmp/pip-dPw0RM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:00:10 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)) 19:00:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:00:10 INFO - Running setup.py (path:/tmp/pip-VbisT2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:00:10 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)) 19:00:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:00:10 INFO - Running setup.py (path:/tmp/pip-cV9SbA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:00:10 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)) 19:00:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:00:10 INFO - Running setup.py (path:/tmp/pip-lPxbHn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:00:10 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)) 19:00:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:00:10 INFO - Running setup.py (path:/tmp/pip-p4AL4Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:00:10 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)) 19:00:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:00:10 INFO - Running setup.py (path:/tmp/pip-bJo4uz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:00:10 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)) 19:00:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:00:10 INFO - Running setup.py (path:/tmp/pip-cXQp9E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:00:11 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)) 19:00:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:00:11 INFO - Running setup.py (path:/tmp/pip-aXBTKK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:00:11 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)) 19:00:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:00:11 INFO - Running setup.py (path:/tmp/pip-yk7aQQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:00:11 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)) 19:00:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:00:11 INFO - Running setup.py (path:/tmp/pip-wMtoES-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:00:11 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)) 19:00:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:00:11 INFO - Running setup.py (path:/tmp/pip-_esLkh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:00:11 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)) 19:00:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:00:11 INFO - Running setup.py (path:/tmp/pip-w1KpSt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:00:11 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)) 19:00:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:00:11 INFO - Running setup.py (path:/tmp/pip-8PIPcU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:00:11 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)) 19:00:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:00:11 INFO - Running setup.py (path:/tmp/pip-Nclp0s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:00:11 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)) 19:00:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:00:11 INFO - Running setup.py (path:/tmp/pip-bEaasu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:00:11 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)) 19:00:11 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)) 19:00:11 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)) 19:00:11 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)) 19:00:11 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)) 19:00:11 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)) 19:00:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:00:11 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 19:00:11 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 19:00:11 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 19:00:11 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 19:00:11 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 19:00:11 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 19:00:13 INFO - Downloading blessings-1.6.tar.gz 19:00:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:00:13 INFO - Installing collected packages: blessings 19:00:13 INFO - Running setup.py install for blessings 19:00:13 INFO - Successfully installed blessings 19:00:13 INFO - Cleaning up... 19:00:13 INFO - Return code: 0 19:00:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:00:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:00:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:00:13 INFO - Reading from file tmpfile_stdout 19:00:13 INFO - Current package versions: 19:00:13 INFO - argparse == 1.2.1 19:00:13 INFO - blessings == 1.6 19:00:13 INFO - blobuploader == 1.2.4 19:00:13 INFO - docopt == 0.6.1 19:00:13 INFO - manifestparser == 1.1 19:00:13 INFO - mozInstall == 1.12 19:00:13 INFO - mozcrash == 0.17 19:00:13 INFO - mozdebug == 0.1 19:00:13 INFO - mozdevice == 0.48 19:00:13 INFO - mozfile == 1.2 19:00:13 INFO - mozhttpd == 0.7 19:00:13 INFO - mozinfo == 0.9 19:00:13 INFO - mozleak == 0.1 19:00:13 INFO - mozlog == 3.1 19:00:13 INFO - moznetwork == 0.27 19:00:13 INFO - mozprocess == 0.22 19:00:13 INFO - mozprofile == 0.28 19:00:13 INFO - mozrunner == 6.11 19:00:13 INFO - mozscreenshot == 0.1 19:00:13 INFO - mozsystemmonitor == 0.0 19:00:13 INFO - moztest == 0.7 19:00:13 INFO - mozversion == 1.4 19:00:13 INFO - psutil == 3.1.1 19:00:13 INFO - requests == 1.2.3 19:00:13 INFO - wsgiref == 0.1.2 19:00:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:13 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 0x7fd203e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16118d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08b0>, '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 0x16a17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a1c60>, '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': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', '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 19:00:13 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 19:00:13 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 19:00:13 INFO - Using env: {'DISPLAY': ':0', 19:00:13 INFO - 'HOME': '/home/cltbld', 19:00:13 INFO - 'LANG': 'en_US.UTF-8', 19:00:13 INFO - 'LANGUAGE': 'en_US:en', 19:00:13 INFO - 'LOGNAME': 'cltbld', 19:00:13 INFO - 'MAIL': '/var/mail/cltbld', 19:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:13 INFO - 'MOZ_NO_REMOTE': '1', 19:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:13 INFO - 'NO_EM_RESTART': '1', 19:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:13 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:13 INFO - 'SHELL': '/bin/bash', 19:00:13 INFO - 'SHLVL': '1', 19:00:13 INFO - 'TERM': 'linux', 19:00:13 INFO - 'TMOUT': '86400', 19:00:13 INFO - 'USER': 'cltbld', 19:00:13 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', 19:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:13 INFO - '_': '/tools/buildbot/bin/python'} 19:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:14 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)) 19:00:14 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)) 19:00:14 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)) 19:00:14 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)) 19:00:14 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)) 19:00:14 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)) 19:00:14 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)) 19:00:14 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)) 19:00:14 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)) 19:00:14 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)) 19:00:14 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)) 19:00:14 INFO - Cleaning up... 19:00:14 INFO - Return code: 0 19:00:14 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd203e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16118d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08b0>, '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 0x16a17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a1c60>, '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': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', '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 19:00:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:00:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:00:14 INFO - Using env: {'DISPLAY': ':0', 19:00:14 INFO - 'HOME': '/home/cltbld', 19:00:14 INFO - 'LANG': 'en_US.UTF-8', 19:00:14 INFO - 'LANGUAGE': 'en_US:en', 19:00:14 INFO - 'LOGNAME': 'cltbld', 19:00:14 INFO - 'MAIL': '/var/mail/cltbld', 19:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:14 INFO - 'MOZ_NO_REMOTE': '1', 19:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:14 INFO - 'NO_EM_RESTART': '1', 19:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:14 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:14 INFO - 'SHELL': '/bin/bash', 19:00:14 INFO - 'SHLVL': '1', 19:00:14 INFO - 'TERM': 'linux', 19:00:14 INFO - 'TMOUT': '86400', 19:00:14 INFO - 'USER': 'cltbld', 19:00:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', 19:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:14 INFO - '_': '/tools/buildbot/bin/python'} 19:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:14 INFO - Downloading/unpacking jsonschema 19:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:00:16 INFO - Downloading/unpacking functools32 (from jsonschema) 19:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:16 INFO - Downloading functools32-3.2.3-2.tar.gz 19:00:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:00:16 INFO - warning: no files found matching '*.txt' 19:00:16 INFO - no previously-included directories found matching 'build' 19:00:16 INFO - no previously-included directories found matching 'dist' 19:00:16 INFO - no previously-included directories found matching '.git*' 19:00:16 INFO - Installing collected packages: jsonschema, functools32 19:00:16 INFO - Running setup.py install for functools32 19:00:16 INFO - warning: no files found matching '*.txt' 19:00:16 INFO - no previously-included directories found matching 'build' 19:00:16 INFO - no previously-included directories found matching 'dist' 19:00:16 INFO - no previously-included directories found matching '.git*' 19:00:16 INFO - Successfully installed jsonschema functools32 19:00:16 INFO - Cleaning up... 19:00:16 INFO - Return code: 0 19:00:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:00: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')]} 19:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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')]} 19:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:16 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 0x7fd203e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16118d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08b0>, '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 0x16a17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a1c60>, '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': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', '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 19:00:16 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 19:00:16 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 19:00:16 INFO - Using env: {'DISPLAY': ':0', 19:00:16 INFO - 'HOME': '/home/cltbld', 19:00:16 INFO - 'LANG': 'en_US.UTF-8', 19:00:16 INFO - 'LANGUAGE': 'en_US:en', 19:00:16 INFO - 'LOGNAME': 'cltbld', 19:00:16 INFO - 'MAIL': '/var/mail/cltbld', 19:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:16 INFO - 'MOZ_NO_REMOTE': '1', 19:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:16 INFO - 'NO_EM_RESTART': '1', 19:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:16 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:16 INFO - 'SHELL': '/bin/bash', 19:00:16 INFO - 'SHLVL': '1', 19:00:16 INFO - 'TERM': 'linux', 19:00:16 INFO - 'TMOUT': '86400', 19:00:16 INFO - 'USER': 'cltbld', 19:00:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', 19:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:16 INFO - '_': '/tools/buildbot/bin/python'} 19:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:16 INFO - Downloading/unpacking flake8 19:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:00:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:00:18 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 19:00:18 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 19:00:18 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 19:00:18 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 19:00:18 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 19:00:18 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 19:00:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:00:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:00:19 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 19:00:19 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 19:00:19 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 19:00:19 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 19:00:19 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 19:00:19 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 19:00:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:00:19 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 19:00:19 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 19:00:19 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 19:00:19 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 19:00:19 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 19:00:19 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 19:00:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:00:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:00:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:00:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:00:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:00:19 INFO - no previously-included directories found matching 'docs/_build' 19:00:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:00:19 INFO - Running setup.py install for pep8 19:00:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:00:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:00:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:00:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:00:19 INFO - no previously-included directories found matching 'docs/_build' 19:00:19 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:00:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:00:19 INFO - Cleaning up... 19:00:19 INFO - Return code: 0 19:00:19 INFO - Running post-action listener: _resource_record_post_action 19:00:19 INFO - Running post-action listener: _start_resource_monitoring 19:00:19 INFO - Starting resource monitoring. 19:00:19 INFO - ##### 19:00:19 INFO - ##### Running install step. 19:00:19 INFO - ##### 19:00:19 INFO - Running pre-action listener: _resource_record_pre_action 19:00:19 INFO - Running main action method: install 19:00:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:00:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:00:20 INFO - Reading from file tmpfile_stdout 19:00:20 INFO - Detecting whether we're running mozinstall >=1.0... 19:00:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:00:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:00:20 INFO - Reading from file tmpfile_stdout 19:00:20 INFO - Output received: 19:00:20 INFO - Usage: mozinstall [options] installer 19:00:20 INFO - Options: 19:00:20 INFO - -h, --help show this help message and exit 19:00:20 INFO - -d DEST, --destination=DEST 19:00:20 INFO - Directory to install application into. [default: 19:00:20 INFO - "/builds/slave/test-pgo"] 19:00:20 INFO - --app=APP Application being installed. [default: firefox] 19:00:20 INFO - mkdir: /builds/slave/test-pgo/build/application 19:00:20 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'] 19:00:20 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 19:00:36 INFO - Reading from file tmpfile_stdout 19:00:36 INFO - Output received: 19:00:36 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:00:36 INFO - Running post-action listener: _resource_record_post_action 19:00:36 INFO - ##### 19:00:36 INFO - ##### Running run-tests step. 19:00:36 INFO - ##### 19:00:36 INFO - Running pre-action listener: _resource_record_pre_action 19:00:36 INFO - Running main action method: run_tests 19:00:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:00:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:00:36 INFO - Python 2.7.3 19:00:36 INFO - Return code: 0 19:00:36 INFO - grabbing minidump binary from tooltool 19:00:36 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')]} 19:00:36 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 0x16a08b0>, '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 0x16a17b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a1c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:00:36 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 19:00:36 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 19:00:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:00:36 INFO - Return code: 0 19:00:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:00:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:00:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:00:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:00:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:00:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:00:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:00:37 INFO - Return code: 0 19:00:37 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/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 19:00:37 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/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 19:00:37 INFO - Using env: {'DISPLAY': ':0', 19:00:37 INFO - 'HOME': '/home/cltbld', 19:00:37 INFO - 'LANG': 'en_US.UTF-8', 19:00:37 INFO - 'LANGUAGE': 'en_US:en', 19:00:37 INFO - 'LOGNAME': 'cltbld', 19:00:37 INFO - 'MAIL': '/var/mail/cltbld', 19:00:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:00:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:37 INFO - 'MOZ_NO_REMOTE': '1', 19:00:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:37 INFO - 'NO_EM_RESTART': '1', 19:00:37 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:37 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:37 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:00:37 INFO - 'SHELL': '/bin/bash', 19:00:37 INFO - 'SHLVL': '1', 19:00:37 INFO - 'TERM': 'linux', 19:00:37 INFO - 'TMOUT': '86400', 19:00:37 INFO - 'USER': 'cltbld', 19:00:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238', 19:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:37 INFO - '_': '/tools/buildbot/bin/python'} 19:00:37 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/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 19:00:37 INFO - mozversion application_buildid: 20160405163015 19:00:37 INFO - mozversion application_changeset: 5fbeb35adff19fade0778136de16f82dce0a4579 19:00:37 INFO - mozversion application_display_name: Nightly 19:00:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:00:37 INFO - mozversion application_name: Firefox 19:00:37 INFO - mozversion application_remotingname: firefox 19:00:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:00:37 INFO - mozversion application_vendor: Mozilla 19:00:37 INFO - mozversion application_version: 48.0a1 19:00:37 INFO - mozversion platform_buildid: 20160405163015 19:00:37 INFO - mozversion platform_changeset: 5fbeb35adff19fade0778136de16f82dce0a4579 19:00:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:00:37 INFO - mozversion platform_version: 48.0a1 19:00:37 INFO - using testdate: 1459908037 19:00:37 INFO - actual date: 1459908037 19:00:37 INFO - starting webserver on 'localhost:32814' 19:00:37 INFO - SUITE-START | Running 2 tests 19:00:37 INFO - TEST-START | dromaeo_css 19:00:37 INFO - operating with platform_type : linux_ 19:00:37 INFO - Initialising browser for dromaeo_css test... 19:00:37 INFO - TEST-INFO | started process 1482 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp95FMrz/profile http://localhost:32814/getInfo.html) 19:00:41 INFO - PROCESS | 1482 | __metrics Screen width/height:1600/1200 19:00:41 INFO - PROCESS | 1482 | colorDepth:24 19:00:41 INFO - PROCESS | 1482 | Browser inner width/height: 1024/697 19:00:41 INFO - PROCESS | 1482 | __metrics 19:00:42 ERROR - PROCESS | 1482 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:00:43 INFO - TEST-INFO | 1482: exit 0 19:00:43 INFO - Browser initialized. 19:00:43 INFO - Running cycle 1/1 for dromaeo_css test... 19:00:43 INFO - TEST-INFO | started process 1563 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp95FMrz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:55 INFO - PROCESS | 1563 | RSS: Main: 152244224 19:00:55 INFO - PROCESS | 1563 | 19:01:46 INFO - PROCESS | 1563 | 1459908106953 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] 19:03:53 INFO - PROCESS | 1563 | Cycle 1(1): loaded http://localhost:32814/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32814/tests/dromaeo/cssquery-ext.html) 19:03:54 INFO - PROCESS | 1563 | RSS: Main: 256880640 19:03:54 INFO - PROCESS | 1563 | 19:06:56 INFO - PROCESS | 1563 | Cycle 1(1): loaded http://localhost:32814/tests/dromaeo/cssquery-ext.html (next: http://localhost:32814/tests/dromaeo/cssquery-jquery.html) 19:06:57 INFO - PROCESS | 1563 | RSS: Main: 234987520 19:06:57 INFO - PROCESS | 1563 | 19:09:58 INFO - PROCESS | 1563 | Cycle 1(1): loaded http://localhost:32814/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32814/tests/dromaeo/cssquery-mootools.html) 19:09:59 INFO - PROCESS | 1563 | RSS: Main: 226729984 19:09:59 INFO - PROCESS | 1563 | 19:13:01 INFO - PROCESS | 1563 | Cycle 1(1): loaded http://localhost:32814/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32814/tests/dromaeo/cssquery-prototype.html) 19:13:01 INFO - PROCESS | 1563 | RSS: Main: 217006080 19:13:01 INFO - PROCESS | 1563 | 19:16:04 INFO - PROCESS | 1563 | Cycle 1(1): loaded http://localhost:32814/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32814/tests/dromaeo/cssquery-yui.html) 19:16:04 INFO - PROCESS | 1563 | RSS: Main: 215986176 19:16:04 INFO - PROCESS | 1563 | 19:19:06 INFO - PROCESS | 1563 | Cycle 1(1): loaded http://localhost:32814/tests/dromaeo/cssquery-yui.html (next: http://localhost:32814/tests/dromaeo/cssquery-dojo.html) 19:19:07 INFO - PROCESS | 1563 | RSS: Main: 263311360 19:19:07 INFO - PROCESS | 1563 | 19:19:07 INFO - PROCESS | 1563 | __start_tp_report 19:19:07 INFO - PROCESS | 1563 | _x_x_mozilla_page_load 19:19:07 INFO - PROCESS | 1563 | _x_x_mozilla_page_load_details 19:19:07 INFO - PROCESS | 1563 | |i|pagename|runs| 19:19:07 INFO - PROCESS | 1563 | |0;dojo.html;3103.022547897412;3149.4645910195263;3176.2377029512922;3186.394585028844;3206.5831441912546;5081.187010078388;5320.414754377015;5333.599980001496;5358;5438.728063596819;5364.329458817648;5371.892562148755;5373.086575282202;5391.191321301807;5420.051490989071;4777.116233496814;4820.686655367399;4926.482719314474;4958.206686930092;4997.625178111638;4791.9520804791855;4930.506949305077;4941.950580494203;4968.652194346397;4997.200447928332;4877.341558889558;4911.557959783637;4915.82794602189;4920.532549407801;4963.106640804654;4866.206786315476;4889.608831293488;4904.975475122637;4907.705537667752;4944.283078953532;4681.438227412698;4786.760661966888;4839.153148199086;4903.436104847917;4925.630577706651;5283.233931080011;5284.9735751320995;5290.761915713802;5310.840674779763;5336.226247194174;5689.487946084872;5693.089105743061;5698.088305871082;5699.401562835926;5700.572457065737;5533.501984821345;5710.428957104298;5731.197632331477;5806.970965145148;5812.447817457335;5345.625806193568;5383.407825139231;5383.973080134613;5384.111621582434;5386.811461598864;5842.766289348463;5848.4151584841175;5858.56060795442;5864.237649105589;5866.413358664099;5389;5569.192467092249;5612.186232996192;5625.071863142535;5649.519790817826;5625.746841392147;5646.237757902631;5647.943520564824;5649.209110724501;5649.4633009864;5505.724713764376;5623.240862483594;5623.831285061455;5628.183913332626;5631.7184140793615;5644.520215781622;5698;5704.429557044263;5720.599558030981;5755.22304488897;4277.272863613193;4301.075268817157;4305.892352691208;4309.849155279613;4349.717268377545;3812.618738126165;3831.2529056834205;3883.37865941448;3884.9611503885167;3890.9610903891166;5382.1119515280325;5400.297961265089;5408.215808707715;5427;5448.210009548593;5716.828495145152;5721;5723.027085395493;5725.198472213893;5726.255586773693;5231.633785634969;5384.838454846361;5400;5405.297311349499;5446.21029950655;4925.11347957364;4929.260610908321;4934.432540257916;4945.109880221595;4966.801327946914;5888.352281249059;5888.411158884077;5890.793822216202;5895.322037965603;5898.233229680114;5534.667919924817;5693.857653558694;5745.396733343106;5778.653280803165;5788.9710551447815;5908.497777688945;5909.793157239476;5918.40815918422;5918.881622367615;5922.970385148219;5659;5664.0937450007805;5665.263515742927;5667.8866422672145;5669.376368599534;5589.636673616202;5695.8860822784145;5740.598158129058;5775.9133612995;5815.563832712648;5597.244372009726;5600.971995140161;5606.24315717373;5608.775648973995;5609.242752228397;5534.584906131976;5560.999020176246;5577.470140336662;5580.190872323409;5587.189857470563;5299;5450.645708028966;5480;5494.1758736189895;5542.0301447245765;5549.611527193058;5596.972015139898;5598.384177740527;5600.187972744011;5607.5513958884;5294.8941021180135;5458.536024437967;5460.91808622863;5461.344638643388;5507.834764957058 19:19:07 INFO - PROCESS | 1563 | |1;ext.html;554.869605642674;559.3841858453189;568.1619611073664;584.2317352681224;596.9820905372841;30251;39048.80475597621;39287;39545.011374715614;39569.60430395695;42675.14649707004;43190;43196.56803431965;43209;43319.783401082954;8655.826883462343;8846.20384165425;8863.734087977338;8867.68963086289;8872.822543549126;8765.517896515688;8887.95556022219;8894;8897.021327653953;8899.599518021705;9003.909960900406;9062.818743625123;9076.591553380114;9080.863787043167;9081.45511269326;8954.149355811187;9030.45817250967;9037.638494460247;9038.141376569216;9042.909570904305;8870.73387798367;8986.730398088068;8993.14565116313;9000.8649870252;9001.684941027033;42823.14353712939;43129.784351078044;43144.78427607873;43223.135537289396;43226.13547729059;3506.491558723996;3609.404448266033;3675.72432067596;3793.981030094832;4239.809208585591;30785;30988;31110.53334199966;31271;31414.528782068286;4095.4471146395153;4104.404861295126;4185.434966279544;4200.537940826506;4206.26390381682;325179;330685.9999999976;331928;332637;333060;67247.66376168186;68406;68463.65768171127;68518;68649.65675171593;61635.383646163864;63119.634831039875;71386.64306678434;71638.2836171642;72286.27713722795;17360.218790154475;17456.039917804643;17456.127193640266;17623.118844057746;17625.823741762673;13136.802947955788;13412.262325572186;13430.19418834873;13432;13433.19400835953;19326.323578674677;21323.147074116863;22108.668369974464;22686.14335562958;22687.659685104736;8153.673853045931;8264.917350826536;8302.958485207535;8341.708040218564;8485.32117430604;956.2597855599823;959.64972784933;1094.9069329106956;1109.4341885638382;1189.2270024484155;32622.347553048807;33070.338593228;33228.66771332304;33695.15762105967;33834.154146146546;1085.218642577343;1139.2993309115;1182.438341787644;1191.7199458127334;1196.8204769284678;14957.476488323075;15297.617559560877;15328.310226039855;15511.224438778016;15636.921815391077;208929;208988;209000;209453;211089;59841.70079149664;60343.39656603466;60754;60917.39082609206;60933;1274.139955530032;1325.9005574581945;1390.5202705066736;1410.8589141085808;1417.376354404059;31193.220169495944;32453.350932980735;33279.16802079871;33321.66678333186;33398.33203335871;46348.7682561585;46744.06511869811;46808.765956171366;48068.759656201495;48463;289991;290760;292260;292693;292819;37941.62058379381;38090.42864357092;38562.22875542417;38892;38995.220095598495;48800.267995979375;48923;49152;49473.75263123661;49753.751231243616;40750.59249407586;40897.795511022254;41243.7937810309;41279.58720412877;41665.79167104145;39109.21781564296;39534.604653953094;40316.39525407062;40492;40650.18699625932;40288.59711402848;41135.1772964533;41859.58140418557;41986.37020444635;42001;35528.46707299444;36114.27771444609;36481.81759091187;36889.07777305589;37055.25889482141;27760;28169.718302817528;28374.290642734097;28407.147785566467;28428.57357139603 19:19:07 INFO - PROCESS | 1563 | |2;jquery.html;373.7253118957566;378.35301634205507;379.05993137020187;380.4483498926557;383.1341168958154;17661;18518.537036574093;19461.221551137973;19756.70364944527;19799.604007919832;10856.511456984435;11245.156613254017;11246.718832029203;11249.43752812358;11253.381064041474;4871.7076975381415;5016.297718319438;5053.84838454847;5382.757775900074;5550.611457197998;5455.972720136394;5470.5350045246205;5487.890242195153;5505.532029777473;5507.421720719327;5108.84673459795;5181.455947125554;5461.69960652164;5462.235287059815;5467.6719396836315;5055.494450554934;5057.645964782467;5088;5093.745312734367;5102.974485127569;4877.8780530486665;4923.58149557288;4926.926096108561;4928;4930.112579735646;13200.14199077057;13441.193528388329;13569.45722171112;13576.660583485393;13587.388567514485;2244.6633005049375;2317.1079134533156;2322.6399908014114;2342.906283748648;2346.9061237550477;9712;9738.318317717763;9793.559289831976;10062.144717699004;10265.332753371007;1931.5557421793067;2011.0648152730155;2012.23535056679;2023.8380929525604;2044.9795502045088;48325.75837120792;68058.9999999995;69164.6541767288;71858.64070679665;72723;9942.602295908227;10171.949140254252;10242.846357304647;10558.366498010144;10576.206784491194;14554;14649.414023439156;14657.56027319182;14661.680448759664;14677.412903483955;7294.489385742947;7599.392048636096;7759;7852.057753069668;7972.720954766672;7184.173820010661;7571.46999710015;7599.290159714131;7839.804004899809;8068.475549089408;4395.252807022814;4430.977845110754;4579.129965306581;4594.724316541018;4634.606058485067;1833.2483681690444;1857.5634725839418;1885.3966730646337;1923.5864289177614;1936.8547358947853;917.9947956987088;961.2982522758425;1023.4473384372504;1041.7656027393928;1096.8537877917595;17932.55168620795;18003.18985645649;18269.995150266863;18563.90718046428;18597.16312765929;1024.2471783239314;1029.9794004119876;1034.5086084109987;1055.4247934875511;1073.8174510333263;10408.739781505523;10487.632932847466;10572.31279966815;10620.734481637866;10686.839697404544;454536;456123;492785;511985;518620;59869;79618;81608.59195704102;81984;82920.58539707263;1013.8732658417698;1023.3501726403787;1036.3937096798306;1062.219268837404;1062.8352605346183;15815.367385304919;15892.60268493297;16033.919830400773;16120.838791611934;16455.42406015784;33554.83222583871;33759.66240337565;33834.323313534085;34293.82853085719;35099.12252193614;48075.75962120167;53602.731986339815;53617.7319113402;53636.19545706739;53656.463435366706;7722.768316950501;7793.142754297136;7830.1472642375475;7866.842663146819;7902.170272121574;8910.087577358558;9404.95297523508;12242.449089791158;12761.361931903553;13152.276624785729;10939.890601093886;11308;11379.146564007568;11559.133065019989;11656.242344247597;11184.94407527957;11426.657200284004;11429.485673144562;11447;11542.249753765978;11470.65588032327;11685.240459370114;11733.413329333669;11745.17783755129;11832.70418239551;7496.550206987598;7567.432442566939;7567.735129270449;7718.421118416029;7844.64699088531;9807.362521436084;10447.94776026115;10473.371597703857;10491;11444.370559619301 19:19:07 INFO - PROCESS | 1563 | |3;mootools.html;1504.5862387843345;1512.3421311729396;1695.6354383807486;1796.3084212578153;1816.1373347659862;7240.2397748236335;7966.6415011324625;8069.59652017399;8269.173082691736;8294.33645308376;8053.436259461825;8077.798055048626;8117.837643247146;8118.06642236143;8132.024157101157;2230.4646884747667;2249.167807911075;2249.4826189976316;2255.323402979108;2255.357223191391;1948.3375652278223;2215.8559693619945;2262.9660555091687;2267.353804165813;2267.455810605459;2185.169635538501;2205.371469131298;2211.292386436341;2213.0815711479718;2216.390492614528;2211.6461366181493;2219.8557093788854;2222.7777222277805;2227.432004838764;2230.0522278031854;2147.6671115977047;2162.329677799887;2236.02732811226;2236.552689462098;2238.854474459155;8385.874211886827;8390.622421991025;8447.155284471564;8453.873191902127;8456.704015359495;5097.617678674077;5165.690058596496;5212.947870521284;5214.947850521484;5218.243354713545;3197.2486465680545;3257.8533965971587;3353.446681297583;3362.7646064775477;3372.4435468147726;981.651513712636;986.9407835529892;1001.6994901529512;1013.9695809125737;1016.5882817458867;11883.168178227528;11912.166148369617;11913.10651701126;11935.701607459883;11940.402979850973;4406.625436837905;4407.493138289138;4433.4236549249035;4457.219986502414;4546.1135078659345;10008.94906034856;10023.548940297704;10023.899761002442;10065.194784417228;10065.59737610502;5140.460251673595;5164.819231326961;5186.455422180692;5187.144121220032;5187.481251874782;4135.793210339471;4597.126545956257;4746.02706445178;4753.35829662998;4763.833265835679;3823.4073718573663;3882.7476214045996;3884.261990221849;3905.1994341159993;3964.1080756829483;1249.575144450891;1269.8095285707218;1287.3177216075494;1287.8840904318656;1302.5766625846638;1119.3787447966456;1130.8586426696663;1141.0187238974474;1366.3919555797772;1440.8703216710337;7625.161232264447;7764.107127680389;7815.3356964657505;7883.251091146447;7896.249856263761;457.74366354841396;462.20270034190753;463.42998112322033;468.5759387754088;472.2656269500959;6042.274927008787;6044.788432404933;6086.878262434727;6098.207233059674;6129.417705317987;9831.557579908922;10315.690529284133;10442.477876106164;10457.163426925828;10457.895421045845;10116.29185956976;10269.178465722724;10274.743131421625;10296.691099267035;10319.535620897077;7989.601819681532;8042.276195142465;8059.476134051268;8130.552819594979;8140.837183256302;7645.541267523967;7767.805804854924;7825.765227043198;7825.804354890945;7836.177201393772;9022.233110185707;9116.1339672731;9185;9366.67216647414;9370.67202647904;9279.953600231956;9366.391184572982;9511.286653500876;9536.284778641768;9669.806603867743;6568.113304703995;6766.18805743314;7434.293742094493;7480.139783924918;7672.424568157299;7889.802754931173;7953.363730901398;7988.520688758693;8000.51996880189;8003.079645840803;7142.535735177197;7258.165310989304;7268.0914885639295;7374.151972523228;7391.9651248826285;6901.89647155283;7005.684744186626;7121.074260346122;7194.2086370498155;7279.199288078201;7394.630268486447;7611.581363024865;7616.657250423855;7616.809579760328;7628.0083589133055;6967.616781077089;7032.12098487689;7033.542819716702;7043.647817609201;7044.260352663102;6772.356626120511;6821.658917054028;6846.965765171142;6848.863022739617;6865.862682746417 19:19:07 INFO - PROCESS | 1563 | |4;prototype.html;332.61416756562386;334.37138180221183;334.5984818218137;337.14197367699205;345.09068604227866;5934.5845790794665;5974.671393073385;6011.789587364432;6013.909791353122;6023.668698221596;5954.851128721784;5961.523078153748;5963.344032156459;5963.671998040106;5965;4380.189664912002;4480.215962206617;4575.611073058794;4619.399478067863;4644.419447569054;4587.1972404829185;4595.195840727876;4597.218472859622;4603.746793926332;4607.516210797869;4557.544245575433;4558.931616025762;4573.451185857702;4579.129965306581;4586.587207151356;4323.459567554056;4469.553044695537;4547.840825571122;4562.224421848294;4564.726116432991;4034.394840773878;4042.0905296308097;4047;4050.1494686115952;4067.2068946555432;5764.481196692276;5766.740496677659;5770.7691692332255;5774.249347584829;5776.046952252873;5306.461126273376;5317.41508434072;5325.334333208349;5326.014687282826;5326.094563924104;6234.283057448406;6245.781397651106;6254.937450625481;6255.593386429868;6256.96871515644;4392.560743925582;4442.977785111086;4479.552044795527;4480.462344518646;4482.417285752864;6498.545101842826;6503.28463868974;6518.739250429977;6523.8695226095215;6527.053577231322;4580.702254353457;4582.816687332536;4587.151376995266;4590.403247577793;4592.150452166293;4641.651876109306;4646.186917289461;4646.465656449484;4650.720956742606;4652.232381657056;5289.391719952255;5293.735313234323;5297.8145764898045;5299.8410047698635;5306.336707911511;6122.816315510542;6285.340039295899;6300.401461861115;6306.306306306303;6309.14826498426;1617.846304601061;1625.057466669329;1633.8611218046362;1640.1635166065394;1641.261432355421;994.5574219472265;1061.3790932304535;1075.1398880895254;1078.9244752867223;1081.2539347849959;5965.343812180657;6016.338202797689;6017.729202185825;6029.57792954489;6030.4572588467245;6393.073004414334;6405.519586031066;6409.102725618417;6412.67936603168;6414.262359828679;6000.249968753906;6012.488938440194;6015.849603759941;6016.789412370546;6024.367441418588;3441.0709108540555;3471.461923401877;3471.531343268626;3474.357243909885;3478.3565040467593;6449.419552240321;6558.213014438298;6581.2102547694585;6600.306967768412;6614.570052946543;6417.550771446047;6513.674316284167;6521.054447105238;6532.934670653232;6542.901856472156;6563.868722625521;6583.177102862142;6583.670816459158;6585.242697089896;6595.670216489157;6389.7763578274535;6393.552451328363;6412.038194270896;6413.2945376007665;6415.839604009937;6187.195664563578;6273.811785646438;6323.304436511888;6331.588446750947;6340.682965851781;6566.080748695091;6580.934190658032;6601.240857301472;6603;6604.570702904488;4485.349624304523;4492.707973981681;4505.594496495331;4507.301368287921;4507.797149128362;6372.299047104908;6381.904271435839;6387.648679322682;6393.424591786761;6393.6163830170335;6207.844803879939;6210.4100110489435;6220.720067596879;6230.719617617127;6232.034034724625;6084.33072362031;6210.285817131088;6218.347073557392;6229.719662615103;6236.719347629459;6080.787172448943;6098.390160983866;6113.266408031065;6115.694215289129;6173.69131543412;6236.688165591793;6248.312685604671;6256.124142619946;6257.749690012349;6260.060990851409;5967.37342579023;6066.666333351532;6068.817935461943;6099.054646529795;6110.633361998294 19:19:07 INFO - PROCESS | 1563 | |5;yui.html;824.1470078468786;834.7328854766473;842.8609279468888;853.6585365853662;872.0755998641439;14193.006489545724;14394.568162955115;14461.276936153203;14552.708945821078;16210.918945405287;15492.612684682861;15639.06165630063;15682.84317156828;15740.685186296267;15777.684446311066;696.3941371007231;825.6325934958945;829.5520418973762;847.2290215903529;854.2610641794834;836.0260296754274;845.6152450634946;846.5090247656344;847.7753395350206;848.9660413583449;881.9911800882005;886.1271647427279;886.6497733395337;886.9201771840533;886.9778255543631;725.2711025419446;860.5783166248524;875.1991927386434;875.7810547363159;881.4402854187605;631.1857703562399;635.3424205946823;636.9044643303495;636.9585976911486;637.1621317966859;14115.011949163563;14143.787843182361;14153.575392738234;14234.786478202835;14243.572692819233;13012.414441350162;13212.735745285041;13550.661233469144;13629.863701363058;13655.112417692819;11258.324500529994;11305.830412543819;11536;11572.942135289353;11600.535978560847;3850.4416859555486;3887.475190849256;3894.2211557688292;3902.941455878164;4011.5587285398583;54786.72606636981;54992.17511737327;55553;55613;55689.72155139239;10902.836457453144;10904.945475272572;10986.945065274622;11051.668449946354;11304.378259195659;19408.902955485133;19418.90290548538;19469.513262168275;19473;19498.12258448373;8199.467034642728;8233;8326.375521835887;8374.371922105867;8398.790030249293;4816.397950256218;4921.26181072842;4925.335079764258;4930.137225985438;5050.747462626928;3283.244853683666;3301.6698330167274;3326.8688645860525;3331.866725331008;3339.0984434203115;584.9941500585024;603.5413086054542;612.2561088277675;613.352912677121;619.8419403052193;720.9675564599605;725.6734469488752;772.9845403091907;784.1922819495928;794.3962588432832;8756.605952732143;9243.306751993627;9334.872817606043;9483.47840868745;9633.9036609633;505.46673259711355;758.2493331601675;760.3157158557232;765.1506827421557;774.233508826258;4254.361845723166;4270.530241673413;4472.552744725502;4561.338605902192;4642.489326174118;62657;63178;63226.68386658037;63409;63492;50107.74946125246;50601.49398505968;50739.23891141636;50771;50814;48230.75884620554;49111;49996.75001624969;50145.997080058194;51254;9661.396844096873;9702.214657529668;9841.901580984098;9867.95066024694;9932.106110449806;36304.818475908505;37880.43179352367;38382.80808595939;41211.793941030104;41633.79183104065;49444.50555494543;52401.7379913098;53243;53441.732791335795;54593.727031364586;13163.47346106145;13189.670258243621;13203.867961320648;13422.932885335511;13455.730885382432;13577.93211033978;13810.309484525533;13860.930695346458;14195.148291102567;14390.784138237725;12491.87508124907;12787.488500459878;13254.469821207043;13431.529896453578;13513.459461621425;12251.571195008131;12581.811272831097;12593.181443206162;12712.173708708904;12893.613191604267;12762.964320565101;13153.60539183826;13164.341782910624;13211.603651890458;13353.53262635842;10890.673279801618;11166.832497512707;11175.608853690082;11198.216124871507;11268.718282043015;11152.88847111551;11194.044744247154;11390.145739069438;11405.372704501333;11468.254563453349 19:19:07 INFO - PROCESS | 1563 | __end_tp_report 19:19:07 INFO - PROCESS | 1563 | __start_cc_report 19:19:07 INFO - PROCESS | 1563 | _x_x_mozilla_cycle_collect,794 19:19:07 INFO - PROCESS | 1563 | __end_cc_report 19:19:07 INFO - PROCESS | 1563 | __startTimestamp1459909147163__endTimestamp 19:19:07 INFO - PROCESS | 1563 | 19:19:07 INFO - PROCESS | 1563 | ------- Summary: start ------- 19:19:07 INFO - PROCESS | 1563 | Number of tests: 6 19:19:07 INFO - PROCESS | 1563 | 19:19:07 INFO - PROCESS | 1563 | [#0] dojo.html Cycles:165 Average:5302.12 Median:5480.00 stddev:591.32 (10.8%) stddev-sans-first:567.41 19:19:07 INFO - PROCESS | 1563 | Values: 3103.0 3149.5 3176.2 3186.4 3206.6 5081.2 5320.4 5333.6 5358.0 5438.7 5364.3 5371.9 5373.1 5391.2 5420.1 4777.1 4820.7 4926.5 4958.2 4997.6 4792.0 4930.5 4942.0 4968.7 4997.2 4877.3 4911.6 4915.8 4920.5 4963.1 4866.2 4889.6 4905.0 4907.7 4944.3 4681.4 4786.8 4839.2 4903.4 4925.6 5283.2 5285.0 5290.8 5310.8 5336.2 5689.5 5693.1 5698.1 5699.4 5700.6 5533.5 5710.4 5731.2 5807.0 5812.4 5345.6 5383.4 5384.0 5384.1 5386.8 5842.8 5848.4 5858.6 5864.2 5866.4 5389.0 5569.2 5612.2 5625.1 5649.5 5625.7 5646.2 5647.9 5649.2 5649.5 5505.7 5623.2 5623.8 5628.2 5631.7 5644.5 5698.0 5704.4 5720.6 5755.2 4277.3 4301.1 4305.9 4309.8 4349.7 3812.6 3831.3 3883.4 3885.0 3891.0 5382.1 5400.3 5408.2 5427.0 5448.2 5716.8 5721.0 5723.0 5725.2 5726.3 5231.6 5384.8 5400.0 5405.3 5446.2 4925.1 4929.3 4934.4 4945.1 4966.8 5888.4 5888.4 5890.8 5895.3 5898.2 5534.7 5693.9 5745.4 5778.7 5789.0 5908.5 5909.8 5918.4 5918.9 5923.0 5659.0 5664.1 5665.3 5667.9 5669.4 5589.6 5695.9 5740.6 5775.9 5815.6 5597.2 5601.0 5606.2 5608.8 5609.2 5534.6 5561.0 5577.5 5580.2 5587.2 5299.0 5450.6 5480.0 5494.2 5542.0 5549.6 5597.0 5598.4 5600.2 5607.6 5294.9 5458.5 5460.9 5461.3 5507.8 19:19:07 INFO - PROCESS | 1563 | 19:19:07 INFO - PROCESS | 1563 | [#1] ext.html Cycles:180 Average:47358.05 Median:40404.20 stddev:73585.05 (182.1%) stddev-sans-first:73707.57 19:19:07 INFO - PROCESS | 1563 | Values: 554.9 559.4 568.2 584.2 597.0 30251.0 39048.8 39287.0 39545.0 39569.6 42675.1 43190.0 43196.6 43209.0 43319.8 8655.8 8846.2 8863.7 8867.7 8872.8 8765.5 8888.0 8894.0 8897.0 8899.6 9003.9 9062.8 9076.6 9080.9 9081.5 8954.1 9030.5 9037.6 9038.1 9042.9 8870.7 8986.7 8993.1 9000.9 9001.7 42823.1 43129.8 43144.8 43223.1 43226.1 3506.5 3609.4 3675.7 3794.0 4239.8 30785.0 30988.0 31110.5 31271.0 31414.5 4095.4 4104.4 4185.4 4200.5 4206.3 325179.0 330686.0 331928.0 332637.0 333060.0 67247.7 68406.0 68463.7 68518.0 68649.7 61635.4 63119.6 71386.6 71638.3 72286.3 17360.2 17456.0 17456.1 17623.1 17625.8 13136.8 13412.3 13430.2 13432.0 13433.2 19326.3 21323.1 22108.7 22686.1 22687.7 8153.7 8264.9 8303.0 8341.7 8485.3 956.3 959.6 1094.9 1109.4 1189.2 32622.3 33070.3 33228.7 33695.2 33834.2 1085.2 1139.3 1182.4 1191.7 1196.8 14957.5 15297.6 15328.3 15511.2 15636.9 208929.0 208988.0 209000.0 209453.0 211089.0 59841.7 60343.4 60754.0 60917.4 60933.0 1274.1 1325.9 1390.5 1410.9 1417.4 31193.2 32453.4 33279.2 33321.7 33398.3 46348.8 46744.1 46808.8 48068.8 48463.0 289991.0 290760.0 292260.0 292693.0 292819.0 37941.6 38090.4 38562.2 38892.0 38995.2 48800.3 48923.0 49152.0 49473.8 49753.8 40750.6 40897.8 41243.8 41279.6 41665.8 39109.2 39534.6 40316.4 40492.0 40650.2 40288.6 41135.2 41859.6 41986.4 42001.0 35528.5 36114.3 36481.8 36889.1 37055.3 27760.0 28169.7 28374.3 28407.1 28428.6 19:19:07 INFO - PROCESS | 1563 | 19:19:07 INFO - PROCESS | 1563 | [#2] jquery.html Cycles:180 Average:26872.08 Median:17950.87 stddev:79972.76 (445.5%) stddev-sans-first:80172.35 19:19:07 INFO - PROCESS | 1563 | Values: 373.7 378.4 379.1 380.4 383.1 17661.0 18518.5 19461.2 19756.7 19799.6 10856.5 11245.2 11246.7 11249.4 11253.4 4871.7 5016.3 5053.8 5382.8 5550.6 5456.0 5470.5 5487.9 5505.5 5507.4 5108.8 5181.5 5461.7 5462.2 5467.7 5055.5 5057.6 5088.0 5093.7 5103.0 4877.9 4923.6 4926.9 4928.0 4930.1 13200.1 13441.2 13569.5 13576.7 13587.4 2244.7 2317.1 2322.6 2342.9 2346.9 9712.0 9738.3 9793.6 10062.1 10265.3 1931.6 2011.1 2012.2 2023.8 2045.0 48325.8 68059.0 69164.7 71858.6 72723.0 9942.6 10171.9 10242.8 10558.4 10576.2 14554.0 14649.4 14657.6 14661.7 14677.4 7294.5 7599.4 7759.0 7852.1 7972.7 7184.2 7571.5 7599.3 7839.8 8068.5 4395.3 4431.0 4579.1 4594.7 4634.6 1833.2 1857.6 1885.4 1923.6 1936.9 918.0 961.3 1023.4 1041.8 1096.9 17932.6 18003.2 18270.0 18563.9 18597.2 1024.2 1030.0 1034.5 1055.4 1073.8 10408.7 10487.6 10572.3 10620.7 10686.8 454536.0 456123.0 492785.0 511985.0 518620.0 59869.0 79618.0 81608.6 81984.0 82920.6 1013.9 1023.4 1036.4 1062.2 1062.8 15815.4 15892.6 16033.9 16120.8 16455.4 33554.8 33759.7 33834.3 34293.8 35099.1 48075.8 53602.7 53617.7 53636.2 53656.5 7722.8 7793.1 7830.1 7866.8 7902.2 8910.1 9405.0 12242.4 12761.4 13152.3 10939.9 11308.0 11379.1 11559.1 11656.2 11184.9 11426.7 11429.5 11447.0 11542.2 11470.7 11685.2 11733.4 11745.2 11832.7 7496.6 7567.4 7567.7 7718.4 7844.6 9807.4 10447.9 10473.4 10491.0 11444.4 19:19:07 INFO - PROCESS | 1563 | 19:19:07 INFO - PROCESS | 1563 | [#3] mootools.html Cycles:180 Average:5825.43 Median:5176.07 stddev:3151.07 (60.9%) stddev-sans-first:3143.17 19:19:07 INFO - PROCESS | 1563 | Values: 1504.6 1512.3 1695.6 1796.3 1816.1 7240.2 7966.6 8069.6 8269.2 8294.3 8053.4 8077.8 8117.8 8118.1 8132.0 2230.5 2249.2 2249.5 2255.3 2255.4 1948.3 2215.9 2263.0 2267.4 2267.5 2185.2 2205.4 2211.3 2213.1 2216.4 2211.6 2219.9 2222.8 2227.4 2230.1 2147.7 2162.3 2236.0 2236.6 2238.9 8385.9 8390.6 8447.2 8453.9 8456.7 5097.6 5165.7 5212.9 5214.9 5218.2 3197.2 3257.9 3353.4 3362.8 3372.4 981.7 986.9 1001.7 1014.0 1016.6 11883.2 11912.2 11913.1 11935.7 11940.4 4406.6 4407.5 4433.4 4457.2 4546.1 10008.9 10023.5 10023.9 10065.2 10065.6 5140.5 5164.8 5186.5 5187.1 5187.5 4135.8 4597.1 4746.0 4753.4 4763.8 3823.4 3882.7 3884.3 3905.2 3964.1 1249.6 1269.8 1287.3 1287.9 1302.6 1119.4 1130.9 1141.0 1366.4 1440.9 7625.2 7764.1 7815.3 7883.3 7896.2 457.7 462.2 463.4 468.6 472.3 6042.3 6044.8 6086.9 6098.2 6129.4 9831.6 10315.7 10442.5 10457.2 10457.9 10116.3 10269.2 10274.7 10296.7 10319.5 7989.6 8042.3 8059.5 8130.6 8140.8 7645.5 7767.8 7825.8 7825.8 7836.2 9022.2 9116.1 9185.0 9366.7 9370.7 9280.0 9366.4 9511.3 9536.3 9669.8 6568.1 6766.2 7434.3 7480.1 7672.4 7889.8 7953.4 7988.5 8000.5 8003.1 7142.5 7258.2 7268.1 7374.2 7392.0 6901.9 7005.7 7121.1 7194.2 7279.2 7394.6 7611.6 7616.7 7616.8 7628.0 6967.6 7032.1 7033.5 7043.6 7044.3 6772.4 6821.7 6847.0 6848.9 6865.9 19:19:07 INFO - PROCESS | 1563 | 19:19:07 INFO - PROCESS | 1563 | [#4] prototype.html Cycles:180 Average:5247.39 Median:6013.20 stddev:1547.39 (25.7%) stddev-sans-first:1507.12 19:19:07 INFO - PROCESS | 1563 | Values: 332.6 334.4 334.6 337.1 345.1 5934.6 5974.7 6011.8 6013.9 6023.7 5954.9 5961.5 5963.3 5963.7 5965.0 4380.2 4480.2 4575.6 4619.4 4644.4 4587.2 4595.2 4597.2 4603.7 4607.5 4557.5 4558.9 4573.5 4579.1 4586.6 4323.5 4469.6 4547.8 4562.2 4564.7 4034.4 4042.1 4047.0 4050.1 4067.2 5764.5 5766.7 5770.8 5774.2 5776.0 5306.5 5317.4 5325.3 5326.0 5326.1 6234.3 6245.8 6254.9 6255.6 6257.0 4392.6 4443.0 4479.6 4480.5 4482.4 6498.5 6503.3 6518.7 6523.9 6527.1 4580.7 4582.8 4587.2 4590.4 4592.2 4641.7 4646.2 4646.5 4650.7 4652.2 5289.4 5293.7 5297.8 5299.8 5306.3 6122.8 6285.3 6300.4 6306.3 6309.1 1617.8 1625.1 1633.9 1640.2 1641.3 994.6 1061.4 1075.1 1078.9 1081.3 5965.3 6016.3 6017.7 6029.6 6030.5 6393.1 6405.5 6409.1 6412.7 6414.3 6000.2 6012.5 6015.8 6016.8 6024.4 3441.1 3471.5 3471.5 3474.4 3478.4 6449.4 6558.2 6581.2 6600.3 6614.6 6417.6 6513.7 6521.1 6532.9 6542.9 6563.9 6583.2 6583.7 6585.2 6595.7 6389.8 6393.6 6412.0 6413.3 6415.8 6187.2 6273.8 6323.3 6331.6 6340.7 6566.1 6580.9 6601.2 6603.0 6604.6 4485.3 4492.7 4505.6 4507.3 4507.8 6372.3 6381.9 6387.6 6393.4 6393.6 6207.8 6210.4 6220.7 6230.7 6232.0 6084.3 6210.3 6218.3 6229.7 6236.7 6080.8 6098.4 6113.3 6115.7 6173.7 6236.7 6248.3 6256.1 6257.7 6260.1 5967.4 6066.7 6068.8 6099.1 6110.6 19:19:07 INFO - PROCESS | 1563 | 19:19:07 INFO - PROCESS | 1563 | [#5] yui.html Cycles:180 Average:15278.48 Median:26523.58 stddev:17467.14 (65.9%) stddev-sans-first:17482.41 19:19:07 INFO - PROCESS | 1563 | Values: 824.1 834.7 842.9 853.7 872.1 14193.0 14394.6 14461.3 14552.7 16210.9 15492.6 15639.1 15682.8 15740.7 15777.7 696.4 825.6 829.6 847.2 854.3 836.0 845.6 846.5 847.8 849.0 882.0 886.1 886.6 886.9 887.0 725.3 860.6 875.2 875.8 881.4 631.2 635.3 636.9 637.0 637.2 14115.0 14143.8 14153.6 14234.8 14243.6 13012.4 13212.7 13550.7 13629.9 13655.1 11258.3 11305.8 11536.0 11572.9 11600.5 3850.4 3887.5 3894.2 3902.9 4011.6 54786.7 54992.2 55553.0 55613.0 55689.7 10902.8 10904.9 10986.9 11051.7 11304.4 19408.9 19418.9 19469.5 19473.0 19498.1 8199.5 8233.0 8326.4 8374.4 8398.8 4816.4 4921.3 4925.3 4930.1 5050.7 3283.2 3301.7 3326.9 3331.9 3339.1 585.0 603.5 612.3 613.4 619.8 721.0 725.7 773.0 784.2 794.4 8756.6 9243.3 9334.9 9483.5 9633.9 505.5 758.2 760.3 765.2 774.2 4254.4 4270.5 4472.6 4561.3 4642.5 62657.0 63178.0 63226.7 63409.0 63492.0 50107.7 50601.5 50739.2 50771.0 50814.0 48230.8 49111.0 49996.8 50146.0 51254.0 9661.4 9702.2 9841.9 9868.0 9932.1 36304.8 37880.4 38382.8 41211.8 41633.8 49444.5 52401.7 53243.0 53441.7 54593.7 13163.5 13189.7 13203.9 13422.9 13455.7 13577.9 13810.3 13860.9 14195.1 14390.8 12491.9 12787.5 13254.5 13431.5 13513.5 12251.6 12581.8 12593.2 12712.2 12893.6 12763.0 13153.6 13164.3 13211.6 13353.5 10890.7 11166.8 11175.6 11198.2 11268.7 11152.9 11194.0 11390.1 11405.4 11468.3 19:19:07 INFO - PROCESS | 1563 | -------- Summary: end -------- 19:19:07 INFO - PROCESS | 1563 | 19:19:07 INFO - TEST-INFO | 1563: exit 0 19:19:07 INFO - TEST-OK | dromaeo_css | took 1109884ms 19:19:07 INFO - TEST-START | kraken 19:19:07 INFO - operating with platform_type : linux_ 19:19:07 INFO - Initialising browser for kraken test... 19:19:07 INFO - TEST-INFO | started process 1747 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcA70k_/profile http://localhost:32814/getInfo.html) 19:19:11 INFO - PROCESS | 1747 | __metrics Screen width/height:1600/1200 19:19:11 INFO - PROCESS | 1747 | colorDepth:24 19:19:11 INFO - PROCESS | 1747 | Browser inner width/height: 1024/697 19:19:11 INFO - PROCESS | 1747 | __metrics 19:19:13 ERROR - PROCESS | 1747 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:19:13 INFO - TEST-INFO | 1747: exit 0 19:19:13 INFO - Browser initialized. 19:19:13 INFO - Running cycle 1/1 for kraken test... 19:19:13 INFO - TEST-INFO | started process 1826 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcA70k_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:25 INFO - PROCESS | 1826 | RSS: Main: 151875584 19:19:25 INFO - PROCESS | 1826 | 19:19:27 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32814/tests/kraken/driver.html?testName=audio-beat-detection) 19:19:28 INFO - PROCESS | 1826 | RSS: Main: 193265664 19:19:28 INFO - PROCESS | 1826 | 19:19:31 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32814/tests/kraken/driver.html?testName=audio-dft) 19:19:31 INFO - PROCESS | 1826 | RSS: Main: 183705600 19:19:31 INFO - PROCESS | 1826 | 19:19:34 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32814/tests/kraken/driver.html?testName=audio-fft) 19:19:35 INFO - PROCESS | 1826 | RSS: Main: 167768064 19:19:35 INFO - PROCESS | 1826 | 19:19:37 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32814/tests/kraken/driver.html?testName=audio-oscillator) 19:19:37 INFO - PROCESS | 1826 | RSS: Main: 169693184 19:19:37 INFO - PROCESS | 1826 | 19:19:40 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32814/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:19:40 INFO - PROCESS | 1826 | RSS: Main: 172142592 19:19:40 INFO - PROCESS | 1826 | 19:19:43 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32814/tests/kraken/driver.html?testName=imaging-darkroom) 19:19:44 INFO - PROCESS | 1826 | RSS: Main: 172638208 19:19:44 INFO - PROCESS | 1826 | 19:19:47 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32814/tests/kraken/driver.html?testName=imaging-desaturate) 19:19:48 INFO - PROCESS | 1826 | RSS: Main: 172236800 19:19:48 INFO - PROCESS | 1826 | 19:19:50 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32814/tests/kraken/driver.html?testName=json-parse-financial) 19:19:51 INFO - PROCESS | 1826 | RSS: Main: 172888064 19:19:51 INFO - PROCESS | 1826 | 19:19:53 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32814/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:19:53 INFO - PROCESS | 1826 | RSS: Main: 181465088 19:19:53 INFO - PROCESS | 1826 | 19:19:55 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:19:55 INFO - PROCESS | 1826 | RSS: Main: 179142656 19:19:55 INFO - PROCESS | 1826 | 19:19:57 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:19:58 INFO - PROCESS | 1826 | RSS: Main: 188321792 19:19:58 INFO - PROCESS | 1826 | 19:20:00 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:01 INFO - PROCESS | 1826 | RSS: Main: 194600960 19:20:01 INFO - PROCESS | 1826 | 19:20:04 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:04 INFO - PROCESS | 1826 | RSS: Main: 194326528 19:20:04 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32814/tests/kraken/driver.html?testName=ai-astar) 19:20:06 INFO - PROCESS | 1826 | RSS: Main: 256598016 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | __start_tp_report 19:20:06 INFO - PROCESS | 1826 | _x_x_mozilla_page_load 19:20:06 INFO - PROCESS | 1826 | _x_x_mozilla_page_load_details 19:20:06 INFO - PROCESS | 1826 | |i|pagename|runs| 19:20:06 INFO - PROCESS | 1826 | |0;ai-astar;110;111;105;110;109;112;99;110;111;110 19:20:06 INFO - PROCESS | 1826 | |1;audio-beat-detection;155;144;159;166;126;154;155;128;171;131 19:20:06 INFO - PROCESS | 1826 | |2;audio-dft;161;161;162;159;160;159;161;164;161;164 19:20:06 INFO - PROCESS | 1826 | |3;audio-fft;76;73;92;98;76;72;72;146;102;73 19:20:06 INFO - PROCESS | 1826 | |4;audio-oscillator;93;92;148;93;93;93;143;93;93;136 19:20:06 INFO - PROCESS | 1826 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;116;117 19:20:06 INFO - PROCESS | 1826 | |6;imaging-darkroom;145;146;146;146;145;145;145;146;145;146 19:20:06 INFO - PROCESS | 1826 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 19:20:06 INFO - PROCESS | 1826 | |8;json-parse-financial;57;55;56;55;56;56;60;65;53;56 19:20:06 INFO - PROCESS | 1826 | |9;json-stringify-tinderbox;62;62;63;62;61;62;62;61;61;61 19:20:06 INFO - PROCESS | 1826 | |10;stanford-crypto-aes;79;78;77;76;77;77;77;86;78;77 19:20:06 INFO - PROCESS | 1826 | |11;stanford-crypto-ccm;117;121;110;110;120;113;120;126;110;119 19:20:06 INFO - PROCESS | 1826 | |12;stanford-crypto-pbkdf2;146;143;151;149;147;139;158;143;153;147 19:20:06 INFO - PROCESS | 1826 | |13;stanford-crypto-sha256-iterative;64;62;65;63;65;64;64;63;64;63 19:20:06 INFO - PROCESS | 1826 | __end_tp_report 19:20:06 INFO - PROCESS | 1826 | __start_cc_report 19:20:06 INFO - PROCESS | 1826 | _x_x_mozilla_cycle_collect,1094 19:20:06 INFO - PROCESS | 1826 | __end_cc_report 19:20:06 INFO - PROCESS | 1826 | __startTimestamp1459909206566__endTimestamp 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | ------- Summary: start ------- 19:20:06 INFO - PROCESS | 1826 | Number of tests: 14 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.50 stddev:3.89 (3.5%) stddev-sans-first:4.10 19:20:06 INFO - PROCESS | 1826 | Values: 110.0 111.0 105.0 110.0 109.0 112.0 99.0 110.0 111.0 110.0 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:155.00 stddev:15.95 (10.3%) stddev-sans-first:16.76 19:20:06 INFO - PROCESS | 1826 | Values: 155.0 144.0 159.0 166.0 126.0 154.0 155.0 128.0 171.0 131.0 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.75 (1.1%) stddev-sans-first:1.86 19:20:06 INFO - PROCESS | 1826 | Values: 161.0 161.0 162.0 159.0 160.0 159.0 161.0 164.0 161.0 164.0 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | [#3] audio-fft Cycles:10 Average:88.00 Median:74.50 stddev:23.40 (31.4%) stddev-sans-first:24.41 19:20:06 INFO - PROCESS | 1826 | Values: 76.0 73.0 92.0 98.0 76.0 72.0 72.0 146.0 102.0 73.0 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:93.00 stddev:24.07 (25.9%) stddev-sans-first:24.93 19:20:06 INFO - PROCESS | 1826 | Values: 93.0 92.0 148.0 93.0 93.0 93.0 143.0 93.0 93.0 136.0 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 19:20:06 INFO - PROCESS | 1826 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 19:20:06 INFO - PROCESS | 1826 | Values: 145.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 19:20:06 INFO - PROCESS | 1826 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.00 stddev:3.35 (6.0%) stddev-sans-first:3.55 19:20:06 INFO - PROCESS | 1826 | Values: 57.0 55.0 56.0 55.0 56.0 56.0 60.0 65.0 53.0 56.0 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 19:20:06 INFO - PROCESS | 1826 | Values: 62.0 62.0 63.0 62.0 61.0 62.0 62.0 61.0 61.0 61.0 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:77.50 stddev:2.86 (3.7%) stddev-sans-first:3.02 19:20:06 INFO - PROCESS | 1826 | Values: 79.0 78.0 77.0 76.0 77.0 77.0 77.0 86.0 78.0 77.0 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | [#11] stanford-crypto-ccm Cycles:10 Average:116.60 Median:119.50 stddev:5.58 (4.7%) stddev-sans-first:5.92 19:20:06 INFO - PROCESS | 1826 | Values: 117.0 121.0 110.0 110.0 120.0 113.0 120.0 126.0 110.0 119.0 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:148.00 stddev:5.48 (3.7%) stddev-sans-first:5.78 19:20:06 INFO - PROCESS | 1826 | Values: 146.0 143.0 151.0 149.0 147.0 139.0 158.0 143.0 153.0 147.0 19:20:06 INFO - PROCESS | 1826 | 19:20:06 INFO - PROCESS | 1826 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:0.95 (1.5%) stddev-sans-first:1.00 19:20:06 INFO - PROCESS | 1826 | Values: 64.0 62.0 65.0 63.0 65.0 64.0 64.0 63.0 64.0 63.0 19:20:06 INFO - PROCESS | 1826 | -------- Summary: end -------- 19:20:06 INFO - PROCESS | 1826 | 19:20:07 INFO - TEST-INFO | 1826: exit 0 19:20:07 INFO - TEST-OK | kraken | took 59539ms 19:20:07 INFO - SUITE-END | took 1169s 19:20:07 INFO - Completed test suite (00:19:29) 19:20:07 INFO - javascript benchmark 19:20:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3103.022547897412, 3149.4645910195263, 3176.2377029512922, 3186.394585028844, 3206.5831441912546, 5081.187010078388, 5320.414754377015, 5333.599980001496, 5358.0, 5438.728063596819, 5364.329458817648, 5371.892562148755, 5373.086575282202, 5391.191321301807, 5420.051490989071, 4777.116233496814, 4820.686655367399, 4926.482719314474, 4958.206686930092, 4997.625178111638, 4791.9520804791855, 4930.506949305077, 4941.950580494203, 4968.652194346397, 4997.200447928332, 4877.341558889558, 4911.557959783637, 4915.82794602189, 4920.532549407801, 4963.106640804654, 4866.206786315476, 4889.608831293488, 4904.975475122637, 4907.705537667752, 4944.283078953532, 4681.438227412698, 4786.760661966888, 4839.153148199086, 4903.436104847917, 4925.630577706651, 5283.233931080011, 5284.9735751320995, 5290.761915713802, 5310.840674779763, 5336.226247194174, 5689.487946084872, 5693.089105743061, 5698.088305871082, 5699.401562835926, 5700.572457065737, 5533.501984821345, 5710.428957104298, 5731.197632331477, 5806.970965145148, 5812.447817457335, 5345.625806193568, 5383.407825139231, 5383.973080134613, 5384.111621582434, 5386.811461598864, 5842.766289348463, 5848.4151584841175, 5858.56060795442, 5864.237649105589, 5866.413358664099, 5389.0, 5569.192467092249, 5612.186232996192, 5625.071863142535, 5649.519790817826, 5625.746841392147, 5646.237757902631, 5647.943520564824, 5649.209110724501, 5649.4633009864, 5505.724713764376, 5623.240862483594, 5623.831285061455, 5628.183913332626, 5631.7184140793615, 5644.520215781622, 5698.0, 5704.429557044263, 5720.599558030981, 5755.22304488897, 4277.272863613193, 4301.075268817157, 4305.892352691208, 4309.849155279613, 4349.717268377545, 3812.618738126165, 3831.2529056834205, 3883.37865941448, 3884.9611503885167, 3890.9610903891166, 5382.1119515280325, 5400.297961265089, 5408.215808707715, 5427.0, 5448.210009548593, 5716.828495145152, 5721.0, 5723.027085395493, 5725.198472213893, 5726.255586773693, 5231.633785634969, 5384.838454846361, 5400.0, 5405.297311349499, 5446.21029950655, 4925.11347957364, 4929.260610908321, 4934.432540257916, 4945.109880221595, 4966.801327946914, 5888.352281249059, 5888.411158884077, 5890.793822216202, 5895.322037965603, 5898.233229680114, 5534.667919924817, 5693.857653558694, 5745.396733343106, 5778.653280803165, 5788.9710551447815, 5908.497777688945, 5909.793157239476, 5918.40815918422, 5918.881622367615, 5922.970385148219, 5659.0, 5664.0937450007805, 5665.263515742927, 5667.8866422672145, 5669.376368599534, 5589.636673616202, 5695.8860822784145, 5740.598158129058, 5775.9133612995, 5815.563832712648, 5597.244372009726, 5600.971995140161, 5606.24315717373, 5608.775648973995, 5609.242752228397, 5534.584906131976, 5560.999020176246, 5577.470140336662, 5580.190872323409, 5587.189857470563, 5299.0, 5450.645708028966, 5480.0, 5494.1758736189895, 5542.0301447245765, 5549.611527193058, 5596.972015139898, 5598.384177740527, 5600.187972744011, 5607.5513958884, 5294.8941021180135, 5458.536024437967, 5460.91808622863, 5461.344638643388, 5507.834764957058], "unit": "score", "name": "dojo.html", "value": 5263.180236861742}, {"lowerIsBetter": false, "replicates": [554.869605642674, 559.3841858453189, 568.1619611073664, 584.2317352681224, 596.9820905372841, 30251.0, 39048.80475597621, 39287.0, 39545.011374715614, 39569.60430395695, 42675.14649707004, 43190.0, 43196.56803431965, 43209.0, 43319.783401082954, 8655.826883462343, 8846.20384165425, 8863.734087977338, 8867.68963086289, 8872.822543549126, 8765.517896515688, 8887.95556022219, 8894.0, 8897.021327653953, 8899.599518021705, 9003.909960900406, 9062.818743625123, 9076.591553380114, 9080.863787043167, 9081.45511269326, 8954.149355811187, 9030.45817250967, 9037.638494460247, 9038.141376569216, 9042.909570904305, 8870.73387798367, 8986.730398088068, 8993.14565116313, 9000.8649870252, 9001.684941027033, 42823.14353712939, 43129.784351078044, 43144.78427607873, 43223.135537289396, 43226.13547729059, 3506.491558723996, 3609.404448266033, 3675.72432067596, 3793.981030094832, 4239.809208585591, 30785.0, 30988.0, 31110.53334199966, 31271.0, 31414.528782068286, 4095.4471146395153, 4104.404861295126, 4185.434966279544, 4200.537940826506, 4206.26390381682, 325179.0, 330685.9999999976, 331928.0, 332637.0, 333060.0, 67247.66376168186, 68406.0, 68463.65768171127, 68518.0, 68649.65675171593, 61635.383646163864, 63119.634831039875, 71386.64306678434, 71638.2836171642, 72286.27713722795, 17360.218790154475, 17456.039917804643, 17456.127193640266, 17623.118844057746, 17625.823741762673, 13136.802947955788, 13412.262325572186, 13430.19418834873, 13432.0, 13433.19400835953, 19326.323578674677, 21323.147074116863, 22108.668369974464, 22686.14335562958, 22687.659685104736, 8153.673853045931, 8264.917350826536, 8302.958485207535, 8341.708040218564, 8485.32117430604, 956.2597855599823, 959.64972784933, 1094.9069329106956, 1109.4341885638382, 1189.2270024484155, 32622.347553048807, 33070.338593228, 33228.66771332304, 33695.15762105967, 33834.154146146546, 1085.218642577343, 1139.2993309115, 1182.438341787644, 1191.7199458127334, 1196.8204769284678, 14957.476488323075, 15297.617559560877, 15328.310226039855, 15511.224438778016, 15636.921815391077, 208929.0, 208988.0, 209000.0, 209453.0, 211089.0, 59841.70079149664, 60343.39656603466, 60754.0, 60917.39082609206, 60933.0, 1274.139955530032, 1325.9005574581945, 1390.5202705066736, 1410.8589141085808, 1417.376354404059, 31193.220169495944, 32453.350932980735, 33279.16802079871, 33321.66678333186, 33398.33203335871, 46348.7682561585, 46744.06511869811, 46808.765956171366, 48068.759656201495, 48463.0, 289991.0, 290760.0, 292260.0, 292693.0, 292819.0, 37941.62058379381, 38090.42864357092, 38562.22875542417, 38892.0, 38995.220095598495, 48800.267995979375, 48923.0, 49152.0, 49473.75263123661, 49753.751231243616, 40750.59249407586, 40897.795511022254, 41243.7937810309, 41279.58720412877, 41665.79167104145, 39109.21781564296, 39534.604653953094, 40316.39525407062, 40492.0, 40650.18699625932, 40288.59711402848, 41135.1772964533, 41859.58140418557, 41986.37020444635, 42001.0, 35528.46707299444, 36114.27771444609, 36481.81759091187, 36889.07777305589, 37055.25889482141, 27760.0, 28169.718302817528, 28374.290642734097, 28407.147785566467, 28428.57357139603], "unit": "score", "name": "ext.html", "value": 19793.682802358202}, {"lowerIsBetter": false, "replicates": [373.7253118957566, 378.35301634205507, 379.05993137020187, 380.4483498926557, 383.1341168958154, 17661.0, 18518.537036574093, 19461.221551137973, 19756.70364944527, 19799.604007919832, 10856.511456984435, 11245.156613254017, 11246.718832029203, 11249.43752812358, 11253.381064041474, 4871.7076975381415, 5016.297718319438, 5053.84838454847, 5382.757775900074, 5550.611457197998, 5455.972720136394, 5470.5350045246205, 5487.890242195153, 5505.532029777473, 5507.421720719327, 5108.84673459795, 5181.455947125554, 5461.69960652164, 5462.235287059815, 5467.6719396836315, 5055.494450554934, 5057.645964782467, 5088.0, 5093.745312734367, 5102.974485127569, 4877.8780530486665, 4923.58149557288, 4926.926096108561, 4928.0, 4930.112579735646, 13200.14199077057, 13441.193528388329, 13569.45722171112, 13576.660583485393, 13587.388567514485, 2244.6633005049375, 2317.1079134533156, 2322.6399908014114, 2342.906283748648, 2346.9061237550477, 9712.0, 9738.318317717763, 9793.559289831976, 10062.144717699004, 10265.332753371007, 1931.5557421793067, 2011.0648152730155, 2012.23535056679, 2023.8380929525604, 2044.9795502045088, 48325.75837120792, 68058.9999999995, 69164.6541767288, 71858.64070679665, 72723.0, 9942.602295908227, 10171.949140254252, 10242.846357304647, 10558.366498010144, 10576.206784491194, 14554.0, 14649.414023439156, 14657.56027319182, 14661.680448759664, 14677.412903483955, 7294.489385742947, 7599.392048636096, 7759.0, 7852.057753069668, 7972.720954766672, 7184.173820010661, 7571.46999710015, 7599.290159714131, 7839.804004899809, 8068.475549089408, 4395.252807022814, 4430.977845110754, 4579.129965306581, 4594.724316541018, 4634.606058485067, 1833.2483681690444, 1857.5634725839418, 1885.3966730646337, 1923.5864289177614, 1936.8547358947853, 917.9947956987088, 961.2982522758425, 1023.4473384372504, 1041.7656027393928, 1096.8537877917595, 17932.55168620795, 18003.18985645649, 18269.995150266863, 18563.90718046428, 18597.16312765929, 1024.2471783239314, 1029.9794004119876, 1034.5086084109987, 1055.4247934875511, 1073.8174510333263, 10408.739781505523, 10487.632932847466, 10572.31279966815, 10620.734481637866, 10686.839697404544, 454536.0, 456123.0, 492785.0, 511985.0, 518620.0, 59869.0, 79618.0, 81608.59195704102, 81984.0, 82920.58539707263, 1013.8732658417698, 1023.3501726403787, 1036.3937096798306, 1062.219268837404, 1062.8352605346183, 15815.367385304919, 15892.60268493297, 16033.919830400773, 16120.838791611934, 16455.42406015784, 33554.83222583871, 33759.66240337565, 33834.323313534085, 34293.82853085719, 35099.12252193614, 48075.75962120167, 53602.731986339815, 53617.7319113402, 53636.19545706739, 53656.463435366706, 7722.768316950501, 7793.142754297136, 7830.1472642375475, 7866.842663146819, 7902.170272121574, 8910.087577358558, 9404.95297523508, 12242.449089791158, 12761.361931903553, 13152.276624785729, 10939.890601093886, 11308.0, 11379.146564007568, 11559.133065019989, 11656.242344247597, 11184.94407527957, 11426.657200284004, 11429.485673144562, 11447.0, 11542.249753765978, 11470.65588032327, 11685.240459370114, 11733.413329333669, 11745.17783755129, 11832.70418239551, 7496.550206987598, 7567.432442566939, 7567.735129270449, 7718.421118416029, 7844.64699088531, 9807.362521436084, 10447.94776026115, 10473.371597703857, 10491.0, 11444.370559619301], "unit": "score", "name": "jquery.html", "value": 8451.531527878411}, {"lowerIsBetter": false, "replicates": [1504.5862387843345, 1512.3421311729396, 1695.6354383807486, 1796.3084212578153, 1816.1373347659862, 7240.2397748236335, 7966.6415011324625, 8069.59652017399, 8269.173082691736, 8294.33645308376, 8053.436259461825, 8077.798055048626, 8117.837643247146, 8118.06642236143, 8132.024157101157, 2230.4646884747667, 2249.167807911075, 2249.4826189976316, 2255.323402979108, 2255.357223191391, 1948.3375652278223, 2215.8559693619945, 2262.9660555091687, 2267.353804165813, 2267.455810605459, 2185.169635538501, 2205.371469131298, 2211.292386436341, 2213.0815711479718, 2216.390492614528, 2211.6461366181493, 2219.8557093788854, 2222.7777222277805, 2227.432004838764, 2230.0522278031854, 2147.6671115977047, 2162.329677799887, 2236.02732811226, 2236.552689462098, 2238.854474459155, 8385.874211886827, 8390.622421991025, 8447.155284471564, 8453.873191902127, 8456.704015359495, 5097.617678674077, 5165.690058596496, 5212.947870521284, 5214.947850521484, 5218.243354713545, 3197.2486465680545, 3257.8533965971587, 3353.446681297583, 3362.7646064775477, 3372.4435468147726, 981.651513712636, 986.9407835529892, 1001.6994901529512, 1013.9695809125737, 1016.5882817458867, 11883.168178227528, 11912.166148369617, 11913.10651701126, 11935.701607459883, 11940.402979850973, 4406.625436837905, 4407.493138289138, 4433.4236549249035, 4457.219986502414, 4546.1135078659345, 10008.94906034856, 10023.548940297704, 10023.899761002442, 10065.194784417228, 10065.59737610502, 5140.460251673595, 5164.819231326961, 5186.455422180692, 5187.144121220032, 5187.481251874782, 4135.793210339471, 4597.126545956257, 4746.02706445178, 4753.35829662998, 4763.833265835679, 3823.4073718573663, 3882.7476214045996, 3884.261990221849, 3905.1994341159993, 3964.1080756829483, 1249.575144450891, 1269.8095285707218, 1287.3177216075494, 1287.8840904318656, 1302.5766625846638, 1119.3787447966456, 1130.8586426696663, 1141.0187238974474, 1366.3919555797772, 1440.8703216710337, 7625.161232264447, 7764.107127680389, 7815.3356964657505, 7883.251091146447, 7896.249856263761, 457.74366354841396, 462.20270034190753, 463.42998112322033, 468.5759387754088, 472.2656269500959, 6042.274927008787, 6044.788432404933, 6086.878262434727, 6098.207233059674, 6129.417705317987, 9831.557579908922, 10315.690529284133, 10442.477876106164, 10457.163426925828, 10457.895421045845, 10116.29185956976, 10269.178465722724, 10274.743131421625, 10296.691099267035, 10319.535620897077, 7989.601819681532, 8042.276195142465, 8059.476134051268, 8130.552819594979, 8140.837183256302, 7645.541267523967, 7767.805804854924, 7825.765227043198, 7825.804354890945, 7836.177201393772, 9022.233110185707, 9116.1339672731, 9185.0, 9366.67216647414, 9370.67202647904, 9279.953600231956, 9366.391184572982, 9511.286653500876, 9536.284778641768, 9669.806603867743, 6568.113304703995, 6766.18805743314, 7434.293742094493, 7480.139783924918, 7672.424568157299, 7889.802754931173, 7953.363730901398, 7988.520688758693, 8000.51996880189, 8003.079645840803, 7142.535735177197, 7258.165310989304, 7268.0914885639295, 7374.151972523228, 7391.9651248826285, 6901.89647155283, 7005.684744186626, 7121.074260346122, 7194.2086370498155, 7279.199288078201, 7394.630268486447, 7611.581363024865, 7616.657250423855, 7616.809579760328, 7628.0083589133055, 6967.616781077089, 7032.12098487689, 7033.542819716702, 7043.647817609201, 7044.260352663102, 6772.356626120511, 6821.658917054028, 6846.965765171142, 6848.863022739617, 6865.862682746417], "unit": "score", "name": "mootools.html", "value": 4626.768883195094}, {"lowerIsBetter": false, "replicates": [332.61416756562386, 334.37138180221183, 334.5984818218137, 337.14197367699205, 345.09068604227866, 5934.5845790794665, 5974.671393073385, 6011.789587364432, 6013.909791353122, 6023.668698221596, 5954.851128721784, 5961.523078153748, 5963.344032156459, 5963.671998040106, 5965.0, 4380.189664912002, 4480.215962206617, 4575.611073058794, 4619.399478067863, 4644.419447569054, 4587.1972404829185, 4595.195840727876, 4597.218472859622, 4603.746793926332, 4607.516210797869, 4557.544245575433, 4558.931616025762, 4573.451185857702, 4579.129965306581, 4586.587207151356, 4323.459567554056, 4469.553044695537, 4547.840825571122, 4562.224421848294, 4564.726116432991, 4034.394840773878, 4042.0905296308097, 4047.0, 4050.1494686115952, 4067.2068946555432, 5764.481196692276, 5766.740496677659, 5770.7691692332255, 5774.249347584829, 5776.046952252873, 5306.461126273376, 5317.41508434072, 5325.334333208349, 5326.014687282826, 5326.094563924104, 6234.283057448406, 6245.781397651106, 6254.937450625481, 6255.593386429868, 6256.96871515644, 4392.560743925582, 4442.977785111086, 4479.552044795527, 4480.462344518646, 4482.417285752864, 6498.545101842826, 6503.28463868974, 6518.739250429977, 6523.8695226095215, 6527.053577231322, 4580.702254353457, 4582.816687332536, 4587.151376995266, 4590.403247577793, 4592.150452166293, 4641.651876109306, 4646.186917289461, 4646.465656449484, 4650.720956742606, 4652.232381657056, 5289.391719952255, 5293.735313234323, 5297.8145764898045, 5299.8410047698635, 5306.336707911511, 6122.816315510542, 6285.340039295899, 6300.401461861115, 6306.306306306303, 6309.14826498426, 1617.846304601061, 1625.057466669329, 1633.8611218046362, 1640.1635166065394, 1641.261432355421, 994.5574219472265, 1061.3790932304535, 1075.1398880895254, 1078.9244752867223, 1081.2539347849959, 5965.343812180657, 6016.338202797689, 6017.729202185825, 6029.57792954489, 6030.4572588467245, 6393.073004414334, 6405.519586031066, 6409.102725618417, 6412.67936603168, 6414.262359828679, 6000.249968753906, 6012.488938440194, 6015.849603759941, 6016.789412370546, 6024.367441418588, 3441.0709108540555, 3471.461923401877, 3471.531343268626, 3474.357243909885, 3478.3565040467593, 6449.419552240321, 6558.213014438298, 6581.2102547694585, 6600.306967768412, 6614.570052946543, 6417.550771446047, 6513.674316284167, 6521.054447105238, 6532.934670653232, 6542.901856472156, 6563.868722625521, 6583.177102862142, 6583.670816459158, 6585.242697089896, 6595.670216489157, 6389.7763578274535, 6393.552451328363, 6412.038194270896, 6413.2945376007665, 6415.839604009937, 6187.195664563578, 6273.811785646438, 6323.304436511888, 6331.588446750947, 6340.682965851781, 6566.080748695091, 6580.934190658032, 6601.240857301472, 6603.0, 6604.570702904488, 4485.349624304523, 4492.707973981681, 4505.594496495331, 4507.301368287921, 4507.797149128362, 6372.299047104908, 6381.904271435839, 6387.648679322682, 6393.424591786761, 6393.6163830170335, 6207.844803879939, 6210.4100110489435, 6220.720067596879, 6230.719617617127, 6232.034034724625, 6084.33072362031, 6210.285817131088, 6218.347073557392, 6229.719662615103, 6236.719347629459, 6080.787172448943, 6098.390160983866, 6113.266408031065, 6115.694215289129, 6173.69131543412, 6236.688165591793, 6248.312685604671, 6256.124142619946, 6257.749690012349, 6260.060990851409, 5967.37342579023, 6066.666333351532, 6068.817935461943, 6099.054646529795, 6110.633361998294], "unit": "score", "name": "prototype.html", "value": 4743.884572919453}, {"lowerIsBetter": false, "replicates": [824.1470078468786, 834.7328854766473, 842.8609279468888, 853.6585365853662, 872.0755998641439, 14193.006489545724, 14394.568162955115, 14461.276936153203, 14552.708945821078, 16210.918945405287, 15492.612684682861, 15639.06165630063, 15682.84317156828, 15740.685186296267, 15777.684446311066, 696.3941371007231, 825.6325934958945, 829.5520418973762, 847.2290215903529, 854.2610641794834, 836.0260296754274, 845.6152450634946, 846.5090247656344, 847.7753395350206, 848.9660413583449, 881.9911800882005, 886.1271647427279, 886.6497733395337, 886.9201771840533, 886.9778255543631, 725.2711025419446, 860.5783166248524, 875.1991927386434, 875.7810547363159, 881.4402854187605, 631.1857703562399, 635.3424205946823, 636.9044643303495, 636.9585976911486, 637.1621317966859, 14115.011949163563, 14143.787843182361, 14153.575392738234, 14234.786478202835, 14243.572692819233, 13012.414441350162, 13212.735745285041, 13550.661233469144, 13629.863701363058, 13655.112417692819, 11258.324500529994, 11305.830412543819, 11536.0, 11572.942135289353, 11600.535978560847, 3850.4416859555486, 3887.475190849256, 3894.2211557688292, 3902.941455878164, 4011.5587285398583, 54786.72606636981, 54992.17511737327, 55553.0, 55613.0, 55689.72155139239, 10902.836457453144, 10904.945475272572, 10986.945065274622, 11051.668449946354, 11304.378259195659, 19408.902955485133, 19418.90290548538, 19469.513262168275, 19473.0, 19498.12258448373, 8199.467034642728, 8233.0, 8326.375521835887, 8374.371922105867, 8398.790030249293, 4816.397950256218, 4921.26181072842, 4925.335079764258, 4930.137225985438, 5050.747462626928, 3283.244853683666, 3301.6698330167274, 3326.8688645860525, 3331.866725331008, 3339.0984434203115, 584.9941500585024, 603.5413086054542, 612.2561088277675, 613.352912677121, 619.8419403052193, 720.9675564599605, 725.6734469488752, 772.9845403091907, 784.1922819495928, 794.3962588432832, 8756.605952732143, 9243.306751993627, 9334.872817606043, 9483.47840868745, 9633.9036609633, 505.46673259711355, 758.2493331601675, 760.3157158557232, 765.1506827421557, 774.233508826258, 4254.361845723166, 4270.530241673413, 4472.552744725502, 4561.338605902192, 4642.489326174118, 62657.0, 63178.0, 63226.68386658037, 63409.0, 63492.0, 50107.74946125246, 50601.49398505968, 50739.23891141636, 50771.0, 50814.0, 48230.75884620554, 49111.0, 49996.75001624969, 50145.997080058194, 51254.0, 9661.396844096873, 9702.214657529668, 9841.901580984098, 9867.95066024694, 9932.106110449806, 36304.818475908505, 37880.43179352367, 38382.80808595939, 41211.793941030104, 41633.79183104065, 49444.50555494543, 52401.7379913098, 53243.0, 53441.732791335795, 54593.727031364586, 13163.47346106145, 13189.670258243621, 13203.867961320648, 13422.932885335511, 13455.730885382432, 13577.93211033978, 13810.309484525533, 13860.930695346458, 14195.148291102567, 14390.784138237725, 12491.87508124907, 12787.488500459878, 13254.469821207043, 13431.529896453578, 13513.459461621425, 12251.571195008131, 12581.811272831097, 12593.181443206162, 12712.173708708904, 12893.613191604267, 12762.964320565101, 13153.60539183826, 13164.341782910624, 13211.603651890458, 13353.53262635842, 10890.673279801618, 11166.832497512707, 11175.608853690082, 11198.216124871507, 11268.718282043015, 11152.88847111551, 11194.044744247154, 11390.145739069438, 11405.372704501333, 11468.254563453349], "unit": "score", "name": "yui.html", "value": 6939.777293355545}], "name": "dromaeo_css", "value": 7154.58678412161}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 105.0, 110.0, 109.0, 112.0, 99.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [155.0, 144.0, 159.0, 166.0, 126.0, 154.0, 155.0, 128.0, 171.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 159.0, 160.0, 159.0, 161.0, 164.0, 161.0, 164.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 92.0, 98.0, 76.0, 72.0, 72.0, 146.0, 102.0, 73.0], "unit": "score", "name": "audio-fft", "value": 88.0}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 148.0, 93.0, 93.0, 93.0, 143.0, 93.0, 93.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 56.0, 55.0, 56.0, 56.0, 60.0, 65.0, 53.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 63.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 61.7}, {"lowerIsBetter": true, "replicates": [79.0, 78.0, 77.0, 76.0, 77.0, 77.0, 77.0, 86.0, 78.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.2}, {"lowerIsBetter": true, "replicates": [117.0, 121.0, 110.0, 110.0, 120.0, 113.0, 120.0, 126.0, 110.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.6}, {"lowerIsBetter": true, "replicates": [146.0, 143.0, 151.0, 149.0, 147.0, 139.0, 158.0, 143.0, 153.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 65.0, 63.0, 65.0, 64.0, 64.0, 63.0, 64.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.7}], "name": "kraken", "value": 1496.5}]} 19:20:07 INFO - Return code: 0 19:20:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:20:07 ERROR - # TBPL SUCCESS # 19:20:07 INFO - Running post-action listener: _resource_record_post_action 19:20:07 INFO - Running post-run listener: _resource_record_post_run 19:20:08 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544866304; Read time: 12; Write time: 429356 19:20:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 243277824; Read time: 0; Write time: 264056 19:20:08 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281841664; Read time: 12; Write time: 156204 19:20:08 INFO - Running post-run listener: _upload_blobber_files 19:20:08 INFO - Blob upload gear active. 19:20:08 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:20:08 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:20:08 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'] 19:20:08 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 19:20:09 INFO - (blobuploader) - INFO - Open directory for files ... 19:20:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:20:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:20:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:11 INFO - (blobuploader) - INFO - Done attempting. 19:20:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:20:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:20:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:12 INFO - (blobuploader) - INFO - Done attempting. 19:20:12 INFO - (blobuploader) - INFO - Iteration through files over. 19:20:12 INFO - Return code: 0 19:20:12 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:20:12 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:20:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3de2306f2002003f2940550b7ffcdfa88f1cc8d2c47ebdf53e1110379ae53dce4de25988ce45b57971ffb7f6ea6df324a2e74f4eba1b239adb5ba9f8a35e005", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0f3af3d5f803c2f6adc5517d00bf4783b4295e535c2d9d14256fdd812055f44bd6311039bcf1ec80f8e9beccc88a73fb73a5d3dd658911aeab3a26a94d4d2cb1"} 19:20:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:20:12 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:20:12 INFO - Contents: 19:20:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c3de2306f2002003f2940550b7ffcdfa88f1cc8d2c47ebdf53e1110379ae53dce4de25988ce45b57971ffb7f6ea6df324a2e74f4eba1b239adb5ba9f8a35e005", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0f3af3d5f803c2f6adc5517d00bf4783b4295e535c2d9d14256fdd812055f44bd6311039bcf1ec80f8e9beccc88a73fb73a5d3dd658911aeab3a26a94d4d2cb1"} 19:20:12 INFO - Running post-run listener: copy_logs_to_upload_dir 19:20:12 INFO - Copying logs to upload dir... 19:20:12 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:20:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.426658 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-05 19:20:12.445792) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 19:20:12.449049) ========= 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=8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238 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/c3de2306f2002003f2940550b7ffcdfa88f1cc8d2c47ebdf53e1110379ae53dce4de25988ce45b57971ffb7f6ea6df324a2e74f4eba1b239adb5ba9f8a35e005", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0f3af3d5f803c2f6adc5517d00bf4783b4295e535c2d9d14256fdd812055f44bd6311039bcf1ec80f8e9beccc88a73fb73a5d3dd658911aeab3a26a94d4d2cb1"} build_url:https://queue.taskcluster.net/v1/task/ZK8WdIDcRMidwsd8j5p8uw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/ZK8WdIDcRMidwsd8j5p8uw/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/c3de2306f2002003f2940550b7ffcdfa88f1cc8d2c47ebdf53e1110379ae53dce4de25988ce45b57971ffb7f6ea6df324a2e74f4eba1b239adb5ba9f8a35e005", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0f3af3d5f803c2f6adc5517d00bf4783b4295e535c2d9d14256fdd812055f44bd6311039bcf1ec80f8e9beccc88a73fb73a5d3dd658911aeab3a26a94d4d2cb1"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 19:20:12.489557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 19:20:12.489903) ========= 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=8887e36bb8e381bfd44124ac000001a8-1459906904.322304-156258238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 19:20:12.583263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 19:20:12.583604) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 19:20:12.583945) ========= ========= Total master_lag: 0.31 =========