builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1466966065.46 results: success (0) buildid: 20160626004021 builduid: 459145537dc84a29aa5814d75de7e674 revision: afcdd85399636b518887cc17aedbda8cc1c1f197 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 11:34:25.463861) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 11:34:25.464275) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 11:34:25.464562) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 11:34:25.489786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:34:25.490346) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-26 11:34:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.6M=0s 2016-06-26 11:34:26 (50.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128166 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:34:25.636563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:34:25.636853) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013677 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:34:25.689864) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:34:25.690185) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev afcdd85399636b518887cc17aedbda8cc1c1f197 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev afcdd85399636b518887cc17aedbda8cc1c1f197 --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=516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-26 11:34:26,881 truncating revision to first 12 chars 2016-06-26 11:34:26,881 Setting DEBUG logging. 2016-06-26 11:34:26,881 attempt 1/10 2016-06-26 11:34:26,881 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/afcdd8539963?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-26 11:34:27,173 unpacking tar archive at: mozilla-aurora-afcdd8539963/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617437 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:34:26.323070) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 11:34:26.323374) ========= script_repo_revision: afcdd85399636b518887cc17aedbda8cc1c1f197 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 11:34:26.323855) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 11:34:26.324160) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 11:34:26.333633) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-26 11:34:26.334121) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:34:27 INFO - MultiFileLogger online at 20160626 11:34:27 in /builds/slave/test 11:34:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:34:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:34:27 INFO - {'append_to_log': False, 11:34:27 INFO - 'base_work_dir': '/builds/slave/test', 11:34:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:34:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:34:27 INFO - 'branch': 'Mozilla-Aurora', 11:34:27 INFO - 'buildbot_json_path': 'buildprops.json', 11:34:27 INFO - 'config_files': ('talos/linux_config.py',), 11:34:27 INFO - 'default_actions': ('clobber', 11:34:27 INFO - 'read-buildbot-config', 11:34:27 INFO - 'download-and-extract', 11:34:27 INFO - 'populate-webroot', 11:34:27 INFO - 'create-virtualenv', 11:34:27 INFO - 'install', 11:34:27 INFO - 'run-tests'), 11:34:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:34:27 INFO - 'download_minidump_stackwalk': True, 11:34:27 INFO - 'download_symbols': 'ondemand', 11:34:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:34:27 INFO - 'tooltool.py': '/tools/tooltool.py', 11:34:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:34:27 INFO - '/tools/misc-python/virtualenv.py')}, 11:34:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:34:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:34:27 INFO - 'installer_path': 'installer.exe', 11:34:27 INFO - 'log_level': 'info', 11:34:27 INFO - 'log_name': 'talos', 11:34:27 INFO - 'log_to_console': True, 11:34:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:34:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:34:27 INFO - 'opt_config_files': (), 11:34:27 INFO - 'pip_index': False, 11:34:27 INFO - 'sps_profile': False, 11:34:27 INFO - 'sps_profile_interval': 0, 11:34:27 INFO - 'suite': 'dromaeojs-e10s', 11:34:27 INFO - 'system_bits': '32', 11:34:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:34:27 INFO - 'title': 'talos-linux64-ix-061', 11:34:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:34:27 INFO - 'use_talos_json': True, 11:34:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:34:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:34:27 INFO - 'work_dir': 'build'} 11:34:27 INFO - ##### 11:34:27 INFO - ##### Running clobber step. 11:34:27 INFO - ##### 11:34:27 INFO - Running pre-action listener: _resource_record_pre_action 11:34:27 INFO - Running main action method: clobber 11:34:27 INFO - rmtree: /builds/slave/test/build 11:34:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:34:28 INFO - Running post-action listener: _resource_record_post_action 11:34:28 INFO - ##### 11:34:28 INFO - ##### Finished clobber step (success) 11:34:28 INFO - ##### 11:34:28 INFO - ##### 11:34:28 INFO - ##### Running read-buildbot-config step. 11:34:28 INFO - ##### 11:34:28 INFO - Running pre-action listener: _resource_record_pre_action 11:34:28 INFO - Running main action method: read_buildbot_config 11:34:28 INFO - Using buildbot properties: 11:34:28 INFO - { 11:34:28 INFO - "project": "", 11:34:28 INFO - "product": "firefox", 11:34:28 INFO - "script_repo_revision": "production", 11:34:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:34:28 INFO - "repository": "", 11:34:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:34:28 INFO - "buildid": "20160626004021", 11:34:28 INFO - "stage_platform": "linux64-pgo", 11:34:28 INFO - "basedir": "/builds/slave/test", 11:34:28 INFO - "nightly_build": "True", 11:34:28 INFO - "buildnumber": 369, 11:34:28 INFO - "slavename": "talos-linux64-ix-061", 11:34:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:34:28 INFO - "platform": "ubuntu64_hw", 11:34:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:34:28 INFO - "branch": "mozilla-aurora", 11:34:28 INFO - "repo_path": "releases/mozilla-aurora", 11:34:28 INFO - "revision": "afcdd85399636b518887cc17aedbda8cc1c1f197", 11:34:28 INFO - "pgo_build": "True", 11:34:28 INFO - "builduid": "459145537dc84a29aa5814d75de7e674", 11:34:28 INFO - "slavebuilddir": "test" 11:34:28 INFO - } 11:34:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 11:34:28 INFO - Running post-action listener: _resource_record_post_action 11:34:28 INFO - ##### 11:34:28 INFO - ##### Finished read-buildbot-config step (success) 11:34:28 INFO - ##### 11:34:28 INFO - ##### 11:34:28 INFO - ##### Running download-and-extract step. 11:34:28 INFO - ##### 11:34:28 INFO - Running pre-action listener: _resource_record_pre_action 11:34:28 INFO - Running main action method: download_and_extract 11:34:28 INFO - mkdir: /builds/slave/test/build/tests 11:34: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')]} 11:34:28 INFO - https://queue.taskcluster.net/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:34:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:34:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:34:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:34:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:34:35 INFO - Downloaded 1361 bytes. 11:34:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:34:35 INFO - Using the following test package requirements: 11:34:35 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 11:34:35 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:34:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:34:35 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:34:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:34:35 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:34:35 INFO - u'jsshell-linux-x86_64.zip'], 11:34:35 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:34:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:34:35 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 11:34:35 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:34:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:34:35 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:34:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:34:35 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:34:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:34:35 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:34:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:34:35 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:35 INFO - https://queue.taskcluster.net/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:34:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:34:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:34:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:34:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:34:38 INFO - Downloaded 24516409 bytes. 11:34:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:34:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:34:40 INFO - Return code: 0 11:34:40 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:34: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')]} 11:34:40 INFO - https://queue.taskcluster.net/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:34:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:34:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:34:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:34:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:34:49 INFO - Downloaded 24516409 bytes. 11:34:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:34:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:34:51 INFO - Return code: 0 11:34:51 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')]} 11:34:51 INFO - https://queue.taskcluster.net/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:34:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 11:34:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 11:34:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 11:34:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:34:51 INFO - Downloaded 10833369 bytes. 11:34:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:34:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:34:52 INFO - Return code: 0 11:34: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')]} 11:34:52 INFO - https://queue.taskcluster.net/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:34:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:34:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:34:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:34:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:34:55 INFO - Downloaded 63629768 bytes. 11:34:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:34:55 INFO - mkdir: /builds/slave/test/properties 11:34:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:34:55 INFO - Writing to file /builds/slave/test/properties/build_url 11:34:55 INFO - Contents: 11:34:55 INFO - build_url:https://queue.taskcluster.net/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:34:55 INFO - Running post-action listener: _resource_record_post_action 11:34:55 INFO - Running post-action listener: set_extra_try_arguments 11:34:55 INFO - ##### 11:34:55 INFO - ##### Finished download-and-extract step (success) 11:34:55 INFO - ##### 11:34:55 INFO - ##### 11:34:55 INFO - ##### Running populate-webroot step. 11:34:55 INFO - ##### 11:34:55 INFO - Running pre-action listener: _resource_record_pre_action 11:34:55 INFO - Running main action method: populate_webroot 11:34:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:34:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:34:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:34:55 INFO - '--tppagecycles', 11:34:55 INFO - '7'], 11:34:55 INFO - 'tests': ['tsvgm']}}, 11:34:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:34:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:34:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:34:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:34:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:34:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:34:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:55 INFO - 'talos_options': ['--disable-e10s'], 11:34:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:34:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:34:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:55 INFO - 'talos_options': ['--disable-e10s'], 11:34:55 INFO - 'tests': ['damp', 'tps']}, 11:34:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:55 INFO - 'tests': ['damp', 'tps']}, 11:34:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:34:55 INFO - 'tests': ['dromaeo_dom']}, 11:34:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:34:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:34:55 INFO - 'tests': ['a11yr', 11:34:55 INFO - 'ts_paint', 11:34:55 INFO - 'tpaint', 11:34:55 INFO - 'sessionrestore', 11:34:55 INFO - 'sessionrestore_no_auto_restore', 11:34:55 INFO - 'tabpaint']}, 11:34:55 INFO - 'other-e10s': {'tests': ['a11yr', 11:34:55 INFO - 'ts_paint', 11:34:55 INFO - 'tpaint', 11:34:55 INFO - 'sessionrestore', 11:34:55 INFO - 'sessionrestore_no_auto_restore', 11:34:55 INFO - 'tabpaint']}, 11:34:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:34:55 INFO - 'ts_paint', 11:34:55 INFO - 'tpaint', 11:34:55 INFO - 'sessionrestore', 11:34:55 INFO - 'sessionrestore_no_auto_restore', 11:34:55 INFO - 'tabpaint']}, 11:34:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:34:55 INFO - 'ts_paint', 11:34:55 INFO - 'tpaint', 11:34:55 INFO - 'sessionrestore', 11:34:55 INFO - 'sessionrestore_no_auto_restore', 11:34:55 INFO - 'tabpaint']}, 11:34:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:34:55 INFO - 'tests': ['a11yr', 11:34:55 INFO - 'ts_paint', 11:34:55 INFO - 'tpaint', 11:34:55 INFO - 'sessionrestore', 11:34:55 INFO - 'sessionrestore_no_auto_restore', 11:34:55 INFO - 'tabpaint']}, 11:34:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:34:55 INFO - 'tests': ['a11yr', 11:34:55 INFO - 'ts_paint', 11:34:55 INFO - 'tpaint', 11:34:55 INFO - 'sessionrestore', 11:34:55 INFO - 'sessionrestore_no_auto_restore', 11:34:55 INFO - 'tabpaint']}, 11:34:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:34:55 INFO - 'tests': ['tsvgx', 11:34:55 INFO - 'tsvgr_opacity', 11:34:55 INFO - 'tart', 11:34:55 INFO - 'tscrollx', 11:34:55 INFO - 'cart']}, 11:34:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:34:55 INFO - 'tsvgr_opacity', 11:34:55 INFO - 'tart', 11:34:55 INFO - 'tscrollx', 11:34:55 INFO - 'cart']}, 11:34:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:55 INFO - 'talos_options': ['--disable-e10s'], 11:34:55 INFO - 'tests': ['tp5o']}, 11:34:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:55 INFO - 'tests': ['tp5o']}, 11:34:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:55 INFO - 'talos_options': ['--disable-e10s', 11:34:55 INFO - '--xperf_path', 11:34:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:34:55 INFO - 'tests': ['tp5n']}, 11:34:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:55 INFO - 'talos_options': ['--xperf_path', 11:34:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:34:55 INFO - 'tests': ['tp5n']}}, 11:34:55 INFO - 'talos.zip': {'path': '', 11:34:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:34:55 INFO - Running post-action listener: _resource_record_post_action 11:34:55 INFO - ##### 11:34:55 INFO - ##### Finished populate-webroot step (success) 11:34:55 INFO - ##### 11:34:55 INFO - ##### 11:34:55 INFO - ##### Running create-virtualenv step. 11:34:55 INFO - ##### 11:34:55 INFO - Running pre-action listener: _resource_record_pre_action 11:34:55 INFO - Running main action method: create_virtualenv 11:34:55 INFO - Creating virtualenv /builds/slave/test/build/venv 11:34:55 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 11:34:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:34:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:34:55 INFO - Using real prefix '/usr' 11:34:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:34:56 INFO - Installing distribute.............................................................................................................................................................................................done. 11:34:58 INFO - Installing pip.................done. 11:34:58 INFO - Return code: 0 11:34:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:58 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 0x7f791679df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', '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 11:34:58 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 11:34:58 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 11:34:58 INFO - Using env: {'DISPLAY': ':0', 11:34:58 INFO - 'HOME': '/home/cltbld', 11:34:58 INFO - 'LANG': 'en_US.UTF-8', 11:34:58 INFO - 'LANGUAGE': 'en_US:en', 11:34:58 INFO - 'LOGNAME': 'cltbld', 11:34:58 INFO - 'MAIL': '/var/mail/cltbld', 11:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:58 INFO - 'MOZ_NO_REMOTE': '1', 11:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:58 INFO - 'NO_EM_RESTART': '1', 11:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:58 INFO - 'PWD': '/builds/slave/test', 11:34:58 INFO - 'SHELL': '/bin/bash', 11:34:58 INFO - 'SHLVL': '1', 11:34:58 INFO - 'TERM': 'linux', 11:34:58 INFO - 'TMOUT': '86400', 11:34:58 INFO - 'USER': 'cltbld', 11:34:58 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', 11:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:58 INFO - '_': '/tools/buildbot/bin/python'} 11:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:34:58 INFO - Cleaning up... 11:34:58 INFO - Return code: 0 11:34:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:58 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 0x7f791679df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', '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 11:34:58 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 11:34:58 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 11:34:58 INFO - Using env: {'DISPLAY': ':0', 11:34:58 INFO - 'HOME': '/home/cltbld', 11:34:58 INFO - 'LANG': 'en_US.UTF-8', 11:34:58 INFO - 'LANGUAGE': 'en_US:en', 11:34:58 INFO - 'LOGNAME': 'cltbld', 11:34:58 INFO - 'MAIL': '/var/mail/cltbld', 11:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:58 INFO - 'MOZ_NO_REMOTE': '1', 11:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:58 INFO - 'NO_EM_RESTART': '1', 11:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:58 INFO - 'PWD': '/builds/slave/test', 11:34:58 INFO - 'SHELL': '/bin/bash', 11:34:58 INFO - 'SHLVL': '1', 11:34:58 INFO - 'TERM': 'linux', 11:34:58 INFO - 'TMOUT': '86400', 11:34:58 INFO - 'USER': 'cltbld', 11:34:58 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', 11:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:58 INFO - '_': '/tools/buildbot/bin/python'} 11:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:58 INFO - Downloading/unpacking psutil>=3.1.1 11:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:35:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:35:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:35:00 INFO - Installing collected packages: psutil 11:35:00 INFO - Running setup.py install for psutil 11:35:00 INFO - building 'psutil._psutil_linux' extension 11:35:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:35:01 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 11:35:01 INFO - building 'psutil._psutil_posix' extension 11:35:01 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 11:35:01 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 11:35:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:35:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:35:01 INFO - Successfully installed psutil 11:35:01 INFO - Cleaning up... 11:35:01 INFO - Return code: 0 11:35:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:01 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 0x7f791679df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', '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 11:35:01 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 11:35:01 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 11:35:01 INFO - Using env: {'DISPLAY': ':0', 11:35:01 INFO - 'HOME': '/home/cltbld', 11:35:01 INFO - 'LANG': 'en_US.UTF-8', 11:35:01 INFO - 'LANGUAGE': 'en_US:en', 11:35:01 INFO - 'LOGNAME': 'cltbld', 11:35:01 INFO - 'MAIL': '/var/mail/cltbld', 11:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:01 INFO - 'MOZ_NO_REMOTE': '1', 11:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:01 INFO - 'NO_EM_RESTART': '1', 11:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:01 INFO - 'PWD': '/builds/slave/test', 11:35:01 INFO - 'SHELL': '/bin/bash', 11:35:01 INFO - 'SHLVL': '1', 11:35:01 INFO - 'TERM': 'linux', 11:35:01 INFO - 'TMOUT': '86400', 11:35:01 INFO - 'USER': 'cltbld', 11:35:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', 11:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:01 INFO - '_': '/tools/buildbot/bin/python'} 11:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:35:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:35:03 INFO - Installing collected packages: mozsystemmonitor 11:35:03 INFO - Running setup.py install for mozsystemmonitor 11:35:03 INFO - Successfully installed mozsystemmonitor 11:35:03 INFO - Cleaning up... 11:35:03 INFO - Return code: 0 11:35:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:03 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 0x7f791679df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', '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 11:35:03 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 11:35:03 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 11:35:03 INFO - Using env: {'DISPLAY': ':0', 11:35:03 INFO - 'HOME': '/home/cltbld', 11:35:03 INFO - 'LANG': 'en_US.UTF-8', 11:35:03 INFO - 'LANGUAGE': 'en_US:en', 11:35:03 INFO - 'LOGNAME': 'cltbld', 11:35:03 INFO - 'MAIL': '/var/mail/cltbld', 11:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:03 INFO - 'MOZ_NO_REMOTE': '1', 11:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:03 INFO - 'NO_EM_RESTART': '1', 11:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:03 INFO - 'PWD': '/builds/slave/test', 11:35:03 INFO - 'SHELL': '/bin/bash', 11:35:03 INFO - 'SHLVL': '1', 11:35:03 INFO - 'TERM': 'linux', 11:35:03 INFO - 'TMOUT': '86400', 11:35:03 INFO - 'USER': 'cltbld', 11:35:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', 11:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:03 INFO - '_': '/tools/buildbot/bin/python'} 11:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:04 INFO - Downloading/unpacking jsonschema==2.5.1 11:35:04 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 11:35:04 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 11:35:04 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 11:35:04 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 11:35:04 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 11:35:04 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 11:35:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:35:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:35: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 11:35: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 11:35: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 11:35: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 11:35: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 11:35: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 11:35:06 INFO - Downloading functools32-3.2.3-2.tar.gz 11:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:35:06 INFO - warning: no files found matching '*.txt' 11:35:06 INFO - no previously-included directories found matching 'build' 11:35:06 INFO - no previously-included directories found matching 'dist' 11:35:06 INFO - no previously-included directories found matching '.git*' 11:35:06 INFO - Installing collected packages: jsonschema, functools32 11:35:06 INFO - Running setup.py install for functools32 11:35:06 INFO - warning: no files found matching '*.txt' 11:35:06 INFO - no previously-included directories found matching 'build' 11:35:06 INFO - no previously-included directories found matching 'dist' 11:35:06 INFO - no previously-included directories found matching '.git*' 11:35:06 INFO - Successfully installed jsonschema functools32 11:35:06 INFO - Cleaning up... 11:35:06 INFO - Return code: 0 11:35:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:06 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 0x7f791679df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', '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 11:35:06 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 11:35:06 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 11:35:06 INFO - Using env: {'DISPLAY': ':0', 11:35:06 INFO - 'HOME': '/home/cltbld', 11:35:06 INFO - 'LANG': 'en_US.UTF-8', 11:35:06 INFO - 'LANGUAGE': 'en_US:en', 11:35:06 INFO - 'LOGNAME': 'cltbld', 11:35:06 INFO - 'MAIL': '/var/mail/cltbld', 11:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:06 INFO - 'MOZ_NO_REMOTE': '1', 11:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:06 INFO - 'NO_EM_RESTART': '1', 11:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:06 INFO - 'PWD': '/builds/slave/test', 11:35:06 INFO - 'SHELL': '/bin/bash', 11:35:06 INFO - 'SHLVL': '1', 11:35:06 INFO - 'TERM': 'linux', 11:35:06 INFO - 'TMOUT': '86400', 11:35:06 INFO - 'USER': 'cltbld', 11:35:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', 11:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:06 INFO - '_': '/tools/buildbot/bin/python'} 11:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:06 INFO - Downloading/unpacking blobuploader==1.2.4 11:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:08 INFO - Downloading blobuploader-1.2.4.tar.gz 11:35:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:35:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:35: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 11:35: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 11:35: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 11:35: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 11:35: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 11:35: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 11:35:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:35:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:35: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 11:35: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 11:35: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 11:35: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 11:35: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 11:35: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 11:35:09 INFO - Downloading docopt-0.6.1.tar.gz 11:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:35:09 INFO - Installing collected packages: blobuploader, requests, docopt 11:35:09 INFO - Running setup.py install for blobuploader 11:35:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:35:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:35:09 INFO - Running setup.py install for requests 11:35:09 INFO - Running setup.py install for docopt 11:35:09 INFO - Successfully installed blobuploader requests docopt 11:35:09 INFO - Cleaning up... 11:35:09 INFO - Return code: 0 11:35:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:09 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 0x7f791679df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', '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 11:35:09 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 11:35:09 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 11:35:09 INFO - Using env: {'DISPLAY': ':0', 11:35:09 INFO - 'HOME': '/home/cltbld', 11:35:09 INFO - 'LANG': 'en_US.UTF-8', 11:35:09 INFO - 'LANGUAGE': 'en_US:en', 11:35:09 INFO - 'LOGNAME': 'cltbld', 11:35:09 INFO - 'MAIL': '/var/mail/cltbld', 11:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:09 INFO - 'MOZ_NO_REMOTE': '1', 11:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:09 INFO - 'NO_EM_RESTART': '1', 11:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:09 INFO - 'PWD': '/builds/slave/test', 11:35:09 INFO - 'SHELL': '/bin/bash', 11:35:09 INFO - 'SHLVL': '1', 11:35:09 INFO - 'TERM': 'linux', 11:35:09 INFO - 'TMOUT': '86400', 11:35:09 INFO - 'USER': 'cltbld', 11:35:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', 11:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:09 INFO - '_': '/tools/buildbot/bin/python'} 11:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:35:10 INFO - Running setup.py (path:/tmp/pip-ib4N3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:35:10 INFO - Running setup.py (path:/tmp/pip-5CCuPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:35:10 INFO - Running setup.py (path:/tmp/pip-Sj7NvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:35:10 INFO - Running setup.py (path:/tmp/pip-V3w65S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:35:10 INFO - Running setup.py (path:/tmp/pip-V7JIAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:35:10 INFO - Running setup.py (path:/tmp/pip-dEXMqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:35:10 INFO - Running setup.py (path:/tmp/pip-EFzls3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:35:10 INFO - Running setup.py (path:/tmp/pip-782zTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:35:10 INFO - Running setup.py (path:/tmp/pip-hMLYW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:35:10 INFO - Running setup.py (path:/tmp/pip-Eo6QqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:35:10 INFO - Running setup.py (path:/tmp/pip-A0qK_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:35:10 INFO - Running setup.py (path:/tmp/pip-n_bGwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:35:10 INFO - Running setup.py (path:/tmp/pip-ptErTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:35:11 INFO - Running setup.py (path:/tmp/pip-r3LjAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:35:11 INFO - Running setup.py (path:/tmp/pip-8DlNE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:35:11 INFO - Running setup.py (path:/tmp/pip-uHqqdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:35:11 INFO - Running setup.py (path:/tmp/pip-n_Cioi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:35:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:35:11 INFO - Running setup.py install for manifestparser 11:35:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:35:11 INFO - Running setup.py install for mozcrash 11:35:11 INFO - Running setup.py install for mozdebug 11:35:11 INFO - Running setup.py install for mozdevice 11:35:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:35:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:35:11 INFO - Running setup.py install for mozfile 11:35:11 INFO - Running setup.py install for mozhttpd 11:35:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:35:11 INFO - Running setup.py install for mozinfo 11:35:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:35:12 INFO - Running setup.py install for mozInstall 11:35:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:35:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:35:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:35:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:35:12 INFO - Running setup.py install for mozleak 11:35:12 INFO - Running setup.py install for mozlog 11:35:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:35:12 INFO - Running setup.py install for moznetwork 11:35:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:35:12 INFO - Running setup.py install for mozprocess 11:35:12 INFO - Running setup.py install for mozprofile 11:35:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:35:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:35:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:35:12 INFO - Running setup.py install for mozrunner 11:35:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:35:12 INFO - Running setup.py install for mozscreenshot 11:35:12 INFO - Running setup.py install for moztest 11:35:13 INFO - Running setup.py install for mozversion 11:35:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:35:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:35:13 INFO - Cleaning up... 11:35:13 INFO - Return code: 0 11:35:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:13 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 0x7f791679df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', '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 11:35:13 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 11:35:13 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 11:35:13 INFO - Using env: {'DISPLAY': ':0', 11:35:13 INFO - 'HOME': '/home/cltbld', 11:35:13 INFO - 'LANG': 'en_US.UTF-8', 11:35:13 INFO - 'LANGUAGE': 'en_US:en', 11:35:13 INFO - 'LOGNAME': 'cltbld', 11:35:13 INFO - 'MAIL': '/var/mail/cltbld', 11:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:13 INFO - 'MOZ_NO_REMOTE': '1', 11:35:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:13 INFO - 'NO_EM_RESTART': '1', 11:35:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:13 INFO - 'PWD': '/builds/slave/test', 11:35:13 INFO - 'SHELL': '/bin/bash', 11:35:13 INFO - 'SHLVL': '1', 11:35:13 INFO - 'TERM': 'linux', 11:35:13 INFO - 'TMOUT': '86400', 11:35:13 INFO - 'USER': 'cltbld', 11:35:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', 11:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:13 INFO - '_': '/tools/buildbot/bin/python'} 11:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:35:13 INFO - Running setup.py (path:/tmp/pip-8jM3ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:35:13 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)) 11:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:35:13 INFO - Running setup.py (path:/tmp/pip-Xphrpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:35:13 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)) 11:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:35:13 INFO - Running setup.py (path:/tmp/pip-gYcec4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:35:13 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)) 11:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:35:13 INFO - Running setup.py (path:/tmp/pip-_SDSIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:35:13 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)) 11:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:35:13 INFO - Running setup.py (path:/tmp/pip-ZQwRYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:35:13 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)) 11:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:35:13 INFO - Running setup.py (path:/tmp/pip-ruzenO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:35:13 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)) 11:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:35:13 INFO - Running setup.py (path:/tmp/pip-uO87bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:35:13 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)) 11:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:35:13 INFO - Running setup.py (path:/tmp/pip-9nmlQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:35:13 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)) 11:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:35:13 INFO - Running setup.py (path:/tmp/pip-5qajLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:35:13 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)) 11:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:35:13 INFO - Running setup.py (path:/tmp/pip-nQzqVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:35:14 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)) 11:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:35:14 INFO - Running setup.py (path:/tmp/pip-4jvL1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:35:14 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)) 11:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:35:14 INFO - Running setup.py (path:/tmp/pip-nYdvIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:35:14 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)) 11:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:35:14 INFO - Running setup.py (path:/tmp/pip-oWlIuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:35:14 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)) 11:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:35:14 INFO - Running setup.py (path:/tmp/pip-HsvEp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:35:14 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)) 11:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:35:14 INFO - Running setup.py (path:/tmp/pip-rN_SQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:35:14 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)) 11:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:35:14 INFO - Running setup.py (path:/tmp/pip-QyCbYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:35:14 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)) 11:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:35:14 INFO - Running setup.py (path:/tmp/pip-aEm7w5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:35:14 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)) 11:35:14 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)) 11:35:14 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)) 11:35:14 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)) 11:35:14 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)) 11:35:14 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)) 11:35:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:16 INFO - Downloading blessings-1.6.tar.gz 11:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:35:16 INFO - Installing collected packages: blessings 11:35:16 INFO - Running setup.py install for blessings 11:35:16 INFO - Successfully installed blessings 11:35:16 INFO - Cleaning up... 11:35:16 INFO - Return code: 0 11:35:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:35:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:35:16 INFO - Reading from file tmpfile_stdout 11:35:16 INFO - Current package versions: 11:35:16 INFO - argparse == 1.2.1 11:35:16 INFO - blessings == 1.6 11:35:16 INFO - blobuploader == 1.2.4 11:35:16 INFO - docopt == 0.6.1 11:35:16 INFO - functools32 == 3.2.3-2 11:35:16 INFO - jsonschema == 2.5.1 11:35:16 INFO - manifestparser == 1.1 11:35:16 INFO - mozInstall == 1.12 11:35:16 INFO - mozcrash == 0.17 11:35:16 INFO - mozdebug == 0.1 11:35:16 INFO - mozdevice == 0.48 11:35:16 INFO - mozfile == 1.2 11:35:16 INFO - mozhttpd == 0.7 11:35:16 INFO - mozinfo == 0.9 11:35:16 INFO - mozleak == 0.1 11:35:16 INFO - mozlog == 3.2 11:35:16 INFO - moznetwork == 0.27 11:35:16 INFO - mozprocess == 0.22 11:35:16 INFO - mozprofile == 0.28 11:35:16 INFO - mozrunner == 6.11 11:35:16 INFO - mozscreenshot == 0.1 11:35:16 INFO - mozsystemmonitor == 0.3 11:35:16 INFO - moztest == 0.7 11:35:16 INFO - mozversion == 1.4 11:35:16 INFO - psutil == 3.1.1 11:35:16 INFO - requests == 1.2.3 11:35:16 INFO - wsgiref == 0.1.2 11:35:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:16 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 0x7f791679df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', '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 11:35:16 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 11:35:16 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 11:35:16 INFO - Using env: {'DISPLAY': ':0', 11:35:16 INFO - 'HOME': '/home/cltbld', 11:35:16 INFO - 'LANG': 'en_US.UTF-8', 11:35:16 INFO - 'LANGUAGE': 'en_US:en', 11:35:16 INFO - 'LOGNAME': 'cltbld', 11:35:16 INFO - 'MAIL': '/var/mail/cltbld', 11:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:16 INFO - 'MOZ_NO_REMOTE': '1', 11:35:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:16 INFO - 'NO_EM_RESTART': '1', 11:35:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:16 INFO - 'PWD': '/builds/slave/test', 11:35:16 INFO - 'SHELL': '/bin/bash', 11:35:16 INFO - 'SHLVL': '1', 11:35:16 INFO - 'TERM': 'linux', 11:35:16 INFO - 'TMOUT': '86400', 11:35:16 INFO - 'USER': 'cltbld', 11:35:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', 11:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:16 INFO - '_': '/tools/buildbot/bin/python'} 11:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:17 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)) 11:35:17 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)) 11:35:17 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)) 11:35:17 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)) 11:35:17 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)) 11:35:17 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)) 11:35:17 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)) 11:35:17 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)) 11:35:17 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)) 11:35:17 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)) 11:35:17 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)) 11:35:17 INFO - Cleaning up... 11:35:17 INFO - Return code: 0 11:35:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:35:17 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')]} 11:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:17 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')]} 11:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:17 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 0x7f791679df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', '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 11:35:17 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 11:35:17 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 11:35:17 INFO - Using env: {'DISPLAY': ':0', 11:35:17 INFO - 'HOME': '/home/cltbld', 11:35:17 INFO - 'LANG': 'en_US.UTF-8', 11:35:17 INFO - 'LANGUAGE': 'en_US:en', 11:35:17 INFO - 'LOGNAME': 'cltbld', 11:35:17 INFO - 'MAIL': '/var/mail/cltbld', 11:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:17 INFO - 'MOZ_NO_REMOTE': '1', 11:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:17 INFO - 'NO_EM_RESTART': '1', 11:35:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:17 INFO - 'PWD': '/builds/slave/test', 11:35:17 INFO - 'SHELL': '/bin/bash', 11:35:17 INFO - 'SHLVL': '1', 11:35:17 INFO - 'TERM': 'linux', 11:35:17 INFO - 'TMOUT': '86400', 11:35:17 INFO - 'USER': 'cltbld', 11:35:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', 11:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:17 INFO - '_': '/tools/buildbot/bin/python'} 11:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:35:17 INFO - Cleaning up... 11:35:17 INFO - Return code: 0 11:35:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:35:17 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')]} 11:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:17 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')]} 11:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:17 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 0x7f791679df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', '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 11:35:17 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 11:35:17 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 11:35:17 INFO - Using env: {'DISPLAY': ':0', 11:35:17 INFO - 'HOME': '/home/cltbld', 11:35:17 INFO - 'LANG': 'en_US.UTF-8', 11:35:17 INFO - 'LANGUAGE': 'en_US:en', 11:35:17 INFO - 'LOGNAME': 'cltbld', 11:35:17 INFO - 'MAIL': '/var/mail/cltbld', 11:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:17 INFO - 'MOZ_NO_REMOTE': '1', 11:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:17 INFO - 'NO_EM_RESTART': '1', 11:35:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:17 INFO - 'PWD': '/builds/slave/test', 11:35:17 INFO - 'SHELL': '/bin/bash', 11:35:17 INFO - 'SHLVL': '1', 11:35:17 INFO - 'TERM': 'linux', 11:35:17 INFO - 'TMOUT': '86400', 11:35:17 INFO - 'USER': 'cltbld', 11:35:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', 11:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:17 INFO - '_': '/tools/buildbot/bin/python'} 11:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:17 INFO - Downloading/unpacking flake8 11:35:17 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 11:35:17 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 11:35:17 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 11:35:17 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 11:35:17 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 11:35:17 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 11:35:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:35:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:35:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:35:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:35:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:35:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:35:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:35:20 INFO - no previously-included directories found matching 'docs/_build' 11:35:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:35:20 INFO - Running setup.py install for pep8 11:35:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:35:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:35:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:35:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:35:20 INFO - no previously-included directories found matching 'docs/_build' 11:35:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:35:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:35:20 INFO - Cleaning up... 11:35:20 INFO - Return code: 0 11:35:20 INFO - Running post-action listener: _resource_record_post_action 11:35:20 INFO - Running post-action listener: _start_resource_monitoring 11:35:20 INFO - Starting resource monitoring. 11:35:20 INFO - ##### 11:35:20 INFO - ##### Finished create-virtualenv step (success) 11:35:20 INFO - ##### 11:35:20 INFO - ##### 11:35:20 INFO - ##### Running install step. 11:35:20 INFO - ##### 11:35:20 INFO - Running pre-action listener: _resource_record_pre_action 11:35:20 INFO - Running main action method: install 11:35:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:35:20 INFO - Reading from file tmpfile_stdout 11:35:20 INFO - Detecting whether we're running mozinstall >=1.0... 11:35:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:35:20 INFO - Reading from file tmpfile_stdout 11:35:20 INFO - Output received: 11:35:20 INFO - Usage: mozinstall [options] installer 11:35:20 INFO - Options: 11:35:20 INFO - -h, --help show this help message and exit 11:35:20 INFO - -d DEST, --destination=DEST 11:35:20 INFO - Directory to install application into. [default: 11:35:20 INFO - "/builds/slave/test"] 11:35:20 INFO - --app=APP Application being installed. [default: firefox] 11:35:20 INFO - mkdir: /builds/slave/test/build/application 11:35:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:35:36 INFO - Reading from file tmpfile_stdout 11:35:36 INFO - Output received: 11:35:36 INFO - /builds/slave/test/build/application/firefox/firefox 11:35:36 INFO - Running post-action listener: _resource_record_post_action 11:35:36 INFO - ##### 11:35:36 INFO - ##### Finished install step (success) 11:35:36 INFO - ##### 11:35:36 INFO - ##### 11:35:36 INFO - ##### Running run-tests step. 11:35:36 INFO - ##### 11:35:36 INFO - Running pre-action listener: _resource_record_pre_action 11:35:36 INFO - Running main action method: run_tests 11:35:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:35:36 INFO - Python 2.7.3 11:35:36 INFO - Return code: 0 11:35:36 INFO - grabbing minidump binary from tooltool 11:35: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')]} 11:35:36 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/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 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:35:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:35:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:35:36 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 11:35:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:35:36 INFO - Return code: 0 11:35:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:35:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:35:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:35:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:35:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:35:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:35:37 INFO - Return code: 0 11:35:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 11:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 11:35:37 INFO - Using env: {'DISPLAY': ':0', 11:35:37 INFO - 'HOME': '/home/cltbld', 11:35:37 INFO - 'LANG': 'en_US.UTF-8', 11:35:37 INFO - 'LANGUAGE': 'en_US:en', 11:35:37 INFO - 'LOGNAME': 'cltbld', 11:35:37 INFO - 'MAIL': '/var/mail/cltbld', 11:35:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:35:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:37 INFO - 'MOZ_NO_REMOTE': '1', 11:35:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:37 INFO - 'NO_EM_RESTART': '1', 11:35:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:37 INFO - 'PWD': '/builds/slave/test', 11:35:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:35:37 INFO - 'SHELL': '/bin/bash', 11:35:37 INFO - 'SHLVL': '1', 11:35:37 INFO - 'TERM': 'linux', 11:35:37 INFO - 'TMOUT': '86400', 11:35:37 INFO - 'USER': 'cltbld', 11:35:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787', 11:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:37 INFO - '_': '/tools/buildbot/bin/python'} 11:35:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 11:35:37 INFO - mozversion application_buildid: 20160626004021 11:35:37 INFO - mozversion application_changeset: afcdd85399636b518887cc17aedbda8cc1c1f197 11:35:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:35:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:35:37 INFO - mozversion application_name: Firefox 11:35:37 INFO - mozversion application_remotingname: firefox-dev 11:35:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:35:37 INFO - mozversion application_vendor: Mozilla 11:35:37 INFO - mozversion application_version: 49.0a2 11:35:37 INFO - mozversion platform_buildid: 20160626004021 11:35:37 INFO - mozversion platform_changeset: afcdd85399636b518887cc17aedbda8cc1c1f197 11:35:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:35:37 INFO - mozversion platform_version: 49.0a2 11:35:37 INFO - using testdate: 1466966137 11:35:37 INFO - actual date: 1466966137 11:35:37 INFO - starting webserver on 'localhost:49849' 11:35:37 INFO - SUITE-START | Running 2 tests 11:35:37 INFO - TEST-START | dromaeo_css 11:35:37 INFO - operating with platform_type : linux_ 11:35:37 INFO - Initialising browser for dromaeo_css test... 11:35:37 INFO - TEST-INFO | started process 16655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNUpX50/profile http://localhost:49849/getInfo.html) 11:35:42 INFO - PROCESS | 16655 | __metrics Screen width/height:1600/1200 11:35:42 INFO - PROCESS | 16655 | colorDepth:24 11:35:42 INFO - PROCESS | 16655 | Browser inner width/height: 1024/697 11:35:42 INFO - PROCESS | 16655 | __metrics 11:35:43 ERROR - PROCESS | 16655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 11:35:44 INFO - TEST-INFO | 16655: exit 0 11:35:44 INFO - Browser initialized. 11:35:44 INFO - Running cycle 1/1 for dromaeo_css test... 11:35:44 INFO - TEST-INFO | started process 16789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNUpX50/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:56 INFO - PROCESS | 16789 | RSS: Main: 155873280 11:35:56 INFO - PROCESS | 16789 | 11:36:46 INFO - PROCESS | 16789 | 1466966206113 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] 11:38:54 INFO - PROCESS | 16789 | Cycle 1(1): loaded http://localhost:49849/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49849/tests/dromaeo/cssquery-ext.html) 11:38:55 INFO - PROCESS | 16789 | RSS: Main: 160694272 11:38:55 INFO - PROCESS | 16789 | 11:41:57 INFO - PROCESS | 16789 | Cycle 1(1): loaded http://localhost:49849/tests/dromaeo/cssquery-ext.html (next: http://localhost:49849/tests/dromaeo/cssquery-jquery.html) 11:41:57 INFO - PROCESS | 16789 | RSS: Main: 157704192 11:41:57 INFO - PROCESS | 16789 | 11:44:59 INFO - PROCESS | 16789 | Cycle 1(1): loaded http://localhost:49849/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49849/tests/dromaeo/cssquery-mootools.html) 11:45:00 INFO - PROCESS | 16789 | RSS: Main: 157868032 11:45:00 INFO - PROCESS | 16789 | 11:48:01 INFO - PROCESS | 16789 | Cycle 1(1): loaded http://localhost:49849/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49849/tests/dromaeo/cssquery-prototype.html) 11:48:02 INFO - PROCESS | 16789 | RSS: Main: 157036544 11:48:02 INFO - PROCESS | 16789 | 11:51:04 INFO - PROCESS | 16789 | Cycle 1(1): loaded http://localhost:49849/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49849/tests/dromaeo/cssquery-yui.html) 11:51:05 INFO - PROCESS | 16789 | RSS: Main: 159055872 11:51:05 INFO - PROCESS | 16789 | 11:54:07 INFO - PROCESS | 16789 | Cycle 1(1): loaded http://localhost:49849/tests/dromaeo/cssquery-yui.html (next: http://localhost:49849/tests/dromaeo/cssquery-dojo.html) 11:54:08 INFO - PROCESS | 16789 | RSS: Main: 159563776 11:54:08 INFO - PROCESS | 16789 | 11:54:08 INFO - PROCESS | 16789 | __start_tp_report 11:54:08 INFO - PROCESS | 16789 | _x_x_mozilla_page_load 11:54:08 INFO - PROCESS | 16789 | _x_x_mozilla_page_load_details 11:54:08 INFO - PROCESS | 16789 | |i|pagename|runs| 11:54:08 INFO - PROCESS | 16789 | |0;dojo.html;3363.2096457332527;3399.473081672342;3410.1815564264575;3423.6405177456368;3437.742169337299;5664.660120392774;5665.405132461084;5698.5726070544715;5722.771089156434;5746.252987111669;5722.885542289152;5723;5752.971235143818;5773.971130144343;5803.680797556132;5155.097857874875;5174.146265866128;5224.320838291036;5249.081410753122;5273.920891186635;5109.974450127745;5121.923171152417;5296.682199068068;5302.893942121155;5304.840854774344;5187.066328060948;5192.506711862367;5195.974020129913;5203.661761985478;5218.399884013349;5178.300929374543;5214.061468935609;5228.294180285651;5240.580753539708;5278.076336641073;4997.90004199914;5125.6155788315655;5195.480451954812;5223.52988231061;5262.736863156827;5467.371252305996;5471.50756431919;5473.589480788957;5506.752196151183;5509.228707980886;6029.246344206974;6041.365656606037;6048.213732214784;6062.302835173923;6104.175936248594;5948.464638182584;6091.969540152315;6149.923763341442;6154;6193.752249909998;5718.857028574277;5777.19119323295;5780.653160810365;5808.970955145197;5812.8837423251725;6292.937070629327;6303.873922521524;6311.33730958252;6311.936880631227;6320;5813.680247586423;5949.970250148722;5953.851153721192;6055.394460553997;6061.36355682647;6112.655464441461;6123.709696704001;6124.168182837791;6126.397462875568;6151.323354431009;6016.127661489147;6034.668093254913;6065.181200537959;6080.604760690541;6083.330833608299;5924.14099955504;6006.369331220247;6008.969955150196;6090.756369745249;6096.634201947897;4650.720956742606;4662.440507139165;4666.673332866667;4677.064587082529;4691.132140554008;4165.4584903962295;4179.895502612399;4181.351890456984;4200.264953633102;4212.115455754265;5674.205611214434;5826.533877289807;5852.590318677737;5913.172155898178;5939.049752039739;6095.05526643371;6141.30190404341;6142.754289828356;6200.720967556471;6207.224096987877;5684.346300175533;5952.821415357546;5955.731992060368;5957.106434034929;5975.940240597538;5291.3121294231505;5320.255164277004;5335.226392173191;5365.248865158881;5378.13949768043;6393.712282947278;6444;6496.35036496356;6501.31736167705;6503.642299673469;5917.526597872074;6088.147659327609;6248.687565621792;6257;6265.624062556261;6260.186175797117;6357.7139028742895;6376.808695739135;6384.6169229846355;6421.967890160519;6035.275766907999;6059.727312271047;6073.726682299219;6076.088586711851;6086.847828804315;5942.792002280073;6050.21347224858;6065.969670151621;6095.573309868267;6187.969060154671;5947.672877991752;5954.225950626391;6005.549583781147;6005.849853753691;6042.093685947143;5905.379935106752;5923.644581325134;5956.344802071855;5960.374160713062;5962.880742385215;5695.8860822784145;5835.270591176103;5886.470217680429;5886.646801191942;5923.170756094237;6041.395860413923;6047.697615119138;6077.179580756541;6083.756649733961;6085.69571521431;5923.052311630118;5932.377100404396;5936.406359364029;5941.702914854326;5947.910781338197 11:54:08 INFO - PROCESS | 16789 | |1;ext.html;596.4929809661788;653.1867824558424;658.4501940879366;668.2115104177069;675.7567275780718;43562;45853.31220031702;45971.54028459715;46023.53976460234;50234.49765502344;48232.51767482324;48747.51252487474;48793.7560312198;48859.75570122153;48915.51084489154;9069;9165.495897725623;9174.724758257229;9215.262778977665;9226.077392260753;9014.053524379944;9065.909340906606;9128.178463938244;9135.58889849955;9144.131307525775;9073.13805188506;9092;9103.36276460648;9156.679516216935;9198.264138868875;9025.142611451902;9078.954605226965;9088.50013249271;9110.134537218953;9126.863097053549;9126.543672816333;9159.954200229024;9178.357514973955;9182.08179182083;9203.953980230122;44648;44744.10511789779;44845;45073.32390014153;45354.092918141454;3806.8667596634264;4000.399940008993;4009.518857737061;4108.77401742904;4567.566081222279;34073.318533629434;34297.48553771695;34466.483002754976;34966.65033349685;36461.45307820385;4164.479440069991;4307.655387568987;4337.566243375637;4342.782860856976;4355.716878402894;387072;387212;389699;390393;391408;37508.24983500369;38596;38734.22531549353;63795.681021594595;63927.360726392144;40074;40287.39568906469;40361.59638403637;40418;40425.39361909515;17599.472015839547;17840.375586854658;17854.464366069038;17856.9107154466;17883.642327153644;14686;15009.774853377208;15014.24928753558;15101.546953591409;15116.848831511545;8981.236594889377;9033.232175265044;9053.321000924958;9105.590248438835;9129.224015958718;3452.2750222453565;3461.234770267182;3469.687728104432;3494.8951531454095;3505.614382417932;1026.5175367577376;1136.6695581944816;1167.9708007299885;1215.1918973882446;1225.4852961756085;33866.661333386844;33957.32085358328;34039.65960340365;34147;34163.14592135217;1152.544744825806;1165.6561314412268;1173.5951096871565;1203.3141109567637;1244.8381710377773;17373.7393939091;17439.128043597768;17573.824261757476;17796.199171037333;17822.46532604024;159111;618605;655280;658403;665368;58982;65111;65943.34056659468;66113.6694316535;66445.66777166084;1475.5573328001772;1514.0158896717442;1516.097921736565;1517.1428143099113;1526.717557251912;33177.50233746544;33774;34047.65952340544;34182.31635367229;34613.65386346104;55691.44308556862;60131.699341503016;62074.0688889658;62326.68836655788;67724.6613766928;457270;457512;462086;464196;465161;45085;45418.545814542755;45642.54357456383;45758.313625296316;46979.29531056969;49883.25175122303;51087.74456127844;51098.48901510937;51898;51964.740176298874;41078;44429.32555979914;44992.77503612461;46076;46884.53115468938;44154.55845441505;44466.55533444624;44786.55213447824;45965.77017114893;46167.307490387;43926;43988.560114398446;44634.3304850421;44852;44966.325505118104;37888.81055594815;38314.80842595769;38350.42474362831;39129;39230.6076939227;29690;30621.387572247986;35630.465543016355;35885.820570896976;36129.638703612625 11:54:08 INFO - PROCESS | 16789 | |2;jquery.html;424.2406093093362;425.34921569997914;431.4434379650251;431.60508135056426;439.2291528367714;18244.63510729786;19259.133338999745;20063.699044514327;20932.267370642032;21020.36938891832;19356;19404.223831046776;19830.107645155967;20140.59718805623;20305.695414568756;5794.942050579493;5951.642901425928;5978.461938425541;5980.820575382723;5981.910271345933;5687.544996400278;5857.648541087548;5866.120081987693;5929.229200203968;5939.732712027969;5868.618539794921;5929.6145750526075;5985.970070149665;6001.159837622737;6004.399560044004;5683.857903552383;5928.970355148218;5929.88140237195;5987;5987.850303742398;5745.798897038625;5847.239858818326;5903.26209223847;5917.615355001911;6056.424639659225;15019.24903754808;15145.242737863064;15202.619934501616;15424.845751542452;24685.876570617213;2421.782039616425;2440.5362981033545;2450.0812195426715;2495.4759500504915;2509.924702258917;9876.407470526168;9997.250206234561;10008.849867251996;10016.09855113036;10189.949050254776;1991.1736629298823;1995.1121750820892;1997.9200831966705;2003.989980050105;2004.538956040119;80919.19080809175;82820.58589707073;83226;83385;85798;11590.536378544932;11662.183647144619;11775.941120294343;11853.34806585646;11938.761224775455;16752.664946701243;16789.580260493585;16851.325946962228;16864.156792160342;16927.153642317833;8213.712520061768;8473.279771219515;9013.720421554955;9048.864267036;9056.637734490678;8280.420370574122;8343.374246931504;8720;8765.035846056928;8800.295976322006;5019.974900125476;5059.8988020239385;5063.063333283354;5075.162598171334;5134.4352121267375;2080.2615071649348;2112.6725357569603;2125.798049185325;2134.818540424081;2183.4868805830615;1054.862867827193;1145.4902568357002;1147.1854982962022;1176.9466327636717;1178.9174757767046;17680;19200;19994.400167994983;20084.799152008585;20264.18943242254;1016.8220561401873;1033.3283365812283;1061.7914737346455;1065.9040686338112;1083.2796190533365;10401.84397234042;10941.56233750641;10996.725081873017;11043.061339786209;11157.386343751172;398708;406266;407736;495764;498686;98951;103865.48067259615;105009;105822;106760.46619767007;1084.8589683341115;1129.728865072393;1140.401289323112;1153.146671463128;1154.5612667186583;18047.729284060486;18209.908950455163;18373.72439413383;18404.539886502946;18428.539286517407;44211.77894110638;44374.556254438336;44407.555924441636;44672.776636116614;45051;61394;61865;62494.68752656208;64000;64008.3599164021;8918.643254269757;8942.910570894468;9052.404451281662;9160;9328.160465558132;9902.207823374258;13283.402246898719;13609.523666672016;13804.516841910485;14730.779038314648;10775.6228532001;11487.655370338904;11533.135014874086;11956.402179890796;12005.579804706793;12332.81500777471;12398.5660501882;12400.81398779001;12506.062045346453;12819.038572107316;11245.887541124812;11418.600348987746;11835.585754498552;11920.701982450508;12437.315947622606;8892.911070889468;8954.686585969459;9009.684661036832;9091.045440228945;9253.953730231306;9097.636094556143;11229.032177662635;11242.437878106226;11281.097512199169;11428.142889283503 11:54:08 INFO - PROCESS | 16789 | |3;mootools.html;1537.8308386077529;1586.2306781211114;1777.7511148439212;1895.87676801008;1914.1577705809434;7931.762047138595;8959.328050396214;9005.864912026316;9497.002814704452;9498.145166934975;9041.502717350542;9231.446113233194;9333.673321433751;9392.248620110391;9431.434113953168;2413.0950893414924;2430.8176886733477;2453.595156799126;2457.0908763757434;2461.1016978802786;2390.988045059772;2405.5790236708594;2441.1333976438377;2445.6698345723275;2460.5817011108065;2403.9759602404015;2431.7932975697086;2434.8782560871887;2455.8035357171475;2463.864487453189;2369.7393286738443;2390.9282721518384;2407.2176542623542;2417.8549287042747;2433.2943446400523;2440.2679196241056;2443.767842055002;2472.208893154191;2482.751724827521;2493.613489909067;9258.259339252843;9323.580438880266;9334.67328643501;9354.906450935472;9386.155246027822;5472.179173124024;5549.084401073818;5609.887802243932;5620.606557540974;5660.943390566124;3465.4455287154187;3468.3756923753713;3584.8028358440274;3603.1892824114625;3733.0480727414338;1139.5327915554665;1147.7015975846257;1147.8852114788538;1153.1697178031804;1173.178774857603;12728.490860365668;12855.16441431304;12868.549600763929;12910.354482275849;12920.483180672762;4643.674942753974;4755.262934245197;4771.188897887368;4789.066132104276;4902.191138462185;10807.351558906334;10820.188485863591;10847.403392813314;10904.454777261264;10923.3992130432;5560.304961879765;5566.415526369754;5571.220029195916;5592.972035139798;5605.271314729141;4476.2837945928495;5006.69959802413;5010.799568017312;5121.129408000649;5156.9742151289;4011.8395264189107;4054.412110243998;4104.486939132608;4121.608447197512;4144.854930077433;1262.8232047513357;1287.060445874498;1291.7222797098668;1293.7994610835335;1300.057458342694;1002.3184234720314;1023.1610079734546;1056.4770438632927;1092.7158938675843;1095.326374279828;6354.428101470798;6399.968000159969;6401.199850018747;6454.935450645527;6545.21457425112;505.46673259711355;512.776942030218;513.386503128765;527.1591811061351;527.7071225469824;4328.329108988112;4340.001799586113;4383.539728328544;4387.210302145644;4389.3415987601475;11214.10287177024;11573.594924177612;11591.188616796911;11666.824997625043;11668.241564298294;11268.492917818718;11418.486168122454;11431.085513158927;11478.885211147948;11778.88221117795;8647.135286471303;8661.873956385629;8682.696105636272;8771.824563508693;8783.648654053766;6370.331115233019;6384.93615063862;6388.361163883575;6402.839929001812;6427.3251308611925;10577.788444231226;10620.84068738954;10716.839247411139;10803.405812680377;10888.564457421615;10759.30064545802;10816.296940698829;10844.783104338027;11070.723231919266;11080;7266.67299971492;7663.846723065619;7880.211978802303;8203.097659257597;8247.628856701343;8995;9006.729798106067;9011.459312441275;9038.322125840457;9084;7956.085050219299;8082.83834323322;8163.591820409075;8228.465149765247;8270.83458330842;8031.237032481905;8169.428140030141;8212.958935205286;8221.095679475133;8268.421210515206;7024.367806897404;7119.67961441726;7181.892271615826;7501.924980750123;7643.159252482112;5485.122380419114;5515.117581186991;5533.695646739468;5557.194206840067;5599.720013999366;5443.074677304947;5465.890682186255;5488.121900495901;5538.363088244903;5556.194351819045 11:54:08 INFO - PROCESS | 16789 | |4;prototype.html;358.82596940483876;359.80210884013786;361.7829302418549;365.12006065382417;371.98140092995345;5815.098659707747;5825.796097136601;5829.708514574265;5887.470127688507;5900.498457631095;5568.52667523261;5820.613548445138;5838.941610583893;5843.779363841745;5843.970780146094;4475.418195634563;4519;4533.342665313536;4549.886252843688;4552.68131230814;4526.524714904937;4542.568455996691;4558.860284928768;4566.817327306904;4604.1482325769675;4437.955620443802;4567.13224487348;4568.497465278833;4577.748223847687;4589.816407343719;4483.484399294058;4486.766139311682;4516.119356725456;4519.864404067883;4531.728096314215;3970.50368703912;4009.258287216874;4017.879463616096;4025.798710064485;4031.57668444812;5591.042383387207;5655.519280861132;5657.57568182388;5680.091185410314;5701.657900525982;5051.26756620288;5197.570668066274;5228.503292187236;5236.8690782730355;5243.374553888269;6029.939700602981;6036.366181550918;6045.33501314855;6102.786402475892;6116.235470566179;4360.49854266757;4401.2517871961845;4440.53374395687;4441.311596702516;4461.353103799964;6145.446909778097;6245.875082498324;6298.968505157491;6387.93612063878;6411.839704007437;4454.841741147325;4455.866324010285;4463.995600989751;4486.618637415856;4487.775611219426;4487.5961163494785;4489.024829075262;4523.660725445605;4523.751193684313;4527.388802511685;4882;5128.1794912813775;5134.922976155361;5164.173732202829;5213.635045546851;6002.279726432856;6060.515158787286;6082.239720034996;6085.452309292096;6091.238595175603;1532.9116327407442;1547.1413365581984;1549.6978089272484;1555.8677512411346;1559.0879335588581;961.7499450142873;998.9650362237433;999.2305924438142;1001.2840818814583;1010.9738615305471;5291;5296.3909150447425;5323.334583177103;5328.08189051941;5358.9368093284365;5547.16792481123;5578.86052848682;5593.3847276799515;5644.6613203207935;5674.574406919498;5326.307580014651;5370.275012873212;5568.749406276727;6036.396360363929;6066.908996365058;3367.8316084195694;3389.305192435545;3418.692382641707;3426.6573342666034;3429.3655673700446;6276.1799078266795;6501.772437964649;6627.734890604418;6636.502262330345;6643.335666433415;6462.353764623594;6475.4819614430735;6495.188101487314;6512.185976752906;6524.282328943812;6390.233172019481;6552.575547047623;6590.176227971504;6647.966760166169;6673.6986287673435;6341.4292713656;6342.841428964312;6355.459785918249;6364.981602943507;6397.7760778374395;5997.821154787969;6278.529110316836;6282.968585157045;6285.465735412358;6311;6394.328595497405;6521.380468855451;6537.738490460329;6574.737010519526;6589.604623722592;4454.5990860821385;4479.641628669764;4488.9102217954805;4492.371068050541;4526.841560545365;6224.595401298901;6333.619982801047;6359.20509936258;6364.936350636434;6463.321351258238;6164.075388691732;6183.423227077066;6187.226596675416;6195.628262304276;6196.907046394217;5949.8215053548465;6154.661493617894;6165.72254248551;6167.938320616916;6186.659733714509;6050.42520960508;6051.788187413596;6071.969640151771;6072.848178795565;6084.513238940963;6163.506919446344;6182.907256391068;6226.782062627786;6236.18929539157;6278.277998030285;5766.4233576642;6028.076382954176;6063.848403789941;6106.1146133811235;6130.570860039933 11:54:08 INFO - PROCESS | 16789 | |5;yui.html;702.8910518869574;732.4030914804434;737.3437640499955;765.3303359560384;774.3185996323235;13625.318734063294;14274.714505709879;14334.06828556143;14530.491432799854;14603.342849571769;14543;15012.549623511284;15031.09813411196;15032.624184395396;15090.622734431645;854.8803167556531;856.1866227084264;866.7876370289288;879.7228872905047;888.6401007591903;883.3066043156124;883.5317281840635;885.8759773631697;886.7517095213351;888.3958907942597;927.3462209142539;927.7912469694298;929.2380248196481;930.2790337488433;931.9161275485238;914.5930061122802;918.1598837064079;919.2599957034618;921.1387352825096;923.3351986569659;677.2719326723742;680.4284401103097;680.904673345732;681.4990981628499;682.1336902134261;15419.074855508705;15495;15538.378464861393;15599.1420471874;15601.531954041397;14093.2953352333;14460.566183014527;14777.26113694311;14803.259837008107;14815.259237038104;11555.480003399784;11561.653150405502;11602.07183425324;11679.94160029203;11713.648590542298;3932.233214523169;3943.664788492953;3992.4210989406374;4039.6162364575316;4060.2691515527194;64515.67742161306;65376.673116634585;73345;81629;82162.58918705428;11729.35488548121;11783.234089784308;11798.5870494534;11945.88054119465;11946.283223006647;23189.42026449352;23227.954742036312;23243;23400.18099366514;23418.765812342;8789.165029322205;8829.38194326391;8829.602667879832;8842.734717958472;8926.285897128215;4853.296272040534;4886.315915771795;4903.387076615423;4955.2567114933045;4974.8756281093265;3562.6615471530163;3660.7986560739414;3672.6143754905884;3676.6690997810324;3690.022144131807;585.2012003615035;601.2604496469368;605.4974371271834;608.7686679061928;616.765629060954;596.8358701357075;626.4612433307443;645.5771469687362;657.4641667041442;715.8604072205974;9875.901240987498;10069.295149339623;10204.43875586835;10249;10504.474776261157;636.8248731598754;643.353429803045;676.9120014398097;680.7719413996267;702.0662518849917;4525.773711314421;4739.289106634033;4802.927956080662;4866.659333846667;4882.926756098661;106955;118887.40556297163;119414;123557;123884.38057809653;70892;102948.48525757324;105166;108189;109653;60731.39268607346;93065.5346723262;93393;93506;94094.52952735193;9143.016637260034;9158.313126515404;9191.402558833654;9230.220602074454;9530.904690953003;54563.45436545584;55689.443105568425;55886;56644.7167764175;56793.43206568047;64663.35336646573;64935.675321623086;65291.347086530426;77721;80428.59785701035;12492.812607811073;12553.623391298275;12671.619851404472;12708.809367859674;12747.426365813746;14377.856221437652;14560.271986400849;14799.630009249855;15020.24898755036;15608.219589020277;13634.454621815017;14068.366923488264;14069.788953165915;14217.50238741639;14462.783058254345;13277.66805829862;13669.453221871014;13911.234882081582;13978.301084945915;14099.224542650252;10723.195760318164;11003.834942476029;11313.264637798517;13824.447022119002;14114.858851411354;11227.326360418074;11375.715607109889;11513.366764828015;11565.421728913689;12352.320622365856;11438.828417573577;11514.654560363202;11522.884771152181;11672.64982050506;11721.355325457182 11:54:08 INFO - PROCESS | 16789 | __end_tp_report 11:54:08 INFO - PROCESS | 16789 | __start_cc_report 11:54:08 INFO - PROCESS | 16789 | _x_x_mozilla_cycle_collect,345 11:54:08 INFO - PROCESS | 16789 | __end_cc_report 11:54:08 INFO - PROCESS | 16789 | __startTimestamp1466967248130__endTimestamp 11:54:08 INFO - PROCESS | 16789 | 11:54:08 INFO - PROCESS | 16789 | ------- Summary: start ------- 11:54:08 INFO - PROCESS | 16789 | Number of tests: 6 11:54:08 INFO - PROCESS | 16789 | 11:54:08 INFO - PROCESS | 16789 | [#0] dojo.html Cycles:165 Average:5691.09 Median:5936.41 stddev:639.16 (10.8%) stddev-sans-first:614.48 11:54:08 INFO - PROCESS | 16789 | Values: 3363.2 3399.5 3410.2 3423.6 3437.7 5664.7 5665.4 5698.6 5722.8 5746.3 5722.9 5723.0 5753.0 5774.0 5803.7 5155.1 5174.1 5224.3 5249.1 5273.9 5110.0 5121.9 5296.7 5302.9 5304.8 5187.1 5192.5 5196.0 5203.7 5218.4 5178.3 5214.1 5228.3 5240.6 5278.1 4997.9 5125.6 5195.5 5223.5 5262.7 5467.4 5471.5 5473.6 5506.8 5509.2 6029.2 6041.4 6048.2 6062.3 6104.2 5948.5 6092.0 6149.9 6154.0 6193.8 5718.9 5777.2 5780.7 5809.0 5812.9 6292.9 6303.9 6311.3 6311.9 6320.0 5813.7 5950.0 5953.9 6055.4 6061.4 6112.7 6123.7 6124.2 6126.4 6151.3 6016.1 6034.7 6065.2 6080.6 6083.3 5924.1 6006.4 6009.0 6090.8 6096.6 4650.7 4662.4 4666.7 4677.1 4691.1 4165.5 4179.9 4181.4 4200.3 4212.1 5674.2 5826.5 5852.6 5913.2 5939.0 6095.1 6141.3 6142.8 6200.7 6207.2 5684.3 5952.8 5955.7 5957.1 5975.9 5291.3 5320.3 5335.2 5365.2 5378.1 6393.7 6444.0 6496.4 6501.3 6503.6 5917.5 6088.1 6248.7 6257.0 6265.6 6260.2 6357.7 6376.8 6384.6 6422.0 6035.3 6059.7 6073.7 6076.1 6086.8 5942.8 6050.2 6066.0 6095.6 6188.0 5947.7 5954.2 6005.5 6005.8 6042.1 5905.4 5923.6 5956.3 5960.4 5962.9 5695.9 5835.3 5886.5 5886.6 5923.2 6041.4 6047.7 6077.2 6083.8 6085.7 5923.1 5932.4 5936.4 5941.7 5947.9 11:54:08 INFO - PROCESS | 16789 | 11:54:08 INFO - PROCESS | 16789 | [#1] ext.html Cycles:180 Average:63455.60 Median:44641.17 stddev:129341.75 (289.7%) stddev-sans-first:129618.48 11:54:08 INFO - PROCESS | 16789 | Values: 596.5 653.2 658.5 668.2 675.8 43562.0 45853.3 45971.5 46023.5 50234.5 48232.5 48747.5 48793.8 48859.8 48915.5 9069.0 9165.5 9174.7 9215.3 9226.1 9014.1 9065.9 9128.2 9135.6 9144.1 9073.1 9092.0 9103.4 9156.7 9198.3 9025.1 9079.0 9088.5 9110.1 9126.9 9126.5 9160.0 9178.4 9182.1 9204.0 44648.0 44744.1 44845.0 45073.3 45354.1 3806.9 4000.4 4009.5 4108.8 4567.6 34073.3 34297.5 34466.5 34966.7 36461.5 4164.5 4307.7 4337.6 4342.8 4355.7 387072.0 387212.0 389699.0 390393.0 391408.0 37508.2 38596.0 38734.2 63795.7 63927.4 40074.0 40287.4 40361.6 40418.0 40425.4 17599.5 17840.4 17854.5 17856.9 17883.6 14686.0 15009.8 15014.2 15101.5 15116.8 8981.2 9033.2 9053.3 9105.6 9129.2 3452.3 3461.2 3469.7 3494.9 3505.6 1026.5 1136.7 1168.0 1215.2 1225.5 33866.7 33957.3 34039.7 34147.0 34163.1 1152.5 1165.7 1173.6 1203.3 1244.8 17373.7 17439.1 17573.8 17796.2 17822.5 159111.0 618605.0 655280.0 658403.0 665368.0 58982.0 65111.0 65943.3 66113.7 66445.7 1475.6 1514.0 1516.1 1517.1 1526.7 33177.5 33774.0 34047.7 34182.3 34613.7 55691.4 60131.7 62074.1 62326.7 67724.7 457270.0 457512.0 462086.0 464196.0 465161.0 45085.0 45418.5 45642.5 45758.3 46979.3 49883.3 51087.7 51098.5 51898.0 51964.7 41078.0 44429.3 44992.8 46076.0 46884.5 44154.6 44466.6 44786.6 45965.8 46167.3 43926.0 43988.6 44634.3 44852.0 44966.3 37888.8 38314.8 38350.4 39129.0 39230.6 29690.0 30621.4 35630.5 35885.8 36129.6 11:54:08 INFO - PROCESS | 16789 | 11:54:08 INFO - PROCESS | 16789 | [#2] jquery.html Cycles:180 Average:28341.00 Median:2119.24 stddev:73884.81 (3486.4%) stddev-sans-first:74062.34 11:54:08 INFO - PROCESS | 16789 | Values: 424.2 425.3 431.4 431.6 439.2 18244.6 19259.1 20063.7 20932.3 21020.4 19356.0 19404.2 19830.1 20140.6 20305.7 5794.9 5951.6 5978.5 5980.8 5981.9 5687.5 5857.6 5866.1 5929.2 5939.7 5868.6 5929.6 5986.0 6001.2 6004.4 5683.9 5929.0 5929.9 5987.0 5987.9 5745.8 5847.2 5903.3 5917.6 6056.4 15019.2 15145.2 15202.6 15424.8 24685.9 2421.8 2440.5 2450.1 2495.5 2509.9 9876.4 9997.3 10008.8 10016.1 10189.9 1991.2 1995.1 1997.9 2004.0 2004.5 80919.2 82820.6 83226.0 83385.0 85798.0 11590.5 11662.2 11775.9 11853.3 11938.8 16752.7 16789.6 16851.3 16864.2 16927.2 8213.7 8473.3 9013.7 9048.9 9056.6 8280.4 8343.4 8720.0 8765.0 8800.3 5020.0 5059.9 5063.1 5075.2 5134.4 2080.3 2112.7 2125.8 2134.8 2183.5 1054.9 1145.5 1147.2 1176.9 1178.9 17680.0 19200.0 19994.4 20084.8 20264.2 1016.8 1033.3 1061.8 1065.9 1083.3 10401.8 10941.6 10996.7 11043.1 11157.4 398708.0 406266.0 407736.0 495764.0 498686.0 98951.0 103865.5 105009.0 105822.0 106760.5 1084.9 1129.7 1140.4 1153.1 1154.6 18047.7 18209.9 18373.7 18404.5 18428.5 44211.8 44374.6 44407.6 44672.8 45051.0 61394.0 61865.0 62494.7 64000.0 64008.4 8918.6 8942.9 9052.4 9160.0 9328.2 9902.2 13283.4 13609.5 13804.5 14730.8 10775.6 11487.7 11533.1 11956.4 12005.6 12332.8 12398.6 12400.8 12506.1 12819.0 11245.9 11418.6 11835.6 11920.7 12437.3 8892.9 8954.7 9009.7 9091.0 9254.0 9097.6 11229.0 11242.4 11281.1 11428.1 11:54:08 INFO - PROCESS | 16789 | 11:54:08 INFO - PROCESS | 16789 | [#3] mootools.html Cycles:180 Average:6107.75 Median:4559.98 stddev:3496.66 (76.7%) stddev-sans-first:3489.60 11:54:08 INFO - PROCESS | 16789 | Values: 1537.8 1586.2 1777.8 1895.9 1914.2 7931.8 8959.3 9005.9 9497.0 9498.1 9041.5 9231.4 9333.7 9392.2 9431.4 2413.1 2430.8 2453.6 2457.1 2461.1 2391.0 2405.6 2441.1 2445.7 2460.6 2404.0 2431.8 2434.9 2455.8 2463.9 2369.7 2390.9 2407.2 2417.9 2433.3 2440.3 2443.8 2472.2 2482.8 2493.6 9258.3 9323.6 9334.7 9354.9 9386.2 5472.2 5549.1 5609.9 5620.6 5660.9 3465.4 3468.4 3584.8 3603.2 3733.0 1139.5 1147.7 1147.9 1153.2 1173.2 12728.5 12855.2 12868.5 12910.4 12920.5 4643.7 4755.3 4771.2 4789.1 4902.2 10807.4 10820.2 10847.4 10904.5 10923.4 5560.3 5566.4 5571.2 5593.0 5605.3 4476.3 5006.7 5010.8 5121.1 5157.0 4011.8 4054.4 4104.5 4121.6 4144.9 1262.8 1287.1 1291.7 1293.8 1300.1 1002.3 1023.2 1056.5 1092.7 1095.3 6354.4 6400.0 6401.2 6454.9 6545.2 505.5 512.8 513.4 527.2 527.7 4328.3 4340.0 4383.5 4387.2 4389.3 11214.1 11573.6 11591.2 11666.8 11668.2 11268.5 11418.5 11431.1 11478.9 11778.9 8647.1 8661.9 8682.7 8771.8 8783.6 6370.3 6384.9 6388.4 6402.8 6427.3 10577.8 10620.8 10716.8 10803.4 10888.6 10759.3 10816.3 10844.8 11070.7 11080.0 7266.7 7663.8 7880.2 8203.1 8247.6 8995.0 9006.7 9011.5 9038.3 9084.0 7956.1 8082.8 8163.6 8228.5 8270.8 8031.2 8169.4 8213.0 8221.1 8268.4 7024.4 7119.7 7181.9 7501.9 7643.2 5485.1 5515.1 5533.7 5557.2 5599.7 5443.1 5465.9 5488.1 5538.4 5556.2 11:54:08 INFO - PROCESS | 16789 | 11:54:08 INFO - PROCESS | 16789 | [#4] prototype.html Cycles:180 Average:5129.24 Median:5734.04 stddev:1515.17 (26.4%) stddev-sans-first:1476.51 11:54:08 INFO - PROCESS | 16789 | Values: 358.8 359.8 361.8 365.1 372.0 5815.1 5825.8 5829.7 5887.5 5900.5 5568.5 5820.6 5838.9 5843.8 5844.0 4475.4 4519.0 4533.3 4549.9 4552.7 4526.5 4542.6 4558.9 4566.8 4604.1 4438.0 4567.1 4568.5 4577.7 4589.8 4483.5 4486.8 4516.1 4519.9 4531.7 3970.5 4009.3 4017.9 4025.8 4031.6 5591.0 5655.5 5657.6 5680.1 5701.7 5051.3 5197.6 5228.5 5236.9 5243.4 6029.9 6036.4 6045.3 6102.8 6116.2 4360.5 4401.3 4440.5 4441.3 4461.4 6145.4 6245.9 6299.0 6387.9 6411.8 4454.8 4455.9 4464.0 4486.6 4487.8 4487.6 4489.0 4523.7 4523.8 4527.4 4882.0 5128.2 5134.9 5164.2 5213.6 6002.3 6060.5 6082.2 6085.5 6091.2 1532.9 1547.1 1549.7 1555.9 1559.1 961.7 999.0 999.2 1001.3 1011.0 5291.0 5296.4 5323.3 5328.1 5358.9 5547.2 5578.9 5593.4 5644.7 5674.6 5326.3 5370.3 5568.7 6036.4 6066.9 3367.8 3389.3 3418.7 3426.7 3429.4 6276.2 6501.8 6627.7 6636.5 6643.3 6462.4 6475.5 6495.2 6512.2 6524.3 6390.2 6552.6 6590.2 6648.0 6673.7 6341.4 6342.8 6355.5 6365.0 6397.8 5997.8 6278.5 6283.0 6285.5 6311.0 6394.3 6521.4 6537.7 6574.7 6589.6 4454.6 4479.6 4488.9 4492.4 4526.8 6224.6 6333.6 6359.2 6364.9 6463.3 6164.1 6183.4 6187.2 6195.6 6196.9 5949.8 6154.7 6165.7 6167.9 6186.7 6050.4 6051.8 6072.0 6072.8 6084.5 6163.5 6182.9 6226.8 6236.2 6278.3 5766.4 6028.1 6063.8 6106.1 6130.6 11:54:08 INFO - PROCESS | 16789 | 11:54:08 INFO - PROCESS | 16789 | [#5] yui.html Cycles:180 Average:20950.00 Median:4016.02 stddev:30338.14 (755.4%) stddev-sans-first:30385.15 11:54:08 INFO - PROCESS | 16789 | Values: 702.9 732.4 737.3 765.3 774.3 13625.3 14274.7 14334.1 14530.5 14603.3 14543.0 15012.5 15031.1 15032.6 15090.6 854.9 856.2 866.8 879.7 888.6 883.3 883.5 885.9 886.8 888.4 927.3 927.8 929.2 930.3 931.9 914.6 918.2 919.3 921.1 923.3 677.3 680.4 680.9 681.5 682.1 15419.1 15495.0 15538.4 15599.1 15601.5 14093.3 14460.6 14777.3 14803.3 14815.3 11555.5 11561.7 11602.1 11679.9 11713.6 3932.2 3943.7 3992.4 4039.6 4060.3 64515.7 65376.7 73345.0 81629.0 82162.6 11729.4 11783.2 11798.6 11945.9 11946.3 23189.4 23228.0 23243.0 23400.2 23418.8 8789.2 8829.4 8829.6 8842.7 8926.3 4853.3 4886.3 4903.4 4955.3 4974.9 3562.7 3660.8 3672.6 3676.7 3690.0 585.2 601.3 605.5 608.8 616.8 596.8 626.5 645.6 657.5 715.9 9875.9 10069.3 10204.4 10249.0 10504.5 636.8 643.4 676.9 680.8 702.1 4525.8 4739.3 4802.9 4866.7 4882.9 106955.0 118887.4 119414.0 123557.0 123884.4 70892.0 102948.5 105166.0 108189.0 109653.0 60731.4 93065.5 93393.0 93506.0 94094.5 9143.0 9158.3 9191.4 9230.2 9530.9 54563.5 55689.4 55886.0 56644.7 56793.4 64663.4 64935.7 65291.3 77721.0 80428.6 12492.8 12553.6 12671.6 12708.8 12747.4 14377.9 14560.3 14799.6 15020.2 15608.2 13634.5 14068.4 14069.8 14217.5 14462.8 13277.7 13669.5 13911.2 13978.3 14099.2 10723.2 11003.8 11313.3 13824.4 14114.9 11227.3 11375.7 11513.4 11565.4 12352.3 11438.8 11514.7 11522.9 11672.6 11721.4 11:54:08 INFO - PROCESS | 16789 | -------- Summary: end -------- 11:54:08 INFO - PROCESS | 16789 | 11:54:08 INFO - TEST-INFO | 16789: exit 0 11:54:08 INFO - TEST-OK | dromaeo_css | took 1111085ms 11:54:08 INFO - TEST-START | kraken 11:54:08 INFO - operating with platform_type : linux_ 11:54:08 INFO - Initialising browser for kraken test... 11:54:08 INFO - TEST-INFO | started process 17032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTn4398/profile http://localhost:49849/getInfo.html) 11:54:13 INFO - PROCESS | 17032 | __metrics Screen width/height:1600/1200 11:54:13 INFO - PROCESS | 17032 | colorDepth:24 11:54:13 INFO - PROCESS | 17032 | Browser inner width/height: 1024/697 11:54:13 INFO - PROCESS | 17032 | __metrics 11:54:14 ERROR - PROCESS | 17032 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 11:54:15 INFO - TEST-INFO | 17032: exit 0 11:54:15 INFO - Browser initialized. 11:54:15 INFO - Running cycle 1/1 for kraken test... 11:54:15 INFO - TEST-INFO | started process 17161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTn4398/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:54:27 INFO - PROCESS | 17161 | RSS: Main: 156250112 11:54:27 INFO - PROCESS | 17161 | 11:54:29 INFO - PROCESS | 17161 | Cycle 1(1): loaded http://localhost:49849/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49849/tests/kraken/driver.html?testName=audio-beat-detection) 11:54:30 INFO - PROCESS | 17161 | RSS: Main: 161513472 11:54:30 INFO - PROCESS | 17161 | 11:54:33 INFO - PROCESS | 17161 | Cycle 1(1): loaded http://localhost:49849/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49849/tests/kraken/driver.html?testName=audio-dft) 11:54:33 INFO - PROCESS | 17161 | RSS: Main: 160600064 11:54:33 INFO - PROCESS | 17161 | 11:54:36 INFO - PROCESS | 17161 | Cycle 1(1): loaded http://localhost:49849/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49849/tests/kraken/driver.html?testName=audio-fft) 11:54:37 INFO - PROCESS | 17161 | RSS: Main: 161300480 11:54:37 INFO - PROCESS | 17161 | 11:54:39 INFO - PROCESS | 17161 | Cycle 1(1): loaded http://localhost:49849/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49849/tests/kraken/driver.html?testName=audio-oscillator) 11:54:39 INFO - PROCESS | 17161 | RSS: Main: 161251328 11:54:39 INFO - PROCESS | 17161 | 11:54:42 INFO - PROCESS | 17161 | Cycle 1(1): loaded http://localhost:49849/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49849/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:54:42 INFO - PROCESS | 17161 | RSS: Main: 160878592 11:54:42 INFO - PROCESS | 17161 | 11:54:45 INFO - PROCESS | 17161 | Cycle 1(1): loaded http://localhost:49849/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49849/tests/kraken/driver.html?testName=imaging-darkroom) 11:54:46 INFO - PROCESS | 17161 | RSS: Main: 160301056 11:54:46 INFO - PROCESS | 17161 | 11:54:49 INFO - PROCESS | 17161 | Cycle 1(1): loaded http://localhost:49849/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49849/tests/kraken/driver.html?testName=imaging-desaturate) 11:54:50 INFO - PROCESS | 17161 | RSS: Main: 161366016 11:54:50 INFO - PROCESS | 17161 | 11:54:53 INFO - PROCESS | 17161 | Cycle 1(1): loaded http://localhost:49849/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49849/tests/kraken/driver.html?testName=json-parse-financial) 11:54:53 INFO - PROCESS | 17161 | RSS: Main: 161030144 11:54:53 INFO - PROCESS | 17161 | 11:54:55 INFO - PROCESS | 17161 | Cycle 1(1): loaded http://localhost:49849/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49849/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:54:55 INFO - PROCESS | 17161 | RSS: Main: 161378304 11:54:55 INFO - PROCESS | 17161 | 11:54:57 INFO - PROCESS | 17161 | Cycle 1(1): loaded http://localhost:49849/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49849/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:54:58 INFO - PROCESS | 17161 | RSS: Main: 160718848 11:54:58 INFO - PROCESS | 17161 | 11:55:00 INFO - PROCESS | 17161 | Cycle 1(1): loaded http://localhost:49849/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49849/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:55:01 INFO - PROCESS | 17161 | RSS: Main: 161148928 11:55:01 INFO - PROCESS | 17161 | 11:55:03 INFO - PROCESS | 17161 | Cycle 1(1): loaded http://localhost:49849/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49849/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:55:04 INFO - PROCESS | 17161 | RSS: Main: 161476608 11:55:04 INFO - PROCESS | 17161 | 11:55:07 INFO - PROCESS | 17161 | Cycle 1(1): loaded http://localhost:49849/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49849/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:55:07 INFO - PROCESS | 17161 | RSS: Main: 161464320 11:55:07 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | Cycle 1(1): loaded http://localhost:49849/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49849/tests/kraken/driver.html?testName=ai-astar) 11:55:09 INFO - PROCESS | 17161 | RSS: Main: 162488320 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | __start_tp_report 11:55:09 INFO - PROCESS | 17161 | _x_x_mozilla_page_load 11:55:09 INFO - PROCESS | 17161 | _x_x_mozilla_page_load_details 11:55:09 INFO - PROCESS | 17161 | |i|pagename|runs| 11:55:09 INFO - PROCESS | 17161 | |0;ai-astar;112;106;111;110;112;111;111;111;112;110 11:55:09 INFO - PROCESS | 17161 | |1;audio-beat-detection;165;123;153;189;133;149;160;128;196;123 11:55:09 INFO - PROCESS | 17161 | |2;audio-dft;162;161;160;160;162;160;161;161;163;161 11:55:09 INFO - PROCESS | 17161 | |3;audio-fft;76;75;77;168;76;76;75;74;168;76 11:55:09 INFO - PROCESS | 17161 | |4;audio-oscillator;86;84;141;86;85;84;139;85;83;134 11:55:09 INFO - PROCESS | 17161 | |5;imaging-gaussian-blur;118;118;117;118;119;118;117;117;118;118 11:55:09 INFO - PROCESS | 17161 | |6;imaging-darkroom;146;146;147;146;146;148;147;146;147;147 11:55:09 INFO - PROCESS | 17161 | |7;imaging-desaturate;95;95;95;95;143;95;96;97;96;96 11:55:09 INFO - PROCESS | 17161 | |8;json-parse-financial;52;51;51;51;53;54;52;51;52;56 11:55:09 INFO - PROCESS | 17161 | |9;json-stringify-tinderbox;60;60;60;60;60;60;60;61;61;60 11:55:09 INFO - PROCESS | 17161 | |10;stanford-crypto-aes;76;78;79;77;77;76;91;78;109;83 11:55:09 INFO - PROCESS | 17161 | |11;stanford-crypto-ccm;125;126;130;136;130;147;121;129;133;131 11:55:09 INFO - PROCESS | 17161 | |12;stanford-crypto-pbkdf2;157;156;156;156;161;159;153;154;164;159 11:55:09 INFO - PROCESS | 17161 | |13;stanford-crypto-sha256-iterative;64;63;63;67;62;62;62;62;63;61 11:55:09 INFO - PROCESS | 17161 | __end_tp_report 11:55:09 INFO - PROCESS | 17161 | __start_cc_report 11:55:09 INFO - PROCESS | 17161 | _x_x_mozilla_cycle_collect,903 11:55:09 INFO - PROCESS | 17161 | __end_cc_report 11:55:09 INFO - PROCESS | 17161 | __startTimestamp1466967309565__endTimestamp 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | ------- Summary: start ------- 11:55:09 INFO - PROCESS | 17161 | Number of tests: 14 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.78 (1.6%) stddev-sans-first:1.81 11:55:09 INFO - PROCESS | 17161 | Values: 112.0 106.0 111.0 110.0 112.0 111.0 111.0 111.0 112.0 110.0 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:156.50 stddev:26.18 (16.7%) stddev-sans-first:27.33 11:55:09 INFO - PROCESS | 17161 | Values: 165.0 123.0 153.0 189.0 133.0 149.0 160.0 128.0 196.0 123.0 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 11:55:09 INFO - PROCESS | 17161 | Values: 162.0 161.0 160.0 160.0 162.0 160.0 161.0 161.0 163.0 161.0 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.00 stddev:38.96 (51.3%) stddev-sans-first:40.77 11:55:09 INFO - PROCESS | 17161 | Values: 76.0 75.0 77.0 168.0 76.0 76.0 75.0 74.0 168.0 76.0 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:84.50 stddev:25.81 (30.5%) stddev-sans-first:26.82 11:55:09 INFO - PROCESS | 17161 | Values: 86.0 84.0 141.0 86.0 85.0 84.0 139.0 85.0 83.0 134.0 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 11:55:09 INFO - PROCESS | 17161 | Values: 118.0 118.0 117.0 118.0 119.0 118.0 117.0 117.0 118.0 118.0 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 11:55:09 INFO - PROCESS | 17161 | Values: 146.0 146.0 147.0 146.0 146.0 148.0 147.0 146.0 147.0 147.0 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | [#7] imaging-desaturate Cycles:10 Average:100.30 Median:95.50 stddev:15.02 (15.7%) stddev-sans-first:15.81 11:55:09 INFO - PROCESS | 17161 | Values: 95.0 95.0 95.0 95.0 143.0 95.0 96.0 97.0 96.0 96.0 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:1.64 (3.1%) stddev-sans-first:1.73 11:55:09 INFO - PROCESS | 17161 | Values: 52.0 51.0 51.0 51.0 53.0 54.0 52.0 51.0 52.0 56.0 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 11:55:09 INFO - PROCESS | 17161 | Values: 60.0 60.0 60.0 60.0 60.0 60.0 60.0 61.0 61.0 60.0 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:78.00 stddev:10.39 (13.3%) stddev-sans-first:10.76 11:55:09 INFO - PROCESS | 17161 | Values: 76.0 78.0 79.0 77.0 77.0 76.0 91.0 78.0 109.0 83.0 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:130.50 stddev:7.08 (5.4%) stddev-sans-first:7.20 11:55:09 INFO - PROCESS | 17161 | Values: 125.0 126.0 130.0 136.0 130.0 147.0 121.0 129.0 133.0 131.0 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:158.00 stddev:3.31 (2.1%) stddev-sans-first:3.50 11:55:09 INFO - PROCESS | 17161 | Values: 157.0 156.0 156.0 156.0 161.0 159.0 153.0 154.0 164.0 159.0 11:55:09 INFO - PROCESS | 17161 | 11:55:09 INFO - PROCESS | 17161 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.66 (2.6%) stddev-sans-first:1.72 11:55:09 INFO - PROCESS | 17161 | Values: 64.0 63.0 63.0 67.0 62.0 62.0 62.0 62.0 63.0 61.0 11:55:09 INFO - PROCESS | 17161 | -------- Summary: end -------- 11:55:09 INFO - PROCESS | 17161 | 11:55:10 INFO - TEST-INFO | 17161: exit 0 11:55:10 INFO - TEST-OK | kraken | took 61707ms 11:55:10 INFO - SUITE-END | took 1172s 11:55:10 INFO - Completed test suite (00:19:32) 11:55:10 INFO - javascript benchmark 11:55:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7581.193979572287, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3363.2096457332527, 3399.473081672342, 3410.1815564264575, 3423.6405177456368, 3437.742169337299, 5664.660120392774, 5665.405132461084, 5698.5726070544715, 5722.771089156434, 5746.252987111669, 5722.885542289152, 5723.0, 5752.971235143818, 5773.971130144343, 5803.680797556132, 5155.097857874875, 5174.146265866128, 5224.320838291036, 5249.081410753122, 5273.920891186635, 5109.974450127745, 5121.923171152417, 5296.682199068068, 5302.893942121155, 5304.840854774344, 5187.066328060948, 5192.506711862367, 5195.974020129913, 5203.661761985478, 5218.399884013349, 5178.300929374543, 5214.061468935609, 5228.294180285651, 5240.580753539708, 5278.076336641073, 4997.90004199914, 5125.6155788315655, 5195.480451954812, 5223.52988231061, 5262.736863156827, 5467.371252305996, 5471.50756431919, 5473.589480788957, 5506.752196151183, 5509.228707980886, 6029.246344206974, 6041.365656606037, 6048.213732214784, 6062.302835173923, 6104.175936248594, 5948.464638182584, 6091.969540152315, 6149.923763341442, 6154.0, 6193.752249909998, 5718.857028574277, 5777.19119323295, 5780.653160810365, 5808.970955145197, 5812.8837423251725, 6292.937070629327, 6303.873922521524, 6311.33730958252, 6311.936880631227, 6320.0, 5813.680247586423, 5949.970250148722, 5953.851153721192, 6055.394460553997, 6061.36355682647, 6112.655464441461, 6123.709696704001, 6124.168182837791, 6126.397462875568, 6151.323354431009, 6016.127661489147, 6034.668093254913, 6065.181200537959, 6080.604760690541, 6083.330833608299, 5924.14099955504, 6006.369331220247, 6008.969955150196, 6090.756369745249, 6096.634201947897, 4650.720956742606, 4662.440507139165, 4666.673332866667, 4677.064587082529, 4691.132140554008, 4165.4584903962295, 4179.895502612399, 4181.351890456984, 4200.264953633102, 4212.115455754265, 5674.205611214434, 5826.533877289807, 5852.590318677737, 5913.172155898178, 5939.049752039739, 6095.05526643371, 6141.30190404341, 6142.754289828356, 6200.720967556471, 6207.224096987877, 5684.346300175533, 5952.821415357546, 5955.731992060368, 5957.106434034929, 5975.940240597538, 5291.3121294231505, 5320.255164277004, 5335.226392173191, 5365.248865158881, 5378.13949768043, 6393.712282947278, 6444.0, 6496.35036496356, 6501.31736167705, 6503.642299673469, 5917.526597872074, 6088.147659327609, 6248.687565621792, 6257.0, 6265.624062556261, 6260.186175797117, 6357.7139028742895, 6376.808695739135, 6384.6169229846355, 6421.967890160519, 6035.275766907999, 6059.727312271047, 6073.726682299219, 6076.088586711851, 6086.847828804315, 5942.792002280073, 6050.21347224858, 6065.969670151621, 6095.573309868267, 6187.969060154671, 5947.672877991752, 5954.225950626391, 6005.549583781147, 6005.849853753691, 6042.093685947143, 5905.379935106752, 5923.644581325134, 5956.344802071855, 5960.374160713062, 5962.880742385215, 5695.8860822784145, 5835.270591176103, 5886.470217680429, 5886.646801191942, 5923.170756094237, 6041.395860413923, 6047.697615119138, 6077.179580756541, 6083.756649733961, 6085.69571521431, 5923.052311630118, 5932.377100404396, 5936.406359364029, 5941.702914854326, 5947.910781338197], "value": 5649.072700510179, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.4929809661788, 653.1867824558424, 658.4501940879366, 668.2115104177069, 675.7567275780718, 43562.0, 45853.31220031702, 45971.54028459715, 46023.53976460234, 50234.49765502344, 48232.51767482324, 48747.51252487474, 48793.7560312198, 48859.75570122153, 48915.51084489154, 9069.0, 9165.495897725623, 9174.724758257229, 9215.262778977665, 9226.077392260753, 9014.053524379944, 9065.909340906606, 9128.178463938244, 9135.58889849955, 9144.131307525775, 9073.13805188506, 9092.0, 9103.36276460648, 9156.679516216935, 9198.264138868875, 9025.142611451902, 9078.954605226965, 9088.50013249271, 9110.134537218953, 9126.863097053549, 9126.543672816333, 9159.954200229024, 9178.357514973955, 9182.08179182083, 9203.953980230122, 44648.0, 44744.10511789779, 44845.0, 45073.32390014153, 45354.092918141454, 3806.8667596634264, 4000.399940008993, 4009.518857737061, 4108.77401742904, 4567.566081222279, 34073.318533629434, 34297.48553771695, 34466.483002754976, 34966.65033349685, 36461.45307820385, 4164.479440069991, 4307.655387568987, 4337.566243375637, 4342.782860856976, 4355.716878402894, 387072.0, 387212.0, 389699.0, 390393.0, 391408.0, 37508.24983500369, 38596.0, 38734.22531549353, 63795.681021594595, 63927.360726392144, 40074.0, 40287.39568906469, 40361.59638403637, 40418.0, 40425.39361909515, 17599.472015839547, 17840.375586854658, 17854.464366069038, 17856.9107154466, 17883.642327153644, 14686.0, 15009.774853377208, 15014.24928753558, 15101.546953591409, 15116.848831511545, 8981.236594889377, 9033.232175265044, 9053.321000924958, 9105.590248438835, 9129.224015958718, 3452.2750222453565, 3461.234770267182, 3469.687728104432, 3494.8951531454095, 3505.614382417932, 1026.5175367577376, 1136.6695581944816, 1167.9708007299885, 1215.1918973882446, 1225.4852961756085, 33866.661333386844, 33957.32085358328, 34039.65960340365, 34147.0, 34163.14592135217, 1152.544744825806, 1165.6561314412268, 1173.5951096871565, 1203.3141109567637, 1244.8381710377773, 17373.7393939091, 17439.128043597768, 17573.824261757476, 17796.199171037333, 17822.46532604024, 159111.0, 618605.0, 655280.0, 658403.0, 665368.0, 58982.0, 65111.0, 65943.34056659468, 66113.6694316535, 66445.66777166084, 1475.5573328001772, 1514.0158896717442, 1516.097921736565, 1517.1428143099113, 1526.717557251912, 33177.50233746544, 33774.0, 34047.65952340544, 34182.31635367229, 34613.65386346104, 55691.44308556862, 60131.699341503016, 62074.0688889658, 62326.68836655788, 67724.6613766928, 457270.0, 457512.0, 462086.0, 464196.0, 465161.0, 45085.0, 45418.545814542755, 45642.54357456383, 45758.313625296316, 46979.29531056969, 49883.25175122303, 51087.74456127844, 51098.48901510937, 51898.0, 51964.740176298874, 41078.0, 44429.32555979914, 44992.77503612461, 46076.0, 46884.53115468938, 44154.55845441505, 44466.55533444624, 44786.55213447824, 45965.77017114893, 46167.307490387, 43926.0, 43988.560114398446, 44634.3304850421, 44852.0, 44966.325505118104, 37888.81055594815, 38314.80842595769, 38350.42474362831, 39129.0, 39230.6076939227, 29690.0, 30621.387572247986, 35630.465543016355, 35885.820570896976, 36129.638703612625], "value": 20577.216425273018, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.2406093093362, 425.34921569997914, 431.4434379650251, 431.60508135056426, 439.2291528367714, 18244.63510729786, 19259.133338999745, 20063.699044514327, 20932.267370642032, 21020.36938891832, 19356.0, 19404.223831046776, 19830.107645155967, 20140.59718805623, 20305.695414568756, 5794.942050579493, 5951.642901425928, 5978.461938425541, 5980.820575382723, 5981.910271345933, 5687.544996400278, 5857.648541087548, 5866.120081987693, 5929.229200203968, 5939.732712027969, 5868.618539794921, 5929.6145750526075, 5985.970070149665, 6001.159837622737, 6004.399560044004, 5683.857903552383, 5928.970355148218, 5929.88140237195, 5987.0, 5987.850303742398, 5745.798897038625, 5847.239858818326, 5903.26209223847, 5917.615355001911, 6056.424639659225, 15019.24903754808, 15145.242737863064, 15202.619934501616, 15424.845751542452, 24685.876570617213, 2421.782039616425, 2440.5362981033545, 2450.0812195426715, 2495.4759500504915, 2509.924702258917, 9876.407470526168, 9997.250206234561, 10008.849867251996, 10016.09855113036, 10189.949050254776, 1991.1736629298823, 1995.1121750820892, 1997.9200831966705, 2003.989980050105, 2004.538956040119, 80919.19080809175, 82820.58589707073, 83226.0, 83385.0, 85798.0, 11590.536378544932, 11662.183647144619, 11775.941120294343, 11853.34806585646, 11938.761224775455, 16752.664946701243, 16789.580260493585, 16851.325946962228, 16864.156792160342, 16927.153642317833, 8213.712520061768, 8473.279771219515, 9013.720421554955, 9048.864267036, 9056.637734490678, 8280.420370574122, 8343.374246931504, 8720.0, 8765.035846056928, 8800.295976322006, 5019.974900125476, 5059.8988020239385, 5063.063333283354, 5075.162598171334, 5134.4352121267375, 2080.2615071649348, 2112.6725357569603, 2125.798049185325, 2134.818540424081, 2183.4868805830615, 1054.862867827193, 1145.4902568357002, 1147.1854982962022, 1176.9466327636717, 1178.9174757767046, 17680.0, 19200.0, 19994.400167994983, 20084.799152008585, 20264.18943242254, 1016.8220561401873, 1033.3283365812283, 1061.7914737346455, 1065.9040686338112, 1083.2796190533365, 10401.84397234042, 10941.56233750641, 10996.725081873017, 11043.061339786209, 11157.386343751172, 398708.0, 406266.0, 407736.0, 495764.0, 498686.0, 98951.0, 103865.48067259615, 105009.0, 105822.0, 106760.46619767007, 1084.8589683341115, 1129.728865072393, 1140.401289323112, 1153.146671463128, 1154.5612667186583, 18047.729284060486, 18209.908950455163, 18373.72439413383, 18404.539886502946, 18428.539286517407, 44211.77894110638, 44374.556254438336, 44407.555924441636, 44672.776636116614, 45051.0, 61394.0, 61865.0, 62494.68752656208, 64000.0, 64008.3599164021, 8918.643254269757, 8942.910570894468, 9052.404451281662, 9160.0, 9328.160465558132, 9902.207823374258, 13283.402246898719, 13609.523666672016, 13804.516841910485, 14730.779038314648, 10775.6228532001, 11487.655370338904, 11533.135014874086, 11956.402179890796, 12005.579804706793, 12332.81500777471, 12398.5660501882, 12400.81398779001, 12506.062045346453, 12819.038572107316, 11245.887541124812, 11418.600348987746, 11835.585754498552, 11920.701982450508, 12437.315947622606, 8892.911070889468, 8954.686585969459, 9009.684661036832, 9091.045440228945, 9253.953730231306, 9097.636094556143, 11229.032177662635, 11242.437878106226, 11281.097512199169, 11428.142889283503], "value": 9543.084757757659, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.8308386077529, 1586.2306781211114, 1777.7511148439212, 1895.87676801008, 1914.1577705809434, 7931.762047138595, 8959.328050396214, 9005.864912026316, 9497.002814704452, 9498.145166934975, 9041.502717350542, 9231.446113233194, 9333.673321433751, 9392.248620110391, 9431.434113953168, 2413.0950893414924, 2430.8176886733477, 2453.595156799126, 2457.0908763757434, 2461.1016978802786, 2390.988045059772, 2405.5790236708594, 2441.1333976438377, 2445.6698345723275, 2460.5817011108065, 2403.9759602404015, 2431.7932975697086, 2434.8782560871887, 2455.8035357171475, 2463.864487453189, 2369.7393286738443, 2390.9282721518384, 2407.2176542623542, 2417.8549287042747, 2433.2943446400523, 2440.2679196241056, 2443.767842055002, 2472.208893154191, 2482.751724827521, 2493.613489909067, 9258.259339252843, 9323.580438880266, 9334.67328643501, 9354.906450935472, 9386.155246027822, 5472.179173124024, 5549.084401073818, 5609.887802243932, 5620.606557540974, 5660.943390566124, 3465.4455287154187, 3468.3756923753713, 3584.8028358440274, 3603.1892824114625, 3733.0480727414338, 1139.5327915554665, 1147.7015975846257, 1147.8852114788538, 1153.1697178031804, 1173.178774857603, 12728.490860365668, 12855.16441431304, 12868.549600763929, 12910.354482275849, 12920.483180672762, 4643.674942753974, 4755.262934245197, 4771.188897887368, 4789.066132104276, 4902.191138462185, 10807.351558906334, 10820.188485863591, 10847.403392813314, 10904.454777261264, 10923.3992130432, 5560.304961879765, 5566.415526369754, 5571.220029195916, 5592.972035139798, 5605.271314729141, 4476.2837945928495, 5006.69959802413, 5010.799568017312, 5121.129408000649, 5156.9742151289, 4011.8395264189107, 4054.412110243998, 4104.486939132608, 4121.608447197512, 4144.854930077433, 1262.8232047513357, 1287.060445874498, 1291.7222797098668, 1293.7994610835335, 1300.057458342694, 1002.3184234720314, 1023.1610079734546, 1056.4770438632927, 1092.7158938675843, 1095.326374279828, 6354.428101470798, 6399.968000159969, 6401.199850018747, 6454.935450645527, 6545.21457425112, 505.46673259711355, 512.776942030218, 513.386503128765, 527.1591811061351, 527.7071225469824, 4328.329108988112, 4340.001799586113, 4383.539728328544, 4387.210302145644, 4389.3415987601475, 11214.10287177024, 11573.594924177612, 11591.188616796911, 11666.824997625043, 11668.241564298294, 11268.492917818718, 11418.486168122454, 11431.085513158927, 11478.885211147948, 11778.88221117795, 8647.135286471303, 8661.873956385629, 8682.696105636272, 8771.824563508693, 8783.648654053766, 6370.331115233019, 6384.93615063862, 6388.361163883575, 6402.839929001812, 6427.3251308611925, 10577.788444231226, 10620.84068738954, 10716.839247411139, 10803.405812680377, 10888.564457421615, 10759.30064545802, 10816.296940698829, 10844.783104338027, 11070.723231919266, 11080.0, 7266.67299971492, 7663.846723065619, 7880.211978802303, 8203.097659257597, 8247.628856701343, 8995.0, 9006.729798106067, 9011.459312441275, 9038.322125840457, 9084.0, 7956.085050219299, 8082.83834323322, 8163.591820409075, 8228.465149765247, 8270.83458330842, 8031.237032481905, 8169.428140030141, 8212.958935205286, 8221.095679475133, 8268.421210515206, 7024.367806897404, 7119.67961441726, 7181.892271615826, 7501.924980750123, 7643.159252482112, 5485.122380419114, 5515.117581186991, 5533.695646739468, 5557.194206840067, 5599.720013999366, 5443.074677304947, 5465.890682186255, 5488.121900495901, 5538.363088244903, 5556.194351819045], "value": 4809.656890133255, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.82596940483876, 359.80210884013786, 361.7829302418549, 365.12006065382417, 371.98140092995345, 5815.098659707747, 5825.796097136601, 5829.708514574265, 5887.470127688507, 5900.498457631095, 5568.52667523261, 5820.613548445138, 5838.941610583893, 5843.779363841745, 5843.970780146094, 4475.418195634563, 4519.0, 4533.342665313536, 4549.886252843688, 4552.68131230814, 4526.524714904937, 4542.568455996691, 4558.860284928768, 4566.817327306904, 4604.1482325769675, 4437.955620443802, 4567.13224487348, 4568.497465278833, 4577.748223847687, 4589.816407343719, 4483.484399294058, 4486.766139311682, 4516.119356725456, 4519.864404067883, 4531.728096314215, 3970.50368703912, 4009.258287216874, 4017.879463616096, 4025.798710064485, 4031.57668444812, 5591.042383387207, 5655.519280861132, 5657.57568182388, 5680.091185410314, 5701.657900525982, 5051.26756620288, 5197.570668066274, 5228.503292187236, 5236.8690782730355, 5243.374553888269, 6029.939700602981, 6036.366181550918, 6045.33501314855, 6102.786402475892, 6116.235470566179, 4360.49854266757, 4401.2517871961845, 4440.53374395687, 4441.311596702516, 4461.353103799964, 6145.446909778097, 6245.875082498324, 6298.968505157491, 6387.93612063878, 6411.839704007437, 4454.841741147325, 4455.866324010285, 4463.995600989751, 4486.618637415856, 4487.775611219426, 4487.5961163494785, 4489.024829075262, 4523.660725445605, 4523.751193684313, 4527.388802511685, 4882.0, 5128.1794912813775, 5134.922976155361, 5164.173732202829, 5213.635045546851, 6002.279726432856, 6060.515158787286, 6082.239720034996, 6085.452309292096, 6091.238595175603, 1532.9116327407442, 1547.1413365581984, 1549.6978089272484, 1555.8677512411346, 1559.0879335588581, 961.7499450142873, 998.9650362237433, 999.2305924438142, 1001.2840818814583, 1010.9738615305471, 5291.0, 5296.3909150447425, 5323.334583177103, 5328.08189051941, 5358.9368093284365, 5547.16792481123, 5578.86052848682, 5593.3847276799515, 5644.6613203207935, 5674.574406919498, 5326.307580014651, 5370.275012873212, 5568.749406276727, 6036.396360363929, 6066.908996365058, 3367.8316084195694, 3389.305192435545, 3418.692382641707, 3426.6573342666034, 3429.3655673700446, 6276.1799078266795, 6501.772437964649, 6627.734890604418, 6636.502262330345, 6643.335666433415, 6462.353764623594, 6475.4819614430735, 6495.188101487314, 6512.185976752906, 6524.282328943812, 6390.233172019481, 6552.575547047623, 6590.176227971504, 6647.966760166169, 6673.6986287673435, 6341.4292713656, 6342.841428964312, 6355.459785918249, 6364.981602943507, 6397.7760778374395, 5997.821154787969, 6278.529110316836, 6282.968585157045, 6285.465735412358, 6311.0, 6394.328595497405, 6521.380468855451, 6537.738490460329, 6574.737010519526, 6589.604623722592, 4454.5990860821385, 4479.641628669764, 4488.9102217954805, 4492.371068050541, 4526.841560545365, 6224.595401298901, 6333.619982801047, 6359.20509936258, 6364.936350636434, 6463.321351258238, 6164.075388691732, 6183.423227077066, 6187.226596675416, 6195.628262304276, 6196.907046394217, 5949.8215053548465, 6154.661493617894, 6165.72254248551, 6167.938320616916, 6186.659733714509, 6050.42520960508, 6051.788187413596, 6071.969640151771, 6072.848178795565, 6084.513238940963, 6163.506919446344, 6182.907256391068, 6226.782062627786, 6236.18929539157, 6278.277998030285, 5766.4233576642, 6028.076382954176, 6063.848403789941, 6106.1146133811235, 6130.570860039933], "value": 4643.81661691056, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.8910518869574, 732.4030914804434, 737.3437640499955, 765.3303359560384, 774.3185996323235, 13625.318734063294, 14274.714505709879, 14334.06828556143, 14530.491432799854, 14603.342849571769, 14543.0, 15012.549623511284, 15031.09813411196, 15032.624184395396, 15090.622734431645, 854.8803167556531, 856.1866227084264, 866.7876370289288, 879.7228872905047, 888.6401007591903, 883.3066043156124, 883.5317281840635, 885.8759773631697, 886.7517095213351, 888.3958907942597, 927.3462209142539, 927.7912469694298, 929.2380248196481, 930.2790337488433, 931.9161275485238, 914.5930061122802, 918.1598837064079, 919.2599957034618, 921.1387352825096, 923.3351986569659, 677.2719326723742, 680.4284401103097, 680.904673345732, 681.4990981628499, 682.1336902134261, 15419.074855508705, 15495.0, 15538.378464861393, 15599.1420471874, 15601.531954041397, 14093.2953352333, 14460.566183014527, 14777.26113694311, 14803.259837008107, 14815.259237038104, 11555.480003399784, 11561.653150405502, 11602.07183425324, 11679.94160029203, 11713.648590542298, 3932.233214523169, 3943.664788492953, 3992.4210989406374, 4039.6162364575316, 4060.2691515527194, 64515.67742161306, 65376.673116634585, 73345.0, 81629.0, 82162.58918705428, 11729.35488548121, 11783.234089784308, 11798.5870494534, 11945.88054119465, 11946.283223006647, 23189.42026449352, 23227.954742036312, 23243.0, 23400.18099366514, 23418.765812342, 8789.165029322205, 8829.38194326391, 8829.602667879832, 8842.734717958472, 8926.285897128215, 4853.296272040534, 4886.315915771795, 4903.387076615423, 4955.2567114933045, 4974.8756281093265, 3562.6615471530163, 3660.7986560739414, 3672.6143754905884, 3676.6690997810324, 3690.022144131807, 585.2012003615035, 601.2604496469368, 605.4974371271834, 608.7686679061928, 616.765629060954, 596.8358701357075, 626.4612433307443, 645.5771469687362, 657.4641667041442, 715.8604072205974, 9875.901240987498, 10069.295149339623, 10204.43875586835, 10249.0, 10504.474776261157, 636.8248731598754, 643.353429803045, 676.9120014398097, 680.7719413996267, 702.0662518849917, 4525.773711314421, 4739.289106634033, 4802.927956080662, 4866.659333846667, 4882.926756098661, 106955.0, 118887.40556297163, 119414.0, 123557.0, 123884.38057809653, 70892.0, 102948.48525757324, 105166.0, 108189.0, 109653.0, 60731.39268607346, 93065.5346723262, 93393.0, 93506.0, 94094.52952735193, 9143.016637260034, 9158.313126515404, 9191.402558833654, 9230.220602074454, 9530.904690953003, 54563.45436545584, 55689.443105568425, 55886.0, 56644.7167764175, 56793.43206568047, 64663.35336646573, 64935.675321623086, 65291.347086530426, 77721.0, 80428.59785701035, 12492.812607811073, 12553.623391298275, 12671.619851404472, 12708.809367859674, 12747.426365813746, 14377.856221437652, 14560.271986400849, 14799.630009249855, 15020.24898755036, 15608.219589020277, 13634.454621815017, 14068.366923488264, 14069.788953165915, 14217.50238741639, 14462.783058254345, 13277.66805829862, 13669.453221871014, 13911.234882081582, 13978.301084945915, 14099.224542650252, 10723.195760318164, 11003.834942476029, 11313.264637798517, 13824.447022119002, 14114.858851411354, 11227.326360418074, 11375.715607109889, 11513.366764828015, 11565.421728913689, 12352.320622365856, 11438.828417573577, 11514.654560363202, 11522.884771152181, 11672.64982050506, 11721.355325457182], "value": 7662.026672022499, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 110.0, 112.0, 111.0, 111.0, 111.0, 112.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 123.0, 153.0, 189.0, 133.0, 149.0, 160.0, 128.0, 196.0, 123.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 160.0, 162.0, 160.0, 161.0, 161.0, 163.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 168.0, 76.0, 76.0, 75.0, 74.0, 168.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 141.0, 86.0, 85.0, 84.0, 139.0, 85.0, 83.0, 134.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 119.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 148.0, 147.0, 146.0, 147.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 143.0, 95.0, 96.0, 97.0, 96.0, 96.0], "value": 100.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 53.0, 54.0, 52.0, 51.0, 52.0, 56.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 61.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 79.0, 77.0, 77.0, 76.0, 91.0, 78.0, 109.0, 83.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 126.0, 130.0, 136.0, 130.0, 147.0, 121.0, 129.0, 133.0, 131.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 156.0, 156.0, 161.0, 159.0, 153.0, 154.0, 164.0, 159.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 67.0, 62.0, 62.0, 62.0, 62.0, 63.0, 61.0], "value": 62.9, "unit": "score"}]}]} 11:55:10 INFO - Return code: 0 11:55:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:55:10 ERROR - # TBPL SUCCESS # 11:55:10 INFO - Running post-action listener: _resource_record_post_action 11:55:10 INFO - ##### 11:55:10 INFO - ##### Finished run-tests step (success) 11:55:10 INFO - ##### 11:55:10 INFO - Running post-run listener: _resource_record_post_run 11:55:10 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 503554048; Read time: 24; Write time: 477704 11:55:10 INFO - TinderboxPrint: CPU usage
13.4% 11:55:10 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 11:55:10 INFO - TinderboxPrint: I/O write bytes / time
503,554,048 / 477,704 11:55:10 INFO - TinderboxPrint: CPU idle
8,225.0 (86.6%) 11:55:10 INFO - TinderboxPrint: CPU user
1,212.3 (12.8%) 11:55:10 INFO - TinderboxPrint: Swap in / out
0 / 0 11:55:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252592128; Read time: 0; Write time: 250648 11:55:10 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250961920; Read time: 24; Write time: 227056 11:55:11 INFO - Running post-run listener: _upload_blobber_files 11:55:11 INFO - Blob upload gear active. 11:55:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:55:11 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 11:55:11 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:55:11 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:55:11 INFO - (blobuploader) - INFO - Open directory for files ... 11:55:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:55:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:55:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:55:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:55:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:55:12 INFO - (blobuploader) - INFO - Done attempting. 11:55:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:55:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:55:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:55:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:55:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:55:15 INFO - (blobuploader) - INFO - Done attempting. 11:55:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:55:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:55:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:55:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:55:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:55:16 INFO - (blobuploader) - INFO - Done attempting. 11:55:16 INFO - (blobuploader) - INFO - Iteration through files over. 11:55:16 INFO - Return code: 0 11:55:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:55:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:55:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50ea52d0d8abbce6e73084acaadeb23d29d3ebd9802f9b17845d18522d3af3a2e3b2a7c4782c66b61fb17e9e5fda1c32a014b6d6cd8a2b9012f2dfb8259abdcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aadc668fdf5e2c3b8ba7194a9fea53fbb6fd39960c6be2350164776dcfa9a662ea536c4e20b5ead42bdf083271b990f5df1b8a0e38bdc776d7d359b643e78cf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8eb5b05c2007adc81ffe1af10ebac66e6827797073ff6f5628f79fce8825ea03c94780ee8c8eacedb0fa3bb86f3dd16b61a1f074a5540f0c0b676114daca0b33"} 11:55:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:55:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:55:16 INFO - Contents: 11:55:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50ea52d0d8abbce6e73084acaadeb23d29d3ebd9802f9b17845d18522d3af3a2e3b2a7c4782c66b61fb17e9e5fda1c32a014b6d6cd8a2b9012f2dfb8259abdcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aadc668fdf5e2c3b8ba7194a9fea53fbb6fd39960c6be2350164776dcfa9a662ea536c4e20b5ead42bdf083271b990f5df1b8a0e38bdc776d7d359b643e78cf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8eb5b05c2007adc81ffe1af10ebac66e6827797073ff6f5628f79fce8825ea03c94780ee8c8eacedb0fa3bb86f3dd16b61a1f074a5540f0c0b676114daca0b33"} 11:55:16 INFO - Running post-run listener: copy_logs_to_upload_dir 11:55:16 INFO - Copying logs to upload dir... 11:55:16 INFO - mkdir: /builds/slave/test/build/upload/logs 11:55:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.329563 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-26 11:55:15.690081) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 11:55:15.698998) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787 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/Mozilla-Aurora/sha512/50ea52d0d8abbce6e73084acaadeb23d29d3ebd9802f9b17845d18522d3af3a2e3b2a7c4782c66b61fb17e9e5fda1c32a014b6d6cd8a2b9012f2dfb8259abdcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aadc668fdf5e2c3b8ba7194a9fea53fbb6fd39960c6be2350164776dcfa9a662ea536c4e20b5ead42bdf083271b990f5df1b8a0e38bdc776d7d359b643e78cf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8eb5b05c2007adc81ffe1af10ebac66e6827797073ff6f5628f79fce8825ea03c94780ee8c8eacedb0fa3bb86f3dd16b61a1f074a5540f0c0b676114daca0b33"} build_url:https://queue.taskcluster.net/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/KHbJ_od7SamzFW4zTB9hzg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50ea52d0d8abbce6e73084acaadeb23d29d3ebd9802f9b17845d18522d3af3a2e3b2a7c4782c66b61fb17e9e5fda1c32a014b6d6cd8a2b9012f2dfb8259abdcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aadc668fdf5e2c3b8ba7194a9fea53fbb6fd39960c6be2350164776dcfa9a662ea536c4e20b5ead42bdf083271b990f5df1b8a0e38bdc776d7d359b643e78cf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8eb5b05c2007adc81ffe1af10ebac66e6827797073ff6f5628f79fce8825ea03c94780ee8c8eacedb0fa3bb86f3dd16b61a1f074a5540f0c0b676114daca0b33"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 11:55:15.726414) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:55:15.726820) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466964189.99411-1125521787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 11:55:15.812679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 11:55:15.813090) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 11:55:15.813484) ========= ========= Total master_lag: 0.20 =========