builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1465104574.81 results: success (0) buildid: 20160604193055 builduid: c8b20be8f91f4c3d9502481262476f3d revision: 4f5df0a09686af630e023c17e965977d9aa1c38a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 22:29:34.806008) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 22:29:34.806589) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 22:29:34.806909) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 22:29:34.821515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 22:29:34.821818) ========= 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=3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 22:29:35-- 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% 225M=0s 2016-06-04 22:29:36 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086988 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 22:29:34.923629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 22:29:34.923989) ========= 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=3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020677 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 22:29:34.973650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 22:29:34.974043) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4f5df0a09686af630e023c17e965977d9aa1c38a --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 4f5df0a09686af630e023c17e965977d9aa1c38a --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=3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 22:29:36,151 truncating revision to first 12 chars 2016-06-04 22:29:36,151 Setting DEBUG logging. 2016-06-04 22:29:36,151 attempt 1/10 2016-06-04 22:29:36,151 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4f5df0a09686?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 22:29:36,445 unpacking tar archive at: mozilla-inbound-4f5df0a09686/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625873 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 22:29:35.614166) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 22:29:35.614528) ========= script_repo_revision: 4f5df0a09686af630e023c17e965977d9aa1c38a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 22:29:35.615025) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 22:29:35.615350) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 22:29:35.629112) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-04 22:29:35.629457) ========= /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=3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:29:36 INFO - MultiFileLogger online at 20160604 22:29:36 in /builds/slave/test 22:29:36 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 22:29:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:29:36 INFO - {'append_to_log': False, 22:29:36 INFO - 'base_work_dir': '/builds/slave/test', 22:29:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:29:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:29:36 INFO - 'branch': 'Mozilla-Inbound', 22:29:36 INFO - 'buildbot_json_path': 'buildprops.json', 22:29:36 INFO - 'config_files': ('talos/linux_config.py',), 22:29:36 INFO - 'default_actions': ('clobber', 22:29:36 INFO - 'read-buildbot-config', 22:29:36 INFO - 'download-and-extract', 22:29:36 INFO - 'populate-webroot', 22:29:36 INFO - 'create-virtualenv', 22:29:36 INFO - 'install', 22:29:36 INFO - 'run-tests'), 22:29:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:29:36 INFO - 'download_minidump_stackwalk': True, 22:29:36 INFO - 'download_symbols': 'ondemand', 22:29:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:29:36 INFO - 'tooltool.py': '/tools/tooltool.py', 22:29:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:29:36 INFO - '/tools/misc-python/virtualenv.py')}, 22:29:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:29:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:29:36 INFO - 'installer_path': 'installer.exe', 22:29:36 INFO - 'log_level': 'info', 22:29:36 INFO - 'log_name': 'talos', 22:29:36 INFO - 'log_to_console': True, 22:29:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:29:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:29:36 INFO - 'opt_config_files': (), 22:29:36 INFO - 'pip_index': False, 22:29:36 INFO - 'sps_profile': False, 22:29:36 INFO - 'sps_profile_interval': 0, 22:29:36 INFO - 'suite': 'dromaeojs-e10s', 22:29:36 INFO - 'system_bits': '32', 22:29:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:29:36 INFO - 'title': 'talos-linux64-ix-059', 22:29:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:29:36 INFO - 'use_talos_json': True, 22:29:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:29:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:29:36 INFO - 'work_dir': 'build'} 22:29:36 INFO - ##### 22:29:36 INFO - ##### Running clobber step. 22:29:36 INFO - ##### 22:29:36 INFO - Running pre-action listener: _resource_record_pre_action 22:29:36 INFO - Running main action method: clobber 22:29:36 INFO - rmtree: /builds/slave/test/build 22:29:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:29:37 INFO - Running post-action listener: _resource_record_post_action 22:29:37 INFO - ##### 22:29:37 INFO - ##### Finished clobber step (success) 22:29:37 INFO - ##### 22:29:37 INFO - ##### 22:29:37 INFO - ##### Running read-buildbot-config step. 22:29:37 INFO - ##### 22:29:37 INFO - Running pre-action listener: _resource_record_pre_action 22:29:37 INFO - Running main action method: read_buildbot_config 22:29:37 INFO - Using buildbot properties: 22:29:37 INFO - { 22:29:37 INFO - "project": "", 22:29:37 INFO - "product": "firefox", 22:29:37 INFO - "script_repo_revision": "production", 22:29:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:29:37 INFO - "repository": "", 22:29:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:29:37 INFO - "buildid": "20160604193055", 22:29:37 INFO - "pgo_build": "True", 22:29:37 INFO - "basedir": "/builds/slave/test", 22:29:37 INFO - "buildnumber": 799, 22:29:37 INFO - "slavename": "talos-linux64-ix-059", 22:29:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:29:37 INFO - "platform": "ubuntu64_hw", 22:29:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:29:37 INFO - "branch": "mozilla-inbound", 22:29:37 INFO - "repo_path": "integration/mozilla-inbound", 22:29:37 INFO - "revision": "4f5df0a09686af630e023c17e965977d9aa1c38a", 22:29:37 INFO - "stage_platform": "linux64-pgo", 22:29:37 INFO - "builduid": "c8b20be8f91f4c3d9502481262476f3d", 22:29:37 INFO - "slavebuilddir": "test" 22:29:37 INFO - } 22:29:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 22:29:37 INFO - Running post-action listener: _resource_record_post_action 22:29:37 INFO - ##### 22:29:37 INFO - ##### Finished read-buildbot-config step (success) 22:29:37 INFO - ##### 22:29:37 INFO - ##### 22:29:37 INFO - ##### Running download-and-extract step. 22:29:37 INFO - ##### 22:29:37 INFO - Running pre-action listener: _resource_record_pre_action 22:29:37 INFO - Running main action method: download_and_extract 22:29:37 INFO - mkdir: /builds/slave/test/build/tests 22:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:37 INFO - https://queue.taskcluster.net/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:29:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:29:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:29:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:29:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:29:39 INFO - Downloaded 1361 bytes. 22:29:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:29:39 INFO - Using the following test package requirements: 22:29:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:29:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:29:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:29:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:39 INFO - u'jsshell-linux-x86_64.zip'], 22:29:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:29:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:29:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:29:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:29:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:29:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:29:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:39 INFO - https://queue.taskcluster.net/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:29:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:29:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:29:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:29:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:29:40 INFO - Downloaded 24441808 bytes. 22:29:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:29:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:29:41 INFO - Return code: 0 22:29:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:29: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')]} 22:29:41 INFO - https://queue.taskcluster.net/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:29:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:29:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:29:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:29:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:29:50 INFO - Downloaded 24441808 bytes. 22:29:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:29:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:29:51 INFO - Return code: 0 22:29: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')]} 22:29:51 INFO - https://queue.taskcluster.net/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:29:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:29:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:29:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:29:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:29:52 INFO - Downloaded 10833369 bytes. 22:29:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:29:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:29:52 INFO - Return code: 0 22:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:52 INFO - https://queue.taskcluster.net/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:29:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:29:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:29:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:29:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:29:54 INFO - Downloaded 59183030 bytes. 22:29:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:29:54 INFO - mkdir: /builds/slave/test/properties 22:29:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:29:54 INFO - Writing to file /builds/slave/test/properties/build_url 22:29:54 INFO - Contents: 22:29:54 INFO - build_url:https://queue.taskcluster.net/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:29:55 INFO - Running post-action listener: _resource_record_post_action 22:29:55 INFO - Running post-action listener: set_extra_try_arguments 22:29:55 INFO - ##### 22:29:55 INFO - ##### Finished download-and-extract step (success) 22:29:55 INFO - ##### 22:29:55 INFO - ##### 22:29:55 INFO - ##### Running populate-webroot step. 22:29:55 INFO - ##### 22:29:55 INFO - Running pre-action listener: _resource_record_pre_action 22:29:55 INFO - Running main action method: populate_webroot 22:29:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:29:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:29:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:29:55 INFO - '--tppagecycles', 22:29:55 INFO - '7'], 22:29:55 INFO - 'tests': ['tsvgm']}}, 22:29:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:29:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:29:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:29:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:29:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:29:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:29:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:55 INFO - 'talos_options': ['--disable-e10s'], 22:29:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:29:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:29:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:55 INFO - 'talos_options': ['--disable-e10s'], 22:29:55 INFO - 'tests': ['damp', 'tps']}, 22:29:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:55 INFO - 'tests': ['damp', 'tps']}, 22:29:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:29:55 INFO - 'tests': ['dromaeo_dom']}, 22:29:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:29:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:29:55 INFO - 'tests': ['a11yr', 22:29:55 INFO - 'ts_paint', 22:29:55 INFO - 'tpaint', 22:29:55 INFO - 'sessionrestore', 22:29:55 INFO - 'sessionrestore_no_auto_restore', 22:29:55 INFO - 'tabpaint']}, 22:29:55 INFO - 'other-e10s': {'tests': ['a11yr', 22:29:55 INFO - 'ts_paint', 22:29:55 INFO - 'tpaint', 22:29:55 INFO - 'sessionrestore', 22:29:55 INFO - 'sessionrestore_no_auto_restore', 22:29:55 INFO - 'tabpaint']}, 22:29:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:29:55 INFO - 'ts_paint', 22:29:55 INFO - 'tpaint', 22:29:55 INFO - 'sessionrestore', 22:29:55 INFO - 'sessionrestore_no_auto_restore', 22:29:55 INFO - 'tabpaint']}, 22:29:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:29:55 INFO - 'ts_paint', 22:29:55 INFO - 'tpaint', 22:29:55 INFO - 'sessionrestore', 22:29:55 INFO - 'sessionrestore_no_auto_restore', 22:29:55 INFO - 'tabpaint']}, 22:29:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:29:55 INFO - 'tests': ['a11yr', 22:29:55 INFO - 'ts_paint', 22:29:55 INFO - 'tpaint', 22:29:55 INFO - 'sessionrestore', 22:29:55 INFO - 'sessionrestore_no_auto_restore', 22:29:55 INFO - 'tabpaint']}, 22:29:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:29:55 INFO - 'tests': ['a11yr', 22:29:55 INFO - 'ts_paint', 22:29:55 INFO - 'tpaint', 22:29:55 INFO - 'sessionrestore', 22:29:55 INFO - 'sessionrestore_no_auto_restore', 22:29:55 INFO - 'tabpaint']}, 22:29:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:29:55 INFO - 'tests': ['tsvgx', 22:29:55 INFO - 'tsvgr_opacity', 22:29:55 INFO - 'tart', 22:29:55 INFO - 'tscrollx', 22:29:55 INFO - 'cart']}, 22:29:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:29:55 INFO - 'tsvgr_opacity', 22:29:55 INFO - 'tart', 22:29:55 INFO - 'tscrollx', 22:29:55 INFO - 'cart']}, 22:29:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:55 INFO - 'talos_options': ['--disable-e10s'], 22:29:55 INFO - 'tests': ['tp5o']}, 22:29:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:55 INFO - 'tests': ['tp5o']}, 22:29:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:55 INFO - 'talos_options': ['--disable-e10s', 22:29:55 INFO - '--xperf_path', 22:29:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:29:55 INFO - 'tests': ['tp5n']}, 22:29:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:55 INFO - 'talos_options': ['--xperf_path', 22:29:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:29:55 INFO - 'tests': ['tp5n']}}, 22:29:55 INFO - 'talos.zip': {'path': '', 22:29:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:29:55 INFO - Running post-action listener: _resource_record_post_action 22:29:55 INFO - ##### 22:29:55 INFO - ##### Finished populate-webroot step (success) 22:29:55 INFO - ##### 22:29:55 INFO - ##### 22:29:55 INFO - ##### Running create-virtualenv step. 22:29:55 INFO - ##### 22:29:55 INFO - Running pre-action listener: _resource_record_pre_action 22:29:55 INFO - Running main action method: create_virtualenv 22:29:55 INFO - Creating virtualenv /builds/slave/test/build/venv 22:29:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:29:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:29:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:29:55 INFO - Using real prefix '/usr' 22:29:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:29:56 INFO - Installing distribute.............................................................................................................................................................................................done. 22:29:58 INFO - Installing pip.................done. 22:29:58 INFO - Return code: 0 22:29:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f492afddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223e1c0>, '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 0x223f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223f550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', '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 22:29:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:29:58 INFO - Using env: {'DISPLAY': ':0', 22:29:58 INFO - 'HOME': '/home/cltbld', 22:29:58 INFO - 'LANG': 'en_US.UTF-8', 22:29:58 INFO - 'LANGUAGE': 'en_US:en', 22:29:58 INFO - 'LOGNAME': 'cltbld', 22:29:58 INFO - 'MAIL': '/var/mail/cltbld', 22:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:58 INFO - 'MOZ_NO_REMOTE': '1', 22:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:58 INFO - 'NO_EM_RESTART': '1', 22:29:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:58 INFO - 'PWD': '/builds/slave/test', 22:29:58 INFO - 'SHELL': '/bin/bash', 22:29:58 INFO - 'SHLVL': '1', 22:29:58 INFO - 'TERM': 'linux', 22:29:58 INFO - 'TMOUT': '86400', 22:29:58 INFO - 'USER': 'cltbld', 22:29:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', 22:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:58 INFO - '_': '/tools/buildbot/bin/python'} 22:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:29:58 INFO - Cleaning up... 22:29:58 INFO - Return code: 0 22:29:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f492afddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223e1c0>, '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 0x223f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223f550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', '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 22:29:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:29:58 INFO - Using env: {'DISPLAY': ':0', 22:29:58 INFO - 'HOME': '/home/cltbld', 22:29:58 INFO - 'LANG': 'en_US.UTF-8', 22:29:58 INFO - 'LANGUAGE': 'en_US:en', 22:29:58 INFO - 'LOGNAME': 'cltbld', 22:29:58 INFO - 'MAIL': '/var/mail/cltbld', 22:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:58 INFO - 'MOZ_NO_REMOTE': '1', 22:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:58 INFO - 'NO_EM_RESTART': '1', 22:29:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:58 INFO - 'PWD': '/builds/slave/test', 22:29:58 INFO - 'SHELL': '/bin/bash', 22:29:58 INFO - 'SHLVL': '1', 22:29:58 INFO - 'TERM': 'linux', 22:29:58 INFO - 'TMOUT': '86400', 22:29:58 INFO - 'USER': 'cltbld', 22:29:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', 22:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:58 INFO - '_': '/tools/buildbot/bin/python'} 22:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:58 INFO - Downloading/unpacking psutil>=3.1.1 22:29: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 22:29: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 22:29: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 22:29: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 22:29: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 22:29: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 22:30:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:30:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:30:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:30:00 INFO - Installing collected packages: psutil 22:30:00 INFO - Running setup.py install for psutil 22:30:00 INFO - building 'psutil._psutil_linux' extension 22:30:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:30:00 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 22:30:00 INFO - building 'psutil._psutil_posix' extension 22:30:00 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 22:30:00 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 22:30:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:30:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:30:01 INFO - Successfully installed psutil 22:30:01 INFO - Cleaning up... 22:30:01 INFO - Return code: 0 22:30:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f492afddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223e1c0>, '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 0x223f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223f550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', '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 22:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:30:01 INFO - Using env: {'DISPLAY': ':0', 22:30:01 INFO - 'HOME': '/home/cltbld', 22:30:01 INFO - 'LANG': 'en_US.UTF-8', 22:30:01 INFO - 'LANGUAGE': 'en_US:en', 22:30:01 INFO - 'LOGNAME': 'cltbld', 22:30:01 INFO - 'MAIL': '/var/mail/cltbld', 22:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:01 INFO - 'MOZ_NO_REMOTE': '1', 22:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:01 INFO - 'NO_EM_RESTART': '1', 22:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:01 INFO - 'PWD': '/builds/slave/test', 22:30:01 INFO - 'SHELL': '/bin/bash', 22:30:01 INFO - 'SHLVL': '1', 22:30:01 INFO - 'TERM': 'linux', 22:30:01 INFO - 'TMOUT': '86400', 22:30:01 INFO - 'USER': 'cltbld', 22:30:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', 22:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:01 INFO - '_': '/tools/buildbot/bin/python'} 22:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:30:03 INFO - Installing collected packages: mozsystemmonitor 22:30:03 INFO - Running setup.py install for mozsystemmonitor 22:30:03 INFO - Successfully installed mozsystemmonitor 22:30:03 INFO - Cleaning up... 22:30:03 INFO - Return code: 0 22:30:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f492afddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223e1c0>, '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 0x223f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223f550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', '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 22:30:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:30:03 INFO - Using env: {'DISPLAY': ':0', 22:30:03 INFO - 'HOME': '/home/cltbld', 22:30:03 INFO - 'LANG': 'en_US.UTF-8', 22:30:03 INFO - 'LANGUAGE': 'en_US:en', 22:30:03 INFO - 'LOGNAME': 'cltbld', 22:30:03 INFO - 'MAIL': '/var/mail/cltbld', 22:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:03 INFO - 'MOZ_NO_REMOTE': '1', 22:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:03 INFO - 'NO_EM_RESTART': '1', 22:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:03 INFO - 'PWD': '/builds/slave/test', 22:30:03 INFO - 'SHELL': '/bin/bash', 22:30:03 INFO - 'SHLVL': '1', 22:30:03 INFO - 'TERM': 'linux', 22:30:03 INFO - 'TMOUT': '86400', 22:30:03 INFO - 'USER': 'cltbld', 22:30:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', 22:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:03 INFO - '_': '/tools/buildbot/bin/python'} 22:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:03 INFO - Downloading/unpacking jsonschema==2.5.1 22:30:03 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 22:30:03 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 22:30:03 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 22:30:03 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 22:30:03 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 22:30:03 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 22:30:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:30:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:05 INFO - Downloading functools32-3.2.3-2.tar.gz 22:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:30:05 INFO - warning: no files found matching '*.txt' 22:30:05 INFO - no previously-included directories found matching 'build' 22:30:05 INFO - no previously-included directories found matching 'dist' 22:30:05 INFO - no previously-included directories found matching '.git*' 22:30:05 INFO - Installing collected packages: jsonschema, functools32 22:30:05 INFO - Running setup.py install for functools32 22:30:05 INFO - warning: no files found matching '*.txt' 22:30:05 INFO - no previously-included directories found matching 'build' 22:30:05 INFO - no previously-included directories found matching 'dist' 22:30:05 INFO - no previously-included directories found matching '.git*' 22:30:05 INFO - Successfully installed jsonschema functools32 22:30:05 INFO - Cleaning up... 22:30:05 INFO - Return code: 0 22:30:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:05 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 0x7f492afddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223e1c0>, '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 0x223f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223f550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', '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 22:30:05 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 22:30:05 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 22:30:05 INFO - Using env: {'DISPLAY': ':0', 22:30:05 INFO - 'HOME': '/home/cltbld', 22:30:05 INFO - 'LANG': 'en_US.UTF-8', 22:30:05 INFO - 'LANGUAGE': 'en_US:en', 22:30:05 INFO - 'LOGNAME': 'cltbld', 22:30:05 INFO - 'MAIL': '/var/mail/cltbld', 22:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:05 INFO - 'MOZ_NO_REMOTE': '1', 22:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:05 INFO - 'NO_EM_RESTART': '1', 22:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:05 INFO - 'PWD': '/builds/slave/test', 22:30:05 INFO - 'SHELL': '/bin/bash', 22:30:05 INFO - 'SHLVL': '1', 22:30:05 INFO - 'TERM': 'linux', 22:30:05 INFO - 'TMOUT': '86400', 22:30:05 INFO - 'USER': 'cltbld', 22:30:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', 22:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:05 INFO - '_': '/tools/buildbot/bin/python'} 22:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:06 INFO - Downloading/unpacking blobuploader==1.2.4 22:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:08 INFO - Downloading blobuploader-1.2.4.tar.gz 22:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:30:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:30: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 22:30: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 22:30: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 22:30: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 22:30: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 22:30: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 22:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:30:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:30: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 22:30: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 22:30: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 22:30: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 22:30: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 22:30: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 22:30:08 INFO - Downloading docopt-0.6.1.tar.gz 22:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:30:08 INFO - Installing collected packages: blobuploader, requests, docopt 22:30:08 INFO - Running setup.py install for blobuploader 22:30:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:30:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:30:08 INFO - Running setup.py install for requests 22:30:09 INFO - Running setup.py install for docopt 22:30:09 INFO - Successfully installed blobuploader requests docopt 22:30:09 INFO - Cleaning up... 22:30:09 INFO - Return code: 0 22:30:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f492afddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223e1c0>, '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 0x223f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223f550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', '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 22:30:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:30:09 INFO - Using env: {'DISPLAY': ':0', 22:30:09 INFO - 'HOME': '/home/cltbld', 22:30:09 INFO - 'LANG': 'en_US.UTF-8', 22:30:09 INFO - 'LANGUAGE': 'en_US:en', 22:30:09 INFO - 'LOGNAME': 'cltbld', 22:30:09 INFO - 'MAIL': '/var/mail/cltbld', 22:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:09 INFO - 'MOZ_NO_REMOTE': '1', 22:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:09 INFO - 'NO_EM_RESTART': '1', 22:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:09 INFO - 'PWD': '/builds/slave/test', 22:30:09 INFO - 'SHELL': '/bin/bash', 22:30:09 INFO - 'SHLVL': '1', 22:30:09 INFO - 'TERM': 'linux', 22:30:09 INFO - 'TMOUT': '86400', 22:30:09 INFO - 'USER': 'cltbld', 22:30:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', 22:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:09 INFO - '_': '/tools/buildbot/bin/python'} 22:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:30:09 INFO - Running setup.py (path:/tmp/pip-1KI0rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:30:09 INFO - Running setup.py (path:/tmp/pip-92YKCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:30:09 INFO - Running setup.py (path:/tmp/pip-b1Ezhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:30:09 INFO - Running setup.py (path:/tmp/pip-1tA7kI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:30:09 INFO - Running setup.py (path:/tmp/pip-6jOFFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:30:09 INFO - Running setup.py (path:/tmp/pip-xjkvza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:30:10 INFO - Running setup.py (path:/tmp/pip-2NnDne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:30:10 INFO - Running setup.py (path:/tmp/pip-eHJFK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:30:10 INFO - Running setup.py (path:/tmp/pip-Moni5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:30:10 INFO - Running setup.py (path:/tmp/pip-QZfiW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:30:10 INFO - Running setup.py (path:/tmp/pip-27en3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:30:10 INFO - Running setup.py (path:/tmp/pip-DhB_10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:30:10 INFO - Running setup.py (path:/tmp/pip-4X2WOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:30:10 INFO - Running setup.py (path:/tmp/pip-DHGwhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:10 INFO - Running setup.py (path:/tmp/pip-HkhBuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:30:10 INFO - Running setup.py (path:/tmp/pip-3K6Jzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:30:10 INFO - Running setup.py (path:/tmp/pip-cXDR23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:30:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:30:10 INFO - Running setup.py install for manifestparser 22:30:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:30:10 INFO - Running setup.py install for mozcrash 22:30:11 INFO - Running setup.py install for mozdebug 22:30:11 INFO - Running setup.py install for mozdevice 22:30:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:30:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:30:11 INFO - Running setup.py install for mozfile 22:30:11 INFO - Running setup.py install for mozhttpd 22:30:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:30:11 INFO - Running setup.py install for mozinfo 22:30:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:30:11 INFO - Running setup.py install for mozInstall 22:30:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:30:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:30:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:30:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:30:11 INFO - Running setup.py install for mozleak 22:30:11 INFO - Running setup.py install for mozlog 22:30:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:30:11 INFO - Running setup.py install for moznetwork 22:30:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:30:11 INFO - Running setup.py install for mozprocess 22:30:12 INFO - Running setup.py install for mozprofile 22:30:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:30:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:30:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:30:12 INFO - Running setup.py install for mozrunner 22:30:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:30:12 INFO - Running setup.py install for mozscreenshot 22:30:12 INFO - Running setup.py install for moztest 22:30:12 INFO - Running setup.py install for mozversion 22:30:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:30:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:30:12 INFO - Cleaning up... 22:30:12 INFO - Return code: 0 22:30:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:12 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 0x7f492afddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223e1c0>, '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 0x223f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223f550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', '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 22:30:12 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 22:30:12 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 22:30:12 INFO - Using env: {'DISPLAY': ':0', 22:30:12 INFO - 'HOME': '/home/cltbld', 22:30:12 INFO - 'LANG': 'en_US.UTF-8', 22:30:12 INFO - 'LANGUAGE': 'en_US:en', 22:30:12 INFO - 'LOGNAME': 'cltbld', 22:30:12 INFO - 'MAIL': '/var/mail/cltbld', 22:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:12 INFO - 'MOZ_NO_REMOTE': '1', 22:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:12 INFO - 'NO_EM_RESTART': '1', 22:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:12 INFO - 'PWD': '/builds/slave/test', 22:30:12 INFO - 'SHELL': '/bin/bash', 22:30:12 INFO - 'SHLVL': '1', 22:30:12 INFO - 'TERM': 'linux', 22:30:12 INFO - 'TMOUT': '86400', 22:30:12 INFO - 'USER': 'cltbld', 22:30:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', 22:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:12 INFO - '_': '/tools/buildbot/bin/python'} 22:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:30:12 INFO - Running setup.py (path:/tmp/pip-Y4mupu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:30:12 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)) 22:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:30:12 INFO - Running setup.py (path:/tmp/pip-8n9Nw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:30:13 INFO - Running setup.py (path:/tmp/pip-fCY2Zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:30:13 INFO - Running setup.py (path:/tmp/pip-T08oZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:30:13 INFO - Running setup.py (path:/tmp/pip-jY9YcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:30:13 INFO - Running setup.py (path:/tmp/pip-oJjv8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:30:13 INFO - Running setup.py (path:/tmp/pip-97lgen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:30:13 INFO - Running setup.py (path:/tmp/pip-bAUtnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:30:13 INFO - Running setup.py (path:/tmp/pip-GEaoTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:30:13 INFO - Running setup.py (path:/tmp/pip-jSOg8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:30:13 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)) 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:30:13 INFO - Running setup.py (path:/tmp/pip-EFrII0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:30:13 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)) 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:30:13 INFO - Running setup.py (path:/tmp/pip-aFXObN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:30:13 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)) 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:30:13 INFO - Running setup.py (path:/tmp/pip-zkp1AE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:30:13 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)) 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:30:13 INFO - Running setup.py (path:/tmp/pip-ZFGmcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:30:13 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)) 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:13 INFO - Running setup.py (path:/tmp/pip-wBG7g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:13 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)) 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:30:13 INFO - Running setup.py (path:/tmp/pip-1xkdsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:30:14 INFO - Running setup.py (path:/tmp/pip-btVFAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:30:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:16 INFO - Downloading blessings-1.6.tar.gz 22:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:30:16 INFO - Installing collected packages: blessings 22:30:16 INFO - Running setup.py install for blessings 22:30:16 INFO - Successfully installed blessings 22:30:16 INFO - Cleaning up... 22:30:16 INFO - Return code: 0 22:30:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:30:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:30:16 INFO - Reading from file tmpfile_stdout 22:30:16 INFO - Current package versions: 22:30:16 INFO - argparse == 1.2.1 22:30:16 INFO - blessings == 1.6 22:30:16 INFO - blobuploader == 1.2.4 22:30:16 INFO - docopt == 0.6.1 22:30:16 INFO - functools32 == 3.2.3-2 22:30:16 INFO - jsonschema == 2.5.1 22:30:16 INFO - manifestparser == 1.1 22:30:16 INFO - mozInstall == 1.12 22:30:16 INFO - mozcrash == 0.17 22:30:16 INFO - mozdebug == 0.1 22:30:16 INFO - mozdevice == 0.48 22:30:16 INFO - mozfile == 1.2 22:30:16 INFO - mozhttpd == 0.7 22:30:16 INFO - mozinfo == 0.9 22:30:16 INFO - mozleak == 0.1 22:30:16 INFO - mozlog == 3.2 22:30:16 INFO - moznetwork == 0.27 22:30:16 INFO - mozprocess == 0.22 22:30:16 INFO - mozprofile == 0.28 22:30:16 INFO - mozrunner == 6.11 22:30:16 INFO - mozscreenshot == 0.1 22:30:16 INFO - mozsystemmonitor == 0.3 22:30:16 INFO - moztest == 0.7 22:30:16 INFO - mozversion == 1.4 22:30:16 INFO - psutil == 3.1.1 22:30:16 INFO - requests == 1.2.3 22:30:16 INFO - wsgiref == 0.1.2 22:30:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f492afddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223e1c0>, '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 0x223f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223f550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', '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 22:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:30:16 INFO - Using env: {'DISPLAY': ':0', 22:30:16 INFO - 'HOME': '/home/cltbld', 22:30:16 INFO - 'LANG': 'en_US.UTF-8', 22:30:16 INFO - 'LANGUAGE': 'en_US:en', 22:30:16 INFO - 'LOGNAME': 'cltbld', 22:30:16 INFO - 'MAIL': '/var/mail/cltbld', 22:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:16 INFO - 'MOZ_NO_REMOTE': '1', 22:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:16 INFO - 'NO_EM_RESTART': '1', 22:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:16 INFO - 'PWD': '/builds/slave/test', 22:30:16 INFO - 'SHELL': '/bin/bash', 22:30:16 INFO - 'SHLVL': '1', 22:30:16 INFO - 'TERM': 'linux', 22:30:16 INFO - 'TMOUT': '86400', 22:30:16 INFO - 'USER': 'cltbld', 22:30:16 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', 22:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:16 INFO - '_': '/tools/buildbot/bin/python'} 22:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:16 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)) 22:30:16 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)) 22:30:16 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)) 22:30:16 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)) 22:30:16 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)) 22:30:16 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)) 22:30:16 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)) 22:30:16 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)) 22:30:16 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)) 22:30:16 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)) 22:30:16 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)) 22:30:16 INFO - Cleaning up... 22:30:16 INFO - Return code: 0 22:30:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:16 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 0x7f492afddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223e1c0>, '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 0x223f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223f550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', '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 22:30:16 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 22:30:16 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 22:30:16 INFO - Using env: {'DISPLAY': ':0', 22:30:16 INFO - 'HOME': '/home/cltbld', 22:30:16 INFO - 'LANG': 'en_US.UTF-8', 22:30:16 INFO - 'LANGUAGE': 'en_US:en', 22:30:16 INFO - 'LOGNAME': 'cltbld', 22:30:16 INFO - 'MAIL': '/var/mail/cltbld', 22:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:16 INFO - 'MOZ_NO_REMOTE': '1', 22:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:16 INFO - 'NO_EM_RESTART': '1', 22:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:16 INFO - 'PWD': '/builds/slave/test', 22:30:16 INFO - 'SHELL': '/bin/bash', 22:30:16 INFO - 'SHLVL': '1', 22:30:16 INFO - 'TERM': 'linux', 22:30:16 INFO - 'TMOUT': '86400', 22:30:16 INFO - 'USER': 'cltbld', 22:30:16 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', 22:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:16 INFO - '_': '/tools/buildbot/bin/python'} 22:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:30:16 INFO - Cleaning up... 22:30:16 INFO - Return code: 0 22:30:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:16 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 0x7f492afddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223e1c0>, '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 0x223f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223f550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', '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 22:30:16 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 22:30:16 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 22:30:16 INFO - Using env: {'DISPLAY': ':0', 22:30:16 INFO - 'HOME': '/home/cltbld', 22:30:16 INFO - 'LANG': 'en_US.UTF-8', 22:30:16 INFO - 'LANGUAGE': 'en_US:en', 22:30:16 INFO - 'LOGNAME': 'cltbld', 22:30:16 INFO - 'MAIL': '/var/mail/cltbld', 22:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:16 INFO - 'MOZ_NO_REMOTE': '1', 22:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:16 INFO - 'NO_EM_RESTART': '1', 22:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:16 INFO - 'PWD': '/builds/slave/test', 22:30:16 INFO - 'SHELL': '/bin/bash', 22:30:16 INFO - 'SHLVL': '1', 22:30:16 INFO - 'TERM': 'linux', 22:30:16 INFO - 'TMOUT': '86400', 22:30:16 INFO - 'USER': 'cltbld', 22:30:16 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', 22:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:16 INFO - '_': '/tools/buildbot/bin/python'} 22:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:17 INFO - Downloading/unpacking flake8 22:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:30:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:30:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:30:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:30:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:30:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:30:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:30:19 INFO - no previously-included directories found matching 'docs/_build' 22:30:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:30:19 INFO - Running setup.py install for pep8 22:30:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:30:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:30:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:30:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:30:19 INFO - no previously-included directories found matching 'docs/_build' 22:30:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:30:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:30:19 INFO - Cleaning up... 22:30:20 INFO - Return code: 0 22:30:20 INFO - Running post-action listener: _resource_record_post_action 22:30:20 INFO - Running post-action listener: _start_resource_monitoring 22:30:20 INFO - Starting resource monitoring. 22:30:20 INFO - ##### 22:30:20 INFO - ##### Finished create-virtualenv step (success) 22:30:20 INFO - ##### 22:30:20 INFO - ##### 22:30:20 INFO - ##### Running install step. 22:30:20 INFO - ##### 22:30:20 INFO - Running pre-action listener: _resource_record_pre_action 22:30:20 INFO - Running main action method: install 22:30:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:30:20 INFO - Reading from file tmpfile_stdout 22:30:20 INFO - Detecting whether we're running mozinstall >=1.0... 22:30:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:30:20 INFO - Reading from file tmpfile_stdout 22:30:20 INFO - Output received: 22:30:20 INFO - Usage: mozinstall [options] installer 22:30:20 INFO - Options: 22:30:20 INFO - -h, --help show this help message and exit 22:30:20 INFO - -d DEST, --destination=DEST 22:30:20 INFO - Directory to install application into. [default: 22:30:20 INFO - "/builds/slave/test"] 22:30:20 INFO - --app=APP Application being installed. [default: firefox] 22:30:20 INFO - mkdir: /builds/slave/test/build/application 22:30:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:30:37 INFO - Reading from file tmpfile_stdout 22:30:37 INFO - Output received: 22:30:37 INFO - /builds/slave/test/build/application/firefox/firefox 22:30:37 INFO - Running post-action listener: _resource_record_post_action 22:30:37 INFO - ##### 22:30:37 INFO - ##### Finished install step (success) 22:30:37 INFO - ##### 22:30:37 INFO - ##### 22:30:37 INFO - ##### Running run-tests step. 22:30:37 INFO - ##### 22:30:37 INFO - Running pre-action listener: _resource_record_pre_action 22:30:37 INFO - Running main action method: run_tests 22:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:30:37 INFO - Python 2.7.3 22:30:37 INFO - Return code: 0 22:30:37 INFO - grabbing minidump binary from tooltool 22:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:37 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 0x223e1c0>, '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 0x223f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:30:37 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 22:30:37 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 22:30:37 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 22:30:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:30:37 INFO - Return code: 0 22:30:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:30:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:30:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:30:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:30:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:30:38 INFO - Return code: 0 22:30:38 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/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 22:30:38 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/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 22:30:38 INFO - Using env: {'DISPLAY': ':0', 22:30:38 INFO - 'HOME': '/home/cltbld', 22:30:38 INFO - 'LANG': 'en_US.UTF-8', 22:30:38 INFO - 'LANGUAGE': 'en_US:en', 22:30:38 INFO - 'LOGNAME': 'cltbld', 22:30:38 INFO - 'MAIL': '/var/mail/cltbld', 22:30:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:30:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:38 INFO - 'MOZ_NO_REMOTE': '1', 22:30:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:38 INFO - 'NO_EM_RESTART': '1', 22:30:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:38 INFO - 'PWD': '/builds/slave/test', 22:30:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:30:38 INFO - 'SHELL': '/bin/bash', 22:30:38 INFO - 'SHLVL': '1', 22:30:38 INFO - 'TERM': 'linux', 22:30:38 INFO - 'TMOUT': '86400', 22:30:38 INFO - 'USER': 'cltbld', 22:30:38 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219', 22:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:38 INFO - '_': '/tools/buildbot/bin/python'} 22:30:38 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/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 22:30:38 INFO - mozversion application_buildid: 20160604193055 22:30:38 INFO - mozversion application_changeset: 4f5df0a09686af630e023c17e965977d9aa1c38a 22:30:38 INFO - mozversion application_display_name: Nightly 22:30:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:30:38 INFO - mozversion application_name: Firefox 22:30:38 INFO - mozversion application_remotingname: firefox 22:30:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:30:38 INFO - mozversion application_vendor: Mozilla 22:30:38 INFO - mozversion application_version: 49.0a1 22:30:38 INFO - mozversion platform_buildid: 20160604193055 22:30:38 INFO - mozversion platform_changeset: 4f5df0a09686af630e023c17e965977d9aa1c38a 22:30:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:30:38 INFO - mozversion platform_version: 49.0a1 22:30:38 INFO - using testdate: 1465104638 22:30:38 INFO - actual date: 1465104638 22:30:38 INFO - starting webserver on 'localhost:51791' 22:30:38 INFO - SUITE-START | Running 2 tests 22:30:38 INFO - TEST-START | dromaeo_css 22:30:38 INFO - operating with platform_type : linux_ 22:30:38 INFO - Initialising browser for dromaeo_css test... 22:30:38 INFO - TEST-INFO | started process 15671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_aTn4B/profile http://localhost:51791/getInfo.html) 22:30:42 INFO - PROCESS | 15671 | __metrics Screen width/height:1600/1200 22:30:42 INFO - PROCESS | 15671 | colorDepth:24 22:30:42 INFO - PROCESS | 15671 | Browser inner width/height: 1024/697 22:30:42 INFO - PROCESS | 15671 | __metrics 22:30:43 ERROR - PROCESS | 15671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 22:30:44 INFO - TEST-INFO | 15671: exit 0 22:30:44 INFO - Browser initialized. 22:30:44 INFO - Running cycle 1/1 for dromaeo_css test... 22:30:44 INFO - TEST-INFO | started process 15793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_aTn4B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:30:55 INFO - PROCESS | 15793 | RSS: Main: 167612416 22:30:55 INFO - PROCESS | 15793 | 22:31:45 INFO - PROCESS | 15793 | 1465104705495 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] 22:33:52 INFO - PROCESS | 15793 | Cycle 1(1): loaded http://localhost:51791/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51791/tests/dromaeo/cssquery-ext.html) 22:33:53 INFO - PROCESS | 15793 | RSS: Main: 171368448 22:33:53 INFO - PROCESS | 15793 | 22:36:56 INFO - PROCESS | 15793 | Cycle 1(1): loaded http://localhost:51791/tests/dromaeo/cssquery-ext.html (next: http://localhost:51791/tests/dromaeo/cssquery-jquery.html) 22:36:56 INFO - PROCESS | 15793 | RSS: Main: 170291200 22:36:56 INFO - PROCESS | 15793 | 22:39:58 INFO - PROCESS | 15793 | Cycle 1(1): loaded http://localhost:51791/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51791/tests/dromaeo/cssquery-mootools.html) 22:39:59 INFO - PROCESS | 15793 | RSS: Main: 171479040 22:39:59 INFO - PROCESS | 15793 | 22:43:00 INFO - PROCESS | 15793 | Cycle 1(1): loaded http://localhost:51791/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51791/tests/dromaeo/cssquery-prototype.html) 22:43:01 INFO - PROCESS | 15793 | RSS: Main: 168923136 22:43:01 INFO - PROCESS | 15793 | 22:46:03 INFO - PROCESS | 15793 | Cycle 1(1): loaded http://localhost:51791/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51791/tests/dromaeo/cssquery-yui.html) 22:46:04 INFO - PROCESS | 15793 | RSS: Main: 170950656 22:46:04 INFO - PROCESS | 15793 | 22:49:07 INFO - PROCESS | 15793 | Cycle 1(1): loaded http://localhost:51791/tests/dromaeo/cssquery-yui.html (next: http://localhost:51791/tests/dromaeo/cssquery-dojo.html) 22:49:07 INFO - PROCESS | 15793 | RSS: Main: 171520000 22:49:07 INFO - PROCESS | 15793 | 22:49:07 INFO - PROCESS | 15793 | __start_tp_report 22:49:07 INFO - PROCESS | 15793 | _x_x_mozilla_page_load 22:49:07 INFO - PROCESS | 15793 | _x_x_mozilla_page_load_details 22:49:07 INFO - PROCESS | 15793 | |i|pagename|runs| 22:49:07 INFO - PROCESS | 15793 | |0;dojo.html;3097.4579448596496;3176.4600017996936;3186.569813075235;3194.0737186215997;3203.631582368027;5428.864278393037;5463.262459567962;5484.643498172621;5539.058360078786;5546.77812887485;5282.2076688496745;5416.83749487516;5498.615096943216;5511.448855114487;5520.282363292767;4955.504449555034;4996.300517927493;5086.440491545927;5134.614903882205;5188.066148093341;523.8160589895892;4849.393825771778;4914.164592019365;4937.382827146606;5090.083784918713;4923.138450771101;4973.950260497385;4994.400671919375;5004.524570165847;5007.14878470659;4920.237363208673;4944.307796908436;4980.327655766461;4997.30037794709;5015.974920125376;4876.585490233334;4920.3357546731095;4922.778474968635;4936.580390666798;4936.851894443173;5327.946720532784;5397.487238712316;5401.297831281908;5404;5406.270153529263;5578.41426650204;5618.185363122365;5855.297364316267;5867.647941123546;5909.4090590941;5879.911801322984;5880.529557635379;5893.882122357529;5919.733611987471;5955.612885162451;5449.7275136243425;5484.067708489566;5492.533134683556;5493.917591236134;5517.779288828482;5785.190073389729;5965.552583556164;6007.879842403127;6051.939480605226;6069.908951365733;5734.598578099493;5767.711614419262;5775.27809023872;5793.681347525927;5843.766249350064;5837.416258374129;5854.151148083504;5857.414258574194;5867.413258674099;5878.11828225761;5554.750036248379;5819.941800582024;5847.853803654858;5848.61983971049;5861.1501332307425;5861.296644402699;5893.6463812171405;5897.0269905465975;5919.585629006015;5939.643621382731;4399.5380485049245;4439.711418757771;4460.3532487789735;4462.598366146997;4480.641548676098;3850.2299540092095;3875.5736868944396;3890.9416358754643;3897.4348719435525;3967.900802479903;5518;5519.862003449946;5538.972305138448;5543.445655434505;5596.916046259309;5873.177755114202;5902.468777810018;5905.966455870205;5908.881822363529;5915.615484993462;5373.489518495737;5511.834644960658;5553.222548843165;5579.38626751057;5589.441055894378;5038.546530812245;5050.3434553507805;5060.342155519759;5069.163588008011;5071.771770270347;6075.848103797441;6075.969620151959;6076.193218773749;6092;6133.172021777003;5646.717664116778;5674.375818660027;5676.943230567724;5816.156657284585;5870.442307980735;6095.824132198525;6102.186302349175;6105.481814251489;6138.204480310071;6141.631502109888;5832.358440571449;5834.18321435008;5837.416258374129;5842.737076831468;5851.912221316768;5610.691411972218;5815.156802263733;5851.180834683063;5853.531717462678;5938.8218353449465;5696.373398926032;5732.369439361583;5735.770569177186;5750.741216645345;5764.279465066867;5702.942970570241;5738.770449181986;5741.5406767459335;5754.68349240779;5760.020796464527;5495.2856128703015;5518.420565840529;5585.385607583244;5622.578306626938;5643.407442218508;5742.655440673573;5768.682722450306;5789.768409263583;5790.652560846194;5795.76816927335;5648.802291919763;5649.152627105803;5660.7169641518585;5663.745131469176;5667.291588551431 22:49:07 INFO - PROCESS | 15793 | |1;ext.html;577.6274303074517;601.6540489218701;619.4301242856571;639.1722719078793;641.2145122225272;32260.354792904156;42412.57587424129;43502;43811.78094109525;43849.34225986613;42194.78902605483;42221;42440.78779606106;42523.78738106313;42537;8636.481811091355;8852.981907080704;8871.556422178865;8880.955595222014;8888.60001299943;8580.099089595597;8693.304535637166;8695.826083478327;8697.95651021744;8719.564021798884;8612.267957223643;8702.086280940504;8765.693200737975;8768.736937891874;8782.38523303369;8626.568671566429;8703.738887833375;8711.520866352348;8732.388732788708;8742.737717868475;8699.956500217522;8750;8809.735707928772;8816.779580510474;8821.2060914518;41580.37629435561;42055.36916946248;42415.57584424178;42467;42478.362824557655;3431.7083047940955;3461.2904354607244;3586.8923932282073;3970.940435893464;4230.725002874803;32075.83962080198;32540.674593254;32820.671793282236;32880.50679239813;33498.330033399194;4297.613214810682;4403.273459879116;4413.823447062114;4539.114872599845;4587.587117159472;359380;360518;361606;361683.9999999974;361945;60361;60510.69744651337;60856;60991.695041525396;61215.38784612186;34538;35905.82047089748;36419.63580364215;38420.807895960344;38487.422688659695;15693.686126277411;15720.371185152695;15836.683266334609;15860;15869.33371995947;13393.799093013613;13459.125156864968;13475;13509.459621615222;13513.662158446117;19397.90301048514;19435.79264784654;19513.899984022963;19544.24101830842;19572.804271957382;7273.197877572082;7277.745278915212;7301.926980730124;7431.925680743231;7458.328750412489;986.3440811860032;987.7481242283316;1021.8927012663563;1097.00720847633;1117.9385133817555;32303.192420189214;32774.34451311008;32919;33032.50451243233;33032.50451243233;1104.9944750276197;1122.8820973797797;1140.7547377313751;1158.1487606609135;1222.614876313976;16841.32634694623;17023.233954472078;17193.65612687739;17242.045505208767;17396.739048914278;607872;609269;610940;613106;613487.1907685553;57217.71391143101;57999;58395.41604583985;58490.70754646199;58806.7059664699;1332.253937794838;1379.0553470872285;1380.7307575022774;1387.036009973059;1389.9513517027058;30824.537631935986;31474.213144671565;31896;31953.68046319507;32261.354772903942;50153.24770128524;50490.2426463596;50615.240771387726;50715.49284507108;50860.23709644284;469800;475097;478107;479502;482456;27803.44393112167;28187.15438536847;28189.295267617654;28252.43495130045;28340.574891376233;47900;48247;48581;48897.75551122222;49369.50630493649;40415.191696165326;40628.79685601553;41569.58430415778;41658.79170604127;42403;41148;41604.37593436161;41645.58354416417;41722.791386042874;41920.3711944315;40991;41053.79473102735;42158;42247;44820;33953;36700.44949325709;37448.502059918384;39066.609333907436;39271;28469.288267792643;28598.42803143967;28621.856890715415;28874.27814304659;29018 22:49:07 INFO - PROCESS | 15793 | |2;jquery.html;388.4154347706703;393.8483683781744;395.8950878017324;404.19968462444353;417.6450017485138;18046.5488362791;18543.81456185438;19512.121954512062;19531.316403925866;19534.609307813836;18116.728249076274;18169.636607267847;18291.359802406918;19048.809511904878;19255.22979080835;5673.971630141844;5731.856703582413;5830.979578573754;5832;5938.851528711795;5782.681952492611;5800.245968024151;5814.941850581482;5833.941660583403;5854.29748430189;5597.44025597439;5748.511376533;5780.219670344512;5797.072468405056;5821.796237131702;5625.578081643852;5742.626729262584;5804.738786754606;5815.098659707731;5831.212786273841;5126.897716990828;5226.55574276187;5226.92159617606;5232.947670523322;5239.1093514102695;22318.553628927493;22412.43968900774;22639.660405093935;23139.652905206436;23157.768422315898;2213.6347502662043;2285.4514916420108;2292.358139720864;2353.9411514712097;2439.2682195341326;13375.398107085204;13569.796453053212;13625.318734063356;13748.450061997508;14236;1950.600126973967;1962.6957821537685;1993.6610776168086;1998.7601487821555;2026.9493262668552;77885;78764.21235787684;79101;79989.60005199937;80174.19825801784;10058.899411005796;10276.897231027595;10341.689749307532;10540.789184216273;10678.786424271471;14147.080439771382;14265.572032838823;14321.283935803169;14323.92838035824;14355.78466323006;7160.319769621878;7542.208068152765;7605.619719014027;7636.923630763621;7646.197149299354;6926.930730692729;6983.336583024605;7149.571025738473;7184.389326907271;7259.6007219603425;6158.445739883342;6280.309165991737;6361.427471527585;6373.075903993895;6493.70778314977;1886.669832779258;1890.8298253157282;1915.990420047891;1938.6801177805505;1938.6898096304524;918.5085979001202;1018.5721996761378;1045.7856139491387;1050.2438244463974;1054.7468607534136;19256.903715481334;19551.315703950295;19942.302019429542;19992.90003550002;20044.69932951007;1067.765091679829;1069.4011353641986;1091.3233795046963;1099.8185299425666;1102.1348241630442;10877.205261131983;11479.426028698532;11541.422928853524;11551.306921584732;11581.305121692725;526138;528435;535452;538490;550043;79267;80018;80250.59874700589;81194;81893.59053204815;1034.7723500829957;1060.0883240413393;1065.680295911239;1075.3655343347461;1087.3258579680648;17562;17571.56071098233;17922.5519362017;18081.18634661417;18273.451796446127;38625.80687096546;39046.21907561776;39499.60500394959;40333.99999999883;40604;52538.474615253355;53077.7346113267;53243.73378133085;53656.46343536515;53709;7889.526628402315;8848.823023539622;8985.550722463982;9046.773830654023;9138.68014619485;13320.134191277535;13328.733425331246;13424.597262082154;13830.930845345709;14013.719725605228;11247.943760281147;11287;11345.886541134483;11756.294622322688;12160.695982600506;11685.415729213335;11735.530578776754;11765.588204412805;11800.940995294968;12287.877121228674;12032.338221397908;12062.698432539257;12183.390830458264;12301.200421972542;12368.628941131781;8827.470351778913;8920;8925;8975.685850995184;9025.954870225607;12094.153409261267;12145.089118315986;12172.75654486923;12250.142490025613;12406 22:49:07 INFO - PROCESS | 15793 | |3;mootools.html;1478.2904205981133;1516.886233532485;1684.7051765940957;1826.7625208722864;1844.9631007379844;7732.420068494871;8528.91471085289;8560.486370817747;9164.358494905351;9177.08229177082;8653.394262401634;8921.420107692995;8967.551622418885;9006.054364291736;9006.32452566057;2270.7842754938297;2297.0467256088705;2301.919432819852;2311.075569772096;2315.131825565413;2236.340279617517;2268.3761965459466;2326.999390262187;2330.149495434171;2335.684682567857;2275.7155355580553;2292.942676433086;2301.2290882554366;2338.2283846330756;2361.586722323595;2242.4842286274084;2285.1202287119495;2317.073170731704;2317.4669825940045;2323.2217207235512;2305.4121199094125;2314.7916687498036;2319.605667036608;2347.483553618218;2353.199912029918;8873.778155546162;8967.01362850086;9032.683856065072;9056.275497960147;9077.591508382138;5129.051125541787;5244.39689435716;5245.082110630625;5253.7635806388425;5258.894822103536;3175.063356309894;3258.0877354340587;3369.2250782319957;3390.643982381839;3404.710599599037;1046.8220402531513;1057.9047885690325;1103.3545375954996;1126.2397881430084;1132.7564573616712;12458.937705311506;12479;12499.937500312531;12534.74930501385;12549.247045177228;4523.5928766410525;4523.886902827456;4638.884027899329;4655.95344046562;4658.068386322749;10648.520816563274;10691.198160138021;10694.73263168427;10736.677899663022;10747.301425407324;5228.6339956203465;5247.081760691864;5260.500252476008;5274.182501712241;5298.867528311823;4246.808893599734;4738.810447582127;4772.331873537708;4855.004724031565;4874.512548745168;3969.4641223435046;4029.2545879012478;4036.5761595032686;4135.276326642826;4275.358696195595;1244.172625204229;1248.219862585884;1251.7044858571517;1272.3956120842527;1281.2248589603155;1022.2282176956498;1037.444966942682;1039.620538503456;1045.9110975567162;1060.2790102730216;6100.328963813977;6157.322694503601;6186.81439556814;6324.494040476751;6371.426571608577;955.9761005974906;991.4794732765356;1017.659084206799;1021.4433133942019;1057.4131357096885;4273.743575385424;4341.9131617367475;4398.69209155356;4425.09285596452;4429.180601588717;10517.84223236652;10858.891411085788;11228.943855280671;11233.38216398106;11288.71778205535;10854.403007834644;11101.666949991513;11111.166662500184;11234.38210898392;11270.94364528172;8316.334693224528;8488.490690558587;8491.95754021226;8522.70170544028;8545.82908341842;5917.940820591911;6170.660613666291;6200.3179650237535;6203.534734894811;6206.782762603287;10072.194224462171;10456.26806123564;10636.255462117577;10651.414172220602;10752.247342685936;10539.894601053891;10656.946715266375;10668.146548276274;10677.359358438518;10684.519196636325;7087.291270872872;7656;7929.841403172019;7989;8014.679412823655;8914.643414263357;8934.061923498199;8950.104989500998;8959.641614335354;9030.774230644023;7530.585817780075;7698.846023079619;7726.3818894487185;7824;8016.038075430985;7502.324790768857;7583.5070720403;7644.885326719992;7758.68965241384;7887.211278872067;6712.6979285931275;6773.93226067733;6807.149106361705;6818.079559259437;6827.556208846409;4938.30863679078;5009.298698182331;5133.307003554472;5133.8716532087;5153.45888681683;5196.662216955886;5243.606729495379;5255.605829562722;5259.027079990214;5275.446078161738 22:49:07 INFO - PROCESS | 15793 | |4;prototype.html;325.70360971515913;331.6567352789862;338.9762915993699;339.45517444501576;346.08460621655706;5523.321189223228;5599.832005039845;5709.800156994506;5734.598578099534;5771.365149833515;5518.365387980383;5573;5619.943800561993;5628.099504079348;5632.014397480435;4306.935395969047;4338.58783415575;4349.630281426083;4354.216241076605;4355.934660980088;4103.958960410402;4213.262679031172;4271.6155546000855;4289.656827453796;4294.453996561236;4230.4500414946015;4250.192463431954;4258.212230737324;4265.7014009019385;4274.4229529013655;4250.851220207293;4297.548757380492;4307.396964424983;4323.092150648367;4333.804978775963;3555.3422616815715;3749.4000959846567;3753.1930634913624;3765.5293088363956;3799.7530160539477;5411.945880541183;5456.181572764078;5462.770876552783;5468.7539060742365;5486.588505862076;4917.188663870457;4919.532644398776;4933.125412343286;4936.4076310842565;4966.230234313687;5588.6646801192055;5849.151872978437;5878.206442130343;5911.142884281755;5915.556333275022;4138.979305103485;4148.23257697327;4149.107941792529;4161.271777438936;4171.791410429466;5922.58541902067;6096.939030609681;6139.386061393825;6145.324014358462;6146.787156623612;4168.124693814333;4180.7909604519655;4193.18232944579;4193.706440549132;4204.306289462265;4248.893777655583;4261.934516370908;4270.210011147948;4282.5867463736895;4287;4913.484084171182;4947.678400904002;4961.677490963076;4965.981973695384;4980.203167493184;5579.637323573955;5820.293563492996;5858.414158584193;5860.824175274749;5922.3485416604135;1477.9113253204841;1497.139144991634;1498.5204734485078;1499.8200215973934;1505.6386467248;934.9719508414759;943.5895385507326;948.7770373962113;957.9664711735056;959.0505399654292;5046.621503387188;5111.7699703513435;5657.472482429721;5832.241808564944;5861.120831875252;6095.878082438327;6169.167162433104;6179.69101544921;6195;6195.344746599438;5530.308711411074;5762.942370576325;5767.452092051249;5808.332041815161;5838.671956984563;3206.470932296145;3213.501907204387;3231.691165078147;3243.772935894465;3249.2039450334346;6300.8424789379715;6361.332060133712;6365.52258580599;6377.457916077093;6385.616862988142;6101.60339577926;6161.977087915877;6217.9689101555105;6227.875442491125;6228.719707613078;6273.65494897785;6278.748850046039;6345.302016778151;6348.77779277723;6351.68241587928;5909.261342332208;6091.847703807441;6094.628708540543;6130;6186.721597528032;6032.6983650818165;6079.179310792986;6091.573589848846;6099.542534310033;6134.938650613437;5983.401659833982;6202.968985155046;6268.529860260407;6351.2696039956;6382.712777925098;4249;4255.5531669175525;4260.680448966402;4277.272863613255;4297.140571885573;6091.7258723358445;6169.691515424301;6178.382161783786;6191.5665903388135;6213.689315534115;5801.912971305518;5894.6757928314355;5905.173275741486;6026.427489388501;6040.546958978006;5887.52899768009;5932.228810254639;5932.317783454958;5954.3152537458745;5994.460498555151;5768.855778605568;5804.65172089676;5814.767409303749;5830.62100963436;5857.58996870215;5702.344230413555;5948.970255148696;5964.866675331673;6007.8197654070445;6031.517478601789;5864.648121112747;5882.941170588239;5964.970175149097;5968.22413086296;5986.521078313637 22:49:07 INFO - PROCESS | 15793 | |5;yui.html;684.5789839248863;709.8757717399454;761.4936067515102;804.8229389534303;834.6494472321626;13688.863111368883;14016.789748153786;14332.498362557313;14408.423663053465;14447.927760361183;12795.936020319885;12850.678733031678;12854.48582056719;13637.908967282618;13763.587092387219;792.1523969352809;803.6102490292203;804.9396295277849;805.6696754330726;805.7502174325948;782.0849605961039;799.5003123048095;807.2815194476921;808.5068108453868;808.6159074439623;835.9749207523754;839.2111415269658;842.2251528593678;846.3863698818369;846.8645016797313;834.9916500835005;836.4479443567217;836.9246767790928;838.5429940682374;840.2899549880341;606.5784279925454;608.4402349838159;608.966506842128;611.9112728654364;613.1109890658519;14361.640958976004;14467.348969296301;14484.493042743454;14513.927430362886;14530.709385812224;13029.804552931713;13192.142510736772;13200;13210.603681889463;13451.932740336235;10738.409387483685;10906.5092070857;10923.071538919201;11003;11331.37677427741;3748.11919198988;3751.456038874348;3782.432635104729;3788.772673639563;3804.524434445694;74856.62571687161;75717.62141189314;76369.99999999945;76401.61799191024;77040;10814.243002989873;10879.347239165676;10965.232433729563;10976.945115274373;11008.39453830031;20862.478438038866;21437.785622143892;21499.892500537397;21519.78480215178;21604.89197554002;8095.595220239083;8373.539455330016;8397.580120994047;8519.105493923173;8547.316214702809;4739.881502962454;4740.312654665055;4745.525447455296;4827.42070951488;4920.040592084509;3544.486049522805;3621.3662609043313;3648.927021459556;3649.61679023704;3678.5401824771902;628.7359309090101;651.9152510173647;660.1484085529709;663.2571519897746;676.1379241467071;643.3887806583764;707.7558242406361;725.6734469488752;728.8615163118991;743.2901578992049;9213.401128926598;9341.813163736688;9562.153500084582;9784.706458806248;9843.116903854174;698.3644883156303;728.7121586973116;730.831908661011;741.9035525381773;766.5209244222361;4177.874663760092;4213.852515162016;4235.78821058952;4300.440942677432;4326.134773045404;68256;82184;111994.44002779934;115733;116044.2966777495;61591.69204153951;78357.60821195858;82915.5854220725;86999;99006;84606.57696711477;85558.57220713857;86150.56924715462;86537.13462865417;86834.1316586826;8244.258016778518;8266;8327.292180164512;8382.58087095655;8458.238758511763;50666.240006399195;51939.740301298254;51976.48023519717;52592.737036314575;53093.4690653104;70343.64828175826;73295;74538.25461745313;74573.62713186616;76870.6156469214;10622.521986510472;11042.889571104508;11079.046797369912;11093.5562577496;11207.943960280147;11877.58428455;11882.46528906184;12100.939495302468;12148.939255303667;12557.937210314256;10980.835287470534;11189.440527973731;11359.091272697999;11842.46708898119;11892.881071189177;10810.459477026274;11086.501107450023;11108.722281943015;11629.825552616549;12162;9911.702648920544;10064.245181611555;10675.412852293199;10861.565537378416;10896.564137434414;9633.732996879327;9656.37233579815;9794.608215671293;9929.65246216379;9962.452065136487;9304.72085837426;9942.15491683215;9950.402975821475;9975.20198384113;9976.15202707778 22:49:07 INFO - PROCESS | 15793 | __end_tp_report 22:49:07 INFO - PROCESS | 15793 | __start_cc_report 22:49:07 INFO - PROCESS | 15793 | _x_x_mozilla_cycle_collect,347 22:49:07 INFO - PROCESS | 15793 | __end_cc_report 22:49:07 INFO - PROCESS | 15793 | __startTimestamp1465105747320__endTimestamp 22:49:07 INFO - PROCESS | 15793 | 22:49:07 INFO - PROCESS | 15793 | ------- Summary: start ------- 22:49:07 INFO - PROCESS | 15793 | Number of tests: 6 22:49:07 INFO - PROCESS | 15793 | 22:49:07 INFO - PROCESS | 15793 | [#0] dojo.html Cycles:165 Average:5406.68 Median:5622.58 stddev:734.53 (13.1%) stddev-sans-first:714.09 22:49:07 INFO - PROCESS | 15793 | Values: 3097.5 3176.5 3186.6 3194.1 3203.6 5428.9 5463.3 5484.6 5539.1 5546.8 5282.2 5416.8 5498.6 5511.4 5520.3 4955.5 4996.3 5086.4 5134.6 5188.1 523.8 4849.4 4914.2 4937.4 5090.1 4923.1 4974.0 4994.4 5004.5 5007.1 4920.2 4944.3 4980.3 4997.3 5016.0 4876.6 4920.3 4922.8 4936.6 4936.9 5327.9 5397.5 5401.3 5404.0 5406.3 5578.4 5618.2 5855.3 5867.6 5909.4 5879.9 5880.5 5893.9 5919.7 5955.6 5449.7 5484.1 5492.5 5493.9 5517.8 5785.2 5965.6 6007.9 6051.9 6069.9 5734.6 5767.7 5775.3 5793.7 5843.8 5837.4 5854.2 5857.4 5867.4 5878.1 5554.8 5819.9 5847.9 5848.6 5861.2 5861.3 5893.6 5897.0 5919.6 5939.6 4399.5 4439.7 4460.4 4462.6 4480.6 3850.2 3875.6 3890.9 3897.4 3967.9 5518.0 5519.9 5539.0 5543.4 5596.9 5873.2 5902.5 5906.0 5908.9 5915.6 5373.5 5511.8 5553.2 5579.4 5589.4 5038.5 5050.3 5060.3 5069.2 5071.8 6075.8 6076.0 6076.2 6092.0 6133.2 5646.7 5674.4 5676.9 5816.2 5870.4 6095.8 6102.2 6105.5 6138.2 6141.6 5832.4 5834.2 5837.4 5842.7 5851.9 5610.7 5815.2 5851.2 5853.5 5938.8 5696.4 5732.4 5735.8 5750.7 5764.3 5702.9 5738.8 5741.5 5754.7 5760.0 5495.3 5518.4 5585.4 5622.6 5643.4 5742.7 5768.7 5789.8 5790.7 5795.8 5648.8 5649.2 5660.7 5663.7 5667.3 22:49:07 INFO - PROCESS | 15793 | 22:49:07 INFO - PROCESS | 15793 | [#1] ext.html Cycles:180 Average:63209.24 Median:42106.68 stddev:131483.90 (312.3%) stddev-sans-first:131768.65 22:49:07 INFO - PROCESS | 15793 | Values: 577.6 601.7 619.4 639.2 641.2 32260.4 42412.6 43502.0 43811.8 43849.3 42194.8 42221.0 42440.8 42523.8 42537.0 8636.5 8853.0 8871.6 8881.0 8888.6 8580.1 8693.3 8695.8 8698.0 8719.6 8612.3 8702.1 8765.7 8768.7 8782.4 8626.6 8703.7 8711.5 8732.4 8742.7 8700.0 8750.0 8809.7 8816.8 8821.2 41580.4 42055.4 42415.6 42467.0 42478.4 3431.7 3461.3 3586.9 3970.9 4230.7 32075.8 32540.7 32820.7 32880.5 33498.3 4297.6 4403.3 4413.8 4539.1 4587.6 359380.0 360518.0 361606.0 361684.0 361945.0 60361.0 60510.7 60856.0 60991.7 61215.4 34538.0 35905.8 36419.6 38420.8 38487.4 15693.7 15720.4 15836.7 15860.0 15869.3 13393.8 13459.1 13475.0 13509.5 13513.7 19397.9 19435.8 19513.9 19544.2 19572.8 7273.2 7277.7 7301.9 7431.9 7458.3 986.3 987.7 1021.9 1097.0 1117.9 32303.2 32774.3 32919.0 33032.5 33032.5 1105.0 1122.9 1140.8 1158.1 1222.6 16841.3 17023.2 17193.7 17242.0 17396.7 607872.0 609269.0 610940.0 613106.0 613487.2 57217.7 57999.0 58395.4 58490.7 58806.7 1332.3 1379.1 1380.7 1387.0 1390.0 30824.5 31474.2 31896.0 31953.7 32261.4 50153.2 50490.2 50615.2 50715.5 50860.2 469800.0 475097.0 478107.0 479502.0 482456.0 27803.4 28187.2 28189.3 28252.4 28340.6 47900.0 48247.0 48581.0 48897.8 49369.5 40415.2 40628.8 41569.6 41658.8 42403.0 41148.0 41604.4 41645.6 41722.8 41920.4 40991.0 41053.8 42158.0 42247.0 44820.0 33953.0 36700.4 37448.5 39066.6 39271.0 28469.3 28598.4 28621.9 28874.3 29018.0 22:49:07 INFO - PROCESS | 15793 | 22:49:07 INFO - PROCESS | 15793 | [#2] jquery.html Cycles:180 Average:29840.21 Median:22365.50 stddev:87798.62 (392.6%) stddev-sans-first:88017.06 22:49:07 INFO - PROCESS | 15793 | Values: 388.4 393.8 395.9 404.2 417.6 18046.5 18543.8 19512.1 19531.3 19534.6 18116.7 18169.6 18291.4 19048.8 19255.2 5674.0 5731.9 5831.0 5832.0 5938.9 5782.7 5800.2 5814.9 5833.9 5854.3 5597.4 5748.5 5780.2 5797.1 5821.8 5625.6 5742.6 5804.7 5815.1 5831.2 5126.9 5226.6 5226.9 5232.9 5239.1 22318.6 22412.4 22639.7 23139.7 23157.8 2213.6 2285.5 2292.4 2353.9 2439.3 13375.4 13569.8 13625.3 13748.5 14236.0 1950.6 1962.7 1993.7 1998.8 2026.9 77885.0 78764.2 79101.0 79989.6 80174.2 10058.9 10276.9 10341.7 10540.8 10678.8 14147.1 14265.6 14321.3 14323.9 14355.8 7160.3 7542.2 7605.6 7636.9 7646.2 6926.9 6983.3 7149.6 7184.4 7259.6 6158.4 6280.3 6361.4 6373.1 6493.7 1886.7 1890.8 1916.0 1938.7 1938.7 918.5 1018.6 1045.8 1050.2 1054.7 19256.9 19551.3 19942.3 19992.9 20044.7 1067.8 1069.4 1091.3 1099.8 1102.1 10877.2 11479.4 11541.4 11551.3 11581.3 526138.0 528435.0 535452.0 538490.0 550043.0 79267.0 80018.0 80250.6 81194.0 81893.6 1034.8 1060.1 1065.7 1075.4 1087.3 17562.0 17571.6 17922.6 18081.2 18273.5 38625.8 39046.2 39499.6 40334.0 40604.0 52538.5 53077.7 53243.7 53656.5 53709.0 7889.5 8848.8 8985.6 9046.8 9138.7 13320.1 13328.7 13424.6 13830.9 14013.7 11247.9 11287.0 11345.9 11756.3 12160.7 11685.4 11735.5 11765.6 11800.9 12287.9 12032.3 12062.7 12183.4 12301.2 12368.6 8827.5 8920.0 8925.0 8975.7 9026.0 12094.2 12145.1 12172.8 12250.1 12406.0 22:49:07 INFO - PROCESS | 15793 | 22:49:07 INFO - PROCESS | 15793 | [#3] mootools.html Cycles:180 Average:5897.43 Median:4370.30 stddev:3383.22 (77.4%) stddev-sans-first:3376.41 22:49:07 INFO - PROCESS | 15793 | Values: 1478.3 1516.9 1684.7 1826.8 1845.0 7732.4 8528.9 8560.5 9164.4 9177.1 8653.4 8921.4 8967.6 9006.1 9006.3 2270.8 2297.0 2301.9 2311.1 2315.1 2236.3 2268.4 2327.0 2330.1 2335.7 2275.7 2292.9 2301.2 2338.2 2361.6 2242.5 2285.1 2317.1 2317.5 2323.2 2305.4 2314.8 2319.6 2347.5 2353.2 8873.8 8967.0 9032.7 9056.3 9077.6 5129.1 5244.4 5245.1 5253.8 5258.9 3175.1 3258.1 3369.2 3390.6 3404.7 1046.8 1057.9 1103.4 1126.2 1132.8 12458.9 12479.0 12499.9 12534.7 12549.2 4523.6 4523.9 4638.9 4656.0 4658.1 10648.5 10691.2 10694.7 10736.7 10747.3 5228.6 5247.1 5260.5 5274.2 5298.9 4246.8 4738.8 4772.3 4855.0 4874.5 3969.5 4029.3 4036.6 4135.3 4275.4 1244.2 1248.2 1251.7 1272.4 1281.2 1022.2 1037.4 1039.6 1045.9 1060.3 6100.3 6157.3 6186.8 6324.5 6371.4 956.0 991.5 1017.7 1021.4 1057.4 4273.7 4341.9 4398.7 4425.1 4429.2 10517.8 10858.9 11228.9 11233.4 11288.7 10854.4 11101.7 11111.2 11234.4 11270.9 8316.3 8488.5 8492.0 8522.7 8545.8 5917.9 6170.7 6200.3 6203.5 6206.8 10072.2 10456.3 10636.3 10651.4 10752.2 10539.9 10656.9 10668.1 10677.4 10684.5 7087.3 7656.0 7929.8 7989.0 8014.7 8914.6 8934.1 8950.1 8959.6 9030.8 7530.6 7698.8 7726.4 7824.0 8016.0 7502.3 7583.5 7644.9 7758.7 7887.2 6712.7 6773.9 6807.1 6818.1 6827.6 4938.3 5009.3 5133.3 5133.9 5153.5 5196.7 5243.6 5255.6 5259.0 5275.4 22:49:07 INFO - PROCESS | 15793 | 22:49:07 INFO - PROCESS | 15793 | [#4] prototype.html Cycles:180 Average:4958.05 Median:5748.77 stddev:1495.09 (26.0%) stddev-sans-first:1458.30 22:49:07 INFO - PROCESS | 15793 | Values: 325.7 331.7 339.0 339.5 346.1 5523.3 5599.8 5709.8 5734.6 5771.4 5518.4 5573.0 5619.9 5628.1 5632.0 4306.9 4338.6 4349.6 4354.2 4355.9 4104.0 4213.3 4271.6 4289.7 4294.5 4230.5 4250.2 4258.2 4265.7 4274.4 4250.9 4297.5 4307.4 4323.1 4333.8 3555.3 3749.4 3753.2 3765.5 3799.8 5411.9 5456.2 5462.8 5468.8 5486.6 4917.2 4919.5 4933.1 4936.4 4966.2 5588.7 5849.2 5878.2 5911.1 5915.6 4139.0 4148.2 4149.1 4161.3 4171.8 5922.6 6096.9 6139.4 6145.3 6146.8 4168.1 4180.8 4193.2 4193.7 4204.3 4248.9 4261.9 4270.2 4282.6 4287.0 4913.5 4947.7 4961.7 4966.0 4980.2 5579.6 5820.3 5858.4 5860.8 5922.3 1477.9 1497.1 1498.5 1499.8 1505.6 935.0 943.6 948.8 958.0 959.1 5046.6 5111.8 5657.5 5832.2 5861.1 6095.9 6169.2 6179.7 6195.0 6195.3 5530.3 5762.9 5767.5 5808.3 5838.7 3206.5 3213.5 3231.7 3243.8 3249.2 6300.8 6361.3 6365.5 6377.5 6385.6 6101.6 6162.0 6218.0 6227.9 6228.7 6273.7 6278.7 6345.3 6348.8 6351.7 5909.3 6091.8 6094.6 6130.0 6186.7 6032.7 6079.2 6091.6 6099.5 6134.9 5983.4 6203.0 6268.5 6351.3 6382.7 4249.0 4255.6 4260.7 4277.3 4297.1 6091.7 6169.7 6178.4 6191.6 6213.7 5801.9 5894.7 5905.2 6026.4 6040.5 5887.5 5932.2 5932.3 5954.3 5994.5 5768.9 5804.7 5814.8 5830.6 5857.6 5702.3 5949.0 5964.9 6007.8 6031.5 5864.6 5882.9 5965.0 5968.2 5986.5 22:49:07 INFO - PROCESS | 15793 | 22:49:07 INFO - PROCESS | 15793 | [#5] yui.html Cycles:180 Average:19235.14 Median:612.51 stddev:27778.98 (4535.3%) stddev-sans-first:27821.98 22:49:07 INFO - PROCESS | 15793 | Values: 684.6 709.9 761.5 804.8 834.6 13688.9 14016.8 14332.5 14408.4 14447.9 12795.9 12850.7 12854.5 13637.9 13763.6 792.2 803.6 804.9 805.7 805.8 782.1 799.5 807.3 808.5 808.6 836.0 839.2 842.2 846.4 846.9 835.0 836.4 836.9 838.5 840.3 606.6 608.4 609.0 611.9 613.1 14361.6 14467.3 14484.5 14513.9 14530.7 13029.8 13192.1 13200.0 13210.6 13451.9 10738.4 10906.5 10923.1 11003.0 11331.4 3748.1 3751.5 3782.4 3788.8 3804.5 74856.6 75717.6 76370.0 76401.6 77040.0 10814.2 10879.3 10965.2 10976.9 11008.4 20862.5 21437.8 21499.9 21519.8 21604.9 8095.6 8373.5 8397.6 8519.1 8547.3 4739.9 4740.3 4745.5 4827.4 4920.0 3544.5 3621.4 3648.9 3649.6 3678.5 628.7 651.9 660.1 663.3 676.1 643.4 707.8 725.7 728.9 743.3 9213.4 9341.8 9562.2 9784.7 9843.1 698.4 728.7 730.8 741.9 766.5 4177.9 4213.9 4235.8 4300.4 4326.1 68256.0 82184.0 111994.4 115733.0 116044.3 61591.7 78357.6 82915.6 86999.0 99006.0 84606.6 85558.6 86150.6 86537.1 86834.1 8244.3 8266.0 8327.3 8382.6 8458.2 50666.2 51939.7 51976.5 52592.7 53093.5 70343.6 73295.0 74538.3 74573.6 76870.6 10622.5 11042.9 11079.0 11093.6 11207.9 11877.6 11882.5 12100.9 12148.9 12557.9 10980.8 11189.4 11359.1 11842.5 11892.9 10810.5 11086.5 11108.7 11629.8 12162.0 9911.7 10064.2 10675.4 10861.6 10896.6 9633.7 9656.4 9794.6 9929.7 9962.5 9304.7 9942.2 9950.4 9975.2 9976.2 22:49:07 INFO - PROCESS | 15793 | -------- Summary: end -------- 22:49:07 INFO - PROCESS | 15793 | 22:49:07 INFO - TEST-INFO | 15793: exit 0 22:49:08 INFO - TEST-OK | dromaeo_css | took 1109685ms 22:49:08 INFO - TEST-START | kraken 22:49:08 INFO - operating with platform_type : linux_ 22:49:08 INFO - Initialising browser for kraken test... 22:49:08 INFO - TEST-INFO | started process 16020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9hckkZ/profile http://localhost:51791/getInfo.html) 22:49:12 INFO - PROCESS | 16020 | __metrics Screen width/height:1600/1200 22:49:12 INFO - PROCESS | 16020 | colorDepth:24 22:49:12 INFO - PROCESS | 16020 | Browser inner width/height: 1024/697 22:49:12 INFO - PROCESS | 16020 | __metrics 22:49:12 ERROR - PROCESS | 16020 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 22:49:13 INFO - TEST-INFO | 16020: exit 0 22:49:13 INFO - Browser initialized. 22:49:13 INFO - Running cycle 1/1 for kraken test... 22:49:13 INFO - TEST-INFO | started process 16139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9hckkZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:49:25 INFO - PROCESS | 16139 | RSS: Main: 167239680 22:49:25 INFO - PROCESS | 16139 | 22:49:28 INFO - PROCESS | 16139 | Cycle 1(1): loaded http://localhost:51791/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51791/tests/kraken/driver.html?testName=audio-beat-detection) 22:49:28 INFO - PROCESS | 16139 | RSS: Main: 173039616 22:49:28 INFO - PROCESS | 16139 | 22:49:31 INFO - PROCESS | 16139 | Cycle 1(1): loaded http://localhost:51791/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51791/tests/kraken/driver.html?testName=audio-dft) 22:49:32 INFO - PROCESS | 16139 | RSS: Main: 171270144 22:49:32 INFO - PROCESS | 16139 | 22:49:35 INFO - PROCESS | 16139 | Cycle 1(1): loaded http://localhost:51791/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51791/tests/kraken/driver.html?testName=audio-fft) 22:49:35 INFO - PROCESS | 16139 | RSS: Main: 166862848 22:49:35 INFO - PROCESS | 16139 | 22:49:37 INFO - PROCESS | 16139 | Cycle 1(1): loaded http://localhost:51791/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51791/tests/kraken/driver.html?testName=audio-oscillator) 22:49:38 INFO - PROCESS | 16139 | RSS: Main: 167243776 22:49:38 INFO - PROCESS | 16139 | 22:49:40 INFO - PROCESS | 16139 | Cycle 1(1): loaded http://localhost:51791/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51791/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:49:41 INFO - PROCESS | 16139 | RSS: Main: 168108032 22:49:41 INFO - PROCESS | 16139 | 22:49:44 INFO - PROCESS | 16139 | Cycle 1(1): loaded http://localhost:51791/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51791/tests/kraken/driver.html?testName=imaging-darkroom) 22:49:45 INFO - PROCESS | 16139 | RSS: Main: 167911424 22:49:45 INFO - PROCESS | 16139 | 22:49:48 INFO - PROCESS | 16139 | Cycle 1(1): loaded http://localhost:51791/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51791/tests/kraken/driver.html?testName=imaging-desaturate) 22:49:49 INFO - PROCESS | 16139 | RSS: Main: 168493056 22:49:49 INFO - PROCESS | 16139 | 22:49:51 INFO - PROCESS | 16139 | Cycle 1(1): loaded http://localhost:51791/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51791/tests/kraken/driver.html?testName=json-parse-financial) 22:49:52 INFO - PROCESS | 16139 | RSS: Main: 168067072 22:49:52 INFO - PROCESS | 16139 | 22:49:54 INFO - PROCESS | 16139 | Cycle 1(1): loaded http://localhost:51791/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51791/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:49:54 INFO - PROCESS | 16139 | RSS: Main: 167931904 22:49:54 INFO - PROCESS | 16139 | 22:49:56 INFO - PROCESS | 16139 | Cycle 1(1): loaded http://localhost:51791/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51791/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:49:57 INFO - PROCESS | 16139 | RSS: Main: 167993344 22:49:57 INFO - PROCESS | 16139 | 22:49:59 INFO - PROCESS | 16139 | Cycle 1(1): loaded http://localhost:51791/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51791/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:49:59 INFO - PROCESS | 16139 | RSS: Main: 169250816 22:49:59 INFO - PROCESS | 16139 | 22:50:02 INFO - PROCESS | 16139 | Cycle 1(1): loaded http://localhost:51791/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:50:03 INFO - PROCESS | 16139 | RSS: Main: 169775104 22:50:03 INFO - PROCESS | 16139 | 22:50:06 INFO - PROCESS | 16139 | Cycle 1(1): loaded http://localhost:51791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:50:06 INFO - PROCESS | 16139 | RSS: Main: 169390080 22:50:06 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | Cycle 1(1): loaded http://localhost:51791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51791/tests/kraken/driver.html?testName=ai-astar) 22:50:08 INFO - PROCESS | 16139 | RSS: Main: 170127360 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | __start_tp_report 22:50:08 INFO - PROCESS | 16139 | _x_x_mozilla_page_load 22:50:08 INFO - PROCESS | 16139 | _x_x_mozilla_page_load_details 22:50:08 INFO - PROCESS | 16139 | |i|pagename|runs| 22:50:08 INFO - PROCESS | 16139 | |0;ai-astar;109;106;110;110;112;112;111;110;110;108 22:50:08 INFO - PROCESS | 16139 | |1;audio-beat-detection;157;130;157;169;134;157;156;132;177;126 22:50:08 INFO - PROCESS | 16139 | |2;audio-dft;162;162;161;162;162;164;173;163;162;163 22:50:08 INFO - PROCESS | 16139 | |3;audio-fft;75;75;74;150;76;76;75;77;159;76 22:50:08 INFO - PROCESS | 16139 | |4;audio-oscillator;90;88;154;85;87;85;151;84;86;147 22:50:08 INFO - PROCESS | 16139 | |5;imaging-gaussian-blur;117;118;118;117;118;117;118;117;117;117 22:50:08 INFO - PROCESS | 16139 | |6;imaging-darkroom;148;148;148;147;148;150;146;147;147;147 22:50:08 INFO - PROCESS | 16139 | |7;imaging-desaturate;96;95;95;95;97;96;95;95;95;96 22:50:08 INFO - PROCESS | 16139 | |8;json-parse-financial;53;55;55;53;62;54;53;55;54;54 22:50:08 INFO - PROCESS | 16139 | |9;json-stringify-tinderbox;62;62;62;62;62;62;67;63;62;61 22:50:08 INFO - PROCESS | 16139 | |10;stanford-crypto-aes;85;79;82;80;86;83;86;81;110;86 22:50:08 INFO - PROCESS | 16139 | |11;stanford-crypto-ccm;142;123;138;127;128;150;142;146;150;129 22:50:08 INFO - PROCESS | 16139 | |12;stanford-crypto-pbkdf2;167;165;164;173;161;167;166;166;162;165 22:50:08 INFO - PROCESS | 16139 | |13;stanford-crypto-sha256-iterative;64;62;63;63;65;64;64;66;63;65 22:50:08 INFO - PROCESS | 16139 | __end_tp_report 22:50:08 INFO - PROCESS | 16139 | __start_cc_report 22:50:08 INFO - PROCESS | 16139 | _x_x_mozilla_cycle_collect,901 22:50:08 INFO - PROCESS | 16139 | __end_cc_report 22:50:08 INFO - PROCESS | 16139 | __startTimestamp1465105808553__endTimestamp 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | ------- Summary: start ------- 22:50:08 INFO - PROCESS | 16139 | Number of tests: 14 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:1.81 (1.6%) stddev-sans-first:1.90 22:50:08 INFO - PROCESS | 16139 | Values: 109.0 106.0 110.0 110.0 112.0 112.0 111.0 110.0 110.0 108.0 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:157.00 stddev:17.72 (11.3%) stddev-sans-first:18.59 22:50:08 INFO - PROCESS | 16139 | Values: 157.0 130.0 157.0 169.0 134.0 157.0 156.0 132.0 177.0 126.0 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | [#2] audio-dft Cycles:10 Average:163.40 Median:162.50 stddev:3.47 (2.1%) stddev-sans-first:3.64 22:50:08 INFO - PROCESS | 16139 | Values: 162.0 162.0 161.0 162.0 162.0 164.0 173.0 163.0 162.0 163.0 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | [#3] audio-fft Cycles:10 Average:91.30 Median:75.50 stddev:33.39 (44.2%) stddev-sans-first:34.89 22:50:08 INFO - PROCESS | 16139 | Values: 75.0 75.0 74.0 150.0 76.0 76.0 75.0 77.0 159.0 76.0 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | [#4] audio-oscillator Cycles:10 Average:105.70 Median:85.50 stddev:31.12 (36.4%) stddev-sans-first:32.49 22:50:08 INFO - PROCESS | 16139 | Values: 90.0 88.0 154.0 85.0 87.0 85.0 151.0 84.0 86.0 147.0 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:50:08 INFO - PROCESS | 16139 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 22:50:08 INFO - PROCESS | 16139 | Values: 148.0 148.0 148.0 147.0 148.0 150.0 146.0 147.0 147.0 147.0 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 22:50:08 INFO - PROCESS | 16139 | Values: 96.0 95.0 95.0 95.0 97.0 96.0 95.0 95.0 95.0 96.0 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:2.66 (4.9%) stddev-sans-first:2.74 22:50:08 INFO - PROCESS | 16139 | Values: 53.0 55.0 55.0 53.0 62.0 54.0 53.0 55.0 54.0 54.0 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.00 stddev:1.65 (2.7%) stddev-sans-first:1.74 22:50:08 INFO - PROCESS | 16139 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 67.0 63.0 62.0 61.0 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:84.00 stddev:8.89 (10.6%) stddev-sans-first:9.43 22:50:08 INFO - PROCESS | 16139 | Values: 85.0 79.0 82.0 80.0 86.0 83.0 86.0 81.0 110.0 86.0 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:142.00 stddev:10.05 (7.1%) stddev-sans-first:10.52 22:50:08 INFO - PROCESS | 16139 | Values: 142.0 123.0 138.0 127.0 128.0 150.0 142.0 146.0 150.0 129.0 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:166.00 stddev:3.27 (2.0%) stddev-sans-first:3.43 22:50:08 INFO - PROCESS | 16139 | Values: 167.0 165.0 164.0 173.0 161.0 167.0 166.0 166.0 162.0 165.0 22:50:08 INFO - PROCESS | 16139 | 22:50:08 INFO - PROCESS | 16139 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 22:50:08 INFO - PROCESS | 16139 | Values: 64.0 62.0 63.0 63.0 65.0 64.0 64.0 66.0 63.0 65.0 22:50:08 INFO - PROCESS | 16139 | -------- Summary: end -------- 22:50:08 INFO - PROCESS | 16139 | 22:50:09 INFO - TEST-INFO | 16139: exit 0 22:50:09 INFO - TEST-OK | kraken | took 61447ms 22:50:09 INFO - SUITE-END | took 1171s 22:50:09 INFO - Completed test suite (00:19:31) 22:50:09 INFO - javascript benchmark 22:50:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7293.992636872716, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.4579448596496, 3176.4600017996936, 3186.569813075235, 3194.0737186215997, 3203.631582368027, 5428.864278393037, 5463.262459567962, 5484.643498172621, 5539.058360078786, 5546.77812887485, 5282.2076688496745, 5416.83749487516, 5498.615096943216, 5511.448855114487, 5520.282363292767, 4955.504449555034, 4996.300517927493, 5086.440491545927, 5134.614903882205, 5188.066148093341, 523.8160589895892, 4849.393825771778, 4914.164592019365, 4937.382827146606, 5090.083784918713, 4923.138450771101, 4973.950260497385, 4994.400671919375, 5004.524570165847, 5007.14878470659, 4920.237363208673, 4944.307796908436, 4980.327655766461, 4997.30037794709, 5015.974920125376, 4876.585490233334, 4920.3357546731095, 4922.778474968635, 4936.580390666798, 4936.851894443173, 5327.946720532784, 5397.487238712316, 5401.297831281908, 5404.0, 5406.270153529263, 5578.41426650204, 5618.185363122365, 5855.297364316267, 5867.647941123546, 5909.4090590941, 5879.911801322984, 5880.529557635379, 5893.882122357529, 5919.733611987471, 5955.612885162451, 5449.7275136243425, 5484.067708489566, 5492.533134683556, 5493.917591236134, 5517.779288828482, 5785.190073389729, 5965.552583556164, 6007.879842403127, 6051.939480605226, 6069.908951365733, 5734.598578099493, 5767.711614419262, 5775.27809023872, 5793.681347525927, 5843.766249350064, 5837.416258374129, 5854.151148083504, 5857.414258574194, 5867.413258674099, 5878.11828225761, 5554.750036248379, 5819.941800582024, 5847.853803654858, 5848.61983971049, 5861.1501332307425, 5861.296644402699, 5893.6463812171405, 5897.0269905465975, 5919.585629006015, 5939.643621382731, 4399.5380485049245, 4439.711418757771, 4460.3532487789735, 4462.598366146997, 4480.641548676098, 3850.2299540092095, 3875.5736868944396, 3890.9416358754643, 3897.4348719435525, 3967.900802479903, 5518.0, 5519.862003449946, 5538.972305138448, 5543.445655434505, 5596.916046259309, 5873.177755114202, 5902.468777810018, 5905.966455870205, 5908.881822363529, 5915.615484993462, 5373.489518495737, 5511.834644960658, 5553.222548843165, 5579.38626751057, 5589.441055894378, 5038.546530812245, 5050.3434553507805, 5060.342155519759, 5069.163588008011, 5071.771770270347, 6075.848103797441, 6075.969620151959, 6076.193218773749, 6092.0, 6133.172021777003, 5646.717664116778, 5674.375818660027, 5676.943230567724, 5816.156657284585, 5870.442307980735, 6095.824132198525, 6102.186302349175, 6105.481814251489, 6138.204480310071, 6141.631502109888, 5832.358440571449, 5834.18321435008, 5837.416258374129, 5842.737076831468, 5851.912221316768, 5610.691411972218, 5815.156802263733, 5851.180834683063, 5853.531717462678, 5938.8218353449465, 5696.373398926032, 5732.369439361583, 5735.770569177186, 5750.741216645345, 5764.279465066867, 5702.942970570241, 5738.770449181986, 5741.5406767459335, 5754.68349240779, 5760.020796464527, 5495.2856128703015, 5518.420565840529, 5585.385607583244, 5622.578306626938, 5643.407442218508, 5742.655440673573, 5768.682722450306, 5789.768409263583, 5790.652560846194, 5795.76816927335, 5648.802291919763, 5649.152627105803, 5660.7169641518585, 5663.745131469176, 5667.291588551431], "value": 5358.294094030588, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.6274303074517, 601.6540489218701, 619.4301242856571, 639.1722719078793, 641.2145122225272, 32260.354792904156, 42412.57587424129, 43502.0, 43811.78094109525, 43849.34225986613, 42194.78902605483, 42221.0, 42440.78779606106, 42523.78738106313, 42537.0, 8636.481811091355, 8852.981907080704, 8871.556422178865, 8880.955595222014, 8888.60001299943, 8580.099089595597, 8693.304535637166, 8695.826083478327, 8697.95651021744, 8719.564021798884, 8612.267957223643, 8702.086280940504, 8765.693200737975, 8768.736937891874, 8782.38523303369, 8626.568671566429, 8703.738887833375, 8711.520866352348, 8732.388732788708, 8742.737717868475, 8699.956500217522, 8750.0, 8809.735707928772, 8816.779580510474, 8821.2060914518, 41580.37629435561, 42055.36916946248, 42415.57584424178, 42467.0, 42478.362824557655, 3431.7083047940955, 3461.2904354607244, 3586.8923932282073, 3970.940435893464, 4230.725002874803, 32075.83962080198, 32540.674593254, 32820.671793282236, 32880.50679239813, 33498.330033399194, 4297.613214810682, 4403.273459879116, 4413.823447062114, 4539.114872599845, 4587.587117159472, 359380.0, 360518.0, 361606.0, 361683.9999999974, 361945.0, 60361.0, 60510.69744651337, 60856.0, 60991.695041525396, 61215.38784612186, 34538.0, 35905.82047089748, 36419.63580364215, 38420.807895960344, 38487.422688659695, 15693.686126277411, 15720.371185152695, 15836.683266334609, 15860.0, 15869.33371995947, 13393.799093013613, 13459.125156864968, 13475.0, 13509.459621615222, 13513.662158446117, 19397.90301048514, 19435.79264784654, 19513.899984022963, 19544.24101830842, 19572.804271957382, 7273.197877572082, 7277.745278915212, 7301.926980730124, 7431.925680743231, 7458.328750412489, 986.3440811860032, 987.7481242283316, 1021.8927012663563, 1097.00720847633, 1117.9385133817555, 32303.192420189214, 32774.34451311008, 32919.0, 33032.50451243233, 33032.50451243233, 1104.9944750276197, 1122.8820973797797, 1140.7547377313751, 1158.1487606609135, 1222.614876313976, 16841.32634694623, 17023.233954472078, 17193.65612687739, 17242.045505208767, 17396.739048914278, 607872.0, 609269.0, 610940.0, 613106.0, 613487.1907685553, 57217.71391143101, 57999.0, 58395.41604583985, 58490.70754646199, 58806.7059664699, 1332.253937794838, 1379.0553470872285, 1380.7307575022774, 1387.036009973059, 1389.9513517027058, 30824.537631935986, 31474.213144671565, 31896.0, 31953.68046319507, 32261.354772903942, 50153.24770128524, 50490.2426463596, 50615.240771387726, 50715.49284507108, 50860.23709644284, 469800.0, 475097.0, 478107.0, 479502.0, 482456.0, 27803.44393112167, 28187.15438536847, 28189.295267617654, 28252.43495130045, 28340.574891376233, 47900.0, 48247.0, 48581.0, 48897.75551122222, 49369.50630493649, 40415.191696165326, 40628.79685601553, 41569.58430415778, 41658.79170604127, 42403.0, 41148.0, 41604.37593436161, 41645.58354416417, 41722.791386042874, 41920.3711944315, 40991.0, 41053.79473102735, 42158.0, 42247.0, 44820.0, 33953.0, 36700.44949325709, 37448.502059918384, 39066.609333907436, 39271.0, 28469.288267792643, 28598.42803143967, 28621.856890715415, 28874.27814304659, 29018.0], "value": 20107.58970596502, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.4154347706703, 393.8483683781744, 395.8950878017324, 404.19968462444353, 417.6450017485138, 18046.5488362791, 18543.81456185438, 19512.121954512062, 19531.316403925866, 19534.609307813836, 18116.728249076274, 18169.636607267847, 18291.359802406918, 19048.809511904878, 19255.22979080835, 5673.971630141844, 5731.856703582413, 5830.979578573754, 5832.0, 5938.851528711795, 5782.681952492611, 5800.245968024151, 5814.941850581482, 5833.941660583403, 5854.29748430189, 5597.44025597439, 5748.511376533, 5780.219670344512, 5797.072468405056, 5821.796237131702, 5625.578081643852, 5742.626729262584, 5804.738786754606, 5815.098659707731, 5831.212786273841, 5126.897716990828, 5226.55574276187, 5226.92159617606, 5232.947670523322, 5239.1093514102695, 22318.553628927493, 22412.43968900774, 22639.660405093935, 23139.652905206436, 23157.768422315898, 2213.6347502662043, 2285.4514916420108, 2292.358139720864, 2353.9411514712097, 2439.2682195341326, 13375.398107085204, 13569.796453053212, 13625.318734063356, 13748.450061997508, 14236.0, 1950.600126973967, 1962.6957821537685, 1993.6610776168086, 1998.7601487821555, 2026.9493262668552, 77885.0, 78764.21235787684, 79101.0, 79989.60005199937, 80174.19825801784, 10058.899411005796, 10276.897231027595, 10341.689749307532, 10540.789184216273, 10678.786424271471, 14147.080439771382, 14265.572032838823, 14321.283935803169, 14323.92838035824, 14355.78466323006, 7160.319769621878, 7542.208068152765, 7605.619719014027, 7636.923630763621, 7646.197149299354, 6926.930730692729, 6983.336583024605, 7149.571025738473, 7184.389326907271, 7259.6007219603425, 6158.445739883342, 6280.309165991737, 6361.427471527585, 6373.075903993895, 6493.70778314977, 1886.669832779258, 1890.8298253157282, 1915.990420047891, 1938.6801177805505, 1938.6898096304524, 918.5085979001202, 1018.5721996761378, 1045.7856139491387, 1050.2438244463974, 1054.7468607534136, 19256.903715481334, 19551.315703950295, 19942.302019429542, 19992.90003550002, 20044.69932951007, 1067.765091679829, 1069.4011353641986, 1091.3233795046963, 1099.8185299425666, 1102.1348241630442, 10877.205261131983, 11479.426028698532, 11541.422928853524, 11551.306921584732, 11581.305121692725, 526138.0, 528435.0, 535452.0, 538490.0, 550043.0, 79267.0, 80018.0, 80250.59874700589, 81194.0, 81893.59053204815, 1034.7723500829957, 1060.0883240413393, 1065.680295911239, 1075.3655343347461, 1087.3258579680648, 17562.0, 17571.56071098233, 17922.5519362017, 18081.18634661417, 18273.451796446127, 38625.80687096546, 39046.21907561776, 39499.60500394959, 40333.99999999883, 40604.0, 52538.474615253355, 53077.7346113267, 53243.73378133085, 53656.46343536515, 53709.0, 7889.526628402315, 8848.823023539622, 8985.550722463982, 9046.773830654023, 9138.68014619485, 13320.134191277535, 13328.733425331246, 13424.597262082154, 13830.930845345709, 14013.719725605228, 11247.943760281147, 11287.0, 11345.886541134483, 11756.294622322688, 12160.695982600506, 11685.415729213335, 11735.530578776754, 11765.588204412805, 11800.940995294968, 12287.877121228674, 12032.338221397908, 12062.698432539257, 12183.390830458264, 12301.200421972542, 12368.628941131781, 8827.470351778913, 8920.0, 8925.0, 8975.685850995184, 9025.954870225607, 12094.153409261267, 12145.089118315986, 12172.75654486923, 12250.142490025613, 12406.0], "value": 9337.42012196365, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.2904205981133, 1516.886233532485, 1684.7051765940957, 1826.7625208722864, 1844.9631007379844, 7732.420068494871, 8528.91471085289, 8560.486370817747, 9164.358494905351, 9177.08229177082, 8653.394262401634, 8921.420107692995, 8967.551622418885, 9006.054364291736, 9006.32452566057, 2270.7842754938297, 2297.0467256088705, 2301.919432819852, 2311.075569772096, 2315.131825565413, 2236.340279617517, 2268.3761965459466, 2326.999390262187, 2330.149495434171, 2335.684682567857, 2275.7155355580553, 2292.942676433086, 2301.2290882554366, 2338.2283846330756, 2361.586722323595, 2242.4842286274084, 2285.1202287119495, 2317.073170731704, 2317.4669825940045, 2323.2217207235512, 2305.4121199094125, 2314.7916687498036, 2319.605667036608, 2347.483553618218, 2353.199912029918, 8873.778155546162, 8967.01362850086, 9032.683856065072, 9056.275497960147, 9077.591508382138, 5129.051125541787, 5244.39689435716, 5245.082110630625, 5253.7635806388425, 5258.894822103536, 3175.063356309894, 3258.0877354340587, 3369.2250782319957, 3390.643982381839, 3404.710599599037, 1046.8220402531513, 1057.9047885690325, 1103.3545375954996, 1126.2397881430084, 1132.7564573616712, 12458.937705311506, 12479.0, 12499.937500312531, 12534.74930501385, 12549.247045177228, 4523.5928766410525, 4523.886902827456, 4638.884027899329, 4655.95344046562, 4658.068386322749, 10648.520816563274, 10691.198160138021, 10694.73263168427, 10736.677899663022, 10747.301425407324, 5228.6339956203465, 5247.081760691864, 5260.500252476008, 5274.182501712241, 5298.867528311823, 4246.808893599734, 4738.810447582127, 4772.331873537708, 4855.004724031565, 4874.512548745168, 3969.4641223435046, 4029.2545879012478, 4036.5761595032686, 4135.276326642826, 4275.358696195595, 1244.172625204229, 1248.219862585884, 1251.7044858571517, 1272.3956120842527, 1281.2248589603155, 1022.2282176956498, 1037.444966942682, 1039.620538503456, 1045.9110975567162, 1060.2790102730216, 6100.328963813977, 6157.322694503601, 6186.81439556814, 6324.494040476751, 6371.426571608577, 955.9761005974906, 991.4794732765356, 1017.659084206799, 1021.4433133942019, 1057.4131357096885, 4273.743575385424, 4341.9131617367475, 4398.69209155356, 4425.09285596452, 4429.180601588717, 10517.84223236652, 10858.891411085788, 11228.943855280671, 11233.38216398106, 11288.71778205535, 10854.403007834644, 11101.666949991513, 11111.166662500184, 11234.38210898392, 11270.94364528172, 8316.334693224528, 8488.490690558587, 8491.95754021226, 8522.70170544028, 8545.82908341842, 5917.940820591911, 6170.660613666291, 6200.3179650237535, 6203.534734894811, 6206.782762603287, 10072.194224462171, 10456.26806123564, 10636.255462117577, 10651.414172220602, 10752.247342685936, 10539.894601053891, 10656.946715266375, 10668.146548276274, 10677.359358438518, 10684.519196636325, 7087.291270872872, 7656.0, 7929.841403172019, 7989.0, 8014.679412823655, 8914.643414263357, 8934.061923498199, 8950.104989500998, 8959.641614335354, 9030.774230644023, 7530.585817780075, 7698.846023079619, 7726.3818894487185, 7824.0, 8016.038075430985, 7502.324790768857, 7583.5070720403, 7644.885326719992, 7758.68965241384, 7887.211278872067, 6712.6979285931275, 6773.93226067733, 6807.149106361705, 6818.079559259437, 6827.556208846409, 4938.30863679078, 5009.298698182331, 5133.307003554472, 5133.8716532087, 5153.45888681683, 5196.662216955886, 5243.606729495379, 5255.605829562722, 5259.027079990214, 5275.446078161738], "value": 4711.810842973147, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.70360971515913, 331.6567352789862, 338.9762915993699, 339.45517444501576, 346.08460621655706, 5523.321189223228, 5599.832005039845, 5709.800156994506, 5734.598578099534, 5771.365149833515, 5518.365387980383, 5573.0, 5619.943800561993, 5628.099504079348, 5632.014397480435, 4306.935395969047, 4338.58783415575, 4349.630281426083, 4354.216241076605, 4355.934660980088, 4103.958960410402, 4213.262679031172, 4271.6155546000855, 4289.656827453796, 4294.453996561236, 4230.4500414946015, 4250.192463431954, 4258.212230737324, 4265.7014009019385, 4274.4229529013655, 4250.851220207293, 4297.548757380492, 4307.396964424983, 4323.092150648367, 4333.804978775963, 3555.3422616815715, 3749.4000959846567, 3753.1930634913624, 3765.5293088363956, 3799.7530160539477, 5411.945880541183, 5456.181572764078, 5462.770876552783, 5468.7539060742365, 5486.588505862076, 4917.188663870457, 4919.532644398776, 4933.125412343286, 4936.4076310842565, 4966.230234313687, 5588.6646801192055, 5849.151872978437, 5878.206442130343, 5911.142884281755, 5915.556333275022, 4138.979305103485, 4148.23257697327, 4149.107941792529, 4161.271777438936, 4171.791410429466, 5922.58541902067, 6096.939030609681, 6139.386061393825, 6145.324014358462, 6146.787156623612, 4168.124693814333, 4180.7909604519655, 4193.18232944579, 4193.706440549132, 4204.306289462265, 4248.893777655583, 4261.934516370908, 4270.210011147948, 4282.5867463736895, 4287.0, 4913.484084171182, 4947.678400904002, 4961.677490963076, 4965.981973695384, 4980.203167493184, 5579.637323573955, 5820.293563492996, 5858.414158584193, 5860.824175274749, 5922.3485416604135, 1477.9113253204841, 1497.139144991634, 1498.5204734485078, 1499.8200215973934, 1505.6386467248, 934.9719508414759, 943.5895385507326, 948.7770373962113, 957.9664711735056, 959.0505399654292, 5046.621503387188, 5111.7699703513435, 5657.472482429721, 5832.241808564944, 5861.120831875252, 6095.878082438327, 6169.167162433104, 6179.69101544921, 6195.0, 6195.344746599438, 5530.308711411074, 5762.942370576325, 5767.452092051249, 5808.332041815161, 5838.671956984563, 3206.470932296145, 3213.501907204387, 3231.691165078147, 3243.772935894465, 3249.2039450334346, 6300.8424789379715, 6361.332060133712, 6365.52258580599, 6377.457916077093, 6385.616862988142, 6101.60339577926, 6161.977087915877, 6217.9689101555105, 6227.875442491125, 6228.719707613078, 6273.65494897785, 6278.748850046039, 6345.302016778151, 6348.77779277723, 6351.68241587928, 5909.261342332208, 6091.847703807441, 6094.628708540543, 6130.0, 6186.721597528032, 6032.6983650818165, 6079.179310792986, 6091.573589848846, 6099.542534310033, 6134.938650613437, 5983.401659833982, 6202.968985155046, 6268.529860260407, 6351.2696039956, 6382.712777925098, 4249.0, 4255.5531669175525, 4260.680448966402, 4277.272863613255, 4297.140571885573, 6091.7258723358445, 6169.691515424301, 6178.382161783786, 6191.5665903388135, 6213.689315534115, 5801.912971305518, 5894.6757928314355, 5905.173275741486, 6026.427489388501, 6040.546958978006, 5887.52899768009, 5932.228810254639, 5932.317783454958, 5954.3152537458745, 5994.460498555151, 5768.855778605568, 5804.65172089676, 5814.767409303749, 5830.62100963436, 5857.58996870215, 5702.344230413555, 5948.970255148696, 5964.866675331673, 6007.8197654070445, 6031.517478601789, 5864.648121112747, 5882.941170588239, 5964.970175149097, 5968.22413086296, 5986.521078313637], "value": 4474.337796730295, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.5789839248863, 709.8757717399454, 761.4936067515102, 804.8229389534303, 834.6494472321626, 13688.863111368883, 14016.789748153786, 14332.498362557313, 14408.423663053465, 14447.927760361183, 12795.936020319885, 12850.678733031678, 12854.48582056719, 13637.908967282618, 13763.587092387219, 792.1523969352809, 803.6102490292203, 804.9396295277849, 805.6696754330726, 805.7502174325948, 782.0849605961039, 799.5003123048095, 807.2815194476921, 808.5068108453868, 808.6159074439623, 835.9749207523754, 839.2111415269658, 842.2251528593678, 846.3863698818369, 846.8645016797313, 834.9916500835005, 836.4479443567217, 836.9246767790928, 838.5429940682374, 840.2899549880341, 606.5784279925454, 608.4402349838159, 608.966506842128, 611.9112728654364, 613.1109890658519, 14361.640958976004, 14467.348969296301, 14484.493042743454, 14513.927430362886, 14530.709385812224, 13029.804552931713, 13192.142510736772, 13200.0, 13210.603681889463, 13451.932740336235, 10738.409387483685, 10906.5092070857, 10923.071538919201, 11003.0, 11331.37677427741, 3748.11919198988, 3751.456038874348, 3782.432635104729, 3788.772673639563, 3804.524434445694, 74856.62571687161, 75717.62141189314, 76369.99999999945, 76401.61799191024, 77040.0, 10814.243002989873, 10879.347239165676, 10965.232433729563, 10976.945115274373, 11008.39453830031, 20862.478438038866, 21437.785622143892, 21499.892500537397, 21519.78480215178, 21604.89197554002, 8095.595220239083, 8373.539455330016, 8397.580120994047, 8519.105493923173, 8547.316214702809, 4739.881502962454, 4740.312654665055, 4745.525447455296, 4827.42070951488, 4920.040592084509, 3544.486049522805, 3621.3662609043313, 3648.927021459556, 3649.61679023704, 3678.5401824771902, 628.7359309090101, 651.9152510173647, 660.1484085529709, 663.2571519897746, 676.1379241467071, 643.3887806583764, 707.7558242406361, 725.6734469488752, 728.8615163118991, 743.2901578992049, 9213.401128926598, 9341.813163736688, 9562.153500084582, 9784.706458806248, 9843.116903854174, 698.3644883156303, 728.7121586973116, 730.831908661011, 741.9035525381773, 766.5209244222361, 4177.874663760092, 4213.852515162016, 4235.78821058952, 4300.440942677432, 4326.134773045404, 68256.0, 82184.0, 111994.44002779934, 115733.0, 116044.2966777495, 61591.69204153951, 78357.60821195858, 82915.5854220725, 86999.0, 99006.0, 84606.57696711477, 85558.57220713857, 86150.56924715462, 86537.13462865417, 86834.1316586826, 8244.258016778518, 8266.0, 8327.292180164512, 8382.58087095655, 8458.238758511763, 50666.240006399195, 51939.740301298254, 51976.48023519717, 52592.737036314575, 53093.4690653104, 70343.64828175826, 73295.0, 74538.25461745313, 74573.62713186616, 76870.6156469214, 10622.521986510472, 11042.889571104508, 11079.046797369912, 11093.5562577496, 11207.943960280147, 11877.58428455, 11882.46528906184, 12100.939495302468, 12148.939255303667, 12557.937210314256, 10980.835287470534, 11189.440527973731, 11359.091272697999, 11842.46708898119, 11892.881071189177, 10810.459477026274, 11086.501107450023, 11108.722281943015, 11629.825552616549, 12162.0, 9911.702648920544, 10064.245181611555, 10675.412852293199, 10861.565537378416, 10896.564137434414, 9633.732996879327, 9656.37233579815, 9794.608215671293, 9929.65246216379, 9962.452065136487, 9304.72085837426, 9942.15491683215, 9950.402975821475, 9975.20198384113, 9976.15202707778], "value": 7099.36551481493, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 106.0, 110.0, 110.0, 112.0, 112.0, 111.0, 110.0, 110.0, 108.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 130.0, 157.0, 169.0, 134.0, 157.0, 156.0, 132.0, 177.0, 126.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 162.0, 164.0, 173.0, 163.0, 162.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 150.0, 76.0, 76.0, 75.0, 77.0, 159.0, 76.0], "value": 91.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 154.0, 85.0, 87.0, 85.0, 151.0, 84.0, 86.0, 147.0], "value": 105.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 150.0, 146.0, 147.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 53.0, 62.0, 54.0, 53.0, 55.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 67.0, 63.0, 62.0, 61.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 82.0, 80.0, 86.0, 83.0, 86.0, 81.0, 110.0, 86.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 123.0, 138.0, 127.0, 128.0, 150.0, 142.0, 146.0, 150.0, 129.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 164.0, 173.0, 161.0, 167.0, 166.0, 166.0, 162.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 63.0, 65.0, 64.0, 64.0, 66.0, 63.0, 65.0], "value": 63.9, "unit": "score"}]}]} 22:50:09 INFO - Return code: 0 22:50:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:50:09 ERROR - # TBPL SUCCESS # 22:50:09 INFO - Running post-action listener: _resource_record_post_action 22:50:09 INFO - ##### 22:50:09 INFO - ##### Finished run-tests step (success) 22:50:09 INFO - ##### 22:50:09 INFO - Running post-run listener: _resource_record_post_run 22:50:09 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543825920; Read time: 12; Write time: 416564 22:50:09 INFO - TinderboxPrint: CPU usage
13.4% 22:50:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 22:50:09 INFO - TinderboxPrint: I/O write bytes / time
543,825,920 / 416,564 22:50:09 INFO - TinderboxPrint: CPU idle
8,210.4 (86.5%) 22:50:09 INFO - TinderboxPrint: CPU user
1,222.7 (12.9%) 22:50:09 INFO - TinderboxPrint: Swap in / out
0 / 0 22:50:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 227598336; Read time: 0; Write time: 223536 22:50:09 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295276544; Read time: 12; Write time: 189956 22:50:10 INFO - Running post-run listener: _upload_blobber_files 22:50:10 INFO - Blob upload gear active. 22:50:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:50:10 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 22:50:10 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'] 22:50:10 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 22:50:10 INFO - (blobuploader) - INFO - Open directory for files ... 22:50:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:50:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:50:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:50:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:50:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:50:11 INFO - (blobuploader) - INFO - Done attempting. 22:50:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:50:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:50:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:50:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:50:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:50:14 INFO - (blobuploader) - INFO - Done attempting. 22:50:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:50:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:50:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:50:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:50:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:50:15 INFO - (blobuploader) - INFO - Done attempting. 22:50:15 INFO - (blobuploader) - INFO - Iteration through files over. 22:50:15 INFO - Return code: 0 22:50:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:50:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:50:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0a06e8faf1af222dcb3f70bd83049e4b0d3ce289eff016129a881ef0500595bba242a80591fa9e23b69c2191cb4ea8beb9d1ccdfe47ef661fe90f062d6773115", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/943c8c16fc5b4097a04add421d475197a2555686ee36f9d2b81bc20f61f4e495dcf2a35a44395c8e7eca6679bea703b8e3c5a8020ae782a050674e9f1d8dc02f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0bb10cd9bc67f60479d766cb1178754584965b7fe50b520c2a66ce52a3ba830152d417a4363eaba552affaeb1b8d856ce30e636d7ea01a9093261f8a499084e2"} 22:50:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:50:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:50:15 INFO - Contents: 22:50:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0a06e8faf1af222dcb3f70bd83049e4b0d3ce289eff016129a881ef0500595bba242a80591fa9e23b69c2191cb4ea8beb9d1ccdfe47ef661fe90f062d6773115", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/943c8c16fc5b4097a04add421d475197a2555686ee36f9d2b81bc20f61f4e495dcf2a35a44395c8e7eca6679bea703b8e3c5a8020ae782a050674e9f1d8dc02f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0bb10cd9bc67f60479d766cb1178754584965b7fe50b520c2a66ce52a3ba830152d417a4363eaba552affaeb1b8d856ce30e636d7ea01a9093261f8a499084e2"} 22:50:15 INFO - Running post-run listener: copy_logs_to_upload_dir 22:50:15 INFO - Copying logs to upload dir... 22:50:15 INFO - mkdir: /builds/slave/test/build/upload/logs 22:50:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.072772 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-04 22:50:14.708009) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 22:50:14.712166) ========= 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=3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219 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/0a06e8faf1af222dcb3f70bd83049e4b0d3ce289eff016129a881ef0500595bba242a80591fa9e23b69c2191cb4ea8beb9d1ccdfe47ef661fe90f062d6773115", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/943c8c16fc5b4097a04add421d475197a2555686ee36f9d2b81bc20f61f4e495dcf2a35a44395c8e7eca6679bea703b8e3c5a8020ae782a050674e9f1d8dc02f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0bb10cd9bc67f60479d766cb1178754584965b7fe50b520c2a66ce52a3ba830152d417a4363eaba552affaeb1b8d856ce30e636d7ea01a9093261f8a499084e2"} build_url:https://queue.taskcluster.net/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/HJZaV861R9Wz4UJT1ZBSHw/artifacts/public/build/firefox-49.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/0a06e8faf1af222dcb3f70bd83049e4b0d3ce289eff016129a881ef0500595bba242a80591fa9e23b69c2191cb4ea8beb9d1ccdfe47ef661fe90f062d6773115", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/943c8c16fc5b4097a04add421d475197a2555686ee36f9d2b81bc20f61f4e495dcf2a35a44395c8e7eca6679bea703b8e3c5a8020ae782a050674e9f1d8dc02f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0bb10cd9bc67f60479d766cb1178754584965b7fe50b520c2a66ce52a3ba830152d417a4363eaba552affaeb1b8d856ce30e636d7ea01a9093261f8a499084e2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 22:50:14.743739) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 22:50:14.744281) ========= 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=3a3620fb28aea1604ab609ef000001d2-1465082278.870744-538264219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 22:50:14.826901) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 22:50:14.827418) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 22:50:14.827958) ========= ========= Total master_lag: 0.16 =========