builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1466409805.71 results: success (0) buildid: 20160619223110 builduid: 6e8915f09b5a41c3beb9953aa44a28e1 revision: 3ddf6bae09dc3467b7176eaa7be9a52086d05d8e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 01:03:25.710094) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 01:03:25.710582) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 01:03:25.710942) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 01:03:25.782102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 01:03:25.782408) ========= 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-1466395065.764248-272804846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-20 01:03:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-20 01:03:28 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137883 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 01:03:25.948517) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 01:03:25.948855) ========= 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-1466395065.764248-272804846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019196 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 01:03:26.004685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 01:03:26.005041) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3ddf6bae09dc3467b7176eaa7be9a52086d05d8e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3ddf6bae09dc3467b7176eaa7be9a52086d05d8e --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-1466395065.764248-272804846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-20 01:03:28,377 truncating revision to first 12 chars 2016-06-20 01:03:28,377 Setting DEBUG logging. 2016-06-20 01:03:28,377 attempt 1/10 2016-06-20 01:03:28,377 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/3ddf6bae09dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 01:03:28,759 unpacking tar archive at: mozilla-inbound-3ddf6bae09dc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.707537 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 01:03:26.730955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 01:03:26.731424) ========= script_repo_revision: 3ddf6bae09dc3467b7176eaa7be9a52086d05d8e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 01:03:26.732123) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 01:03:26.732608) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 01:03:26.744791) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-20 01:03:26.745104) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1466395065.764248-272804846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:03:29 INFO - MultiFileLogger online at 20160620 01:03:29 in /builds/slave/test 01:03:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:03:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:03:29 INFO - {'append_to_log': False, 01:03:29 INFO - 'base_work_dir': '/builds/slave/test', 01:03:29 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:03:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:03:29 INFO - 'branch': 'Mozilla-Inbound', 01:03:29 INFO - 'buildbot_json_path': 'buildprops.json', 01:03:29 INFO - 'config_files': ('talos/linux_config.py',), 01:03:29 INFO - 'default_actions': ('clobber', 01:03:29 INFO - 'read-buildbot-config', 01:03:29 INFO - 'download-and-extract', 01:03:29 INFO - 'populate-webroot', 01:03:29 INFO - 'create-virtualenv', 01:03:29 INFO - 'install', 01:03:29 INFO - 'run-tests'), 01:03:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:03:29 INFO - 'download_minidump_stackwalk': True, 01:03:29 INFO - 'download_symbols': 'ondemand', 01:03:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:03:29 INFO - 'tooltool.py': '/tools/tooltool.py', 01:03:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:03:29 INFO - '/tools/misc-python/virtualenv.py')}, 01:03:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:03:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:03:29 INFO - 'installer_path': 'installer.exe', 01:03:29 INFO - 'log_level': 'info', 01:03:29 INFO - 'log_name': 'talos', 01:03:29 INFO - 'log_to_console': True, 01:03:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:03:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:03:29 INFO - 'opt_config_files': (), 01:03:29 INFO - 'pip_index': False, 01:03:29 INFO - 'sps_profile': False, 01:03:29 INFO - 'sps_profile_interval': 0, 01:03:29 INFO - 'suite': 'dromaeojs-e10s', 01:03:29 INFO - 'system_bits': '32', 01:03:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:03:29 INFO - 'title': 'talos-linux64-ix-061', 01:03:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:03:29 INFO - 'use_talos_json': True, 01:03:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:03:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:03:29 INFO - 'work_dir': 'build'} 01:03:29 INFO - ##### 01:03:29 INFO - ##### Running clobber step. 01:03:29 INFO - ##### 01:03:29 INFO - Running pre-action listener: _resource_record_pre_action 01:03:29 INFO - Running main action method: clobber 01:03:29 INFO - rmtree: /builds/slave/test/build 01:03:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:03:29 INFO - Running post-action listener: _resource_record_post_action 01:03:29 INFO - ##### 01:03:29 INFO - ##### Finished clobber step (success) 01:03:29 INFO - ##### 01:03:29 INFO - ##### 01:03:29 INFO - ##### Running read-buildbot-config step. 01:03:29 INFO - ##### 01:03:29 INFO - Running pre-action listener: _resource_record_pre_action 01:03:29 INFO - Running main action method: read_buildbot_config 01:03:29 INFO - Using buildbot properties: 01:03:29 INFO - { 01:03:29 INFO - "project": "", 01:03:29 INFO - "product": "firefox", 01:03:29 INFO - "script_repo_revision": "production", 01:03:29 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 01:03:29 INFO - "repository": "", 01:03:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 01:03:29 INFO - "buildid": "20160619223110", 01:03:29 INFO - "pgo_build": "True", 01:03:29 INFO - "basedir": "/builds/slave/test", 01:03:29 INFO - "buildnumber": 737, 01:03:29 INFO - "slavename": "talos-linux64-ix-061", 01:03:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:03:29 INFO - "platform": "ubuntu64_hw", 01:03:29 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:03:29 INFO - "branch": "mozilla-inbound", 01:03:29 INFO - "repo_path": "integration/mozilla-inbound", 01:03:29 INFO - "revision": "3ddf6bae09dc3467b7176eaa7be9a52086d05d8e", 01:03:29 INFO - "stage_platform": "linux64-pgo", 01:03:29 INFO - "builduid": "6e8915f09b5a41c3beb9953aa44a28e1", 01:03:29 INFO - "slavebuilddir": "test" 01:03:29 INFO - } 01:03:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:03:29 INFO - Running post-action listener: _resource_record_post_action 01:03:29 INFO - ##### 01:03:29 INFO - ##### Finished read-buildbot-config step (success) 01:03:29 INFO - ##### 01:03:29 INFO - ##### 01:03:29 INFO - ##### Running download-and-extract step. 01:03:29 INFO - ##### 01:03:29 INFO - Running pre-action listener: _resource_record_pre_action 01:03:29 INFO - Running main action method: download_and_extract 01:03:29 INFO - mkdir: /builds/slave/test/build/tests 01:03:29 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')]} 01:03:29 INFO - https://queue.taskcluster.net/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:03:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:03:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:03:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:03:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:03:33 INFO - Downloaded 1361 bytes. 01:03:33 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:03:33 INFO - Using the following test package requirements: 01:03:33 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:03:33 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:03:33 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:03:33 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:33 INFO - u'jsshell-linux-x86_64.zip'], 01:03:33 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:03:33 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:03:33 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:03:33 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:03:33 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:03:33 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:03:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:03:33 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')]} 01:03:33 INFO - https://queue.taskcluster.net/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:03:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:03:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:03:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:03:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:03:35 INFO - Downloaded 24221902 bytes. 01:03:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:03:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:03:36 INFO - Return code: 0 01:03:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:03: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')]} 01:03:36 INFO - https://queue.taskcluster.net/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:03:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:03:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:03:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:03:40 INFO - Downloaded 24221902 bytes. 01:03:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:03:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:03:41 INFO - Return code: 0 01:03:41 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')]} 01:03:41 INFO - https://queue.taskcluster.net/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:03:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:03:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:03:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:03:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:03:42 INFO - Downloaded 14405384 bytes. 01:03:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:03:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:03:42 INFO - Return code: 0 01:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:42 INFO - https://queue.taskcluster.net/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:03:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:03:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:03:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:03:44 INFO - Downloaded 60122255 bytes. 01:03:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:03:44 INFO - mkdir: /builds/slave/test/properties 01:03:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:03:44 INFO - Writing to file /builds/slave/test/properties/build_url 01:03:44 INFO - Contents: 01:03:44 INFO - build_url:https://queue.taskcluster.net/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:03:45 INFO - Running post-action listener: _resource_record_post_action 01:03:45 INFO - Running post-action listener: set_extra_try_arguments 01:03:45 INFO - ##### 01:03:45 INFO - ##### Finished download-and-extract step (success) 01:03:45 INFO - ##### 01:03:45 INFO - ##### 01:03:45 INFO - ##### Running populate-webroot step. 01:03:45 INFO - ##### 01:03:45 INFO - Running pre-action listener: _resource_record_pre_action 01:03:45 INFO - Running main action method: populate_webroot 01:03:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:03:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:03:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:03:45 INFO - '--tppagecycles', 01:03:45 INFO - '7'], 01:03:45 INFO - 'tests': ['tsvgm']}}, 01:03:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:03:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:03:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:03:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:03:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:03:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:03:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:45 INFO - 'talos_options': ['--disable-e10s'], 01:03:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:03:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:03:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:45 INFO - 'talos_options': ['--disable-e10s'], 01:03:45 INFO - 'tests': ['damp', 'tps']}, 01:03:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:45 INFO - 'tests': ['damp', 'tps']}, 01:03:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:03:45 INFO - 'tests': ['dromaeo_dom']}, 01:03:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:03:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:03:45 INFO - 'tests': ['basic_compositor_video']}, 01:03:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:03:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:03:45 INFO - 'tests': ['a11yr', 01:03:45 INFO - 'ts_paint', 01:03:45 INFO - 'tpaint', 01:03:45 INFO - 'sessionrestore', 01:03:45 INFO - 'sessionrestore_no_auto_restore', 01:03:45 INFO - 'tabpaint']}, 01:03:45 INFO - 'other-e10s': {'tests': ['a11yr', 01:03:45 INFO - 'ts_paint', 01:03:45 INFO - 'tpaint', 01:03:45 INFO - 'sessionrestore', 01:03:45 INFO - 'sessionrestore_no_auto_restore', 01:03:45 INFO - 'tabpaint']}, 01:03:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:03:45 INFO - 'ts_paint', 01:03:45 INFO - 'tpaint', 01:03:45 INFO - 'sessionrestore', 01:03:45 INFO - 'sessionrestore_no_auto_restore', 01:03:45 INFO - 'tabpaint']}, 01:03:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:03:45 INFO - 'ts_paint', 01:03:45 INFO - 'tpaint', 01:03:45 INFO - 'sessionrestore', 01:03:45 INFO - 'sessionrestore_no_auto_restore', 01:03:45 INFO - 'tabpaint']}, 01:03:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:03:45 INFO - 'tests': ['a11yr', 01:03:45 INFO - 'ts_paint', 01:03:45 INFO - 'tpaint', 01:03:45 INFO - 'sessionrestore', 01:03:45 INFO - 'sessionrestore_no_auto_restore', 01:03:45 INFO - 'tabpaint']}, 01:03:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:03:45 INFO - 'tests': ['a11yr', 01:03:45 INFO - 'ts_paint', 01:03:45 INFO - 'tpaint', 01:03:45 INFO - 'sessionrestore', 01:03:45 INFO - 'sessionrestore_no_auto_restore', 01:03:45 INFO - 'tabpaint']}, 01:03:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:03:45 INFO - 'tests': ['tsvgx', 01:03:45 INFO - 'tsvgr_opacity', 01:03:45 INFO - 'tart', 01:03:45 INFO - 'tscrollx', 01:03:45 INFO - 'cart']}, 01:03:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:03:45 INFO - 'tsvgr_opacity', 01:03:45 INFO - 'tart', 01:03:45 INFO - 'tscrollx', 01:03:45 INFO - 'cart']}, 01:03:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:45 INFO - 'talos_options': ['--disable-e10s'], 01:03:45 INFO - 'tests': ['tp5o']}, 01:03:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:45 INFO - 'tests': ['tp5o']}, 01:03:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:45 INFO - 'talos_options': ['--disable-e10s', 01:03:45 INFO - '--xperf_path', 01:03:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:03:45 INFO - 'tests': ['tp5n']}, 01:03:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:45 INFO - 'talos_options': ['--xperf_path', 01:03:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:03:45 INFO - 'tests': ['tp5n']}}, 01:03:45 INFO - 'talos.zip': {'path': '', 01:03:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:03:45 INFO - Running post-action listener: _resource_record_post_action 01:03:45 INFO - ##### 01:03:45 INFO - ##### Finished populate-webroot step (success) 01:03:45 INFO - ##### 01:03:45 INFO - ##### 01:03:45 INFO - ##### Running create-virtualenv step. 01:03:45 INFO - ##### 01:03:45 INFO - Running pre-action listener: _resource_record_pre_action 01:03:45 INFO - Running main action method: create_virtualenv 01:03:45 INFO - Creating virtualenv /builds/slave/test/build/venv 01:03:45 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 01:03:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:03:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:03:45 INFO - Using real prefix '/usr' 01:03:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:03:46 INFO - Installing distribute.............................................................................................................................................................................................done. 01:03:48 INFO - Installing pip.................done. 01:03:48 INFO - Return code: 0 01:03:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:03:48 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')]} 01:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:48 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')]} 01:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:48 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 0x7f5b93458f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21841c0>, '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 0x21850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2185550>, '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-1466395065.764248-272804846', '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 01:03:48 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 01:03:48 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 01:03:48 INFO - Using env: {'DISPLAY': ':0', 01:03:48 INFO - 'HOME': '/home/cltbld', 01:03:48 INFO - 'LANG': 'en_US.UTF-8', 01:03:48 INFO - 'LANGUAGE': 'en_US:en', 01:03:48 INFO - 'LOGNAME': 'cltbld', 01:03:48 INFO - 'MAIL': '/var/mail/cltbld', 01:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:48 INFO - 'MOZ_NO_REMOTE': '1', 01:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:48 INFO - 'NO_EM_RESTART': '1', 01:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:48 INFO - 'PWD': '/builds/slave/test', 01:03:48 INFO - 'SHELL': '/bin/bash', 01:03:48 INFO - 'SHLVL': '1', 01:03:48 INFO - 'TERM': 'linux', 01:03:48 INFO - 'TMOUT': '86400', 01:03:48 INFO - 'USER': 'cltbld', 01:03:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466395065.764248-272804846', 01:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:48 INFO - '_': '/tools/buildbot/bin/python'} 01:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:48 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 01:03:48 INFO - Cleaning up... 01:03:48 INFO - Return code: 0 01:03:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:03:48 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')]} 01:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:48 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')]} 01:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:48 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 0x7f5b93458f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21841c0>, '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 0x21850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2185550>, '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-1466395065.764248-272804846', '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 01:03:48 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 01:03:48 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 01:03:48 INFO - Using env: {'DISPLAY': ':0', 01:03:48 INFO - 'HOME': '/home/cltbld', 01:03:48 INFO - 'LANG': 'en_US.UTF-8', 01:03:48 INFO - 'LANGUAGE': 'en_US:en', 01:03:48 INFO - 'LOGNAME': 'cltbld', 01:03:48 INFO - 'MAIL': '/var/mail/cltbld', 01:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:48 INFO - 'MOZ_NO_REMOTE': '1', 01:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:48 INFO - 'NO_EM_RESTART': '1', 01:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:48 INFO - 'PWD': '/builds/slave/test', 01:03:48 INFO - 'SHELL': '/bin/bash', 01:03:48 INFO - 'SHLVL': '1', 01:03:48 INFO - 'TERM': 'linux', 01:03:48 INFO - 'TMOUT': '86400', 01:03:48 INFO - 'USER': 'cltbld', 01:03:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466395065.764248-272804846', 01:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:48 INFO - '_': '/tools/buildbot/bin/python'} 01:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:48 INFO - Downloading/unpacking psutil>=3.1.1 01:03:48 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 01:03:48 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 01:03:48 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 01:03:48 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 01:03:48 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 01:03:48 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 01:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:03:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:03:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:03:50 INFO - Installing collected packages: psutil 01:03:50 INFO - Running setup.py install for psutil 01:03:50 INFO - building 'psutil._psutil_linux' extension 01:03:50 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 01:03:50 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 01:03:50 INFO - building 'psutil._psutil_posix' extension 01:03:50 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 01:03:50 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 01:03:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:03:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:03:51 INFO - Successfully installed psutil 01:03:51 INFO - Cleaning up... 01:03:51 INFO - Return code: 0 01:03:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:03: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')]} 01:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03: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')]} 01:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:51 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 0x7f5b93458f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21841c0>, '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 0x21850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2185550>, '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-1466395065.764248-272804846', '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 01:03:51 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 01:03:51 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 01:03:51 INFO - Using env: {'DISPLAY': ':0', 01:03:51 INFO - 'HOME': '/home/cltbld', 01:03:51 INFO - 'LANG': 'en_US.UTF-8', 01:03:51 INFO - 'LANGUAGE': 'en_US:en', 01:03:51 INFO - 'LOGNAME': 'cltbld', 01:03:51 INFO - 'MAIL': '/var/mail/cltbld', 01:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:51 INFO - 'MOZ_NO_REMOTE': '1', 01:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:51 INFO - 'NO_EM_RESTART': '1', 01:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:51 INFO - 'PWD': '/builds/slave/test', 01:03:51 INFO - 'SHELL': '/bin/bash', 01:03:51 INFO - 'SHLVL': '1', 01:03:51 INFO - 'TERM': 'linux', 01:03:51 INFO - 'TMOUT': '86400', 01:03:51 INFO - 'USER': 'cltbld', 01:03:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466395065.764248-272804846', 01:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:51 INFO - '_': '/tools/buildbot/bin/python'} 01:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:03:51 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 01:03:51 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 01:03:51 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 01:03:51 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 01:03:51 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 01:03:51 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 01:03:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:03:53 INFO - Installing collected packages: mozsystemmonitor 01:03:53 INFO - Running setup.py install for mozsystemmonitor 01:03:53 INFO - Successfully installed mozsystemmonitor 01:03:53 INFO - Cleaning up... 01:03:53 INFO - Return code: 0 01:03:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:53 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 0x7f5b93458f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21841c0>, '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 0x21850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2185550>, '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-1466395065.764248-272804846', '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 01:03:53 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 01:03:53 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 01:03:53 INFO - Using env: {'DISPLAY': ':0', 01:03:53 INFO - 'HOME': '/home/cltbld', 01:03:53 INFO - 'LANG': 'en_US.UTF-8', 01:03:53 INFO - 'LANGUAGE': 'en_US:en', 01:03:53 INFO - 'LOGNAME': 'cltbld', 01:03:53 INFO - 'MAIL': '/var/mail/cltbld', 01:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:53 INFO - 'MOZ_NO_REMOTE': '1', 01:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:53 INFO - 'NO_EM_RESTART': '1', 01:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:53 INFO - 'PWD': '/builds/slave/test', 01:03:53 INFO - 'SHELL': '/bin/bash', 01:03:53 INFO - 'SHLVL': '1', 01:03:53 INFO - 'TERM': 'linux', 01:03:53 INFO - 'TMOUT': '86400', 01:03:53 INFO - 'USER': 'cltbld', 01:03:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466395065.764248-272804846', 01:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:53 INFO - '_': '/tools/buildbot/bin/python'} 01:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:53 INFO - Downloading/unpacking jsonschema==2.5.1 01:03:53 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 01:03:53 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 01:03:53 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 01:03:53 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 01:03:53 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 01:03:53 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 01:03:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:03:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:55 INFO - Downloading functools32-3.2.3-2.tar.gz 01:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:03:55 INFO - warning: no files found matching '*.txt' 01:03:55 INFO - no previously-included directories found matching 'build' 01:03:55 INFO - no previously-included directories found matching 'dist' 01:03:55 INFO - no previously-included directories found matching '.git*' 01:03:55 INFO - Installing collected packages: jsonschema, functools32 01:03:55 INFO - Running setup.py install for functools32 01:03:55 INFO - warning: no files found matching '*.txt' 01:03:55 INFO - no previously-included directories found matching 'build' 01:03:55 INFO - no previously-included directories found matching 'dist' 01:03:55 INFO - no previously-included directories found matching '.git*' 01:03:55 INFO - Successfully installed jsonschema functools32 01:03:55 INFO - Cleaning up... 01:03:55 INFO - Return code: 0 01:03:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5b93458f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21841c0>, '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 0x21850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2185550>, '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-1466395065.764248-272804846', '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 01:03:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:03:55 INFO - Using env: {'DISPLAY': ':0', 01:03:55 INFO - 'HOME': '/home/cltbld', 01:03:55 INFO - 'LANG': 'en_US.UTF-8', 01:03:55 INFO - 'LANGUAGE': 'en_US:en', 01:03:55 INFO - 'LOGNAME': 'cltbld', 01:03:55 INFO - 'MAIL': '/var/mail/cltbld', 01:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:55 INFO - 'MOZ_NO_REMOTE': '1', 01:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:55 INFO - 'NO_EM_RESTART': '1', 01:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:55 INFO - 'PWD': '/builds/slave/test', 01:03:55 INFO - 'SHELL': '/bin/bash', 01:03:55 INFO - 'SHLVL': '1', 01:03:55 INFO - 'TERM': 'linux', 01:03:55 INFO - 'TMOUT': '86400', 01:03:55 INFO - 'USER': 'cltbld', 01:03:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466395065.764248-272804846', 01:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:55 INFO - '_': '/tools/buildbot/bin/python'} 01:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:56 INFO - Downloading/unpacking blobuploader==1.2.4 01:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:57 INFO - Downloading blobuploader-1.2.4.tar.gz 01:03:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:03:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:03: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 01:03: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 01:03: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 01:03: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 01:03: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 01:03: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 01:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:03:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:03: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 01:03: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 01:03: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 01:03: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 01:03: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 01:03: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 01:03:58 INFO - Downloading docopt-0.6.1.tar.gz 01:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:03:58 INFO - Installing collected packages: blobuploader, requests, docopt 01:03:58 INFO - Running setup.py install for blobuploader 01:03:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:03:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:03:58 INFO - Running setup.py install for requests 01:03:59 INFO - Running setup.py install for docopt 01:03:59 INFO - Successfully installed blobuploader requests docopt 01:03:59 INFO - Cleaning up... 01:03:59 INFO - Return code: 0 01:03:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:03:59 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')]} 01:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:59 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')]} 01:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:59 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 0x7f5b93458f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21841c0>, '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 0x21850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2185550>, '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-1466395065.764248-272804846', '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 01:03:59 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 01:03:59 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 01:03:59 INFO - Using env: {'DISPLAY': ':0', 01:03:59 INFO - 'HOME': '/home/cltbld', 01:03:59 INFO - 'LANG': 'en_US.UTF-8', 01:03:59 INFO - 'LANGUAGE': 'en_US:en', 01:03:59 INFO - 'LOGNAME': 'cltbld', 01:03:59 INFO - 'MAIL': '/var/mail/cltbld', 01:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:59 INFO - 'MOZ_NO_REMOTE': '1', 01:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:59 INFO - 'NO_EM_RESTART': '1', 01:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:59 INFO - 'PWD': '/builds/slave/test', 01:03:59 INFO - 'SHELL': '/bin/bash', 01:03:59 INFO - 'SHLVL': '1', 01:03:59 INFO - 'TERM': 'linux', 01:03:59 INFO - 'TMOUT': '86400', 01:03:59 INFO - 'USER': 'cltbld', 01:03:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466395065.764248-272804846', 01:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:59 INFO - '_': '/tools/buildbot/bin/python'} 01:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:03:59 INFO - Running setup.py (path:/tmp/pip-AXo1Hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:03:59 INFO - Running setup.py (path:/tmp/pip-KlER_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:03:59 INFO - Running setup.py (path:/tmp/pip-X6AAho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:03:59 INFO - Running setup.py (path:/tmp/pip-NS69dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:03:59 INFO - Running setup.py (path:/tmp/pip-ctRHYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:03:59 INFO - Running setup.py (path:/tmp/pip-EjWt2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:03:59 INFO - Running setup.py (path:/tmp/pip-nbTs3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:04:00 INFO - Running setup.py (path:/tmp/pip-nOOmM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:04:00 INFO - Running setup.py (path:/tmp/pip-P3pjRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:04:00 INFO - Running setup.py (path:/tmp/pip-gyGc9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:04:00 INFO - Running setup.py (path:/tmp/pip-ceA3_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:04:00 INFO - Running setup.py (path:/tmp/pip-S591_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:04:00 INFO - Running setup.py (path:/tmp/pip-Vzh7Ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:04:00 INFO - Running setup.py (path:/tmp/pip-WnYSbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:04:00 INFO - Running setup.py (path:/tmp/pip-4E9tpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:04:00 INFO - Running setup.py (path:/tmp/pip-hJwIe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:04:00 INFO - Running setup.py (path:/tmp/pip-VARdw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:04:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:04:00 INFO - Running setup.py install for manifestparser 01:04:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:04:00 INFO - Running setup.py install for mozcrash 01:04:01 INFO - Running setup.py install for mozdebug 01:04:01 INFO - Running setup.py install for mozdevice 01:04:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:04:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:04:01 INFO - Running setup.py install for mozfile 01:04:01 INFO - Running setup.py install for mozhttpd 01:04:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:04:01 INFO - Running setup.py install for mozinfo 01:04:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:04:01 INFO - Running setup.py install for mozInstall 01:04:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:04:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:04:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:04:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:04:01 INFO - Running setup.py install for mozleak 01:04:01 INFO - Running setup.py install for mozlog 01:04:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:04:01 INFO - Running setup.py install for moznetwork 01:04:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:04:01 INFO - Running setup.py install for mozprocess 01:04:02 INFO - Running setup.py install for mozprofile 01:04:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:04:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:04:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:04:02 INFO - Running setup.py install for mozrunner 01:04:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:04:02 INFO - Running setup.py install for mozscreenshot 01:04:02 INFO - Running setup.py install for moztest 01:04:02 INFO - Running setup.py install for mozversion 01:04:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:04:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:04:02 INFO - Cleaning up... 01:04:02 INFO - Return code: 0 01:04:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:02 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 0x7f5b93458f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21841c0>, '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 0x21850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2185550>, '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-1466395065.764248-272804846', '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 01:04:02 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 01:04:02 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 01:04:02 INFO - Using env: {'DISPLAY': ':0', 01:04:02 INFO - 'HOME': '/home/cltbld', 01:04:02 INFO - 'LANG': 'en_US.UTF-8', 01:04:02 INFO - 'LANGUAGE': 'en_US:en', 01:04:02 INFO - 'LOGNAME': 'cltbld', 01:04:02 INFO - 'MAIL': '/var/mail/cltbld', 01:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:02 INFO - 'MOZ_NO_REMOTE': '1', 01:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:02 INFO - 'NO_EM_RESTART': '1', 01:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:02 INFO - 'PWD': '/builds/slave/test', 01:04:02 INFO - 'SHELL': '/bin/bash', 01:04:02 INFO - 'SHLVL': '1', 01:04:02 INFO - 'TERM': 'linux', 01:04:02 INFO - 'TMOUT': '86400', 01:04:02 INFO - 'USER': 'cltbld', 01:04:02 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466395065.764248-272804846', 01:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:02 INFO - '_': '/tools/buildbot/bin/python'} 01:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:04:02 INFO - Running setup.py (path:/tmp/pip-nVQkZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:04:02 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)) 01:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:04:02 INFO - Running setup.py (path:/tmp/pip-p_fE2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:04:02 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)) 01:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:04:02 INFO - Running setup.py (path:/tmp/pip-YbTFba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:04:03 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)) 01:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:04:03 INFO - Running setup.py (path:/tmp/pip-HSkT2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:04:03 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)) 01:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:04:03 INFO - Running setup.py (path:/tmp/pip-VXgKgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:04:03 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)) 01:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:04:03 INFO - Running setup.py (path:/tmp/pip-I9Zizs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:04:03 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)) 01:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:04:03 INFO - Running setup.py (path:/tmp/pip-dsf6BN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:04:03 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)) 01:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:04:03 INFO - Running setup.py (path:/tmp/pip-07oCgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:04:03 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)) 01:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:04:03 INFO - Running setup.py (path:/tmp/pip-TLfp5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:04:03 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)) 01:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:04:03 INFO - Running setup.py (path:/tmp/pip-dVtbnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:04:03 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)) 01:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:04:03 INFO - Running setup.py (path:/tmp/pip-tpJNMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:04:03 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)) 01:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:04:03 INFO - Running setup.py (path:/tmp/pip-4p6Zdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:04:03 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)) 01:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:04:03 INFO - Running setup.py (path:/tmp/pip-50Rdt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:04:03 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)) 01:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:04:03 INFO - Running setup.py (path:/tmp/pip-NK1Ixc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:04:03 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)) 01:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:04:03 INFO - Running setup.py (path:/tmp/pip-HVR3hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:04:03 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)) 01:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:04:03 INFO - Running setup.py (path:/tmp/pip-uEjqcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:04:04 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)) 01:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:04:04 INFO - Running setup.py (path:/tmp/pip-glgfB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:04:04 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)) 01:04:04 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)) 01:04:04 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)) 01:04:04 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)) 01:04:04 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)) 01:04:04 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)) 01:04:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:04: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 01:04: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 01:04: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 01:04: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 01:04: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 01:04: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 01:04:05 INFO - Downloading blessings-1.6.tar.gz 01:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:04:06 INFO - Installing collected packages: blessings 01:04:06 INFO - Running setup.py install for blessings 01:04:06 INFO - Successfully installed blessings 01:04:06 INFO - Cleaning up... 01:04:06 INFO - Return code: 0 01:04:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:04:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:04:06 INFO - Reading from file tmpfile_stdout 01:04:06 INFO - Current package versions: 01:04:06 INFO - argparse == 1.2.1 01:04:06 INFO - blessings == 1.6 01:04:06 INFO - blobuploader == 1.2.4 01:04:06 INFO - docopt == 0.6.1 01:04:06 INFO - functools32 == 3.2.3-2 01:04:06 INFO - jsonschema == 2.5.1 01:04:06 INFO - manifestparser == 1.1 01:04:06 INFO - mozInstall == 1.12 01:04:06 INFO - mozcrash == 0.17 01:04:06 INFO - mozdebug == 0.1 01:04:06 INFO - mozdevice == 0.48 01:04:06 INFO - mozfile == 1.2 01:04:06 INFO - mozhttpd == 0.7 01:04:06 INFO - mozinfo == 0.9 01:04:06 INFO - mozleak == 0.1 01:04:06 INFO - mozlog == 3.2 01:04:06 INFO - moznetwork == 0.27 01:04:06 INFO - mozprocess == 0.22 01:04:06 INFO - mozprofile == 0.28 01:04:06 INFO - mozrunner == 6.11 01:04:06 INFO - mozscreenshot == 0.1 01:04:06 INFO - mozsystemmonitor == 0.3 01:04:06 INFO - moztest == 0.7 01:04:06 INFO - mozversion == 1.4 01:04:06 INFO - psutil == 3.1.1 01:04:06 INFO - requests == 1.2.3 01:04:06 INFO - wsgiref == 0.1.2 01:04:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:04: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')]} 01:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04: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')]} 01:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:06 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 0x7f5b93458f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21841c0>, '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 0x21850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2185550>, '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-1466395065.764248-272804846', '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 01:04:06 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 01:04:06 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 01:04:06 INFO - Using env: {'DISPLAY': ':0', 01:04:06 INFO - 'HOME': '/home/cltbld', 01:04:06 INFO - 'LANG': 'en_US.UTF-8', 01:04:06 INFO - 'LANGUAGE': 'en_US:en', 01:04:06 INFO - 'LOGNAME': 'cltbld', 01:04:06 INFO - 'MAIL': '/var/mail/cltbld', 01:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:06 INFO - 'MOZ_NO_REMOTE': '1', 01:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:06 INFO - 'NO_EM_RESTART': '1', 01:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:06 INFO - 'PWD': '/builds/slave/test', 01:04:06 INFO - 'SHELL': '/bin/bash', 01:04:06 INFO - 'SHLVL': '1', 01:04:06 INFO - 'TERM': 'linux', 01:04:06 INFO - 'TMOUT': '86400', 01:04:06 INFO - 'USER': 'cltbld', 01:04:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466395065.764248-272804846', 01:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:06 INFO - '_': '/tools/buildbot/bin/python'} 01:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:06 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)) 01:04:06 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)) 01:04:06 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)) 01:04:06 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)) 01:04:06 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)) 01:04:06 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)) 01:04:06 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)) 01:04:06 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)) 01:04:06 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)) 01:04:06 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)) 01:04:06 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)) 01:04:06 INFO - Cleaning up... 01:04:06 INFO - Return code: 0 01:04:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:04: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')]} 01:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04: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')]} 01:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b93458f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21841c0>, '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 0x21850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2185550>, '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-1466395065.764248-272804846', '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 01:04: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', 'jsonschema'] in /builds/slave/test/build 01:04: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 jsonschema 01:04:06 INFO - Using env: {'DISPLAY': ':0', 01:04:06 INFO - 'HOME': '/home/cltbld', 01:04:06 INFO - 'LANG': 'en_US.UTF-8', 01:04:06 INFO - 'LANGUAGE': 'en_US:en', 01:04:06 INFO - 'LOGNAME': 'cltbld', 01:04:06 INFO - 'MAIL': '/var/mail/cltbld', 01:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:06 INFO - 'MOZ_NO_REMOTE': '1', 01:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:06 INFO - 'NO_EM_RESTART': '1', 01:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:06 INFO - 'PWD': '/builds/slave/test', 01:04:06 INFO - 'SHELL': '/bin/bash', 01:04:06 INFO - 'SHLVL': '1', 01:04:06 INFO - 'TERM': 'linux', 01:04:06 INFO - 'TMOUT': '86400', 01:04:06 INFO - 'USER': 'cltbld', 01:04:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466395065.764248-272804846', 01:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:06 INFO - '_': '/tools/buildbot/bin/python'} 01:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:04:06 INFO - Cleaning up... 01:04:06 INFO - Return code: 0 01:04:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:04: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')]} 01:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04: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')]} 01:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b93458f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21841c0>, '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 0x21850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2185550>, '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-1466395065.764248-272804846', '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 01:04: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', 'flake8'] in /builds/slave/test/build 01:04: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 flake8 01:04:06 INFO - Using env: {'DISPLAY': ':0', 01:04:06 INFO - 'HOME': '/home/cltbld', 01:04:06 INFO - 'LANG': 'en_US.UTF-8', 01:04:06 INFO - 'LANGUAGE': 'en_US:en', 01:04:06 INFO - 'LOGNAME': 'cltbld', 01:04:06 INFO - 'MAIL': '/var/mail/cltbld', 01:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:06 INFO - 'MOZ_NO_REMOTE': '1', 01:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:06 INFO - 'NO_EM_RESTART': '1', 01:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:06 INFO - 'PWD': '/builds/slave/test', 01:04:06 INFO - 'SHELL': '/bin/bash', 01:04:06 INFO - 'SHLVL': '1', 01:04:06 INFO - 'TERM': 'linux', 01:04:06 INFO - 'TMOUT': '86400', 01:04:06 INFO - 'USER': 'cltbld', 01:04:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466395065.764248-272804846', 01:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:06 INFO - '_': '/tools/buildbot/bin/python'} 01:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:07 INFO - Downloading/unpacking flake8 01:04:07 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 01:04:07 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 01:04:07 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 01:04:07 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 01:04:07 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 01:04:07 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 01:04:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:04:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:04: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 01:04: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 01:04: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 01:04: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 01:04: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 01:04: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 01:04:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:04:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:04:09 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 01:04:09 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 01:04:09 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 01:04:09 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 01:04:09 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 01:04:09 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 01:04:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:04:09 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 01:04:09 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 01:04:09 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 01:04:09 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 01:04:09 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 01:04:09 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 01:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:04:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:04:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:04:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:04:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:04:09 INFO - no previously-included directories found matching 'docs/_build' 01:04:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:04:09 INFO - Running setup.py install for pep8 01:04:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:04:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:04:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:04:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:04:09 INFO - no previously-included directories found matching 'docs/_build' 01:04:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:04:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:04:09 INFO - Cleaning up... 01:04:09 INFO - Return code: 0 01:04:09 INFO - Running post-action listener: _resource_record_post_action 01:04:09 INFO - Running post-action listener: _start_resource_monitoring 01:04:09 INFO - Starting resource monitoring. 01:04:09 INFO - ##### 01:04:09 INFO - ##### Finished create-virtualenv step (success) 01:04:09 INFO - ##### 01:04:09 INFO - ##### 01:04:09 INFO - ##### Running install step. 01:04:09 INFO - ##### 01:04:09 INFO - Running pre-action listener: _resource_record_pre_action 01:04:09 INFO - Running main action method: install 01:04:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:04:10 INFO - Reading from file tmpfile_stdout 01:04:10 INFO - Detecting whether we're running mozinstall >=1.0... 01:04:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:04:10 INFO - Reading from file tmpfile_stdout 01:04:10 INFO - Output received: 01:04:10 INFO - Usage: mozinstall [options] installer 01:04:10 INFO - Options: 01:04:10 INFO - -h, --help show this help message and exit 01:04:10 INFO - -d DEST, --destination=DEST 01:04:10 INFO - Directory to install application into. [default: 01:04:10 INFO - "/builds/slave/test"] 01:04:10 INFO - --app=APP Application being installed. [default: firefox] 01:04:10 INFO - mkdir: /builds/slave/test/build/application 01:04:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:04:27 INFO - Reading from file tmpfile_stdout 01:04:27 INFO - Output received: 01:04:27 INFO - /builds/slave/test/build/application/firefox/firefox 01:04:27 INFO - Running post-action listener: _resource_record_post_action 01:04:27 INFO - ##### 01:04:27 INFO - ##### Finished install step (success) 01:04:27 INFO - ##### 01:04:27 INFO - ##### 01:04:27 INFO - ##### Running run-tests step. 01:04:27 INFO - ##### 01:04:27 INFO - Running pre-action listener: _resource_record_pre_action 01:04:27 INFO - Running main action method: run_tests 01:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:04:27 INFO - Python 2.7.3 01:04:27 INFO - Return code: 0 01:04:27 INFO - grabbing minidump binary from tooltool 01:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:27 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 0x21841c0>, '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 0x21850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2185550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:04:27 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 01:04:27 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 01:04:27 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 01:04:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:04:27 INFO - Return code: 0 01:04:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:04:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:04:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:04:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:04:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:04:28 INFO - Return code: 0 01:04:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.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 01:04:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.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 01:04:28 INFO - Using env: {'DISPLAY': ':0', 01:04:28 INFO - 'HOME': '/home/cltbld', 01:04:28 INFO - 'LANG': 'en_US.UTF-8', 01:04:28 INFO - 'LANGUAGE': 'en_US:en', 01:04:28 INFO - 'LOGNAME': 'cltbld', 01:04:28 INFO - 'MAIL': '/var/mail/cltbld', 01:04:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:04:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:28 INFO - 'MOZ_NO_REMOTE': '1', 01:04:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:04:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:28 INFO - 'NO_EM_RESTART': '1', 01:04:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:28 INFO - 'PWD': '/builds/slave/test', 01:04:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:04:28 INFO - 'SHELL': '/bin/bash', 01:04:28 INFO - 'SHLVL': '1', 01:04:28 INFO - 'TERM': 'linux', 01:04:28 INFO - 'TMOUT': '86400', 01:04:28 INFO - 'USER': 'cltbld', 01:04:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466395065.764248-272804846', 01:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:28 INFO - '_': '/tools/buildbot/bin/python'} 01:04:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.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 01:04:28 INFO - mozversion application_buildid: 20160619223110 01:04:28 INFO - mozversion application_changeset: 3ddf6bae09dc3467b7176eaa7be9a52086d05d8e 01:04:28 INFO - mozversion application_display_name: Nightly 01:04:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:04:28 INFO - mozversion application_name: Firefox 01:04:28 INFO - mozversion application_remotingname: firefox 01:04:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:04:28 INFO - mozversion application_vendor: Mozilla 01:04:28 INFO - mozversion application_version: 50.0a1 01:04:28 INFO - mozversion platform_buildid: 20160619223110 01:04:28 INFO - mozversion platform_changeset: 3ddf6bae09dc3467b7176eaa7be9a52086d05d8e 01:04:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:04:28 INFO - mozversion platform_version: 50.0a1 01:04:28 INFO - using testdate: 1466409868 01:04:28 INFO - actual date: 1466409868 01:04:28 INFO - starting webserver on 'localhost:58833' 01:04:28 INFO - SUITE-START | Running 2 tests 01:04:28 INFO - TEST-START | dromaeo_css 01:04:28 INFO - operating with platform_type : linux_ 01:04:28 INFO - Initialising browser for dromaeo_css test... 01:04:28 INFO - TEST-INFO | started process 16922 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTWRxQM/profile http://localhost:58833/getInfo.html) 01:04:33 INFO - PROCESS | 16922 | __metrics Screen width/height:1600/1200 01:04:33 INFO - PROCESS | 16922 | colorDepth:24 01:04:33 INFO - PROCESS | 16922 | Browser inner width/height: 1024/697 01:04:33 INFO - PROCESS | 16922 | __metrics 01:04:34 ERROR - PROCESS | 16922 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 01:04:35 INFO - TEST-INFO | 16922: exit 0 01:04:35 INFO - Browser initialized. 01:04:35 INFO - Running cycle 1/1 for dromaeo_css test... 01:04:35 INFO - TEST-INFO | started process 17042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTWRxQM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:04:47 INFO - PROCESS | 17042 | RSS: Main: 184807424 01:04:47 INFO - PROCESS | 17042 | 01:05:36 INFO - PROCESS | 17042 | 1466409936915 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] 01:07:45 INFO - PROCESS | 17042 | Cycle 1(1): loaded http://localhost:58833/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58833/tests/dromaeo/cssquery-ext.html) 01:07:46 INFO - PROCESS | 17042 | RSS: Main: 188923904 01:07:46 INFO - PROCESS | 17042 | 01:10:48 INFO - PROCESS | 17042 | Cycle 1(1): loaded http://localhost:58833/tests/dromaeo/cssquery-ext.html (next: http://localhost:58833/tests/dromaeo/cssquery-jquery.html) 01:10:48 INFO - PROCESS | 17042 | RSS: Main: 188043264 01:10:48 INFO - PROCESS | 17042 | 01:13:50 INFO - PROCESS | 17042 | Cycle 1(1): loaded http://localhost:58833/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58833/tests/dromaeo/cssquery-mootools.html) 01:13:51 INFO - PROCESS | 17042 | RSS: Main: 189325312 01:13:51 INFO - PROCESS | 17042 | 01:16:53 INFO - PROCESS | 17042 | Cycle 1(1): loaded http://localhost:58833/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58833/tests/dromaeo/cssquery-prototype.html) 01:16:53 INFO - PROCESS | 17042 | RSS: Main: 186621952 01:16:53 INFO - PROCESS | 17042 | 01:19:56 INFO - PROCESS | 17042 | Cycle 1(1): loaded http://localhost:58833/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58833/tests/dromaeo/cssquery-yui.html) 01:19:56 INFO - PROCESS | 17042 | RSS: Main: 188465152 01:19:56 INFO - PROCESS | 17042 | 01:22:59 INFO - PROCESS | 17042 | Cycle 1(1): loaded http://localhost:58833/tests/dromaeo/cssquery-yui.html (next: http://localhost:58833/tests/dromaeo/cssquery-dojo.html) 01:22:59 INFO - PROCESS | 17042 | RSS: Main: 189603840 01:22:59 INFO - PROCESS | 17042 | 01:22:59 INFO - PROCESS | 17042 | __start_tp_report 01:22:59 INFO - PROCESS | 17042 | _x_x_mozilla_page_load 01:22:59 INFO - PROCESS | 17042 | _x_x_mozilla_page_load_details 01:22:59 INFO - PROCESS | 17042 | |i|pagename|runs| 01:22:59 INFO - PROCESS | 17042 | |0;dojo.html;3071.7389021933136;3133.4203172413117;3144.1667957991135;3147.8111313321187;3176.0154352150835;5432.511074003339;5446.373667028293;5460.126379779236;5500.532454741352;5526.944730552693;5264.052470555299;5357.223202635615;5388.030154572176;5432;5501.14732216506;4837.9758101209445;4896.534829191221;4992;5043.067032598962;5075.619328550373;835.0214234641455;4999.4250661174065;5040.722760248185;5053.519915608012;5072;4992.500749925015;5015.0972824891505;5022.547970682638;5031.647784655075;5069.467705890866;4927.94049279403;5050.444451110375;5053.343065401475;5074.4925507449325;5077.822276220315;4953.281774142765;4998.075356059141;5004.074246264453;5017.347744793154;5043.672161309503;5455.208994695787;5460.808871689512;5462.289902312714;5479.424660410639;5505.146702261116;5622.353429355595;5831.562632802556;5866.6186697864505;5884.205632239636;5885.705714714247;5998.7600495980105;6021.277446706424;6023.8192854214;6026.306974697878;6061.42416470439;5537.446255374471;5538.778448862041;5558.194061861008;5579.191017302468;5583.022970980062;5743.770249189985;5889.882202355929;5913.113033045078;5939.3763654816485;6024.0662697282;5733.369329373765;5734.197212390269;5763.164341170507;5765.711714414347;5768.711564421846;5834.620749651259;5835.824925252249;5838.854028649318;5840.561957853178;5864.325602555676;5532.612717109763;5681.289838770153;5703.62926409782;5741.483266506035;5761.769529218785;5621.915671264935;5771.076627739541;5776.711164441761;5793.449622285876;5805.10020946754;4477.70894891831;4481.843135490242;4491.921938734746;4492.528284530143;4537.500874903758;3902.765834049966;3909.843606255775;3910.452536644872;3948.0524674078015;3953.5651078381356;5481.780728770805;5481.862953426116;5507.752151153208;5520.696361700065;5549.334079910356;5715.799947001835;5778.306603207642;5825.359210486843;5867.941320586825;5882.852928676732;5537.418571050062;5590.97204513983;5604.663720176803;5622.803201887996;5671.120976248688;5087.4149472811105;5112.642115051911;5118.872028199325;5152.098382782998;5186.559142472856;5875.588708790429;5942.257217847769;6117.663528505975;6135.785247516315;6137.232845894263;5812.244408226988;5863.17915491823;5877.853053673522;5882.764689412375;5902.085176797603;6026.608270462406;6030.547708921761;6032.939670603238;6037.758489660365;6054.122152287806;5550.361708403424;5753.8561535961935;5755.65466072037;5775.075987841925;5787.102999035156;5937.940620593911;5947.226860508106;5948.970255148696;5951.702414879325;5989.790357337472;5765.4522820332;5779.68211748341;5784.074548072288;5784.8553786154;5787.710614469344;5543.861403464784;5637.379888212376;5642.633228840276;5713.400092990176;5722.856928576819;5467;5504.53211477029;5537.197106419627;5586.804461843816;5597.5521958242425;5732.856678583069;5755.769769209185;5762.222100016612;5803.30360356743;5809.970950145223;5519.365272993497;5525.778968841201;5557.1108622621805;5599.32808063035;5696.857578560403 01:22:59 INFO - PROCESS | 17042 | |1;ext.html;554.8071645961182;583.9094940284255;620.2959640807682;623.3953065526438;635.0410879571848;39387;40701.389479157835;40944.38583421247;40951.18097638049;44583.777081114546;36661.63338366616;37137.44293835595;37139.25721485575;37199.81400092996;37374.0656483588;8811.86782198269;8934.776630584221;8936.821263574757;8952.194302512773;8986.505742184178;8828.602712877935;8841.16008979146;8848;8869.822603547926;8911.598978045971;8900.554972251393;8925.15211054952;8930;8953.283737301;8954.328425368123;8803.295736341077;8816.691415800447;8848.867266991001;8894.42186257891;8923.063078376807;8831.3376496763;8896.777580560472;8915.063918288615;8917.108289171096;8941.374103812735;41593;41675.58324416778;41931.37102943458;41983;42070.36894446586;3386.305807309496;3504.0714210734177;3506.4740288956605;3888.3972984187494;3942.3889297158985;32516.512252316235;32746.6725332746;33157.66842331594;33178.170545736306;33210.667893321;4349.84775532858;4429.357743127261;4460.085682435093;4516.706414083107;4587.816487340536;345483;347295;347749;348581;348625;49243.753781230866;52951.47048529465;55149.1727624086;55235;55295;43265;45168.09663806706;45310.32034519419;45559.544404556196;45586;15440.768388474182;15546.611334716723;15616.3753449863;15646.530604081896;15657.060576365455;12110.273383597012;12160.756784864254;12187.634370968884;12216.633500994983;12235.755284894252;15468.613284667974;15577.84422155764;15607.141607211484;15666.216689165496;15835.653969412499;6094.238220222473;6254.874902501924;6355.682215889187;6445;6529.902051469232;931.2968708624945;1021.7649940513575;1035.6737627647267;1038.4911393417322;1062.2564205056492;30776.846115769276;30920.381592368478;31154.572996970313;31343.37313253768;31589;1059.8304271316551;1080.956761729522;1108.3682301088463;1125.291066628019;1149.9655010349702;16493.422730204384;16766;16817.57956051084;16853.578660533338;16989.320427182774;406262;412403;412541;416650;417625;54549.45450545523;54739.72630136903;55033;55228.723856380464;55426.16860747092;1273.7579859826603;1313.1661395014044;1333.9399727012308;1338.6987927716186;1339.5847287340955;27920.860395698703;30197.849010754806;30623.54064688987;30638.387232255674;30813.22966925845;47926.76036619934;48021;48211.27683084827;48247;48476.5152348472;352213;353595;354133;355050;358576;39177.80411097926;39209.60790392174;39421.211575768895;40622.79688601538;40974;45431.318530222736;45969.77015114903;45999.77000114978;46521.76739116283;47162.52837471581;37315;39448;39553.20893582055;39785;40037.59962400455;39591.604083958795;40132;40317.59682403138;41861.58138418699;43556.56443435525;39983.80008099941;40359;40682.1863562733;40955.795221023705;44386.778066109466;34195.82902085573;37175.25649487049;37381.62618373781;37740;38022.8098859515;27934.3016424591;28011;28015.859920700266;28248.85875570691;28546 01:22:59 INFO - PROCESS | 17042 | |2;jquery.html;385.2487649084285;385.322792765249;385.54890777789984;390.9081365879018;407.5354096330182;13862.514811981582;18088;18791.718124228148;19463.513412164702;19513.70729439056;17799.46601601954;18022.909885450554;18526.629467410643;18636;18772.812271877276;5473;5614.214010038598;5667.546596272288;5680.602357834953;5704.11586204137;5478.178273259004;5540.63985840919;5567.7494512746825;5642.971785141089;5645.943540564604;5101.566366858821;5386.515213630772;5525.668459892399;5600.439956004388;5609.57928155388;5409.107497262947;5495.725213739317;5497.725113744336;5517.889642207154;5542.75057622408;5364.865878353034;5439.3200849893765;5461.317335333083;5482.150266708627;5516.972415137939;12989.740205195938;13297.66755831112;17536.91231543847;22874.199403020815;22950.967206475747;2198.9560208795733;2595.688517377908;2952.46855565998;2967.5993740845142;3006.8496575171152;9626.903730962671;9732.90267097327;9814.411135331902;9899.90100098997;10041.19670426364;1834.385480863912;1916.6741653918866;1981.8315443187346;1987.9900600497049;2002.9499262518555;76259;80215.59892200501;81493.59253203755;82151;82340;8176.1383515769;9252.491112988715;9803.460809655395;10993.945030274797;11251.83122253167;14306.070105443114;14352.282385880664;14392.640183995483;14442.205678687773;14453.49412770548;7128.394086502602;7210.9278907210255;7327.706891724378;7481.102267727799;7502.17476077631;6776.220734615582;6899.724011039602;6925.134358205224;6997.265287144878;7079.681414336264;4340.153670034313;4443.911121777546;4452.4211852458975;4563.201439748031;4568.862934111982;1886.2737845929416;1962.1170473287077;1992.591518738684;2001.1795163982697;2028.239410221167;877.8024944387589;930.4882314726873;934.9018353072829;984.5913945712449;1021.2595867995792;18620.16209270586;19291.903540482206;19396.70904936427;19666.50833729168;19908.303209387603;909.3225546967551;921.3964853021282;942.5569982108398;974.7368210583103;975.0785507695301;8280.04779450371;10842.512086956105;11134.053605443629;11140.220184587;11192.720181995515;347374;347930;350302;431432;432636;87951.04220310101;91466;92292.53853730689;92714;94435.52782236045;450.8692479181066;472.30335255497863;476.10492274523676;476.2713049034982;478.9544993225638;10137.543810528396;10539.736506587396;10572.84140737905;10841.295315804447;10992.615258466236;39217;39609.61366352164;40615.79692101521;41325.38011929884;42142;51538.74230628823;54590.45409545854;55531;56187;56963.715181423824;7984.56084915312;8397.454165479225;8820.558972051243;8912.777180570538;8941.597628106621;9132.315076369166;13248.337583120612;13772;13874.098183618033;13994;11955.282683039046;12169.087318450975;12265.816012759637;12359.25844449336;12410.379481025731;11625.360605166798;11762.117841161777;11816.350100744541;11885.5840045598;12367;11837.171398002058;11848.644540663794;12298.75402491963;12457.252564846138;12538.247705137721;7910.129885712452;8233.300169485661;8279.875801862856;8414.4109912308;8425.157484251526;11009.760922342299;11340.546378144782;11776.175667703521;11852;12042.698932526757 01:22:59 INFO - PROCESS | 17042 | |3;mootools.html;1188.9583864564743;1213.696575856036;1234.1607706759403;1602.4952140075875;1668.2492878204796;7216.386607138399;8221.383396245283;8282;8671.91328086719;8781.990071141821;8355.958220208906;8652.264557512603;8674.26268767154;8688.26149777268;8692.695755648554;2212.4358288636417;2261.5816074026275;2264.6603009548617;2265.762094980028;2268.8411811173223;2238.4963383238805;2248.2580748353084;2275.12407723027;2303.1363238785457;2303.3550605830396;2236.105557776886;2249.9437514062115;2251.6397376419777;2275.1923067311113;2295.2081531871477;2145.5816115857415;2171.174953517661;2173.9347819565437;2182.181681869291;2188.7701791311842;2198.318521258415;2206.5476577301615;2207.8564893281887;2209.723784526934;2209.7458792238936;9131.406458580172;9156.816863662689;9195.954020229923;9202.079792020812;9226.815463690757;5177.275181474596;5211.296474975868;5281.973590132063;5295.602829787781;5296.735163241822;3207.0859804955476;3232.3535292941506;3325.2850637112897;3367.107716455141;3372.578427696538;1113.4488428228078;1119.2668801934747;1135.3301552084226;1153.089059642881;1160.5009845766317;12467.93766031173;12616.17994830333;12644.30456324911;12646.367681615975;12756.425960831784;4423.292273236267;4451.10977804434;4493.910121797546;4517.796699148546;4587.541245875453;10719.464026798629;10756.408397538211;10792.838107428395;10802.189835762349;10802.459877006118;5096.210087436453;5122.282880396748;5145.099607568661;5149.2791009258735;5150.742462876841;4028.3957406389277;4663.440387153563;4752.643551733634;4866.902661946741;4885.8045678173185;3967.504061992251;3991.980040099781;4038.4749982502085;4056.817443215062;4137.234611596864;1263.4693428759942;1264.3362234826789;1276.5340650662442;1278.3544310123514;1283.8395200599925;869.7869022089628;878.1920633017639;881.3654168998311;908.2325435007408;910.3036177324352;6102.542309326818;6226;6254;6303.3066362700065;6360.363963603695;956.6699488676395;969.7090872738291;985.5072463768116;985.9507024648739;990.5294984882123;4273.700840941105;4332.263515202423;4347.7173983690955;4370.497392799869;4395.978020109879;11032;11345.262557933707;11345.546178152947;11381.487833047533;11404.315741055563;10524.210684198715;11085.057770089472;11089.05743011837;11254.606088786853;11264.66206013821;7930.841383172305;8179.672813087529;8233.259006689426;8235.876461853077;8330.916690833135;5860.794872179454;6144.907826382697;6211.3167551570195;6219.346968568235;6291.748330066746;9553.522323883639;9615.423074615546;9720.951395242979;9758.219342452729;9868.457234851865;9808.803823923625;9842.507874606385;9933.255005874444;9936.503174841084;9940.403575785476;6456.386643268882;7596.962015189889;7740.690372385042;7864.764057078297;7881.763547093597;8666.263367613823;8802.91197088021;8820.647174112964;8829.69096081634;8842.734717958472;7580.0145981022115;7589.6584653689615;7664.616769161631;8016.038075430985;8023.6790528378215;7492.737754178577;7542.245775422414;7588.696452141852;7713.2286771322415;7944.880826787487;7101.857962840818;7143.571385716666;7146.249643787328;7217.530860494261;7219;5149.279100925798;5268.552173065333;5413.53984911287;5426.348838139448;5458.181272809111;5381.67709937405;5401.297831281908;5512.586556008396;5666.461686139975;5675.858103547444 01:22:59 INFO - PROCESS | 17042 | |4;prototype.html;293.58164615423016;299.89053995291727;303.1874576135955;306.7116910104502;307.6631088957591;5636.239107720462;5648.548116150709;5681.375048744635;5701.116326969316;5730.914036289454;5540.279763630722;5544.6395984261;5545.445455454463;5552.889422115572;5564.944350556493;4100.569440208772;4157.916841663165;4270.167317373113;4291.656667466611;4296.742195468266;4252.38340440636;4253.978730106345;4281.871543853674;4293.592108749679;4311.698181127306;4269.978650106745;4286;4288.056627541936;4290.163418133465;4290.656747460212;4025.778582177979;4242.363645453176;4248.596383343577;4289.957100428987;4289.957100428987;3673.577538583044;3680.7975561344115;3684.907877303062;3691.2248427830186;3694.946940122052;5408.486193811582;5459.989901868167;5474.343078830526;5476.58925580579;5505.174223866412;4618.491965883783;4825.841797968497;4844.951550484485;4852.2721591761165;4914.287428322909;5828.601135727437;5847.883042339129;5853.443922827325;5889.941100588982;5894.97052514739;4050.5341885682933;4061.878143655695;4075.673946084336;4077.5922407759285;4082.6733861291027;5916.26046744157;5951.256092988377;6023.518118550549;6093.634381937098;6125.59111404375;4063.878083657495;4073.124278280184;4075.184963007351;4101.507819061731;4121.196366708463;4170.291050521358;4188.937165942513;4204.885705288101;4225.471816022997;4226.5139508956245;4667.382778346809;4837.37114175155;4838;4878.414590249193;4906.337644418029;5858.677772722456;5871.060630299217;5884.293884733859;5915.704214789243;5916.645001299936;1415.8654927781845;1434.4692463788465;1436.367998080841;1444.4366696988184;1445.4218312675014;897.3673560140217;900.5857305639348;911.2026976395654;921.6037104045325;958.5063692198523;5546.916796247979;5577.9163312550345;5599.80400685974;5627.5779316551425;5655.886882262332;5921.437463440966;5956.940430595725;5981.581289309794;6006.939930600725;6039.365866583946;5387;5603.635763675348;5606.635568688103;5614.747336369792;5618.9095997201375;3187.474066779002;3191.2500562367827;3193.850213922986;3207.230264736493;3215.565898603705;5835.941640583625;6111.311023149799;6133.601315914451;6146.139540464339;6173.197484327098;6075.329284446812;6102.267727872595;6128.908066379008;6145.170401995762;6160.44555989963;6017.6389416634265;6093.817185484442;6100.633961962208;6114.205153330127;6201.658908759971;5613.214150018919;5897.174395584708;5924.733386997509;5945.910811337747;5954;5773.711314434177;5935.34711181761;5937.970310148422;5961.225040744675;5974.671393073423;5940.524758019262;6009.338972713085;6017.819465416044;6072.240969878765;6090.969545152246;4024.5170579530645;4117.3618089196225;4122.361034039729;4142.399352093989;4150.813213405464;5918.822435326947;5941.287045554561;5982.4316689914385;5982.49148822355;6046.244219472566;5615.803446879503;5710.3433105193435;5788.855278618068;5845.824625261249;5857.188549496351;5614.663120212637;5759.280089988752;5767.653940763567;5769.365369809401;5786.855328616818;5530.529904958124;5592.2170896075395;5688.345840228427;5751.5398768099285;5759.308882933907;5864.970675146597;5867.882642347215;5885.735141918538;5894.911576326273;5901.114832775118;5605.691686957257;5766.509846663081;5783.652980821164;5794.7102644866745;5795.985702501961 01:22:59 INFO - PROCESS | 17042 | |5;yui.html;791.5132193700872;800.8798680197966;802.4783890471193;813.369638530139;854.9914500854993;13193.538226162087;13253.271070091141;13299.202047877123;13313.201207927532;14367.784483232746;13448.596542103753;14360.712785744305;14401.711965760678;14724.6318842029;14905.25473726312;780.3055280800093;781.136843787615;782.3428320211021;782.7573452229799;783.0134031120772;763.0538132715449;763.713607397226;764.2128607534221;765.674588299973;765.7281665008925;694.8158737934451;812.2162113560413;822.3256929317962;836.7071524966243;839.1189251286156;804.3123129724061;813.6582635293191;816.143049797713;818.5947955761876;819.3076850061689;593.8188852400016;595.4700316718124;595.7468076067654;596.2129988415294;597.0954004682909;13953.86046139546;14035.859641403558;14065.226412547307;14078.648033799134;14085.08446950945;12654.683632909158;12834.16577922432;12940.35298235094;13006.219626822422;13295;10968.835467467994;11037.779244415147;11870.228435151774;12406.379681015913;12582.119251652388;4484;4495.865124046284;4503.459584849807;4521.412216411845;4569.954300456986;74016;75091.62454187749;75291;75555.62222188964;75558.62220688861;10485;10631.84052239217;10930.672079837617;11079.72300692489;11180.776384472265;21575.35273941784;21611.567768644854;21791.23730669419;21796.346109616738;21800;8301.653037062244;8333.791655208668;8350.582470876432;8434.225554948553;8466.111058338909;4524;4636.327732478771;4675.345451636774;4676;4688.46082700487;3065.494193458099;3086.7221950024605;3136.2473006478735;3138.2781960149296;3147.937041259162;553.9307586551681;557.6709741252599;578.7337824600646;591.8934591773522;600.8888355654218;543.3072832139054;601.8164459839703;622.390057743414;674.6518687061839;716.3051839715467;9006.214277876981;9014;9086;9326.440413575207;9601.135897769234;644.8226737647091;672.4620303756975;673.3031312591543;676.9695363708645;680.1871763242976;4383.276759334738;4496.19068567661;4512.553438789192;4591;4692.648051396159;93339;113253;115944.42027789807;120099;120202;103715.4814225924;104524.99999999847;106032;106218.46890765651;106615;59606.10590841141;88919;90444;90542;91074;8765.211130997986;8767.956160219159;8825;8864.73405797827;8966.282697384064;52215.73892130515;53004;54216;54378.45621543734;54683;64415.67792161009;73807.26192738004;74294.25705742874;74669;74686.62656686682;10565.788684226427;11013.614523491638;11032.393218373067;11032.724181895517;11100.389478578432;12118.333491658044;12337.814932775836;12358;12608.432620532281;13022.218666880017;11481.712957176138;11732;11734.471948762155;12088.697782555506;12236.08229382782;10811.729706757395;11116.444177790916;11133.944330278297;11405.543778248777;11544.769104618028;10427.530761115617;10871.836922446011;10975.176861735243;11118.777624447304;11310.377929213642;9357.017513161292;9447.196988256075;9519.238460923249;9592.952035240058;9796.412215267106;9767.9023209767;10254.230932680228;10276.486175691036;10341.74145646365;10359.63741269052 01:22:59 INFO - PROCESS | 17042 | __end_tp_report 01:22:59 INFO - PROCESS | 17042 | __start_cc_report 01:22:59 INFO - PROCESS | 17042 | _x_x_mozilla_cycle_collect,363 01:22:59 INFO - PROCESS | 17042 | __end_cc_report 01:22:59 INFO - PROCESS | 17042 | __startTimestamp1466410979877__endTimestamp 01:22:59 INFO - PROCESS | 17042 | 01:22:59 INFO - PROCESS | 17042 | ------- Summary: start ------- 01:22:59 INFO - PROCESS | 17042 | Number of tests: 6 01:22:59 INFO - PROCESS | 17042 | 01:22:59 INFO - PROCESS | 17042 | [#0] dojo.html Cycles:165 Average:5408.28 Median:5599.33 stddev:712.01 (12.7%) stddev-sans-first:690.20 01:22:59 INFO - PROCESS | 17042 | Values: 3071.7 3133.4 3144.2 3147.8 3176.0 5432.5 5446.4 5460.1 5500.5 5526.9 5264.1 5357.2 5388.0 5432.0 5501.1 4838.0 4896.5 4992.0 5043.1 5075.6 835.0 4999.4 5040.7 5053.5 5072.0 4992.5 5015.1 5022.5 5031.6 5069.5 4927.9 5050.4 5053.3 5074.5 5077.8 4953.3 4998.1 5004.1 5017.3 5043.7 5455.2 5460.8 5462.3 5479.4 5505.1 5622.4 5831.6 5866.6 5884.2 5885.7 5998.8 6021.3 6023.8 6026.3 6061.4 5537.4 5538.8 5558.2 5579.2 5583.0 5743.8 5889.9 5913.1 5939.4 6024.1 5733.4 5734.2 5763.2 5765.7 5768.7 5834.6 5835.8 5838.9 5840.6 5864.3 5532.6 5681.3 5703.6 5741.5 5761.8 5621.9 5771.1 5776.7 5793.4 5805.1 4477.7 4481.8 4491.9 4492.5 4537.5 3902.8 3909.8 3910.5 3948.1 3953.6 5481.8 5481.9 5507.8 5520.7 5549.3 5715.8 5778.3 5825.4 5867.9 5882.9 5537.4 5591.0 5604.7 5622.8 5671.1 5087.4 5112.6 5118.9 5152.1 5186.6 5875.6 5942.3 6117.7 6135.8 6137.2 5812.2 5863.2 5877.9 5882.8 5902.1 6026.6 6030.5 6032.9 6037.8 6054.1 5550.4 5753.9 5755.7 5775.1 5787.1 5937.9 5947.2 5949.0 5951.7 5989.8 5765.5 5779.7 5784.1 5784.9 5787.7 5543.9 5637.4 5642.6 5713.4 5722.9 5467.0 5504.5 5537.2 5586.8 5597.6 5732.9 5755.8 5762.2 5803.3 5810.0 5519.4 5525.8 5557.1 5599.3 5696.9 01:22:59 INFO - PROCESS | 17042 | 01:22:59 INFO - PROCESS | 17042 | [#1] ext.html Cycles:180 Average:53538.89 Median:40224.80 stddev:98074.30 (243.8%) stddev-sans-first:98268.74 01:22:59 INFO - PROCESS | 17042 | Values: 554.8 583.9 620.3 623.4 635.0 39387.0 40701.4 40944.4 40951.2 44583.8 36661.6 37137.4 37139.3 37199.8 37374.1 8811.9 8934.8 8936.8 8952.2 8986.5 8828.6 8841.2 8848.0 8869.8 8911.6 8900.6 8925.2 8930.0 8953.3 8954.3 8803.3 8816.7 8848.9 8894.4 8923.1 8831.3 8896.8 8915.1 8917.1 8941.4 41593.0 41675.6 41931.4 41983.0 42070.4 3386.3 3504.1 3506.5 3888.4 3942.4 32516.5 32746.7 33157.7 33178.2 33210.7 4349.8 4429.4 4460.1 4516.7 4587.8 345483.0 347295.0 347749.0 348581.0 348625.0 49243.8 52951.5 55149.2 55235.0 55295.0 43265.0 45168.1 45310.3 45559.5 45586.0 15440.8 15546.6 15616.4 15646.5 15657.1 12110.3 12160.8 12187.6 12216.6 12235.8 15468.6 15577.8 15607.1 15666.2 15835.7 6094.2 6254.9 6355.7 6445.0 6529.9 931.3 1021.8 1035.7 1038.5 1062.3 30776.8 30920.4 31154.6 31343.4 31589.0 1059.8 1081.0 1108.4 1125.3 1150.0 16493.4 16766.0 16817.6 16853.6 16989.3 406262.0 412403.0 412541.0 416650.0 417625.0 54549.5 54739.7 55033.0 55228.7 55426.2 1273.8 1313.2 1333.9 1338.7 1339.6 27920.9 30197.8 30623.5 30638.4 30813.2 47926.8 48021.0 48211.3 48247.0 48476.5 352213.0 353595.0 354133.0 355050.0 358576.0 39177.8 39209.6 39421.2 40622.8 40974.0 45431.3 45969.8 45999.8 46521.8 47162.5 37315.0 39448.0 39553.2 39785.0 40037.6 39591.6 40132.0 40317.6 41861.6 43556.6 39983.8 40359.0 40682.2 40955.8 44386.8 34195.8 37175.3 37381.6 37740.0 38022.8 27934.3 28011.0 28015.9 28248.9 28546.0 01:22:59 INFO - PROCESS | 17042 | 01:22:59 INFO - PROCESS | 17042 | [#2] jquery.html Cycles:180 Average:25331.42 Median:432034.00 stddev:64125.95 (14.8%) stddev-sans-first:64278.48 01:22:59 INFO - PROCESS | 17042 | Values: 385.2 385.3 385.5 390.9 407.5 13862.5 18088.0 18791.7 19463.5 19513.7 17799.5 18022.9 18526.6 18636.0 18772.8 5473.0 5614.2 5667.5 5680.6 5704.1 5478.2 5540.6 5567.7 5643.0 5645.9 5101.6 5386.5 5525.7 5600.4 5609.6 5409.1 5495.7 5497.7 5517.9 5542.8 5364.9 5439.3 5461.3 5482.2 5517.0 12989.7 13297.7 17536.9 22874.2 22951.0 2199.0 2595.7 2952.5 2967.6 3006.8 9626.9 9732.9 9814.4 9899.9 10041.2 1834.4 1916.7 1981.8 1988.0 2002.9 76259.0 80215.6 81493.6 82151.0 82340.0 8176.1 9252.5 9803.5 10993.9 11251.8 14306.1 14352.3 14392.6 14442.2 14453.5 7128.4 7210.9 7327.7 7481.1 7502.2 6776.2 6899.7 6925.1 6997.3 7079.7 4340.2 4443.9 4452.4 4563.2 4568.9 1886.3 1962.1 1992.6 2001.2 2028.2 877.8 930.5 934.9 984.6 1021.3 18620.2 19291.9 19396.7 19666.5 19908.3 909.3 921.4 942.6 974.7 975.1 8280.0 10842.5 11134.1 11140.2 11192.7 347374.0 347930.0 350302.0 431432.0 432636.0 87951.0 91466.0 92292.5 92714.0 94435.5 450.9 472.3 476.1 476.3 479.0 10137.5 10539.7 10572.8 10841.3 10992.6 39217.0 39609.6 40615.8 41325.4 42142.0 51538.7 54590.5 55531.0 56187.0 56963.7 7984.6 8397.5 8820.6 8912.8 8941.6 9132.3 13248.3 13772.0 13874.1 13994.0 11955.3 12169.1 12265.8 12359.3 12410.4 11625.4 11762.1 11816.4 11885.6 12367.0 11837.2 11848.6 12298.8 12457.3 12538.2 7910.1 8233.3 8279.9 8414.4 8425.2 11009.8 11340.5 11776.2 11852.0 12042.7 01:22:59 INFO - PROCESS | 17042 | 01:22:59 INFO - PROCESS | 17042 | [#3] mootools.html Cycles:180 Average:5826.30 Median:5164.01 stddev:3354.07 (65.0%) stddev-sans-first:3345.37 01:22:59 INFO - PROCESS | 17042 | Values: 1189.0 1213.7 1234.2 1602.5 1668.2 7216.4 8221.4 8282.0 8671.9 8782.0 8356.0 8652.3 8674.3 8688.3 8692.7 2212.4 2261.6 2264.7 2265.8 2268.8 2238.5 2248.3 2275.1 2303.1 2303.4 2236.1 2249.9 2251.6 2275.2 2295.2 2145.6 2171.2 2173.9 2182.2 2188.8 2198.3 2206.5 2207.9 2209.7 2209.7 9131.4 9156.8 9196.0 9202.1 9226.8 5177.3 5211.3 5282.0 5295.6 5296.7 3207.1 3232.4 3325.3 3367.1 3372.6 1113.4 1119.3 1135.3 1153.1 1160.5 12467.9 12616.2 12644.3 12646.4 12756.4 4423.3 4451.1 4493.9 4517.8 4587.5 10719.5 10756.4 10792.8 10802.2 10802.5 5096.2 5122.3 5145.1 5149.3 5150.7 4028.4 4663.4 4752.6 4866.9 4885.8 3967.5 3992.0 4038.5 4056.8 4137.2 1263.5 1264.3 1276.5 1278.4 1283.8 869.8 878.2 881.4 908.2 910.3 6102.5 6226.0 6254.0 6303.3 6360.4 956.7 969.7 985.5 986.0 990.5 4273.7 4332.3 4347.7 4370.5 4396.0 11032.0 11345.3 11345.5 11381.5 11404.3 10524.2 11085.1 11089.1 11254.6 11264.7 7930.8 8179.7 8233.3 8235.9 8330.9 5860.8 6144.9 6211.3 6219.3 6291.7 9553.5 9615.4 9721.0 9758.2 9868.5 9808.8 9842.5 9933.3 9936.5 9940.4 6456.4 7597.0 7740.7 7864.8 7881.8 8666.3 8802.9 8820.6 8829.7 8842.7 7580.0 7589.7 7664.6 8016.0 8023.7 7492.7 7542.2 7588.7 7713.2 7944.9 7101.9 7143.6 7146.2 7217.5 7219.0 5149.3 5268.6 5413.5 5426.3 5458.2 5381.7 5401.3 5512.6 5666.5 5675.9 01:22:59 INFO - PROCESS | 17042 | 01:22:59 INFO - PROCESS | 17042 | [#4] prototype.html Cycles:180 Average:4865.65 Median:5614.71 stddev:1463.60 (26.1%) stddev-sans-first:1426.90 01:22:59 INFO - PROCESS | 17042 | Values: 293.6 299.9 303.2 306.7 307.7 5636.2 5648.5 5681.4 5701.1 5730.9 5540.3 5544.6 5545.4 5552.9 5564.9 4100.6 4157.9 4270.2 4291.7 4296.7 4252.4 4254.0 4281.9 4293.6 4311.7 4270.0 4286.0 4288.1 4290.2 4290.7 4025.8 4242.4 4248.6 4290.0 4290.0 3673.6 3680.8 3684.9 3691.2 3694.9 5408.5 5460.0 5474.3 5476.6 5505.2 4618.5 4825.8 4845.0 4852.3 4914.3 5828.6 5847.9 5853.4 5889.9 5895.0 4050.5 4061.9 4075.7 4077.6 4082.7 5916.3 5951.3 6023.5 6093.6 6125.6 4063.9 4073.1 4075.2 4101.5 4121.2 4170.3 4188.9 4204.9 4225.5 4226.5 4667.4 4837.4 4838.0 4878.4 4906.3 5858.7 5871.1 5884.3 5915.7 5916.6 1415.9 1434.5 1436.4 1444.4 1445.4 897.4 900.6 911.2 921.6 958.5 5546.9 5577.9 5599.8 5627.6 5655.9 5921.4 5956.9 5981.6 6006.9 6039.4 5387.0 5603.6 5606.6 5614.7 5618.9 3187.5 3191.3 3193.9 3207.2 3215.6 5835.9 6111.3 6133.6 6146.1 6173.2 6075.3 6102.3 6128.9 6145.2 6160.4 6017.6 6093.8 6100.6 6114.2 6201.7 5613.2 5897.2 5924.7 5945.9 5954.0 5773.7 5935.3 5938.0 5961.2 5974.7 5940.5 6009.3 6017.8 6072.2 6091.0 4024.5 4117.4 4122.4 4142.4 4150.8 5918.8 5941.3 5982.4 5982.5 6046.2 5615.8 5710.3 5788.9 5845.8 5857.2 5614.7 5759.3 5767.7 5769.4 5786.9 5530.5 5592.2 5688.3 5751.5 5759.3 5865.0 5867.9 5885.7 5894.9 5901.1 5605.7 5766.5 5783.7 5794.7 5796.0 01:22:59 INFO - PROCESS | 17042 | 01:22:59 INFO - PROCESS | 17042 | [#5] yui.html Cycles:180 Average:20259.12 Median:4682.23 stddev:30252.70 (646.1%) stddev-sans-first:30302.25 01:22:59 INFO - PROCESS | 17042 | Values: 791.5 800.9 802.5 813.4 855.0 13193.5 13253.3 13299.2 13313.2 14367.8 13448.6 14360.7 14401.7 14724.6 14905.3 780.3 781.1 782.3 782.8 783.0 763.1 763.7 764.2 765.7 765.7 694.8 812.2 822.3 836.7 839.1 804.3 813.7 816.1 818.6 819.3 593.8 595.5 595.7 596.2 597.1 13953.9 14035.9 14065.2 14078.6 14085.1 12654.7 12834.2 12940.4 13006.2 13295.0 10968.8 11037.8 11870.2 12406.4 12582.1 4484.0 4495.9 4503.5 4521.4 4570.0 74016.0 75091.6 75291.0 75555.6 75558.6 10485.0 10631.8 10930.7 11079.7 11180.8 21575.4 21611.6 21791.2 21796.3 21800.0 8301.7 8333.8 8350.6 8434.2 8466.1 4524.0 4636.3 4675.3 4676.0 4688.5 3065.5 3086.7 3136.2 3138.3 3147.9 553.9 557.7 578.7 591.9 600.9 543.3 601.8 622.4 674.7 716.3 9006.2 9014.0 9086.0 9326.4 9601.1 644.8 672.5 673.3 677.0 680.2 4383.3 4496.2 4512.6 4591.0 4692.6 93339.0 113253.0 115944.4 120099.0 120202.0 103715.5 104525.0 106032.0 106218.5 106615.0 59606.1 88919.0 90444.0 90542.0 91074.0 8765.2 8768.0 8825.0 8864.7 8966.3 52215.7 53004.0 54216.0 54378.5 54683.0 64415.7 73807.3 74294.3 74669.0 74686.6 10565.8 11013.6 11032.4 11032.7 11100.4 12118.3 12337.8 12358.0 12608.4 13022.2 11481.7 11732.0 11734.5 12088.7 12236.1 10811.7 11116.4 11133.9 11405.5 11544.8 10427.5 10871.8 10975.2 11118.8 11310.4 9357.0 9447.2 9519.2 9593.0 9796.4 9767.9 10254.2 10276.5 10341.7 10359.6 01:22:59 INFO - PROCESS | 17042 | -------- Summary: end -------- 01:22:59 INFO - PROCESS | 17042 | 01:23:00 INFO - TEST-INFO | 17042: exit 0 01:23:00 INFO - TEST-OK | dromaeo_css | took 1112180ms 01:23:00 INFO - TEST-START | kraken 01:23:00 INFO - operating with platform_type : linux_ 01:23:00 INFO - Initialising browser for kraken test... 01:23:00 INFO - TEST-INFO | started process 17277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQS3L7T/profile http://localhost:58833/getInfo.html) 01:23:05 INFO - PROCESS | 17277 | __metrics Screen width/height:1600/1200 01:23:05 INFO - PROCESS | 17277 | colorDepth:24 01:23:05 INFO - PROCESS | 17277 | Browser inner width/height: 1024/697 01:23:05 INFO - PROCESS | 17277 | __metrics 01:23:06 ERROR - PROCESS | 17277 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 01:23:07 INFO - TEST-INFO | 17277: exit 0 01:23:07 INFO - Browser initialized. 01:23:07 INFO - Running cycle 1/1 for kraken test... 01:23:07 INFO - TEST-INFO | started process 17399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQS3L7T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:23:19 INFO - PROCESS | 17399 | RSS: Main: 185180160 01:23:19 INFO - PROCESS | 17399 | 01:23:21 INFO - PROCESS | 17399 | Cycle 1(1): loaded http://localhost:58833/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58833/tests/kraken/driver.html?testName=audio-beat-detection) 01:23:22 INFO - PROCESS | 17399 | RSS: Main: 191340544 01:23:22 INFO - PROCESS | 17399 | 01:23:25 INFO - PROCESS | 17399 | Cycle 1(1): loaded http://localhost:58833/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58833/tests/kraken/driver.html?testName=audio-dft) 01:23:26 INFO - PROCESS | 17399 | RSS: Main: 190271488 01:23:26 INFO - PROCESS | 17399 | 01:23:28 INFO - PROCESS | 17399 | Cycle 1(1): loaded http://localhost:58833/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58833/tests/kraken/driver.html?testName=audio-fft) 01:23:29 INFO - PROCESS | 17399 | RSS: Main: 185479168 01:23:29 INFO - PROCESS | 17399 | 01:23:31 INFO - PROCESS | 17399 | Cycle 1(1): loaded http://localhost:58833/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58833/tests/kraken/driver.html?testName=audio-oscillator) 01:23:32 INFO - PROCESS | 17399 | RSS: Main: 186118144 01:23:32 INFO - PROCESS | 17399 | 01:23:34 INFO - PROCESS | 17399 | Cycle 1(1): loaded http://localhost:58833/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58833/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:23:35 INFO - PROCESS | 17399 | RSS: Main: 186871808 01:23:35 INFO - PROCESS | 17399 | 01:23:38 INFO - PROCESS | 17399 | Cycle 1(1): loaded http://localhost:58833/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58833/tests/kraken/driver.html?testName=imaging-darkroom) 01:23:39 INFO - PROCESS | 17399 | RSS: Main: 187006976 01:23:39 INFO - PROCESS | 17399 | 01:23:42 INFO - PROCESS | 17399 | Cycle 1(1): loaded http://localhost:58833/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58833/tests/kraken/driver.html?testName=imaging-desaturate) 01:23:43 INFO - PROCESS | 17399 | RSS: Main: 184598528 01:23:43 INFO - PROCESS | 17399 | 01:23:46 INFO - PROCESS | 17399 | Cycle 1(1): loaded http://localhost:58833/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58833/tests/kraken/driver.html?testName=json-parse-financial) 01:23:46 INFO - PROCESS | 17399 | RSS: Main: 185847808 01:23:46 INFO - PROCESS | 17399 | 01:23:48 INFO - PROCESS | 17399 | Cycle 1(1): loaded http://localhost:58833/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58833/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:23:49 INFO - PROCESS | 17399 | RSS: Main: 185909248 01:23:49 INFO - PROCESS | 17399 | 01:23:50 INFO - PROCESS | 17399 | Cycle 1(1): loaded http://localhost:58833/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58833/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:23:51 INFO - PROCESS | 17399 | RSS: Main: 186310656 01:23:51 INFO - PROCESS | 17399 | 01:23:53 INFO - PROCESS | 17399 | Cycle 1(1): loaded http://localhost:58833/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58833/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:23:54 INFO - PROCESS | 17399 | RSS: Main: 186675200 01:23:54 INFO - PROCESS | 17399 | 01:23:56 INFO - PROCESS | 17399 | Cycle 1(1): loaded http://localhost:58833/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:23:57 INFO - PROCESS | 17399 | RSS: Main: 186982400 01:23:57 INFO - PROCESS | 17399 | 01:24:00 INFO - PROCESS | 17399 | Cycle 1(1): loaded http://localhost:58833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:24:00 INFO - PROCESS | 17399 | RSS: Main: 187088896 01:24:00 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | Cycle 1(1): loaded http://localhost:58833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58833/tests/kraken/driver.html?testName=ai-astar) 01:24:02 INFO - PROCESS | 17399 | RSS: Main: 187711488 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | __start_tp_report 01:24:02 INFO - PROCESS | 17399 | _x_x_mozilla_page_load 01:24:02 INFO - PROCESS | 17399 | _x_x_mozilla_page_load_details 01:24:02 INFO - PROCESS | 17399 | |i|pagename|runs| 01:24:02 INFO - PROCESS | 17399 | |0;ai-astar;114;105;110;110;111;112;111;112;110;111 01:24:02 INFO - PROCESS | 17399 | |1;audio-beat-detection;163;125;153;182;130;151;158;137;180;132 01:24:02 INFO - PROCESS | 17399 | |2;audio-dft;163;162;163;162;164;175;163;163;165;164 01:24:02 INFO - PROCESS | 17399 | |3;audio-fft;74;77;76;170;75;75;77;74;184;76 01:24:02 INFO - PROCESS | 17399 | |4;audio-oscillator;85;86;142;87;88;87;136;85;85;141 01:24:02 INFO - PROCESS | 17399 | |5;imaging-gaussian-blur;117;117;118;118;118;118;119;118;117;118 01:24:02 INFO - PROCESS | 17399 | |6;imaging-darkroom;146;148;147;146;148;147;147;148;148;148 01:24:02 INFO - PROCESS | 17399 | |7;imaging-desaturate;96;95;96;100;95;96;95;95;96;95 01:24:02 INFO - PROCESS | 17399 | |8;json-parse-financial;54;59;55;54;54;54;53;55;56;55 01:24:02 INFO - PROCESS | 17399 | |9;json-stringify-tinderbox;65;61;63;62;62;61;61;61;61;61 01:24:02 INFO - PROCESS | 17399 | |10;stanford-crypto-aes;81;79;80;82;82;81;81;81;114;83 01:24:02 INFO - PROCESS | 17399 | |11;stanford-crypto-ccm;148;122;138;122;129;125;144;124;148;134 01:24:02 INFO - PROCESS | 17399 | |12;stanford-crypto-pbkdf2;168;171;174;166;167;164;169;167;171;169 01:24:02 INFO - PROCESS | 17399 | |13;stanford-crypto-sha256-iterative;63;66;65;67;65;63;64;74;64;63 01:24:02 INFO - PROCESS | 17399 | __end_tp_report 01:24:02 INFO - PROCESS | 17399 | __start_cc_report 01:24:02 INFO - PROCESS | 17399 | _x_x_mozilla_cycle_collect,894 01:24:02 INFO - PROCESS | 17399 | __end_cc_report 01:24:02 INFO - PROCESS | 17399 | __startTimestamp1466411042898__endTimestamp 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | ------- Summary: start ------- 01:24:02 INFO - PROCESS | 17399 | Number of tests: 14 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:2.32 (2.1%) stddev-sans-first:2.11 01:24:02 INFO - PROCESS | 17399 | Values: 114.0 105.0 110.0 110.0 111.0 112.0 111.0 112.0 110.0 111.0 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:155.50 stddev:20.20 (13.0%) stddev-sans-first:20.96 01:24:02 INFO - PROCESS | 17399 | Values: 163.0 125.0 153.0 182.0 130.0 151.0 158.0 137.0 180.0 132.0 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:3.84 (2.3%) stddev-sans-first:4.03 01:24:02 INFO - PROCESS | 17399 | Values: 163.0 162.0 163.0 162.0 164.0 175.0 163.0 163.0 165.0 164.0 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | [#3] audio-fft Cycles:10 Average:95.80 Median:75.50 stddev:42.94 (56.9%) stddev-sans-first:44.81 01:24:02 INFO - PROCESS | 17399 | Values: 74.0 77.0 76.0 170.0 75.0 75.0 77.0 74.0 184.0 76.0 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:85.50 stddev:25.92 (30.3%) stddev-sans-first:26.73 01:24:02 INFO - PROCESS | 17399 | Values: 85.0 86.0 142.0 87.0 88.0 87.0 136.0 85.0 85.0 141.0 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 01:24:02 INFO - PROCESS | 17399 | Values: 117.0 117.0 118.0 118.0 118.0 118.0 119.0 118.0 117.0 118.0 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 01:24:02 INFO - PROCESS | 17399 | Values: 146.0 148.0 147.0 146.0 148.0 147.0 147.0 148.0 148.0 148.0 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.50 stddev:1.52 (1.6%) stddev-sans-first:1.62 01:24:02 INFO - PROCESS | 17399 | Values: 96.0 95.0 96.0 100.0 95.0 96.0 95.0 95.0 96.0 95.0 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.66 (3.0%) stddev-sans-first:1.73 01:24:02 INFO - PROCESS | 17399 | Values: 54.0 59.0 55.0 54.0 54.0 54.0 53.0 55.0 56.0 55.0 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:61.50 stddev:1.32 (2.1%) stddev-sans-first:0.73 01:24:02 INFO - PROCESS | 17399 | Values: 65.0 61.0 63.0 62.0 62.0 61.0 61.0 61.0 61.0 61.0 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:81.00 stddev:10.46 (12.9%) stddev-sans-first:11.02 01:24:02 INFO - PROCESS | 17399 | Values: 81.0 79.0 80.0 82.0 82.0 81.0 81.0 81.0 114.0 83.0 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:136.00 stddev:10.53 (7.7%) stddev-sans-first:9.76 01:24:02 INFO - PROCESS | 17399 | Values: 148.0 122.0 138.0 122.0 129.0 125.0 144.0 124.0 148.0 134.0 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:169.00 stddev:2.88 (1.7%) stddev-sans-first:3.04 01:24:02 INFO - PROCESS | 17399 | Values: 168.0 171.0 174.0 166.0 167.0 164.0 169.0 167.0 171.0 169.0 01:24:02 INFO - PROCESS | 17399 | 01:24:02 INFO - PROCESS | 17399 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.00 stddev:3.31 (5.1%) stddev-sans-first:3.39 01:24:02 INFO - PROCESS | 17399 | Values: 63.0 66.0 65.0 67.0 65.0 63.0 64.0 74.0 64.0 63.0 01:24:02 INFO - PROCESS | 17399 | -------- Summary: end -------- 01:24:02 INFO - PROCESS | 17399 | 01:24:03 INFO - TEST-INFO | 17399: exit 0 01:24:03 INFO - TEST-OK | kraken | took 63216ms 01:24:03 INFO - SUITE-END | took 1175s 01:24:04 INFO - Completed test suite (00:19:35) 01:24:04 INFO - javascript benchmark 01:24:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7106.8202696445105, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.7389021933136, 3133.4203172413117, 3144.1667957991135, 3147.8111313321187, 3176.0154352150835, 5432.511074003339, 5446.373667028293, 5460.126379779236, 5500.532454741352, 5526.944730552693, 5264.052470555299, 5357.223202635615, 5388.030154572176, 5432.0, 5501.14732216506, 4837.9758101209445, 4896.534829191221, 4992.0, 5043.067032598962, 5075.619328550373, 835.0214234641455, 4999.4250661174065, 5040.722760248185, 5053.519915608012, 5072.0, 4992.500749925015, 5015.0972824891505, 5022.547970682638, 5031.647784655075, 5069.467705890866, 4927.94049279403, 5050.444451110375, 5053.343065401475, 5074.4925507449325, 5077.822276220315, 4953.281774142765, 4998.075356059141, 5004.074246264453, 5017.347744793154, 5043.672161309503, 5455.208994695787, 5460.808871689512, 5462.289902312714, 5479.424660410639, 5505.146702261116, 5622.353429355595, 5831.562632802556, 5866.6186697864505, 5884.205632239636, 5885.705714714247, 5998.7600495980105, 6021.277446706424, 6023.8192854214, 6026.306974697878, 6061.42416470439, 5537.446255374471, 5538.778448862041, 5558.194061861008, 5579.191017302468, 5583.022970980062, 5743.770249189985, 5889.882202355929, 5913.113033045078, 5939.3763654816485, 6024.0662697282, 5733.369329373765, 5734.197212390269, 5763.164341170507, 5765.711714414347, 5768.711564421846, 5834.620749651259, 5835.824925252249, 5838.854028649318, 5840.561957853178, 5864.325602555676, 5532.612717109763, 5681.289838770153, 5703.62926409782, 5741.483266506035, 5761.769529218785, 5621.915671264935, 5771.076627739541, 5776.711164441761, 5793.449622285876, 5805.10020946754, 4477.70894891831, 4481.843135490242, 4491.921938734746, 4492.528284530143, 4537.500874903758, 3902.765834049966, 3909.843606255775, 3910.452536644872, 3948.0524674078015, 3953.5651078381356, 5481.780728770805, 5481.862953426116, 5507.752151153208, 5520.696361700065, 5549.334079910356, 5715.799947001835, 5778.306603207642, 5825.359210486843, 5867.941320586825, 5882.852928676732, 5537.418571050062, 5590.97204513983, 5604.663720176803, 5622.803201887996, 5671.120976248688, 5087.4149472811105, 5112.642115051911, 5118.872028199325, 5152.098382782998, 5186.559142472856, 5875.588708790429, 5942.257217847769, 6117.663528505975, 6135.785247516315, 6137.232845894263, 5812.244408226988, 5863.17915491823, 5877.853053673522, 5882.764689412375, 5902.085176797603, 6026.608270462406, 6030.547708921761, 6032.939670603238, 6037.758489660365, 6054.122152287806, 5550.361708403424, 5753.8561535961935, 5755.65466072037, 5775.075987841925, 5787.102999035156, 5937.940620593911, 5947.226860508106, 5948.970255148696, 5951.702414879325, 5989.790357337472, 5765.4522820332, 5779.68211748341, 5784.074548072288, 5784.8553786154, 5787.710614469344, 5543.861403464784, 5637.379888212376, 5642.633228840276, 5713.400092990176, 5722.856928576819, 5467.0, 5504.53211477029, 5537.197106419627, 5586.804461843816, 5597.5521958242425, 5732.856678583069, 5755.769769209185, 5762.222100016612, 5803.30360356743, 5809.970950145223, 5519.365272993497, 5525.778968841201, 5557.1108622621805, 5599.32808063035, 5696.857578560403], "value": 5362.049108041318, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.8071645961182, 583.9094940284255, 620.2959640807682, 623.3953065526438, 635.0410879571848, 39387.0, 40701.389479157835, 40944.38583421247, 40951.18097638049, 44583.777081114546, 36661.63338366616, 37137.44293835595, 37139.25721485575, 37199.81400092996, 37374.0656483588, 8811.86782198269, 8934.776630584221, 8936.821263574757, 8952.194302512773, 8986.505742184178, 8828.602712877935, 8841.16008979146, 8848.0, 8869.822603547926, 8911.598978045971, 8900.554972251393, 8925.15211054952, 8930.0, 8953.283737301, 8954.328425368123, 8803.295736341077, 8816.691415800447, 8848.867266991001, 8894.42186257891, 8923.063078376807, 8831.3376496763, 8896.777580560472, 8915.063918288615, 8917.108289171096, 8941.374103812735, 41593.0, 41675.58324416778, 41931.37102943458, 41983.0, 42070.36894446586, 3386.305807309496, 3504.0714210734177, 3506.4740288956605, 3888.3972984187494, 3942.3889297158985, 32516.512252316235, 32746.6725332746, 33157.66842331594, 33178.170545736306, 33210.667893321, 4349.84775532858, 4429.357743127261, 4460.085682435093, 4516.706414083107, 4587.816487340536, 345483.0, 347295.0, 347749.0, 348581.0, 348625.0, 49243.753781230866, 52951.47048529465, 55149.1727624086, 55235.0, 55295.0, 43265.0, 45168.09663806706, 45310.32034519419, 45559.544404556196, 45586.0, 15440.768388474182, 15546.611334716723, 15616.3753449863, 15646.530604081896, 15657.060576365455, 12110.273383597012, 12160.756784864254, 12187.634370968884, 12216.633500994983, 12235.755284894252, 15468.613284667974, 15577.84422155764, 15607.141607211484, 15666.216689165496, 15835.653969412499, 6094.238220222473, 6254.874902501924, 6355.682215889187, 6445.0, 6529.902051469232, 931.2968708624945, 1021.7649940513575, 1035.6737627647267, 1038.4911393417322, 1062.2564205056492, 30776.846115769276, 30920.381592368478, 31154.572996970313, 31343.37313253768, 31589.0, 1059.8304271316551, 1080.956761729522, 1108.3682301088463, 1125.291066628019, 1149.9655010349702, 16493.422730204384, 16766.0, 16817.57956051084, 16853.578660533338, 16989.320427182774, 406262.0, 412403.0, 412541.0, 416650.0, 417625.0, 54549.45450545523, 54739.72630136903, 55033.0, 55228.723856380464, 55426.16860747092, 1273.7579859826603, 1313.1661395014044, 1333.9399727012308, 1338.6987927716186, 1339.5847287340955, 27920.860395698703, 30197.849010754806, 30623.54064688987, 30638.387232255674, 30813.22966925845, 47926.76036619934, 48021.0, 48211.27683084827, 48247.0, 48476.5152348472, 352213.0, 353595.0, 354133.0, 355050.0, 358576.0, 39177.80411097926, 39209.60790392174, 39421.211575768895, 40622.79688601538, 40974.0, 45431.318530222736, 45969.77015114903, 45999.77000114978, 46521.76739116283, 47162.52837471581, 37315.0, 39448.0, 39553.20893582055, 39785.0, 40037.59962400455, 39591.604083958795, 40132.0, 40317.59682403138, 41861.58138418699, 43556.56443435525, 39983.80008099941, 40359.0, 40682.1863562733, 40955.795221023705, 44386.778066109466, 34195.82902085573, 37175.25649487049, 37381.62618373781, 37740.0, 38022.8098859515, 27934.3016424591, 28011.0, 28015.859920700266, 28248.85875570691, 28546.0], "value": 19354.851568939066, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.2487649084285, 385.322792765249, 385.54890777789984, 390.9081365879018, 407.5354096330182, 13862.514811981582, 18088.0, 18791.718124228148, 19463.513412164702, 19513.70729439056, 17799.46601601954, 18022.909885450554, 18526.629467410643, 18636.0, 18772.812271877276, 5473.0, 5614.214010038598, 5667.546596272288, 5680.602357834953, 5704.11586204137, 5478.178273259004, 5540.63985840919, 5567.7494512746825, 5642.971785141089, 5645.943540564604, 5101.566366858821, 5386.515213630772, 5525.668459892399, 5600.439956004388, 5609.57928155388, 5409.107497262947, 5495.725213739317, 5497.725113744336, 5517.889642207154, 5542.75057622408, 5364.865878353034, 5439.3200849893765, 5461.317335333083, 5482.150266708627, 5516.972415137939, 12989.740205195938, 13297.66755831112, 17536.91231543847, 22874.199403020815, 22950.967206475747, 2198.9560208795733, 2595.688517377908, 2952.46855565998, 2967.5993740845142, 3006.8496575171152, 9626.903730962671, 9732.90267097327, 9814.411135331902, 9899.90100098997, 10041.19670426364, 1834.385480863912, 1916.6741653918866, 1981.8315443187346, 1987.9900600497049, 2002.9499262518555, 76259.0, 80215.59892200501, 81493.59253203755, 82151.0, 82340.0, 8176.1383515769, 9252.491112988715, 9803.460809655395, 10993.945030274797, 11251.83122253167, 14306.070105443114, 14352.282385880664, 14392.640183995483, 14442.205678687773, 14453.49412770548, 7128.394086502602, 7210.9278907210255, 7327.706891724378, 7481.102267727799, 7502.17476077631, 6776.220734615582, 6899.724011039602, 6925.134358205224, 6997.265287144878, 7079.681414336264, 4340.153670034313, 4443.911121777546, 4452.4211852458975, 4563.201439748031, 4568.862934111982, 1886.2737845929416, 1962.1170473287077, 1992.591518738684, 2001.1795163982697, 2028.239410221167, 877.8024944387589, 930.4882314726873, 934.9018353072829, 984.5913945712449, 1021.2595867995792, 18620.16209270586, 19291.903540482206, 19396.70904936427, 19666.50833729168, 19908.303209387603, 909.3225546967551, 921.3964853021282, 942.5569982108398, 974.7368210583103, 975.0785507695301, 8280.04779450371, 10842.512086956105, 11134.053605443629, 11140.220184587, 11192.720181995515, 347374.0, 347930.0, 350302.0, 431432.0, 432636.0, 87951.04220310101, 91466.0, 92292.53853730689, 92714.0, 94435.52782236045, 450.8692479181066, 472.30335255497863, 476.10492274523676, 476.2713049034982, 478.9544993225638, 10137.543810528396, 10539.736506587396, 10572.84140737905, 10841.295315804447, 10992.615258466236, 39217.0, 39609.61366352164, 40615.79692101521, 41325.38011929884, 42142.0, 51538.74230628823, 54590.45409545854, 55531.0, 56187.0, 56963.715181423824, 7984.56084915312, 8397.454165479225, 8820.558972051243, 8912.777180570538, 8941.597628106621, 9132.315076369166, 13248.337583120612, 13772.0, 13874.098183618033, 13994.0, 11955.282683039046, 12169.087318450975, 12265.816012759637, 12359.25844449336, 12410.379481025731, 11625.360605166798, 11762.117841161777, 11816.350100744541, 11885.5840045598, 12367.0, 11837.171398002058, 11848.644540663794, 12298.75402491963, 12457.252564846138, 12538.247705137721, 7910.129885712452, 8233.300169485661, 8279.875801862856, 8414.4109912308, 8425.157484251526, 11009.760922342299, 11340.546378144782, 11776.175667703521, 11852.0, 12042.698932526757], "value": 8595.017643580266, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1188.9583864564743, 1213.696575856036, 1234.1607706759403, 1602.4952140075875, 1668.2492878204796, 7216.386607138399, 8221.383396245283, 8282.0, 8671.91328086719, 8781.990071141821, 8355.958220208906, 8652.264557512603, 8674.26268767154, 8688.26149777268, 8692.695755648554, 2212.4358288636417, 2261.5816074026275, 2264.6603009548617, 2265.762094980028, 2268.8411811173223, 2238.4963383238805, 2248.2580748353084, 2275.12407723027, 2303.1363238785457, 2303.3550605830396, 2236.105557776886, 2249.9437514062115, 2251.6397376419777, 2275.1923067311113, 2295.2081531871477, 2145.5816115857415, 2171.174953517661, 2173.9347819565437, 2182.181681869291, 2188.7701791311842, 2198.318521258415, 2206.5476577301615, 2207.8564893281887, 2209.723784526934, 2209.7458792238936, 9131.406458580172, 9156.816863662689, 9195.954020229923, 9202.079792020812, 9226.815463690757, 5177.275181474596, 5211.296474975868, 5281.973590132063, 5295.602829787781, 5296.735163241822, 3207.0859804955476, 3232.3535292941506, 3325.2850637112897, 3367.107716455141, 3372.578427696538, 1113.4488428228078, 1119.2668801934747, 1135.3301552084226, 1153.089059642881, 1160.5009845766317, 12467.93766031173, 12616.17994830333, 12644.30456324911, 12646.367681615975, 12756.425960831784, 4423.292273236267, 4451.10977804434, 4493.910121797546, 4517.796699148546, 4587.541245875453, 10719.464026798629, 10756.408397538211, 10792.838107428395, 10802.189835762349, 10802.459877006118, 5096.210087436453, 5122.282880396748, 5145.099607568661, 5149.2791009258735, 5150.742462876841, 4028.3957406389277, 4663.440387153563, 4752.643551733634, 4866.902661946741, 4885.8045678173185, 3967.504061992251, 3991.980040099781, 4038.4749982502085, 4056.817443215062, 4137.234611596864, 1263.4693428759942, 1264.3362234826789, 1276.5340650662442, 1278.3544310123514, 1283.8395200599925, 869.7869022089628, 878.1920633017639, 881.3654168998311, 908.2325435007408, 910.3036177324352, 6102.542309326818, 6226.0, 6254.0, 6303.3066362700065, 6360.363963603695, 956.6699488676395, 969.7090872738291, 985.5072463768116, 985.9507024648739, 990.5294984882123, 4273.700840941105, 4332.263515202423, 4347.7173983690955, 4370.497392799869, 4395.978020109879, 11032.0, 11345.262557933707, 11345.546178152947, 11381.487833047533, 11404.315741055563, 10524.210684198715, 11085.057770089472, 11089.05743011837, 11254.606088786853, 11264.66206013821, 7930.841383172305, 8179.672813087529, 8233.259006689426, 8235.876461853077, 8330.916690833135, 5860.794872179454, 6144.907826382697, 6211.3167551570195, 6219.346968568235, 6291.748330066746, 9553.522323883639, 9615.423074615546, 9720.951395242979, 9758.219342452729, 9868.457234851865, 9808.803823923625, 9842.507874606385, 9933.255005874444, 9936.503174841084, 9940.403575785476, 6456.386643268882, 7596.962015189889, 7740.690372385042, 7864.764057078297, 7881.763547093597, 8666.263367613823, 8802.91197088021, 8820.647174112964, 8829.69096081634, 8842.734717958472, 7580.0145981022115, 7589.6584653689615, 7664.616769161631, 8016.038075430985, 8023.6790528378215, 7492.737754178577, 7542.245775422414, 7588.696452141852, 7713.2286771322415, 7944.880826787487, 7101.857962840818, 7143.571385716666, 7146.249643787328, 7217.530860494261, 7219.0, 5149.279100925798, 5268.552173065333, 5413.53984911287, 5426.348838139448, 5458.181272809111, 5381.67709937405, 5401.297831281908, 5512.586556008396, 5666.461686139975, 5675.858103547444], "value": 4624.407651190587, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.58164615423016, 299.89053995291727, 303.1874576135955, 306.7116910104502, 307.6631088957591, 5636.239107720462, 5648.548116150709, 5681.375048744635, 5701.116326969316, 5730.914036289454, 5540.279763630722, 5544.6395984261, 5545.445455454463, 5552.889422115572, 5564.944350556493, 4100.569440208772, 4157.916841663165, 4270.167317373113, 4291.656667466611, 4296.742195468266, 4252.38340440636, 4253.978730106345, 4281.871543853674, 4293.592108749679, 4311.698181127306, 4269.978650106745, 4286.0, 4288.056627541936, 4290.163418133465, 4290.656747460212, 4025.778582177979, 4242.363645453176, 4248.596383343577, 4289.957100428987, 4289.957100428987, 3673.577538583044, 3680.7975561344115, 3684.907877303062, 3691.2248427830186, 3694.946940122052, 5408.486193811582, 5459.989901868167, 5474.343078830526, 5476.58925580579, 5505.174223866412, 4618.491965883783, 4825.841797968497, 4844.951550484485, 4852.2721591761165, 4914.287428322909, 5828.601135727437, 5847.883042339129, 5853.443922827325, 5889.941100588982, 5894.97052514739, 4050.5341885682933, 4061.878143655695, 4075.673946084336, 4077.5922407759285, 4082.6733861291027, 5916.26046744157, 5951.256092988377, 6023.518118550549, 6093.634381937098, 6125.59111404375, 4063.878083657495, 4073.124278280184, 4075.184963007351, 4101.507819061731, 4121.196366708463, 4170.291050521358, 4188.937165942513, 4204.885705288101, 4225.471816022997, 4226.5139508956245, 4667.382778346809, 4837.37114175155, 4838.0, 4878.414590249193, 4906.337644418029, 5858.677772722456, 5871.060630299217, 5884.293884733859, 5915.704214789243, 5916.645001299936, 1415.8654927781845, 1434.4692463788465, 1436.367998080841, 1444.4366696988184, 1445.4218312675014, 897.3673560140217, 900.5857305639348, 911.2026976395654, 921.6037104045325, 958.5063692198523, 5546.916796247979, 5577.9163312550345, 5599.80400685974, 5627.5779316551425, 5655.886882262332, 5921.437463440966, 5956.940430595725, 5981.581289309794, 6006.939930600725, 6039.365866583946, 5387.0, 5603.635763675348, 5606.635568688103, 5614.747336369792, 5618.9095997201375, 3187.474066779002, 3191.2500562367827, 3193.850213922986, 3207.230264736493, 3215.565898603705, 5835.941640583625, 6111.311023149799, 6133.601315914451, 6146.139540464339, 6173.197484327098, 6075.329284446812, 6102.267727872595, 6128.908066379008, 6145.170401995762, 6160.44555989963, 6017.6389416634265, 6093.817185484442, 6100.633961962208, 6114.205153330127, 6201.658908759971, 5613.214150018919, 5897.174395584708, 5924.733386997509, 5945.910811337747, 5954.0, 5773.711314434177, 5935.34711181761, 5937.970310148422, 5961.225040744675, 5974.671393073423, 5940.524758019262, 6009.338972713085, 6017.819465416044, 6072.240969878765, 6090.969545152246, 4024.5170579530645, 4117.3618089196225, 4122.361034039729, 4142.399352093989, 4150.813213405464, 5918.822435326947, 5941.287045554561, 5982.4316689914385, 5982.49148822355, 6046.244219472566, 5615.803446879503, 5710.3433105193435, 5788.855278618068, 5845.824625261249, 5857.188549496351, 5614.663120212637, 5759.280089988752, 5767.653940763567, 5769.365369809401, 5786.855328616818, 5530.529904958124, 5592.2170896075395, 5688.345840228427, 5751.5398768099285, 5759.308882933907, 5864.970675146597, 5867.882642347215, 5885.735141918538, 5894.911576326273, 5901.114832775118, 5605.691686957257, 5766.509846663081, 5783.652980821164, 5794.7102644866745, 5795.985702501961], "value": 4379.569596336809, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.5132193700872, 800.8798680197966, 802.4783890471193, 813.369638530139, 854.9914500854993, 13193.538226162087, 13253.271070091141, 13299.202047877123, 13313.201207927532, 14367.784483232746, 13448.596542103753, 14360.712785744305, 14401.711965760678, 14724.6318842029, 14905.25473726312, 780.3055280800093, 781.136843787615, 782.3428320211021, 782.7573452229799, 783.0134031120772, 763.0538132715449, 763.713607397226, 764.2128607534221, 765.674588299973, 765.7281665008925, 694.8158737934451, 812.2162113560413, 822.3256929317962, 836.7071524966243, 839.1189251286156, 804.3123129724061, 813.6582635293191, 816.143049797713, 818.5947955761876, 819.3076850061689, 593.8188852400016, 595.4700316718124, 595.7468076067654, 596.2129988415294, 597.0954004682909, 13953.86046139546, 14035.859641403558, 14065.226412547307, 14078.648033799134, 14085.08446950945, 12654.683632909158, 12834.16577922432, 12940.35298235094, 13006.219626822422, 13295.0, 10968.835467467994, 11037.779244415147, 11870.228435151774, 12406.379681015913, 12582.119251652388, 4484.0, 4495.865124046284, 4503.459584849807, 4521.412216411845, 4569.954300456986, 74016.0, 75091.62454187749, 75291.0, 75555.62222188964, 75558.62220688861, 10485.0, 10631.84052239217, 10930.672079837617, 11079.72300692489, 11180.776384472265, 21575.35273941784, 21611.567768644854, 21791.23730669419, 21796.346109616738, 21800.0, 8301.653037062244, 8333.791655208668, 8350.582470876432, 8434.225554948553, 8466.111058338909, 4524.0, 4636.327732478771, 4675.345451636774, 4676.0, 4688.46082700487, 3065.494193458099, 3086.7221950024605, 3136.2473006478735, 3138.2781960149296, 3147.937041259162, 553.9307586551681, 557.6709741252599, 578.7337824600646, 591.8934591773522, 600.8888355654218, 543.3072832139054, 601.8164459839703, 622.390057743414, 674.6518687061839, 716.3051839715467, 9006.214277876981, 9014.0, 9086.0, 9326.440413575207, 9601.135897769234, 644.8226737647091, 672.4620303756975, 673.3031312591543, 676.9695363708645, 680.1871763242976, 4383.276759334738, 4496.19068567661, 4512.553438789192, 4591.0, 4692.648051396159, 93339.0, 113253.0, 115944.42027789807, 120099.0, 120202.0, 103715.4814225924, 104524.99999999847, 106032.0, 106218.46890765651, 106615.0, 59606.10590841141, 88919.0, 90444.0, 90542.0, 91074.0, 8765.211130997986, 8767.956160219159, 8825.0, 8864.73405797827, 8966.282697384064, 52215.73892130515, 53004.0, 54216.0, 54378.45621543734, 54683.0, 64415.67792161009, 73807.26192738004, 74294.25705742874, 74669.0, 74686.62656686682, 10565.788684226427, 11013.614523491638, 11032.393218373067, 11032.724181895517, 11100.389478578432, 12118.333491658044, 12337.814932775836, 12358.0, 12608.432620532281, 13022.218666880017, 11481.712957176138, 11732.0, 11734.471948762155, 12088.697782555506, 12236.08229382782, 10811.729706757395, 11116.444177790916, 11133.944330278297, 11405.543778248777, 11544.769104618028, 10427.530761115617, 10871.836922446011, 10975.176861735243, 11118.777624447304, 11310.377929213642, 9357.017513161292, 9447.196988256075, 9519.238460923249, 9592.952035240058, 9796.412215267106, 9767.9023209767, 10254.230932680228, 10276.486175691036, 10341.74145646365, 10359.63741269052], "value": 7131.087644392904, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 105.0, 110.0, 110.0, 111.0, 112.0, 111.0, 112.0, 110.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 125.0, 153.0, 182.0, 130.0, 151.0, 158.0, 137.0, 180.0, 132.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 164.0, 175.0, 163.0, 163.0, 165.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 170.0, 75.0, 75.0, 77.0, 74.0, 184.0, 76.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 142.0, 87.0, 88.0, 87.0, 136.0, 85.0, 85.0, 141.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 146.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 100.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 55.0, 54.0, 54.0, 54.0, 53.0, 55.0, 56.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 63.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 80.0, 82.0, 82.0, 81.0, 81.0, 81.0, 114.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 138.0, 122.0, 129.0, 125.0, 144.0, 124.0, 148.0, 134.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 171.0, 174.0, 166.0, 167.0, 164.0, 169.0, 167.0, 171.0, 169.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 65.0, 67.0, 65.0, 63.0, 64.0, 74.0, 64.0, 63.0], "value": 65.4, "unit": "score"}]}]} 01:24:04 INFO - Return code: 0 01:24:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:24:04 ERROR - # TBPL SUCCESS # 01:24:04 INFO - Running post-action listener: _resource_record_post_action 01:24:04 INFO - ##### 01:24:04 INFO - ##### Finished run-tests step (success) 01:24:04 INFO - ##### 01:24:04 INFO - Running post-run listener: _resource_record_post_run 01:24:04 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 551088128; Read time: 0; Write time: 375292 01:24:04 INFO - TinderboxPrint: CPU usage
13.4% 01:24:04 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 01:24:04 INFO - TinderboxPrint: I/O write bytes / time
551,088,128 / 375,292 01:24:04 INFO - TinderboxPrint: CPU idle
8,244.1 (86.6%) 01:24:04 INFO - TinderboxPrint: CPU user
1,221.4 (12.8%) 01:24:04 INFO - TinderboxPrint: Swap in / out
0 / 0 01:24:04 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 256237568; Read time: 0; Write time: 190356 01:24:04 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 294850560; Read time: 0; Write time: 184936 01:24:04 INFO - Running post-run listener: _upload_blobber_files 01:24:04 INFO - Blob upload gear active. 01:24:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:24:04 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 01:24:04 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:24:04 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:24:05 INFO - (blobuploader) - INFO - Open directory for files ... 01:24:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:24:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:24:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:24:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:24:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:24:06 INFO - (blobuploader) - INFO - Done attempting. 01:24:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:24:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:24:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:24:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:24:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:24:09 INFO - (blobuploader) - INFO - Done attempting. 01:24:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:24:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:24:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:24:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:24:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:24:09 INFO - (blobuploader) - INFO - Done attempting. 01:24:09 INFO - (blobuploader) - INFO - Iteration through files over. 01:24:09 INFO - Return code: 0 01:24:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:24:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:24:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/599e750033150693bcbc79b55675d0fe8fc6bf8420bc8cc3a10f229239945d681210886626f0e4881c1b2652384cc428ab81925394c581a78d87d138ae2678f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2e28c1b7bd7539aac63ae29f2d5f64000904ccba8a798553e92ba5eba19be75f1b96a85b593f96b2326216a0184b72a158bda9dc69650cd38e6e8cfefacabf92", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7adddd0bbc71efb736e90b237ee15efddbd0ca3bae589af19f77068ee32a5ce94ed07af4714f88ecb682788364dd7297b87849a43b44ef2ac4ced89d5b704cf2"} 01:24:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:24:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:24:09 INFO - Contents: 01:24:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/599e750033150693bcbc79b55675d0fe8fc6bf8420bc8cc3a10f229239945d681210886626f0e4881c1b2652384cc428ab81925394c581a78d87d138ae2678f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2e28c1b7bd7539aac63ae29f2d5f64000904ccba8a798553e92ba5eba19be75f1b96a85b593f96b2326216a0184b72a158bda9dc69650cd38e6e8cfefacabf92", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7adddd0bbc71efb736e90b237ee15efddbd0ca3bae589af19f77068ee32a5ce94ed07af4714f88ecb682788364dd7297b87849a43b44ef2ac4ced89d5b704cf2"} 01:24:09 INFO - Running post-run listener: copy_logs_to_upload_dir 01:24:09 INFO - Copying logs to upload dir... 01:24:09 INFO - mkdir: /builds/slave/test/build/upload/logs 01:24:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.921774 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-20 01:24:07.674041) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 01:24:07.678074) ========= 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-1466395065.764248-272804846 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-Inbound/sha512/599e750033150693bcbc79b55675d0fe8fc6bf8420bc8cc3a10f229239945d681210886626f0e4881c1b2652384cc428ab81925394c581a78d87d138ae2678f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2e28c1b7bd7539aac63ae29f2d5f64000904ccba8a798553e92ba5eba19be75f1b96a85b593f96b2326216a0184b72a158bda9dc69650cd38e6e8cfefacabf92", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7adddd0bbc71efb736e90b237ee15efddbd0ca3bae589af19f77068ee32a5ce94ed07af4714f88ecb682788364dd7297b87849a43b44ef2ac4ced89d5b704cf2"} build_url:https://queue.taskcluster.net/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/cVuCDRs-SBa5cxtE8PsrYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/599e750033150693bcbc79b55675d0fe8fc6bf8420bc8cc3a10f229239945d681210886626f0e4881c1b2652384cc428ab81925394c581a78d87d138ae2678f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2e28c1b7bd7539aac63ae29f2d5f64000904ccba8a798553e92ba5eba19be75f1b96a85b593f96b2326216a0184b72a158bda9dc69650cd38e6e8cfefacabf92", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7adddd0bbc71efb736e90b237ee15efddbd0ca3bae589af19f77068ee32a5ce94ed07af4714f88ecb682788364dd7297b87849a43b44ef2ac4ced89d5b704cf2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 01:24:07.704294) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 01:24:07.704701) ========= 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-1466395065.764248-272804846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 01:24:07.786832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 01:24:07.787194) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 01:24:07.787550) ========= ========= Total master_lag: 0.18 =========