builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1465735045.48 results: success (0) buildid: 20160612030220 builduid: bedbd0d7da9140f28d442edfb954acfa revision: 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-12 05:37:25.483863) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-12 05:37:25.484363) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-12 05:37:25.484719) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-12 05:37:25.529085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 05:37:25.529425) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-12 05:37:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-06-12 05:37:25 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117629 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 05:37:25.668559) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 05:37:25.668906) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020427 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 05:37:25.724428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 05:37:25.724819) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-12 05:37:25,992 truncating revision to first 12 chars 2016-06-12 05:37:25,992 Setting DEBUG logging. 2016-06-12 05:37:25,992 attempt 1/10 2016-06-12 05:37:25,992 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/016e0f47e8ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-12 05:37:26,436 unpacking tar archive at: mozilla-central-016e0f47e8ad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.804061 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 05:37:26.548739) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-12 05:37:26.549058) ========= script_repo_revision: 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-12 05:37:26.549526) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-12 05:37:26.549850) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-12 05:37:26.571970) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-12 05:37:26.572276) ========= /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/. (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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:37:26 INFO - MultiFileLogger online at 20160612 05:37:26 in /builds/slave/test 05:37:26 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 05:37:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:37:26 INFO - {'append_to_log': False, 05:37:26 INFO - 'base_work_dir': '/builds/slave/test', 05:37:26 INFO - 'blob_upload_branch': 'Firefox', 05:37:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:37:26 INFO - 'branch': 'Firefox', 05:37:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:37:26 INFO - 'config_files': ('talos/linux_config.py',), 05:37:26 INFO - 'default_actions': ('clobber', 05:37:26 INFO - 'read-buildbot-config', 05:37:26 INFO - 'download-and-extract', 05:37:26 INFO - 'populate-webroot', 05:37:26 INFO - 'create-virtualenv', 05:37:26 INFO - 'install', 05:37:26 INFO - 'run-tests'), 05:37:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:37:26 INFO - 'download_minidump_stackwalk': True, 05:37:26 INFO - 'download_symbols': 'ondemand', 05:37:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:37:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:37:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:37:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:37:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:37:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:37:26 INFO - 'installer_path': 'installer.exe', 05:37:26 INFO - 'log_level': 'info', 05:37:26 INFO - 'log_name': 'talos', 05:37:26 INFO - 'log_to_console': True, 05:37:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:37:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:37:26 INFO - 'opt_config_files': (), 05:37:26 INFO - 'pip_index': False, 05:37:26 INFO - 'sps_profile': False, 05:37:26 INFO - 'sps_profile_interval': 0, 05:37:26 INFO - 'suite': 'dromaeojs-e10s', 05:37:26 INFO - 'system_bits': '32', 05:37:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:37:26 INFO - 'title': 'talos-linux64-ix-025', 05:37:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:37:26 INFO - 'use_talos_json': True, 05:37:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:37:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:37:26 INFO - 'work_dir': 'build'} 05:37:26 INFO - ##### 05:37:26 INFO - ##### Running clobber step. 05:37:26 INFO - ##### 05:37:26 INFO - Running pre-action listener: _resource_record_pre_action 05:37:26 INFO - Running main action method: clobber 05:37:26 INFO - rmtree: /builds/slave/test/build 05:37:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:37:27 INFO - Running post-action listener: _resource_record_post_action 05:37:27 INFO - ##### 05:37:27 INFO - ##### Finished clobber step (success) 05:37:27 INFO - ##### 05:37:27 INFO - ##### 05:37:27 INFO - ##### Running read-buildbot-config step. 05:37:27 INFO - ##### 05:37:27 INFO - Running pre-action listener: _resource_record_pre_action 05:37:27 INFO - Running main action method: read_buildbot_config 05:37:27 INFO - Using buildbot properties: 05:37:27 INFO - { 05:37:27 INFO - "project": "", 05:37:27 INFO - "product": "firefox", 05:37:27 INFO - "script_repo_revision": "production", 05:37:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:37:27 INFO - "repository": "", 05:37:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:37:27 INFO - "buildid": "20160612030220", 05:37:27 INFO - "stage_platform": "linux64-pgo", 05:37:27 INFO - "basedir": "/builds/slave/test", 05:37:27 INFO - "nightly_build": "True", 05:37:27 INFO - "buildnumber": 246, 05:37:27 INFO - "slavename": "talos-linux64-ix-025", 05:37:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:37:27 INFO - "platform": "ubuntu64_hw", 05:37:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:37:27 INFO - "branch": "mozilla-central", 05:37:27 INFO - "repo_path": "mozilla-central", 05:37:27 INFO - "revision": "016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d", 05:37:27 INFO - "pgo_build": "True", 05:37:27 INFO - "builduid": "bedbd0d7da9140f28d442edfb954acfa", 05:37:27 INFO - "slavebuilddir": "test" 05:37:27 INFO - } 05:37:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:37:27 INFO - Running post-action listener: _resource_record_post_action 05:37:27 INFO - ##### 05:37:27 INFO - ##### Finished read-buildbot-config step (success) 05:37:27 INFO - ##### 05:37:27 INFO - ##### 05:37:27 INFO - ##### Running download-and-extract step. 05:37:27 INFO - ##### 05:37:27 INFO - Running pre-action listener: _resource_record_pre_action 05:37:27 INFO - Running main action method: download_and_extract 05:37:27 INFO - mkdir: /builds/slave/test/build/tests 05:37:27 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')]} 05:37:27 INFO - https://queue.taskcluster.net/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:37:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:37:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:37:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:37:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:37:36 INFO - Downloaded 1361 bytes. 05:37:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:37:36 INFO - Using the following test package requirements: 05:37:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:37:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:37:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:36 INFO - u'jsshell-linux-x86_64.zip'], 05:37:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:37:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:37:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:37:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:37:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:37:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:36 INFO - https://queue.taskcluster.net/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:37:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:37:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:37:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:37:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:37:38 INFO - Downloaded 24464797 bytes. 05:37:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:37:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:37:39 INFO - Return code: 0 05:37:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:39 INFO - https://queue.taskcluster.net/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:37:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:37:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:37:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:37:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:37:44 INFO - Downloaded 24464797 bytes. 05:37:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:37:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:37:45 INFO - Return code: 0 05:37:45 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')]} 05:37:45 INFO - https://queue.taskcluster.net/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:37:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:37:47 INFO - Downloaded 10833377 bytes. 05:37:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:37:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:37:47 INFO - Return code: 0 05:37: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')]} 05:37:47 INFO - https://queue.taskcluster.net/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:37:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:37:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:37:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:37:48 INFO - Downloaded 59337635 bytes. 05:37:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:37:48 INFO - mkdir: /builds/slave/test/properties 05:37:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:37:48 INFO - Writing to file /builds/slave/test/properties/build_url 05:37:48 INFO - Contents: 05:37:48 INFO - build_url:https://queue.taskcluster.net/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:37:49 INFO - Running post-action listener: _resource_record_post_action 05:37:49 INFO - Running post-action listener: set_extra_try_arguments 05:37:49 INFO - ##### 05:37:49 INFO - ##### Finished download-and-extract step (success) 05:37:49 INFO - ##### 05:37:49 INFO - ##### 05:37:49 INFO - ##### Running populate-webroot step. 05:37:49 INFO - ##### 05:37:49 INFO - Running pre-action listener: _resource_record_pre_action 05:37:49 INFO - Running main action method: populate_webroot 05:37:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:37:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:37:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:37:49 INFO - '--tppagecycles', 05:37:49 INFO - '7'], 05:37:49 INFO - 'tests': ['tsvgm']}}, 05:37:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:37:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:37:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:37:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:37:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['damp', 'tps']}, 05:37:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'tests': ['damp', 'tps']}, 05:37:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['dromaeo_dom']}, 05:37:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:37:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['a11yr', 05:37:49 INFO - 'ts_paint', 05:37:49 INFO - 'tpaint', 05:37:49 INFO - 'sessionrestore', 05:37:49 INFO - 'sessionrestore_no_auto_restore', 05:37:49 INFO - 'tabpaint']}, 05:37:49 INFO - 'other-e10s': {'tests': ['a11yr', 05:37:49 INFO - 'ts_paint', 05:37:49 INFO - 'tpaint', 05:37:49 INFO - 'sessionrestore', 05:37:49 INFO - 'sessionrestore_no_auto_restore', 05:37:49 INFO - 'tabpaint']}, 05:37:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:37:49 INFO - 'ts_paint', 05:37:49 INFO - 'tpaint', 05:37:49 INFO - 'sessionrestore', 05:37:49 INFO - 'sessionrestore_no_auto_restore', 05:37:49 INFO - 'tabpaint']}, 05:37:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:37:49 INFO - 'ts_paint', 05:37:49 INFO - 'tpaint', 05:37:49 INFO - 'sessionrestore', 05:37:49 INFO - 'sessionrestore_no_auto_restore', 05:37:49 INFO - 'tabpaint']}, 05:37:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['a11yr', 05:37:49 INFO - 'ts_paint', 05:37:49 INFO - 'tpaint', 05:37:49 INFO - 'sessionrestore', 05:37:49 INFO - 'sessionrestore_no_auto_restore', 05:37:49 INFO - 'tabpaint']}, 05:37:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['a11yr', 05:37:49 INFO - 'ts_paint', 05:37:49 INFO - 'tpaint', 05:37:49 INFO - 'sessionrestore', 05:37:49 INFO - 'sessionrestore_no_auto_restore', 05:37:49 INFO - 'tabpaint']}, 05:37:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['tsvgx', 05:37:49 INFO - 'tsvgr_opacity', 05:37:49 INFO - 'tart', 05:37:49 INFO - 'tscrollx', 05:37:49 INFO - 'cart']}, 05:37:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:37:49 INFO - 'tsvgr_opacity', 05:37:49 INFO - 'tart', 05:37:49 INFO - 'tscrollx', 05:37:49 INFO - 'cart']}, 05:37:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'talos_options': ['--disable-e10s'], 05:37:49 INFO - 'tests': ['tp5o']}, 05:37:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'tests': ['tp5o']}, 05:37:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'talos_options': ['--disable-e10s', 05:37:49 INFO - '--xperf_path', 05:37:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:49 INFO - 'tests': ['tp5n']}, 05:37:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:49 INFO - 'talos_options': ['--xperf_path', 05:37:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:49 INFO - 'tests': ['tp5n']}}, 05:37:49 INFO - 'talos.zip': {'path': '', 05:37:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:37:49 INFO - Running post-action listener: _resource_record_post_action 05:37:49 INFO - ##### 05:37:49 INFO - ##### Finished populate-webroot step (success) 05:37:49 INFO - ##### 05:37:49 INFO - ##### 05:37:49 INFO - ##### Running create-virtualenv step. 05:37:49 INFO - ##### 05:37:49 INFO - Running pre-action listener: _resource_record_pre_action 05:37:49 INFO - Running main action method: create_virtualenv 05:37:49 INFO - Creating virtualenv /builds/slave/test/build/venv 05:37:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:37:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:37:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:37:49 INFO - Using real prefix '/usr' 05:37:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:37:50 INFO - Installing distribute.............................................................................................................................................................................................done. 05:37:52 INFO - Installing pip.................done. 05:37:52 INFO - Return code: 0 05:37:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:37: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')]} 05:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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')]} 05:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f1fbd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 05:37:52 INFO - Running command: ['/builds/slave/test/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/build 05:37:52 INFO - Copy/paste: /builds/slave/test/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 05:37:52 INFO - Using env: {'DISPLAY': ':0', 05:37:52 INFO - 'HOME': '/home/cltbld', 05:37:52 INFO - 'LANG': 'en_US.UTF-8', 05:37:52 INFO - 'LANGUAGE': 'en_US:en', 05:37:52 INFO - 'LOGNAME': 'cltbld', 05:37:52 INFO - 'MAIL': '/var/mail/cltbld', 05:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:52 INFO - 'MOZ_NO_REMOTE': '1', 05:37:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:52 INFO - 'NO_EM_RESTART': '1', 05:37:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:52 INFO - 'PWD': '/builds/slave/test', 05:37:52 INFO - 'SHELL': '/bin/bash', 05:37:52 INFO - 'SHLVL': '1', 05:37:52 INFO - 'TERM': 'linux', 05:37:52 INFO - 'TMOUT': '86400', 05:37:52 INFO - 'USER': 'cltbld', 05:37:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', 05:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:52 INFO - '_': '/tools/buildbot/bin/python'} 05:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37: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 05:37:52 INFO - Cleaning up... 05:37:52 INFO - Return code: 0 05:37:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:37: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')]} 05:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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')]} 05:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1fbd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 05:37:52 INFO - Running command: ['/builds/slave/test/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>=3.1.1'] in /builds/slave/test/build 05:37:52 INFO - Copy/paste: /builds/slave/test/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>=3.1.1 05:37:52 INFO - Using env: {'DISPLAY': ':0', 05:37:52 INFO - 'HOME': '/home/cltbld', 05:37:52 INFO - 'LANG': 'en_US.UTF-8', 05:37:52 INFO - 'LANGUAGE': 'en_US:en', 05:37:52 INFO - 'LOGNAME': 'cltbld', 05:37:52 INFO - 'MAIL': '/var/mail/cltbld', 05:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:52 INFO - 'MOZ_NO_REMOTE': '1', 05:37:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:52 INFO - 'NO_EM_RESTART': '1', 05:37:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:52 INFO - 'PWD': '/builds/slave/test', 05:37:52 INFO - 'SHELL': '/bin/bash', 05:37:52 INFO - 'SHLVL': '1', 05:37:52 INFO - 'TERM': 'linux', 05:37:52 INFO - 'TMOUT': '86400', 05:37:52 INFO - 'USER': 'cltbld', 05:37:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', 05:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:52 INFO - '_': '/tools/buildbot/bin/python'} 05:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:52 INFO - Downloading/unpacking psutil>=3.1.1 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:37:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:54 INFO - Installing collected packages: psutil 05:37:54 INFO - Running setup.py install for psutil 05:37:54 INFO - building 'psutil._psutil_linux' extension 05:37: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 05:37:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:37:54 INFO - building 'psutil._psutil_posix' extension 05:37:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:37:55 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 05:37:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:55 INFO - Successfully installed psutil 05:37:55 INFO - Cleaning up... 05:37:55 INFO - Return code: 0 05:37:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:37:55 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')]} 05:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:55 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')]} 05:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1fbd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 05:37:55 INFO - Running command: ['/builds/slave/test/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.3'] in /builds/slave/test/build 05:37:55 INFO - Copy/paste: /builds/slave/test/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.3 05:37:55 INFO - Using env: {'DISPLAY': ':0', 05:37:55 INFO - 'HOME': '/home/cltbld', 05:37:55 INFO - 'LANG': 'en_US.UTF-8', 05:37:55 INFO - 'LANGUAGE': 'en_US:en', 05:37:55 INFO - 'LOGNAME': 'cltbld', 05:37:55 INFO - 'MAIL': '/var/mail/cltbld', 05:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:55 INFO - 'MOZ_NO_REMOTE': '1', 05:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:55 INFO - 'NO_EM_RESTART': '1', 05:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:55 INFO - 'PWD': '/builds/slave/test', 05:37:55 INFO - 'SHELL': '/bin/bash', 05:37:55 INFO - 'SHLVL': '1', 05:37:55 INFO - 'TERM': 'linux', 05:37:55 INFO - 'TMOUT': '86400', 05:37:55 INFO - 'USER': 'cltbld', 05:37:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', 05:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:55 INFO - '_': '/tools/buildbot/bin/python'} 05:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:37:57 INFO - Installing collected packages: mozsystemmonitor 05:37:57 INFO - Running setup.py install for mozsystemmonitor 05:37:57 INFO - Successfully installed mozsystemmonitor 05:37:57 INFO - Cleaning up... 05:37:57 INFO - Return code: 0 05:37:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1fbd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 05:37:57 INFO - Running command: ['/builds/slave/test/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==2.5.1'] in /builds/slave/test/build 05:37:57 INFO - Copy/paste: /builds/slave/test/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==2.5.1 05:37:57 INFO - Using env: {'DISPLAY': ':0', 05:37:57 INFO - 'HOME': '/home/cltbld', 05:37:57 INFO - 'LANG': 'en_US.UTF-8', 05:37:57 INFO - 'LANGUAGE': 'en_US:en', 05:37:57 INFO - 'LOGNAME': 'cltbld', 05:37:57 INFO - 'MAIL': '/var/mail/cltbld', 05:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:57 INFO - 'MOZ_NO_REMOTE': '1', 05:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:57 INFO - 'NO_EM_RESTART': '1', 05:37:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:57 INFO - 'PWD': '/builds/slave/test', 05:37:57 INFO - 'SHELL': '/bin/bash', 05:37:57 INFO - 'SHLVL': '1', 05:37:57 INFO - 'TERM': 'linux', 05:37:57 INFO - 'TMOUT': '86400', 05:37:57 INFO - 'USER': 'cltbld', 05:37:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', 05:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:57 INFO - '_': '/tools/buildbot/bin/python'} 05:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:57 INFO - Downloading/unpacking jsonschema==2.5.1 05:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:37:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:59 INFO - Downloading functools32-3.2.3-2.tar.gz 05:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:37:59 INFO - warning: no files found matching '*.txt' 05:37:59 INFO - no previously-included directories found matching 'build' 05:37:59 INFO - no previously-included directories found matching 'dist' 05:37:59 INFO - no previously-included directories found matching '.git*' 05:37:59 INFO - Installing collected packages: jsonschema, functools32 05:37:59 INFO - Running setup.py install for functools32 05:37:59 INFO - warning: no files found matching '*.txt' 05:38:00 INFO - no previously-included directories found matching 'build' 05:38:00 INFO - no previously-included directories found matching 'dist' 05:38:00 INFO - no previously-included directories found matching '.git*' 05:38:00 INFO - Successfully installed jsonschema functools32 05:38:00 INFO - Cleaning up... 05:38:00 INFO - Return code: 0 05:38:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f1fbd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 05:38:00 INFO - Running command: ['/builds/slave/test/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/build 05:38:00 INFO - Copy/paste: /builds/slave/test/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 05:38:00 INFO - Using env: {'DISPLAY': ':0', 05:38:00 INFO - 'HOME': '/home/cltbld', 05:38:00 INFO - 'LANG': 'en_US.UTF-8', 05:38:00 INFO - 'LANGUAGE': 'en_US:en', 05:38:00 INFO - 'LOGNAME': 'cltbld', 05:38:00 INFO - 'MAIL': '/var/mail/cltbld', 05:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:00 INFO - 'MOZ_NO_REMOTE': '1', 05:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:00 INFO - 'NO_EM_RESTART': '1', 05:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:00 INFO - 'PWD': '/builds/slave/test', 05:38:00 INFO - 'SHELL': '/bin/bash', 05:38:00 INFO - 'SHLVL': '1', 05:38:00 INFO - 'TERM': 'linux', 05:38:00 INFO - 'TMOUT': '86400', 05:38:00 INFO - 'USER': 'cltbld', 05:38:00 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', 05:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:00 INFO - '_': '/tools/buildbot/bin/python'} 05:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:00 INFO - Downloading/unpacking blobuploader==1.2.4 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:38:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:38:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 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 05:38:02 INFO - Downloading docopt-0.6.1.tar.gz 05:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:38:02 INFO - Installing collected packages: blobuploader, requests, docopt 05:38:02 INFO - Running setup.py install for blobuploader 05:38:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:38:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:38:03 INFO - Running setup.py install for requests 05:38:03 INFO - Running setup.py install for docopt 05:38:03 INFO - Successfully installed blobuploader requests docopt 05:38:03 INFO - Cleaning up... 05:38:03 INFO - Return code: 0 05:38:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f1fbd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 05:38:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 05:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/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 05:38:03 INFO - Using env: {'DISPLAY': ':0', 05:38:03 INFO - 'HOME': '/home/cltbld', 05:38:03 INFO - 'LANG': 'en_US.UTF-8', 05:38:03 INFO - 'LANGUAGE': 'en_US:en', 05:38:03 INFO - 'LOGNAME': 'cltbld', 05:38:03 INFO - 'MAIL': '/var/mail/cltbld', 05:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:03 INFO - 'MOZ_NO_REMOTE': '1', 05:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:03 INFO - 'NO_EM_RESTART': '1', 05:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:03 INFO - 'PWD': '/builds/slave/test', 05:38:03 INFO - 'SHELL': '/bin/bash', 05:38:03 INFO - 'SHLVL': '1', 05:38:03 INFO - 'TERM': 'linux', 05:38:03 INFO - 'TMOUT': '86400', 05:38:03 INFO - 'USER': 'cltbld', 05:38:03 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', 05:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:03 INFO - '_': '/tools/buildbot/bin/python'} 05:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:03 INFO - Running setup.py (path:/tmp/pip-qRz2xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:03 INFO - Running setup.py (path:/tmp/pip-tOyuTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:03 INFO - Running setup.py (path:/tmp/pip-G6J5Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:04 INFO - Running setup.py (path:/tmp/pip-rdePC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:04 INFO - Running setup.py (path:/tmp/pip-_jgtns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:04 INFO - Running setup.py (path:/tmp/pip-zJoo30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:04 INFO - Running setup.py (path:/tmp/pip-Jv7CAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:04 INFO - Running setup.py (path:/tmp/pip-RuinSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:04 INFO - Running setup.py (path:/tmp/pip-2Ykrfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:04 INFO - Running setup.py (path:/tmp/pip-xNsEQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:04 INFO - Running setup.py (path:/tmp/pip-KwuZ1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:04 INFO - Running setup.py (path:/tmp/pip-cm3hjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:04 INFO - Running setup.py (path:/tmp/pip-taKSra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:04 INFO - Running setup.py (path:/tmp/pip-hb0fpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:04 INFO - Running setup.py (path:/tmp/pip-4b7CR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:04 INFO - Running setup.py (path:/tmp/pip-eGhfnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:04 INFO - Running setup.py (path:/tmp/pip-bEYp_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:38:04 INFO - Running setup.py install for manifestparser 05:38:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:38:05 INFO - Running setup.py install for mozcrash 05:38:05 INFO - Running setup.py install for mozdebug 05:38:05 INFO - Running setup.py install for mozdevice 05:38:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:38:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:38:05 INFO - Running setup.py install for mozfile 05:38:05 INFO - Running setup.py install for mozhttpd 05:38:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:38:05 INFO - Running setup.py install for mozinfo 05:38:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:38:05 INFO - Running setup.py install for mozInstall 05:38:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:38:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:38:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:38:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:38:05 INFO - Running setup.py install for mozleak 05:38:05 INFO - Running setup.py install for mozlog 05:38:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:38:06 INFO - Running setup.py install for moznetwork 05:38:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:38:06 INFO - Running setup.py install for mozprocess 05:38:06 INFO - Running setup.py install for mozprofile 05:38:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:38:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:38:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:38:06 INFO - Running setup.py install for mozrunner 05:38:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:38:06 INFO - Running setup.py install for mozscreenshot 05:38:06 INFO - Running setup.py install for moztest 05:38:06 INFO - Running setup.py install for mozversion 05:38:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:38:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:38:06 INFO - Cleaning up... 05:38:06 INFO - Return code: 0 05:38:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f1fbd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 05:38:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 05:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 05:38:06 INFO - Using env: {'DISPLAY': ':0', 05:38:06 INFO - 'HOME': '/home/cltbld', 05:38:06 INFO - 'LANG': 'en_US.UTF-8', 05:38:06 INFO - 'LANGUAGE': 'en_US:en', 05:38:06 INFO - 'LOGNAME': 'cltbld', 05:38:06 INFO - 'MAIL': '/var/mail/cltbld', 05:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:06 INFO - 'MOZ_NO_REMOTE': '1', 05:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:06 INFO - 'NO_EM_RESTART': '1', 05:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:06 INFO - 'PWD': '/builds/slave/test', 05:38:06 INFO - 'SHELL': '/bin/bash', 05:38:06 INFO - 'SHLVL': '1', 05:38:06 INFO - 'TERM': 'linux', 05:38:06 INFO - 'TMOUT': '86400', 05:38:06 INFO - 'USER': 'cltbld', 05:38:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', 05:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:06 INFO - '_': '/tools/buildbot/bin/python'} 05:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:07 INFO - Running setup.py (path:/tmp/pip-47CKNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:07 INFO - Running setup.py (path:/tmp/pip-6p4NvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:07 INFO - Running setup.py (path:/tmp/pip-iHoTto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:07 INFO - Running setup.py (path:/tmp/pip-CUZxJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:07 INFO - Running setup.py (path:/tmp/pip-ciE8pL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:07 INFO - Running setup.py (path:/tmp/pip-R9Q1ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:07 INFO - Running setup.py (path:/tmp/pip-Y534Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:07 INFO - Running setup.py (path:/tmp/pip-Yr5xbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:07 INFO - Running setup.py (path:/tmp/pip-cpfcF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:07 INFO - Running setup.py (path:/tmp/pip-CnpY2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:07 INFO - Running setup.py (path:/tmp/pip-m_dVCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:07 INFO - Running setup.py (path:/tmp/pip-ahcjpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:07 INFO - Running setup.py (path:/tmp/pip-h46FZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:08 INFO - Running setup.py (path:/tmp/pip-S0LfbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:08 INFO - Running setup.py (path:/tmp/pip-uCkP7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:08 INFO - Running setup.py (path:/tmp/pip-dkCUkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:08 INFO - Running setup.py (path:/tmp/pip-3VT9tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:38:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:10 INFO - Downloading blessings-1.6.tar.gz 05:38:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:38:10 INFO - Installing collected packages: blessings 05:38:10 INFO - Running setup.py install for blessings 05:38:10 INFO - Successfully installed blessings 05:38:10 INFO - Cleaning up... 05:38:10 INFO - Return code: 0 05:38:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:38:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:10 INFO - Reading from file tmpfile_stdout 05:38:10 INFO - Current package versions: 05:38:10 INFO - argparse == 1.2.1 05:38:10 INFO - blessings == 1.6 05:38:10 INFO - blobuploader == 1.2.4 05:38:10 INFO - docopt == 0.6.1 05:38:10 INFO - functools32 == 3.2.3-2 05:38:10 INFO - jsonschema == 2.5.1 05:38:10 INFO - manifestparser == 1.1 05:38:10 INFO - mozInstall == 1.12 05:38:10 INFO - mozcrash == 0.17 05:38:10 INFO - mozdebug == 0.1 05:38:10 INFO - mozdevice == 0.48 05:38:10 INFO - mozfile == 1.2 05:38:10 INFO - mozhttpd == 0.7 05:38:10 INFO - mozinfo == 0.9 05:38:10 INFO - mozleak == 0.1 05:38:10 INFO - mozlog == 3.2 05:38:10 INFO - moznetwork == 0.27 05:38:10 INFO - mozprocess == 0.22 05:38:10 INFO - mozprofile == 0.28 05:38:10 INFO - mozrunner == 6.11 05:38:10 INFO - mozscreenshot == 0.1 05:38:10 INFO - mozsystemmonitor == 0.3 05:38:10 INFO - moztest == 0.7 05:38:10 INFO - mozversion == 1.4 05:38:10 INFO - psutil == 3.1.1 05:38:10 INFO - requests == 1.2.3 05:38:10 INFO - wsgiref == 0.1.2 05:38:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f1fbd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 05:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 05:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 05:38:10 INFO - Using env: {'DISPLAY': ':0', 05:38:10 INFO - 'HOME': '/home/cltbld', 05:38:10 INFO - 'LANG': 'en_US.UTF-8', 05:38:10 INFO - 'LANGUAGE': 'en_US:en', 05:38:10 INFO - 'LOGNAME': 'cltbld', 05:38:10 INFO - 'MAIL': '/var/mail/cltbld', 05:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:10 INFO - 'MOZ_NO_REMOTE': '1', 05:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:10 INFO - 'NO_EM_RESTART': '1', 05:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:10 INFO - 'PWD': '/builds/slave/test', 05:38:10 INFO - 'SHELL': '/bin/bash', 05:38:10 INFO - 'SHLVL': '1', 05:38:10 INFO - 'TERM': 'linux', 05:38:10 INFO - 'TMOUT': '86400', 05:38:10 INFO - 'USER': 'cltbld', 05:38:10 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', 05:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:10 INFO - '_': '/tools/buildbot/bin/python'} 05:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:38:10 INFO - Cleaning up... 05:38:10 INFO - Return code: 0 05:38:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f1fbd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 05:38:10 INFO - Running command: ['/builds/slave/test/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/build 05:38:10 INFO - Copy/paste: /builds/slave/test/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 05:38:10 INFO - Using env: {'DISPLAY': ':0', 05:38:10 INFO - 'HOME': '/home/cltbld', 05:38:10 INFO - 'LANG': 'en_US.UTF-8', 05:38:10 INFO - 'LANGUAGE': 'en_US:en', 05:38:10 INFO - 'LOGNAME': 'cltbld', 05:38:10 INFO - 'MAIL': '/var/mail/cltbld', 05:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:10 INFO - 'MOZ_NO_REMOTE': '1', 05:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:10 INFO - 'NO_EM_RESTART': '1', 05:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:10 INFO - 'PWD': '/builds/slave/test', 05:38:10 INFO - 'SHELL': '/bin/bash', 05:38:10 INFO - 'SHLVL': '1', 05:38:10 INFO - 'TERM': 'linux', 05:38:10 INFO - 'TMOUT': '86400', 05:38:10 INFO - 'USER': 'cltbld', 05:38:10 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', 05:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:10 INFO - '_': '/tools/buildbot/bin/python'} 05:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:38:11 INFO - Cleaning up... 05:38:11 INFO - Return code: 0 05:38:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:38:11 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')]} 05:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:11 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')]} 05:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f1fbd37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd74350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 05:38:11 INFO - Running command: ['/builds/slave/test/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/build 05:38:11 INFO - Copy/paste: /builds/slave/test/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 05:38:11 INFO - Using env: {'DISPLAY': ':0', 05:38:11 INFO - 'HOME': '/home/cltbld', 05:38:11 INFO - 'LANG': 'en_US.UTF-8', 05:38:11 INFO - 'LANGUAGE': 'en_US:en', 05:38:11 INFO - 'LOGNAME': 'cltbld', 05:38:11 INFO - 'MAIL': '/var/mail/cltbld', 05:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:11 INFO - 'MOZ_NO_REMOTE': '1', 05:38:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:11 INFO - 'NO_EM_RESTART': '1', 05:38:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:11 INFO - 'PWD': '/builds/slave/test', 05:38:11 INFO - 'SHELL': '/bin/bash', 05:38:11 INFO - 'SHLVL': '1', 05:38:11 INFO - 'TERM': 'linux', 05:38:11 INFO - 'TMOUT': '86400', 05:38:11 INFO - 'USER': 'cltbld', 05:38:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', 05:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:11 INFO - '_': '/tools/buildbot/bin/python'} 05:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:11 INFO - Downloading/unpacking flake8 05:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:38:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:38:13 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 05:38:13 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 05:38:13 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 05:38:13 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 05:38:13 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 05:38:13 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 05:38:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:38:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:38:13 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 05:38:13 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 05:38:13 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 05:38:13 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 05:38:13 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 05:38:13 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 05:38:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:38:13 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 05:38:13 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 05:38:13 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 05:38:13 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 05:38:13 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 05:38:13 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 05:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:38:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:38:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:38:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:38:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:38:13 INFO - no previously-included directories found matching 'docs/_build' 05:38:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:38:13 INFO - Running setup.py install for pep8 05:38:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:38:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:38:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:38:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:38:14 INFO - no previously-included directories found matching 'docs/_build' 05:38:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:38:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:38:14 INFO - Cleaning up... 05:38:14 INFO - Return code: 0 05:38:14 INFO - Running post-action listener: _resource_record_post_action 05:38:14 INFO - Running post-action listener: _start_resource_monitoring 05:38:14 INFO - Starting resource monitoring. 05:38:14 INFO - ##### 05:38:14 INFO - ##### Finished create-virtualenv step (success) 05:38:14 INFO - ##### 05:38:14 INFO - ##### 05:38:14 INFO - ##### Running install step. 05:38:14 INFO - ##### 05:38:14 INFO - Running pre-action listener: _resource_record_pre_action 05:38:14 INFO - Running main action method: install 05:38:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:14 INFO - Reading from file tmpfile_stdout 05:38:14 INFO - Detecting whether we're running mozinstall >=1.0... 05:38:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:38:14 INFO - Reading from file tmpfile_stdout 05:38:14 INFO - Output received: 05:38:14 INFO - Usage: mozinstall [options] installer 05:38:14 INFO - Options: 05:38:14 INFO - -h, --help show this help message and exit 05:38:14 INFO - -d DEST, --destination=DEST 05:38:14 INFO - Directory to install application into. [default: 05:38:14 INFO - "/builds/slave/test"] 05:38:14 INFO - --app=APP Application being installed. [default: firefox] 05:38:14 INFO - mkdir: /builds/slave/test/build/application 05:38:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:38:31 INFO - Reading from file tmpfile_stdout 05:38:31 INFO - Output received: 05:38:31 INFO - /builds/slave/test/build/application/firefox/firefox 05:38:31 INFO - Running post-action listener: _resource_record_post_action 05:38:31 INFO - ##### 05:38:31 INFO - ##### Finished install step (success) 05:38:31 INFO - ##### 05:38:31 INFO - ##### 05:38:31 INFO - ##### Running run-tests step. 05:38:31 INFO - ##### 05:38:31 INFO - Running pre-action listener: _resource_record_pre_action 05:38:31 INFO - Running main action method: run_tests 05:38:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:38:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:38:31 INFO - Python 2.7.3 05:38:31 INFO - Return code: 0 05:38:31 INFO - grabbing minidump binary from tooltool 05:38:31 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')]} 05:38:31 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/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe031c0>, '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 0xe040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:38:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:38:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:38:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:38:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:38:31 INFO - Return code: 0 05:38:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:38:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:38:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:38:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:38:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:38:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:38:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:38:32 INFO - Return code: 0 05:38:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:38:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:38:32 INFO - Using env: {'DISPLAY': ':0', 05:38:32 INFO - 'HOME': '/home/cltbld', 05:38:32 INFO - 'LANG': 'en_US.UTF-8', 05:38:32 INFO - 'LANGUAGE': 'en_US:en', 05:38:32 INFO - 'LOGNAME': 'cltbld', 05:38:32 INFO - 'MAIL': '/var/mail/cltbld', 05:38:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:38:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:32 INFO - 'MOZ_NO_REMOTE': '1', 05:38:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:38:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:32 INFO - 'NO_EM_RESTART': '1', 05:38:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:32 INFO - 'PWD': '/builds/slave/test', 05:38:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:38:32 INFO - 'SHELL': '/bin/bash', 05:38:32 INFO - 'SHLVL': '1', 05:38:32 INFO - 'TERM': 'linux', 05:38:32 INFO - 'TMOUT': '86400', 05:38:32 INFO - 'USER': 'cltbld', 05:38:32 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362', 05:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:32 INFO - '_': '/tools/buildbot/bin/python'} 05:38:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:38:32 INFO - mozversion application_buildid: 20160612030220 05:38:32 INFO - mozversion application_changeset: 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d 05:38:32 INFO - mozversion application_display_name: Nightly 05:38:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:38:32 INFO - mozversion application_name: Firefox 05:38:32 INFO - mozversion application_remotingname: firefox 05:38:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:38:32 INFO - mozversion application_vendor: Mozilla 05:38:32 INFO - mozversion application_version: 50.0a1 05:38:32 INFO - mozversion platform_buildid: 20160612030220 05:38:32 INFO - mozversion platform_changeset: 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d 05:38:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:38:32 INFO - mozversion platform_version: 50.0a1 05:38:32 INFO - using testdate: 1465735112 05:38:32 INFO - actual date: 1465735112 05:38:32 INFO - starting webserver on 'localhost:57809' 05:38:32 INFO - SUITE-START | Running 2 tests 05:38:32 INFO - TEST-START | dromaeo_css 05:38:32 INFO - operating with platform_type : linux_ 05:38:32 INFO - Initialising browser for dromaeo_css test... 05:38:32 INFO - TEST-INFO | started process 15483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6pG95T/profile http://localhost:57809/getInfo.html) 05:38:37 INFO - PROCESS | 15483 | __metrics Screen width/height:1600/1200 05:38:37 INFO - PROCESS | 15483 | colorDepth:24 05:38:37 INFO - PROCESS | 15483 | Browser inner width/height: 1024/697 05:38:37 INFO - PROCESS | 15483 | __metrics 05:38:38 ERROR - PROCESS | 15483 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:38:38 INFO - TEST-INFO | 15483: exit 0 05:38:38 INFO - Browser initialized. 05:38:38 INFO - Running cycle 1/1 for dromaeo_css test... 05:38:38 INFO - TEST-INFO | started process 15601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6pG95T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:50 INFO - PROCESS | 15601 | RSS: Main: 184913920 05:38:50 INFO - PROCESS | 15601 | 05:39:40 INFO - PROCESS | 15601 | 1465735180484 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] 05:41:48 INFO - PROCESS | 15601 | Cycle 1(1): loaded http://localhost:57809/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57809/tests/dromaeo/cssquery-ext.html) 05:41:49 INFO - PROCESS | 15601 | RSS: Main: 189407232 05:41:49 INFO - PROCESS | 15601 | 05:44:51 INFO - PROCESS | 15601 | Cycle 1(1): loaded http://localhost:57809/tests/dromaeo/cssquery-ext.html (next: http://localhost:57809/tests/dromaeo/cssquery-jquery.html) 05:44:52 INFO - PROCESS | 15601 | RSS: Main: 188022784 05:44:52 INFO - PROCESS | 15601 | 05:47:54 INFO - PROCESS | 15601 | Cycle 1(1): loaded http://localhost:57809/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57809/tests/dromaeo/cssquery-mootools.html) 05:47:54 INFO - PROCESS | 15601 | RSS: Main: 188993536 05:47:54 INFO - PROCESS | 15601 | 05:50:56 INFO - PROCESS | 15601 | Cycle 1(1): loaded http://localhost:57809/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57809/tests/dromaeo/cssquery-prototype.html) 05:50:57 INFO - PROCESS | 15601 | RSS: Main: 186634240 05:50:57 INFO - PROCESS | 15601 | 05:53:59 INFO - PROCESS | 15601 | Cycle 1(1): loaded http://localhost:57809/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57809/tests/dromaeo/cssquery-yui.html) 05:54:00 INFO - PROCESS | 15601 | RSS: Main: 188772352 05:54:00 INFO - PROCESS | 15601 | 05:57:02 INFO - PROCESS | 15601 | Cycle 1(1): loaded http://localhost:57809/tests/dromaeo/cssquery-yui.html (next: http://localhost:57809/tests/dromaeo/cssquery-dojo.html) 05:57:03 INFO - PROCESS | 15601 | RSS: Main: 189562880 05:57:03 INFO - PROCESS | 15601 | 05:57:03 INFO - PROCESS | 15601 | __start_tp_report 05:57:03 INFO - PROCESS | 15601 | _x_x_mozilla_page_load 05:57:03 INFO - PROCESS | 15601 | _x_x_mozilla_page_load_details 05:57:03 INFO - PROCESS | 15601 | |i|pagename|runs| 05:57:03 INFO - PROCESS | 15601 | |0;dojo.html;3132.6084239470065;3149.0395429394025;3173.6350319713233;3177;3202.3115030268486;5473.890522189558;5478.068728316186;5481.643693159946;5517.117261238202;5527.419620939803;5422.2951016367815;5431.266778984836;5469.206964990074;5501.669899806005;5530.115181570949;4900.338454308676;4949.034938187055;5037.168867136918;5088.363954505687;5132.024915266087;781.9432360719741;5056.696598204119;5076.390833100015;5108.208227724708;5122.308488354061;4950.084234416644;4975.3283306753665;4999;5010.949890501103;5033.245013248005;4941.530554597343;4985.850424487271;4991.475895031006;5009.9479109387075;5040.16837221858;4920.581750551208;4929.038837426703;4947.653664243504;4958.057968985881;4976.353074100344;5464.836054918359;5523.28197334348;5538.667679939176;5578.191162281447;5664.603477756558;5785.363610002938;5842.269716285465;5926.940730592682;5953.226080609536;5977.491913187341;5814.5057670098095;5902.055671092648;5926.614770039933;5953.2856057272975;5993.61041532299;5499.752511137009;5502.284702988626;5509.090999985037;5513.972430137864;5555.666660000413;5821.446962538552;6000.879982400327;6004.129401236796;6007.879842403127;6018.247719035121;5800.303963524319;5842.649441033552;5849.298084229835;5851.239338885917;5862.355140934494;5902.881942361215;5934.495567876693;5938.495227905676;5957.314908785545;5958.493528050078;5761.222234998221;5772.249607550992;5806.680632565165;5843.2403787507355;5874.676892770939;5783.1325301204315;5790.94209057904;5811.27359080115;5866.6480011199465;5874.0601503760045;4532.864014079583;4535.9546404536195;4542.909141817211;4557.202489564379;4585.6102231310715;3980.960190398117;3995.5005624296964;4012.27778999777;4012.8996775080273;4049.838006479708;5587.05020146576;5590.664560126405;5631.239782629293;5655.434456554394;5667.518260947783;5873.2658417697785;5938.228030356113;5944.7027648617395;5950.642961422329;5952.7321270542925;5554.444555544494;5602.635828671123;5628.437156284421;5654.519365853948;5659.094544872883;5101.51535604117;5118.181091025418;5142.408623008327;5145.073886700355;5156.587473002151;5951.7619295227705;6136.539759518054;6143.1706719592285;6152.261728592508;6153.29237137726;5906.911396328973;5964.105384192232;5979.910301345571;5997.16039754426;6000.249968753906;6158.722857471335;6167.321594624498;6170.876582468415;6187.288461826947;6191.102290167991;5735.627184233012;5800.50695690871;5874.471297583238;5885.529157667291;5894.263217097863;5906.645601263938;5949.286085669574;5966.970165149321;5977.402259773988;6028.306744724413;5722.685252311163;5724.370319264961;5733.627314224562;5783.103618939072;5797.623154494944;5629.634073785191;5702.287214098238;5739.053056245672;5775.624584402;5778.855528611818;5516.972415137899;5607.467290607386;5609.018421776254;5652.576056795839;5789.363170051375;5756.510696590837;5797.362290147996;5807.593468457337;5807.738651760596;5813.970930145322;5564.109742441352;5667.518260947865;5682.9431705684065;5686.857828554319;5701.087825947829 05:57:03 INFO - PROCESS | 15601 | |1;ext.html;568.1250873654573;628.6950828848009;639.3893831391022;645.2676212498812;663.432764985937;44448.33327500086;46147;46642.30036549454;46651;49675.75162124184;46724.29913551299;46824.29763553549;47034.29448558266;47077.058458830805;47292.29061564079;9026.187643112118;9182.494962777044;9231.492267925261;9232.630694772235;9260.212881905047;9046.140616641409;9058.592363343632;9121.087891210893;9147.22248608869;9157.816843663122;9148.313876459259;9202.907970920272;9228.446293222394;9236.67671631493;9237.261019118454;9115.042920493319;9128.863067053966;9149.771255718593;9154.49650269235;9162.496062716547;9102.226310763594;9165;9191.40255883372;9227.307951903567;9238.214751746042;44734.10531789379;45106.32340514895;45264.773676131736;45302.77348613269;45378.77310613426;3568.660977207187;3597.568291804974;3688.2992231475932;3718.200586873835;3726.9068273293115;33866.32267354664;33955;34055.489167662505;34643.30713385744;35146.824265878764;4379.474463064453;4381.38660587518;4387.451568553931;4404.537523560012;4484.573965473275;366786;366845.1657741721;366934;368777;369185.9999999973;34647.82676086654;35360;62177;62994;63329.366706332345;38686;38828.6117138825;38925.805370972965;38950.415743763864;39079;16102.677946441005;16314.102724350038;16334.346626135059;16389.508314750576;16528.83471165297;13545.458181672622;13575.185488870698;13578.864211357957;13637.386317615532;13694.452221911011;8962.462252264884;8963.50700711454;9010.504422256708;9091.681791137278;9136.634534618674;3355.8657653694067;3468.497067925137;3497.2306092659574;3514.8594056237976;3541.1678255609913;1001.702695436569;1032.896710328976;1058.878229003659;1086.6522712732008;1104.3705088099866;34155.487667685;34195.316093678484;34392.82803586016;34412.65587344095;34449.483257751155;1088.515610553312;1112.7385064509833;1137.6416428824894;1169.649105268433;1193.5106606291379;17741;17985.7302140468;18009;18032.549186270448;18076.18657160431;555474;563608;564113;564374;566086;61322;62369.37630623636;62380.376196237456;62407.68796156081;62790.37209627937;1359.2456186816214;1377.6555861034742;1378.8552202018643;1384.3147641917315;1390.2909516146838;32128.678713213503;33552.49671254982;33900;33998.49002265018;34040.82979585185;54488.18267725908;54763.45236547584;54785.17822232749;54909;55036.44963550474;433710;439268;439485;440968;440969;29901;30071.248218794706;30141.246468838453;30593.54109688312;30640;50734.23898641449;51009.489905100476;51645.74177129241;51717.48282517127;51854;40327.798361008005;41856.37215441831;43606.909827254574;44651;45097.77451112724;42290.154196916505;42889.142217156106;42942.57057429386;43310.13379732451;43488.34767478427;39023;43440;43623.12753744844;44086.55913440824;44475.77762111169;36375.272494549434;37680.43479347757;38394.42408363933;39363.60636393714;39930.60069399385;29831.850840745657;30106.698933011266;30178.69821301759;30261.243468913453;30406.23984400319 05:57:03 INFO - PROCESS | 15601 | |2;jquery.html;397.57260944484676;409.1040621039924;411.36444193720706;413.742223640134;418.12611641668906;14017.859821401782;17982;18906.338278160267;19459.124339404727;19727.210911563558;18922.14850331735;19032.2387104516;19254.22983080675;19970.50073748157;19975.200991960304;5658.971705141479;5734.225879506276;5811.593188476808;5865.8240252792275;5891.116332550109;5647.689377084259;5733.971330143343;5746.224259724946;6852.314768523132;7234.095738032746;7162.892556611655;7335.9266407336045;7339.119305683299;7342.4860259781835;7394.334509894108;7176.246494118094;7250.70997160113;7327;7353.338199562038;7394.630268486554;6392;6827.385535301847;6879.140107486564;7006.194287656934;7096.396806271473;24832.627510587357;24935.251942441755;25685.486290274275;26393.604095938575;26659;2538.8476691398573;2759.6412466379443;2801.5097357962277;2977.732004119618;3041.726244637993;14835.554933352018;14915.925420372938;14976.700465990729;16075.196240187945;16850.662986740197;2003.5792483578466;2077.0757013129164;2127.95744085119;2156.4501052231735;2182.1162429216192;97937;100212.4989375063;104031;105000.4749976253;105320.4733976333;16998.91500542514;17103.315867365414;17445.65108697819;17803.287868485117;17897.28410863577;31306.21734456657;31337.216569585944;31591;31766.523502147487;31967.52048719271;9750.512474376254;10055.69832905014;10106.69503912816;10427;10433.843492347622;8703.782405439915;8740.300775937909;8898.688545900863;8968.955155224183;8986.820263594822;8749.650013999497;8790.824183516293;8914.331425143011;9019.32355073359;9184.448933064037;3388.5594872666397;3497.2480916603054;3527.6472352764517;3585.820708964541;3651.7808931464197;887.8490656588395;958.3626888119322;971.2084651009404;1029.6550655530332;1051.033049594375;19425.902870485555;19636.607267854564;19728.210871564977;19754.40736777899;20046.89976550108;925.5418567808978;993.6919554937992;1028.1723212813608;1062.1980404794485;1101.0746688057052;10500.737481563023;11084;11183.83224251637;11210.607628732956;11249.437528123724;468654;470265;472731;491607;493689.441739082;92599.53700231455;93936;93982.53008734912;95390.52304738571;97259;998.2114129837493;1010.7877345757473;1016.0753714120116;1036.76154484469;1040.77623310987;17335.56661083483;17544.473665790047;17569.297228110732;17605.471835844946;17706.114694265492;40706.796466017484;41158.794206029976;41259.587404126774;41497.585024149375;42402;56136.43863561475;58561.4143858573;59044.40955590389;59207.70396148164;59588;7241.963790181016;7659.540427574363;8126.187381261827;8619.956900215459;8732.56337183151;12741.235525868478;13246.337683115613;13441.865581344062;13654.658633534242;13719.382627781973;11526.308421494738;11750.70623234426;11917.284962902253;12002.39988000614;12192.634220973385;10345.120664743281;11772.17594768358;11943.761124777282;11980;12029.4586743595;11222.719432014264;11302.660920172408;11711.414429278673;12465.439055242718;12511.687207819878;7834.882476762967;7978.4016198786485;8015.278624923785;8132.308753755997;8421.536815475207;11403.657890263305;12081.758364832478;12152.21010634306;12201.20692155007;12430.875691242973 05:57:03 INFO - PROCESS | 15601 | |3;mootools.html;1432.026222168925;1467.0317590390343;1533.2180587900175;1682.949511514655;1707.462149422931;7779.961100194505;8410.621522031508;8445.408821382505;8994.68518601849;9034.232090272326;8446.662133514668;8518.446300990432;8617.353698472609;8642.481451112937;8690.869636955451;2265.1958554713046;2281.931542053741;2303.9078436862505;2306.215886598556;2306.642470417088;2155.245664017597;2161.8162456191244;2215.6898034275214;2245.4835387860803;2247.5280191159877;2156.9784302157013;2165.675148727688;2169.620316444616;2178.7930146636045;2200.7799220078023;2191.835612329082;2207.6578130389735;2208.4258092895802;2232.977670223301;2247.2808701215617;2304.216566367443;2318.5826551220775;2330.1378489958656;2332.731735850382;2334.5447637710654;8751.43115697484;8779.297656187553;8815.426997245158;8834.160754728291;8846.469211847245;5246.501582349671;5316.707581083039;5374.946250537484;5377.354717433894;5378.46215378463;3232.6767323267723;3398.422268214385;3460.9826950865336;3466.168119651291;3470.4967779671806;1161.8431511745891;1170.9355985420798;1181.7163880668663;1191.4817054581285;1214.0348423003734;12103.45534450943;12126.69683257908;12139.514419423213;12140.392980351035;12155.817662735066;4657.4876763555985;4704.247320428715;4710.528947105262;4770.594499467584;4788.640851936118;10090.293679442368;10193.847092293621;10198.388096714221;10283.12593429567;10306.742331441774;5388.838334849961;5403.594730395157;5410.215518749838;5414.702191379433;5423.701696406657;4349.325854492558;4699.224627936421;4837;4977.1538838397555;4985.252212168131;3977.6817854571564;3999.24014437256;4074.3684728867074;4110.260153172458;4115.32097203964;1276.1067252922992;1296.8054791781308;1318.4726109556063;1318.4792007157312;1319.845135506432;814.2793627639581;917.2661870503571;921.6083164654995;936.7470782888582;959.0888655777039;6010.849728756729;6156.415140561639;6170.660613666201;6257.2804127525915;6352.491800656029;936.3024546712743;970.9563069661882;982.597135174575;1003.7641154328727;1005.085372311208;4144.33690609501;4333.306670932636;4372.825086996484;4382.824687012548;4432.778361081933;10658.253922225369;10944.507497162647;10974;10985.505652245669;11040.668779936615;10628.46857657114;10923.83614245771;10930.56277748881;10939.726506837393;10948.945255273673;8148.144444833444;8231.300339471212;8322.45904016237;8338.291245244101;8423.663053477792;6004.669743164168;6026.879462410815;6092.543059270483;6199.628022318675;6250.749970001149;9644.807103858024;10087.546060427445;10092.646757363751;10169;10177.236707246839;10130.29087963865;10148.441835699108;10188.643397481053;10202.591896324064;10214.744631384276;6995.930040699528;7468.701251950079;7678.846423071619;7707;7861.2531809478005;8269.710560130367;8290.170982901662;8299.419040667337;8301.29438997692;8414.6213420395;7281.927180728125;7510.173880873209;7512;7542.843529919913;7596.8480630388185;7397.741079062207;7409.184989651027;7472.402207823252;7520.285572870568;7545.396368290414;7022.789316320519;7039.19049309336;7125.786226413215;7139.178994415709;7163.820904477429;5074.086664400444;5184.688918664892;5256.237845512455;5314.734263286898;5333.226682131147;5353.2773075634295;5358.169483730028;5378.515933565841;5392.110301800159;5411.674139835608 05:57:03 INFO - PROCESS | 15601 | |4;prototype.html;332.6560694793036;334.4431521516674;334.57676039809644;335.75322138228415;337.9239671074007;5687.829365119042;5711.400302968181;5732.340780810203;5752.3384810746675;5755.366909639936;5610.831675049745;5616.129499927518;5619.157126431038;5640.238567793347;5644.79852857385;4159.438475805758;4234.851780187694;4363.759993200372;4366.454193225847;4378.40891479651;4349.021470169202;4354.934675979863;4386.420888480145;4405;4420.160169567772;4379.379629537076;4387.605115539601;4391.64866810656;4396.824127034914;4420.469543654766;4264.829406823724;4400.845970391053;4414.84548040817;4421.457661844453;4438.578335058164;3882.301185786557;3885.203533275672;3894.1822217334393;3898.571157172709;3907.8241479133508;5488.506034456918;5519.227308176858;5541.445855414467;5550.86122846928;5576.7211639417865;4862.270659401082;5021.046001259749;5036.017976494585;5053.267276244924;5064.518870707277;5857.941420585825;5910.586258961875;5913.201717768089;5945.483901605106;6002.159697642333;4279.443672322609;4288.356746488021;4299.903524601238;4300.892477688051;4322.891927701801;5981.371955944606;6141.385861413823;6152.5693201475915;6155.569110162291;6170.691465426756;4368.453943257093;4382.956170438319;4383.758893260838;4403.713758605681;4404.53752355998;4408.823647054082;4437.156940181355;4441.489228738672;4442.445593783587;4443.111377724468;4918.254019822912;4986.775595098229;5014.824481143215;5022.397312322545;5025.447200807908;5983.401659833982;5986.910196347058;5993.61041532299;6042.214512113397;6085.878282434326;1464.7656374979952;1509.7433436315853;1512.8335883052855;1516.5374560759074;1516.666333406671;956.9760356418566;968.8352979993418;972.5186032913612;990.8860481044628;997.9700608981742;5621.690807005572;5631.7747290108755;5638.661680299195;5666.320041595035;5699.5155411790465;5973.96885059082;6018.21763170785;6042.7310264844;6043.697815109315;6061.212042434456;5406.297016439808;5699.373068962411;5779.971100144472;5830.979578573732;5838.211841401357;3240.088347874765;3256.2510622556943;3271.8854840080485;3316.1263885904386;3324.135724711544;6056.212692350055;6247.250329960343;6261.373862613702;6265.530085243534;6305.779297724649;6227.159333489921;6244.687765611701;6246.125542424064;6246.250449946036;6279.802069275808;6051.727672254759;6283.43449089575;6295.811125666238;6324.778632747832;6332.968335158294;6017.826523827812;6109.594793197501;6135.815925522242;6147.569670123227;6159.384061593805;6108.472881779555;6111.419415155553;6131.386861313833;6147.231596050494;6153.507719382528;6046.818595442144;6334.968325158345;6377.553571249968;6394.680265986775;6404.391582799627;4250.873518517534;4266.850660226877;4294.162638285505;4297.8495752648505;4308.46144231971;5816.76732930678;6186.752529898934;6228.128062071223;6228.781992630236;6229.345918678655;5942.692607626315;5960.5827592068135;5966.49284810796;5970.641761494324;5996.820095397145;5816.70916454184;5967.791127310524;5969.985157495437;5970.522358211246;5995.250593675791;5549.611527193219;5775.884482310246;5778.017736984639;5801.6519008859605;5822.214001109796;5923.85190370227;5940.613860099253;5969.76120955157;6061.605995610271;6074.787382441594;5686.402927692533;5836.620619659709;5837.591368604327;5853.882922341614;5858.179854820243 05:57:03 INFO - PROCESS | 15601 | |5;yui.html;672.6245771257966;694.642259236493;748.2592233688648;763.1529002806883;848.3679658654304;15177.089374637515;15616.063036217807;15692.921535392335;15703.371865125395;15790.36838526459;14695.191764452977;14839.183844888526;14905.478308259213;14915.254237288147;14918.552443426688;666.0508774995612;772.142921357293;784.3764207455087;787.6927998080753;791.540906274361;793.7698067560401;794.6622685358728;799.7440818937943;800.7837883771379;801.286854699318;856.7429771068686;856.7729551668813;859.4113032572676;859.4284800607588;859.9355048371366;844.5650489997656;855.2260204514924;856.4775486952954;856.6873091321685;856.734412332179;616.5252755378378;618.3476432363855;619.9473044791198;620.407510827159;620.6214209332304;14565.92717036408;14582.708345833023;14596.197209153492;14607.415703371853;14611.196384198865;15206.695866082728;15299.011128553328;15369.154696491689;15409.152496612682;15776.211189440482;12219.389030548436;12288.324142172178;12404.75190496185;12437;12471.625851224388;3917.7257591968573;3951.288768021755;4034.7492277394103;4053.837846486137;4066.552679205285;73432;73512.63243683748;73921;78160.60919695365;78172.60913695395;11726;11876.406179690981;11923.76152476963;11954.641360759191;12161.027117830552;22609.095636174698;22660.433489162904;22745.545089098458;22747.88626056859;22794.43013924665;8457.407981441364;8562.871556926651;8577.485350878967;8701.782455438664;8721.956390218009;4669.2062349400685;4709.505501922249;4739.857804265877;4790.353302304214;4823.782929768169;3545.556805399325;3665.743397962117;3673.44898265257;3677.3932301170007;3698.1679122197293;576.2134686153371;596.8011458581997;606.5784279925498;609.7987664070846;611.5780111722897;596.7374355283748;605.6335916770379;652.9804105876831;728.2317155401103;773.6982576795054;9754.829420469589;10041.548130334153;10090.899091008996;10231;10330.845037324447;566.6769941133597;645.470714014513;646.867392184601;745.2249660353281;746.4028776978396;4540.568645978627;4793.9280910786365;4849.114257753998;4859.1960184912305;4912.803487860517;114733;119119;119224;120163;121977.39011305064;85179.57410212909;94820.52589737007;95299.52350238204;95828.52085739527;96709.51645241729;88331;88428.5578572103;88710;89321.9999999987;90752;9187.448753074837;9326.997238324973;9341.392809467363;9500.47747373901;9540.602695091218;38721.806390968995;38919;53153.7342313286;53947;55663.443365567444;71604.64197678979;73014;80937.59531202307;82401;82814;11373.943130284295;11776.11679124052;11835.112366572714;11978.880211197777;12569.748605028031;12942.870571294166;12999.870001299865;13001.674958126123;13081.495628002522;13847.515336963157;12476.625701228977;12778.828351633134;12913.289769062792;12923.483060677467;13388.129771564818;12662.683432914251;12863.871361286267;12880.227186368847;12903.09678322546;12996.220226786423;12707.745845082862;12714.745705086032;13179.868201317864;13333.333333333489;13333.399996999964;10109.443980581138;10396.896031039592;10656.555379644884;10935.56257749681;11247.268927519684;10443;10643.254972151875;10762.300450470695;10961.232713710282;11013.118950483782 05:57:03 INFO - PROCESS | 15601 | __end_tp_report 05:57:03 INFO - PROCESS | 15601 | __start_cc_report 05:57:03 INFO - PROCESS | 15601 | _x_x_mozilla_cycle_collect,344 05:57:03 INFO - PROCESS | 15601 | __end_cc_report 05:57:03 INFO - PROCESS | 15601 | __startTimestamp1465736223030__endTimestamp 05:57:03 INFO - PROCESS | 15601 | 05:57:03 INFO - PROCESS | 15601 | ------- Summary: start ------- 05:57:03 INFO - PROCESS | 15601 | Number of tests: 6 05:57:03 INFO - PROCESS | 15601 | 05:57:03 INFO - PROCESS | 15601 | [#0] dojo.html Cycles:165 Average:5457.19 Median:5686.86 stddev:725.18 (12.8%) stddev-sans-first:704.10 05:57:03 INFO - PROCESS | 15601 | Values: 3132.6 3149.0 3173.6 3177.0 3202.3 5473.9 5478.1 5481.6 5517.1 5527.4 5422.3 5431.3 5469.2 5501.7 5530.1 4900.3 4949.0 5037.2 5088.4 5132.0 781.9 5056.7 5076.4 5108.2 5122.3 4950.1 4975.3 4999.0 5010.9 5033.2 4941.5 4985.9 4991.5 5009.9 5040.2 4920.6 4929.0 4947.7 4958.1 4976.4 5464.8 5523.3 5538.7 5578.2 5664.6 5785.4 5842.3 5926.9 5953.2 5977.5 5814.5 5902.1 5926.6 5953.3 5993.6 5499.8 5502.3 5509.1 5514.0 5555.7 5821.4 6000.9 6004.1 6007.9 6018.2 5800.3 5842.6 5849.3 5851.2 5862.4 5902.9 5934.5 5938.5 5957.3 5958.5 5761.2 5772.2 5806.7 5843.2 5874.7 5783.1 5790.9 5811.3 5866.6 5874.1 4532.9 4536.0 4542.9 4557.2 4585.6 3981.0 3995.5 4012.3 4012.9 4049.8 5587.1 5590.7 5631.2 5655.4 5667.5 5873.3 5938.2 5944.7 5950.6 5952.7 5554.4 5602.6 5628.4 5654.5 5659.1 5101.5 5118.2 5142.4 5145.1 5156.6 5951.8 6136.5 6143.2 6152.3 6153.3 5906.9 5964.1 5979.9 5997.2 6000.2 6158.7 6167.3 6170.9 6187.3 6191.1 5735.6 5800.5 5874.5 5885.5 5894.3 5906.6 5949.3 5967.0 5977.4 6028.3 5722.7 5724.4 5733.6 5783.1 5797.6 5629.6 5702.3 5739.1 5775.6 5778.9 5517.0 5607.5 5609.0 5652.6 5789.4 5756.5 5797.4 5807.6 5807.7 5814.0 5564.1 5667.5 5682.9 5686.9 5701.1 05:57:03 INFO - PROCESS | 15601 | 05:57:03 INFO - PROCESS | 15601 | [#1] ext.html Cycles:180 Average:61547.52 Median:43464.17 stddev:123057.61 (283.1%) stddev-sans-first:123317.65 05:57:03 INFO - PROCESS | 15601 | Values: 568.1 628.7 639.4 645.3 663.4 44448.3 46147.0 46642.3 46651.0 49675.8 46724.3 46824.3 47034.3 47077.1 47292.3 9026.2 9182.5 9231.5 9232.6 9260.2 9046.1 9058.6 9121.1 9147.2 9157.8 9148.3 9202.9 9228.4 9236.7 9237.3 9115.0 9128.9 9149.8 9154.5 9162.5 9102.2 9165.0 9191.4 9227.3 9238.2 44734.1 45106.3 45264.8 45302.8 45378.8 3568.7 3597.6 3688.3 3718.2 3726.9 33866.3 33955.0 34055.5 34643.3 35146.8 4379.5 4381.4 4387.5 4404.5 4484.6 366786.0 366845.2 366934.0 368777.0 369186.0 34647.8 35360.0 62177.0 62994.0 63329.4 38686.0 38828.6 38925.8 38950.4 39079.0 16102.7 16314.1 16334.3 16389.5 16528.8 13545.5 13575.2 13578.9 13637.4 13694.5 8962.5 8963.5 9010.5 9091.7 9136.6 3355.9 3468.5 3497.2 3514.9 3541.2 1001.7 1032.9 1058.9 1086.7 1104.4 34155.5 34195.3 34392.8 34412.7 34449.5 1088.5 1112.7 1137.6 1169.6 1193.5 17741.0 17985.7 18009.0 18032.5 18076.2 555474.0 563608.0 564113.0 564374.0 566086.0 61322.0 62369.4 62380.4 62407.7 62790.4 1359.2 1377.7 1378.9 1384.3 1390.3 32128.7 33552.5 33900.0 33998.5 34040.8 54488.2 54763.5 54785.2 54909.0 55036.4 433710.0 439268.0 439485.0 440968.0 440969.0 29901.0 30071.2 30141.2 30593.5 30640.0 50734.2 51009.5 51645.7 51717.5 51854.0 40327.8 41856.4 43606.9 44651.0 45097.8 42290.2 42889.1 42942.6 43310.1 43488.3 39023.0 43440.0 43623.1 44086.6 44475.8 36375.3 37680.4 38394.4 39363.6 39930.6 29831.9 30106.7 30178.7 30261.2 30406.2 05:57:03 INFO - PROCESS | 15601 | 05:57:03 INFO - PROCESS | 15601 | [#2] jquery.html Cycles:180 Average:30630.87 Median:3009.73 stddev:79433.81 (2639.2%) stddev-sans-first:79624.20 05:57:03 INFO - PROCESS | 15601 | Values: 397.6 409.1 411.4 413.7 418.1 14017.9 17982.0 18906.3 19459.1 19727.2 18922.1 19032.2 19254.2 19970.5 19975.2 5659.0 5734.2 5811.6 5865.8 5891.1 5647.7 5734.0 5746.2 6852.3 7234.1 7162.9 7335.9 7339.1 7342.5 7394.3 7176.2 7250.7 7327.0 7353.3 7394.6 6392.0 6827.4 6879.1 7006.2 7096.4 24832.6 24935.3 25685.5 26393.6 26659.0 2538.8 2759.6 2801.5 2977.7 3041.7 14835.6 14915.9 14976.7 16075.2 16850.7 2003.6 2077.1 2128.0 2156.5 2182.1 97937.0 100212.5 104031.0 105000.5 105320.5 16998.9 17103.3 17445.7 17803.3 17897.3 31306.2 31337.2 31591.0 31766.5 31967.5 9750.5 10055.7 10106.7 10427.0 10433.8 8703.8 8740.3 8898.7 8969.0 8986.8 8749.7 8790.8 8914.3 9019.3 9184.4 3388.6 3497.2 3527.6 3585.8 3651.8 887.8 958.4 971.2 1029.7 1051.0 19425.9 19636.6 19728.2 19754.4 20046.9 925.5 993.7 1028.2 1062.2 1101.1 10500.7 11084.0 11183.8 11210.6 11249.4 468654.0 470265.0 472731.0 491607.0 493689.4 92599.5 93936.0 93982.5 95390.5 97259.0 998.2 1010.8 1016.1 1036.8 1040.8 17335.6 17544.5 17569.3 17605.5 17706.1 40706.8 41158.8 41259.6 41497.6 42402.0 56136.4 58561.4 59044.4 59207.7 59588.0 7242.0 7659.5 8126.2 8620.0 8732.6 12741.2 13246.3 13441.9 13654.7 13719.4 11526.3 11750.7 11917.3 12002.4 12192.6 10345.1 11772.2 11943.8 11980.0 12029.5 11222.7 11302.7 11711.4 12465.4 12511.7 7834.9 7978.4 8015.3 8132.3 8421.5 11403.7 12081.8 12152.2 12201.2 12430.9 05:57:03 INFO - PROCESS | 15601 | 05:57:03 INFO - PROCESS | 15601 | [#3] mootools.html Cycles:180 Average:5794.23 Median:4740.56 stddev:3260.06 (68.8%) stddev-sans-first:3252.73 05:57:03 INFO - PROCESS | 15601 | Values: 1432.0 1467.0 1533.2 1682.9 1707.5 7780.0 8410.6 8445.4 8994.7 9034.2 8446.7 8518.4 8617.4 8642.5 8690.9 2265.2 2281.9 2303.9 2306.2 2306.6 2155.2 2161.8 2215.7 2245.5 2247.5 2157.0 2165.7 2169.6 2178.8 2200.8 2191.8 2207.7 2208.4 2233.0 2247.3 2304.2 2318.6 2330.1 2332.7 2334.5 8751.4 8779.3 8815.4 8834.2 8846.5 5246.5 5316.7 5374.9 5377.4 5378.5 3232.7 3398.4 3461.0 3466.2 3470.5 1161.8 1170.9 1181.7 1191.5 1214.0 12103.5 12126.7 12139.5 12140.4 12155.8 4657.5 4704.2 4710.5 4770.6 4788.6 10090.3 10193.8 10198.4 10283.1 10306.7 5388.8 5403.6 5410.2 5414.7 5423.7 4349.3 4699.2 4837.0 4977.2 4985.3 3977.7 3999.2 4074.4 4110.3 4115.3 1276.1 1296.8 1318.5 1318.5 1319.8 814.3 917.3 921.6 936.7 959.1 6010.8 6156.4 6170.7 6257.3 6352.5 936.3 971.0 982.6 1003.8 1005.1 4144.3 4333.3 4372.8 4382.8 4432.8 10658.3 10944.5 10974.0 10985.5 11040.7 10628.5 10923.8 10930.6 10939.7 10948.9 8148.1 8231.3 8322.5 8338.3 8423.7 6004.7 6026.9 6092.5 6199.6 6250.7 9644.8 10087.5 10092.6 10169.0 10177.2 10130.3 10148.4 10188.6 10202.6 10214.7 6995.9 7468.7 7678.8 7707.0 7861.3 8269.7 8290.2 8299.4 8301.3 8414.6 7281.9 7510.2 7512.0 7542.8 7596.8 7397.7 7409.2 7472.4 7520.3 7545.4 7022.8 7039.2 7125.8 7139.2 7163.8 5074.1 5184.7 5256.2 5314.7 5333.2 5353.3 5358.2 5378.5 5392.1 5411.7 05:57:03 INFO - PROCESS | 15601 | 05:57:03 INFO - PROCESS | 15601 | [#4] prototype.html Cycles:180 Average:5002.87 Median:5721.87 stddev:1479.46 (25.9%) stddev-sans-first:1441.49 05:57:03 INFO - PROCESS | 15601 | Values: 332.7 334.4 334.6 335.8 337.9 5687.8 5711.4 5732.3 5752.3 5755.4 5610.8 5616.1 5619.2 5640.2 5644.8 4159.4 4234.9 4363.8 4366.5 4378.4 4349.0 4354.9 4386.4 4405.0 4420.2 4379.4 4387.6 4391.6 4396.8 4420.5 4264.8 4400.8 4414.8 4421.5 4438.6 3882.3 3885.2 3894.2 3898.6 3907.8 5488.5 5519.2 5541.4 5550.9 5576.7 4862.3 5021.0 5036.0 5053.3 5064.5 5857.9 5910.6 5913.2 5945.5 6002.2 4279.4 4288.4 4299.9 4300.9 4322.9 5981.4 6141.4 6152.6 6155.6 6170.7 4368.5 4383.0 4383.8 4403.7 4404.5 4408.8 4437.2 4441.5 4442.4 4443.1 4918.3 4986.8 5014.8 5022.4 5025.4 5983.4 5986.9 5993.6 6042.2 6085.9 1464.8 1509.7 1512.8 1516.5 1516.7 957.0 968.8 972.5 990.9 998.0 5621.7 5631.8 5638.7 5666.3 5699.5 5974.0 6018.2 6042.7 6043.7 6061.2 5406.3 5699.4 5780.0 5831.0 5838.2 3240.1 3256.3 3271.9 3316.1 3324.1 6056.2 6247.3 6261.4 6265.5 6305.8 6227.2 6244.7 6246.1 6246.3 6279.8 6051.7 6283.4 6295.8 6324.8 6333.0 6017.8 6109.6 6135.8 6147.6 6159.4 6108.5 6111.4 6131.4 6147.2 6153.5 6046.8 6335.0 6377.6 6394.7 6404.4 4250.9 4266.9 4294.2 4297.8 4308.5 5816.8 6186.8 6228.1 6228.8 6229.3 5942.7 5960.6 5966.5 5970.6 5996.8 5816.7 5967.8 5970.0 5970.5 5995.3 5549.6 5775.9 5778.0 5801.7 5822.2 5923.9 5940.6 5969.8 6061.6 6074.8 5686.4 5836.6 5837.6 5853.9 5858.2 05:57:03 INFO - PROCESS | 15601 | 05:57:03 INFO - PROCESS | 15601 | [#5] yui.html Cycles:180 Average:20778.49 Median:4303.56 stddev:30205.23 (701.9%) stddev-sans-first:30252.24 05:57:03 INFO - PROCESS | 15601 | Values: 672.6 694.6 748.3 763.2 848.4 15177.1 15616.1 15692.9 15703.4 15790.4 14695.2 14839.2 14905.5 14915.3 14918.6 666.1 772.1 784.4 787.7 791.5 793.8 794.7 799.7 800.8 801.3 856.7 856.8 859.4 859.4 859.9 844.6 855.2 856.5 856.7 856.7 616.5 618.3 619.9 620.4 620.6 14565.9 14582.7 14596.2 14607.4 14611.2 15206.7 15299.0 15369.2 15409.2 15776.2 12219.4 12288.3 12404.8 12437.0 12471.6 3917.7 3951.3 4034.7 4053.8 4066.6 73432.0 73512.6 73921.0 78160.6 78172.6 11726.0 11876.4 11923.8 11954.6 12161.0 22609.1 22660.4 22745.5 22747.9 22794.4 8457.4 8562.9 8577.5 8701.8 8722.0 4669.2 4709.5 4739.9 4790.4 4823.8 3545.6 3665.7 3673.4 3677.4 3698.2 576.2 596.8 606.6 609.8 611.6 596.7 605.6 653.0 728.2 773.7 9754.8 10041.5 10090.9 10231.0 10330.8 566.7 645.5 646.9 745.2 746.4 4540.6 4793.9 4849.1 4859.2 4912.8 114733.0 119119.0 119224.0 120163.0 121977.4 85179.6 94820.5 95299.5 95828.5 96709.5 88331.0 88428.6 88710.0 89322.0 90752.0 9187.4 9327.0 9341.4 9500.5 9540.6 38721.8 38919.0 53153.7 53947.0 55663.4 71604.6 73014.0 80937.6 82401.0 82814.0 11373.9 11776.1 11835.1 11978.9 12569.7 12942.9 12999.9 13001.7 13081.5 13847.5 12476.6 12778.8 12913.3 12923.5 13388.1 12662.7 12863.9 12880.2 12903.1 12996.2 12707.7 12714.7 13179.9 13333.3 13333.4 10109.4 10396.9 10656.6 10935.6 11247.3 10443.0 10643.3 10762.3 10961.2 11013.1 05:57:03 INFO - PROCESS | 15601 | -------- Summary: end -------- 05:57:03 INFO - PROCESS | 15601 | 05:57:03 INFO - TEST-INFO | 15601: exit 0 05:57:03 INFO - TEST-OK | dromaeo_css | took 1111277ms 05:57:03 INFO - TEST-START | kraken 05:57:03 INFO - operating with platform_type : linux_ 05:57:03 INFO - Initialising browser for kraken test... 05:57:03 INFO - TEST-INFO | started process 15841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKZycDs/profile http://localhost:57809/getInfo.html) 05:57:08 INFO - PROCESS | 15841 | __metrics Screen width/height:1600/1200 05:57:08 INFO - PROCESS | 15841 | colorDepth:24 05:57:08 INFO - PROCESS | 15841 | Browser inner width/height: 1024/697 05:57:08 INFO - PROCESS | 15841 | __metrics 05:57:09 ERROR - PROCESS | 15841 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:57:10 INFO - TEST-INFO | 15841: exit 0 05:57:10 INFO - Browser initialized. 05:57:10 INFO - Running cycle 1/1 for kraken test... 05:57:10 INFO - TEST-INFO | started process 15961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKZycDs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:22 INFO - PROCESS | 15961 | RSS: Main: 184954880 05:57:22 INFO - PROCESS | 15961 | 05:57:24 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:57809/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57809/tests/kraken/driver.html?testName=audio-beat-detection) 05:57:25 INFO - PROCESS | 15961 | RSS: Main: 190648320 05:57:25 INFO - PROCESS | 15961 | 05:57:28 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:57809/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57809/tests/kraken/driver.html?testName=audio-dft) 05:57:28 INFO - PROCESS | 15961 | RSS: Main: 190341120 05:57:28 INFO - PROCESS | 15961 | 05:57:31 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:57809/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57809/tests/kraken/driver.html?testName=audio-fft) 05:57:32 INFO - PROCESS | 15961 | RSS: Main: 185184256 05:57:32 INFO - PROCESS | 15961 | 05:57:34 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:57809/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57809/tests/kraken/driver.html?testName=audio-oscillator) 05:57:35 INFO - PROCESS | 15961 | RSS: Main: 186122240 05:57:35 INFO - PROCESS | 15961 | 05:57:37 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:57809/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57809/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:57:38 INFO - PROCESS | 15961 | RSS: Main: 186056704 05:57:38 INFO - PROCESS | 15961 | 05:57:41 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:57809/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57809/tests/kraken/driver.html?testName=imaging-darkroom) 05:57:41 INFO - PROCESS | 15961 | RSS: Main: 187019264 05:57:41 INFO - PROCESS | 15961 | 05:57:45 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:57809/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57809/tests/kraken/driver.html?testName=imaging-desaturate) 05:57:45 INFO - PROCESS | 15961 | RSS: Main: 187113472 05:57:45 INFO - PROCESS | 15961 | 05:57:48 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:57809/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57809/tests/kraken/driver.html?testName=json-parse-financial) 05:57:49 INFO - PROCESS | 15961 | RSS: Main: 187019264 05:57:49 INFO - PROCESS | 15961 | 05:57:50 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:57809/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57809/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:57:51 INFO - PROCESS | 15961 | RSS: Main: 186843136 05:57:51 INFO - PROCESS | 15961 | 05:57:53 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:57809/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57809/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:57:53 INFO - PROCESS | 15961 | RSS: Main: 187068416 05:57:53 INFO - PROCESS | 15961 | 05:57:56 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:57809/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57809/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:57:56 INFO - PROCESS | 15961 | RSS: Main: 187420672 05:57:56 INFO - PROCESS | 15961 | 05:57:59 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:57809/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:57:59 INFO - PROCESS | 15961 | RSS: Main: 187482112 05:57:59 INFO - PROCESS | 15961 | 05:58:02 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:57809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:58:03 INFO - PROCESS | 15961 | RSS: Main: 186974208 05:58:03 INFO - PROCESS | 15961 | 05:58:04 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:57809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57809/tests/kraken/driver.html?testName=ai-astar) 05:58:05 INFO - PROCESS | 15961 | RSS: Main: 188043264 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | __start_tp_report 05:58:05 INFO - PROCESS | 15961 | _x_x_mozilla_page_load 05:58:05 INFO - PROCESS | 15961 | _x_x_mozilla_page_load_details 05:58:05 INFO - PROCESS | 15961 | |i|pagename|runs| 05:58:05 INFO - PROCESS | 15961 | |0;ai-astar;111;106;111;111;110;112;110;110;109;111 05:58:05 INFO - PROCESS | 15961 | |1;audio-beat-detection;165;126;150;181;131;159;162;127;184;126 05:58:05 INFO - PROCESS | 15961 | |2;audio-dft;162;164;164;163;165;168;161;167;161;162 05:58:05 INFO - PROCESS | 15961 | |3;audio-fft;77;74;76;156;76;76;76;74;176;75 05:58:05 INFO - PROCESS | 15961 | |4;audio-oscillator;85;86;141;84;85;84;140;86;84;156 05:58:05 INFO - PROCESS | 15961 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;118;117 05:58:05 INFO - PROCESS | 15961 | |6;imaging-darkroom;146;146;147;147;147;146;151;146;147;148 05:58:05 INFO - PROCESS | 15961 | |7;imaging-desaturate;96;95;96;95;95;96;95;97;95;95 05:58:05 INFO - PROCESS | 15961 | |8;json-parse-financial;54;58;55;55;54;55;53;53;53;55 05:58:05 INFO - PROCESS | 15961 | |9;json-stringify-tinderbox;61;62;63;62;62;62;65;61;61;63 05:58:05 INFO - PROCESS | 15961 | |10;stanford-crypto-aes;81;80;80;79;81;81;80;81;109;83 05:58:05 INFO - PROCESS | 15961 | |11;stanford-crypto-ccm;132;125;133;132;126;125;128;123;127;133 05:58:05 INFO - PROCESS | 15961 | |12;stanford-crypto-pbkdf2;161;159;158;160;165;161;159;169;166;158 05:58:05 INFO - PROCESS | 15961 | |13;stanford-crypto-sha256-iterative;65;64;63;64;66;62;64;62;62;64 05:58:05 INFO - PROCESS | 15961 | __end_tp_report 05:58:05 INFO - PROCESS | 15961 | __start_cc_report 05:58:05 INFO - PROCESS | 15961 | _x_x_mozilla_cycle_collect,916 05:58:05 INFO - PROCESS | 15961 | __end_cc_report 05:58:05 INFO - PROCESS | 15961 | __startTimestamp1465736285213__endTimestamp 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | ------- Summary: start ------- 05:58:05 INFO - PROCESS | 15961 | Number of tests: 14 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:1.66 (1.5%) stddev-sans-first:1.73 05:58:05 INFO - PROCESS | 15961 | Values: 111.0 106.0 111.0 111.0 110.0 112.0 110.0 110.0 109.0 111.0 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:160.50 stddev:22.60 (14.1%) stddev-sans-first:23.40 05:58:05 INFO - PROCESS | 15961 | Values: 165.0 126.0 150.0 181.0 131.0 159.0 162.0 127.0 184.0 126.0 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:2.41 (1.5%) stddev-sans-first:2.47 05:58:05 INFO - PROCESS | 15961 | Values: 162.0 164.0 164.0 163.0 165.0 168.0 161.0 167.0 161.0 162.0 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:38.46 (50.6%) stddev-sans-first:40.32 05:58:05 INFO - PROCESS | 15961 | Values: 77.0 74.0 76.0 156.0 76.0 76.0 76.0 74.0 176.0 75.0 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:84.50 stddev:29.69 (35.1%) stddev-sans-first:30.75 05:58:05 INFO - PROCESS | 15961 | Values: 85.0 86.0 141.0 84.0 85.0 84.0 140.0 86.0 84.0 156.0 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:58:05 INFO - PROCESS | 15961 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.52 (1.0%) stddev-sans-first:1.56 05:58:05 INFO - PROCESS | 15961 | Values: 146.0 146.0 147.0 147.0 147.0 146.0 151.0 146.0 147.0 148.0 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 05:58:05 INFO - PROCESS | 15961 | Values: 96.0 95.0 96.0 95.0 95.0 96.0 95.0 97.0 95.0 95.0 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.51 (2.7%) stddev-sans-first:1.59 05:58:05 INFO - PROCESS | 15961 | Values: 54.0 58.0 55.0 55.0 54.0 55.0 53.0 53.0 53.0 55.0 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:1.23 (2.0%) stddev-sans-first:1.22 05:58:05 INFO - PROCESS | 15961 | Values: 61.0 62.0 63.0 62.0 62.0 62.0 65.0 61.0 61.0 63.0 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:81.00 stddev:9.02 (11.1%) stddev-sans-first:9.52 05:58:05 INFO - PROCESS | 15961 | Values: 81.0 80.0 80.0 79.0 81.0 81.0 80.0 81.0 109.0 83.0 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:130.00 stddev:3.78 (2.9%) stddev-sans-first:3.77 05:58:05 INFO - PROCESS | 15961 | Values: 132.0 125.0 133.0 132.0 126.0 125.0 128.0 123.0 127.0 133.0 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:161.00 stddev:3.78 (2.3%) stddev-sans-first:4.00 05:58:05 INFO - PROCESS | 15961 | Values: 161.0 159.0 158.0 160.0 165.0 161.0 159.0 169.0 166.0 158.0 05:58:05 INFO - PROCESS | 15961 | 05:58:05 INFO - PROCESS | 15961 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.35 (2.1%) stddev-sans-first:1.33 05:58:05 INFO - PROCESS | 15961 | Values: 65.0 64.0 63.0 64.0 66.0 62.0 64.0 62.0 62.0 64.0 05:58:05 INFO - PROCESS | 15961 | -------- Summary: end -------- 05:58:05 INFO - PROCESS | 15961 | 05:58:06 INFO - TEST-INFO | 15961: exit 0 05:58:06 INFO - TEST-OK | kraken | took 62422ms 05:58:06 INFO - SUITE-END | took 1173s 05:58:06 INFO - Completed test suite (00:19:33) 05:58:06 INFO - javascript benchmark 05:58:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7488.487614892872, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.6084239470065, 3149.0395429394025, 3173.6350319713233, 3177.0, 3202.3115030268486, 5473.890522189558, 5478.068728316186, 5481.643693159946, 5517.117261238202, 5527.419620939803, 5422.2951016367815, 5431.266778984836, 5469.206964990074, 5501.669899806005, 5530.115181570949, 4900.338454308676, 4949.034938187055, 5037.168867136918, 5088.363954505687, 5132.024915266087, 781.9432360719741, 5056.696598204119, 5076.390833100015, 5108.208227724708, 5122.308488354061, 4950.084234416644, 4975.3283306753665, 4999.0, 5010.949890501103, 5033.245013248005, 4941.530554597343, 4985.850424487271, 4991.475895031006, 5009.9479109387075, 5040.16837221858, 4920.581750551208, 4929.038837426703, 4947.653664243504, 4958.057968985881, 4976.353074100344, 5464.836054918359, 5523.28197334348, 5538.667679939176, 5578.191162281447, 5664.603477756558, 5785.363610002938, 5842.269716285465, 5926.940730592682, 5953.226080609536, 5977.491913187341, 5814.5057670098095, 5902.055671092648, 5926.614770039933, 5953.2856057272975, 5993.61041532299, 5499.752511137009, 5502.284702988626, 5509.090999985037, 5513.972430137864, 5555.666660000413, 5821.446962538552, 6000.879982400327, 6004.129401236796, 6007.879842403127, 6018.247719035121, 5800.303963524319, 5842.649441033552, 5849.298084229835, 5851.239338885917, 5862.355140934494, 5902.881942361215, 5934.495567876693, 5938.495227905676, 5957.314908785545, 5958.493528050078, 5761.222234998221, 5772.249607550992, 5806.680632565165, 5843.2403787507355, 5874.676892770939, 5783.1325301204315, 5790.94209057904, 5811.27359080115, 5866.6480011199465, 5874.0601503760045, 4532.864014079583, 4535.9546404536195, 4542.909141817211, 4557.202489564379, 4585.6102231310715, 3980.960190398117, 3995.5005624296964, 4012.27778999777, 4012.8996775080273, 4049.838006479708, 5587.05020146576, 5590.664560126405, 5631.239782629293, 5655.434456554394, 5667.518260947783, 5873.2658417697785, 5938.228030356113, 5944.7027648617395, 5950.642961422329, 5952.7321270542925, 5554.444555544494, 5602.635828671123, 5628.437156284421, 5654.519365853948, 5659.094544872883, 5101.51535604117, 5118.181091025418, 5142.408623008327, 5145.073886700355, 5156.587473002151, 5951.7619295227705, 6136.539759518054, 6143.1706719592285, 6152.261728592508, 6153.29237137726, 5906.911396328973, 5964.105384192232, 5979.910301345571, 5997.16039754426, 6000.249968753906, 6158.722857471335, 6167.321594624498, 6170.876582468415, 6187.288461826947, 6191.102290167991, 5735.627184233012, 5800.50695690871, 5874.471297583238, 5885.529157667291, 5894.263217097863, 5906.645601263938, 5949.286085669574, 5966.970165149321, 5977.402259773988, 6028.306744724413, 5722.685252311163, 5724.370319264961, 5733.627314224562, 5783.103618939072, 5797.623154494944, 5629.634073785191, 5702.287214098238, 5739.053056245672, 5775.624584402, 5778.855528611818, 5516.972415137899, 5607.467290607386, 5609.018421776254, 5652.576056795839, 5789.363170051375, 5756.510696590837, 5797.362290147996, 5807.593468457337, 5807.738651760596, 5813.970930145322, 5564.109742441352, 5667.518260947865, 5682.9431705684065, 5686.857828554319, 5701.087825947829], "value": 5409.993329132818, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.1250873654573, 628.6950828848009, 639.3893831391022, 645.2676212498812, 663.432764985937, 44448.33327500086, 46147.0, 46642.30036549454, 46651.0, 49675.75162124184, 46724.29913551299, 46824.29763553549, 47034.29448558266, 47077.058458830805, 47292.29061564079, 9026.187643112118, 9182.494962777044, 9231.492267925261, 9232.630694772235, 9260.212881905047, 9046.140616641409, 9058.592363343632, 9121.087891210893, 9147.22248608869, 9157.816843663122, 9148.313876459259, 9202.907970920272, 9228.446293222394, 9236.67671631493, 9237.261019118454, 9115.042920493319, 9128.863067053966, 9149.771255718593, 9154.49650269235, 9162.496062716547, 9102.226310763594, 9165.0, 9191.40255883372, 9227.307951903567, 9238.214751746042, 44734.10531789379, 45106.32340514895, 45264.773676131736, 45302.77348613269, 45378.77310613426, 3568.660977207187, 3597.568291804974, 3688.2992231475932, 3718.200586873835, 3726.9068273293115, 33866.32267354664, 33955.0, 34055.489167662505, 34643.30713385744, 35146.824265878764, 4379.474463064453, 4381.38660587518, 4387.451568553931, 4404.537523560012, 4484.573965473275, 366786.0, 366845.1657741721, 366934.0, 368777.0, 369185.9999999973, 34647.82676086654, 35360.0, 62177.0, 62994.0, 63329.366706332345, 38686.0, 38828.6117138825, 38925.805370972965, 38950.415743763864, 39079.0, 16102.677946441005, 16314.102724350038, 16334.346626135059, 16389.508314750576, 16528.83471165297, 13545.458181672622, 13575.185488870698, 13578.864211357957, 13637.386317615532, 13694.452221911011, 8962.462252264884, 8963.50700711454, 9010.504422256708, 9091.681791137278, 9136.634534618674, 3355.8657653694067, 3468.497067925137, 3497.2306092659574, 3514.8594056237976, 3541.1678255609913, 1001.702695436569, 1032.896710328976, 1058.878229003659, 1086.6522712732008, 1104.3705088099866, 34155.487667685, 34195.316093678484, 34392.82803586016, 34412.65587344095, 34449.483257751155, 1088.515610553312, 1112.7385064509833, 1137.6416428824894, 1169.649105268433, 1193.5106606291379, 17741.0, 17985.7302140468, 18009.0, 18032.549186270448, 18076.18657160431, 555474.0, 563608.0, 564113.0, 564374.0, 566086.0, 61322.0, 62369.37630623636, 62380.376196237456, 62407.68796156081, 62790.37209627937, 1359.2456186816214, 1377.6555861034742, 1378.8552202018643, 1384.3147641917315, 1390.2909516146838, 32128.678713213503, 33552.49671254982, 33900.0, 33998.49002265018, 34040.82979585185, 54488.18267725908, 54763.45236547584, 54785.17822232749, 54909.0, 55036.44963550474, 433710.0, 439268.0, 439485.0, 440968.0, 440969.0, 29901.0, 30071.248218794706, 30141.246468838453, 30593.54109688312, 30640.0, 50734.23898641449, 51009.489905100476, 51645.74177129241, 51717.48282517127, 51854.0, 40327.798361008005, 41856.37215441831, 43606.909827254574, 44651.0, 45097.77451112724, 42290.154196916505, 42889.142217156106, 42942.57057429386, 43310.13379732451, 43488.34767478427, 39023.0, 43440.0, 43623.12753744844, 44086.55913440824, 44475.77762111169, 36375.272494549434, 37680.43479347757, 38394.42408363933, 39363.60636393714, 39930.60069399385, 29831.850840745657, 30106.698933011266, 30178.69821301759, 30261.243468913453, 30406.23984400319], "value": 19800.825564549617, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.57260944484676, 409.1040621039924, 411.36444193720706, 413.742223640134, 418.12611641668906, 14017.859821401782, 17982.0, 18906.338278160267, 19459.124339404727, 19727.210911563558, 18922.14850331735, 19032.2387104516, 19254.22983080675, 19970.50073748157, 19975.200991960304, 5658.971705141479, 5734.225879506276, 5811.593188476808, 5865.8240252792275, 5891.116332550109, 5647.689377084259, 5733.971330143343, 5746.224259724946, 6852.314768523132, 7234.095738032746, 7162.892556611655, 7335.9266407336045, 7339.119305683299, 7342.4860259781835, 7394.334509894108, 7176.246494118094, 7250.70997160113, 7327.0, 7353.338199562038, 7394.630268486554, 6392.0, 6827.385535301847, 6879.140107486564, 7006.194287656934, 7096.396806271473, 24832.627510587357, 24935.251942441755, 25685.486290274275, 26393.604095938575, 26659.0, 2538.8476691398573, 2759.6412466379443, 2801.5097357962277, 2977.732004119618, 3041.726244637993, 14835.554933352018, 14915.925420372938, 14976.700465990729, 16075.196240187945, 16850.662986740197, 2003.5792483578466, 2077.0757013129164, 2127.95744085119, 2156.4501052231735, 2182.1162429216192, 97937.0, 100212.4989375063, 104031.0, 105000.4749976253, 105320.4733976333, 16998.91500542514, 17103.315867365414, 17445.65108697819, 17803.287868485117, 17897.28410863577, 31306.21734456657, 31337.216569585944, 31591.0, 31766.523502147487, 31967.52048719271, 9750.512474376254, 10055.69832905014, 10106.69503912816, 10427.0, 10433.843492347622, 8703.782405439915, 8740.300775937909, 8898.688545900863, 8968.955155224183, 8986.820263594822, 8749.650013999497, 8790.824183516293, 8914.331425143011, 9019.32355073359, 9184.448933064037, 3388.5594872666397, 3497.2480916603054, 3527.6472352764517, 3585.820708964541, 3651.7808931464197, 887.8490656588395, 958.3626888119322, 971.2084651009404, 1029.6550655530332, 1051.033049594375, 19425.902870485555, 19636.607267854564, 19728.210871564977, 19754.40736777899, 20046.89976550108, 925.5418567808978, 993.6919554937992, 1028.1723212813608, 1062.1980404794485, 1101.0746688057052, 10500.737481563023, 11084.0, 11183.83224251637, 11210.607628732956, 11249.437528123724, 468654.0, 470265.0, 472731.0, 491607.0, 493689.441739082, 92599.53700231455, 93936.0, 93982.53008734912, 95390.52304738571, 97259.0, 998.2114129837493, 1010.7877345757473, 1016.0753714120116, 1036.76154484469, 1040.77623310987, 17335.56661083483, 17544.473665790047, 17569.297228110732, 17605.471835844946, 17706.114694265492, 40706.796466017484, 41158.794206029976, 41259.587404126774, 41497.585024149375, 42402.0, 56136.43863561475, 58561.4143858573, 59044.40955590389, 59207.70396148164, 59588.0, 7241.963790181016, 7659.540427574363, 8126.187381261827, 8619.956900215459, 8732.56337183151, 12741.235525868478, 13246.337683115613, 13441.865581344062, 13654.658633534242, 13719.382627781973, 11526.308421494738, 11750.70623234426, 11917.284962902253, 12002.39988000614, 12192.634220973385, 10345.120664743281, 11772.17594768358, 11943.761124777282, 11980.0, 12029.4586743595, 11222.719432014264, 11302.660920172408, 11711.414429278673, 12465.439055242718, 12511.687207819878, 7834.882476762967, 7978.4016198786485, 8015.278624923785, 8132.308753755997, 8421.536815475207, 11403.657890263305, 12081.758364832478, 12152.21010634306, 12201.20692155007, 12430.875691242973], "value": 10477.060956229929, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.026222168925, 1467.0317590390343, 1533.2180587900175, 1682.949511514655, 1707.462149422931, 7779.961100194505, 8410.621522031508, 8445.408821382505, 8994.68518601849, 9034.232090272326, 8446.662133514668, 8518.446300990432, 8617.353698472609, 8642.481451112937, 8690.869636955451, 2265.1958554713046, 2281.931542053741, 2303.9078436862505, 2306.215886598556, 2306.642470417088, 2155.245664017597, 2161.8162456191244, 2215.6898034275214, 2245.4835387860803, 2247.5280191159877, 2156.9784302157013, 2165.675148727688, 2169.620316444616, 2178.7930146636045, 2200.7799220078023, 2191.835612329082, 2207.6578130389735, 2208.4258092895802, 2232.977670223301, 2247.2808701215617, 2304.216566367443, 2318.5826551220775, 2330.1378489958656, 2332.731735850382, 2334.5447637710654, 8751.43115697484, 8779.297656187553, 8815.426997245158, 8834.160754728291, 8846.469211847245, 5246.501582349671, 5316.707581083039, 5374.946250537484, 5377.354717433894, 5378.46215378463, 3232.6767323267723, 3398.422268214385, 3460.9826950865336, 3466.168119651291, 3470.4967779671806, 1161.8431511745891, 1170.9355985420798, 1181.7163880668663, 1191.4817054581285, 1214.0348423003734, 12103.45534450943, 12126.69683257908, 12139.514419423213, 12140.392980351035, 12155.817662735066, 4657.4876763555985, 4704.247320428715, 4710.528947105262, 4770.594499467584, 4788.640851936118, 10090.293679442368, 10193.847092293621, 10198.388096714221, 10283.12593429567, 10306.742331441774, 5388.838334849961, 5403.594730395157, 5410.215518749838, 5414.702191379433, 5423.701696406657, 4349.325854492558, 4699.224627936421, 4837.0, 4977.1538838397555, 4985.252212168131, 3977.6817854571564, 3999.24014437256, 4074.3684728867074, 4110.260153172458, 4115.32097203964, 1276.1067252922992, 1296.8054791781308, 1318.4726109556063, 1318.4792007157312, 1319.845135506432, 814.2793627639581, 917.2661870503571, 921.6083164654995, 936.7470782888582, 959.0888655777039, 6010.849728756729, 6156.415140561639, 6170.660613666201, 6257.2804127525915, 6352.491800656029, 936.3024546712743, 970.9563069661882, 982.597135174575, 1003.7641154328727, 1005.085372311208, 4144.33690609501, 4333.306670932636, 4372.825086996484, 4382.824687012548, 4432.778361081933, 10658.253922225369, 10944.507497162647, 10974.0, 10985.505652245669, 11040.668779936615, 10628.46857657114, 10923.83614245771, 10930.56277748881, 10939.726506837393, 10948.945255273673, 8148.144444833444, 8231.300339471212, 8322.45904016237, 8338.291245244101, 8423.663053477792, 6004.669743164168, 6026.879462410815, 6092.543059270483, 6199.628022318675, 6250.749970001149, 9644.807103858024, 10087.546060427445, 10092.646757363751, 10169.0, 10177.236707246839, 10130.29087963865, 10148.441835699108, 10188.643397481053, 10202.591896324064, 10214.744631384276, 6995.930040699528, 7468.701251950079, 7678.846423071619, 7707.0, 7861.2531809478005, 8269.710560130367, 8290.170982901662, 8299.419040667337, 8301.29438997692, 8414.6213420395, 7281.927180728125, 7510.173880873209, 7512.0, 7542.843529919913, 7596.8480630388185, 7397.741079062207, 7409.184989651027, 7472.402207823252, 7520.285572870568, 7545.396368290414, 7022.789316320519, 7039.19049309336, 7125.786226413215, 7139.178994415709, 7163.820904477429, 5074.086664400444, 5184.688918664892, 5256.237845512455, 5314.734263286898, 5333.226682131147, 5353.2773075634295, 5358.169483730028, 5378.515933565841, 5392.110301800159, 5411.674139835608], "value": 4643.82405295754, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.6560694793036, 334.4431521516674, 334.57676039809644, 335.75322138228415, 337.9239671074007, 5687.829365119042, 5711.400302968181, 5732.340780810203, 5752.3384810746675, 5755.366909639936, 5610.831675049745, 5616.129499927518, 5619.157126431038, 5640.238567793347, 5644.79852857385, 4159.438475805758, 4234.851780187694, 4363.759993200372, 4366.454193225847, 4378.40891479651, 4349.021470169202, 4354.934675979863, 4386.420888480145, 4405.0, 4420.160169567772, 4379.379629537076, 4387.605115539601, 4391.64866810656, 4396.824127034914, 4420.469543654766, 4264.829406823724, 4400.845970391053, 4414.84548040817, 4421.457661844453, 4438.578335058164, 3882.301185786557, 3885.203533275672, 3894.1822217334393, 3898.571157172709, 3907.8241479133508, 5488.506034456918, 5519.227308176858, 5541.445855414467, 5550.86122846928, 5576.7211639417865, 4862.270659401082, 5021.046001259749, 5036.017976494585, 5053.267276244924, 5064.518870707277, 5857.941420585825, 5910.586258961875, 5913.201717768089, 5945.483901605106, 6002.159697642333, 4279.443672322609, 4288.356746488021, 4299.903524601238, 4300.892477688051, 4322.891927701801, 5981.371955944606, 6141.385861413823, 6152.5693201475915, 6155.569110162291, 6170.691465426756, 4368.453943257093, 4382.956170438319, 4383.758893260838, 4403.713758605681, 4404.53752355998, 4408.823647054082, 4437.156940181355, 4441.489228738672, 4442.445593783587, 4443.111377724468, 4918.254019822912, 4986.775595098229, 5014.824481143215, 5022.397312322545, 5025.447200807908, 5983.401659833982, 5986.910196347058, 5993.61041532299, 6042.214512113397, 6085.878282434326, 1464.7656374979952, 1509.7433436315853, 1512.8335883052855, 1516.5374560759074, 1516.666333406671, 956.9760356418566, 968.8352979993418, 972.5186032913612, 990.8860481044628, 997.9700608981742, 5621.690807005572, 5631.7747290108755, 5638.661680299195, 5666.320041595035, 5699.5155411790465, 5973.96885059082, 6018.21763170785, 6042.7310264844, 6043.697815109315, 6061.212042434456, 5406.297016439808, 5699.373068962411, 5779.971100144472, 5830.979578573732, 5838.211841401357, 3240.088347874765, 3256.2510622556943, 3271.8854840080485, 3316.1263885904386, 3324.135724711544, 6056.212692350055, 6247.250329960343, 6261.373862613702, 6265.530085243534, 6305.779297724649, 6227.159333489921, 6244.687765611701, 6246.125542424064, 6246.250449946036, 6279.802069275808, 6051.727672254759, 6283.43449089575, 6295.811125666238, 6324.778632747832, 6332.968335158294, 6017.826523827812, 6109.594793197501, 6135.815925522242, 6147.569670123227, 6159.384061593805, 6108.472881779555, 6111.419415155553, 6131.386861313833, 6147.231596050494, 6153.507719382528, 6046.818595442144, 6334.968325158345, 6377.553571249968, 6394.680265986775, 6404.391582799627, 4250.873518517534, 4266.850660226877, 4294.162638285505, 4297.8495752648505, 4308.46144231971, 5816.76732930678, 6186.752529898934, 6228.128062071223, 6228.781992630236, 6229.345918678655, 5942.692607626315, 5960.5827592068135, 5966.49284810796, 5970.641761494324, 5996.820095397145, 5816.70916454184, 5967.791127310524, 5969.985157495437, 5970.522358211246, 5995.250593675791, 5549.611527193219, 5775.884482310246, 5778.017736984639, 5801.6519008859605, 5822.214001109796, 5923.85190370227, 5940.613860099253, 5969.76120955157, 6061.605995610271, 6074.787382441594, 5686.402927692533, 5836.620619659709, 5837.591368604327, 5853.882922341614, 5858.179854820243], "value": 4522.17508283717, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.6245771257966, 694.642259236493, 748.2592233688648, 763.1529002806883, 848.3679658654304, 15177.089374637515, 15616.063036217807, 15692.921535392335, 15703.371865125395, 15790.36838526459, 14695.191764452977, 14839.183844888526, 14905.478308259213, 14915.254237288147, 14918.552443426688, 666.0508774995612, 772.142921357293, 784.3764207455087, 787.6927998080753, 791.540906274361, 793.7698067560401, 794.6622685358728, 799.7440818937943, 800.7837883771379, 801.286854699318, 856.7429771068686, 856.7729551668813, 859.4113032572676, 859.4284800607588, 859.9355048371366, 844.5650489997656, 855.2260204514924, 856.4775486952954, 856.6873091321685, 856.734412332179, 616.5252755378378, 618.3476432363855, 619.9473044791198, 620.407510827159, 620.6214209332304, 14565.92717036408, 14582.708345833023, 14596.197209153492, 14607.415703371853, 14611.196384198865, 15206.695866082728, 15299.011128553328, 15369.154696491689, 15409.152496612682, 15776.211189440482, 12219.389030548436, 12288.324142172178, 12404.75190496185, 12437.0, 12471.625851224388, 3917.7257591968573, 3951.288768021755, 4034.7492277394103, 4053.837846486137, 4066.552679205285, 73432.0, 73512.63243683748, 73921.0, 78160.60919695365, 78172.60913695395, 11726.0, 11876.406179690981, 11923.76152476963, 11954.641360759191, 12161.027117830552, 22609.095636174698, 22660.433489162904, 22745.545089098458, 22747.88626056859, 22794.43013924665, 8457.407981441364, 8562.871556926651, 8577.485350878967, 8701.782455438664, 8721.956390218009, 4669.2062349400685, 4709.505501922249, 4739.857804265877, 4790.353302304214, 4823.782929768169, 3545.556805399325, 3665.743397962117, 3673.44898265257, 3677.3932301170007, 3698.1679122197293, 576.2134686153371, 596.8011458581997, 606.5784279925498, 609.7987664070846, 611.5780111722897, 596.7374355283748, 605.6335916770379, 652.9804105876831, 728.2317155401103, 773.6982576795054, 9754.829420469589, 10041.548130334153, 10090.899091008996, 10231.0, 10330.845037324447, 566.6769941133597, 645.470714014513, 646.867392184601, 745.2249660353281, 746.4028776978396, 4540.568645978627, 4793.9280910786365, 4849.114257753998, 4859.1960184912305, 4912.803487860517, 114733.0, 119119.0, 119224.0, 120163.0, 121977.39011305064, 85179.57410212909, 94820.52589737007, 95299.52350238204, 95828.52085739527, 96709.51645241729, 88331.0, 88428.5578572103, 88710.0, 89321.9999999987, 90752.0, 9187.448753074837, 9326.997238324973, 9341.392809467363, 9500.47747373901, 9540.602695091218, 38721.806390968995, 38919.0, 53153.7342313286, 53947.0, 55663.443365567444, 71604.64197678979, 73014.0, 80937.59531202307, 82401.0, 82814.0, 11373.943130284295, 11776.11679124052, 11835.112366572714, 11978.880211197777, 12569.748605028031, 12942.870571294166, 12999.870001299865, 13001.674958126123, 13081.495628002522, 13847.515336963157, 12476.625701228977, 12778.828351633134, 12913.289769062792, 12923.483060677467, 13388.129771564818, 12662.683432914251, 12863.871361286267, 12880.227186368847, 12903.09678322546, 12996.220226786423, 12707.745845082862, 12714.745705086032, 13179.868201317864, 13333.333333333489, 13333.399996999964, 10109.443980581138, 10396.896031039592, 10656.555379644884, 10935.56257749681, 11247.268927519684, 10443.0, 10643.254972151875, 10762.300450470695, 10961.232713710282, 11013.118950483782], "value": 7481.329438889654, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 111.0, 110.0, 112.0, 110.0, 110.0, 109.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 126.0, 150.0, 181.0, 131.0, 159.0, 162.0, 127.0, 184.0, 126.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 163.0, 165.0, 168.0, 161.0, 167.0, 161.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 76.0, 156.0, 76.0, 76.0, 76.0, 74.0, 176.0, 75.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 141.0, 84.0, 85.0, 84.0, 140.0, 86.0, 84.0, 156.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 151.0, 146.0, 147.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 97.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 55.0, 55.0, 54.0, 55.0, 53.0, 53.0, 53.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 62.0, 62.0, 62.0, 65.0, 61.0, 61.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 79.0, 81.0, 81.0, 80.0, 81.0, 109.0, 83.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 125.0, 133.0, 132.0, 126.0, 125.0, 128.0, 123.0, 127.0, 133.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 158.0, 160.0, 165.0, 161.0, 159.0, 169.0, 166.0, 158.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 64.0, 66.0, 62.0, 64.0, 62.0, 62.0, 64.0], "value": 63.6, "unit": "score"}]}]} 05:58:06 INFO - Return code: 0 05:58:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:58:06 ERROR - # TBPL SUCCESS # 05:58:06 INFO - Running post-action listener: _resource_record_post_action 05:58:06 INFO - ##### 05:58:06 INFO - ##### Finished run-tests step (success) 05:58:06 INFO - ##### 05:58:06 INFO - Running post-run listener: _resource_record_post_run 05:58:06 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 16384; Write bytes: 541847552; Read time: 264; Write time: 468692 05:58:06 INFO - TinderboxPrint: CPU usage
13.4% 05:58:06 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 264 05:58:06 INFO - TinderboxPrint: I/O write bytes / time
541,847,552 / 468,692 05:58:06 INFO - TinderboxPrint: CPU idle
8,229.1 (86.5%) 05:58:06 INFO - TinderboxPrint: CPU user
1,222.1 (12.9%) 05:58:06 INFO - TinderboxPrint: Swap in / out
0 / 0 05:58:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248315904; Read time: 16; Write time: 265536 05:58:06 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 12288; Write bytes: 292806656; Read time: 248; Write time: 203108 05:58:07 INFO - Running post-run listener: _upload_blobber_files 05:58:07 INFO - Blob upload gear active. 05:58:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:58:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:58:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:58:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:58:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:58:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:58:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:11 INFO - (blobuploader) - INFO - Done attempting. 05:58:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:58:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:58:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:12 INFO - (blobuploader) - INFO - Done attempting. 05:58:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:58:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:58:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:13 INFO - (blobuploader) - INFO - Done attempting. 05:58:13 INFO - (blobuploader) - INFO - Iteration through files over. 05:58:13 INFO - Return code: 0 05:58:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:58:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:58:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce8fe81943422966c0c1a21691f5cfcaae30be77ffd2f2d455f0a4ae3c0ffee2c27448786023f8e76a109403fafff40dc41ee0014d5c4aa0e2bf709b1ed968dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01ea9568c4476bcb356e012377ccb46b994f5cd1e0b785f286e3659fdccabc0d628e1e1475b43bf34ba72c9eb156a138f7d6d7569ea6b65c193c767db710ca70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac2f69b88d9bd8d374d65051383f9c313782da26ea9c1db38611eccc953270afdd8b202ebd2673fc6773532c4fe163a8bef63185123a3b5a922ad61a77c54759"} 05:58:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:58:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:58:13 INFO - Contents: 05:58:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce8fe81943422966c0c1a21691f5cfcaae30be77ffd2f2d455f0a4ae3c0ffee2c27448786023f8e76a109403fafff40dc41ee0014d5c4aa0e2bf709b1ed968dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01ea9568c4476bcb356e012377ccb46b994f5cd1e0b785f286e3659fdccabc0d628e1e1475b43bf34ba72c9eb156a138f7d6d7569ea6b65c193c767db710ca70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac2f69b88d9bd8d374d65051383f9c313782da26ea9c1db38611eccc953270afdd8b202ebd2673fc6773532c4fe163a8bef63185123a3b5a922ad61a77c54759"} 05:58:13 INFO - Running post-run listener: copy_logs_to_upload_dir 05:58:13 INFO - Copying logs to upload dir... 05:58:13 INFO - mkdir: /builds/slave/test/build/upload/logs 05:58:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.267093 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-12 05:58:12.853790) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-12 05:58:12.857163) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362 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/ce8fe81943422966c0c1a21691f5cfcaae30be77ffd2f2d455f0a4ae3c0ffee2c27448786023f8e76a109403fafff40dc41ee0014d5c4aa0e2bf709b1ed968dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01ea9568c4476bcb356e012377ccb46b994f5cd1e0b785f286e3659fdccabc0d628e1e1475b43bf34ba72c9eb156a138f7d6d7569ea6b65c193c767db710ca70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac2f69b88d9bd8d374d65051383f9c313782da26ea9c1db38611eccc953270afdd8b202ebd2673fc6773532c4fe163a8bef63185123a3b5a922ad61a77c54759"} build_url:https://queue.taskcluster.net/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/EwAc_r3KRK2t6qZNaz7SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce8fe81943422966c0c1a21691f5cfcaae30be77ffd2f2d455f0a4ae3c0ffee2c27448786023f8e76a109403fafff40dc41ee0014d5c4aa0e2bf709b1ed968dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01ea9568c4476bcb356e012377ccb46b994f5cd1e0b785f286e3659fdccabc0d628e1e1475b43bf34ba72c9eb156a138f7d6d7569ea6b65c193c767db710ca70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac2f69b88d9bd8d374d65051383f9c313782da26ea9c1db38611eccc953270afdd8b202ebd2673fc6773532c4fe163a8bef63185123a3b5a922ad61a77c54759"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-12 05:58:12.883201) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 05:58:12.883587) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1465732891.555748-1090870362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004739 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 05:58:12.967750) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-12 05:58:12.968120) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-12 05:58:12.968439) ========= ========= Total master_lag: 0.18 =========