builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1465514194.67 results: success (0) buildid: 20160609133009 builduid: 3af3af3b7a99412dbde1fb2824436ce6 revision: 3ccccf8e5036179a3178437cabc154b5e04b333d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 16:16:34.669046) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 16:16:34.669572) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 16:16:34.669852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 16:16:34.684052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:16:34.684420) ========= 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=db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 16:16:34-- 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% 25.2M=0s 2016-06-09 16:16:34 (25.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081617 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:16:34.779836) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:16:34.780153) ========= 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=db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017478 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:16:34.830148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:16:34.830507) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3ccccf8e5036179a3178437cabc154b5e04b333d --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 3ccccf8e5036179a3178437cabc154b5e04b333d --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=db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 16:16:35,038 truncating revision to first 12 chars 2016-06-09 16:16:35,038 Setting DEBUG logging. 2016-06-09 16:16:35,038 attempt 1/10 2016-06-09 16:16:35,038 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3ccccf8e5036?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 16:16:35,362 unpacking tar archive at: mozilla-central-3ccccf8e5036/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672489 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:16:35.516206) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 16:16:35.516539) ========= script_repo_revision: 3ccccf8e5036179a3178437cabc154b5e04b333d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 16:16:35.516938) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 16:16:35.517203) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 16:16:35.525800) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-09 16:16:35.526100) ========= /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=db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:16:35 INFO - MultiFileLogger online at 20160609 16:16:35 in /builds/slave/test 16:16:35 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 16:16:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:16:35 INFO - {'append_to_log': False, 16:16:35 INFO - 'base_work_dir': '/builds/slave/test', 16:16:35 INFO - 'blob_upload_branch': 'Firefox', 16:16:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:16:35 INFO - 'branch': 'Firefox', 16:16:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:16:35 INFO - 'config_files': ('talos/linux_config.py',), 16:16:35 INFO - 'default_actions': ('clobber', 16:16:35 INFO - 'read-buildbot-config', 16:16:35 INFO - 'download-and-extract', 16:16:35 INFO - 'populate-webroot', 16:16:35 INFO - 'create-virtualenv', 16:16:35 INFO - 'install', 16:16:35 INFO - 'run-tests'), 16:16:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:16:35 INFO - 'download_minidump_stackwalk': True, 16:16:35 INFO - 'download_symbols': 'ondemand', 16:16:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:16:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:16:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:16:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:16:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:16:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:16:35 INFO - 'installer_path': 'installer.exe', 16:16:35 INFO - 'log_level': 'info', 16:16:35 INFO - 'log_name': 'talos', 16:16:35 INFO - 'log_to_console': True, 16:16:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:16:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:16:35 INFO - 'opt_config_files': (), 16:16:35 INFO - 'pip_index': False, 16:16:35 INFO - 'sps_profile': False, 16:16:35 INFO - 'sps_profile_interval': 0, 16:16:35 INFO - 'suite': 'dromaeojs-e10s', 16:16:35 INFO - 'system_bits': '32', 16:16:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:16:35 INFO - 'title': 'talos-linux64-ix-031', 16:16:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:16:35 INFO - 'use_talos_json': True, 16:16:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:16:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:16:35 INFO - 'work_dir': 'build'} 16:16:35 INFO - ##### 16:16:35 INFO - ##### Running clobber step. 16:16:35 INFO - ##### 16:16:35 INFO - Running pre-action listener: _resource_record_pre_action 16:16:35 INFO - Running main action method: clobber 16:16:35 INFO - rmtree: /builds/slave/test/build 16:16:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:16:36 INFO - Running post-action listener: _resource_record_post_action 16:16:36 INFO - ##### 16:16:36 INFO - ##### Finished clobber step (success) 16:16:36 INFO - ##### 16:16:36 INFO - ##### 16:16:36 INFO - ##### Running read-buildbot-config step. 16:16:36 INFO - ##### 16:16:36 INFO - Running pre-action listener: _resource_record_pre_action 16:16:36 INFO - Running main action method: read_buildbot_config 16:16:36 INFO - Using buildbot properties: 16:16:36 INFO - { 16:16:36 INFO - "project": "", 16:16:36 INFO - "product": "firefox", 16:16:36 INFO - "script_repo_revision": "production", 16:16:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:16:36 INFO - "repository": "", 16:16:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 16:16:36 INFO - "buildid": "20160609133009", 16:16:36 INFO - "pgo_build": "True", 16:16:36 INFO - "basedir": "/builds/slave/test", 16:16:36 INFO - "buildnumber": 65, 16:16:36 INFO - "slavename": "talos-linux64-ix-031", 16:16:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:16:36 INFO - "platform": "ubuntu64_hw", 16:16:36 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:16:36 INFO - "branch": "mozilla-central", 16:16:36 INFO - "repo_path": "mozilla-central", 16:16:36 INFO - "revision": "3ccccf8e5036179a3178437cabc154b5e04b333d", 16:16:36 INFO - "stage_platform": "linux64-pgo", 16:16:36 INFO - "builduid": "3af3af3b7a99412dbde1fb2824436ce6", 16:16:36 INFO - "slavebuilddir": "test" 16:16:36 INFO - } 16:16:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:16:36 INFO - Running post-action listener: _resource_record_post_action 16:16:36 INFO - ##### 16:16:36 INFO - ##### Finished read-buildbot-config step (success) 16:16:36 INFO - ##### 16:16:36 INFO - ##### 16:16:36 INFO - ##### Running download-and-extract step. 16:16:36 INFO - ##### 16:16:36 INFO - Running pre-action listener: _resource_record_pre_action 16:16:36 INFO - Running main action method: download_and_extract 16:16:36 INFO - mkdir: /builds/slave/test/build/tests 16:16: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')]} 16:16:36 INFO - https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:16:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:16:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:16:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/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 16:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/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 16:16:37 INFO - Downloaded 1361 bytes. 16:16:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:16:37 INFO - Using the following test package requirements: 16:16:37 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:16:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:16:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:16:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:37 INFO - u'jsshell-linux-x86_64.zip'], 16:16:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:16:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:16:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:16:37 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:16:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:16:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:16:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:16:37 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')]} 16:16:37 INFO - https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:16:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:16:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:16:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/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 16:16:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/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 16:16:38 INFO - Downloaded 24452789 bytes. 16:16: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'] 16:16: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 16:16:40 INFO - Return code: 0 16:16:40 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 16:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:40 INFO - https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:16:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:16:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:16:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/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 16:16:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/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 16:16:41 INFO - Downloaded 24452789 bytes. 16:16:41 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'] 16:16:41 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 16:16:42 INFO - Return code: 0 16:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:42 INFO - https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:16:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:16:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:16:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/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 16:16:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/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 16:16:43 INFO - Downloaded 10833377 bytes. 16:16:43 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'] 16:16:43 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 16:16:43 INFO - Return code: 0 16:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:43 INFO - https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:16:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:16:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:16:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/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 16:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/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 16:16:45 INFO - Downloaded 59328660 bytes. 16:16:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:16:45 INFO - mkdir: /builds/slave/test/properties 16:16:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:16:45 INFO - Writing to file /builds/slave/test/properties/build_url 16:16:45 INFO - Contents: 16:16:45 INFO - build_url:https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:16:47 INFO - Running post-action listener: _resource_record_post_action 16:16:47 INFO - Running post-action listener: set_extra_try_arguments 16:16:47 INFO - ##### 16:16:47 INFO - ##### Finished download-and-extract step (success) 16:16:47 INFO - ##### 16:16:47 INFO - ##### 16:16:47 INFO - ##### Running populate-webroot step. 16:16:47 INFO - ##### 16:16:47 INFO - Running pre-action listener: _resource_record_pre_action 16:16:47 INFO - Running main action method: populate_webroot 16:16:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:16:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:16:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:16:47 INFO - '--tppagecycles', 16:16:47 INFO - '7'], 16:16:47 INFO - 'tests': ['tsvgm']}}, 16:16:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:16:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:16:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:16:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:16:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:16:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:16:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:47 INFO - 'talos_options': ['--disable-e10s'], 16:16:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:47 INFO - 'talos_options': ['--disable-e10s'], 16:16:47 INFO - 'tests': ['damp', 'tps']}, 16:16:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:47 INFO - 'tests': ['damp', 'tps']}, 16:16:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:16:47 INFO - 'tests': ['dromaeo_dom']}, 16:16:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:16:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:16:47 INFO - 'tests': ['a11yr', 16:16:47 INFO - 'ts_paint', 16:16:47 INFO - 'tpaint', 16:16:47 INFO - 'sessionrestore', 16:16:47 INFO - 'sessionrestore_no_auto_restore', 16:16:47 INFO - 'tabpaint']}, 16:16:47 INFO - 'other-e10s': {'tests': ['a11yr', 16:16:47 INFO - 'ts_paint', 16:16:47 INFO - 'tpaint', 16:16:47 INFO - 'sessionrestore', 16:16:47 INFO - 'sessionrestore_no_auto_restore', 16:16:47 INFO - 'tabpaint']}, 16:16:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:16:47 INFO - 'ts_paint', 16:16:47 INFO - 'tpaint', 16:16:47 INFO - 'sessionrestore', 16:16:47 INFO - 'sessionrestore_no_auto_restore', 16:16:47 INFO - 'tabpaint']}, 16:16:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:16:47 INFO - 'ts_paint', 16:16:47 INFO - 'tpaint', 16:16:47 INFO - 'sessionrestore', 16:16:47 INFO - 'sessionrestore_no_auto_restore', 16:16:47 INFO - 'tabpaint']}, 16:16:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:16:47 INFO - 'tests': ['a11yr', 16:16:47 INFO - 'ts_paint', 16:16:47 INFO - 'tpaint', 16:16:47 INFO - 'sessionrestore', 16:16:47 INFO - 'sessionrestore_no_auto_restore', 16:16:47 INFO - 'tabpaint']}, 16:16:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:16:47 INFO - 'tests': ['a11yr', 16:16:47 INFO - 'ts_paint', 16:16:47 INFO - 'tpaint', 16:16:47 INFO - 'sessionrestore', 16:16:47 INFO - 'sessionrestore_no_auto_restore', 16:16:47 INFO - 'tabpaint']}, 16:16:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:16:47 INFO - 'tests': ['tsvgx', 16:16:47 INFO - 'tsvgr_opacity', 16:16:47 INFO - 'tart', 16:16:47 INFO - 'tscrollx', 16:16:47 INFO - 'cart']}, 16:16:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:16:47 INFO - 'tsvgr_opacity', 16:16:47 INFO - 'tart', 16:16:47 INFO - 'tscrollx', 16:16:47 INFO - 'cart']}, 16:16:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:47 INFO - 'talos_options': ['--disable-e10s'], 16:16:47 INFO - 'tests': ['tp5o']}, 16:16:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:47 INFO - 'tests': ['tp5o']}, 16:16:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:47 INFO - 'talos_options': ['--disable-e10s', 16:16:47 INFO - '--xperf_path', 16:16:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:47 INFO - 'tests': ['tp5n']}, 16:16:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:47 INFO - 'talos_options': ['--xperf_path', 16:16:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:47 INFO - 'tests': ['tp5n']}}, 16:16:47 INFO - 'talos.zip': {'path': '', 16:16:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:16:47 INFO - Running post-action listener: _resource_record_post_action 16:16:47 INFO - ##### 16:16:47 INFO - ##### Finished populate-webroot step (success) 16:16:47 INFO - ##### 16:16:47 INFO - ##### 16:16:47 INFO - ##### Running create-virtualenv step. 16:16:47 INFO - ##### 16:16:47 INFO - Running pre-action listener: _resource_record_pre_action 16:16:47 INFO - Running main action method: create_virtualenv 16:16:47 INFO - Creating virtualenv /builds/slave/test/build/venv 16:16:47 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 16:16:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:16:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:16:47 INFO - Using real prefix '/usr' 16:16:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:16:47 INFO - Installing distribute.............................................................................................................................................................................................done. 16:16:49 INFO - Installing pip.................done. 16:16:49 INFO - Return code: 0 16:16:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:49 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 0x7fd76b6b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113ed00>, '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 0x113fab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113ff60>, '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': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', '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 16:16:49 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 16:16:49 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 16:16:49 INFO - Using env: {'DISPLAY': ':0', 16:16:49 INFO - 'HOME': '/home/cltbld', 16:16:49 INFO - 'LANG': 'en_US.UTF-8', 16:16:49 INFO - 'LANGUAGE': 'en_US:en', 16:16:49 INFO - 'LOGNAME': 'cltbld', 16:16:49 INFO - 'MAIL': '/var/mail/cltbld', 16:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:49 INFO - 'MOZ_NO_REMOTE': '1', 16:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:49 INFO - 'NO_EM_RESTART': '1', 16:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:49 INFO - 'PWD': '/builds/slave/test', 16:16:49 INFO - 'SHELL': '/bin/bash', 16:16:49 INFO - 'SHLVL': '1', 16:16:49 INFO - 'TERM': 'linux', 16:16:49 INFO - 'TMOUT': '86400', 16:16:49 INFO - 'USER': 'cltbld', 16:16:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', 16:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:49 INFO - '_': '/tools/buildbot/bin/python'} 16:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:49 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 16:16:49 INFO - Cleaning up... 16:16:49 INFO - Return code: 0 16:16:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:49 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 0x7fd76b6b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113ed00>, '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 0x113fab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113ff60>, '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': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', '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 16:16:49 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 16:16:49 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 16:16:49 INFO - Using env: {'DISPLAY': ':0', 16:16:49 INFO - 'HOME': '/home/cltbld', 16:16:49 INFO - 'LANG': 'en_US.UTF-8', 16:16:49 INFO - 'LANGUAGE': 'en_US:en', 16:16:49 INFO - 'LOGNAME': 'cltbld', 16:16:49 INFO - 'MAIL': '/var/mail/cltbld', 16:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:49 INFO - 'MOZ_NO_REMOTE': '1', 16:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:49 INFO - 'NO_EM_RESTART': '1', 16:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:49 INFO - 'PWD': '/builds/slave/test', 16:16:49 INFO - 'SHELL': '/bin/bash', 16:16:49 INFO - 'SHLVL': '1', 16:16:49 INFO - 'TERM': 'linux', 16:16:49 INFO - 'TMOUT': '86400', 16:16:49 INFO - 'USER': 'cltbld', 16:16:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', 16:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:49 INFO - '_': '/tools/buildbot/bin/python'} 16:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:50 INFO - Downloading/unpacking psutil>=3.1.1 16:16:50 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 16:16:50 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 16:16:50 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 16:16:50 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 16:16:50 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 16:16:50 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 16:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:16:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:52 INFO - Installing collected packages: psutil 16:16:52 INFO - Running setup.py install for psutil 16:16:52 INFO - building 'psutil._psutil_linux' extension 16:16:52 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 16:16:52 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 16:16:52 INFO - building 'psutil._psutil_posix' extension 16:16:52 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 16:16:52 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 16:16:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:52 INFO - Successfully installed psutil 16:16:52 INFO - Cleaning up... 16:16:52 INFO - Return code: 0 16:16:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:16: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')]} 16:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd76b6b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113ed00>, '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 0x113fab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113ff60>, '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': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', '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 16:16: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:16: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 mozsystemmonitor==0.3 16:16:52 INFO - Using env: {'DISPLAY': ':0', 16:16:52 INFO - 'HOME': '/home/cltbld', 16:16:52 INFO - 'LANG': 'en_US.UTF-8', 16:16:52 INFO - 'LANGUAGE': 'en_US:en', 16:16:52 INFO - 'LOGNAME': 'cltbld', 16:16:52 INFO - 'MAIL': '/var/mail/cltbld', 16:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:52 INFO - 'MOZ_NO_REMOTE': '1', 16:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:52 INFO - 'NO_EM_RESTART': '1', 16:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:52 INFO - 'PWD': '/builds/slave/test', 16:16:52 INFO - 'SHELL': '/bin/bash', 16:16:52 INFO - 'SHLVL': '1', 16:16:52 INFO - 'TERM': 'linux', 16:16:52 INFO - 'TMOUT': '86400', 16:16:52 INFO - 'USER': 'cltbld', 16:16:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', 16:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:52 INFO - '_': '/tools/buildbot/bin/python'} 16:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:16:54 INFO - Installing collected packages: mozsystemmonitor 16:16:54 INFO - Running setup.py install for mozsystemmonitor 16:16:54 INFO - Successfully installed mozsystemmonitor 16:16:54 INFO - Cleaning up... 16:16:54 INFO - Return code: 0 16:16:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:54 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 0x7fd76b6b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113ed00>, '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 0x113fab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113ff60>, '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': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', '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 16:16:54 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 16:16:54 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 16:16:54 INFO - Using env: {'DISPLAY': ':0', 16:16:54 INFO - 'HOME': '/home/cltbld', 16:16:54 INFO - 'LANG': 'en_US.UTF-8', 16:16:54 INFO - 'LANGUAGE': 'en_US:en', 16:16:54 INFO - 'LOGNAME': 'cltbld', 16:16:54 INFO - 'MAIL': '/var/mail/cltbld', 16:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:54 INFO - 'MOZ_NO_REMOTE': '1', 16:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:54 INFO - 'NO_EM_RESTART': '1', 16:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:54 INFO - 'PWD': '/builds/slave/test', 16:16:54 INFO - 'SHELL': '/bin/bash', 16:16:54 INFO - 'SHLVL': '1', 16:16:54 INFO - 'TERM': 'linux', 16:16:54 INFO - 'TMOUT': '86400', 16:16:54 INFO - 'USER': 'cltbld', 16:16:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', 16:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:54 INFO - '_': '/tools/buildbot/bin/python'} 16:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:55 INFO - Downloading/unpacking jsonschema==2.5.1 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:16:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:57 INFO - Downloading functools32-3.2.3-2.tar.gz 16:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:16:57 INFO - warning: no files found matching '*.txt' 16:16:57 INFO - no previously-included directories found matching 'build' 16:16:57 INFO - no previously-included directories found matching 'dist' 16:16:57 INFO - no previously-included directories found matching '.git*' 16:16:57 INFO - Installing collected packages: jsonschema, functools32 16:16:57 INFO - Running setup.py install for functools32 16:16:57 INFO - warning: no files found matching '*.txt' 16:16:57 INFO - no previously-included directories found matching 'build' 16:16:57 INFO - no previously-included directories found matching 'dist' 16:16:57 INFO - no previously-included directories found matching '.git*' 16:16:57 INFO - Successfully installed jsonschema functools32 16:16:57 INFO - Cleaning up... 16:16:57 INFO - Return code: 0 16:16:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:16: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')]} 16:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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', '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 0x7fd76b6b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113ed00>, '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 0x113fab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113ff60>, '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': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', '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 16:16: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:16: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 blobuploader==1.2.4 16:16:57 INFO - Using env: {'DISPLAY': ':0', 16:16:57 INFO - 'HOME': '/home/cltbld', 16:16:57 INFO - 'LANG': 'en_US.UTF-8', 16:16:57 INFO - 'LANGUAGE': 'en_US:en', 16:16:57 INFO - 'LOGNAME': 'cltbld', 16:16:57 INFO - 'MAIL': '/var/mail/cltbld', 16:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:57 INFO - 'MOZ_NO_REMOTE': '1', 16:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:57 INFO - 'NO_EM_RESTART': '1', 16:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:57 INFO - 'PWD': '/builds/slave/test', 16:16:57 INFO - 'SHELL': '/bin/bash', 16:16:57 INFO - 'SHLVL': '1', 16:16:57 INFO - 'TERM': 'linux', 16:16:57 INFO - 'TMOUT': '86400', 16:16:57 INFO - 'USER': 'cltbld', 16:16:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', 16:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:57 INFO - '_': '/tools/buildbot/bin/python'} 16:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:57 INFO - Downloading/unpacking blobuploader==1.2.4 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16:59 INFO - Downloading blobuploader-1.2.4.tar.gz 16:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:16:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:17:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17:00 INFO - Downloading docopt-0.6.1.tar.gz 16:17:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:17:00 INFO - Installing collected packages: blobuploader, requests, docopt 16:17:00 INFO - Running setup.py install for blobuploader 16:17:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:17:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:17:00 INFO - Running setup.py install for requests 16:17:00 INFO - Running setup.py install for docopt 16:17:00 INFO - Successfully installed blobuploader requests docopt 16:17:00 INFO - Cleaning up... 16:17:00 INFO - Return code: 0 16:17:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:17: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')]} 16:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17: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')]} 16:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:00 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 0x7fd76b6b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113ed00>, '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 0x113fab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113ff60>, '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': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', '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 16:17:00 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 16:17:00 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 16:17:00 INFO - Using env: {'DISPLAY': ':0', 16:17:00 INFO - 'HOME': '/home/cltbld', 16:17:00 INFO - 'LANG': 'en_US.UTF-8', 16:17:00 INFO - 'LANGUAGE': 'en_US:en', 16:17:00 INFO - 'LOGNAME': 'cltbld', 16:17:00 INFO - 'MAIL': '/var/mail/cltbld', 16:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:00 INFO - 'MOZ_NO_REMOTE': '1', 16:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:00 INFO - 'NO_EM_RESTART': '1', 16:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:00 INFO - 'PWD': '/builds/slave/test', 16:17:00 INFO - 'SHELL': '/bin/bash', 16:17:00 INFO - 'SHLVL': '1', 16:17:00 INFO - 'TERM': 'linux', 16:17:00 INFO - 'TMOUT': '86400', 16:17:00 INFO - 'USER': 'cltbld', 16:17:00 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', 16:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:00 INFO - '_': '/tools/buildbot/bin/python'} 16:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:17:01 INFO - Running setup.py (path:/tmp/pip-NAzr0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:17:01 INFO - Running setup.py (path:/tmp/pip-8imoaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:17:01 INFO - Running setup.py (path:/tmp/pip-8QAhgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:17:01 INFO - Running setup.py (path:/tmp/pip-IjSv18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:17:01 INFO - Running setup.py (path:/tmp/pip-e_KTjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:17:01 INFO - Running setup.py (path:/tmp/pip-LrVxg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:17:01 INFO - Running setup.py (path:/tmp/pip-GByy6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:17:01 INFO - Running setup.py (path:/tmp/pip-Y25LNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:17:01 INFO - Running setup.py (path:/tmp/pip-OdDOyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:17:01 INFO - Running setup.py (path:/tmp/pip-6GIGbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:17:01 INFO - Running setup.py (path:/tmp/pip-l6UNp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:17:01 INFO - Running setup.py (path:/tmp/pip-b4dBfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:17:01 INFO - Running setup.py (path:/tmp/pip-ZiXP_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:17:02 INFO - Running setup.py (path:/tmp/pip-eziuCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:02 INFO - Running setup.py (path:/tmp/pip-zfTQjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:17:02 INFO - Running setup.py (path:/tmp/pip-7Slai7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:17:02 INFO - Running setup.py (path:/tmp/pip-n70GJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:17:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:17:02 INFO - Running setup.py install for manifestparser 16:17:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:17:02 INFO - Running setup.py install for mozcrash 16:17:02 INFO - Running setup.py install for mozdebug 16:17:02 INFO - Running setup.py install for mozdevice 16:17:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:17:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:17:02 INFO - Running setup.py install for mozfile 16:17:02 INFO - Running setup.py install for mozhttpd 16:17:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:17:02 INFO - Running setup.py install for mozinfo 16:17:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:17:03 INFO - Running setup.py install for mozInstall 16:17:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:17:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:17:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:17:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:17:03 INFO - Running setup.py install for mozleak 16:17:03 INFO - Running setup.py install for mozlog 16:17:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:17:03 INFO - Running setup.py install for moznetwork 16:17:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:17:03 INFO - Running setup.py install for mozprocess 16:17:03 INFO - Running setup.py install for mozprofile 16:17:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:17:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:17:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:17:03 INFO - Running setup.py install for mozrunner 16:17:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:17:03 INFO - Running setup.py install for mozscreenshot 16:17:03 INFO - Running setup.py install for moztest 16:17:04 INFO - Running setup.py install for mozversion 16:17:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:17:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:17:04 INFO - Cleaning up... 16:17:04 INFO - Return code: 0 16:17:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:17:04 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')]} 16:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:04 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')]} 16:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:04 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 0x7fd76b6b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113ed00>, '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 0x113fab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113ff60>, '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': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', '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 16:17:04 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 16:17:04 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 16:17:04 INFO - Using env: {'DISPLAY': ':0', 16:17:04 INFO - 'HOME': '/home/cltbld', 16:17:04 INFO - 'LANG': 'en_US.UTF-8', 16:17:04 INFO - 'LANGUAGE': 'en_US:en', 16:17:04 INFO - 'LOGNAME': 'cltbld', 16:17:04 INFO - 'MAIL': '/var/mail/cltbld', 16:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:04 INFO - 'MOZ_NO_REMOTE': '1', 16:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:04 INFO - 'NO_EM_RESTART': '1', 16:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:04 INFO - 'PWD': '/builds/slave/test', 16:17:04 INFO - 'SHELL': '/bin/bash', 16:17:04 INFO - 'SHLVL': '1', 16:17:04 INFO - 'TERM': 'linux', 16:17:04 INFO - 'TMOUT': '86400', 16:17:04 INFO - 'USER': 'cltbld', 16:17:04 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', 16:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:04 INFO - '_': '/tools/buildbot/bin/python'} 16:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:17:04 INFO - Running setup.py (path:/tmp/pip-GWBPiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:17:04 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)) 16:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:17:04 INFO - Running setup.py (path:/tmp/pip-1HDcwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:17:04 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)) 16:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:17:04 INFO - Running setup.py (path:/tmp/pip-Gl2eIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:17:04 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)) 16:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:17:04 INFO - Running setup.py (path:/tmp/pip-nh2Lmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:17:04 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)) 16:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:17:04 INFO - Running setup.py (path:/tmp/pip-iNvK0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:17:04 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)) 16:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:17:04 INFO - Running setup.py (path:/tmp/pip-wirpKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:17:04 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)) 16:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:17:04 INFO - Running setup.py (path:/tmp/pip-ZCBTwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:17:04 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)) 16:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:17:04 INFO - Running setup.py (path:/tmp/pip-J6LP4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:17:04 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)) 16:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:17:04 INFO - Running setup.py (path:/tmp/pip-luMOWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:17:05 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)) 16:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:17:05 INFO - Running setup.py (path:/tmp/pip-WYt59x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:17:05 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)) 16:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:17:05 INFO - Running setup.py (path:/tmp/pip-1vEljp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:17:05 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)) 16:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:17:05 INFO - Running setup.py (path:/tmp/pip-QyJdMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:17:05 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)) 16:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:17:05 INFO - Running setup.py (path:/tmp/pip-IA3XKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:17:05 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)) 16:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:17:05 INFO - Running setup.py (path:/tmp/pip-2EIGn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:17:05 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)) 16:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:05 INFO - Running setup.py (path:/tmp/pip-SaMjiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:05 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)) 16:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:17:05 INFO - Running setup.py (path:/tmp/pip-X6VY0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:17:05 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)) 16:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:17:05 INFO - Running setup.py (path:/tmp/pip-__M_0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:17:05 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)) 16:17:05 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)) 16:17:05 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)) 16:17:05 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)) 16:17:05 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)) 16:17:05 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)) 16:17:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:07 INFO - Downloading blessings-1.6.tar.gz 16:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:17:07 INFO - Installing collected packages: blessings 16:17:07 INFO - Running setup.py install for blessings 16:17:07 INFO - Successfully installed blessings 16:17:07 INFO - Cleaning up... 16:17:07 INFO - Return code: 0 16:17:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:17:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:17:08 INFO - Reading from file tmpfile_stdout 16:17:08 INFO - Current package versions: 16:17:08 INFO - argparse == 1.2.1 16:17:08 INFO - blessings == 1.6 16:17:08 INFO - blobuploader == 1.2.4 16:17:08 INFO - docopt == 0.6.1 16:17:08 INFO - functools32 == 3.2.3-2 16:17:08 INFO - jsonschema == 2.5.1 16:17:08 INFO - manifestparser == 1.1 16:17:08 INFO - mozInstall == 1.12 16:17:08 INFO - mozcrash == 0.17 16:17:08 INFO - mozdebug == 0.1 16:17:08 INFO - mozdevice == 0.48 16:17:08 INFO - mozfile == 1.2 16:17:08 INFO - mozhttpd == 0.7 16:17:08 INFO - mozinfo == 0.9 16:17:08 INFO - mozleak == 0.1 16:17:08 INFO - mozlog == 3.2 16:17:08 INFO - moznetwork == 0.27 16:17:08 INFO - mozprocess == 0.22 16:17:08 INFO - mozprofile == 0.28 16:17:08 INFO - mozrunner == 6.11 16:17:08 INFO - mozscreenshot == 0.1 16:17:08 INFO - mozsystemmonitor == 0.3 16:17:08 INFO - moztest == 0.7 16:17:08 INFO - mozversion == 1.4 16:17:08 INFO - psutil == 3.1.1 16:17:08 INFO - requests == 1.2.3 16:17:08 INFO - wsgiref == 0.1.2 16:17:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:17:08 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')]} 16:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:08 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')]} 16:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:08 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 0x7fd76b6b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113ed00>, '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 0x113fab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113ff60>, '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': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', '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 16:17:08 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 16:17:08 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 16:17:08 INFO - Using env: {'DISPLAY': ':0', 16:17:08 INFO - 'HOME': '/home/cltbld', 16:17:08 INFO - 'LANG': 'en_US.UTF-8', 16:17:08 INFO - 'LANGUAGE': 'en_US:en', 16:17:08 INFO - 'LOGNAME': 'cltbld', 16:17:08 INFO - 'MAIL': '/var/mail/cltbld', 16:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:08 INFO - 'MOZ_NO_REMOTE': '1', 16:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:08 INFO - 'NO_EM_RESTART': '1', 16:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:08 INFO - 'PWD': '/builds/slave/test', 16:17:08 INFO - 'SHELL': '/bin/bash', 16:17:08 INFO - 'SHLVL': '1', 16:17:08 INFO - 'TERM': 'linux', 16:17:08 INFO - 'TMOUT': '86400', 16:17:08 INFO - 'USER': 'cltbld', 16:17:08 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', 16:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:08 INFO - '_': '/tools/buildbot/bin/python'} 16:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:08 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)) 16:17:08 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)) 16:17:08 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)) 16:17:08 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)) 16:17:08 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)) 16:17:08 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)) 16:17:08 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)) 16:17:08 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)) 16:17:08 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)) 16:17:08 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)) 16:17:08 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)) 16:17:08 INFO - Cleaning up... 16:17:08 INFO - Return code: 0 16:17:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:17:08 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')]} 16:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:08 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')]} 16:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:08 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 0x7fd76b6b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113ed00>, '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 0x113fab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113ff60>, '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': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', '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 16:17:08 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 16:17:08 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 16:17:08 INFO - Using env: {'DISPLAY': ':0', 16:17:08 INFO - 'HOME': '/home/cltbld', 16:17:08 INFO - 'LANG': 'en_US.UTF-8', 16:17:08 INFO - 'LANGUAGE': 'en_US:en', 16:17:08 INFO - 'LOGNAME': 'cltbld', 16:17:08 INFO - 'MAIL': '/var/mail/cltbld', 16:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:08 INFO - 'MOZ_NO_REMOTE': '1', 16:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:08 INFO - 'NO_EM_RESTART': '1', 16:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:08 INFO - 'PWD': '/builds/slave/test', 16:17:08 INFO - 'SHELL': '/bin/bash', 16:17:08 INFO - 'SHLVL': '1', 16:17:08 INFO - 'TERM': 'linux', 16:17:08 INFO - 'TMOUT': '86400', 16:17:08 INFO - 'USER': 'cltbld', 16:17:08 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', 16:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:08 INFO - '_': '/tools/buildbot/bin/python'} 16:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:17:08 INFO - Cleaning up... 16:17:08 INFO - Return code: 0 16:17:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:17:08 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')]} 16:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:08 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')]} 16:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:08 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 0x7fd76b6b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113ed00>, '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 0x113fab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113ff60>, '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': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', '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 16:17:08 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 16:17:08 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 16:17:08 INFO - Using env: {'DISPLAY': ':0', 16:17:08 INFO - 'HOME': '/home/cltbld', 16:17:08 INFO - 'LANG': 'en_US.UTF-8', 16:17:08 INFO - 'LANGUAGE': 'en_US:en', 16:17:08 INFO - 'LOGNAME': 'cltbld', 16:17:08 INFO - 'MAIL': '/var/mail/cltbld', 16:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:08 INFO - 'MOZ_NO_REMOTE': '1', 16:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:08 INFO - 'NO_EM_RESTART': '1', 16:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:08 INFO - 'PWD': '/builds/slave/test', 16:17:08 INFO - 'SHELL': '/bin/bash', 16:17:08 INFO - 'SHLVL': '1', 16:17:08 INFO - 'TERM': 'linux', 16:17:08 INFO - 'TMOUT': '86400', 16:17:08 INFO - 'USER': 'cltbld', 16:17:08 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', 16:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:08 INFO - '_': '/tools/buildbot/bin/python'} 16:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:08 INFO - Downloading/unpacking flake8 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:17:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:17:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:17:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:17:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:17:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:17:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:17:11 INFO - no previously-included directories found matching 'docs/_build' 16:17:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:17:11 INFO - Running setup.py install for pep8 16:17:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:17:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:17:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:17:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:17:11 INFO - no previously-included directories found matching 'docs/_build' 16:17:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:17:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:17:11 INFO - Cleaning up... 16:17:11 INFO - Return code: 0 16:17:11 INFO - Running post-action listener: _resource_record_post_action 16:17:11 INFO - Running post-action listener: _start_resource_monitoring 16:17:11 INFO - Starting resource monitoring. 16:17:11 INFO - ##### 16:17:11 INFO - ##### Finished create-virtualenv step (success) 16:17:11 INFO - ##### 16:17:11 INFO - ##### 16:17:11 INFO - ##### Running install step. 16:17:11 INFO - ##### 16:17:11 INFO - Running pre-action listener: _resource_record_pre_action 16:17:11 INFO - Running main action method: install 16:17:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:17:11 INFO - Reading from file tmpfile_stdout 16:17:11 INFO - Detecting whether we're running mozinstall >=1.0... 16:17:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:17:11 INFO - Reading from file tmpfile_stdout 16:17:11 INFO - Output received: 16:17:11 INFO - Usage: mozinstall [options] installer 16:17:11 INFO - Options: 16:17:11 INFO - -h, --help show this help message and exit 16:17:11 INFO - -d DEST, --destination=DEST 16:17:11 INFO - Directory to install application into. [default: 16:17:11 INFO - "/builds/slave/test"] 16:17:11 INFO - --app=APP Application being installed. [default: firefox] 16:17:11 INFO - mkdir: /builds/slave/test/build/application 16:17:11 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'] 16:17:11 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 16:17:28 INFO - Reading from file tmpfile_stdout 16:17:28 INFO - Output received: 16:17:28 INFO - /builds/slave/test/build/application/firefox/firefox 16:17:28 INFO - Running post-action listener: _resource_record_post_action 16:17:28 INFO - ##### 16:17:28 INFO - ##### Finished install step (success) 16:17:28 INFO - ##### 16:17:28 INFO - ##### 16:17:28 INFO - ##### Running run-tests step. 16:17:28 INFO - ##### 16:17:28 INFO - Running pre-action listener: _resource_record_pre_action 16:17:28 INFO - Running main action method: run_tests 16:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:17:28 INFO - Python 2.7.3 16:17:28 INFO - Return code: 0 16:17:28 INFO - grabbing minidump binary from tooltool 16:17:28 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')]} 16:17:28 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 0x113ed00>, '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 0x113fab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113ff60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:17:28 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 16:17:28 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 16:17:28 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 16:17:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:17:28 INFO - Return code: 0 16:17:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:17:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:17:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:17:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:17:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:17:29 INFO - Return code: 0 16:17:29 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/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 16:17:29 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/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 16:17:29 INFO - Using env: {'DISPLAY': ':0', 16:17:29 INFO - 'HOME': '/home/cltbld', 16:17:29 INFO - 'LANG': 'en_US.UTF-8', 16:17:29 INFO - 'LANGUAGE': 'en_US:en', 16:17:29 INFO - 'LOGNAME': 'cltbld', 16:17:29 INFO - 'MAIL': '/var/mail/cltbld', 16:17:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:17:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:29 INFO - 'MOZ_NO_REMOTE': '1', 16:17:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:29 INFO - 'NO_EM_RESTART': '1', 16:17:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:29 INFO - 'PWD': '/builds/slave/test', 16:17:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:17:29 INFO - 'SHELL': '/bin/bash', 16:17:29 INFO - 'SHLVL': '1', 16:17:29 INFO - 'TERM': 'linux', 16:17:29 INFO - 'TMOUT': '86400', 16:17:29 INFO - 'USER': 'cltbld', 16:17:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989', 16:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:29 INFO - '_': '/tools/buildbot/bin/python'} 16:17:29 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/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 16:17:29 INFO - mozversion application_buildid: 20160609133009 16:17:29 INFO - mozversion application_changeset: 3ccccf8e5036179a3178437cabc154b5e04b333d 16:17:29 INFO - mozversion application_display_name: Nightly 16:17:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:17:29 INFO - mozversion application_name: Firefox 16:17:29 INFO - mozversion application_remotingname: firefox 16:17:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:17:29 INFO - mozversion application_vendor: Mozilla 16:17:29 INFO - mozversion application_version: 50.0a1 16:17:29 INFO - mozversion platform_buildid: 20160609133009 16:17:29 INFO - mozversion platform_changeset: 3ccccf8e5036179a3178437cabc154b5e04b333d 16:17:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:17:29 INFO - mozversion platform_version: 50.0a1 16:17:29 INFO - using testdate: 1465514249 16:17:29 INFO - actual date: 1465514249 16:17:29 INFO - starting webserver on 'localhost:45078' 16:17:29 INFO - SUITE-START | Running 2 tests 16:17:29 INFO - TEST-START | dromaeo_css 16:17:29 INFO - operating with platform_type : linux_ 16:17:29 INFO - Initialising browser for dromaeo_css test... 16:17:29 INFO - TEST-INFO | started process 16584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp22Gg4e/profile http://localhost:45078/getInfo.html) 16:17:34 INFO - PROCESS | 16584 | __metrics Screen width/height:1600/1200 16:17:34 INFO - PROCESS | 16584 | colorDepth:24 16:17:34 INFO - PROCESS | 16584 | Browser inner width/height: 1024/697 16:17:34 INFO - PROCESS | 16584 | __metrics 16:17:35 ERROR - PROCESS | 16584 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 16:17:36 INFO - TEST-INFO | 16584: exit 0 16:17:36 INFO - Browser initialized. 16:17:36 INFO - Running cycle 1/1 for dromaeo_css test... 16:17:36 INFO - TEST-INFO | started process 16704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp22Gg4e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:17:48 INFO - PROCESS | 16704 | RSS: Main: 184438784 16:17:48 INFO - PROCESS | 16704 | 16:18:37 INFO - PROCESS | 16704 | 1465514317794 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] 16:20:45 INFO - PROCESS | 16704 | Cycle 1(1): loaded http://localhost:45078/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45078/tests/dromaeo/cssquery-ext.html) 16:20:46 INFO - PROCESS | 16704 | RSS: Main: 188231680 16:20:46 INFO - PROCESS | 16704 | 16:23:48 INFO - PROCESS | 16704 | Cycle 1(1): loaded http://localhost:45078/tests/dromaeo/cssquery-ext.html (next: http://localhost:45078/tests/dromaeo/cssquery-jquery.html) 16:23:49 INFO - PROCESS | 16704 | RSS: Main: 187424768 16:23:49 INFO - PROCESS | 16704 | 16:26:51 INFO - PROCESS | 16704 | Cycle 1(1): loaded http://localhost:45078/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45078/tests/dromaeo/cssquery-mootools.html) 16:26:51 INFO - PROCESS | 16704 | RSS: Main: 187998208 16:26:51 INFO - PROCESS | 16704 | 16:29:53 INFO - PROCESS | 16704 | Cycle 1(1): loaded http://localhost:45078/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45078/tests/dromaeo/cssquery-prototype.html) 16:29:54 INFO - PROCESS | 16704 | RSS: Main: 185610240 16:29:54 INFO - PROCESS | 16704 | 16:32:56 INFO - PROCESS | 16704 | Cycle 1(1): loaded http://localhost:45078/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45078/tests/dromaeo/cssquery-yui.html) 16:32:57 INFO - PROCESS | 16704 | RSS: Main: 187129856 16:32:57 INFO - PROCESS | 16704 | 16:35:59 INFO - PROCESS | 16704 | Cycle 1(1): loaded http://localhost:45078/tests/dromaeo/cssquery-yui.html (next: http://localhost:45078/tests/dromaeo/cssquery-dojo.html) 16:35:59 INFO - PROCESS | 16704 | RSS: Main: 189534208 16:35:59 INFO - PROCESS | 16704 | 16:35:59 INFO - PROCESS | 16704 | __start_tp_report 16:35:59 INFO - PROCESS | 16704 | _x_x_mozilla_page_load 16:35:59 INFO - PROCESS | 16704 | _x_x_mozilla_page_load_details 16:35:59 INFO - PROCESS | 16704 | |i|pagename|runs| 16:35:59 INFO - PROCESS | 16704 | |0;dojo.html;3067.754579633629;3126.171564535398;3134.905952821416;3143.0256620447662;3168.19211101169;5440.727963601819;5492.066348720717;5501.834944951653;5544.500994910457;5549.417311182328;5368.46315368463;5481.917771233435;5485.533729632986;5506.449355064491;5564.221009058725;4843.128236917353;4921.876953076166;5001.499850015006;5021.397432308128;5069.974650126745;653.7331723404635;4852.344933433977;4946.1344264753525;4981.153203955337;5040.218766091243;4954.603631709455;4979.427365852919;4980.252962055721;4986.077575648498;4989.226669866177;5012.949870501285;5013.774380152902;5021.5229553192385;5022.27177059328;5032.798688052473;4948.826791062295;4963.553280204799;4991.5258050485145;5047.798088076473;5054.772535235923;5445.972770136124;5553;5566.192902029183;5586.91619625706;5618.15727640853;5736.2256095427;5841.85395365115;5842.649441033552;5856.970715146397;5867.325257595388;5798;5829.766809327664;5833.474987251126;5882.529397648221;5897.351291357947;5424.728763561846;5447.046766815831;5467.753951072212;5475.425080366544;5476.17857321401;5904.704764761745;5938.228030356113;5942.58401911862;5950.137230101611;5952.970235148797;5768.682722450221;5786.479216870502;5789;5794.913076303858;5853.912191317134;5876.236089308362;5881.323647780475;5881.676507792027;5882.088276317178;5889.793857215062;5657.886842263131;5725.083986562214;5743.339515955635;5842.386549412336;5859.296884373817;5742.626729262584;5755.510781583528;5783.913241301384;5796.88406231873;5817.447342502455;4460.241758900995;4460.799264033061;4461.286194208911;4474.39595654589;4490.708103973231;3935.8622448214173;3988.501437320335;3993.6405723484445;3995.760254384746;4027.4764280643913;5700.37295897451;5711.3146422428745;5723;5730.36965933747;5769.365369809318;6031.577789554689;6045.516358691294;6046.606970546988;6047.0929360596265;6052.66710330936;5578.944210557924;5588.966041282376;5598.412166722435;5616.719164041781;5650.576206784508;5059.974700126476;5077.339945807022;5080.034793389244;5087.669301495391;5120.462351453119;5938.8812223755285;6028.186194863637;6030.517558595302;6034.668093254913;6047.274327080779;5901.17383566301;5919.289685237799;5936.168936349001;5981.7607295707685;5989.610675306091;6083;6090.482309003784;6092.055731361646;6105.297890742444;6116.8776624468155;5657.32112146545;5789.884202315846;5821.738021789114;5825.213596164633;5857.384974577608;5915.438033386821;5986.790462333797;6018.8194354169445;6021.87956240864;6092.878142437038;5859.355470898283;5872.618279811799;5884.440978107073;5887.1757953885635;5891.94108058931;5649;5735.311762588516;5739.971300143639;5775.191473193672;5848.0350742127075;5598.524125449382;5710.2862142232225;5713.771449141987;5715.114157305624;5755.050416681201;5799.9130013049;5816.738246778989;5832.066869300891;5842.707864606838;5858.297004359504;5557.083081291542;5676;5717.285339332583;5769.826905192683;5777.3933736957015 16:35:59 INFO - PROCESS | 16704 | |1;ext.html;568.7042737776356;621.3382747374044;624.615861245334;645.0421124629923;646.8964965605504;38402.80798596007;42485.57514424855;42502.574974250245;42695.35956960648;42918.785406072966;42061.57938420615;42958.785206073924;43016.56983430165;43060.78469607647;43102;8768.430052046613;8936.910630893706;8947.50788706621;8955.283577313832;8959.596818143167;8855.690050848221;8866.069062748415;8925.285977121846;8945.821083578325;8961.283097352196;8892.8666070009;8950.015498295183;8964.775880603005;8997.05530919254;8998.59506322217;8855.645774169025;8875.911240887604;8922.955385223066;8956.373053886231;9006.504642244674;8847.247983921374;8886.466811991237;8936.821263574691;8944.418612790148;8985.23625491834;41034;41383.379249311285;41587;41597.584024159674;41643;3030.3484750778466;3332.3002169544425;3501.4047611906035;3836.827342769582;4158.771267580282;31216.37567248665;31249.218769530715;31726.841365793254;32645;34199.65800342015;4384.298512238027;4401.493828209765;4455.576720211575;4462.955370446286;4535.229011068126;350256;351653;351708;355710.22144889366;355725;61262.69368653128;62114;62187.37812621816;62302.68848655728;62311.37688623146;35665.46501802475;36288.81855590705;36530.26939461196;37039;37718.62281377206;16831.07429091387;16837.57906052334;16951.406700765416;16995.23521441538;17067.40264090751;12673.809892851614;12731.745365092645;12780.552680656132;12791.680207994688;12828.871711282954;19717.211311547377;19821.801781982285;19981;20048.69926951097;20131.597368052557;7147;7193.187610566408;7323.304286092813;7343.522671026366;7424.517406368569;966.1449617088927;1024.4212020208558;1035.6892932120334;1053.4732633683159;1107.7009207514088;32534.837325813693;32690.673093269237;32712;32758.672413275563;33148.66851331456;1100.3342977498658;1126.1835169502046;1176.012149794177;1186.4067966016992;1224.2837939805313;17083.231254593575;17367.56581085483;17408;17451.563710907074;17632.55918602045;564228;564777;566327;569151;569875;58217.70891145517;60157.09764353538;60445.395546043976;60480.69759651174;60559;1355.5323413422354;1362.7410791949499;1373.3545233740126;1375.8968077394236;1394.4979807269374;30874.845625771726;32114;32284.192895176868;32349;32591;52104.218436722724;52417.213741794665;52516.47483525116;52578.73710631422;52589;366989;367714;368200;368713;370161;28361.43277134487;28380;29242.268943276587;29310.775814660796;29363.706362936096;50085.24872126848;50398.74800625973;50610.49389506058;50899.236511451614;51904.221436677726;41574.584254157075;42167.36748948707;42275.78862105793;42868;43044.56955430406;41600;41827.1634567313;41909.371359430246;42047.789761051;43260.134797304505;40429.24906300811;42066.789666051474;42084.57915420806;42216.36675449809;42408.78795606002;35838.820805896845;36390;37230.25539489249;37243;38047.42928856014;28221.43557128805;28636.570451443662;28781.28046798847;28826.567601486415;28862.567061494516 16:35:59 INFO - PROCESS | 16704 | |2;jquery.html;390.96676782473486;399.3390937997615;400.5233771811544;402.4185052598994;420.186938274439;13653.385597648105;17696.82303176968;18579.442616721488;19243.422697319067;19250.133743981503;18416.263349466004;18420.72368914464;18756.155972981214;19276.132574034167;19339.806601933975;5625.774969001245;5715.057015592422;5814.912776308338;5898.557608179382;5916.556258280646;5843.824685259449;5856.56075794315;5864.560157988147;5881.558883083764;5894.056950887859;5718.85462995353;5782.739776710037;5839.737211825457;5888.7055647217685;5889.676067816268;5775.480206781389;5832.416758324176;5852.297724273115;5882.14708867214;5900.675462849542;5082.771275292621;5275.393329767049;5292.655977361459;5303.443138470482;5305.628605997582;21365;22074.88962555177;22518;22520.324390268317;22595.77404225953;2327.8021368183727;2401.351635058542;2407.9398015049587;2783.318087068661;2847.117393607988;14603.196824174665;14676.559703208814;14740.852591474055;14999.850001500063;15189.848101519065;1919.481739930211;1980.3563841751345;1982.2170242754032;2030.7766145723958;2037.8879161646253;77359.61320193364;79768;80346.59826700829;80593.59703201505;80717;10153.13698335635;10390.324628899098;10807.891921080845;10904.727381815359;10917.344959302467;15116.395344186329;15151.166685832384;15189.088654680754;15259.389624415122;15262.31319590621;7626.885596716053;7691.846163076819;7785.416093792875;7858.685652573948;7917.524948503108;7202.92797072033;7286.48994570375;7366.337029667356;7367.668454919542;7472.738454154079;6594.604323740591;6624.238212605515;6651.268360480343;6751.0886030386255;6789.490788190906;1924.451531313569;1956.149075152285;1976.2095161935054;2002.779694233633;2027.9188832446832;954.8281309364381;1008.9293749437616;1010.1716592394313;1021.4739409204266;1035.6271742172812;19144.523655216886;19341.613167736567;19578.118984645724;19776.208951641773;19780.109895054757;1000.174855744014;1007.6876168387677;1038.2783965144304;1052.4737631184407;1096.550414330121;9030.86453703195;11482;11634.94182529082;11688;11724.648260552198;457415;467634;470216;471603;487643;68910.65544672245;83910.58044709859;84498.15501845026;84649.57675211708;84903.57548212219;1031.0617338222182;1048.9632862849917;1080.1574771678104;1116.0625074937093;1121.3047910295506;17397.13014349303;17531.21109550048;17751.289948402435;17770.20034098443;17890.821091788916;37709.24581508409;38703.419448707726;38904;39004.609953901236;39460;50104.749476252386;50562;50884.49115508798;51045;51419;8130.512169269863;8783.29733621296;8803.735887923373;8909.376343655882;9018.053104424203;9451.858222126537;12978.545750898673;13251.271180085188;13356.332183390987;13529.86470135286;11633.476493557979;11854.229475084092;11967.10246731516;12007.519699211934;12033.578824741093;11364.261323014309;11564.363959982282;11704.94147529291;11945.283283003047;12041.75916481648;11808.819118088122;12090.75818483643;12116.697082573006;12204.755904881675;12323.691907702021;8839.381243312906;8946.284297256334;9012.324075694218;9028.413153145024;9112.225460835638;8944.910550894669;11123.555057797597;11293.548258069914;11845;11993.700157496132 16:35:59 INFO - PROCESS | 16704 | |3;mootools.html;1446.1323206076356;1483.9851601483986;1592.6018495376156;1694.2460605030767;1724.7757791487113;7608.505447145932;8768.912310876889;8972.820543589125;9340.719778406641;9361.859572106416;9025.413348132382;9133.223675987549;9159.954200228989;9215.769605759859;9243.676471323504;2327.3483424641086;2353.364591560278;2365.7042869641296;2378.1200955646436;2379.3694670912223;2353.2822489140804;2363.420961864346;2392.712874455068;2396.4727759892794;2399.9160029398886;2360.834741568091;2361.126383238204;2368.7749663782;2383.7377888432256;2384.666146739458;2278.829087818412;2315.097112126272;2318.8260880434036;2321.94195145121;2348.788609025196;2265.5808675395106;2267.888041727545;2331.5570041692026;2334.159702507096;2338.403707054707;9262.907370926272;9378.85931711025;9392.436453812794;9398.34211605188;9432.386894851812;5309.123994540896;5467;5487.945120548783;5489.917651235235;5494.203340515643;3399.83000849959;3431.227973705921;3450.6721861423125;3463.5497385339995;3512.3853325667906;1178.693539679681;1192.7197108679454;1212.8544574651098;1213.21141258182;1233.808759642257;13082.803757943639;13088.214707117604;13094.34528273592;13122;13151.408186631625;4748.630768928796;4785.042991401664;4853.80584776605;4866.829660961849;4877.804887804519;10707.196960228013;10778.946105269424;10806.459677016117;10847.620333288298;10858.402787846744;5329.973350133302;5360.142377219626;5404.83785486436;5406.810761623325;5449.427810079964;4207.537170911197;4804.279358096313;4914.017196560702;4948.084604348207;4964.950350496521;4074.6197788426903;4075.1034772350035;4116.217918595457;4140.047789008545;4156.397322388237;1233.2970206981934;1263.2673049631376;1270.783966725659;1278.5077745068215;1281.51943021367;841.7643059943226;923.316745608245;953.6682810528192;958.1855422890627;965.5220665770488;5916.7041647918295;6035.517158627299;6051.546134039877;6136.2636483622255;6214.658193799294;461.5914915299984;466.9836555720601;472.5156714367732;477.67756764184037;479.33851285226166;3863.864764733221;3883.8446462141765;3965.960340396559;3980.5820388859333;3993.940090898639;10778.73053173677;11581.015613672764;11582.536698531965;11610.825837612443;11636.53453861836;11138.888611113947;11340.489677964511;11356.432178391047;11458.541658333574;11560.537578496935;8500.74497765068;8555.57222138903;8555.957220213859;8619.525926074;8621.525816080175;5898.20374249488;5921.3782552831335;5937.495312898279;5948.167256583995;6043.516518678583;10367.896321036693;10376.221783366429;10554.947225263824;10602.363858168535;10687.358758474516;10665.840012399975;10689.091427228772;10706.250562460553;10710.410927398756;10779.191560632828;7966.083900351534;7966.681332746625;8109.553974531457;8111.756647300354;8121.9593902032475;8653.841392458293;8721.869171962553;8755.03694593607;8816.955915220382;8834.160754728291;7822.804429889298;7901.249381308767;7918.683252669829;8050.758477245692;8184;7564.394848412224;7695;7765.1846556110795;7777.105632852295;7860.253275938777;7047.682854271673;7090.149182098181;7092.645367731696;7117.252688467636;7120.216776154515;5029.170186919117;5041.319421878;5110.616703747308;5132.204508301219;5143.305653736697;5047.697138171721;5107.514786095315;5177.4822517747925;5296.894062118813;5297.311349524537 16:35:59 INFO - PROCESS | 16704 | |4;prototype.html;319.8736499082861;321.77636542602886;325.9276978739946;326.2269564914689;340.4297801183018;5392.676439413638;5485.945140548593;5489.176623506476;5569.164625306206;5580.748866301021;5488.4785945335225;5498.340199176095;5501.2945986744035;5504.834854954348;5511.759854032841;4338.240807858628;4340.804663790137;4342.240107981106;4360.934585981213;4395.472543294809;4096.836126554934;4308.418363520932;4319.33050377192;4331.631811296028;4386.75872826996;4236.766977816219;4262.744235345889;4263.509696384909;4280.614744672979;4297.076128632343;4270.743755374688;4294.248506511348;4307.461567304087;4311.482622085338;4317.244482215599;3646.033801042726;3775.339315619756;3785.8107094645156;3786.3752480840626;3790.1851102012924;5377.085895397752;5453.609329620961;5454.018276710191;5476.3702174250075;5478.534324582415;4895.437024742129;4911.533404326583;4925.408950925876;4946.194638956791;5009.524095210949;5616.887662246773;5751.22358481608;5752.971235143839;5822.854428639275;5835.766569337221;4137.379393091031;4149.83400663973;4160.981923766971;4161.689067943588;4198.685098617585;5877.265341832271;6125.816225513242;6131.662758548278;6135.447809697104;6147;4136.152088821785;4146.170765846782;4172.624463798273;4173.457450531411;4173.5409104998425;4225.429567008476;4240.300350442142;4250.638695710899;4251.383549385384;4255.6169944705125;4859.514048595112;4910.238912968495;4912.852614421573;4926.852194434173;4957.132501812169;5741.913871291934;5817.970910145422;5844;5867.735951882176;5868.559858010666;1473.1161303218198;1475.0043720488627;1493.2011373914904;1494.75336569467;1497.4010395841533;917.5870858113875;919.6413398774483;925.7601972833729;931.59475628102;957.7749228931195;5001.874953126201;5029.622778291569;5057.367829021372;5141.691498510101;5169.560587350117;5257.316548848626;5282.366116066097;5316.245638939141;5324;5357.276767636397;4891.486393928657;4894.290327902506;5032.018756342478;5084.77118529667;5130.333056702605;2849.9287517811804;2863.040881304786;2887.3503461721366;2893.6382952130984;2914.3970816051087;5455.34535855692;5460.044492213926;5475.698836564027;5495.725213739377;5501.669899806025;5467.020473841766;5716.942365662366;6081.209442772411;6127.295361033538;6180.8763824723255;6130.877382452326;6174.753009879644;6217.502599792006;6244.781432649836;6281.120643109968;5783.392743762012;5994.31065427464;6033.42682445167;6095.35998720128;6115.327313995368;5947.791827286024;5985.760569577343;6000.489958353589;6008.579399441997;6023.608465449732;6065.423784740443;6203.844903877439;6218.53360997936;6226.848033113888;6247.281562620356;4217.831286748618;4259.275923093143;4265.680073994401;4268.359746038119;4282.828686852491;5808.970955145197;5984.431479009487;6107.083937409424;6128;6160.845978850564;5884.705764711833;5908.970455147697;5919.526437885045;5922.763089476372;5926.970365148147;5808.448197421239;5829.941700583109;5875.618084824473;5925.674087925206;5946.554008449297;5575.832725018256;5702.885942281214;5747.626404283708;5771.509421699203;5860.706964651836;5842.2405087338375;5894.557908156819;5905.936931352398;5929.673867937305;5937.881242375042;5614.6631202128;5736.971315143564;5769.53843692512;5777.884442311214;5793.884122317614 16:35:59 INFO - PROCESS | 16704 | |5;yui.html;725.7097161135548;772.9912464234176;804.4971892567146;828.1925123005067;841.8484672758905;14863.628409289773;14892.106473611577;14982.475613353536;15127.092374457541;16457.423990160347;14756;15216.163111028889;15236.238188090607;15241.390344386238;15289.541313760605;785.8742601183826;794.1026639896937;808.7695006923028;808.8301456694102;810.8459392715395;807.321849646297;811.1726039439768;811.4806523824757;812.8333691593209;813.6745301879266;852.3053711225363;853.2704537620339;855.5337341149088;856.3235044314983;862.1378621378622;850.345234169689;853.5007020892754;853.5007020892785;856.7044369692509;858.2018722587991;613.1262950295855;618.505195843328;619.2383368456823;622.1290193728815;623.2365352443221;15566.922165389215;15592;15680.529584112495;15681.294341754648;15682.68634627301;13961.860381396158;14008;14505;14765.261736913111;14901.701965960729;11982.101342399268;11995.820062699066;12229.510819567207;12250.632481025494;12287.262764234174;3856.633619806114;3882.49527561418;3910.8240129194255;3919.3533067043904;3993.101552150743;61246.38753612496;61388.38611613871;62110.37889621091;62501.37498625001;64557.67721161364;10620.89379106199;11231.775364492827;11843;11872.228305160137;12000.819987700017;21291.57416851654;21307;21341.573168536543;21372.78627213739;21454.24910128138;8585.957070214608;8674.826503469896;8851.380403371832;8916.955415222883;9021.909780902108;4811.639127065414;4867.099586576494;4874.195757699939;4947.282644016669;4955.35580374549;3746.0073080633656;3867.8066096695616;3868.3423817951016;3873.96126038736;3882.864099756495;670.269406347084;670.2928410526844;676.202081543783;678.7013713965938;699.3915293694519;605.449041372349;701.3792793377897;723.442948929332;761.6534476813148;768;10496.370217786956;10527.263091583516;10576.576936922436;10622.73443163927;10814.891851081546;621.4810633121303;647.4820143884873;652.1717418877998;704.5807744392079;729.6351824087956;4515.729056256635;4591.311303304531;4613.838515651936;4621.1219868224925;4694.859154225379;71093.64453177701;113552;119022;120408.3979580114;122028;64879.35120648733;71860.64069679723;98937.61155078613;99532.50233748785;104283;60016.69991650101;91121;91205.54397227972;92329;92455.53772231095;9349.859752103588;9664.661736839176;9677.70966870995;9720.368176068532;9793.902060979584;49675.75162124166;50590.747046264536;51714.96570068653;51761;52203;72773.27226727665;74375;76337;76913.23086769285;78184;10984.890151098707;11148.665540033811;11332.206745528063;11367.147463940073;11571.826422603835;13185.208887466782;14394.35225414838;15172.393104275705;15237.238138093273;15335.846641533442;13937.58187254384;14179;14183.716325673222;14258.643533911736;14759.262036898326;13391.129576577492;13633.727325453634;14261.144331340152;14850.108993460426;15228.238588070331;13854.584362469142;14276.559278670939;14414.927925360305;14447;14863.554093377215;11767.23512971654;11984.820227696417;12045.759084818079;12251.877481225074;12406.81389779136;11859.822102668639;11944.402779860799;12051.397430128634;12276.140670153003;12359.25844449336 16:35:59 INFO - PROCESS | 16704 | __end_tp_report 16:35:59 INFO - PROCESS | 16704 | __start_cc_report 16:35:59 INFO - PROCESS | 16704 | _x_x_mozilla_cycle_collect,350 16:35:59 INFO - PROCESS | 16704 | __end_cc_report 16:35:59 INFO - PROCESS | 16704 | __startTimestamp1465515359809__endTimestamp 16:35:59 INFO - PROCESS | 16704 | 16:35:59 INFO - PROCESS | 16704 | ------- Summary: start ------- 16:35:59 INFO - PROCESS | 16704 | Number of tests: 6 16:35:59 INFO - PROCESS | 16704 | 16:35:59 INFO - PROCESS | 16704 | [#0] dojo.html Cycles:165 Average:5444.50 Median:5725.08 stddev:736.62 (12.9%) stddev-sans-first:714.89 16:35:59 INFO - PROCESS | 16704 | Values: 3067.8 3126.2 3134.9 3143.0 3168.2 5440.7 5492.1 5501.8 5544.5 5549.4 5368.5 5481.9 5485.5 5506.4 5564.2 4843.1 4921.9 5001.5 5021.4 5070.0 653.7 4852.3 4946.1 4981.2 5040.2 4954.6 4979.4 4980.3 4986.1 4989.2 5012.9 5013.8 5021.5 5022.3 5032.8 4948.8 4963.6 4991.5 5047.8 5054.8 5446.0 5553.0 5566.2 5586.9 5618.2 5736.2 5841.9 5842.6 5857.0 5867.3 5798.0 5829.8 5833.5 5882.5 5897.4 5424.7 5447.0 5467.8 5475.4 5476.2 5904.7 5938.2 5942.6 5950.1 5953.0 5768.7 5786.5 5789.0 5794.9 5853.9 5876.2 5881.3 5881.7 5882.1 5889.8 5657.9 5725.1 5743.3 5842.4 5859.3 5742.6 5755.5 5783.9 5796.9 5817.4 4460.2 4460.8 4461.3 4474.4 4490.7 3935.9 3988.5 3993.6 3995.8 4027.5 5700.4 5711.3 5723.0 5730.4 5769.4 6031.6 6045.5 6046.6 6047.1 6052.7 5578.9 5589.0 5598.4 5616.7 5650.6 5060.0 5077.3 5080.0 5087.7 5120.5 5938.9 6028.2 6030.5 6034.7 6047.3 5901.2 5919.3 5936.2 5981.8 5989.6 6083.0 6090.5 6092.1 6105.3 6116.9 5657.3 5789.9 5821.7 5825.2 5857.4 5915.4 5986.8 6018.8 6021.9 6092.9 5859.4 5872.6 5884.4 5887.2 5891.9 5649.0 5735.3 5740.0 5775.2 5848.0 5598.5 5710.3 5713.8 5715.1 5755.1 5799.9 5816.7 5832.1 5842.7 5858.3 5557.1 5676.0 5717.3 5769.8 5777.4 16:35:59 INFO - PROCESS | 16704 | 16:35:59 INFO - PROCESS | 16704 | [#1] ext.html Cycles:180 Average:59035.60 Median:41598.79 stddev:116841.38 (280.9%) stddev-sans-first:117086.69 16:35:59 INFO - PROCESS | 16704 | Values: 568.7 621.3 624.6 645.0 646.9 38402.8 42485.6 42502.6 42695.4 42918.8 42061.6 42958.8 43016.6 43060.8 43102.0 8768.4 8936.9 8947.5 8955.3 8959.6 8855.7 8866.1 8925.3 8945.8 8961.3 8892.9 8950.0 8964.8 8997.1 8998.6 8855.6 8875.9 8923.0 8956.4 9006.5 8847.2 8886.5 8936.8 8944.4 8985.2 41034.0 41383.4 41587.0 41597.6 41643.0 3030.3 3332.3 3501.4 3836.8 4158.8 31216.4 31249.2 31726.8 32645.0 34199.7 4384.3 4401.5 4455.6 4463.0 4535.2 350256.0 351653.0 351708.0 355710.2 355725.0 61262.7 62114.0 62187.4 62302.7 62311.4 35665.5 36288.8 36530.3 37039.0 37718.6 16831.1 16837.6 16951.4 16995.2 17067.4 12673.8 12731.7 12780.6 12791.7 12828.9 19717.2 19821.8 19981.0 20048.7 20131.6 7147.0 7193.2 7323.3 7343.5 7424.5 966.1 1024.4 1035.7 1053.5 1107.7 32534.8 32690.7 32712.0 32758.7 33148.7 1100.3 1126.2 1176.0 1186.4 1224.3 17083.2 17367.6 17408.0 17451.6 17632.6 564228.0 564777.0 566327.0 569151.0 569875.0 58217.7 60157.1 60445.4 60480.7 60559.0 1355.5 1362.7 1373.4 1375.9 1394.5 30874.8 32114.0 32284.2 32349.0 32591.0 52104.2 52417.2 52516.5 52578.7 52589.0 366989.0 367714.0 368200.0 368713.0 370161.0 28361.4 28380.0 29242.3 29310.8 29363.7 50085.2 50398.7 50610.5 50899.2 51904.2 41574.6 42167.4 42275.8 42868.0 43044.6 41600.0 41827.2 41909.4 42047.8 43260.1 40429.2 42066.8 42084.6 42216.4 42408.8 35838.8 36390.0 37230.3 37243.0 38047.4 28221.4 28636.6 28781.3 28826.6 28862.6 16:35:59 INFO - PROCESS | 16704 | 16:35:59 INFO - PROCESS | 16704 | [#2] jquery.html Cycles:180 Average:27965.18 Median:12461.79 stddev:77414.72 (621.2%) stddev-sans-first:77604.20 16:35:59 INFO - PROCESS | 16704 | Values: 391.0 399.3 400.5 402.4 420.2 13653.4 17696.8 18579.4 19243.4 19250.1 18416.3 18420.7 18756.2 19276.1 19339.8 5625.8 5715.1 5814.9 5898.6 5916.6 5843.8 5856.6 5864.6 5881.6 5894.1 5718.9 5782.7 5839.7 5888.7 5889.7 5775.5 5832.4 5852.3 5882.1 5900.7 5082.8 5275.4 5292.7 5303.4 5305.6 21365.0 22074.9 22518.0 22520.3 22595.8 2327.8 2401.4 2407.9 2783.3 2847.1 14603.2 14676.6 14740.9 14999.9 15189.8 1919.5 1980.4 1982.2 2030.8 2037.9 77359.6 79768.0 80346.6 80593.6 80717.0 10153.1 10390.3 10807.9 10904.7 10917.3 15116.4 15151.2 15189.1 15259.4 15262.3 7626.9 7691.8 7785.4 7858.7 7917.5 7202.9 7286.5 7366.3 7367.7 7472.7 6594.6 6624.2 6651.3 6751.1 6789.5 1924.5 1956.1 1976.2 2002.8 2027.9 954.8 1008.9 1010.2 1021.5 1035.6 19144.5 19341.6 19578.1 19776.2 19780.1 1000.2 1007.7 1038.3 1052.5 1096.6 9030.9 11482.0 11634.9 11688.0 11724.6 457415.0 467634.0 470216.0 471603.0 487643.0 68910.7 83910.6 84498.2 84649.6 84903.6 1031.1 1049.0 1080.2 1116.1 1121.3 17397.1 17531.2 17751.3 17770.2 17890.8 37709.2 38703.4 38904.0 39004.6 39460.0 50104.7 50562.0 50884.5 51045.0 51419.0 8130.5 8783.3 8803.7 8909.4 9018.1 9451.9 12978.5 13251.3 13356.3 13529.9 11633.5 11854.2 11967.1 12007.5 12033.6 11364.3 11564.4 11704.9 11945.3 12041.8 11808.8 12090.8 12116.7 12204.8 12323.7 8839.4 8946.3 9012.3 9028.4 9112.2 8944.9 11123.6 11293.5 11845.0 11993.7 16:35:59 INFO - PROCESS | 16704 | 16:35:59 INFO - PROCESS | 16704 | [#3] mootools.html Cycles:180 Average:5969.40 Median:2631.36 stddev:3498.90 (133.0%) stddev-sans-first:3492.20 16:35:59 INFO - PROCESS | 16704 | Values: 1446.1 1484.0 1592.6 1694.2 1724.8 7608.5 8768.9 8972.8 9340.7 9361.9 9025.4 9133.2 9160.0 9215.8 9243.7 2327.3 2353.4 2365.7 2378.1 2379.4 2353.3 2363.4 2392.7 2396.5 2399.9 2360.8 2361.1 2368.8 2383.7 2384.7 2278.8 2315.1 2318.8 2321.9 2348.8 2265.6 2267.9 2331.6 2334.2 2338.4 9262.9 9378.9 9392.4 9398.3 9432.4 5309.1 5467.0 5487.9 5489.9 5494.2 3399.8 3431.2 3450.7 3463.5 3512.4 1178.7 1192.7 1212.9 1213.2 1233.8 13082.8 13088.2 13094.3 13122.0 13151.4 4748.6 4785.0 4853.8 4866.8 4877.8 10707.2 10778.9 10806.5 10847.6 10858.4 5330.0 5360.1 5404.8 5406.8 5449.4 4207.5 4804.3 4914.0 4948.1 4965.0 4074.6 4075.1 4116.2 4140.0 4156.4 1233.3 1263.3 1270.8 1278.5 1281.5 841.8 923.3 953.7 958.2 965.5 5916.7 6035.5 6051.5 6136.3 6214.7 461.6 467.0 472.5 477.7 479.3 3863.9 3883.8 3966.0 3980.6 3993.9 10778.7 11581.0 11582.5 11610.8 11636.5 11138.9 11340.5 11356.4 11458.5 11560.5 8500.7 8555.6 8556.0 8619.5 8621.5 5898.2 5921.4 5937.5 5948.2 6043.5 10367.9 10376.2 10554.9 10602.4 10687.4 10665.8 10689.1 10706.3 10710.4 10779.2 7966.1 7966.7 8109.6 8111.8 8122.0 8653.8 8721.9 8755.0 8817.0 8834.2 7822.8 7901.2 7918.7 8050.8 8184.0 7564.4 7695.0 7765.2 7777.1 7860.3 7047.7 7090.1 7092.6 7117.3 7120.2 5029.2 5041.3 5110.6 5132.2 5143.3 5047.7 5107.5 5177.5 5296.9 5297.3 16:35:59 INFO - PROCESS | 16704 | 16:35:59 INFO - PROCESS | 16704 | [#4] prototype.html Cycles:180 Average:4827.15 Median:5463.53 stddev:1439.02 (26.3%) stddev-sans-first:1402.73 16:35:59 INFO - PROCESS | 16704 | Values: 319.9 321.8 325.9 326.2 340.4 5392.7 5485.9 5489.2 5569.2 5580.7 5488.5 5498.3 5501.3 5504.8 5511.8 4338.2 4340.8 4342.2 4360.9 4395.5 4096.8 4308.4 4319.3 4331.6 4386.8 4236.8 4262.7 4263.5 4280.6 4297.1 4270.7 4294.2 4307.5 4311.5 4317.2 3646.0 3775.3 3785.8 3786.4 3790.2 5377.1 5453.6 5454.0 5476.4 5478.5 4895.4 4911.5 4925.4 4946.2 5009.5 5616.9 5751.2 5753.0 5822.9 5835.8 4137.4 4149.8 4161.0 4161.7 4198.7 5877.3 6125.8 6131.7 6135.4 6147.0 4136.2 4146.2 4172.6 4173.5 4173.5 4225.4 4240.3 4250.6 4251.4 4255.6 4859.5 4910.2 4912.9 4926.9 4957.1 5741.9 5818.0 5844.0 5867.7 5868.6 1473.1 1475.0 1493.2 1494.8 1497.4 917.6 919.6 925.8 931.6 957.8 5001.9 5029.6 5057.4 5141.7 5169.6 5257.3 5282.4 5316.2 5324.0 5357.3 4891.5 4894.3 5032.0 5084.8 5130.3 2849.9 2863.0 2887.4 2893.6 2914.4 5455.3 5460.0 5475.7 5495.7 5501.7 5467.0 5716.9 6081.2 6127.3 6180.9 6130.9 6174.8 6217.5 6244.8 6281.1 5783.4 5994.3 6033.4 6095.4 6115.3 5947.8 5985.8 6000.5 6008.6 6023.6 6065.4 6203.8 6218.5 6226.8 6247.3 4217.8 4259.3 4265.7 4268.4 4282.8 5809.0 5984.4 6107.1 6128.0 6160.8 5884.7 5909.0 5919.5 5922.8 5927.0 5808.4 5829.9 5875.6 5925.7 5946.6 5575.8 5702.9 5747.6 5771.5 5860.7 5842.2 5894.6 5905.9 5929.7 5937.9 5614.7 5737.0 5769.5 5777.9 5793.9 16:35:59 INFO - PROCESS | 16704 | 16:35:59 INFO - PROCESS | 16704 | [#5] yui.html Cycles:180 Average:20096.38 Median:4553.52 stddev:28325.53 (622.1%) stddev-sans-first:28367.65 16:35:59 INFO - PROCESS | 16704 | Values: 725.7 773.0 804.5 828.2 841.8 14863.6 14892.1 14982.5 15127.1 16457.4 14756.0 15216.2 15236.2 15241.4 15289.5 785.9 794.1 808.8 808.8 810.8 807.3 811.2 811.5 812.8 813.7 852.3 853.3 855.5 856.3 862.1 850.3 853.5 853.5 856.7 858.2 613.1 618.5 619.2 622.1 623.2 15566.9 15592.0 15680.5 15681.3 15682.7 13961.9 14008.0 14505.0 14765.3 14901.7 11982.1 11995.8 12229.5 12250.6 12287.3 3856.6 3882.5 3910.8 3919.4 3993.1 61246.4 61388.4 62110.4 62501.4 64557.7 10620.9 11231.8 11843.0 11872.2 12000.8 21291.6 21307.0 21341.6 21372.8 21454.2 8586.0 8674.8 8851.4 8917.0 9021.9 4811.6 4867.1 4874.2 4947.3 4955.4 3746.0 3867.8 3868.3 3874.0 3882.9 670.3 670.3 676.2 678.7 699.4 605.4 701.4 723.4 761.7 768.0 10496.4 10527.3 10576.6 10622.7 10814.9 621.5 647.5 652.2 704.6 729.6 4515.7 4591.3 4613.8 4621.1 4694.9 71093.6 113552.0 119022.0 120408.4 122028.0 64879.4 71860.6 98937.6 99532.5 104283.0 60016.7 91121.0 91205.5 92329.0 92455.5 9349.9 9664.7 9677.7 9720.4 9793.9 49675.8 50590.7 51715.0 51761.0 52203.0 72773.3 74375.0 76337.0 76913.2 78184.0 10984.9 11148.7 11332.2 11367.1 11571.8 13185.2 14394.4 15172.4 15237.2 15335.8 13937.6 14179.0 14183.7 14258.6 14759.3 13391.1 13633.7 14261.1 14850.1 15228.2 13854.6 14276.6 14414.9 14447.0 14863.6 11767.2 11984.8 12045.8 12251.9 12406.8 11859.8 11944.4 12051.4 12276.1 12359.3 16:35:59 INFO - PROCESS | 16704 | -------- Summary: end -------- 16:35:59 INFO - PROCESS | 16704 | 16:36:00 INFO - TEST-INFO | 16704: exit 0 16:36:00 INFO - TEST-OK | dromaeo_css | took 1110633ms 16:36:00 INFO - TEST-START | kraken 16:36:00 INFO - operating with platform_type : linux_ 16:36:00 INFO - Initialising browser for kraken test... 16:36:00 INFO - TEST-INFO | started process 16938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmFYpRV/profile http://localhost:45078/getInfo.html) 16:36:05 INFO - PROCESS | 16938 | __metrics Screen width/height:1600/1200 16:36:05 INFO - PROCESS | 16938 | colorDepth:24 16:36:05 INFO - PROCESS | 16938 | Browser inner width/height: 1024/697 16:36:05 INFO - PROCESS | 16938 | __metrics 16:36:05 ERROR - PROCESS | 16938 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 16:36:06 INFO - TEST-INFO | 16938: exit 0 16:36:06 INFO - Browser initialized. 16:36:06 INFO - Running cycle 1/1 for kraken test... 16:36:06 INFO - TEST-INFO | started process 17057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmFYpRV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:36:18 INFO - PROCESS | 17057 | RSS: Main: 184811520 16:36:18 INFO - PROCESS | 17057 | 16:36:21 INFO - PROCESS | 17057 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45078/tests/kraken/driver.html?testName=audio-beat-detection) 16:36:22 INFO - PROCESS | 17057 | RSS: Main: 190611456 16:36:22 INFO - PROCESS | 17057 | 16:36:24 INFO - PROCESS | 17057 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45078/tests/kraken/driver.html?testName=audio-dft) 16:36:25 INFO - PROCESS | 17057 | RSS: Main: 189718528 16:36:25 INFO - PROCESS | 17057 | 16:36:28 INFO - PROCESS | 17057 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45078/tests/kraken/driver.html?testName=audio-fft) 16:36:28 INFO - PROCESS | 17057 | RSS: Main: 184262656 16:36:28 INFO - PROCESS | 17057 | 16:36:31 INFO - PROCESS | 17057 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45078/tests/kraken/driver.html?testName=audio-oscillator) 16:36:31 INFO - PROCESS | 17057 | RSS: Main: 185241600 16:36:31 INFO - PROCESS | 17057 | 16:36:34 INFO - PROCESS | 17057 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45078/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:36:34 INFO - PROCESS | 17057 | RSS: Main: 185872384 16:36:34 INFO - PROCESS | 17057 | 16:36:37 INFO - PROCESS | 17057 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45078/tests/kraken/driver.html?testName=imaging-darkroom) 16:36:38 INFO - PROCESS | 17057 | RSS: Main: 186417152 16:36:38 INFO - PROCESS | 17057 | 16:36:41 INFO - PROCESS | 17057 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45078/tests/kraken/driver.html?testName=imaging-desaturate) 16:36:42 INFO - PROCESS | 17057 | RSS: Main: 186503168 16:36:42 INFO - PROCESS | 17057 | 16:36:45 INFO - PROCESS | 17057 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45078/tests/kraken/driver.html?testName=json-parse-financial) 16:36:45 INFO - PROCESS | 17057 | RSS: Main: 186175488 16:36:45 INFO - PROCESS | 17057 | 16:36:47 INFO - PROCESS | 17057 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45078/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:36:48 INFO - PROCESS | 17057 | RSS: Main: 186200064 16:36:48 INFO - PROCESS | 17057 | 16:36:49 INFO - PROCESS | 17057 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:36:50 INFO - PROCESS | 17057 | RSS: Main: 186343424 16:36:50 INFO - PROCESS | 17057 | 16:36:52 INFO - PROCESS | 17057 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:36:53 INFO - PROCESS | 17057 | RSS: Main: 186499072 16:36:53 INFO - PROCESS | 17057 | 16:36:55 INFO - PROCESS | 17057 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:36:56 INFO - PROCESS | 17057 | RSS: Main: 187260928 16:36:56 INFO - PROCESS | 17057 | 16:36:59 INFO - PROCESS | 17057 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:36:59 INFO - PROCESS | 17057 | RSS: Main: 186269696 16:36:59 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45078/tests/kraken/driver.html?testName=ai-astar) 16:37:01 INFO - PROCESS | 17057 | RSS: Main: 187109376 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | __start_tp_report 16:37:01 INFO - PROCESS | 17057 | _x_x_mozilla_page_load 16:37:01 INFO - PROCESS | 17057 | _x_x_mozilla_page_load_details 16:37:01 INFO - PROCESS | 17057 | |i|pagename|runs| 16:37:01 INFO - PROCESS | 17057 | |0;ai-astar;111;105;110;110;112;110;111;112;110;111 16:37:01 INFO - PROCESS | 17057 | |1;audio-beat-detection;156;125;152;187;125;158;160;131;177;135 16:37:01 INFO - PROCESS | 17057 | |2;audio-dft;161;161;161;166;165;174;163;164;162;162 16:37:01 INFO - PROCESS | 17057 | |3;audio-fft;77;76;75;152;77;75;79;76;161;76 16:37:01 INFO - PROCESS | 17057 | |4;audio-oscillator;84;85;140;85;85;84;140;85;84;142 16:37:01 INFO - PROCESS | 17057 | |5;imaging-gaussian-blur;117;117;117;117;122;119;118;118;117;117 16:37:01 INFO - PROCESS | 17057 | |6;imaging-darkroom;147;147;147;149;147;148;147;148;151;147 16:37:01 INFO - PROCESS | 17057 | |7;imaging-desaturate;97;95;94;97;96;95;96;96;96;95 16:37:01 INFO - PROCESS | 17057 | |8;json-parse-financial;62;54;55;55;53;57;53;54;53;52 16:37:01 INFO - PROCESS | 17057 | |9;json-stringify-tinderbox;62;62;61;62;63;62;63;67;63;62 16:37:01 INFO - PROCESS | 17057 | |10;stanford-crypto-aes;80;83;79;80;81;80;80;80;102;80 16:37:01 INFO - PROCESS | 17057 | |11;stanford-crypto-ccm;127;125;123;122;123;134;136;141;127;127 16:37:01 INFO - PROCESS | 17057 | |12;stanford-crypto-pbkdf2;161;162;159;161;162;159;161;159;161;157 16:37:01 INFO - PROCESS | 17057 | |13;stanford-crypto-sha256-iterative;65;66;64;66;66;63;63;62;66;66 16:37:01 INFO - PROCESS | 17057 | __end_tp_report 16:37:01 INFO - PROCESS | 17057 | __start_cc_report 16:37:01 INFO - PROCESS | 17057 | _x_x_mozilla_cycle_collect,883 16:37:01 INFO - PROCESS | 17057 | __end_cc_report 16:37:01 INFO - PROCESS | 17057 | __startTimestamp1465515421775__endTimestamp 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | ------- Summary: start ------- 16:37:01 INFO - PROCESS | 17057 | Number of tests: 14 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.99 (1.8%) stddev-sans-first:2.09 16:37:01 INFO - PROCESS | 17057 | Values: 111.0 105.0 110.0 110.0 112.0 110.0 111.0 112.0 110.0 111.0 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:157.00 stddev:21.43 (13.7%) stddev-sans-first:22.64 16:37:01 INFO - PROCESS | 17057 | Values: 156.0 125.0 152.0 187.0 125.0 158.0 160.0 131.0 177.0 135.0 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:3.96 (2.4%) stddev-sans-first:4.06 16:37:01 INFO - PROCESS | 17057 | Values: 161.0 161.0 161.0 166.0 165.0 174.0 163.0 164.0 162.0 162.0 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | [#3] audio-fft Cycles:10 Average:92.40 Median:76.00 stddev:33.87 (44.6%) stddev-sans-first:35.46 16:37:01 INFO - PROCESS | 17057 | Values: 77.0 76.0 75.0 152.0 77.0 75.0 79.0 76.0 161.0 76.0 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:84.50 stddev:27.11 (32.1%) stddev-sans-first:28.01 16:37:01 INFO - PROCESS | 17057 | Values: 84.0 85.0 140.0 85.0 85.0 84.0 140.0 85.0 84.0 142.0 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:117.50 stddev:1.60 (1.4%) stddev-sans-first:1.66 16:37:01 INFO - PROCESS | 17057 | Values: 117.0 117.0 117.0 117.0 122.0 119.0 118.0 118.0 117.0 117.0 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.50 stddev:1.32 (0.9%) stddev-sans-first:1.36 16:37:01 INFO - PROCESS | 17057 | Values: 147.0 147.0 147.0 149.0 147.0 148.0 147.0 148.0 151.0 147.0 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:0.88 16:37:01 INFO - PROCESS | 17057 | Values: 97.0 95.0 94.0 97.0 96.0 95.0 96.0 96.0 96.0 95.0 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:2.90 (5.3%) stddev-sans-first:1.50 16:37:01 INFO - PROCESS | 17057 | Values: 62.0 54.0 55.0 55.0 53.0 57.0 53.0 54.0 53.0 52.0 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:62.50 stddev:1.64 (2.6%) stddev-sans-first:1.72 16:37:01 INFO - PROCESS | 17057 | Values: 62.0 62.0 61.0 62.0 63.0 62.0 63.0 67.0 63.0 62.0 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:80.00 stddev:6.93 (8.7%) stddev-sans-first:7.29 16:37:01 INFO - PROCESS | 17057 | Values: 80.0 83.0 79.0 80.0 81.0 80.0 80.0 80.0 102.0 80.0 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:127.00 stddev:6.36 (5.0%) stddev-sans-first:6.73 16:37:01 INFO - PROCESS | 17057 | Values: 127.0 125.0 123.0 122.0 123.0 134.0 136.0 141.0 127.0 127.0 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:161.00 stddev:1.62 (1.0%) stddev-sans-first:1.69 16:37:01 INFO - PROCESS | 17057 | Values: 161.0 162.0 159.0 161.0 162.0 159.0 161.0 159.0 161.0 157.0 16:37:01 INFO - PROCESS | 17057 | 16:37:01 INFO - PROCESS | 17057 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:66.00 stddev:1.57 (2.4%) stddev-sans-first:1.66 16:37:01 INFO - PROCESS | 17057 | Values: 65.0 66.0 64.0 66.0 66.0 63.0 63.0 62.0 66.0 66.0 16:37:01 INFO - PROCESS | 17057 | -------- Summary: end -------- 16:37:01 INFO - PROCESS | 17057 | 16:37:02 INFO - TEST-INFO | 17057: exit 0 16:37:02 INFO - TEST-OK | kraken | took 62225ms 16:37:02 INFO - SUITE-END | took 1172s 16:37:02 INFO - Completed test suite (00:19:33) 16:37:02 INFO - javascript benchmark 16:37:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7335.938952806099, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.754579633629, 3126.171564535398, 3134.905952821416, 3143.0256620447662, 3168.19211101169, 5440.727963601819, 5492.066348720717, 5501.834944951653, 5544.500994910457, 5549.417311182328, 5368.46315368463, 5481.917771233435, 5485.533729632986, 5506.449355064491, 5564.221009058725, 4843.128236917353, 4921.876953076166, 5001.499850015006, 5021.397432308128, 5069.974650126745, 653.7331723404635, 4852.344933433977, 4946.1344264753525, 4981.153203955337, 5040.218766091243, 4954.603631709455, 4979.427365852919, 4980.252962055721, 4986.077575648498, 4989.226669866177, 5012.949870501285, 5013.774380152902, 5021.5229553192385, 5022.27177059328, 5032.798688052473, 4948.826791062295, 4963.553280204799, 4991.5258050485145, 5047.798088076473, 5054.772535235923, 5445.972770136124, 5553.0, 5566.192902029183, 5586.91619625706, 5618.15727640853, 5736.2256095427, 5841.85395365115, 5842.649441033552, 5856.970715146397, 5867.325257595388, 5798.0, 5829.766809327664, 5833.474987251126, 5882.529397648221, 5897.351291357947, 5424.728763561846, 5447.046766815831, 5467.753951072212, 5475.425080366544, 5476.17857321401, 5904.704764761745, 5938.228030356113, 5942.58401911862, 5950.137230101611, 5952.970235148797, 5768.682722450221, 5786.479216870502, 5789.0, 5794.913076303858, 5853.912191317134, 5876.236089308362, 5881.323647780475, 5881.676507792027, 5882.088276317178, 5889.793857215062, 5657.886842263131, 5725.083986562214, 5743.339515955635, 5842.386549412336, 5859.296884373817, 5742.626729262584, 5755.510781583528, 5783.913241301384, 5796.88406231873, 5817.447342502455, 4460.241758900995, 4460.799264033061, 4461.286194208911, 4474.39595654589, 4490.708103973231, 3935.8622448214173, 3988.501437320335, 3993.6405723484445, 3995.760254384746, 4027.4764280643913, 5700.37295897451, 5711.3146422428745, 5723.0, 5730.36965933747, 5769.365369809318, 6031.577789554689, 6045.516358691294, 6046.606970546988, 6047.0929360596265, 6052.66710330936, 5578.944210557924, 5588.966041282376, 5598.412166722435, 5616.719164041781, 5650.576206784508, 5059.974700126476, 5077.339945807022, 5080.034793389244, 5087.669301495391, 5120.462351453119, 5938.8812223755285, 6028.186194863637, 6030.517558595302, 6034.668093254913, 6047.274327080779, 5901.17383566301, 5919.289685237799, 5936.168936349001, 5981.7607295707685, 5989.610675306091, 6083.0, 6090.482309003784, 6092.055731361646, 6105.297890742444, 6116.8776624468155, 5657.32112146545, 5789.884202315846, 5821.738021789114, 5825.213596164633, 5857.384974577608, 5915.438033386821, 5986.790462333797, 6018.8194354169445, 6021.87956240864, 6092.878142437038, 5859.355470898283, 5872.618279811799, 5884.440978107073, 5887.1757953885635, 5891.94108058931, 5649.0, 5735.311762588516, 5739.971300143639, 5775.191473193672, 5848.0350742127075, 5598.524125449382, 5710.2862142232225, 5713.771449141987, 5715.114157305624, 5755.050416681201, 5799.9130013049, 5816.738246778989, 5832.066869300891, 5842.707864606838, 5858.297004359504, 5557.083081291542, 5676.0, 5717.285339332583, 5769.826905192683, 5777.3933736957015], "value": 5394.97798813011, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.7042737776356, 621.3382747374044, 624.615861245334, 645.0421124629923, 646.8964965605504, 38402.80798596007, 42485.57514424855, 42502.574974250245, 42695.35956960648, 42918.785406072966, 42061.57938420615, 42958.785206073924, 43016.56983430165, 43060.78469607647, 43102.0, 8768.430052046613, 8936.910630893706, 8947.50788706621, 8955.283577313832, 8959.596818143167, 8855.690050848221, 8866.069062748415, 8925.285977121846, 8945.821083578325, 8961.283097352196, 8892.8666070009, 8950.015498295183, 8964.775880603005, 8997.05530919254, 8998.59506322217, 8855.645774169025, 8875.911240887604, 8922.955385223066, 8956.373053886231, 9006.504642244674, 8847.247983921374, 8886.466811991237, 8936.821263574691, 8944.418612790148, 8985.23625491834, 41034.0, 41383.379249311285, 41587.0, 41597.584024159674, 41643.0, 3030.3484750778466, 3332.3002169544425, 3501.4047611906035, 3836.827342769582, 4158.771267580282, 31216.37567248665, 31249.218769530715, 31726.841365793254, 32645.0, 34199.65800342015, 4384.298512238027, 4401.493828209765, 4455.576720211575, 4462.955370446286, 4535.229011068126, 350256.0, 351653.0, 351708.0, 355710.22144889366, 355725.0, 61262.69368653128, 62114.0, 62187.37812621816, 62302.68848655728, 62311.37688623146, 35665.46501802475, 36288.81855590705, 36530.26939461196, 37039.0, 37718.62281377206, 16831.07429091387, 16837.57906052334, 16951.406700765416, 16995.23521441538, 17067.40264090751, 12673.809892851614, 12731.745365092645, 12780.552680656132, 12791.680207994688, 12828.871711282954, 19717.211311547377, 19821.801781982285, 19981.0, 20048.69926951097, 20131.597368052557, 7147.0, 7193.187610566408, 7323.304286092813, 7343.522671026366, 7424.517406368569, 966.1449617088927, 1024.4212020208558, 1035.6892932120334, 1053.4732633683159, 1107.7009207514088, 32534.837325813693, 32690.673093269237, 32712.0, 32758.672413275563, 33148.66851331456, 1100.3342977498658, 1126.1835169502046, 1176.012149794177, 1186.4067966016992, 1224.2837939805313, 17083.231254593575, 17367.56581085483, 17408.0, 17451.563710907074, 17632.55918602045, 564228.0, 564777.0, 566327.0, 569151.0, 569875.0, 58217.70891145517, 60157.09764353538, 60445.395546043976, 60480.69759651174, 60559.0, 1355.5323413422354, 1362.7410791949499, 1373.3545233740126, 1375.8968077394236, 1394.4979807269374, 30874.845625771726, 32114.0, 32284.192895176868, 32349.0, 32591.0, 52104.218436722724, 52417.213741794665, 52516.47483525116, 52578.73710631422, 52589.0, 366989.0, 367714.0, 368200.0, 368713.0, 370161.0, 28361.43277134487, 28380.0, 29242.268943276587, 29310.775814660796, 29363.706362936096, 50085.24872126848, 50398.74800625973, 50610.49389506058, 50899.236511451614, 51904.221436677726, 41574.584254157075, 42167.36748948707, 42275.78862105793, 42868.0, 43044.56955430406, 41600.0, 41827.1634567313, 41909.371359430246, 42047.789761051, 43260.134797304505, 40429.24906300811, 42066.789666051474, 42084.57915420806, 42216.36675449809, 42408.78795606002, 35838.820805896845, 36390.0, 37230.25539489249, 37243.0, 38047.42928856014, 28221.43557128805, 28636.570451443662, 28781.28046798847, 28826.567601486415, 28862.567061494516], "value": 20071.093344378438, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.96676782473486, 399.3390937997615, 400.5233771811544, 402.4185052598994, 420.186938274439, 13653.385597648105, 17696.82303176968, 18579.442616721488, 19243.422697319067, 19250.133743981503, 18416.263349466004, 18420.72368914464, 18756.155972981214, 19276.132574034167, 19339.806601933975, 5625.774969001245, 5715.057015592422, 5814.912776308338, 5898.557608179382, 5916.556258280646, 5843.824685259449, 5856.56075794315, 5864.560157988147, 5881.558883083764, 5894.056950887859, 5718.85462995353, 5782.739776710037, 5839.737211825457, 5888.7055647217685, 5889.676067816268, 5775.480206781389, 5832.416758324176, 5852.297724273115, 5882.14708867214, 5900.675462849542, 5082.771275292621, 5275.393329767049, 5292.655977361459, 5303.443138470482, 5305.628605997582, 21365.0, 22074.88962555177, 22518.0, 22520.324390268317, 22595.77404225953, 2327.8021368183727, 2401.351635058542, 2407.9398015049587, 2783.318087068661, 2847.117393607988, 14603.196824174665, 14676.559703208814, 14740.852591474055, 14999.850001500063, 15189.848101519065, 1919.481739930211, 1980.3563841751345, 1982.2170242754032, 2030.7766145723958, 2037.8879161646253, 77359.61320193364, 79768.0, 80346.59826700829, 80593.59703201505, 80717.0, 10153.13698335635, 10390.324628899098, 10807.891921080845, 10904.727381815359, 10917.344959302467, 15116.395344186329, 15151.166685832384, 15189.088654680754, 15259.389624415122, 15262.31319590621, 7626.885596716053, 7691.846163076819, 7785.416093792875, 7858.685652573948, 7917.524948503108, 7202.92797072033, 7286.48994570375, 7366.337029667356, 7367.668454919542, 7472.738454154079, 6594.604323740591, 6624.238212605515, 6651.268360480343, 6751.0886030386255, 6789.490788190906, 1924.451531313569, 1956.149075152285, 1976.2095161935054, 2002.779694233633, 2027.9188832446832, 954.8281309364381, 1008.9293749437616, 1010.1716592394313, 1021.4739409204266, 1035.6271742172812, 19144.523655216886, 19341.613167736567, 19578.118984645724, 19776.208951641773, 19780.109895054757, 1000.174855744014, 1007.6876168387677, 1038.2783965144304, 1052.4737631184407, 1096.550414330121, 9030.86453703195, 11482.0, 11634.94182529082, 11688.0, 11724.648260552198, 457415.0, 467634.0, 470216.0, 471603.0, 487643.0, 68910.65544672245, 83910.58044709859, 84498.15501845026, 84649.57675211708, 84903.57548212219, 1031.0617338222182, 1048.9632862849917, 1080.1574771678104, 1116.0625074937093, 1121.3047910295506, 17397.13014349303, 17531.21109550048, 17751.289948402435, 17770.20034098443, 17890.821091788916, 37709.24581508409, 38703.419448707726, 38904.0, 39004.609953901236, 39460.0, 50104.749476252386, 50562.0, 50884.49115508798, 51045.0, 51419.0, 8130.512169269863, 8783.29733621296, 8803.735887923373, 8909.376343655882, 9018.053104424203, 9451.858222126537, 12978.545750898673, 13251.271180085188, 13356.332183390987, 13529.86470135286, 11633.476493557979, 11854.229475084092, 11967.10246731516, 12007.519699211934, 12033.578824741093, 11364.261323014309, 11564.363959982282, 11704.94147529291, 11945.283283003047, 12041.75916481648, 11808.819118088122, 12090.75818483643, 12116.697082573006, 12204.755904881675, 12323.691907702021, 8839.381243312906, 8946.284297256334, 9012.324075694218, 9028.413153145024, 9112.225460835638, 8944.910550894669, 11123.555057797597, 11293.548258069914, 11845.0, 11993.700157496132], "value": 9322.038588197374, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.1323206076356, 1483.9851601483986, 1592.6018495376156, 1694.2460605030767, 1724.7757791487113, 7608.505447145932, 8768.912310876889, 8972.820543589125, 9340.719778406641, 9361.859572106416, 9025.413348132382, 9133.223675987549, 9159.954200228989, 9215.769605759859, 9243.676471323504, 2327.3483424641086, 2353.364591560278, 2365.7042869641296, 2378.1200955646436, 2379.3694670912223, 2353.2822489140804, 2363.420961864346, 2392.712874455068, 2396.4727759892794, 2399.9160029398886, 2360.834741568091, 2361.126383238204, 2368.7749663782, 2383.7377888432256, 2384.666146739458, 2278.829087818412, 2315.097112126272, 2318.8260880434036, 2321.94195145121, 2348.788609025196, 2265.5808675395106, 2267.888041727545, 2331.5570041692026, 2334.159702507096, 2338.403707054707, 9262.907370926272, 9378.85931711025, 9392.436453812794, 9398.34211605188, 9432.386894851812, 5309.123994540896, 5467.0, 5487.945120548783, 5489.917651235235, 5494.203340515643, 3399.83000849959, 3431.227973705921, 3450.6721861423125, 3463.5497385339995, 3512.3853325667906, 1178.693539679681, 1192.7197108679454, 1212.8544574651098, 1213.21141258182, 1233.808759642257, 13082.803757943639, 13088.214707117604, 13094.34528273592, 13122.0, 13151.408186631625, 4748.630768928796, 4785.042991401664, 4853.80584776605, 4866.829660961849, 4877.804887804519, 10707.196960228013, 10778.946105269424, 10806.459677016117, 10847.620333288298, 10858.402787846744, 5329.973350133302, 5360.142377219626, 5404.83785486436, 5406.810761623325, 5449.427810079964, 4207.537170911197, 4804.279358096313, 4914.017196560702, 4948.084604348207, 4964.950350496521, 4074.6197788426903, 4075.1034772350035, 4116.217918595457, 4140.047789008545, 4156.397322388237, 1233.2970206981934, 1263.2673049631376, 1270.783966725659, 1278.5077745068215, 1281.51943021367, 841.7643059943226, 923.316745608245, 953.6682810528192, 958.1855422890627, 965.5220665770488, 5916.7041647918295, 6035.517158627299, 6051.546134039877, 6136.2636483622255, 6214.658193799294, 461.5914915299984, 466.9836555720601, 472.5156714367732, 477.67756764184037, 479.33851285226166, 3863.864764733221, 3883.8446462141765, 3965.960340396559, 3980.5820388859333, 3993.940090898639, 10778.73053173677, 11581.015613672764, 11582.536698531965, 11610.825837612443, 11636.53453861836, 11138.888611113947, 11340.489677964511, 11356.432178391047, 11458.541658333574, 11560.537578496935, 8500.74497765068, 8555.57222138903, 8555.957220213859, 8619.525926074, 8621.525816080175, 5898.20374249488, 5921.3782552831335, 5937.495312898279, 5948.167256583995, 6043.516518678583, 10367.896321036693, 10376.221783366429, 10554.947225263824, 10602.363858168535, 10687.358758474516, 10665.840012399975, 10689.091427228772, 10706.250562460553, 10710.410927398756, 10779.191560632828, 7966.083900351534, 7966.681332746625, 8109.553974531457, 8111.756647300354, 8121.9593902032475, 8653.841392458293, 8721.869171962553, 8755.03694593607, 8816.955915220382, 8834.160754728291, 7822.804429889298, 7901.249381308767, 7918.683252669829, 8050.758477245692, 8184.0, 7564.394848412224, 7695.0, 7765.1846556110795, 7777.105632852295, 7860.253275938777, 7047.682854271673, 7090.149182098181, 7092.645367731696, 7117.252688467636, 7120.216776154515, 5029.170186919117, 5041.319421878, 5110.616703747308, 5132.204508301219, 5143.305653736697, 5047.697138171721, 5107.514786095315, 5177.4822517747925, 5296.894062118813, 5297.311349524537], "value": 4657.928962137912, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.8736499082861, 321.77636542602886, 325.9276978739946, 326.2269564914689, 340.4297801183018, 5392.676439413638, 5485.945140548593, 5489.176623506476, 5569.164625306206, 5580.748866301021, 5488.4785945335225, 5498.340199176095, 5501.2945986744035, 5504.834854954348, 5511.759854032841, 4338.240807858628, 4340.804663790137, 4342.240107981106, 4360.934585981213, 4395.472543294809, 4096.836126554934, 4308.418363520932, 4319.33050377192, 4331.631811296028, 4386.75872826996, 4236.766977816219, 4262.744235345889, 4263.509696384909, 4280.614744672979, 4297.076128632343, 4270.743755374688, 4294.248506511348, 4307.461567304087, 4311.482622085338, 4317.244482215599, 3646.033801042726, 3775.339315619756, 3785.8107094645156, 3786.3752480840626, 3790.1851102012924, 5377.085895397752, 5453.609329620961, 5454.018276710191, 5476.3702174250075, 5478.534324582415, 4895.437024742129, 4911.533404326583, 4925.408950925876, 4946.194638956791, 5009.524095210949, 5616.887662246773, 5751.22358481608, 5752.971235143839, 5822.854428639275, 5835.766569337221, 4137.379393091031, 4149.83400663973, 4160.981923766971, 4161.689067943588, 4198.685098617585, 5877.265341832271, 6125.816225513242, 6131.662758548278, 6135.447809697104, 6147.0, 4136.152088821785, 4146.170765846782, 4172.624463798273, 4173.457450531411, 4173.5409104998425, 4225.429567008476, 4240.300350442142, 4250.638695710899, 4251.383549385384, 4255.6169944705125, 4859.514048595112, 4910.238912968495, 4912.852614421573, 4926.852194434173, 4957.132501812169, 5741.913871291934, 5817.970910145422, 5844.0, 5867.735951882176, 5868.559858010666, 1473.1161303218198, 1475.0043720488627, 1493.2011373914904, 1494.75336569467, 1497.4010395841533, 917.5870858113875, 919.6413398774483, 925.7601972833729, 931.59475628102, 957.7749228931195, 5001.874953126201, 5029.622778291569, 5057.367829021372, 5141.691498510101, 5169.560587350117, 5257.316548848626, 5282.366116066097, 5316.245638939141, 5324.0, 5357.276767636397, 4891.486393928657, 4894.290327902506, 5032.018756342478, 5084.77118529667, 5130.333056702605, 2849.9287517811804, 2863.040881304786, 2887.3503461721366, 2893.6382952130984, 2914.3970816051087, 5455.34535855692, 5460.044492213926, 5475.698836564027, 5495.725213739377, 5501.669899806025, 5467.020473841766, 5716.942365662366, 6081.209442772411, 6127.295361033538, 6180.8763824723255, 6130.877382452326, 6174.753009879644, 6217.502599792006, 6244.781432649836, 6281.120643109968, 5783.392743762012, 5994.31065427464, 6033.42682445167, 6095.35998720128, 6115.327313995368, 5947.791827286024, 5985.760569577343, 6000.489958353589, 6008.579399441997, 6023.608465449732, 6065.423784740443, 6203.844903877439, 6218.53360997936, 6226.848033113888, 6247.281562620356, 4217.831286748618, 4259.275923093143, 4265.680073994401, 4268.359746038119, 4282.828686852491, 5808.970955145197, 5984.431479009487, 6107.083937409424, 6128.0, 6160.845978850564, 5884.705764711833, 5908.970455147697, 5919.526437885045, 5922.763089476372, 5926.970365148147, 5808.448197421239, 5829.941700583109, 5875.618084824473, 5925.674087925206, 5946.554008449297, 5575.832725018256, 5702.885942281214, 5747.626404283708, 5771.509421699203, 5860.706964651836, 5842.2405087338375, 5894.557908156819, 5905.936931352398, 5929.673867937305, 5937.881242375042, 5614.6631202128, 5736.971315143564, 5769.53843692512, 5777.884442311214, 5793.884122317614], "value": 4361.114668517575, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.7097161135548, 772.9912464234176, 804.4971892567146, 828.1925123005067, 841.8484672758905, 14863.628409289773, 14892.106473611577, 14982.475613353536, 15127.092374457541, 16457.423990160347, 14756.0, 15216.163111028889, 15236.238188090607, 15241.390344386238, 15289.541313760605, 785.8742601183826, 794.1026639896937, 808.7695006923028, 808.8301456694102, 810.8459392715395, 807.321849646297, 811.1726039439768, 811.4806523824757, 812.8333691593209, 813.6745301879266, 852.3053711225363, 853.2704537620339, 855.5337341149088, 856.3235044314983, 862.1378621378622, 850.345234169689, 853.5007020892754, 853.5007020892785, 856.7044369692509, 858.2018722587991, 613.1262950295855, 618.505195843328, 619.2383368456823, 622.1290193728815, 623.2365352443221, 15566.922165389215, 15592.0, 15680.529584112495, 15681.294341754648, 15682.68634627301, 13961.860381396158, 14008.0, 14505.0, 14765.261736913111, 14901.701965960729, 11982.101342399268, 11995.820062699066, 12229.510819567207, 12250.632481025494, 12287.262764234174, 3856.633619806114, 3882.49527561418, 3910.8240129194255, 3919.3533067043904, 3993.101552150743, 61246.38753612496, 61388.38611613871, 62110.37889621091, 62501.37498625001, 64557.67721161364, 10620.89379106199, 11231.775364492827, 11843.0, 11872.228305160137, 12000.819987700017, 21291.57416851654, 21307.0, 21341.573168536543, 21372.78627213739, 21454.24910128138, 8585.957070214608, 8674.826503469896, 8851.380403371832, 8916.955415222883, 9021.909780902108, 4811.639127065414, 4867.099586576494, 4874.195757699939, 4947.282644016669, 4955.35580374549, 3746.0073080633656, 3867.8066096695616, 3868.3423817951016, 3873.96126038736, 3882.864099756495, 670.269406347084, 670.2928410526844, 676.202081543783, 678.7013713965938, 699.3915293694519, 605.449041372349, 701.3792793377897, 723.442948929332, 761.6534476813148, 768.0, 10496.370217786956, 10527.263091583516, 10576.576936922436, 10622.73443163927, 10814.891851081546, 621.4810633121303, 647.4820143884873, 652.1717418877998, 704.5807744392079, 729.6351824087956, 4515.729056256635, 4591.311303304531, 4613.838515651936, 4621.1219868224925, 4694.859154225379, 71093.64453177701, 113552.0, 119022.0, 120408.3979580114, 122028.0, 64879.35120648733, 71860.64069679723, 98937.61155078613, 99532.50233748785, 104283.0, 60016.69991650101, 91121.0, 91205.54397227972, 92329.0, 92455.53772231095, 9349.859752103588, 9664.661736839176, 9677.70966870995, 9720.368176068532, 9793.902060979584, 49675.75162124166, 50590.747046264536, 51714.96570068653, 51761.0, 52203.0, 72773.27226727665, 74375.0, 76337.0, 76913.23086769285, 78184.0, 10984.890151098707, 11148.665540033811, 11332.206745528063, 11367.147463940073, 11571.826422603835, 13185.208887466782, 14394.35225414838, 15172.393104275705, 15237.238138093273, 15335.846641533442, 13937.58187254384, 14179.0, 14183.716325673222, 14258.643533911736, 14759.262036898326, 13391.129576577492, 13633.727325453634, 14261.144331340152, 14850.108993460426, 15228.238588070331, 13854.584362469142, 14276.559278670939, 14414.927925360305, 14447.0, 14863.554093377215, 11767.23512971654, 11984.820227696417, 12045.759084818079, 12251.877481225074, 12406.81389779136, 11859.822102668639, 11944.402779860799, 12051.397430128634, 12276.140670153003, 12359.25844449336], "value": 7600.266299473846, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 110.0, 112.0, 110.0, 111.0, 112.0, 110.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 152.0, 187.0, 125.0, 158.0, 160.0, 131.0, 177.0, 135.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 166.0, 165.0, 174.0, 163.0, 164.0, 162.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 152.0, 77.0, 75.0, 79.0, 76.0, 161.0, 76.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 140.0, 85.0, 85.0, 84.0, 140.0, 85.0, 84.0, 142.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 122.0, 119.0, 118.0, 118.0, 117.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 149.0, 147.0, 148.0, 147.0, 148.0, 151.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 94.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 54.0, 55.0, 55.0, 53.0, 57.0, 53.0, 54.0, 53.0, 52.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 63.0, 62.0, 63.0, 67.0, 63.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 79.0, 80.0, 81.0, 80.0, 80.0, 80.0, 102.0, 80.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 125.0, 123.0, 122.0, 123.0, 134.0, 136.0, 141.0, 127.0, 127.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 159.0, 161.0, 162.0, 159.0, 161.0, 159.0, 161.0, 157.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 66.0, 66.0, 63.0, 63.0, 62.0, 66.0, 66.0], "value": 64.7, "unit": "score"}]}]} 16:37:03 INFO - Return code: 0 16:37:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:37:03 ERROR - # TBPL SUCCESS # 16:37:03 INFO - Running post-action listener: _resource_record_post_action 16:37:03 INFO - ##### 16:37:03 INFO - ##### Finished run-tests step (success) 16:37:03 INFO - ##### 16:37:03 INFO - Running post-run listener: _resource_record_post_run 16:37:03 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541052928; Read time: 20; Write time: 592604 16:37:03 INFO - TinderboxPrint: CPU usage
13.4% 16:37:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 16:37:03 INFO - TinderboxPrint: I/O write bytes / time
541,052,928 / 592,604 16:37:03 INFO - TinderboxPrint: CPU idle
8,221.9 (86.5%) 16:37:03 INFO - TinderboxPrint: CPU user
1,219.7 (12.8%) 16:37:03 INFO - TinderboxPrint: Swap in / out
0 / 0 16:37:03 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 248786944; Read time: 0; Write time: 408856 16:37:03 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292265984; Read time: 20; Write time: 183748 16:37:03 INFO - Running post-run listener: _upload_blobber_files 16:37:03 INFO - Blob upload gear active. 16:37:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:37:03 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 16:37:03 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'] 16:37:03 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 16:37:04 INFO - (blobuploader) - INFO - Open directory for files ... 16:37:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:37:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:37:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:37:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:37:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:37:04 INFO - (blobuploader) - INFO - Done attempting. 16:37:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:37:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:37:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:37:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:37:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:37:08 INFO - (blobuploader) - INFO - Done attempting. 16:37:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:37:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:37:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:37:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:37:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:37:09 INFO - (blobuploader) - INFO - Done attempting. 16:37:09 INFO - (blobuploader) - INFO - Iteration through files over. 16:37:09 INFO - Return code: 0 16:37:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:37:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:37:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52caebf496cb7f1facacf2883b014a1d9166d2e2b4343ffdd60a9f064adef899c871c4f4b2f79c5425674a9c7ebdd326cc1da03a9dea05fb0dad7e2bc49d3d6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8266a68316d1374927672329d77039e925d8ebbe25e45472880c69779ab0c83e871dea0dbba5f11890f817e3898ff8c3543efc69695e8f021bde74946c8cf0be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9043908584fedbc2b7f94bf0cf0b77876d8dd0fa21a5fcd3b604f918fa24c54c3be6c5d73164e34c124b88123e9c8e61dad755b18f84a517901616a5575dca1a"} 16:37:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:37:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:37:09 INFO - Contents: 16:37:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52caebf496cb7f1facacf2883b014a1d9166d2e2b4343ffdd60a9f064adef899c871c4f4b2f79c5425674a9c7ebdd326cc1da03a9dea05fb0dad7e2bc49d3d6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8266a68316d1374927672329d77039e925d8ebbe25e45472880c69779ab0c83e871dea0dbba5f11890f817e3898ff8c3543efc69695e8f021bde74946c8cf0be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9043908584fedbc2b7f94bf0cf0b77876d8dd0fa21a5fcd3b604f918fa24c54c3be6c5d73164e34c124b88123e9c8e61dad755b18f84a517901616a5575dca1a"} 16:37:09 INFO - Running post-run listener: copy_logs_to_upload_dir 16:37:09 INFO - Copying logs to upload dir... 16:37:09 INFO - mkdir: /builds/slave/test/build/upload/logs 16:37:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.586682 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-09 16:37:09.139824) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:09.143685) ========= 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=db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989 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/52caebf496cb7f1facacf2883b014a1d9166d2e2b4343ffdd60a9f064adef899c871c4f4b2f79c5425674a9c7ebdd326cc1da03a9dea05fb0dad7e2bc49d3d6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8266a68316d1374927672329d77039e925d8ebbe25e45472880c69779ab0c83e871dea0dbba5f11890f817e3898ff8c3543efc69695e8f021bde74946c8cf0be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9043908584fedbc2b7f94bf0cf0b77876d8dd0fa21a5fcd3b604f918fa24c54c3be6c5d73164e34c124b88123e9c8e61dad755b18f84a517901616a5575dca1a"} build_url:https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/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/52caebf496cb7f1facacf2883b014a1d9166d2e2b4343ffdd60a9f064adef899c871c4f4b2f79c5425674a9c7ebdd326cc1da03a9dea05fb0dad7e2bc49d3d6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8266a68316d1374927672329d77039e925d8ebbe25e45472880c69779ab0c83e871dea0dbba5f11890f817e3898ff8c3543efc69695e8f021bde74946c8cf0be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9043908584fedbc2b7f94bf0cf0b77876d8dd0fa21a5fcd3b604f918fa24c54c3be6c5d73164e34c124b88123e9c8e61dad755b18f84a517901616a5575dca1a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:09.168992) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:09.169335) ========= 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=db0483c52d987ecb441a263b000001ad-1465514193.799918-638199989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:09.255143) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 16:37:09.255938) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 16:37:09.256708) ========= ========= Total master_lag: 0.18 =========