builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1459563735.97 results: success (0) buildid: 20160401163014 builduid: 822bc3a31c51436f8e484880f9135ca8 revision: c40c0b2f3b4c778af4307e090b4063b63c806cda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:15.967778) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:15.968969) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:15.969548) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005607 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.015759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.016105) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.043435) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.043757) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.042285 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.097869) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.098259) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.098683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.099014) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-01 19:22:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 20.0M=0.001s 2016-04-01 19:22:16 (20.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135721 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.247874) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.248254) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.061925 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.321385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.321758) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c40c0b2f3b4c778af4307e090b4063b63c806cda --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c40c0b2f3b4c778af4307e090b4063b63c806cda --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=9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-01 19:22:16,337 truncating revision to first 12 chars 2016-04-01 19:22:16,337 Setting DEBUG logging. 2016-04-01 19:22:16,337 attempt 1/10 2016-04-01 19:22:16,337 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c40c0b2f3b4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 19:22:16,608 unpacking tar archive at: mozilla-central-c40c0b2f3b4c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.594587 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.931533) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.931944) ========= echo c40c0b2f3b4c778af4307e090b4063b63c806cda in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c40c0b2f3b4c778af4307e090b4063b63c806cda'] 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=9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c40c0b2f3b4c778af4307e090b4063b63c806cda program finished with exit code 0 elapsedTime=0.004156 script_repo_revision: 'c40c0b2f3b4c778af4307e090b4063b63c806cda' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.981755) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.982113) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 19:22:16.992861) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2016-04-01 19:22:16.993176) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:22:17 INFO - MultiFileLogger online at 20160401 19:22:17 in /builds/slave/test-pgo 19:22:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:22:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:22:17 INFO - {'append_to_log': False, 19:22:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:22:17 INFO - 'blob_upload_branch': 'Firefox', 19:22:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:22:17 INFO - 'branch': 'Firefox', 19:22:17 INFO - 'buildbot_json_path': 'buildprops.json', 19:22:17 INFO - 'config_files': ('talos/linux_config.py',), 19:22:17 INFO - 'default_actions': ('clobber', 19:22:17 INFO - 'read-buildbot-config', 19:22:17 INFO - 'download-and-extract', 19:22:17 INFO - 'populate-webroot', 19:22:17 INFO - 'create-virtualenv', 19:22:17 INFO - 'install', 19:22:17 INFO - 'run-tests'), 19:22:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:22:17 INFO - 'download_minidump_stackwalk': True, 19:22:17 INFO - 'download_symbols': 'ondemand', 19:22:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:22:17 INFO - 'tooltool.py': '/tools/tooltool.py', 19:22:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:22:17 INFO - '/tools/misc-python/virtualenv.py')}, 19:22:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:22:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:22:17 INFO - 'installer_path': 'installer.exe', 19:22:17 INFO - 'log_level': 'info', 19:22:17 INFO - 'log_name': 'talos', 19:22:17 INFO - 'log_to_console': True, 19:22:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:22:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:22:17 INFO - 'opt_config_files': (), 19:22:17 INFO - 'pip_index': False, 19:22:17 INFO - 'sps_profile': False, 19:22:17 INFO - 'sps_profile_interval': 0, 19:22:17 INFO - 'suite': 'dromaeojs-e10s', 19:22:17 INFO - 'system_bits': '32', 19:22:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:22:17 INFO - 'title': 'talos-linux64-ix-022', 19:22:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:22:17 INFO - 'use_talos_json': True, 19:22:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:22:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:22:17 INFO - 'work_dir': 'build'} 19:22:17 INFO - ##### 19:22:17 INFO - ##### Running clobber step. 19:22:17 INFO - ##### 19:22:17 INFO - Running pre-action listener: _resource_record_pre_action 19:22:17 INFO - Running main action method: clobber 19:22:17 INFO - rmtree: /builds/slave/test-pgo/build 19:22:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:22:18 INFO - Running post-action listener: _resource_record_post_action 19:22:18 INFO - ##### 19:22:18 INFO - ##### Running read-buildbot-config step. 19:22:18 INFO - ##### 19:22:18 INFO - Running pre-action listener: _resource_record_pre_action 19:22:18 INFO - Running main action method: read_buildbot_config 19:22:18 INFO - Using buildbot properties: 19:22:18 INFO - { 19:22:18 INFO - "project": "", 19:22:18 INFO - "product": "firefox", 19:22:18 INFO - "script_repo_revision": "production", 19:22:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:22:18 INFO - "repository": "", 19:22:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:22:18 INFO - "buildid": "20160401163014", 19:22:18 INFO - "pgo_build": "True", 19:22:18 INFO - "basedir": "/builds/slave/test-pgo", 19:22:18 INFO - "buildnumber": 159, 19:22:18 INFO - "slavename": "talos-linux64-ix-022", 19:22:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:22:18 INFO - "platform": "ubuntu64_hw", 19:22:18 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:22:18 INFO - "branch": "mozilla-central", 19:22:18 INFO - "repo_path": "mozilla-central", 19:22:18 INFO - "revision": "c40c0b2f3b4c778af4307e090b4063b63c806cda", 19:22:18 INFO - "stage_platform": "linux64-pgo", 19:22:18 INFO - "builduid": "822bc3a31c51436f8e484880f9135ca8", 19:22:18 INFO - "slavebuilddir": "test" 19:22:18 INFO - } 19:22:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 19:22:18 INFO - Running post-action listener: _resource_record_post_action 19:22:18 INFO - ##### 19:22:18 INFO - ##### Running download-and-extract step. 19:22:18 INFO - ##### 19:22:18 INFO - Running pre-action listener: _resource_record_pre_action 19:22:18 INFO - Running main action method: download_and_extract 19:22:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:22:18 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:22:18 INFO - https://queue.taskcluster.net/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:22:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:22:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:22:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/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 19:22:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/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 19:22:21 INFO - Downloaded 1361 bytes. 19:22:21 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:22:21 INFO - Using the following test package requirements: 19:22:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:22:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:22:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:22:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:21 INFO - u'jsshell-linux-x86_64.zip'], 19:22:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:22:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:22:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:22:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:22:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:22:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:22:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:21 INFO - https://queue.taskcluster.net/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:22:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:22:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:22:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/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 19:22:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/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 19:22:22 INFO - Downloaded 23689112 bytes. 19:22:22 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'] 19:22:22 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 19:22:24 INFO - Return code: 0 19:22:24 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 19:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:24 INFO - https://queue.taskcluster.net/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:22:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:22:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:22:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/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 19:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/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 19:22:41 INFO - Downloaded 23689112 bytes. 19:22:41 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'] 19:22:41 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 19:22:43 INFO - Return code: 0 19:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:43 INFO - https://queue.taskcluster.net/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:22:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:22:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:22:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/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 19:22:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/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 19:23:15 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip: The read operation timed out 19:23:15 INFO - retry: attempt #1 caught exception: The read operation timed out 19:23:15 INFO - retry: Failed, sleeping 30 seconds before retrying 19:23:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/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 #2 19:23:47 INFO - Downloaded 10847584 bytes. 19:23:47 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'] 19:23:47 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 19:23:47 INFO - Return code: 0 19:23: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')]} 19:23:47 INFO - https://queue.taskcluster.net/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:23:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:23:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:23:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/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 19:23:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/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 19:23:48 INFO - Downloaded 57809973 bytes. 19:23:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:23:48 INFO - mkdir: /builds/slave/test-pgo/properties 19:23:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:23:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:23:48 INFO - Contents: 19:23:48 INFO - build_url:https://queue.taskcluster.net/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:23:49 INFO - Running post-action listener: _resource_record_post_action 19:23:49 INFO - Running post-action listener: set_extra_try_arguments 19:23:49 INFO - ##### 19:23:49 INFO - ##### Running populate-webroot step. 19:23:49 INFO - ##### 19:23:49 INFO - Running pre-action listener: _resource_record_pre_action 19:23:49 INFO - Running main action method: populate_webroot 19:23:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:23:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:23:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:23:49 INFO - '--tppagecycles', 19:23:49 INFO - '7'], 19:23:49 INFO - 'tests': ['tsvgm']}}, 19:23:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:23:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:23:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:23:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:23:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:23:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:23:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:23:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:49 INFO - 'talos_options': ['--e10s'], 19:23:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:23:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:49 INFO - 'tests': ['damp', 'tps']}, 19:23:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:49 INFO - 'talos_options': ['--e10s'], 19:23:49 INFO - 'tests': ['damp', 'tps']}, 19:23:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:23:49 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 19:23:49 INFO - 'tests': ['dromaeo_dom']}, 19:23:49 INFO - 'other': {'tests': ['a11yr', 19:23:49 INFO - 'ts_paint', 19:23:49 INFO - 'tpaint', 19:23:49 INFO - 'sessionrestore', 19:23:49 INFO - 'sessionrestore_no_auto_restore', 19:23:49 INFO - 'tabpaint']}, 19:23:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:23:49 INFO - 'tests': ['a11yr', 19:23:49 INFO - 'ts_paint', 19:23:49 INFO - 'tpaint', 19:23:49 INFO - 'sessionrestore', 19:23:49 INFO - 'sessionrestore_no_auto_restore', 19:23:49 INFO - 'tabpaint']}, 19:23:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:23:49 INFO - 'tests': ['a11yr', 19:23:49 INFO - 'ts_paint', 19:23:49 INFO - 'tpaint', 19:23:49 INFO - 'sessionrestore', 19:23:49 INFO - 'sessionrestore_no_auto_restore', 19:23:49 INFO - 'tabpaint']}, 19:23:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:23:49 INFO - 'tests': ['a11yr', 19:23:49 INFO - 'ts_paint', 19:23:49 INFO - 'tpaint', 19:23:49 INFO - 'sessionrestore', 19:23:49 INFO - 'sessionrestore_no_auto_restore', 19:23:49 INFO - 'tabpaint']}, 19:23:49 INFO - 'other_l64': {'tests': ['a11yr', 19:23:49 INFO - 'ts_paint', 19:23:49 INFO - 'tpaint', 19:23:49 INFO - 'sessionrestore', 19:23:49 INFO - 'sessionrestore_no_auto_restore', 19:23:49 INFO - 'tabpaint']}, 19:23:49 INFO - 'other_nol64': {'tests': ['a11yr', 19:23:49 INFO - 'ts_paint', 19:23:49 INFO - 'tpaint', 19:23:49 INFO - 'sessionrestore', 19:23:49 INFO - 'sessionrestore_no_auto_restore', 19:23:49 INFO - 'tabpaint']}, 19:23:49 INFO - 'svgr': {'tests': ['tsvgx', 19:23:49 INFO - 'tsvgr_opacity', 19:23:49 INFO - 'tart', 19:23:49 INFO - 'tscrollx', 19:23:49 INFO - 'cart']}, 19:23:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:23:49 INFO - 'tests': ['tsvgx', 19:23:49 INFO - 'tsvgr_opacity', 19:23:49 INFO - 'tart', 19:23:49 INFO - 'tscrollx', 19:23:49 INFO - 'cart']}, 19:23:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:49 INFO - 'tests': ['tp5o']}, 19:23:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:49 INFO - 'talos_options': ['--e10s'], 19:23:49 INFO - 'tests': ['tp5o']}, 19:23:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:49 INFO - 'talos_options': ['--xperf_path', 19:23:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:23:49 INFO - 'tests': ['tp5n']}, 19:23:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:49 INFO - 'talos_options': ['--e10s', 19:23:49 INFO - '--xperf_path', 19:23:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:23:49 INFO - 'tests': ['tp5n']}}, 19:23:49 INFO - 'talos.zip': {'path': '', 19:23:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:23:49 INFO - Running post-action listener: _resource_record_post_action 19:23:49 INFO - ##### 19:23:49 INFO - ##### Running create-virtualenv step. 19:23:49 INFO - ##### 19:23:49 INFO - Running pre-action listener: _resource_record_pre_action 19:23:49 INFO - Running main action method: create_virtualenv 19:23:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:23:49 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 19:23:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:23:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:23:49 INFO - Using real prefix '/usr' 19:23:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:23:50 INFO - Installing distribute.............................................................................................................................................................................................done. 19:23:52 INFO - Installing pip.................done. 19:23:52 INFO - Return code: 0 19:23:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:23: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')]} 19:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23: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')]} 19:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7c01f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98b0>, '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 0x22fa7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fac60>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', '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:23:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:23:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:23:52 INFO - Using env: {'DISPLAY': ':0', 19:23:52 INFO - 'HOME': '/home/cltbld', 19:23:52 INFO - 'LANG': 'en_US.UTF-8', 19:23:52 INFO - 'LANGUAGE': 'en_US:en', 19:23:52 INFO - 'LOGNAME': 'cltbld', 19:23:52 INFO - 'MAIL': '/var/mail/cltbld', 19:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:52 INFO - 'MOZ_NO_REMOTE': '1', 19:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:52 INFO - 'NO_EM_RESTART': '1', 19:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:23:52 INFO - 'PWD': '/builds/slave/test-pgo', 19:23:52 INFO - 'SHELL': '/bin/bash', 19:23:52 INFO - 'SHLVL': '1', 19:23:52 INFO - 'TERM': 'linux', 19:23:52 INFO - 'TMOUT': '86400', 19:23:52 INFO - 'USER': 'cltbld', 19:23:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', 19:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:52 INFO - '_': '/tools/buildbot/bin/python'} 19:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:52 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 19:23:52 INFO - Cleaning up... 19:23:52 INFO - Return code: 0 19:23:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:23: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')]} 19:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23: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')]} 19:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd7c01f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98b0>, '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 0x22fa7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fac60>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', '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:23:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:23:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:23:52 INFO - Using env: {'DISPLAY': ':0', 19:23:52 INFO - 'HOME': '/home/cltbld', 19:23:52 INFO - 'LANG': 'en_US.UTF-8', 19:23:52 INFO - 'LANGUAGE': 'en_US:en', 19:23:52 INFO - 'LOGNAME': 'cltbld', 19:23:52 INFO - 'MAIL': '/var/mail/cltbld', 19:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:52 INFO - 'MOZ_NO_REMOTE': '1', 19:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:52 INFO - 'NO_EM_RESTART': '1', 19:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:23:52 INFO - 'PWD': '/builds/slave/test-pgo', 19:23:52 INFO - 'SHELL': '/bin/bash', 19:23:52 INFO - 'SHLVL': '1', 19:23:52 INFO - 'TERM': 'linux', 19:23:52 INFO - 'TMOUT': '86400', 19:23:52 INFO - 'USER': 'cltbld', 19:23:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', 19:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:52 INFO - '_': '/tools/buildbot/bin/python'} 19:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:52 INFO - Downloading/unpacking psutil>=0.7.1 19:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:23:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:23:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:23:54 INFO - Installing collected packages: psutil 19:23:54 INFO - Running setup.py install for psutil 19:23:54 INFO - building 'psutil._psutil_linux' extension 19:23:54 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:23:56 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:23:56 INFO - building 'psutil._psutil_posix' extension 19:23:56 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:23:56 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:23:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:23:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:23:56 INFO - Successfully installed psutil 19:23:56 INFO - Cleaning up... 19:23:56 INFO - Return code: 0 19:23:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:56 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 0x7fd7c01f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98b0>, '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 0x22fa7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fac60>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', '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:23:56 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:23:56 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:23:56 INFO - Using env: {'DISPLAY': ':0', 19:23:56 INFO - 'HOME': '/home/cltbld', 19:23:56 INFO - 'LANG': 'en_US.UTF-8', 19:23:56 INFO - 'LANGUAGE': 'en_US:en', 19:23:56 INFO - 'LOGNAME': 'cltbld', 19:23:56 INFO - 'MAIL': '/var/mail/cltbld', 19:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:56 INFO - 'MOZ_NO_REMOTE': '1', 19:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:56 INFO - 'NO_EM_RESTART': '1', 19:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:23:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:23:56 INFO - 'SHELL': '/bin/bash', 19:23:56 INFO - 'SHLVL': '1', 19:23:56 INFO - 'TERM': 'linux', 19:23:56 INFO - 'TMOUT': '86400', 19:23:56 INFO - 'USER': 'cltbld', 19:23:56 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', 19:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:56 INFO - '_': '/tools/buildbot/bin/python'} 19:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:23:56 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:23:56 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:23:56 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:23:56 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:23:56 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:23:56 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:23:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:23:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:23:58 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:23:58 INFO - Installing collected packages: mozsystemmonitor 19:23:58 INFO - Running setup.py install for mozsystemmonitor 19:23:58 INFO - Successfully installed mozsystemmonitor 19:23:58 INFO - Cleaning up... 19:23:58 INFO - Return code: 0 19:23:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:23: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')]} 19:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23: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')]} 19:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23: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', '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 0x7fd7c01f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98b0>, '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 0x22fa7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fac60>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', '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:23: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:23: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 blobuploader==1.2.4 19:23:58 INFO - Using env: {'DISPLAY': ':0', 19:23:58 INFO - 'HOME': '/home/cltbld', 19:23:58 INFO - 'LANG': 'en_US.UTF-8', 19:23:58 INFO - 'LANGUAGE': 'en_US:en', 19:23:58 INFO - 'LOGNAME': 'cltbld', 19:23:58 INFO - 'MAIL': '/var/mail/cltbld', 19:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:58 INFO - 'MOZ_NO_REMOTE': '1', 19:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:58 INFO - 'NO_EM_RESTART': '1', 19:23:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:23:58 INFO - 'PWD': '/builds/slave/test-pgo', 19:23:58 INFO - 'SHELL': '/bin/bash', 19:23:58 INFO - 'SHLVL': '1', 19:23:58 INFO - 'TERM': 'linux', 19:23:58 INFO - 'TMOUT': '86400', 19:23:58 INFO - 'USER': 'cltbld', 19:23:58 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', 19:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:58 INFO - '_': '/tools/buildbot/bin/python'} 19:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:58 INFO - Downloading/unpacking blobuploader==1.2.4 19:23: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 19:23: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:23: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 19:23: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 19:23: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 19:23: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:24:00 INFO - Downloading blobuploader-1.2.4.tar.gz 19:24:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:24:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:24:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:24: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:24: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:24: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:24: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:24: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:24: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:24:01 INFO - Downloading docopt-0.6.1.tar.gz 19:24:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:24:01 INFO - Installing collected packages: blobuploader, requests, docopt 19:24:01 INFO - Running setup.py install for blobuploader 19:24:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:24:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:24:01 INFO - Running setup.py install for requests 19:24:02 INFO - Running setup.py install for docopt 19:24:02 INFO - Successfully installed blobuploader requests docopt 19:24:02 INFO - Cleaning up... 19:24:02 INFO - Return code: 0 19:24:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:24:02 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:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:02 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:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:02 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 0x7fd7c01f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98b0>, '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 0x22fa7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fac60>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', '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:24:02 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:24:02 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:24:02 INFO - Using env: {'DISPLAY': ':0', 19:24:02 INFO - 'HOME': '/home/cltbld', 19:24:02 INFO - 'LANG': 'en_US.UTF-8', 19:24:02 INFO - 'LANGUAGE': 'en_US:en', 19:24:02 INFO - 'LOGNAME': 'cltbld', 19:24:02 INFO - 'MAIL': '/var/mail/cltbld', 19:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:02 INFO - 'MOZ_NO_REMOTE': '1', 19:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:02 INFO - 'NO_EM_RESTART': '1', 19:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:24:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:24:02 INFO - 'SHELL': '/bin/bash', 19:24:02 INFO - 'SHLVL': '1', 19:24:02 INFO - 'TERM': 'linux', 19:24:02 INFO - 'TMOUT': '86400', 19:24:02 INFO - 'USER': 'cltbld', 19:24:02 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', 19:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:02 INFO - '_': '/tools/buildbot/bin/python'} 19:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:24:02 INFO - Running setup.py (path:/tmp/pip-DaeDje-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:24:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:24:02 INFO - Running setup.py (path:/tmp/pip-6VRyCJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:24:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:24:02 INFO - Running setup.py (path:/tmp/pip-PObtFX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:24:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:24:02 INFO - Running setup.py (path:/tmp/pip-V5FVE4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:24:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:24:02 INFO - Running setup.py (path:/tmp/pip-8TxHYJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:24:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:24:02 INFO - Running setup.py (path:/tmp/pip-UmKnn0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:24:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:24:02 INFO - Running setup.py (path:/tmp/pip-MnaeVe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:24:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:24:02 INFO - Running setup.py (path:/tmp/pip-0VIXEt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:24:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:24:02 INFO - Running setup.py (path:/tmp/pip-wa3Bcf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:24:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:24:03 INFO - Running setup.py (path:/tmp/pip-kN30h_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:24:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:24:03 INFO - Running setup.py (path:/tmp/pip-mNUXjC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:24:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:24:03 INFO - Running setup.py (path:/tmp/pip-JKiKwR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:24:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:24:03 INFO - Running setup.py (path:/tmp/pip-ycQLBO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:24:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:24:03 INFO - Running setup.py (path:/tmp/pip-8JhjFw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:24:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:24:03 INFO - Running setup.py (path:/tmp/pip-Iwlld9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:24:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:24:03 INFO - Running setup.py (path:/tmp/pip-iZTYn3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:24:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:24:03 INFO - Running setup.py (path:/tmp/pip-5EUSeH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:24:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:24:03 INFO - Running setup.py install for manifestparser 19:24:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:24:03 INFO - Running setup.py install for mozcrash 19:24:03 INFO - Running setup.py install for mozdebug 19:24:03 INFO - Running setup.py install for mozdevice 19:24:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:24:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:24:04 INFO - Running setup.py install for mozfile 19:24:04 INFO - Running setup.py install for mozhttpd 19:24:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:24:04 INFO - Running setup.py install for mozinfo 19:24:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:24:04 INFO - Running setup.py install for mozInstall 19:24:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:24:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:24:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:24:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:24:04 INFO - Running setup.py install for mozleak 19:24:04 INFO - Running setup.py install for mozlog 19:24:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:24:04 INFO - Running setup.py install for moznetwork 19:24:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:24:04 INFO - Running setup.py install for mozprocess 19:24:04 INFO - Running setup.py install for mozprofile 19:24:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:24:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:24:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:24:04 INFO - Running setup.py install for mozrunner 19:24:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:24:05 INFO - Running setup.py install for mozscreenshot 19:24:05 INFO - Running setup.py install for moztest 19:24:05 INFO - Running setup.py install for mozversion 19:24:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:24:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:24:05 INFO - Cleaning up... 19:24:05 INFO - Return code: 0 19:24:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:05 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 0x7fd7c01f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98b0>, '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 0x22fa7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fac60>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', '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:24:05 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:24:05 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:24:05 INFO - Using env: {'DISPLAY': ':0', 19:24:05 INFO - 'HOME': '/home/cltbld', 19:24:05 INFO - 'LANG': 'en_US.UTF-8', 19:24:05 INFO - 'LANGUAGE': 'en_US:en', 19:24:05 INFO - 'LOGNAME': 'cltbld', 19:24:05 INFO - 'MAIL': '/var/mail/cltbld', 19:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:05 INFO - 'MOZ_NO_REMOTE': '1', 19:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:05 INFO - 'NO_EM_RESTART': '1', 19:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:24:05 INFO - 'PWD': '/builds/slave/test-pgo', 19:24:05 INFO - 'SHELL': '/bin/bash', 19:24:05 INFO - 'SHLVL': '1', 19:24:05 INFO - 'TERM': 'linux', 19:24:05 INFO - 'TMOUT': '86400', 19:24:05 INFO - 'USER': 'cltbld', 19:24:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', 19:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:05 INFO - '_': '/tools/buildbot/bin/python'} 19:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:24:05 INFO - Running setup.py (path:/tmp/pip-o6jQZD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:24:05 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:24:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:24:05 INFO - Running setup.py (path:/tmp/pip-Q_veCD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:24:05 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:24:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:24:05 INFO - Running setup.py (path:/tmp/pip-Y6Xqup-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:24:05 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:24:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:24:05 INFO - Running setup.py (path:/tmp/pip-s4nPDf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:24:05 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:24:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:24:05 INFO - Running setup.py (path:/tmp/pip-UmgYov-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:24:05 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:24:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:24:05 INFO - Running setup.py (path:/tmp/pip-fFDIik-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:24:06 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:24:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:24:06 INFO - Running setup.py (path:/tmp/pip-ZamY59-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:24:06 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:24:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:24:06 INFO - Running setup.py (path:/tmp/pip-u7T0zR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:24:06 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:24:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:24:06 INFO - Running setup.py (path:/tmp/pip-YFNVaW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:24:06 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:24:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:24:06 INFO - Running setup.py (path:/tmp/pip-QWzooN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:24:06 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:24:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:24:06 INFO - Running setup.py (path:/tmp/pip-KbFUHt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:24:06 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:24:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:24:06 INFO - Running setup.py (path:/tmp/pip-vUSk3Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:24:06 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:24:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:24:06 INFO - Running setup.py (path:/tmp/pip-X5IRfS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:24:06 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:24:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:24:06 INFO - Running setup.py (path:/tmp/pip-vmUolw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:24:06 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:24:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:24:06 INFO - Running setup.py (path:/tmp/pip-2GXM8O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:24:06 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:24:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:24:06 INFO - Running setup.py (path:/tmp/pip-YGe4d0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:24:06 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:24:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:24:06 INFO - Running setup.py (path:/tmp/pip-ffA2_y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:24:06 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:24:06 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:24:06 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:24:06 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:24:06 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:24:06 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:24:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:24: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:24: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:24: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:24: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:24: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:24: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:24:08 INFO - Downloading blessings-1.6.tar.gz 19:24:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:24:08 INFO - Installing collected packages: blessings 19:24:08 INFO - Running setup.py install for blessings 19:24:08 INFO - Successfully installed blessings 19:24:08 INFO - Cleaning up... 19:24:09 INFO - Return code: 0 19:24:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:24:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:24:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:24:09 INFO - Reading from file tmpfile_stdout 19:24:09 INFO - Current package versions: 19:24:09 INFO - argparse == 1.2.1 19:24:09 INFO - blessings == 1.6 19:24:09 INFO - blobuploader == 1.2.4 19:24:09 INFO - docopt == 0.6.1 19:24:09 INFO - manifestparser == 1.1 19:24:09 INFO - mozInstall == 1.12 19:24:09 INFO - mozcrash == 0.17 19:24:09 INFO - mozdebug == 0.1 19:24:09 INFO - mozdevice == 0.48 19:24:09 INFO - mozfile == 1.2 19:24:09 INFO - mozhttpd == 0.7 19:24:09 INFO - mozinfo == 0.9 19:24:09 INFO - mozleak == 0.1 19:24:09 INFO - mozlog == 3.1 19:24:09 INFO - moznetwork == 0.27 19:24:09 INFO - mozprocess == 0.22 19:24:09 INFO - mozprofile == 0.28 19:24:09 INFO - mozrunner == 6.11 19:24:09 INFO - mozscreenshot == 0.1 19:24:09 INFO - mozsystemmonitor == 0.0 19:24:09 INFO - moztest == 0.7 19:24:09 INFO - mozversion == 1.4 19:24:09 INFO - psutil == 3.1.1 19:24:09 INFO - requests == 1.2.3 19:24:09 INFO - wsgiref == 0.1.2 19:24:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:09 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 0x7fd7c01f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98b0>, '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 0x22fa7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fac60>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', '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:24:09 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:24:09 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:24:09 INFO - Using env: {'DISPLAY': ':0', 19:24:09 INFO - 'HOME': '/home/cltbld', 19:24:09 INFO - 'LANG': 'en_US.UTF-8', 19:24:09 INFO - 'LANGUAGE': 'en_US:en', 19:24:09 INFO - 'LOGNAME': 'cltbld', 19:24:09 INFO - 'MAIL': '/var/mail/cltbld', 19:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:09 INFO - 'MOZ_NO_REMOTE': '1', 19:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:09 INFO - 'NO_EM_RESTART': '1', 19:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:24:09 INFO - 'PWD': '/builds/slave/test-pgo', 19:24:09 INFO - 'SHELL': '/bin/bash', 19:24:09 INFO - 'SHLVL': '1', 19:24:09 INFO - 'TERM': 'linux', 19:24:09 INFO - 'TMOUT': '86400', 19:24:09 INFO - 'USER': 'cltbld', 19:24:09 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', 19:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:09 INFO - '_': '/tools/buildbot/bin/python'} 19:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 INFO - Cleaning up... 19:24:10 INFO - Return code: 0 19:24:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:24: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:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7c01f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98b0>, '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 0x22fa7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fac60>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', '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:24:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:24:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:24:10 INFO - Using env: {'DISPLAY': ':0', 19:24:10 INFO - 'HOME': '/home/cltbld', 19:24:10 INFO - 'LANG': 'en_US.UTF-8', 19:24:10 INFO - 'LANGUAGE': 'en_US:en', 19:24:10 INFO - 'LOGNAME': 'cltbld', 19:24:10 INFO - 'MAIL': '/var/mail/cltbld', 19:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:10 INFO - 'MOZ_NO_REMOTE': '1', 19:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:10 INFO - 'NO_EM_RESTART': '1', 19:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:24:10 INFO - 'PWD': '/builds/slave/test-pgo', 19:24:10 INFO - 'SHELL': '/bin/bash', 19:24:10 INFO - 'SHLVL': '1', 19:24:10 INFO - 'TERM': 'linux', 19:24:10 INFO - 'TMOUT': '86400', 19:24:10 INFO - 'USER': 'cltbld', 19:24:10 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', 19:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:10 INFO - '_': '/tools/buildbot/bin/python'} 19:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:10 INFO - Downloading/unpacking jsonschema 19:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:24:12 INFO - Downloading/unpacking functools32 (from jsonschema) 19:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:12 INFO - Downloading functools32-3.2.3-2.tar.gz 19:24:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:24:12 INFO - warning: no files found matching '*.txt' 19:24:12 INFO - no previously-included directories found matching 'build' 19:24:12 INFO - no previously-included directories found matching 'dist' 19:24:12 INFO - no previously-included directories found matching '.git*' 19:24:12 INFO - Installing collected packages: jsonschema, functools32 19:24:12 INFO - Running setup.py install for functools32 19:24:12 INFO - warning: no files found matching '*.txt' 19:24:12 INFO - no previously-included directories found matching 'build' 19:24:12 INFO - no previously-included directories found matching 'dist' 19:24:12 INFO - no previously-included directories found matching '.git*' 19:24:12 INFO - Successfully installed jsonschema functools32 19:24:12 INFO - Cleaning up... 19:24:12 INFO - Return code: 0 19:24:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:24:12 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:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:12 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:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:12 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 0x7fd7c01f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98b0>, '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 0x22fa7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fac60>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', '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:24:12 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:24:12 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:24:12 INFO - Using env: {'DISPLAY': ':0', 19:24:12 INFO - 'HOME': '/home/cltbld', 19:24:12 INFO - 'LANG': 'en_US.UTF-8', 19:24:12 INFO - 'LANGUAGE': 'en_US:en', 19:24:12 INFO - 'LOGNAME': 'cltbld', 19:24:12 INFO - 'MAIL': '/var/mail/cltbld', 19:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:12 INFO - 'MOZ_NO_REMOTE': '1', 19:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:12 INFO - 'NO_EM_RESTART': '1', 19:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:24:12 INFO - 'PWD': '/builds/slave/test-pgo', 19:24:12 INFO - 'SHELL': '/bin/bash', 19:24:12 INFO - 'SHLVL': '1', 19:24:12 INFO - 'TERM': 'linux', 19:24:12 INFO - 'TMOUT': '86400', 19:24:12 INFO - 'USER': 'cltbld', 19:24:12 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', 19:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:12 INFO - '_': '/tools/buildbot/bin/python'} 19:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:12 INFO - Downloading/unpacking flake8 19:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:24:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:24: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:24: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:24: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:24: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:24: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:24: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:24:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:24:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:24: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:24: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:24: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:24: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:24: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:24: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:24:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:24:15 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:24:15 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:24:15 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:24:15 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:24:15 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:24:15 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:24:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:24:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:24:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:24:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:24:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:24:15 INFO - no previously-included directories found matching 'docs/_build' 19:24:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:24:15 INFO - Running setup.py install for pep8 19:24:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:24:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:24:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:24:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:24:15 INFO - no previously-included directories found matching 'docs/_build' 19:24:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:24:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:24:15 INFO - Cleaning up... 19:24:15 INFO - Return code: 0 19:24:15 INFO - Running post-action listener: _resource_record_post_action 19:24:15 INFO - Running post-action listener: _start_resource_monitoring 19:24:15 INFO - Starting resource monitoring. 19:24:15 INFO - ##### 19:24:15 INFO - ##### Running install step. 19:24:15 INFO - ##### 19:24:15 INFO - Running pre-action listener: _resource_record_pre_action 19:24:15 INFO - Running main action method: install 19:24:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:24:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:24:15 INFO - Reading from file tmpfile_stdout 19:24:15 INFO - Detecting whether we're running mozinstall >=1.0... 19:24:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:24:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:24:16 INFO - Reading from file tmpfile_stdout 19:24:16 INFO - Output received: 19:24:16 INFO - Usage: mozinstall [options] installer 19:24:16 INFO - Options: 19:24:16 INFO - -h, --help show this help message and exit 19:24:16 INFO - -d DEST, --destination=DEST 19:24:16 INFO - Directory to install application into. [default: 19:24:16 INFO - "/builds/slave/test-pgo"] 19:24:16 INFO - --app=APP Application being installed. [default: firefox] 19:24:16 INFO - mkdir: /builds/slave/test-pgo/build/application 19:24:16 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:24:16 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:24:32 INFO - Reading from file tmpfile_stdout 19:24:32 INFO - Output received: 19:24:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:24:32 INFO - Running post-action listener: _resource_record_post_action 19:24:32 INFO - ##### 19:24:32 INFO - ##### Running run-tests step. 19:24:32 INFO - ##### 19:24:32 INFO - Running pre-action listener: _resource_record_pre_action 19:24:32 INFO - Running main action method: run_tests 19:24:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:24:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:24:32 INFO - Python 2.7.3 19:24:32 INFO - Return code: 0 19:24:32 INFO - grabbing minidump binary from tooltool 19:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:24:32 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 0x22f98b0>, '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 0x22fa7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fac60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:24:32 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:24:32 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:24:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:24:32 INFO - Return code: 0 19:24:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:24:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:24:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:24:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:24:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:24:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:24:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:24:33 INFO - Return code: 0 19:24:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 19:24:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:24:33 INFO - Using env: {'DISPLAY': ':0', 19:24:33 INFO - 'HOME': '/home/cltbld', 19:24:33 INFO - 'LANG': 'en_US.UTF-8', 19:24:33 INFO - 'LANGUAGE': 'en_US:en', 19:24:33 INFO - 'LOGNAME': 'cltbld', 19:24:33 INFO - 'MAIL': '/var/mail/cltbld', 19:24:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:24:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:33 INFO - 'MOZ_NO_REMOTE': '1', 19:24:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:33 INFO - 'NO_EM_RESTART': '1', 19:24:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:24:33 INFO - 'PWD': '/builds/slave/test-pgo', 19:24:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:24:33 INFO - 'SHELL': '/bin/bash', 19:24:33 INFO - 'SHLVL': '1', 19:24:33 INFO - 'TERM': 'linux', 19:24:33 INFO - 'TMOUT': '86400', 19:24:33 INFO - 'USER': 'cltbld', 19:24:33 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765', 19:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:33 INFO - '_': '/tools/buildbot/bin/python'} 19:24:33 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:24:34 INFO - mozversion application_buildid: 20160401163014 19:24:34 INFO - mozversion application_changeset: c40c0b2f3b4c778af4307e090b4063b63c806cda 19:24:34 INFO - mozversion application_display_name: Nightly 19:24:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:24:34 INFO - mozversion application_name: Firefox 19:24:34 INFO - mozversion application_remotingname: firefox 19:24:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:24:34 INFO - mozversion application_vendor: Mozilla 19:24:34 INFO - mozversion application_version: 48.0a1 19:24:34 INFO - mozversion platform_buildid: 20160401163014 19:24:34 INFO - mozversion platform_changeset: c40c0b2f3b4c778af4307e090b4063b63c806cda 19:24:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:24:34 INFO - mozversion platform_version: 48.0a1 19:24:34 INFO - using testdate: 1459563874 19:24:34 INFO - actual date: 1459563874 19:24:34 INFO - starting webserver on 'localhost:55651' 19:24:34 INFO - SUITE-START | Running 2 tests 19:24:34 INFO - TEST-START | dromaeo_css 19:24:34 INFO - operating with platform_type : linux_ 19:24:34 INFO - Initialising browser for dromaeo_css test... 19:24:34 INFO - TEST-INFO | started process 3328 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHs7PWc/profile http://localhost:55651/getInfo.html) 19:24:40 INFO - PROCESS | 3328 | 19:24:40 INFO - PROCESS | 3328 | (process:3399): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:24:40 INFO - PROCESS | 3328 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 19:24:41 INFO - PROCESS | 3328 | __metrics Screen width/height:1600/1200 19:24:41 INFO - PROCESS | 3328 | colorDepth:24 19:24:41 INFO - PROCESS | 3328 | Browser inner width/height: 1024/697 19:24:41 INFO - PROCESS | 3328 | __metrics 19:24:42 ERROR - PROCESS | 3328 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 19:24:43 INFO - TEST-INFO | 3328: exit 0 19:24:43 INFO - Browser initialized. 19:24:43 INFO - Running cycle 1/1 for dromaeo_css test... 19:24:43 INFO - TEST-INFO | started process 3450 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHs7PWc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:44 INFO - PROCESS | 3450 | 19:24:44 INFO - PROCESS | 3450 | (process:3512): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:24:54 INFO - PROCESS | 3450 | RSS: Main: 163393536 19:24:54 INFO - PROCESS | 3450 | 19:25:44 INFO - PROCESS | 3450 | 1459563944377 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:27:51 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:55651/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55651/tests/dromaeo/cssquery-ext.html) 19:27:52 INFO - PROCESS | 3450 | RSS: Main: 168775680 19:27:52 INFO - PROCESS | 3450 | 19:30:54 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:55651/tests/dromaeo/cssquery-ext.html (next: http://localhost:55651/tests/dromaeo/cssquery-jquery.html) 19:30:55 INFO - PROCESS | 3450 | RSS: Main: 165101568 19:30:55 INFO - PROCESS | 3450 | 19:33:57 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:55651/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55651/tests/dromaeo/cssquery-mootools.html) 19:33:57 INFO - PROCESS | 3450 | RSS: Main: 166277120 19:33:57 INFO - PROCESS | 3450 | 19:36:59 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:55651/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55651/tests/dromaeo/cssquery-prototype.html) 19:36:59 INFO - PROCESS | 3450 | RSS: Main: 163913728 19:36:59 INFO - PROCESS | 3450 | 19:40:02 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:55651/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55651/tests/dromaeo/cssquery-yui.html) 19:40:02 INFO - PROCESS | 3450 | RSS: Main: 165306368 19:40:02 INFO - PROCESS | 3450 | 19:43:05 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:55651/tests/dromaeo/cssquery-yui.html (next: http://localhost:55651/tests/dromaeo/cssquery-dojo.html) 19:43:05 INFO - PROCESS | 3450 | RSS: Main: 167477248 19:43:05 INFO - PROCESS | 3450 | 19:43:05 INFO - PROCESS | 3450 | __start_tp_report 19:43:05 INFO - PROCESS | 3450 | _x_x_mozilla_page_load 19:43:05 INFO - PROCESS | 3450 | _x_x_mozilla_page_load_details 19:43:05 INFO - PROCESS | 3450 | |i|pagename|runs| 19:43:05 INFO - PROCESS | 3450 | |0;dojo.html;3129.342838004019;3181.077487528615;3212.0363890832773;3213.3412650406667;3226.6773322667723;5386.9461305386985;5417.133258678612;5430.619856610039;5445.618806683534;5487.6158668893195;5380;5392.379876314215;5420.783168673258;5431.511163995239;5471.644343117695;4842.515748425156;4857.587105096071;4925.48282430345;4930.260460930871;4956.3804524434445;4833.854984350475;4845.297431872376;4853.247746599282;4897.804087836482;4906.337644417994;4870.14772414826;4884.145274576935;4900.485449027872;4919.434265059528;4946.332245146895;4891.8777030574165;4929.235968424864;4934.210526315808;4947.763059235192;4949.8020079196785;4717.528247175289;4745.59662428694;4782.019685964404;4834.613230941516;4932.901341973176;5167.044096842096;5177.326947496839;5181.222816577543;5189.506996835295;5202.115640341151;5618.7190640468225;5627.718614069321;5634.577406694514;5638.718064096779;5685.061964775807;5589.496945274945;5810.854728631818;5835.270591176103;5890.558208134407;5910.822675319747;5276.604254680914;5304.867378315573;5305.1776974569;5309.256704061435;5314.388845282803;5479.315085614298;5777.711114444345;5777.952968061555;5796.855078623068;5816.41835816415;5595.664260144405;5647.463490968352;5657.2928383952;5675.404082571353;5688.146777983253;5632.070708333079;5647.632903861236;5649.71751412436;5665.150227465913;5679.091345384719;5487.6158668892795;5555.777768889199;5560.638558493685;5575.107982722826;5771.076627739625;5540.501354878;5611.887762244733;5705.258316418839;5752.36723960364;5790.218320526759;4156.501219853576;4182.790860456965;4186.455760751083;4198.6011328923705;4302.483701955785;3871.690264778811;3879.9030024249055;3900.258950799339;3909.257241124234;3928.3910993796007;5279.41926388097;5430.64700794455;5439.456054394608;5445.782168713207;5492.588055895823;5702.087665973508;5738.971305143447;5745.368009518949;5764.827055188351;5813.76744930198;5382.811601593926;5392.083345831218;5417.8103766367985;5440.6735595864375;5442.047641662693;4609.746463944448;4747.738874361943;4780.880477988078;4814.422269327633;4822.734749588806;5933.3473317934995;5950.494207992369;5956.16613674086;5969.731362088716;5978.342382337939;5780.768769249267;5795.246617939641;5809.36097029318;5811.331696854916;5817.331006934088;5659.066254068032;5915.556333274935;5957.255343082114;5998.3401825798255;6033.396660333931;5599.8880022400135;5601.355844077983;5603.635763675348;5609.354924183608;5614.831555053192;5620.044592419216;5673.9432605675065;5678.290213723285;5684.943150568607;5686.2607860977805;5503;5597.552195824405;5636.633618814764;5639.379668236573;5692.601517893873;5445.074337362578;5456.208849716848;5458.044842152528;5470.370907345547;5514.365847927379;5195.11683013881;5302.125149350314;5441.156620723794;5441.347038355264;5498.120300751861;5395.649282796606;5592.636478628876;5673.092305231144;5673.773049078156;5678.886422271614;5492.450754924475;5542.196381524575;5554.777808887599;5568.359638641446;5622.522085622768 19:43:05 INFO - PROCESS | 3450 | |1;ext.html;540.2032002795875;571.9513841323487;585.8681796595765;609.2688773471834;642.9357064293574;37387.62612373875;38325.808370958104;38370.616293837054;38430.23139537207;38449.42325865114;35408.46887296693;35793.82103089488;35808;35860.02769847657;35865.10337241564;8565.614547345385;8686.695965641204;8792.164744349277;8792.428492148021;8812.911870881273;8690.435121717068;8760.518171500566;8768.736937891841;8772.69295574655;8772.780680483007;8731.519766412845;8848.867266990968;8860.734177974671;8868.113188681113;8891.733248002538;8788.60451279694;8845.69040083594;8848.159424854628;8871.467711937305;8889.95555022224;8732.476051436934;8819.382643214978;8823.55882205887;8836.823263534758;8850.468971861708;28056.158315250574;35814.28371432557;35931.82034089839;36114.81942590296;36192.276154477026;3255.853486593085;3518.1380561762276;3620.746547741659;3758.3798673218885;4373.693841431101;29114;29568.26079348012;29677.40645187106;29732.256693582618;30316.090517284516;4242.4272723182285;4296.398504209382;4307.547707490699;4321.6326612238;4332.588404101605;227405;228456;230652.9999999983;231005;231463;47585.286220706716;47949;58815;59957.700211499534;60044;47163.5283647166;47532;47722;47742.5225747745;47841.5215847844;16057.197140142945;16241.51275461738;16251.349946002263;16261.837381626268;16304.266308016167;12772.489100436065;12850.55023074188;12878.935605321913;12893.806592901114;12911.5480958166;15709.528714138594;15789.447369342019;16066.27701753424;16153.757693634605;16329.265183066791;6129.651476675124;6131.202943617302;6315.210598675166;6393.424591786761;6447.903281450782;1116.8213085906216;1131.0499180688262;1134.6312448454285;1143.9304250525786;1159.0611604600301;30563.847180763954;30901.69098309033;31142.377152456826;31752.206194845312;32442;1176.723469984553;1184.798584240681;1187.590281352932;1208.4078801387432;1238.5665017243894;15167.469138580318;15635.296411661502;15723.213839308217;15758.369665213493;15851.762223566655;402794;409935;411957;412733;416060;56137;56760.43239567552;56793;56793;56935.14597281044;1248.7814632439288;1264.9557265495664;1284.5439868846424;1285.9678508037373;1317.0977880152127;30949.535756963214;31033.224169395944;31409.842950786013;31447.84276078605;31590.894318698734;44854.77572612116;44954.55045449504;45115.323270150315;45145.77427112844;45208.32187517256;372780.90533663466;374604;375349;375586;376761;36560.81719591385;38437.924966002094;38528.80735596304;38561.80719096387;38565.6143438562;46835.53164468312;48039.75980120077;48397.27404089012;48710.26934595913;49022.509774901795;36942.7834329941;36987.26025479529;37053.44419833651;37325.44011839879;37571.81214093912;38941.80529097337;39958.60041399549;40910;41162;41546;35510.46734299039;39476.40785388164;40890;41236;42740;32267.51598725974;32667.509987349735;33163.66836331606;34458.655413445544;35098.12254693653;27218.455630886874;27989.44021119607;28193.295167620152;28285.292867678472;28304.15087547377 19:43:05 INFO - PROCESS | 3450 | |2;jquery.html;365.8719448193131;370.2354637673205;374.77700768043013;376.9547654281487;378.4512456937441;17594.296228150874;18563.535911602215;19890.502737431572;19973.10121044553;19973.201071957104;17585.208665610047;17989.100544972764;18116.36592719255;18169.545761355974;18213.27146914125;5384.3807962084375;5594.748236329355;5641.069223578104;5647.068233741448;5656.490915817576;3924.5879182685835;5463.262459567967;5711.828645140652;6042.305134909498;6054.152418661369;5978.8804223915495;6003.1895694081395;6015.308239552442;6032.607880487776;6046.00240960241;5771.884562308751;6007.579469437142;6013.579049466539;6013.939860601404;6024.7288872000645;5260.421353651095;5325.4940780625775;5337.905729325479;5343.305370301875;5356.598255130881;20491;21146.154153833828;21704.13183472659;21953.451163720874;22048.228312009163;2076.5743022680313;2213.6347502662043;2216.6231740604135;2360.976390236093;2651.9602205966926;13413.66465838362;13419.798703019462;13744.175349479063;14101.78847317291;14124.858751412457;1959.500327416514;1993.9700904486444;2008.437637461513;2024.4129202531249;2034.6744520876737;71468.6426567869;71690;72667.63666181688;72700.27299727041;72836.99999999948;10139.847902281472;10441.269111162146;10544.472776361152;10951.945240273906;11039.448027598588;13995.230262335466;14047.929760351337;14163.929180354238;14220.85779142216;14234.359453824603;7700.653470593837;7755.2244775521995;7846.372290216769;7847.764567062997;8058.1538938411795;7454.440916931252;7703.422243331773;7827.569483678339;7877.960610196912;7908.604569771604;6110.511159107261;6274.6548939808745;6302.558820882494;6346.428821406003;6364.395382438661;1755.4195332860675;1812.8368446839847;1856.174002568844;1880.6896862017613;1923.2691577200574;935.8830146231721;964.5466630683568;982.4498280962683;1021.6322124035341;1127.7349822791637;17466.388676396266;17555.21001554933;17911.641767164583;18795.718064229048;19450.319238826574;982.8378317577519;1014.1379827146866;1019.1846522781744;1037.0407373179778;1085.2132204152085;10487.632932847313;10772.838407423895;10819.621313253998;10847.945760271148;10870.782584348268;439500;446179;449271;465885.035173418;498454;86786;89046.10953890378;89423.9999999987;89430;89596;1014.624588902111;1014.9035841594889;1085.6363118355282;1119.652907598647;1121.1087185687397;16377.42679006229;16501.33994640201;16646;16712.582185445463;16976.57558561046;37988;39289.607103928596;39704.62510686508;39874.800625996686;39947.60052399439;54239.72880135574;57420;57429.70281188706;57458.42541574531;57869;7689.9615501922135;7830.177831327628;7845.450818442654;7860.646270917937;7920.603969801602;8330.833383332421;11200.943995279971;12850.807237891626;13083.869161308265;13372.598822035354;10509.159267258754;10729.30259533159;10742;11103.222774405715;11485.48315325829;11186.776264474827;11428.542858285908;11452.94273528627;11479.196456248317;11643.417829108681;11689;11691.123165762432;12007.099467540143;12028.578999734968;12248.14263001617;7741.535507869321;7822.765317040498;7916.129225785044;7919.524828510308;7948.483348582324;11060.115190784878;11642.6507204784;11795.764084718086;11839.171258011856;11944.402779860799 19:43:05 INFO - PROCESS | 3450 | |3;mootools.html;1466.0910235653894;1528.5414375687292;1670.432053101945;1789.6331252093323;1807.7830660320762;6400.967995160017;7606.771796846089;7624.123225829031;7783.844323113534;7787.883181752279;7779.1442941276555;7791.454598178129;7818.374530037598;7860.646270917809;7879.290863822255;2299.839011269216;2304.83866129371;2318.7565305642916;2319.768023197675;2327.162221600231;2261.2989973108306;2277.567262220173;2314.085936055257;2331.3705299569106;2332.276994131816;2290.4273931517123;2312.9653055204185;2317.4901521665206;2322.581935251654;2339.4853132310864;2288.519410923708;2297.24191016964;2303.6199027160496;2311.791938725523;2314.2131675230416;2280.817534597228;2303.6544518322216;2308.8730119843403;2322.5587138443643;2337.146941366389;7774.766756997299;7834.764957051298;7851.5681637509915;7851.685932562691;7855.096663883613;4867.853964381075;4972.925406118911;4984.501549844987;4990.326305948687;4995.375578052744;3197.1527545200543;3219.404410184123;3358.2443950111274;3373.443381841993;3380.7464440167087;1011.2951133981728;1034.312182398704;1038.950659833566;1042.3276986343842;1049.7375656085978;10919.563217471292;10953.726156846064;10954.671359859218;10955.4522273886;10977.231593788438;4346.695731298842;4440.955590444054;4475.664325175625;4511.774411279423;4570.65720070996;9135.720999060137;9188.95405522968;9194.988551259356;9198.448093114435;9214.907850921405;4984.053029924303;5018.648694591344;5043.293938848564;5047.974760126176;5061.468545802712;3829.1384438501673;4640.373549570832;4648.2562789953445;4677.134730074947;4770.833020844323;3789.5452545694693;3859.9807000964815;3896.6103389661375;3912.9021774455296;3922.1371298314325;1256.5476428485738;1265.9177153484993;1271.6439396968863;1272.5164437513686;1286.897048236139;1232.06363163996;1239.0273635196327;1244.4337826289018;1249.3191210790142;1249.3503378243263;6994.370506654425;7122.109736282965;7140.321669441499;7356.1540422850985;7374.446916481285;475.5339767028332;479.46300143839125;486.3677219614487;489.4493694593582;490.47029208454785;5869.589128761031;5904.321003084614;5906.379830117861;5932.525397968152;5994.610350327215;9311.348205625676;9753.122219000325;9864.753381165385;9866.506674666238;9965.601375944882;9596.712098637052;9651.324407291422;9779.217662586976;9817.312788104764;9846.310758246997;7066.116735408074;7215.278472152848;7244.094488188976;7257.092863392076;7300.196978332379;7251.927480725125;7289.8177545559665;7324.340809327186;7335;7365.226651201761;8590.226879580869;8711.433756805787;8788.42875213109;8788.736337909873;8790.692325768567;8801.47191168532;8989.146031127033;9002.774930626787;9056.954715226382;9221.907780922105;5841.299044114733;6824.761133360308;7008.264132266038;7265.309795569412;7316.670749816378;7536.886946695914;7564.962175189089;7585.089789225328;7603.239676032353;7630.694772209049;6549.498421325919;6667.333266673294;6708.127943367331;6720.630365329954;6834.965825170842;6539.70571324282;6589.4069533742195;6591.143151390289;6652.068710380454;6710.16122984627;7149.392301654418;7213.062301900719;7215.242399547972;7246.492745507764;7257;6671.532992690659;6698.83252918681;6704.497162712913;6722;6730.158730158731;6758.324167583202;6786.457083433214;6832.555883867532;6859.142607174103;6901.102856628606 19:43:05 INFO - PROCESS | 3450 | |4;prototype.html;334.14958929524363;334.68539572801564;337.4112174255924;340.8091468777486;347.9982600086998;6408.8077357679285;6412.326705695898;6437.710303036363;6480.254770701359;6493.058506516558;6380.266269379023;6391.233052033763;6393.104965304849;6401.143668336189;6407.135036770034;4558.931616025762;4693.249080147177;4817.03659268146;4820.831270905519;4861.4652388237355;4785.3300537924715;4788.449328327235;4798.088363210979;4803.2795080738;4804.25534042224;4740.07568524138;4745.810167593292;4754.738489383082;4766.904661906759;4766.952330476685;4763.618910487153;4765.189917713997;4772.689775164603;4790.353302304179;4831.178699621073;4216.093539888939;4219.514755803091;4221.64116050133;4222.071144348239;4231.1749208904275;6012.96993515034;6126.785562505291;6171.537134714869;6196.659183744892;6213.751449941997;5527.2538207341895;5591.692456914868;5597.132444471114;5598.272224610774;5601.495865372136;6740.393364597161;6751.898721519181;6758.898616520756;6777.220619628756;6779.457643388567;4596.954030459686;4599.356090147382;4603.401557797499;4605.976970115128;4607.055553611535;7029.543079699854;7049.929500704979;7094.858102837914;7098.645067746592;7117.928820711779;4458.130664520388;4570.702904311209;4686.531346865354;4698.788554515055;4718.858434246909;4637.884052898705;4657.1617108920045;4662.323963025342;4672.929906051412;4683.1336202802595;5471.097268950658;5485.232067510552;5490.890182196334;5501.229827824108;5502.669839809624;6751.966240168767;6789.15135608049;6795.252522222551;6818.761343352959;6827.48793840454;1652.1491431912575;1670.6742185273997;1672.824353442871;1675.865930725539;1676.4886709553703;1029.0481304793036;1053.5733028123623;1061.5170097605571;1068.9465526723632;1073.1146803886825;6459.289478157399;6494.447971922439;6496.123023391876;6532.379423954717;6550.377714117151;6954.79135625932;6963.6866341014775;6966.407855332252;6990.056342393814;7025.367716905503;6286.622802631857;6380.840478988062;6575.605463672099;6605.207375115017;6606.8017959461295;3783.319002579507;3807.5240594925635;3827.78947157909;3829.100161462054;3831.444440556104;7244.311790379906;7252.528585642022;7275.454340924452;7285.672144753499;7294.963525182447;7144.24985376528;7189.173245076779;7196.748113815991;7222.025026621444;7228.855422891513;7045.929540704527;7166.713331466787;7215.025971493887;7224.494285399972;7232.276772322831;6933.1333583302085;7058.752943646948;7084.25615310385;7148.106486689164;7159.427245820218;7004.299570043158;7006.334398232159;7009.894851577333;7013.684384202621;7034.5427547209265;7156.105486814148;7250.89123663156;7294.635268236673;7318.817029574303;7336;4665.976670116627;4726.7636618169645;4732.905341893212;4735.502772209006;4737.123632128068;7040.225575186623;7046.506744527834;7080.822979425556;7087.114110736158;7089.503734738519;6828.112345395067;6863.759768408281;6867.313268673292;6893.827654308482;6893.931060689329;6769.3907548320885;6770.932290677227;6795.966020169867;6814.591124532544;6831.180258368829;6501.837454063686;6702.530822842355;6737.157855268091;6751.493637977073;6751.594904305757;6841.555298905555;6874;6890.2420733718245;6913.861722765617;6916.20463646687;6705.195376554844;6738;6770.627615480998;6780.186377634715;6792.626405547545 19:43:05 INFO - PROCESS | 3450 | |5;yui.html;720.5604581205467;749.9350921691198;754.1854796819435;757.3675980556235;772.3898120484818;12811.295378754165;12959.611211663641;13119.47522099116;13134.540291089826;13147.60557183286;12225;12742.29917354545;12769.361531923412;12796.552120675778;12804.103712740112;494.04402481198997;815.9347252219837;825.0470706334194;835.0814104485048;837.7277384849917;823.185046803663;823.2302796884932;824.7319621123129;825.5129473610568;828.2214718164936;871.1854416120947;874.8031692869117;875.544716747291;875.8073223890734;876.3252295732283;863.0420233540765;867.9826403471958;868.9174528419821;869.2654706772767;877.1272583779148;630.9589876658002;632.7279269913935;634.0647544871324;634.7270673610345;635.0727937211676;13158.671033224151;13184.86815131846;13195.802062969064;13228.86771132286;13252.337383130805;12843.807342889864;13115.540956066492;13181.802272965913;13211.273379964097;13409.128406653535;9706.126448619658;9790.216782657442;9793.755156121082;10170.898291017069;10204.081632653022;3677.356462619031;3766.152615661482;3773.3585290500682;3821.522309711286;3853.2293541291856;53030.46969530333;53277.13530026431;53291.46708532942;54927.725361373334;55867.16199257055;10350;10445.477726113664;10498.790024199474;10597.417142057107;10611.893881061245;17391.304347826197;17461.126943652765;17537.912310438365;17559.561010974827;17562.29750809953;7509.549427034395;7709.691612335444;7753.302202801662;8074.152214017561;8141;4626.4910859805395;4634.72191668501;4718.2214934536105;4750.334953106568;4754.120487709784;3230.0632816483426;3239.627442844103;3245.935081298408;3264.55928449661;3277.6066871975518;598.2462097756771;615.6367743031633;618.2827919613227;619.8853212155675;622.9221347331584;574.5059249045818;680.6970897950365;698.7484505577988;699.9825004374932;729.4273994914073;8919.331050171264;9127.224185944136;9144.651213623667;9178.31162662803;9324.766880828034;620.2438506476483;650.2132419772129;690.930906909305;696.8048946295046;740.4187712645547;4738.715677059387;4760.666753327303;4812.085703716282;4816.253480710496;4856.732879691651;64675;65167;66206;66619.00071498932;67062;58430.12354814681;58747.41252587505;58822.70588647029;59109;59603.10595341073;51052;51376;51462.48537514652;52033.21950170751;52365.47634523682;9229.35394522377;9241.676541321021;9339.719808405758;9342.159205671522;9676.467794271382;37628.81185594055;38403.807980959915;38569.807150964065;38684.80657596694;39368.40947385734;50089.49910500849;50499.24251136163;50578.49421505738;50794.492055078976;51517;10981.83527247076;11454.370009649216;11461.656150315504;11516.366599836754;11664.88335116638;13314;13372;13659.590212293648;13761;13873.72252554923;11774.175807693378;11775.175737698279;12130.757384852077;12393;12792.488300468249;12623.431945562288;12738.235705857678;12846.743065138831;13015.435034889333;13067.150635208682;11561.653150405502;12202.877971220529;12245.510179592717;12369.257844529357;12450.937745311216;9920.20638348916;10179.134773544332;10482.37105773656;10624.203184761329;10625.9468702656;10160.33957792741;10384.584616615251;10458.738531536772;10723.571057157626;11267.380294083903 19:43:05 INFO - PROCESS | 3450 | __end_tp_report 19:43:05 INFO - PROCESS | 3450 | __start_cc_report 19:43:05 INFO - PROCESS | 3450 | _x_x_mozilla_cycle_collect,322 19:43:05 INFO - PROCESS | 3450 | __end_cc_report 19:43:05 INFO - PROCESS | 3450 | __startTimestamp1459564985295__endTimestamp 19:43:05 INFO - PROCESS | 3450 | 19:43:05 INFO - PROCESS | 3450 | ------- Summary: start ------- 19:43:05 INFO - PROCESS | 3450 | Number of tests: 6 19:43:05 INFO - PROCESS | 3450 | 19:43:05 INFO - PROCESS | 3450 | [#0] dojo.html Cycles:165 Average:5294.01 Median:5479.32 stddev:600.04 (11.0%) stddev-sans-first:577.35 19:43:05 INFO - PROCESS | 3450 | Values: 3129.3 3181.1 3212.0 3213.3 3226.7 5386.9 5417.1 5430.6 5445.6 5487.6 5380.0 5392.4 5420.8 5431.5 5471.6 4842.5 4857.6 4925.5 4930.3 4956.4 4833.9 4845.3 4853.2 4897.8 4906.3 4870.1 4884.1 4900.5 4919.4 4946.3 4891.9 4929.2 4934.2 4947.8 4949.8 4717.5 4745.6 4782.0 4834.6 4932.9 5167.0 5177.3 5181.2 5189.5 5202.1 5618.7 5627.7 5634.6 5638.7 5685.1 5589.5 5810.9 5835.3 5890.6 5910.8 5276.6 5304.9 5305.2 5309.3 5314.4 5479.3 5777.7 5778.0 5796.9 5816.4 5595.7 5647.5 5657.3 5675.4 5688.1 5632.1 5647.6 5649.7 5665.2 5679.1 5487.6 5555.8 5560.6 5575.1 5771.1 5540.5 5611.9 5705.3 5752.4 5790.2 4156.5 4182.8 4186.5 4198.6 4302.5 3871.7 3879.9 3900.3 3909.3 3928.4 5279.4 5430.6 5439.5 5445.8 5492.6 5702.1 5739.0 5745.4 5764.8 5813.8 5382.8 5392.1 5417.8 5440.7 5442.0 4609.7 4747.7 4780.9 4814.4 4822.7 5933.3 5950.5 5956.2 5969.7 5978.3 5780.8 5795.2 5809.4 5811.3 5817.3 5659.1 5915.6 5957.3 5998.3 6033.4 5599.9 5601.4 5603.6 5609.4 5614.8 5620.0 5673.9 5678.3 5684.9 5686.3 5503.0 5597.6 5636.6 5639.4 5692.6 5445.1 5456.2 5458.0 5470.4 5514.4 5195.1 5302.1 5441.2 5441.3 5498.1 5395.6 5592.6 5673.1 5673.8 5678.9 5492.5 5542.2 5554.8 5568.4 5622.5 19:43:05 INFO - PROCESS | 3450 | 19:43:05 INFO - PROCESS | 3450 | [#1] ext.html Cycles:180 Average:50253.38 Median:190259.69 stddev:91581.57 (48.1%) stddev-sans-first:91762.42 19:43:05 INFO - PROCESS | 3450 | Values: 540.2 572.0 585.9 609.3 642.9 37387.6 38325.8 38370.6 38430.2 38449.4 35408.5 35793.8 35808.0 35860.0 35865.1 8565.6 8686.7 8792.2 8792.4 8812.9 8690.4 8760.5 8768.7 8772.7 8772.8 8731.5 8848.9 8860.7 8868.1 8891.7 8788.6 8845.7 8848.2 8871.5 8890.0 8732.5 8819.4 8823.6 8836.8 8850.5 28056.2 35814.3 35931.8 36114.8 36192.3 3255.9 3518.1 3620.7 3758.4 4373.7 29114.0 29568.3 29677.4 29732.3 30316.1 4242.4 4296.4 4307.5 4321.6 4332.6 227405.0 228456.0 230653.0 231005.0 231463.0 47585.3 47949.0 58815.0 59957.7 60044.0 47163.5 47532.0 47722.0 47742.5 47841.5 16057.2 16241.5 16251.3 16261.8 16304.3 12772.5 12850.6 12878.9 12893.8 12911.5 15709.5 15789.4 16066.3 16153.8 16329.3 6129.7 6131.2 6315.2 6393.4 6447.9 1116.8 1131.0 1134.6 1143.9 1159.1 30563.8 30901.7 31142.4 31752.2 32442.0 1176.7 1184.8 1187.6 1208.4 1238.6 15167.5 15635.3 15723.2 15758.4 15851.8 402794.0 409935.0 411957.0 412733.0 416060.0 56137.0 56760.4 56793.0 56793.0 56935.1 1248.8 1265.0 1284.5 1286.0 1317.1 30949.5 31033.2 31409.8 31447.8 31590.9 44854.8 44954.6 45115.3 45145.8 45208.3 372780.9 374604.0 375349.0 375586.0 376761.0 36560.8 38437.9 38528.8 38561.8 38565.6 46835.5 48039.8 48397.3 48710.3 49022.5 36942.8 36987.3 37053.4 37325.4 37571.8 38941.8 39958.6 40910.0 41162.0 41546.0 35510.5 39476.4 40890.0 41236.0 42740.0 32267.5 32667.5 33163.7 34458.7 35098.1 27218.5 27989.4 28193.3 28285.3 28304.2 19:43:05 INFO - PROCESS | 3450 | 19:43:05 INFO - PROCESS | 3450 | [#2] jquery.html Cycles:180 Average:27592.09 Median:12130.93 stddev:75844.05 (625.2%) stddev-sans-first:76029.26 19:43:05 INFO - PROCESS | 3450 | Values: 365.9 370.2 374.8 377.0 378.5 17594.3 18563.5 19890.5 19973.1 19973.2 17585.2 17989.1 18116.4 18169.5 18213.3 5384.4 5594.7 5641.1 5647.1 5656.5 3924.6 5463.3 5711.8 6042.3 6054.2 5978.9 6003.2 6015.3 6032.6 6046.0 5771.9 6007.6 6013.6 6013.9 6024.7 5260.4 5325.5 5337.9 5343.3 5356.6 20491.0 21146.2 21704.1 21953.5 22048.2 2076.6 2213.6 2216.6 2361.0 2652.0 13413.7 13419.8 13744.2 14101.8 14124.9 1959.5 1994.0 2008.4 2024.4 2034.7 71468.6 71690.0 72667.6 72700.3 72837.0 10139.8 10441.3 10544.5 10951.9 11039.4 13995.2 14047.9 14163.9 14220.9 14234.4 7700.7 7755.2 7846.4 7847.8 8058.2 7454.4 7703.4 7827.6 7878.0 7908.6 6110.5 6274.7 6302.6 6346.4 6364.4 1755.4 1812.8 1856.2 1880.7 1923.3 935.9 964.5 982.4 1021.6 1127.7 17466.4 17555.2 17911.6 18795.7 19450.3 982.8 1014.1 1019.2 1037.0 1085.2 10487.6 10772.8 10819.6 10847.9 10870.8 439500.0 446179.0 449271.0 465885.0 498454.0 86786.0 89046.1 89424.0 89430.0 89596.0 1014.6 1014.9 1085.6 1119.7 1121.1 16377.4 16501.3 16646.0 16712.6 16976.6 37988.0 39289.6 39704.6 39874.8 39947.6 54239.7 57420.0 57429.7 57458.4 57869.0 7690.0 7830.2 7845.5 7860.6 7920.6 8330.8 11200.9 12850.8 13083.9 13372.6 10509.2 10729.3 10742.0 11103.2 11485.5 11186.8 11428.5 11452.9 11479.2 11643.4 11689.0 11691.1 12007.1 12028.6 12248.1 7741.5 7822.8 7916.1 7919.5 7948.5 11060.1 11642.7 11795.8 11839.2 11944.4 19:43:05 INFO - PROCESS | 3450 | 19:43:05 INFO - PROCESS | 3450 | [#3] mootools.html Cycles:180 Average:5555.96 Median:6197.79 stddev:2888.21 (46.6%) stddev-sans-first:2879.96 19:43:05 INFO - PROCESS | 3450 | Values: 1466.1 1528.5 1670.4 1789.6 1807.8 6401.0 7606.8 7624.1 7783.8 7787.9 7779.1 7791.5 7818.4 7860.6 7879.3 2299.8 2304.8 2318.8 2319.8 2327.2 2261.3 2277.6 2314.1 2331.4 2332.3 2290.4 2313.0 2317.5 2322.6 2339.5 2288.5 2297.2 2303.6 2311.8 2314.2 2280.8 2303.7 2308.9 2322.6 2337.1 7774.8 7834.8 7851.6 7851.7 7855.1 4867.9 4972.9 4984.5 4990.3 4995.4 3197.2 3219.4 3358.2 3373.4 3380.7 1011.3 1034.3 1039.0 1042.3 1049.7 10919.6 10953.7 10954.7 10955.5 10977.2 4346.7 4441.0 4475.7 4511.8 4570.7 9135.7 9189.0 9195.0 9198.4 9214.9 4984.1 5018.6 5043.3 5048.0 5061.5 3829.1 4640.4 4648.3 4677.1 4770.8 3789.5 3860.0 3896.6 3912.9 3922.1 1256.5 1265.9 1271.6 1272.5 1286.9 1232.1 1239.0 1244.4 1249.3 1249.4 6994.4 7122.1 7140.3 7356.2 7374.4 475.5 479.5 486.4 489.4 490.5 5869.6 5904.3 5906.4 5932.5 5994.6 9311.3 9753.1 9864.8 9866.5 9965.6 9596.7 9651.3 9779.2 9817.3 9846.3 7066.1 7215.3 7244.1 7257.1 7300.2 7251.9 7289.8 7324.3 7335.0 7365.2 8590.2 8711.4 8788.4 8788.7 8790.7 8801.5 8989.1 9002.8 9057.0 9221.9 5841.3 6824.8 7008.3 7265.3 7316.7 7536.9 7565.0 7585.1 7603.2 7630.7 6549.5 6667.3 6708.1 6720.6 6835.0 6539.7 6589.4 6591.1 6652.1 6710.2 7149.4 7213.1 7215.2 7246.5 7257.0 6671.5 6698.8 6704.5 6722.0 6730.2 6758.3 6786.5 6832.6 6859.1 6901.1 19:43:05 INFO - PROCESS | 3450 | 19:43:05 INFO - PROCESS | 3450 | [#4] prototype.html Cycles:180 Average:5654.09 Median:6469.77 stddev:1748.81 (27.0%) stddev-sans-first:1707.52 19:43:05 INFO - PROCESS | 3450 | Values: 334.1 334.7 337.4 340.8 348.0 6408.8 6412.3 6437.7 6480.3 6493.1 6380.3 6391.2 6393.1 6401.1 6407.1 4558.9 4693.2 4817.0 4820.8 4861.5 4785.3 4788.4 4798.1 4803.3 4804.3 4740.1 4745.8 4754.7 4766.9 4767.0 4763.6 4765.2 4772.7 4790.4 4831.2 4216.1 4219.5 4221.6 4222.1 4231.2 6013.0 6126.8 6171.5 6196.7 6213.8 5527.3 5591.7 5597.1 5598.3 5601.5 6740.4 6751.9 6758.9 6777.2 6779.5 4597.0 4599.4 4603.4 4606.0 4607.1 7029.5 7049.9 7094.9 7098.6 7117.9 4458.1 4570.7 4686.5 4698.8 4718.9 4637.9 4657.2 4662.3 4672.9 4683.1 5471.1 5485.2 5490.9 5501.2 5502.7 6752.0 6789.2 6795.3 6818.8 6827.5 1652.1 1670.7 1672.8 1675.9 1676.5 1029.0 1053.6 1061.5 1068.9 1073.1 6459.3 6494.4 6496.1 6532.4 6550.4 6954.8 6963.7 6966.4 6990.1 7025.4 6286.6 6380.8 6575.6 6605.2 6606.8 3783.3 3807.5 3827.8 3829.1 3831.4 7244.3 7252.5 7275.5 7285.7 7295.0 7144.2 7189.2 7196.7 7222.0 7228.9 7045.9 7166.7 7215.0 7224.5 7232.3 6933.1 7058.8 7084.3 7148.1 7159.4 7004.3 7006.3 7009.9 7013.7 7034.5 7156.1 7250.9 7294.6 7318.8 7336.0 4666.0 4726.8 4732.9 4735.5 4737.1 7040.2 7046.5 7080.8 7087.1 7089.5 6828.1 6863.8 6867.3 6893.8 6893.9 6769.4 6770.9 6796.0 6814.6 6831.2 6501.8 6702.5 6737.2 6751.5 6751.6 6841.6 6874.0 6890.2 6913.9 6916.2 6705.2 6738.0 6770.6 6780.2 6792.6 19:43:05 INFO - PROCESS | 3450 | 19:43:05 INFO - PROCESS | 3450 | [#5] yui.html Cycles:180 Average:15071.47 Median:2675.39 stddev:18150.82 (678.4%) stddev-sans-first:18169.74 19:43:05 INFO - PROCESS | 3450 | Values: 720.6 749.9 754.2 757.4 772.4 12811.3 12959.6 13119.5 13134.5 13147.6 12225.0 12742.3 12769.4 12796.6 12804.1 494.0 815.9 825.0 835.1 837.7 823.2 823.2 824.7 825.5 828.2 871.2 874.8 875.5 875.8 876.3 863.0 868.0 868.9 869.3 877.1 631.0 632.7 634.1 634.7 635.1 13158.7 13184.9 13195.8 13228.9 13252.3 12843.8 13115.5 13181.8 13211.3 13409.1 9706.1 9790.2 9793.8 10170.9 10204.1 3677.4 3766.2 3773.4 3821.5 3853.2 53030.5 53277.1 53291.5 54927.7 55867.2 10350.0 10445.5 10498.8 10597.4 10611.9 17391.3 17461.1 17537.9 17559.6 17562.3 7509.5 7709.7 7753.3 8074.2 8141.0 4626.5 4634.7 4718.2 4750.3 4754.1 3230.1 3239.6 3245.9 3264.6 3277.6 598.2 615.6 618.3 619.9 622.9 574.5 680.7 698.7 700.0 729.4 8919.3 9127.2 9144.7 9178.3 9324.8 620.2 650.2 690.9 696.8 740.4 4738.7 4760.7 4812.1 4816.3 4856.7 64675.0 65167.0 66206.0 66619.0 67062.0 58430.1 58747.4 58822.7 59109.0 59603.1 51052.0 51376.0 51462.5 52033.2 52365.5 9229.4 9241.7 9339.7 9342.2 9676.5 37628.8 38403.8 38569.8 38684.8 39368.4 50089.5 50499.2 50578.5 50794.5 51517.0 10981.8 11454.4 11461.7 11516.4 11664.9 13314.0 13372.0 13659.6 13761.0 13873.7 11774.2 11775.2 12130.8 12393.0 12792.5 12623.4 12738.2 12846.7 13015.4 13067.2 11561.7 12202.9 12245.5 12369.3 12450.9 9920.2 10179.1 10482.4 10624.2 10625.9 10160.3 10384.6 10458.7 10723.6 11267.4 19:43:05 INFO - PROCESS | 3450 | -------- Summary: end -------- 19:43:05 INFO - PROCESS | 3450 | 19:43:05 INFO - TEST-INFO | 3450: exit 0 19:43:05 INFO - TEST-OK | dromaeo_css | took 1111775ms 19:43:05 INFO - TEST-START | kraken 19:43:05 INFO - operating with platform_type : linux_ 19:43:05 INFO - Initialising browser for kraken test... 19:43:05 INFO - TEST-INFO | started process 3690 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQjSHuH/profile http://localhost:55651/getInfo.html) 19:43:09 INFO - PROCESS | 3690 | 19:43:09 INFO - PROCESS | 3690 | (process:3758): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:43:09 INFO - PROCESS | 3690 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 19:43:10 INFO - PROCESS | 3690 | __metrics Screen width/height:1600/1200 19:43:10 INFO - PROCESS | 3690 | colorDepth:24 19:43:10 INFO - PROCESS | 3690 | Browser inner width/height: 1024/697 19:43:10 INFO - PROCESS | 3690 | __metrics 19:43:10 ERROR - PROCESS | 3690 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 19:43:11 INFO - TEST-INFO | 3690: exit 0 19:43:11 INFO - Browser initialized. 19:43:11 INFO - Running cycle 1/1 for kraken test... 19:43:11 INFO - TEST-INFO | started process 3809 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQjSHuH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:43:13 INFO - PROCESS | 3809 | 19:43:13 INFO - PROCESS | 3809 | (process:3871): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:43:23 INFO - PROCESS | 3809 | RSS: Main: 162525184 19:43:23 INFO - PROCESS | 3809 | 19:43:25 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55651/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55651/tests/kraken/driver.html?testName=audio-beat-detection) 19:43:26 INFO - PROCESS | 3809 | RSS: Main: 167976960 19:43:26 INFO - PROCESS | 3809 | 19:43:29 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55651/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55651/tests/kraken/driver.html?testName=audio-dft) 19:43:29 INFO - PROCESS | 3809 | RSS: Main: 171819008 19:43:29 INFO - PROCESS | 3809 | 19:43:32 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55651/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55651/tests/kraken/driver.html?testName=audio-fft) 19:43:33 INFO - PROCESS | 3809 | RSS: Main: 161443840 19:43:33 INFO - PROCESS | 3809 | 19:43:35 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55651/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55651/tests/kraken/driver.html?testName=audio-oscillator) 19:43:35 INFO - PROCESS | 3809 | RSS: Main: 161886208 19:43:35 INFO - PROCESS | 3809 | 19:43:38 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55651/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55651/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:43:38 INFO - PROCESS | 3809 | RSS: Main: 163741696 19:43:38 INFO - PROCESS | 3809 | 19:43:41 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55651/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55651/tests/kraken/driver.html?testName=imaging-darkroom) 19:43:42 INFO - PROCESS | 3809 | RSS: Main: 163295232 19:43:42 INFO - PROCESS | 3809 | 19:43:45 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55651/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55651/tests/kraken/driver.html?testName=imaging-desaturate) 19:43:46 INFO - PROCESS | 3809 | RSS: Main: 163770368 19:43:46 INFO - PROCESS | 3809 | 19:43:49 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55651/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55651/tests/kraken/driver.html?testName=json-parse-financial) 19:43:49 INFO - PROCESS | 3809 | RSS: Main: 166010880 19:43:49 INFO - PROCESS | 3809 | 19:43:51 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55651/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55651/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:43:52 INFO - PROCESS | 3809 | RSS: Main: 166260736 19:43:52 INFO - PROCESS | 3809 | 19:43:53 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55651/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55651/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:43:54 INFO - PROCESS | 3809 | RSS: Main: 165933056 19:43:54 INFO - PROCESS | 3809 | 19:43:56 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55651/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55651/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:43:57 INFO - PROCESS | 3809 | RSS: Main: 167485440 19:43:57 INFO - PROCESS | 3809 | 19:43:59 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55651/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:44:00 INFO - PROCESS | 3809 | RSS: Main: 166842368 19:44:00 INFO - PROCESS | 3809 | 19:44:02 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:44:03 INFO - PROCESS | 3809 | RSS: Main: 166699008 19:44:03 INFO - PROCESS | 3809 | 19:44:04 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55651/tests/kraken/driver.html?testName=ai-astar) 19:44:05 INFO - PROCESS | 3809 | RSS: Main: 169066496 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | __start_tp_report 19:44:05 INFO - PROCESS | 3809 | _x_x_mozilla_page_load 19:44:05 INFO - PROCESS | 3809 | _x_x_mozilla_page_load_details 19:44:05 INFO - PROCESS | 3809 | |i|pagename|runs| 19:44:05 INFO - PROCESS | 3809 | |0;ai-astar;111;104;110;108;111;121;110;110;113;110 19:44:05 INFO - PROCESS | 3809 | |1;audio-beat-detection;154;133;149;179;129;156;166;131;184;131 19:44:05 INFO - PROCESS | 3809 | |2;audio-dft;162;166;161;161;164;163;163;164;170;163 19:44:05 INFO - PROCESS | 3809 | |3;audio-fft;77;74;73;77;77;73;76;73;146;73 19:44:05 INFO - PROCESS | 3809 | |4;audio-oscillator;94;95;143;92;93;93;145;93;92;143 19:44:05 INFO - PROCESS | 3809 | |5;imaging-gaussian-blur;117;117;118;118;117;118;118;117;118;118 19:44:05 INFO - PROCESS | 3809 | |6;imaging-darkroom;147;147;147;147;150;147;148;146;147;147 19:44:05 INFO - PROCESS | 3809 | |7;imaging-desaturate;95;96;95;96;95;97;96;96;96;96 19:44:05 INFO - PROCESS | 3809 | |8;json-parse-financial;56;59;60;65;58;56;56;60;55;57 19:44:05 INFO - PROCESS | 3809 | |9;json-stringify-tinderbox;62;61;61;62;64;62;63;62;62;62 19:44:05 INFO - PROCESS | 3809 | |10;stanford-crypto-aes;79;79;79;78;79;86;81;80;82;79 19:44:05 INFO - PROCESS | 3809 | |11;stanford-crypto-ccm;121;111;117;131;112;112;119;123;117;124 19:44:05 INFO - PROCESS | 3809 | |12;stanford-crypto-pbkdf2;145;135;141;150;143;142;141;142;141;145 19:44:05 INFO - PROCESS | 3809 | |13;stanford-crypto-sha256-iterative;63;63;67;63;64;63;64;62;64;65 19:44:05 INFO - PROCESS | 3809 | __end_tp_report 19:44:05 INFO - PROCESS | 3809 | __start_cc_report 19:44:05 INFO - PROCESS | 3809 | _x_x_mozilla_cycle_collect,816 19:44:05 INFO - PROCESS | 3809 | __end_cc_report 19:44:05 INFO - PROCESS | 3809 | __startTimestamp1459565045126__endTimestamp 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | ------- Summary: start ------- 19:44:05 INFO - PROCESS | 3809 | Number of tests: 14 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | [#0] ai-astar Cycles:10 Average:110.80 Median:110.50 stddev:4.29 (3.9%) stddev-sans-first:4.55 19:44:05 INFO - PROCESS | 3809 | Values: 111.0 104.0 110.0 108.0 111.0 121.0 110.0 110.0 113.0 110.0 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:155.00 stddev:20.39 (13.2%) stddev-sans-first:21.61 19:44:05 INFO - PROCESS | 3809 | Values: 154.0 133.0 149.0 179.0 129.0 156.0 166.0 131.0 184.0 131.0 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.67 (1.6%) stddev-sans-first:2.76 19:44:05 INFO - PROCESS | 3809 | Values: 162.0 166.0 161.0 161.0 164.0 163.0 163.0 164.0 170.0 163.0 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:22.60 (30.1%) stddev-sans-first:23.90 19:44:05 INFO - PROCESS | 3809 | Values: 77.0 74.0 73.0 77.0 77.0 73.0 76.0 73.0 146.0 73.0 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:93.00 stddev:24.43 (26.3%) stddev-sans-first:25.35 19:44:05 INFO - PROCESS | 3809 | Values: 94.0 95.0 143.0 92.0 93.0 93.0 145.0 93.0 92.0 143.0 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:44:05 INFO - PROCESS | 3809 | Values: 117.0 117.0 118.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 19:44:05 INFO - PROCESS | 3809 | Values: 147.0 147.0 147.0 147.0 150.0 147.0 148.0 146.0 147.0 147.0 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 19:44:05 INFO - PROCESS | 3809 | Values: 95.0 96.0 95.0 96.0 95.0 97.0 96.0 96.0 96.0 96.0 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.50 stddev:2.97 (5.1%) stddev-sans-first:3.05 19:44:05 INFO - PROCESS | 3809 | Values: 56.0 59.0 60.0 65.0 58.0 56.0 56.0 60.0 55.0 57.0 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.88 (1.4%) stddev-sans-first:0.93 19:44:05 INFO - PROCESS | 3809 | Values: 62.0 61.0 61.0 62.0 64.0 62.0 63.0 62.0 62.0 62.0 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.50 stddev:2.35 (3.0%) stddev-sans-first:2.45 19:44:05 INFO - PROCESS | 3809 | Values: 79.0 79.0 79.0 78.0 79.0 86.0 81.0 80.0 82.0 79.0 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:120.00 stddev:6.31 (5.3%) stddev-sans-first:6.64 19:44:05 INFO - PROCESS | 3809 | Values: 121.0 111.0 117.0 131.0 112.0 112.0 119.0 123.0 117.0 124.0 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.50 Median:142.50 stddev:3.84 (2.7%) stddev-sans-first:3.96 19:44:05 INFO - PROCESS | 3809 | Values: 145.0 135.0 141.0 150.0 143.0 142.0 141.0 142.0 141.0 145.0 19:44:05 INFO - PROCESS | 3809 | 19:44:05 INFO - PROCESS | 3809 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.40 (2.2%) stddev-sans-first:1.45 19:44:05 INFO - PROCESS | 3809 | Values: 63.0 63.0 67.0 63.0 64.0 63.0 64.0 62.0 64.0 65.0 19:44:05 INFO - PROCESS | 3809 | -------- Summary: end -------- 19:44:05 INFO - PROCESS | 3809 | 19:44:06 INFO - TEST-INFO | 3809: exit 0 19:44:06 INFO - TEST-OK | kraken | took 60102ms 19:44:06 INFO - SUITE-END | took 1171s 19:44:06 INFO - Completed test suite (00:19:32) 19:44:06 INFO - javascript benchmark 19:44:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3129.342838004019, 3181.077487528615, 3212.0363890832773, 3213.3412650406667, 3226.6773322667723, 5386.9461305386985, 5417.133258678612, 5430.619856610039, 5445.618806683534, 5487.6158668893195, 5380.0, 5392.379876314215, 5420.783168673258, 5431.511163995239, 5471.644343117695, 4842.515748425156, 4857.587105096071, 4925.48282430345, 4930.260460930871, 4956.3804524434445, 4833.854984350475, 4845.297431872376, 4853.247746599282, 4897.804087836482, 4906.337644417994, 4870.14772414826, 4884.145274576935, 4900.485449027872, 4919.434265059528, 4946.332245146895, 4891.8777030574165, 4929.235968424864, 4934.210526315808, 4947.763059235192, 4949.8020079196785, 4717.528247175289, 4745.59662428694, 4782.019685964404, 4834.613230941516, 4932.901341973176, 5167.044096842096, 5177.326947496839, 5181.222816577543, 5189.506996835295, 5202.115640341151, 5618.7190640468225, 5627.718614069321, 5634.577406694514, 5638.718064096779, 5685.061964775807, 5589.496945274945, 5810.854728631818, 5835.270591176103, 5890.558208134407, 5910.822675319747, 5276.604254680914, 5304.867378315573, 5305.1776974569, 5309.256704061435, 5314.388845282803, 5479.315085614298, 5777.711114444345, 5777.952968061555, 5796.855078623068, 5816.41835816415, 5595.664260144405, 5647.463490968352, 5657.2928383952, 5675.404082571353, 5688.146777983253, 5632.070708333079, 5647.632903861236, 5649.71751412436, 5665.150227465913, 5679.091345384719, 5487.6158668892795, 5555.777768889199, 5560.638558493685, 5575.107982722826, 5771.076627739625, 5540.501354878, 5611.887762244733, 5705.258316418839, 5752.36723960364, 5790.218320526759, 4156.501219853576, 4182.790860456965, 4186.455760751083, 4198.6011328923705, 4302.483701955785, 3871.690264778811, 3879.9030024249055, 3900.258950799339, 3909.257241124234, 3928.3910993796007, 5279.41926388097, 5430.64700794455, 5439.456054394608, 5445.782168713207, 5492.588055895823, 5702.087665973508, 5738.971305143447, 5745.368009518949, 5764.827055188351, 5813.76744930198, 5382.811601593926, 5392.083345831218, 5417.8103766367985, 5440.6735595864375, 5442.047641662693, 4609.746463944448, 4747.738874361943, 4780.880477988078, 4814.422269327633, 4822.734749588806, 5933.3473317934995, 5950.494207992369, 5956.16613674086, 5969.731362088716, 5978.342382337939, 5780.768769249267, 5795.246617939641, 5809.36097029318, 5811.331696854916, 5817.331006934088, 5659.066254068032, 5915.556333274935, 5957.255343082114, 5998.3401825798255, 6033.396660333931, 5599.8880022400135, 5601.355844077983, 5603.635763675348, 5609.354924183608, 5614.831555053192, 5620.044592419216, 5673.9432605675065, 5678.290213723285, 5684.943150568607, 5686.2607860977805, 5503.0, 5597.552195824405, 5636.633618814764, 5639.379668236573, 5692.601517893873, 5445.074337362578, 5456.208849716848, 5458.044842152528, 5470.370907345547, 5514.365847927379, 5195.11683013881, 5302.125149350314, 5441.156620723794, 5441.347038355264, 5498.120300751861, 5395.649282796606, 5592.636478628876, 5673.092305231144, 5673.773049078156, 5678.886422271614, 5492.450754924475, 5542.196381524575, 5554.777808887599, 5568.359638641446, 5622.522085622768], "unit": "score", "name": "dojo.html", "value": 5254.395076177278}, {"lowerIsBetter": false, "replicates": [540.2032002795875, 571.9513841323487, 585.8681796595765, 609.2688773471834, 642.9357064293574, 37387.62612373875, 38325.808370958104, 38370.616293837054, 38430.23139537207, 38449.42325865114, 35408.46887296693, 35793.82103089488, 35808.0, 35860.02769847657, 35865.10337241564, 8565.614547345385, 8686.695965641204, 8792.164744349277, 8792.428492148021, 8812.911870881273, 8690.435121717068, 8760.518171500566, 8768.736937891841, 8772.69295574655, 8772.780680483007, 8731.519766412845, 8848.867266990968, 8860.734177974671, 8868.113188681113, 8891.733248002538, 8788.60451279694, 8845.69040083594, 8848.159424854628, 8871.467711937305, 8889.95555022224, 8732.476051436934, 8819.382643214978, 8823.55882205887, 8836.823263534758, 8850.468971861708, 28056.158315250574, 35814.28371432557, 35931.82034089839, 36114.81942590296, 36192.276154477026, 3255.853486593085, 3518.1380561762276, 3620.746547741659, 3758.3798673218885, 4373.693841431101, 29114.0, 29568.26079348012, 29677.40645187106, 29732.256693582618, 30316.090517284516, 4242.4272723182285, 4296.398504209382, 4307.547707490699, 4321.6326612238, 4332.588404101605, 227405.0, 228456.0, 230652.9999999983, 231005.0, 231463.0, 47585.286220706716, 47949.0, 58815.0, 59957.700211499534, 60044.0, 47163.5283647166, 47532.0, 47722.0, 47742.5225747745, 47841.5215847844, 16057.197140142945, 16241.51275461738, 16251.349946002263, 16261.837381626268, 16304.266308016167, 12772.489100436065, 12850.55023074188, 12878.935605321913, 12893.806592901114, 12911.5480958166, 15709.528714138594, 15789.447369342019, 16066.27701753424, 16153.757693634605, 16329.265183066791, 6129.651476675124, 6131.202943617302, 6315.210598675166, 6393.424591786761, 6447.903281450782, 1116.8213085906216, 1131.0499180688262, 1134.6312448454285, 1143.9304250525786, 1159.0611604600301, 30563.847180763954, 30901.69098309033, 31142.377152456826, 31752.206194845312, 32442.0, 1176.723469984553, 1184.798584240681, 1187.590281352932, 1208.4078801387432, 1238.5665017243894, 15167.469138580318, 15635.296411661502, 15723.213839308217, 15758.369665213493, 15851.762223566655, 402794.0, 409935.0, 411957.0, 412733.0, 416060.0, 56137.0, 56760.43239567552, 56793.0, 56793.0, 56935.14597281044, 1248.7814632439288, 1264.9557265495664, 1284.5439868846424, 1285.9678508037373, 1317.0977880152127, 30949.535756963214, 31033.224169395944, 31409.842950786013, 31447.84276078605, 31590.894318698734, 44854.77572612116, 44954.55045449504, 45115.323270150315, 45145.77427112844, 45208.32187517256, 372780.90533663466, 374604.0, 375349.0, 375586.0, 376761.0, 36560.81719591385, 38437.924966002094, 38528.80735596304, 38561.80719096387, 38565.6143438562, 46835.53164468312, 48039.75980120077, 48397.27404089012, 48710.26934595913, 49022.509774901795, 36942.7834329941, 36987.26025479529, 37053.44419833651, 37325.44011839879, 37571.81214093912, 38941.80529097337, 39958.60041399549, 40910.0, 41162.0, 41546.0, 35510.46734299039, 39476.40785388164, 40890.0, 41236.0, 42740.0, 32267.51598725974, 32667.509987349735, 33163.66836331606, 34458.655413445544, 35098.12254693653, 27218.455630886874, 27989.44021119607, 28193.295167620152, 28285.292867678472, 28304.15087547377], "unit": "score", "name": "ext.html", "value": 18933.487554259496}, {"lowerIsBetter": false, "replicates": [365.8719448193131, 370.2354637673205, 374.77700768043013, 376.9547654281487, 378.4512456937441, 17594.296228150874, 18563.535911602215, 19890.502737431572, 19973.10121044553, 19973.201071957104, 17585.208665610047, 17989.100544972764, 18116.36592719255, 18169.545761355974, 18213.27146914125, 5384.3807962084375, 5594.748236329355, 5641.069223578104, 5647.068233741448, 5656.490915817576, 3924.5879182685835, 5463.262459567967, 5711.828645140652, 6042.305134909498, 6054.152418661369, 5978.8804223915495, 6003.1895694081395, 6015.308239552442, 6032.607880487776, 6046.00240960241, 5771.884562308751, 6007.579469437142, 6013.579049466539, 6013.939860601404, 6024.7288872000645, 5260.421353651095, 5325.4940780625775, 5337.905729325479, 5343.305370301875, 5356.598255130881, 20491.0, 21146.154153833828, 21704.13183472659, 21953.451163720874, 22048.228312009163, 2076.5743022680313, 2213.6347502662043, 2216.6231740604135, 2360.976390236093, 2651.9602205966926, 13413.66465838362, 13419.798703019462, 13744.175349479063, 14101.78847317291, 14124.858751412457, 1959.500327416514, 1993.9700904486444, 2008.437637461513, 2024.4129202531249, 2034.6744520876737, 71468.6426567869, 71690.0, 72667.63666181688, 72700.27299727041, 72836.99999999948, 10139.847902281472, 10441.269111162146, 10544.472776361152, 10951.945240273906, 11039.448027598588, 13995.230262335466, 14047.929760351337, 14163.929180354238, 14220.85779142216, 14234.359453824603, 7700.653470593837, 7755.2244775521995, 7846.372290216769, 7847.764567062997, 8058.1538938411795, 7454.440916931252, 7703.422243331773, 7827.569483678339, 7877.960610196912, 7908.604569771604, 6110.511159107261, 6274.6548939808745, 6302.558820882494, 6346.428821406003, 6364.395382438661, 1755.4195332860675, 1812.8368446839847, 1856.174002568844, 1880.6896862017613, 1923.2691577200574, 935.8830146231721, 964.5466630683568, 982.4498280962683, 1021.6322124035341, 1127.7349822791637, 17466.388676396266, 17555.21001554933, 17911.641767164583, 18795.718064229048, 19450.319238826574, 982.8378317577519, 1014.1379827146866, 1019.1846522781744, 1037.0407373179778, 1085.2132204152085, 10487.632932847313, 10772.838407423895, 10819.621313253998, 10847.945760271148, 10870.782584348268, 439500.0, 446179.0, 449271.0, 465885.035173418, 498454.0, 86786.0, 89046.10953890378, 89423.9999999987, 89430.0, 89596.0, 1014.624588902111, 1014.9035841594889, 1085.6363118355282, 1119.652907598647, 1121.1087185687397, 16377.42679006229, 16501.33994640201, 16646.0, 16712.582185445463, 16976.57558561046, 37988.0, 39289.607103928596, 39704.62510686508, 39874.800625996686, 39947.60052399439, 54239.72880135574, 57420.0, 57429.70281188706, 57458.42541574531, 57869.0, 7689.9615501922135, 7830.177831327628, 7845.450818442654, 7860.646270917937, 7920.603969801602, 8330.833383332421, 11200.943995279971, 12850.807237891626, 13083.869161308265, 13372.598822035354, 10509.159267258754, 10729.30259533159, 10742.0, 11103.222774405715, 11485.48315325829, 11186.776264474827, 11428.542858285908, 11452.94273528627, 11479.196456248317, 11643.417829108681, 11689.0, 11691.123165762432, 12007.099467540143, 12028.578999734968, 12248.14263001617, 7741.535507869321, 7822.765317040498, 7916.129225785044, 7919.524828510308, 7948.483348582324, 11060.115190784878, 11642.6507204784, 11795.764084718086, 11839.171258011856, 11944.402779860799], "unit": "score", "name": "jquery.html", "value": 9094.147569839166}, {"lowerIsBetter": false, "replicates": [1466.0910235653894, 1528.5414375687292, 1670.432053101945, 1789.6331252093323, 1807.7830660320762, 6400.967995160017, 7606.771796846089, 7624.123225829031, 7783.844323113534, 7787.883181752279, 7779.1442941276555, 7791.454598178129, 7818.374530037598, 7860.646270917809, 7879.290863822255, 2299.839011269216, 2304.83866129371, 2318.7565305642916, 2319.768023197675, 2327.162221600231, 2261.2989973108306, 2277.567262220173, 2314.085936055257, 2331.3705299569106, 2332.276994131816, 2290.4273931517123, 2312.9653055204185, 2317.4901521665206, 2322.581935251654, 2339.4853132310864, 2288.519410923708, 2297.24191016964, 2303.6199027160496, 2311.791938725523, 2314.2131675230416, 2280.817534597228, 2303.6544518322216, 2308.8730119843403, 2322.5587138443643, 2337.146941366389, 7774.766756997299, 7834.764957051298, 7851.5681637509915, 7851.685932562691, 7855.096663883613, 4867.853964381075, 4972.925406118911, 4984.501549844987, 4990.326305948687, 4995.375578052744, 3197.1527545200543, 3219.404410184123, 3358.2443950111274, 3373.443381841993, 3380.7464440167087, 1011.2951133981728, 1034.312182398704, 1038.950659833566, 1042.3276986343842, 1049.7375656085978, 10919.563217471292, 10953.726156846064, 10954.671359859218, 10955.4522273886, 10977.231593788438, 4346.695731298842, 4440.955590444054, 4475.664325175625, 4511.774411279423, 4570.65720070996, 9135.720999060137, 9188.95405522968, 9194.988551259356, 9198.448093114435, 9214.907850921405, 4984.053029924303, 5018.648694591344, 5043.293938848564, 5047.974760126176, 5061.468545802712, 3829.1384438501673, 4640.373549570832, 4648.2562789953445, 4677.134730074947, 4770.833020844323, 3789.5452545694693, 3859.9807000964815, 3896.6103389661375, 3912.9021774455296, 3922.1371298314325, 1256.5476428485738, 1265.9177153484993, 1271.6439396968863, 1272.5164437513686, 1286.897048236139, 1232.06363163996, 1239.0273635196327, 1244.4337826289018, 1249.3191210790142, 1249.3503378243263, 6994.370506654425, 7122.109736282965, 7140.321669441499, 7356.1540422850985, 7374.446916481285, 475.5339767028332, 479.46300143839125, 486.3677219614487, 489.4493694593582, 490.47029208454785, 5869.589128761031, 5904.321003084614, 5906.379830117861, 5932.525397968152, 5994.610350327215, 9311.348205625676, 9753.122219000325, 9864.753381165385, 9866.506674666238, 9965.601375944882, 9596.712098637052, 9651.324407291422, 9779.217662586976, 9817.312788104764, 9846.310758246997, 7066.116735408074, 7215.278472152848, 7244.094488188976, 7257.092863392076, 7300.196978332379, 7251.927480725125, 7289.8177545559665, 7324.340809327186, 7335.0, 7365.226651201761, 8590.226879580869, 8711.433756805787, 8788.42875213109, 8788.736337909873, 8790.692325768567, 8801.47191168532, 8989.146031127033, 9002.774930626787, 9056.954715226382, 9221.907780922105, 5841.299044114733, 6824.761133360308, 7008.264132266038, 7265.309795569412, 7316.670749816378, 7536.886946695914, 7564.962175189089, 7585.089789225328, 7603.239676032353, 7630.694772209049, 6549.498421325919, 6667.333266673294, 6708.127943367331, 6720.630365329954, 6834.965825170842, 6539.70571324282, 6589.4069533742195, 6591.143151390289, 6652.068710380454, 6710.16122984627, 7149.392301654418, 7213.062301900719, 7215.242399547972, 7246.492745507764, 7257.0, 6671.532992690659, 6698.83252918681, 6704.497162712913, 6722.0, 6730.158730158731, 6758.324167583202, 6786.457083433214, 6832.555883867532, 6859.142607174103, 6901.102856628606], "unit": "score", "name": "mootools.html", "value": 4499.595033459536}, {"lowerIsBetter": false, "replicates": [334.14958929524363, 334.68539572801564, 337.4112174255924, 340.8091468777486, 347.9982600086998, 6408.8077357679285, 6412.326705695898, 6437.710303036363, 6480.254770701359, 6493.058506516558, 6380.266269379023, 6391.233052033763, 6393.104965304849, 6401.143668336189, 6407.135036770034, 4558.931616025762, 4693.249080147177, 4817.03659268146, 4820.831270905519, 4861.4652388237355, 4785.3300537924715, 4788.449328327235, 4798.088363210979, 4803.2795080738, 4804.25534042224, 4740.07568524138, 4745.810167593292, 4754.738489383082, 4766.904661906759, 4766.952330476685, 4763.618910487153, 4765.189917713997, 4772.689775164603, 4790.353302304179, 4831.178699621073, 4216.093539888939, 4219.514755803091, 4221.64116050133, 4222.071144348239, 4231.1749208904275, 6012.96993515034, 6126.785562505291, 6171.537134714869, 6196.659183744892, 6213.751449941997, 5527.2538207341895, 5591.692456914868, 5597.132444471114, 5598.272224610774, 5601.495865372136, 6740.393364597161, 6751.898721519181, 6758.898616520756, 6777.220619628756, 6779.457643388567, 4596.954030459686, 4599.356090147382, 4603.401557797499, 4605.976970115128, 4607.055553611535, 7029.543079699854, 7049.929500704979, 7094.858102837914, 7098.645067746592, 7117.928820711779, 4458.130664520388, 4570.702904311209, 4686.531346865354, 4698.788554515055, 4718.858434246909, 4637.884052898705, 4657.1617108920045, 4662.323963025342, 4672.929906051412, 4683.1336202802595, 5471.097268950658, 5485.232067510552, 5490.890182196334, 5501.229827824108, 5502.669839809624, 6751.966240168767, 6789.15135608049, 6795.252522222551, 6818.761343352959, 6827.48793840454, 1652.1491431912575, 1670.6742185273997, 1672.824353442871, 1675.865930725539, 1676.4886709553703, 1029.0481304793036, 1053.5733028123623, 1061.5170097605571, 1068.9465526723632, 1073.1146803886825, 6459.289478157399, 6494.447971922439, 6496.123023391876, 6532.379423954717, 6550.377714117151, 6954.79135625932, 6963.6866341014775, 6966.407855332252, 6990.056342393814, 7025.367716905503, 6286.622802631857, 6380.840478988062, 6575.605463672099, 6605.207375115017, 6606.8017959461295, 3783.319002579507, 3807.5240594925635, 3827.78947157909, 3829.100161462054, 3831.444440556104, 7244.311790379906, 7252.528585642022, 7275.454340924452, 7285.672144753499, 7294.963525182447, 7144.24985376528, 7189.173245076779, 7196.748113815991, 7222.025026621444, 7228.855422891513, 7045.929540704527, 7166.713331466787, 7215.025971493887, 7224.494285399972, 7232.276772322831, 6933.1333583302085, 7058.752943646948, 7084.25615310385, 7148.106486689164, 7159.427245820218, 7004.299570043158, 7006.334398232159, 7009.894851577333, 7013.684384202621, 7034.5427547209265, 7156.105486814148, 7250.89123663156, 7294.635268236673, 7318.817029574303, 7336.0, 4665.976670116627, 4726.7636618169645, 4732.905341893212, 4735.502772209006, 4737.123632128068, 7040.225575186623, 7046.506744527834, 7080.822979425556, 7087.114110736158, 7089.503734738519, 6828.112345395067, 6863.759768408281, 6867.313268673292, 6893.827654308482, 6893.931060689329, 6769.3907548320885, 6770.932290677227, 6795.966020169867, 6814.591124532544, 6831.180258368829, 6501.837454063686, 6702.530822842355, 6737.157855268091, 6751.493637977073, 6751.594904305757, 6841.555298905555, 6874.0, 6890.2420733718245, 6913.861722765617, 6916.20463646687, 6705.195376554844, 6738.0, 6770.627615480998, 6780.186377634715, 6792.626405547545], "unit": "score", "name": "prototype.html", "value": 5071.980313170301}, {"lowerIsBetter": false, "replicates": [720.5604581205467, 749.9350921691198, 754.1854796819435, 757.3675980556235, 772.3898120484818, 12811.295378754165, 12959.611211663641, 13119.47522099116, 13134.540291089826, 13147.60557183286, 12225.0, 12742.29917354545, 12769.361531923412, 12796.552120675778, 12804.103712740112, 494.04402481198997, 815.9347252219837, 825.0470706334194, 835.0814104485048, 837.7277384849917, 823.185046803663, 823.2302796884932, 824.7319621123129, 825.5129473610568, 828.2214718164936, 871.1854416120947, 874.8031692869117, 875.544716747291, 875.8073223890734, 876.3252295732283, 863.0420233540765, 867.9826403471958, 868.9174528419821, 869.2654706772767, 877.1272583779148, 630.9589876658002, 632.7279269913935, 634.0647544871324, 634.7270673610345, 635.0727937211676, 13158.671033224151, 13184.86815131846, 13195.802062969064, 13228.86771132286, 13252.337383130805, 12843.807342889864, 13115.540956066492, 13181.802272965913, 13211.273379964097, 13409.128406653535, 9706.126448619658, 9790.216782657442, 9793.755156121082, 10170.898291017069, 10204.081632653022, 3677.356462619031, 3766.152615661482, 3773.3585290500682, 3821.522309711286, 3853.2293541291856, 53030.46969530333, 53277.13530026431, 53291.46708532942, 54927.725361373334, 55867.16199257055, 10350.0, 10445.477726113664, 10498.790024199474, 10597.417142057107, 10611.893881061245, 17391.304347826197, 17461.126943652765, 17537.912310438365, 17559.561010974827, 17562.29750809953, 7509.549427034395, 7709.691612335444, 7753.302202801662, 8074.152214017561, 8141.0, 4626.4910859805395, 4634.72191668501, 4718.2214934536105, 4750.334953106568, 4754.120487709784, 3230.0632816483426, 3239.627442844103, 3245.935081298408, 3264.55928449661, 3277.6066871975518, 598.2462097756771, 615.6367743031633, 618.2827919613227, 619.8853212155675, 622.9221347331584, 574.5059249045818, 680.6970897950365, 698.7484505577988, 699.9825004374932, 729.4273994914073, 8919.331050171264, 9127.224185944136, 9144.651213623667, 9178.31162662803, 9324.766880828034, 620.2438506476483, 650.2132419772129, 690.930906909305, 696.8048946295046, 740.4187712645547, 4738.715677059387, 4760.666753327303, 4812.085703716282, 4816.253480710496, 4856.732879691651, 64675.0, 65167.0, 66206.0, 66619.00071498932, 67062.0, 58430.12354814681, 58747.41252587505, 58822.70588647029, 59109.0, 59603.10595341073, 51052.0, 51376.0, 51462.48537514652, 52033.21950170751, 52365.47634523682, 9229.35394522377, 9241.676541321021, 9339.719808405758, 9342.159205671522, 9676.467794271382, 37628.81185594055, 38403.807980959915, 38569.807150964065, 38684.80657596694, 39368.40947385734, 50089.49910500849, 50499.24251136163, 50578.49421505738, 50794.492055078976, 51517.0, 10981.83527247076, 11454.370009649216, 11461.656150315504, 11516.366599836754, 11664.88335116638, 13314.0, 13372.0, 13659.590212293648, 13761.0, 13873.72252554923, 11774.175807693378, 11775.175737698279, 12130.757384852077, 12393.0, 12792.488300468249, 12623.431945562288, 12738.235705857678, 12846.743065138831, 13015.435034889333, 13067.150635208682, 11561.653150405502, 12202.877971220529, 12245.510179592717, 12369.257844529357, 12450.937745311216, 9920.20638348916, 10179.134773544332, 10482.37105773656, 10624.203184761329, 10625.9468702656, 10160.33957792741, 10384.584616615251, 10458.738531536772, 10723.571057157626, 11267.380294083903], "unit": "score", "name": "yui.html", "value": 6656.979157944141}], "name": "dromaeo_css", "value": 7183.954739966864}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 110.0, 108.0, 111.0, 121.0, 110.0, 110.0, 113.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [154.0, 133.0, 149.0, 179.0, 129.0, 156.0, 166.0, 131.0, 184.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 151.2}, {"lowerIsBetter": true, "replicates": [162.0, 166.0, 161.0, 161.0, 164.0, 163.0, 163.0, 164.0, 170.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [77.0, 74.0, 73.0, 77.0, 77.0, 73.0, 76.0, 73.0, 146.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 143.0, 92.0, 93.0, 93.0, 145.0, 93.0, 92.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 150.0, 147.0, 148.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 60.0, 65.0, 58.0, 56.0, 56.0, 60.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 61.0, 62.0, 64.0, 62.0, 63.0, 62.0, 62.0, 62.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 62.1}, {"lowerIsBetter": true, "replicates": [79.0, 79.0, 79.0, 78.0, 79.0, 86.0, 81.0, 80.0, 82.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.2}, {"lowerIsBetter": true, "replicates": [121.0, 111.0, 117.0, 131.0, 112.0, 112.0, 119.0, 123.0, 117.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.7}, {"lowerIsBetter": true, "replicates": [145.0, 135.0, 141.0, 150.0, 143.0, 142.0, 141.0, 142.0, 141.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.5}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 67.0, 63.0, 64.0, 63.0, 64.0, 62.0, 64.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.8}], "name": "kraken", "value": 1502.1}]} 19:44:06 INFO - Return code: 0 19:44:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:44:06 ERROR - # TBPL SUCCESS # 19:44:06 INFO - Running post-action listener: _resource_record_post_action 19:44:06 INFO - Running post-run listener: _resource_record_post_run 19:44:07 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8011776; Write bytes: 413483008; Read time: 2408; Write time: 510848 19:44:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 835584; Read time: 0; Write time: 76 19:44:07 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 6250496; Write bytes: 412647424; Read time: 2372; Write time: 510772 19:44:07 INFO - Running post-run listener: _upload_blobber_files 19:44:07 INFO - Blob upload gear active. 19:44:07 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:44:07 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:44:07 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:44:07 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:44:07 INFO - (blobuploader) - INFO - Open directory for files ... 19:44:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:44:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:44:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:08 INFO - (blobuploader) - INFO - Done attempting. 19:44:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:44:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:44:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:09 INFO - (blobuploader) - INFO - Done attempting. 19:44:09 INFO - (blobuploader) - INFO - Iteration through files over. 19:44:09 INFO - Return code: 0 19:44:09 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:44:09 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:44:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/733284ad8d51df8f25e7d6ef817680f7f4b64d9e02d944db0381d4efb0ee655a35e80d8c4bdd0705d82a4f8997e4ce6f0941976f5638e6cbf2c49a29f5e0f32b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3173c0829d87080a51729cce6f3b7a90b5acbbdbd5557e92d9dade280e927e84ad93204f3a786d36f729f48d5c56adf11c5d96aeb311d2e9c1d81ffa236f5e6"} 19:44:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:44:09 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:44:09 INFO - Contents: 19:44:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/733284ad8d51df8f25e7d6ef817680f7f4b64d9e02d944db0381d4efb0ee655a35e80d8c4bdd0705d82a4f8997e4ce6f0941976f5638e6cbf2c49a29f5e0f32b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3173c0829d87080a51729cce6f3b7a90b5acbbdbd5557e92d9dade280e927e84ad93204f3a786d36f729f48d5c56adf11c5d96aeb311d2e9c1d81ffa236f5e6"} 19:44:09 INFO - Running post-run listener: copy_logs_to_upload_dir 19:44:09 INFO - Copying logs to upload dir... 19:44:09 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:44:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1312.586314 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2016-04-01 19:44:09.596329) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:09.599656) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/733284ad8d51df8f25e7d6ef817680f7f4b64d9e02d944db0381d4efb0ee655a35e80d8c4bdd0705d82a4f8997e4ce6f0941976f5638e6cbf2c49a29f5e0f32b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3173c0829d87080a51729cce6f3b7a90b5acbbdbd5557e92d9dade280e927e84ad93204f3a786d36f729f48d5c56adf11c5d96aeb311d2e9c1d81ffa236f5e6"} build_url:https://queue.taskcluster.net/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/NZ8NmbBvTKa81rZCLmPOVQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/733284ad8d51df8f25e7d6ef817680f7f4b64d9e02d944db0381d4efb0ee655a35e80d8c4bdd0705d82a4f8997e4ce6f0941976f5638e6cbf2c49a29f5e0f32b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3173c0829d87080a51729cce6f3b7a90b5acbbdbd5557e92d9dade280e927e84ad93204f3a786d36f729f48d5c56adf11c5d96aeb311d2e9c1d81ffa236f5e6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:09.624145) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:09.624476) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459561026.906207-702175765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:09.708191) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 19:44:09.708515) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 19:44:09.708808) ========= ========= Total master_lag: 0.25 =========