builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1466458179.12 results: success (0) buildid: 20160620184817 builduid: 692d6887aa22433d8976d9306ab80b05 revision: e50976a962c4059618f0adcef93e49acf7264215 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 14:29:39.120111) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 14:29:39.120584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 14:29:39.120900) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 14:29:39.156212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 14:29:39.156623) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-20 14:29:39-- 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% 46.4M=0s 2016-06-20 14:29:39 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166167 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 14:29:39.340231) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 14:29:39.340953) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017641 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 14:29:39.392450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 14:29:39.392877) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e50976a962c4059618f0adcef93e49acf7264215 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e50976a962c4059618f0adcef93e49acf7264215 --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=8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-20 14:29:39,655 truncating revision to first 12 chars 2016-06-20 14:29:39,655 Setting DEBUG logging. 2016-06-20 14:29:39,656 attempt 1/10 2016-06-20 14:29:39,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e50976a962c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 14:29:39,984 unpacking tar archive at: mozilla-aurora-e50976a962c4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695588 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 14:29:40.101972) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 14:29:40.102299) ========= script_repo_revision: e50976a962c4059618f0adcef93e49acf7264215 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 14:29:40.102750) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 14:29:40.103067) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 14:29:40.116448) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-20 14:29:40.116785) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:29:40 INFO - MultiFileLogger online at 20160620 14:29:40 in /builds/slave/test 14:29:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:29:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:29:40 INFO - {'append_to_log': False, 14:29:40 INFO - 'base_work_dir': '/builds/slave/test', 14:29:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:29:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:29:40 INFO - 'branch': 'Mozilla-Aurora', 14:29:40 INFO - 'buildbot_json_path': 'buildprops.json', 14:29:40 INFO - 'config_files': ('talos/linux_config.py',), 14:29:40 INFO - 'default_actions': ('clobber', 14:29:40 INFO - 'read-buildbot-config', 14:29:40 INFO - 'download-and-extract', 14:29:40 INFO - 'populate-webroot', 14:29:40 INFO - 'create-virtualenv', 14:29:40 INFO - 'install', 14:29:40 INFO - 'run-tests'), 14:29:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:29:40 INFO - 'download_minidump_stackwalk': True, 14:29:40 INFO - 'download_symbols': 'ondemand', 14:29:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:29:40 INFO - 'tooltool.py': '/tools/tooltool.py', 14:29:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:29:40 INFO - '/tools/misc-python/virtualenv.py')}, 14:29:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:29:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:29:40 INFO - 'installer_path': 'installer.exe', 14:29:40 INFO - 'log_level': 'info', 14:29:40 INFO - 'log_name': 'talos', 14:29:40 INFO - 'log_to_console': True, 14:29:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:29:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:29:40 INFO - 'opt_config_files': (), 14:29:40 INFO - 'pip_index': False, 14:29:40 INFO - 'sps_profile': False, 14:29:40 INFO - 'sps_profile_interval': 0, 14:29:40 INFO - 'suite': 'dromaeojs-e10s', 14:29:40 INFO - 'system_bits': '32', 14:29:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:29:40 INFO - 'title': 'talos-linux64-ix-001', 14:29:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:29:40 INFO - 'use_talos_json': True, 14:29:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:29:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:29:40 INFO - 'work_dir': 'build'} 14:29:40 INFO - ##### 14:29:40 INFO - ##### Running clobber step. 14:29:40 INFO - ##### 14:29:40 INFO - Running pre-action listener: _resource_record_pre_action 14:29:40 INFO - Running main action method: clobber 14:29:40 INFO - rmtree: /builds/slave/test/build 14:29:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:29:41 INFO - Running post-action listener: _resource_record_post_action 14:29:41 INFO - ##### 14:29:41 INFO - ##### Finished clobber step (success) 14:29:41 INFO - ##### 14:29:41 INFO - ##### 14:29:41 INFO - ##### Running read-buildbot-config step. 14:29:41 INFO - ##### 14:29:41 INFO - Running pre-action listener: _resource_record_pre_action 14:29:41 INFO - Running main action method: read_buildbot_config 14:29:41 INFO - Using buildbot properties: 14:29:41 INFO - { 14:29:41 INFO - "project": "", 14:29:41 INFO - "product": "firefox", 14:29:41 INFO - "script_repo_revision": "production", 14:29:41 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 14:29:41 INFO - "repository": "", 14:29:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 14:29:41 INFO - "buildid": "20160620184817", 14:29:41 INFO - "stage_platform": "linux64-pgo", 14:29:41 INFO - "basedir": "/builds/slave/test", 14:29:41 INFO - "nightly_build": "True", 14:29:41 INFO - "buildnumber": 405, 14:29:41 INFO - "slavename": "talos-linux64-ix-001", 14:29:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:29:41 INFO - "platform": "ubuntu64_hw", 14:29:41 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:29:41 INFO - "branch": "mozilla-aurora", 14:29:41 INFO - "repo_path": "releases/mozilla-aurora", 14:29:41 INFO - "revision": "e50976a962c4059618f0adcef93e49acf7264215", 14:29:41 INFO - "pgo_build": "True", 14:29:41 INFO - "builduid": "692d6887aa22433d8976d9306ab80b05", 14:29:41 INFO - "slavebuilddir": "test" 14:29:41 INFO - } 14:29:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 14:29:41 INFO - Running post-action listener: _resource_record_post_action 14:29:41 INFO - ##### 14:29:41 INFO - ##### Finished read-buildbot-config step (success) 14:29:41 INFO - ##### 14:29:41 INFO - ##### 14:29:41 INFO - ##### Running download-and-extract step. 14:29:41 INFO - ##### 14:29:41 INFO - Running pre-action listener: _resource_record_pre_action 14:29:41 INFO - Running main action method: download_and_extract 14:29:41 INFO - mkdir: /builds/slave/test/build/tests 14: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')]} 14:29:41 INFO - https://queue.taskcluster.net/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:29:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:29:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:29:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:29:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:29:46 INFO - Downloaded 1361 bytes. 14:29:46 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:29:46 INFO - Using the following test package requirements: 14:29:46 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:29:46 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:46 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:29:46 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:46 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:29:46 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:46 INFO - u'jsshell-linux-x86_64.zip'], 14:29:46 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:46 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:29:46 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:29:46 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:46 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:29:46 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:46 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:29:46 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:46 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:29:46 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:29:46 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:29:46 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:29:46 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')]} 14:29:46 INFO - https://queue.taskcluster.net/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:29:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:29:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:29:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:29:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:29:51 INFO - Downloaded 24472795 bytes. 14:29:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:29:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:29:52 INFO - Return code: 0 14:29:52 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14: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')]} 14:29:52 INFO - https://queue.taskcluster.net/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:29:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:29:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:29:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:29:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:29:54 INFO - Downloaded 24472795 bytes. 14:29:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:29:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:29:55 INFO - Return code: 0 14:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:55 INFO - https://queue.taskcluster.net/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:29:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:29:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:29:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:29:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:29:56 INFO - Downloaded 10833369 bytes. 14:29:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:29:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:29:56 INFO - Return code: 0 14:29:56 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')]} 14:29:56 INFO - https://queue.taskcluster.net/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:29:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:29:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:29:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:29:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:29:58 INFO - Downloaded 63556516 bytes. 14:29:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:29:58 INFO - mkdir: /builds/slave/test/properties 14:29:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:29:58 INFO - Writing to file /builds/slave/test/properties/build_url 14:29:58 INFO - Contents: 14:29:58 INFO - build_url:https://queue.taskcluster.net/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:29:59 INFO - Running post-action listener: _resource_record_post_action 14:29:59 INFO - Running post-action listener: set_extra_try_arguments 14:29:59 INFO - ##### 14:29:59 INFO - ##### Finished download-and-extract step (success) 14:29:59 INFO - ##### 14:29:59 INFO - ##### 14:29:59 INFO - ##### Running populate-webroot step. 14:29:59 INFO - ##### 14:29:59 INFO - Running pre-action listener: _resource_record_pre_action 14:29:59 INFO - Running main action method: populate_webroot 14:29:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:29:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:29:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:29:59 INFO - '--tppagecycles', 14:29:59 INFO - '7'], 14:29:59 INFO - 'tests': ['tsvgm']}}, 14:29:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:29:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:29:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:29:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:29:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:29:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:29:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:59 INFO - 'talos_options': ['--disable-e10s'], 14:29:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:29:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:29:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:59 INFO - 'talos_options': ['--disable-e10s'], 14:29:59 INFO - 'tests': ['damp', 'tps']}, 14:29:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:59 INFO - 'tests': ['damp', 'tps']}, 14:29:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:29:59 INFO - 'tests': ['dromaeo_dom']}, 14:29:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:29:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:29:59 INFO - 'tests': ['a11yr', 14:29:59 INFO - 'ts_paint', 14:29:59 INFO - 'tpaint', 14:29:59 INFO - 'sessionrestore', 14:29:59 INFO - 'sessionrestore_no_auto_restore', 14:29:59 INFO - 'tabpaint']}, 14:29:59 INFO - 'other-e10s': {'tests': ['a11yr', 14:29:59 INFO - 'ts_paint', 14:29:59 INFO - 'tpaint', 14:29:59 INFO - 'sessionrestore', 14:29:59 INFO - 'sessionrestore_no_auto_restore', 14:29:59 INFO - 'tabpaint']}, 14:29:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:29:59 INFO - 'ts_paint', 14:29:59 INFO - 'tpaint', 14:29:59 INFO - 'sessionrestore', 14:29:59 INFO - 'sessionrestore_no_auto_restore', 14:29:59 INFO - 'tabpaint']}, 14:29:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:29:59 INFO - 'ts_paint', 14:29:59 INFO - 'tpaint', 14:29:59 INFO - 'sessionrestore', 14:29:59 INFO - 'sessionrestore_no_auto_restore', 14:29:59 INFO - 'tabpaint']}, 14:29:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:29:59 INFO - 'tests': ['a11yr', 14:29:59 INFO - 'ts_paint', 14:29:59 INFO - 'tpaint', 14:29:59 INFO - 'sessionrestore', 14:29:59 INFO - 'sessionrestore_no_auto_restore', 14:29:59 INFO - 'tabpaint']}, 14:29:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:29:59 INFO - 'tests': ['a11yr', 14:29:59 INFO - 'ts_paint', 14:29:59 INFO - 'tpaint', 14:29:59 INFO - 'sessionrestore', 14:29:59 INFO - 'sessionrestore_no_auto_restore', 14:29:59 INFO - 'tabpaint']}, 14:29:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:29:59 INFO - 'tests': ['tsvgx', 14:29:59 INFO - 'tsvgr_opacity', 14:29:59 INFO - 'tart', 14:29:59 INFO - 'tscrollx', 14:29:59 INFO - 'cart']}, 14:29:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:29:59 INFO - 'tsvgr_opacity', 14:29:59 INFO - 'tart', 14:29:59 INFO - 'tscrollx', 14:29:59 INFO - 'cart']}, 14:29:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:59 INFO - 'talos_options': ['--disable-e10s'], 14:29:59 INFO - 'tests': ['tp5o']}, 14:29:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:59 INFO - 'tests': ['tp5o']}, 14:29:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:59 INFO - 'talos_options': ['--disable-e10s', 14:29:59 INFO - '--xperf_path', 14:29:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:29:59 INFO - 'tests': ['tp5n']}, 14:29:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:59 INFO - 'talos_options': ['--xperf_path', 14:29:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:29:59 INFO - 'tests': ['tp5n']}}, 14:29:59 INFO - 'talos.zip': {'path': '', 14:29:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:29:59 INFO - Running post-action listener: _resource_record_post_action 14:29:59 INFO - ##### 14:29:59 INFO - ##### Finished populate-webroot step (success) 14:29:59 INFO - ##### 14:29:59 INFO - ##### 14:29:59 INFO - ##### Running create-virtualenv step. 14:29:59 INFO - ##### 14:29:59 INFO - Running pre-action listener: _resource_record_pre_action 14:29:59 INFO - Running main action method: create_virtualenv 14:29:59 INFO - Creating virtualenv /builds/slave/test/build/venv 14:29:59 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 14:29:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:29:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:29:59 INFO - Using real prefix '/usr' 14:29:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:29:59 INFO - Installing distribute.............................................................................................................................................................................................done. 14:30:01 INFO - Installing pip.................done. 14:30:01 INFO - Return code: 0 14:30:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14: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')]} 14:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14: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')]} 14:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc64a85af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1155350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e41c0>, '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 0x11e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e5550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', '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 14: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', 'pip>=1.5'] in /builds/slave/test/build 14: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 pip>=1.5 14:30:01 INFO - Using env: {'DISPLAY': ':0', 14:30:01 INFO - 'HOME': '/home/cltbld', 14:30:01 INFO - 'LANG': 'en_US.UTF-8', 14:30:01 INFO - 'LANGUAGE': 'en_US:en', 14:30:01 INFO - 'LOGNAME': 'cltbld', 14:30:01 INFO - 'MAIL': '/var/mail/cltbld', 14:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:01 INFO - 'MOZ_NO_REMOTE': '1', 14:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:01 INFO - 'NO_EM_RESTART': '1', 14:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:01 INFO - 'PWD': '/builds/slave/test', 14:30:01 INFO - 'SHELL': '/bin/bash', 14:30:01 INFO - 'SHLVL': '1', 14:30:01 INFO - 'TERM': 'linux', 14:30:01 INFO - 'TMOUT': '86400', 14:30:01 INFO - 'USER': 'cltbld', 14:30:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', 14:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:01 INFO - '_': '/tools/buildbot/bin/python'} 14:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:01 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 14:30:01 INFO - Cleaning up... 14:30:01 INFO - Return code: 0 14:30:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14: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')]} 14:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14: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')]} 14:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14: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', '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 0x7fc64a85af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1155350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e41c0>, '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 0x11e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e5550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', '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 14: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14: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 psutil>=3.1.1 14:30:01 INFO - Using env: {'DISPLAY': ':0', 14:30:01 INFO - 'HOME': '/home/cltbld', 14:30:01 INFO - 'LANG': 'en_US.UTF-8', 14:30:01 INFO - 'LANGUAGE': 'en_US:en', 14:30:01 INFO - 'LOGNAME': 'cltbld', 14:30:01 INFO - 'MAIL': '/var/mail/cltbld', 14:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:01 INFO - 'MOZ_NO_REMOTE': '1', 14:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:01 INFO - 'NO_EM_RESTART': '1', 14:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:01 INFO - 'PWD': '/builds/slave/test', 14:30:01 INFO - 'SHELL': '/bin/bash', 14:30:01 INFO - 'SHLVL': '1', 14:30:01 INFO - 'TERM': 'linux', 14:30:01 INFO - 'TMOUT': '86400', 14:30:01 INFO - 'USER': 'cltbld', 14:30:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', 14:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:01 INFO - '_': '/tools/buildbot/bin/python'} 14:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:02 INFO - Downloading/unpacking psutil>=3.1.1 14:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:30:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:04 INFO - Installing collected packages: psutil 14:30:04 INFO - Running setup.py install for psutil 14:30:04 INFO - building 'psutil._psutil_linux' extension 14:30:04 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 14:30:04 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 14:30:04 INFO - building 'psutil._psutil_posix' extension 14:30:04 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 14:30:04 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 14:30:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:04 INFO - Successfully installed psutil 14:30:04 INFO - Cleaning up... 14:30:04 INFO - Return code: 0 14:30:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:04 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 0x7fc64a85af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1155350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e41c0>, '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 0x11e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e5550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', '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 14:30:04 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 14:30:04 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 14:30:04 INFO - Using env: {'DISPLAY': ':0', 14:30:04 INFO - 'HOME': '/home/cltbld', 14:30:04 INFO - 'LANG': 'en_US.UTF-8', 14:30:04 INFO - 'LANGUAGE': 'en_US:en', 14:30:04 INFO - 'LOGNAME': 'cltbld', 14:30:04 INFO - 'MAIL': '/var/mail/cltbld', 14:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:04 INFO - 'MOZ_NO_REMOTE': '1', 14:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:04 INFO - 'NO_EM_RESTART': '1', 14:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:04 INFO - 'PWD': '/builds/slave/test', 14:30:04 INFO - 'SHELL': '/bin/bash', 14:30:04 INFO - 'SHLVL': '1', 14:30:04 INFO - 'TERM': 'linux', 14:30:04 INFO - 'TMOUT': '86400', 14:30:04 INFO - 'USER': 'cltbld', 14:30:04 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', 14:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:04 INFO - '_': '/tools/buildbot/bin/python'} 14:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:30:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:30:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:30:06 INFO - Installing collected packages: mozsystemmonitor 14:30:06 INFO - Running setup.py install for mozsystemmonitor 14:30:07 INFO - Successfully installed mozsystemmonitor 14:30:07 INFO - Cleaning up... 14:30:07 INFO - Return code: 0 14:30:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:30:07 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')]} 14:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:07 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')]} 14:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:07 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 0x7fc64a85af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1155350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e41c0>, '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 0x11e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e5550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', '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 14:30:07 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 14:30:07 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 14:30:07 INFO - Using env: {'DISPLAY': ':0', 14:30:07 INFO - 'HOME': '/home/cltbld', 14:30:07 INFO - 'LANG': 'en_US.UTF-8', 14:30:07 INFO - 'LANGUAGE': 'en_US:en', 14:30:07 INFO - 'LOGNAME': 'cltbld', 14:30:07 INFO - 'MAIL': '/var/mail/cltbld', 14:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:07 INFO - 'MOZ_NO_REMOTE': '1', 14:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:07 INFO - 'NO_EM_RESTART': '1', 14:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:07 INFO - 'PWD': '/builds/slave/test', 14:30:07 INFO - 'SHELL': '/bin/bash', 14:30:07 INFO - 'SHLVL': '1', 14:30:07 INFO - 'TERM': 'linux', 14:30:07 INFO - 'TMOUT': '86400', 14:30:07 INFO - 'USER': 'cltbld', 14:30:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', 14:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:07 INFO - '_': '/tools/buildbot/bin/python'} 14:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:07 INFO - Downloading/unpacking jsonschema==2.5.1 14:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:30:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:09 INFO - Downloading functools32-3.2.3-2.tar.gz 14:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:30:09 INFO - warning: no files found matching '*.txt' 14:30:09 INFO - no previously-included directories found matching 'build' 14:30:09 INFO - no previously-included directories found matching 'dist' 14:30:09 INFO - no previously-included directories found matching '.git*' 14:30:09 INFO - Installing collected packages: jsonschema, functools32 14:30:09 INFO - Running setup.py install for functools32 14:30:09 INFO - warning: no files found matching '*.txt' 14:30:09 INFO - no previously-included directories found matching 'build' 14:30:09 INFO - no previously-included directories found matching 'dist' 14:30:09 INFO - no previously-included directories found matching '.git*' 14:30:09 INFO - Successfully installed jsonschema functools32 14:30:09 INFO - Cleaning up... 14:30:09 INFO - Return code: 0 14:30:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14: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')]} 14:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14: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')]} 14:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:09 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 0x7fc64a85af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1155350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e41c0>, '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 0x11e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e5550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', '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 14:30:09 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 14:30:09 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 14:30:09 INFO - Using env: {'DISPLAY': ':0', 14:30:09 INFO - 'HOME': '/home/cltbld', 14:30:09 INFO - 'LANG': 'en_US.UTF-8', 14:30:09 INFO - 'LANGUAGE': 'en_US:en', 14:30:09 INFO - 'LOGNAME': 'cltbld', 14:30:09 INFO - 'MAIL': '/var/mail/cltbld', 14:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:09 INFO - 'MOZ_NO_REMOTE': '1', 14:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:09 INFO - 'NO_EM_RESTART': '1', 14:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:09 INFO - 'PWD': '/builds/slave/test', 14:30:09 INFO - 'SHELL': '/bin/bash', 14:30:09 INFO - 'SHLVL': '1', 14:30:09 INFO - 'TERM': 'linux', 14:30:09 INFO - 'TMOUT': '86400', 14:30:09 INFO - 'USER': 'cltbld', 14:30:09 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', 14:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:09 INFO - '_': '/tools/buildbot/bin/python'} 14:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:09 INFO - Downloading/unpacking blobuploader==1.2.4 14:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:11 INFO - Downloading blobuploader-1.2.4.tar.gz 14:30:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:30:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:30:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:30:12 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 14:30:12 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 14:30:12 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 14:30:12 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 14:30:12 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 14:30:12 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 14:30:12 INFO - Downloading docopt-0.6.1.tar.gz 14:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:30:12 INFO - Installing collected packages: blobuploader, requests, docopt 14:30:12 INFO - Running setup.py install for blobuploader 14:30:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:30:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:30:12 INFO - Running setup.py install for requests 14:30:12 INFO - Running setup.py install for docopt 14:30:13 INFO - Successfully installed blobuploader requests docopt 14:30:13 INFO - Cleaning up... 14:30:13 INFO - Return code: 0 14:30:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:13 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 0x7fc64a85af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1155350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e41c0>, '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 0x11e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e5550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', '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 14:30:13 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 14:30:13 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 14:30:13 INFO - Using env: {'DISPLAY': ':0', 14:30:13 INFO - 'HOME': '/home/cltbld', 14:30:13 INFO - 'LANG': 'en_US.UTF-8', 14:30:13 INFO - 'LANGUAGE': 'en_US:en', 14:30:13 INFO - 'LOGNAME': 'cltbld', 14:30:13 INFO - 'MAIL': '/var/mail/cltbld', 14:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:13 INFO - 'MOZ_NO_REMOTE': '1', 14:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:13 INFO - 'NO_EM_RESTART': '1', 14:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:13 INFO - 'PWD': '/builds/slave/test', 14:30:13 INFO - 'SHELL': '/bin/bash', 14:30:13 INFO - 'SHLVL': '1', 14:30:13 INFO - 'TERM': 'linux', 14:30:13 INFO - 'TMOUT': '86400', 14:30:13 INFO - 'USER': 'cltbld', 14:30:13 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', 14:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:13 INFO - '_': '/tools/buildbot/bin/python'} 14:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:30:13 INFO - Running setup.py (path:/tmp/pip-RDXLxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:30:13 INFO - Running setup.py (path:/tmp/pip-faRxpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:30:13 INFO - Running setup.py (path:/tmp/pip-gslvl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:30:13 INFO - Running setup.py (path:/tmp/pip-Ne3MeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:30:13 INFO - Running setup.py (path:/tmp/pip-3L0kKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:30:13 INFO - Running setup.py (path:/tmp/pip-7N3tE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:30:13 INFO - Running setup.py (path:/tmp/pip-o4ofFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:30:13 INFO - Running setup.py (path:/tmp/pip-kpZMxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:30:13 INFO - Running setup.py (path:/tmp/pip-49oRUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:30:13 INFO - Running setup.py (path:/tmp/pip-mmRT0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:30:14 INFO - Running setup.py (path:/tmp/pip-BHVnq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:30:14 INFO - Running setup.py (path:/tmp/pip-ApJuS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:30:14 INFO - Running setup.py (path:/tmp/pip-iGpZfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:30:14 INFO - Running setup.py (path:/tmp/pip-eZ6IZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:14 INFO - Running setup.py (path:/tmp/pip-0PtwJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:30:14 INFO - Running setup.py (path:/tmp/pip-XM1RvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:30:14 INFO - Running setup.py (path:/tmp/pip-U65Gkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:30:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:30:14 INFO - Running setup.py install for manifestparser 14:30:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:30:14 INFO - Running setup.py install for mozcrash 14:30:14 INFO - Running setup.py install for mozdebug 14:30:14 INFO - Running setup.py install for mozdevice 14:30:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:30:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:30:14 INFO - Running setup.py install for mozfile 14:30:15 INFO - Running setup.py install for mozhttpd 14:30:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:30:15 INFO - Running setup.py install for mozinfo 14:30:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:30:15 INFO - Running setup.py install for mozInstall 14:30:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:30:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:30:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:30:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:30:15 INFO - Running setup.py install for mozleak 14:30:15 INFO - Running setup.py install for mozlog 14:30:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:30:15 INFO - Running setup.py install for moznetwork 14:30:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:30:15 INFO - Running setup.py install for mozprocess 14:30:15 INFO - Running setup.py install for mozprofile 14:30:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:30:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:30:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:30:15 INFO - Running setup.py install for mozrunner 14:30:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:30:16 INFO - Running setup.py install for mozscreenshot 14:30:16 INFO - Running setup.py install for moztest 14:30:16 INFO - Running setup.py install for mozversion 14:30:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:30:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:30:16 INFO - Cleaning up... 14:30:16 INFO - Return code: 0 14:30:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14: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')]} 14:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14: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')]} 14:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14: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/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 0x7fc64a85af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1155350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e41c0>, '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 0x11e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e5550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', '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 14:30:16 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 14:30:16 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 14:30:16 INFO - Using env: {'DISPLAY': ':0', 14:30:16 INFO - 'HOME': '/home/cltbld', 14:30:16 INFO - 'LANG': 'en_US.UTF-8', 14:30:16 INFO - 'LANGUAGE': 'en_US:en', 14:30:16 INFO - 'LOGNAME': 'cltbld', 14:30:16 INFO - 'MAIL': '/var/mail/cltbld', 14:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:16 INFO - 'MOZ_NO_REMOTE': '1', 14:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:16 INFO - 'NO_EM_RESTART': '1', 14:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:16 INFO - 'PWD': '/builds/slave/test', 14:30:16 INFO - 'SHELL': '/bin/bash', 14:30:16 INFO - 'SHLVL': '1', 14:30:16 INFO - 'TERM': 'linux', 14:30:16 INFO - 'TMOUT': '86400', 14:30:16 INFO - 'USER': 'cltbld', 14:30:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', 14:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:16 INFO - '_': '/tools/buildbot/bin/python'} 14:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:30:16 INFO - Running setup.py (path:/tmp/pip-YR0VK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:30:16 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)) 14:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:30:16 INFO - Running setup.py (path:/tmp/pip-4tTD52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:30:16 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)) 14:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:30:16 INFO - Running setup.py (path:/tmp/pip-1uGAo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:30:16 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)) 14:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:30:16 INFO - Running setup.py (path:/tmp/pip-a2ngdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:30:16 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)) 14:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:30:16 INFO - Running setup.py (path:/tmp/pip-5GF6Xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:30:16 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)) 14:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:30:16 INFO - Running setup.py (path:/tmp/pip-jRTA1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:30:17 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)) 14:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:30:17 INFO - Running setup.py (path:/tmp/pip-kddpEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:30:17 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)) 14:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:30:17 INFO - Running setup.py (path:/tmp/pip-4F1Tyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:30:17 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)) 14:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:30:17 INFO - Running setup.py (path:/tmp/pip-bJlN5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:30:17 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)) 14:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:30:17 INFO - Running setup.py (path:/tmp/pip-2Kjirq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:30:17 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)) 14:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:30:17 INFO - Running setup.py (path:/tmp/pip-jJv8IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:30:17 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)) 14:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:30:17 INFO - Running setup.py (path:/tmp/pip-l56ZJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:30:17 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)) 14:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:30:17 INFO - Running setup.py (path:/tmp/pip-ToKb2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:30:17 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)) 14:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:30:17 INFO - Running setup.py (path:/tmp/pip-CZWtQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:30:17 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)) 14:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:17 INFO - Running setup.py (path:/tmp/pip-KrBuiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:17 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)) 14:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:30:17 INFO - Running setup.py (path:/tmp/pip-eqTpyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:30:17 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)) 14:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:30:17 INFO - Running setup.py (path:/tmp/pip-N2yHzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:30:17 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)) 14:30:17 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)) 14:30:17 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)) 14:30:17 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)) 14:30:17 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)) 14:30:17 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)) 14:30:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14: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 14: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 14: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 14: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 14: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 14: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 14:30:19 INFO - Downloading blessings-1.6.tar.gz 14:30:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:30:19 INFO - Installing collected packages: blessings 14:30:19 INFO - Running setup.py install for blessings 14:30:19 INFO - Successfully installed blessings 14:30:19 INFO - Cleaning up... 14:30:19 INFO - Return code: 0 14:30:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:30:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:30:20 INFO - Reading from file tmpfile_stdout 14:30:20 INFO - Current package versions: 14:30:20 INFO - argparse == 1.2.1 14:30:20 INFO - blessings == 1.6 14:30:20 INFO - blobuploader == 1.2.4 14:30:20 INFO - docopt == 0.6.1 14:30:20 INFO - functools32 == 3.2.3-2 14:30:20 INFO - jsonschema == 2.5.1 14:30:20 INFO - manifestparser == 1.1 14:30:20 INFO - mozInstall == 1.12 14:30:20 INFO - mozcrash == 0.17 14:30:20 INFO - mozdebug == 0.1 14:30:20 INFO - mozdevice == 0.48 14:30:20 INFO - mozfile == 1.2 14:30:20 INFO - mozhttpd == 0.7 14:30:20 INFO - mozinfo == 0.9 14:30:20 INFO - mozleak == 0.1 14:30:20 INFO - mozlog == 3.2 14:30:20 INFO - moznetwork == 0.27 14:30:20 INFO - mozprocess == 0.22 14:30:20 INFO - mozprofile == 0.28 14:30:20 INFO - mozrunner == 6.11 14:30:20 INFO - mozscreenshot == 0.1 14:30:20 INFO - mozsystemmonitor == 0.3 14:30:20 INFO - moztest == 0.7 14:30:20 INFO - mozversion == 1.4 14:30:20 INFO - psutil == 3.1.1 14:30:20 INFO - requests == 1.2.3 14:30:20 INFO - wsgiref == 0.1.2 14:30:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:20 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')]} 14:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:20 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')]} 14:30:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:20 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 0x7fc64a85af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1155350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e41c0>, '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 0x11e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e5550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', '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 14:30:20 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 14:30:20 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 14:30:20 INFO - Using env: {'DISPLAY': ':0', 14:30:20 INFO - 'HOME': '/home/cltbld', 14:30:20 INFO - 'LANG': 'en_US.UTF-8', 14:30:20 INFO - 'LANGUAGE': 'en_US:en', 14:30:20 INFO - 'LOGNAME': 'cltbld', 14:30:20 INFO - 'MAIL': '/var/mail/cltbld', 14:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:20 INFO - 'MOZ_NO_REMOTE': '1', 14:30:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:20 INFO - 'NO_EM_RESTART': '1', 14:30:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:20 INFO - 'PWD': '/builds/slave/test', 14:30:20 INFO - 'SHELL': '/bin/bash', 14:30:20 INFO - 'SHLVL': '1', 14:30:20 INFO - 'TERM': 'linux', 14:30:20 INFO - 'TMOUT': '86400', 14:30:20 INFO - 'USER': 'cltbld', 14:30:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', 14:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:20 INFO - '_': '/tools/buildbot/bin/python'} 14:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:20 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)) 14:30:20 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)) 14:30:20 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)) 14:30:20 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)) 14:30:20 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)) 14:30:20 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)) 14:30:20 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)) 14:30:20 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)) 14:30:20 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)) 14:30:20 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)) 14:30:20 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)) 14:30:20 INFO - Cleaning up... 14:30:20 INFO - Return code: 0 14:30:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:30:20 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')]} 14:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:20 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')]} 14:30:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:20 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 0x7fc64a85af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1155350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e41c0>, '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 0x11e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e5550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', '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 14:30:20 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 14:30:20 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 14:30:20 INFO - Using env: {'DISPLAY': ':0', 14:30:20 INFO - 'HOME': '/home/cltbld', 14:30:20 INFO - 'LANG': 'en_US.UTF-8', 14:30:20 INFO - 'LANGUAGE': 'en_US:en', 14:30:20 INFO - 'LOGNAME': 'cltbld', 14:30:20 INFO - 'MAIL': '/var/mail/cltbld', 14:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:20 INFO - 'MOZ_NO_REMOTE': '1', 14:30:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:20 INFO - 'NO_EM_RESTART': '1', 14:30:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:20 INFO - 'PWD': '/builds/slave/test', 14:30:20 INFO - 'SHELL': '/bin/bash', 14:30:20 INFO - 'SHLVL': '1', 14:30:20 INFO - 'TERM': 'linux', 14:30:20 INFO - 'TMOUT': '86400', 14:30:20 INFO - 'USER': 'cltbld', 14:30:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', 14:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:20 INFO - '_': '/tools/buildbot/bin/python'} 14:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:30:20 INFO - Cleaning up... 14:30:20 INFO - Return code: 0 14:30:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:30:20 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')]} 14:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:20 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')]} 14:30:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:20 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 0x7fc64a85af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1155350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e41c0>, '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 0x11e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e5550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', '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 14:30:20 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 14:30:20 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 14:30:20 INFO - Using env: {'DISPLAY': ':0', 14:30:20 INFO - 'HOME': '/home/cltbld', 14:30:20 INFO - 'LANG': 'en_US.UTF-8', 14:30:20 INFO - 'LANGUAGE': 'en_US:en', 14:30:20 INFO - 'LOGNAME': 'cltbld', 14:30:20 INFO - 'MAIL': '/var/mail/cltbld', 14:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:20 INFO - 'MOZ_NO_REMOTE': '1', 14:30:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:20 INFO - 'NO_EM_RESTART': '1', 14:30:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:20 INFO - 'PWD': '/builds/slave/test', 14:30:20 INFO - 'SHELL': '/bin/bash', 14:30:20 INFO - 'SHLVL': '1', 14:30:20 INFO - 'TERM': 'linux', 14:30:20 INFO - 'TMOUT': '86400', 14:30:20 INFO - 'USER': 'cltbld', 14:30:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', 14:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:20 INFO - '_': '/tools/buildbot/bin/python'} 14:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:20 INFO - Downloading/unpacking flake8 14:30:20 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 14:30:20 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 14:30:20 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 14:30:20 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 14:30:20 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 14:30:20 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 14:30:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:30:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:30:22 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 14:30:22 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 14:30:22 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 14:30:22 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 14:30:22 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 14:30:22 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 14:30:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:30:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:30:22 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 14:30:22 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 14:30:22 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 14:30:22 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 14:30:22 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 14:30:22 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 14:30:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:30:23 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 14:30:23 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 14:30:23 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 14:30:23 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 14:30:23 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 14:30:23 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 14:30:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:30:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:30:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:30:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:30:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:30:23 INFO - no previously-included directories found matching 'docs/_build' 14:30:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:30:23 INFO - Running setup.py install for pep8 14:30:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:30:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:30:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:30:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:30:23 INFO - no previously-included directories found matching 'docs/_build' 14:30:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:30:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:30:23 INFO - Cleaning up... 14:30:23 INFO - Return code: 0 14:30:23 INFO - Running post-action listener: _resource_record_post_action 14:30:23 INFO - Running post-action listener: _start_resource_monitoring 14:30:23 INFO - Starting resource monitoring. 14:30:23 INFO - ##### 14:30:23 INFO - ##### Finished create-virtualenv step (success) 14:30:23 INFO - ##### 14:30:23 INFO - ##### 14:30:23 INFO - ##### Running install step. 14:30:23 INFO - ##### 14:30:23 INFO - Running pre-action listener: _resource_record_pre_action 14:30:23 INFO - Running main action method: install 14:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:30:23 INFO - Reading from file tmpfile_stdout 14:30:23 INFO - Detecting whether we're running mozinstall >=1.0... 14:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:30:24 INFO - Reading from file tmpfile_stdout 14:30:24 INFO - Output received: 14:30:24 INFO - Usage: mozinstall [options] installer 14:30:24 INFO - Options: 14:30:24 INFO - -h, --help show this help message and exit 14:30:24 INFO - -d DEST, --destination=DEST 14:30:24 INFO - Directory to install application into. [default: 14:30:24 INFO - "/builds/slave/test"] 14:30:24 INFO - --app=APP Application being installed. [default: firefox] 14:30:24 INFO - mkdir: /builds/slave/test/build/application 14:30:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:30:39 INFO - Reading from file tmpfile_stdout 14:30:39 INFO - Output received: 14:30:39 INFO - /builds/slave/test/build/application/firefox/firefox 14:30:39 INFO - Running post-action listener: _resource_record_post_action 14:30:39 INFO - ##### 14:30:39 INFO - ##### Finished install step (success) 14:30:39 INFO - ##### 14:30:39 INFO - ##### 14:30:39 INFO - ##### Running run-tests step. 14:30:39 INFO - ##### 14:30:39 INFO - Running pre-action listener: _resource_record_pre_action 14:30:39 INFO - Running main action method: run_tests 14:30:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:30:39 INFO - Python 2.7.3 14:30:39 INFO - Return code: 0 14:30:39 INFO - grabbing minidump binary from tooltool 14:30: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')]} 14:30:39 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 0x11e41c0>, '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 0x11e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e5550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:30:39 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 14:30:39 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 14:30:39 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 14:30:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:30:39 INFO - Return code: 0 14:30:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:30:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:30:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:30:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:30:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:30:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:30:40 INFO - Return code: 0 14:30:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 14:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 14:30:40 INFO - Using env: {'DISPLAY': ':0', 14:30:40 INFO - 'HOME': '/home/cltbld', 14:30:40 INFO - 'LANG': 'en_US.UTF-8', 14:30:40 INFO - 'LANGUAGE': 'en_US:en', 14:30:40 INFO - 'LOGNAME': 'cltbld', 14:30:40 INFO - 'MAIL': '/var/mail/cltbld', 14:30:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:30:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:40 INFO - 'MOZ_NO_REMOTE': '1', 14:30:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:40 INFO - 'NO_EM_RESTART': '1', 14:30:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:40 INFO - 'PWD': '/builds/slave/test', 14:30:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:30:40 INFO - 'SHELL': '/bin/bash', 14:30:40 INFO - 'SHLVL': '1', 14:30:40 INFO - 'TERM': 'linux', 14:30:40 INFO - 'TMOUT': '86400', 14:30:40 INFO - 'USER': 'cltbld', 14:30:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496', 14:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:40 INFO - '_': '/tools/buildbot/bin/python'} 14:30:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 14:30:41 INFO - mozversion application_buildid: 20160620184817 14:30:41 INFO - mozversion application_changeset: e50976a962c4059618f0adcef93e49acf7264215 14:30:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:30:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:30:41 INFO - mozversion application_name: Firefox 14:30:41 INFO - mozversion application_remotingname: firefox-dev 14:30:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:30:41 INFO - mozversion application_vendor: Mozilla 14:30:41 INFO - mozversion application_version: 49.0a2 14:30:41 INFO - mozversion platform_buildid: 20160620184817 14:30:41 INFO - mozversion platform_changeset: e50976a962c4059618f0adcef93e49acf7264215 14:30:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:30:41 INFO - mozversion platform_version: 49.0a2 14:30:41 INFO - using testdate: 1466458241 14:30:41 INFO - actual date: 1466458241 14:30:41 INFO - starting webserver on 'localhost:60779' 14:30:41 INFO - SUITE-START | Running 2 tests 14:30:41 INFO - TEST-START | dromaeo_css 14:30:41 INFO - operating with platform_type : linux_ 14:30:41 INFO - Initialising browser for dromaeo_css test... 14:30:41 INFO - TEST-INFO | started process 20989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxeZRNO/profile http://localhost:60779/getInfo.html) 14:30:45 INFO - PROCESS | 20989 | __metrics Screen width/height:1600/1200 14:30:45 INFO - PROCESS | 20989 | colorDepth:24 14:30:45 INFO - PROCESS | 20989 | Browser inner width/height: 1024/697 14:30:45 INFO - PROCESS | 20989 | __metrics 14:30:46 ERROR - PROCESS | 20989 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:30:47 INFO - TEST-INFO | 20989: exit 0 14:30:47 INFO - Browser initialized. 14:30:47 INFO - Running cycle 1/1 for dromaeo_css test... 14:30:47 INFO - TEST-INFO | started process 21117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxeZRNO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:59 INFO - PROCESS | 21117 | RSS: Main: 156094464 14:30:59 INFO - PROCESS | 21117 | 14:31:48 INFO - PROCESS | 21117 | 1466458308830 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] 14:33:57 INFO - PROCESS | 21117 | Cycle 1(1): loaded http://localhost:60779/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60779/tests/dromaeo/cssquery-ext.html) 14:33:58 INFO - PROCESS | 21117 | RSS: Main: 159092736 14:33:58 INFO - PROCESS | 21117 | 14:37:00 INFO - PROCESS | 21117 | Cycle 1(1): loaded http://localhost:60779/tests/dromaeo/cssquery-ext.html (next: http://localhost:60779/tests/dromaeo/cssquery-jquery.html) 14:37:00 INFO - PROCESS | 21117 | RSS: Main: 156647424 14:37:00 INFO - PROCESS | 21117 | 14:40:02 INFO - PROCESS | 21117 | Cycle 1(1): loaded http://localhost:60779/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60779/tests/dromaeo/cssquery-mootools.html) 14:40:03 INFO - PROCESS | 21117 | RSS: Main: 157347840 14:40:03 INFO - PROCESS | 21117 | 14:43:04 INFO - PROCESS | 21117 | Cycle 1(1): loaded http://localhost:60779/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60779/tests/dromaeo/cssquery-prototype.html) 14:43:05 INFO - PROCESS | 21117 | RSS: Main: 156422144 14:43:05 INFO - PROCESS | 21117 | 14:46:07 INFO - PROCESS | 21117 | Cycle 1(1): loaded http://localhost:60779/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60779/tests/dromaeo/cssquery-yui.html) 14:46:08 INFO - PROCESS | 21117 | RSS: Main: 158605312 14:46:08 INFO - PROCESS | 21117 | 14:49:10 INFO - PROCESS | 21117 | Cycle 1(1): loaded http://localhost:60779/tests/dromaeo/cssquery-yui.html (next: http://localhost:60779/tests/dromaeo/cssquery-dojo.html) 14:49:11 INFO - PROCESS | 21117 | RSS: Main: 159080448 14:49:11 INFO - PROCESS | 21117 | 14:49:11 INFO - PROCESS | 21117 | __start_tp_report 14:49:11 INFO - PROCESS | 21117 | _x_x_mozilla_page_load 14:49:11 INFO - PROCESS | 21117 | _x_x_mozilla_page_load_details 14:49:11 INFO - PROCESS | 21117 | |i|pagename|runs| 14:49:11 INFO - PROCESS | 21117 | |0;dojo.html;3432.3650124726923;3443.1908501502157;3488.197714525659;3492.266624008958;3502.1594817243863;5887.470127688507;5915.556333275005;5948.672822994734;5990.550708696844;6000.819975400734;5980.073088671252;5980.372060933593;5982.521398288138;6027.156198132265;6027.578069535134;5283.128283833163;5419.295491586108;5441.455854414567;5471.261379713747;5514.6691198528215;5289.603279754015;5306.628536002462;5505.889882202354;5509.862253443676;5556;5371.865703357408;5387.757550910199;5401.054815407308;5416.485433883775;5431.266778984846;5387.488188622075;5397.4062853086125;5484.369297530795;5487.094629386186;5490.945090549083;5355.571554275649;5364.865878353034;5393.1370980643305;5421.620486565942;5449.100898351767;5582.553395728372;5585.636933599303;5643.661380317194;5683.318001839764;5720.427957204288;6303.747850085991;6322.336154703736;6323.30443651198;6334;6342.460890824285;6138.9095594588325;6388.1695379600815;6394.456471199907;6399.552031357807;6399.9040014399825;5813.8953598816515;5860.003799354077;5906.911396329058;5971.402859714038;5980.342162362137;6500.414962653384;6502.44729198014;6535.771248006297;6542.607443553402;6550.312217217219;6117.632942023404;6132.722655450988;6222.253329600477;6274.090256912722;6276.748930042839;6210.192674952317;6411.3909178627955;6414.61512309263;6415.13395691585;6421.4541763949655;6355.618662880242;6359.650219237987;6362.045693145972;6371.490280777527;6379.457746091634;6059.606125601822;6206;6297.905531417033;6362.363763623601;6367.777127800505;4799.0641824844515;4805.327254184417;4806.663533552688;4834.903301933941;4847.903041939212;4280.700350975402;4301.354796780508;4315.741055536678;4331.978340108342;4350.477942646839;5961.493273071837;5984.042553191555;6017.819465416044;6034.09488576717;6210.068489726577;6223.96888015557;6295.307516173218;6307.148534947723;6365.427111559982;6504.869902601921;6147;6190.535709821691;6209.192804935329;6214.098955651405;6226.813195604139;5129.487051294841;5135.666181698178;5158.948410515847;5168.508991645787;5311.628186027018;6422.6467544285515;6447.806565803034;6469.256035555877;6512.706928188148;6541.084248205255;6300.558960872695;6312.8321260566945;6320.873582528416;6321.747130114744;6328.778492752732;6423.164988551458;6512.05575191604;6586.110875031809;6621.139251897415;6711.798646040626;6355.586886852339;6377.681115944091;6383.712732926937;6384.297727249906;6385.584936979081;6124.777645458507;6407.103005579316;6448.419642232222;6449.871002580016;6457.128287681103;6079.209702738615;6109.144719739151;6115.879294474783;6143.815685529441;6158.291796443466;6159;6161.630302181883;6191.318954915046;6195.1636529068;6199.535034872312;5927.525797936069;6003.609765365412;6097.725602347817;6110.602810817282;6133;6117.005394430456;6159.507239420746;6218.378162183745;6262.843428914313;6293.37066293367;6084.60450070744;6120.7857724981195;6122.6938653068055;6129.908051379144;6136.723847426787 14:49:11 INFO - PROCESS | 21117 | |1;ext.html;600.267673438405;641.7272659119873;650.1255810934292;658.6574981009875;662.7349060375849;46120.53879461208;47883.521164788384;47901.52098479014;48346.99999999991;51470.48529514704;45862;46425.303620445724;46687.53312466874;46806.53193468064;46918.765406173006;9118.179363857269;9275.860862087075;9316.441013539175;9320.067993200693;9323.76690582734;8894;8949.731508054769;8992.05583413742;9000.414973026765;9014.143656352637;9186.86219706705;9218.492982885939;9219.815603687955;9241.861372079391;9285.907140928606;9160.770980725469;9216.815663686755;9225.308101892386;9231.353805233637;9234.492102934337;9086.273098152133;9209.447433154031;9214.585343659552;9216.308776841764;9231.076892310783;44878.32682509765;45085.54914450846;45521.77239113816;45540.772296138304;45668.314975275396;3591.910202244939;3792.27946690128;4302.677299202573;4402.295632698785;4429.003474218307;35101.47347789785;35189;35342.29315413703;35346.823265883766;35358.46962295568;3903.98048009761;4051.2910240707756;4051.351783714621;4061.3501839705505;4250.957490425087;402265;402765;403280;404016;406211;68949;69172.65413672899;69395;69647.30352696408;69709.65145174343;39591.80204098961;40498.190036199114;40642.79678601588;42097.94755131146;71702;19288.710669339973;19357.612847742967;19464.31874884372;19486.805131948782;19534;14703.338349774285;14833.332500037524;14881.851181488262;14934.626634334229;14937.70124597502;21335.573288534142;21446.24938127158;21470.463238419165;21471.355859324245;21659.458513537287;7393.778186654409;7589.810254743566;7643.40124357721;7816.648250828726;7857.1749966253865;1019.8572199892021;1138.4080278255426;1142.714321419645;1154.8325492803497;1170.3621526268205;32921.67078329234;33116.83441582777;33152;33291.16772080717;34265.65734342675;1134.5291703942937;1136.2614300704608;1190.7261329894172;1253.523661008829;1257.0697683713986;17414.511759943092;17604.207810648553;17820.91089544544;17832.286708531512;17905.552361190814;897699;913061;915248;917198;917483;63993.680031600474;64759.67620161869;64845.67577162084;64957.67521162364;64959.350406496276;1466.5600319903986;1470.2207829849983;1477.7857210704387;1495.53638372105;1508.5700575336195;32651;32970.340593187524;33514.83242583772;33543.49684754682;33635.32729345448;55783.72108139433;62784;62912.37087629065;63554.68222658857;63682.363176367646;543824;544205;544392;550837;551834;46499;46527;47983.28025079557;48290.27564586464;48301;51959.2206116901;52104;52984;53070.67323316794;53516;43162.78418607887;43885.78057109694;43944.121117578106;44187.55812441834;44729.55270447254;43474.782626086664;43489.78255108704;43591;43977.12045759131;44114.33828492511;39543.604563953995;43214.56785432105;44203.778981104886;44478.55521444874;44724.32913506235;38267.808660956514;38329.4250586247;38642.80678596701;39012.2197556053;39537.406938895365;29758.702412976458;29949.401011980073;30050.24874378158;30061.549076764302;30524.389512210077 14:49:11 INFO - PROCESS | 21117 | |2;jquery.html;431.83835482551933;437.5012485766229;438.2396541999631;439.83506185180556;453.143558674106;18700.53248668784;20411.795882041177;20749.688754668674;21601.783982160174;21647.67528487074;19379;19773;20377.898110509464;20473.18107275707;20475.590488190264;5774.855628609276;6012.458878700916;6012.75948962041;6042.9726946419;6051.092336149591;5502.5597952163735;5784.768609255625;5787.971060144714;5854.560907931901;5949.85125371867;5867.55993300502;5873;5884.2056322396575;5942.732577034022;6478.643674597895;6584.703688334036;6586.604803711793;6594.406503414716;6609.471242300629;6612.768553100643;5082.23766435034;5363.436839131913;5388.407275199725;5457.2359869618285;5936.228290322274;14501.564953051426;14664.046836955671;21271.36185914425;23890.283291501284;24076.398090047715;2248.651459023854;2267.478479949621;2289.4161988692777;2375.3705268103968;2584.612308153773;10793.514291856807;12196.57311994076;13104.34478276092;14621.92689036548;15309;2020.2626041494748;2058.4853786553363;2064.762552306474;2084.603925254212;2119.481551373082;83785;85117.57441212755;87219;87551.12448875494;88117.11882881218;11479;11890;12212.206206596542;12463.501459941683;12699.174553653984;16733.330666773192;16871.91564042172;16900.15499225034;16909.408170713967;16959.321627135025;8807.383483156245;8905.332100092519;9015.188633022928;9104.635814567475;9231.446113233227;8706.73752305912;8766.430182038148;8836.823263534694;8839.248663863644;8909.153630405232;5026.421961474477;5059.494050594984;5146.382434107856;5164.535191832753;5223.764930578133;2094.6749108489566;2136.2736669532123;2146.967795483069;2153.1279831667885;2167.0248388225364;960.6685693435753;1042.2860340666668;1067.8878717734526;1082.0153660169208;1137.3687603380204;19429.902850485658;19612.70580941287;20198.09108590117;20208.191672333236;20263.392098237076;1030.6547306652205;1031.242037102729;1040.0171837613534;1044.827603445423;1045.163868904873;11014.1739369546;11380.658580242605;11396.430178491042;11399.943000284946;11432.885671143182;486419;487707;491122;494113;515997;66908.33091669118;71072.64463677649;88925.55537222272;94079;95857.52071239738;979.1334668818147;980.666573365045;989.351974456732;997.9750506237402;1063.0379506546742;18438.72341914899;18471.353502627342;18506.352277670216;18765.437036888914;18900.905495472434;40760.388594170516;41896.790516048444;42028.78985605053;42457.36313955231;43491.347629786214;54246;58453;58786.7060664711;59013.5246618838;59040.704796475744;7185.209626940928;7830.569318687527;8227.588620568828;8984.191422771983;9018.09819018093;12451.128421010442;13047.478100875858;13082.803757943448;13265.80101298462;13345.66635834073;11841.28952262867;11886.465109069939;12021.098417618889;12229.266244025386;12233.571824986082;5605.299337582802;11181.161412894227;11219.71950701239;11370.602028928948;11721.531138754695;11644.301341919512;11678.824817627572;11700.765984680089;11770.882291176978;11856.525738970344;7599.430042746705;7990.640421181177;8046.517208967481;8920.73237802867;8957.372983891066;9017;11305.943470282597;11457.942710286396;11632.18574699763;11881.405929703307 14:49:11 INFO - PROCESS | 21117 | |3;mootools.html;1604.558746344755;1625.4798464491362;1848.7134494153402;1947.09460101053;1953.6581098307793;9487.715368538946;9784.315097943147;10054.597816087366;10180.694579162619;10255.077043066123;10048.246381521396;10103;10165.542550585224;10185.28702990791;10191.745206369844;2499.8625075620835;2532.531481675896;2532.936676583082;2556.75710807473;2560.5519034168947;2478.8016958643266;2541.3519552514176;2544.7836933860644;2553.5531282025663;2558.5010922870047;2521.747825217473;2532.8606926619027;2548.8215824892263;2554.7317531659187;2557.2839604910655;2518.055729101587;2518.874056297187;2523.2430270918653;2551.4897020595768;2551.5917453207585;2428.113738485458;2428.235105941623;2454.656348111248;2465.630155476675;2496.8876400561835;9969.75075623108;10074.69775906724;10100.343477673927;10104.141148002429;10133.543990520444;5731.885362292731;5843.590948633555;5857.85355366115;5861.150133230658;5867.970660146715;3466.5493485846678;3613.9819300903328;3620.203555217874;3635.8545658173643;3677.3748462761396;1212.1514939542355;1220.0020829303858;1224.687704635321;1243.9937800311031;1255;13821.585352439442;14014.789778153336;14108.647283817987;14114.647133821634;14193.57419277413;4893.412790465096;4948.851534453972;5212.8175513857595;5216.765245563959;5302.655327403706;11018.50416731249;11035.558577656964;11072.335659860435;11117.055050320652;11133.888661113448;5824.184614154022;5846.795362162304;5863.912041319383;5876.471117599436;5881.911771323434;4800.447948485899;5372.409035006146;5410.296661433988;5440.183972404171;5486.286782718221;4346.978265108654;4350.129974005212;4378.1900348435;4409.316555933835;4411.073674528321;1301.5899991502647;1314.6056183145017;1333.5665908579751;1335.6527302901316;1337.2578219088305;1015.7562185075528;1030.5002073994108;1030.7732298894232;1033.6330602636106;1068.433730123036;6328.6202827830475;6350.174477318012;6367.56729735815;6420.903686444707;6484.578502397329;449.9113585237387;451.1405772004337;454.45919355966294;462.7131178669179;466.3587567095244;4362.76004819738;4429.136318417942;4494.191045611821;4513.300438432048;4532.1842068427995;12058.336791476377;12314.445849936774;12358.876411235953;12405.565805196775;12429.502819887284;11679.941600291944;12285.140040197279;12317.876821231674;12380.81428778569;12497.87502124967;9222.40054396462;9306.813863722824;9352.625894964125;9411.717648470556;9432.717018489457;6351.777687780906;6361.14124593174;6598.505112116514;6627.668616569249;6668.29982851813;11120.61077862271;11376.43117844088;11540.826887596524;11546.13403994687;11558.711032223926;11496.850314968437;11681.06551475863;11729.824052639047;11878.46546905374;11895.107866909842;8547.57262136903;8813.779655508664;8867.68963086289;8885.244754195966;9032.645103234567;9753.561089750836;9773.218142548722;9814.803703926023;9872.35829671069;9890.554925028247;8461.280791132576;8747.912520874965;8760.649574016968;8785.648574056966;8793.340499462438;8539.487630741927;8542.316614670686;8736.91263087361;8741.388102832741;8834.867476987722;7631.122420921443;7640.3505702015955;7661.693532258647;7687.769366919001;7731.884021739791;5296.576273898156;5315.176147697113;5414.864628384322;5471.343438787371;5535.474129957647;5319.308489896289;5344.171653393731;5379.681977915279;5464.453554644504;5551.722413879371 14:49:11 INFO - PROCESS | 21117 | |4;prototype.html;355.95016697662317;359.1022443890274;362.50156035451243;363.29883325182385;366.79642798246977;5710.314762228539;5862.560307976908;5889.9692553803125;5963.701814909254;6009.1587177795145;5818.854528636786;5838.474537291643;5856.150858125569;5859.384764599719;5869.23699919011;4578.1759283329075;4578.908421831561;4588.49526552079;4597.471390735082;4628.398308219927;4453.465584129909;4590.632749380042;4603.480851319074;4607.2858706900315;4642.628589712815;4520.547945205486;4536.34223037661;4567.13224487348;4577.885552861172;4592.97703511482;4580.748058856761;4581.427321584802;4582.381378513891;4589.105124500724;4624.583787459128;3747.9437808432895;3948.802559871995;3972.483577134983;4079.8368065277355;4103.651189648884;5679.914801277984;5685.715714214314;5694.487496125327;5750.281214848144;5750.769969201227;5264.184051472028;5272;5273.472652734734;5281.419043905167;5308.203769434577;5878.735456904449;6194.287656919422;6201.96899015502;6215.7513699451965;6233.34549872266;4380.233459144637;4386.232409328355;4403.933940990888;4421.049474363027;4439.178751930903;6110.63336199825;6422.871542569169;6426.357364263583;6429.292777794439;6450.967945097279;4442.267025940748;4456.866294011184;4471.888202794891;4479.372887795711;4502.864914052584;4529.365888775574;4545.2954792007295;4553.2942393929;4558.931616025762;4567.885802854888;4958.355413796256;5122.692638441706;5167.767450464738;5222.164453687392;5250.317458730341;5968.313643930916;6105.603135796159;6105.8168254952425;6150.569460137837;6165.475934545614;1556.4630202580092;1568.6235303527071;1572.5832654346607;1584.6909852578638;1586.397169075744;980.1913421427352;988.8776238968823;993.279872092727;1001.5142655811925;1015.8730158730159;5380.282957106636;5381.0583147948955;5404.32445944257;5405.405405405402;5445.618806683573;5582.441755824385;5679.2333035040565;5685.630434021776;5698.230738850285;5750.30996280449;5407.756650950717;5450.236966824647;5645.745941432563;6193.349698281616;6204.7828326008375;3411.5053317269353;3422.5037369581273;3432.6567343265474;3452.5684289463816;3464.601570819388;6314.873702525923;6626.867462650816;6629.204495460575;6634.369734875179;6694.297098804653;6410.326915673881;6443.29123796382;6510.869782604322;6512.120863683437;6537.444317232993;6368.554201205871;6515.198464660147;6589.703463344161;6635.435987940982;6643.867122657616;6429.871402571829;6430.614163150226;6444.677766111769;6473.385028422293;6499.5775274607;6287.30839607652;6304.306526282014;6310.6529140895855;6339.383457218564;6344.96827515878;6421.261554921244;6629.5359324846795;6637.059831450921;6656.5401181207735;6666.76666316696;4482.260427029503;4535.591796738309;4542.432195975503;4549.499555048876;4564.383808185985;6144.846378840565;6413.326600706859;6505.837354065997;6519.771807986698;6523.380278873499;6188.504919606331;6191.288001879841;6233.314335423009;6233.470155036873;6233.844153896189;6058.606190597597;6152.292486363946;6162.383761623802;6180.289266734203;6181.134641150153;6103.389661033861;6109.2974307955155;6110.205673262448;6127.325994140552;6140.5394595406415;6215.10439316013;6223.222097237845;6224.230217553145;6297.748090076346;6300.21247344082;5919.378465261086;6059.484943779828;6100.664463454553;6119.571629985859;6153.230846144232 14:49:11 INFO - PROCESS | 21117 | |5;yui.html;787.5904529644581;823.435946376732;880.141861684857;886.6187539358075;919.4804935211607;14455.855441445583;15389;15583.688326233469;15626;15684.451044213427;14194.574162775134;14195.78706319406;14207.573772786833;14268.4292628295;14364.497242596484;728.1335211098802;855.9529225892574;856.7601071699934;859.759267405126;866.0213958227195;866.5883705239992;872.2847265242503;873.2271939333704;873.4409977614332;876.4609764994547;915.4049867586056;919.6045700348848;921.9907800921972;922.575615217001;925.3291363761286;915.629170186069;917.0416914324513;917.4449458077867;919.6321471411422;921.1203300847675;673.9494537909627;675.3988949834651;676.6650507998523;678.131991051455;678.5962352400314;14120.152790832582;14202.715945681131;14204.431822727078;14213.78679319811;14235.145891246455;12587.181833180814;13779.173249605055;14272.357743901446;14970.326335314938;16326.75509867353;13799.862001379957;14022.789658155136;14092.084014539023;14209.502667406694;14348.569542913625;4710.882227944295;4733.502982186856;4777.689450185727;4791.065742180276;4888.169011268093;80955;82089;84373.57813210956;84921;85177;11735.823962640567;11844.822327665092;11880.702982425508;11983.16117871758;12154.149209555246;21190.15239390438;21209.89395053015;21233.57532849365;21298.893505532375;21347.359579212647;7380.446466515033;7564.9243507565325;7637.274458926393;7682.654280557388;7800.92199078002;5022.497750225021;5050.318207042076;5087.058894104529;5100.1074811907765;5117.02776472469;3519.3841077811794;3632.4914511968345;3639.1084184375;3639.1811842335264;3641.035125691694;627.244170774225;645.8159424563977;659.8152517295165;664.5281849886538;665.6072916978909;590.1590233916652;610.8930937086081;618.1085877215734;667.5927684112687;685.540687739216;9149.222316103205;9214;9250.121238482334;9377.484238366955;9622.085901839455;491.930654604299;579.1631093070473;594.5392320951297;676.5095305903279;778.4395235430482;4062.6749860011128;4268.103698223345;4328.09110086879;4365.1051534436;4415.09490554442;73269;74112;75027.62486187535;126709.36645316899;132316;62678.37321626725;85248;86575;91389;108300;91865;97246.51376743213;98347.50826245823;100299.49850250702;102060.48969755252;10377.221708372053;10534.262601617813;10943;10992.890071099506;11013.2841365311;41560;47062.29406558836;51454.22818657798;54591.72704136454;55866.1620075691;81369.18630813852;81888;82569.58715206386;84745.57627211824;85760;13856;14008.894218757481;14078.296085195903;14196.290185490478;14369.425222991382;15758.76361854596;15956.920215398848;16146.838531614534;16618;16723.66552668964;14765.704685906006;15037.473688420852;15351.385944562093;15543.922280388526;15614.141222232885;14631.414743410145;14754.409823606935;14907.776383354041;15556.455524056604;16087;14678.339474723449;15266.160361180242;15272.77090843616;15318.310676019382;15632.2965466552;10812.405317707287;10937.45312734376;11191.216614837209;11191.496382662963;11688;11313.264637798517;11662.241954272946;11809.586664467046;12057.397130143634;13038.282894440517 14:49:11 INFO - PROCESS | 21117 | __end_tp_report 14:49:11 INFO - PROCESS | 21117 | __start_cc_report 14:49:11 INFO - PROCESS | 21117 | _x_x_mozilla_cycle_collect,332 14:49:11 INFO - PROCESS | 21117 | __end_cc_report 14:49:11 INFO - PROCESS | 21117 | __startTimestamp1466459351064__endTimestamp 14:49:11 INFO - PROCESS | 21117 | 14:49:11 INFO - PROCESS | 21117 | ------- Summary: start ------- 14:49:11 INFO - PROCESS | 21117 | Number of tests: 6 14:49:11 INFO - PROCESS | 21117 | 14:49:11 INFO - PROCESS | 21117 | [#0] dojo.html Cycles:165 Average:5884.18 Median:6124.78 stddev:673.68 (11.0%) stddev-sans-first:647.71 14:49:11 INFO - PROCESS | 21117 | Values: 3432.4 3443.2 3488.2 3492.3 3502.2 5887.5 5915.6 5948.7 5990.6 6000.8 5980.1 5980.4 5982.5 6027.2 6027.6 5283.1 5419.3 5441.5 5471.3 5514.7 5289.6 5306.6 5505.9 5509.9 5556.0 5371.9 5387.8 5401.1 5416.5 5431.3 5387.5 5397.4 5484.4 5487.1 5490.9 5355.6 5364.9 5393.1 5421.6 5449.1 5582.6 5585.6 5643.7 5683.3 5720.4 6303.7 6322.3 6323.3 6334.0 6342.5 6138.9 6388.2 6394.5 6399.6 6399.9 5813.9 5860.0 5906.9 5971.4 5980.3 6500.4 6502.4 6535.8 6542.6 6550.3 6117.6 6132.7 6222.3 6274.1 6276.7 6210.2 6411.4 6414.6 6415.1 6421.5 6355.6 6359.7 6362.0 6371.5 6379.5 6059.6 6206.0 6297.9 6362.4 6367.8 4799.1 4805.3 4806.7 4834.9 4847.9 4280.7 4301.4 4315.7 4332.0 4350.5 5961.5 5984.0 6017.8 6034.1 6210.1 6224.0 6295.3 6307.1 6365.4 6504.9 6147.0 6190.5 6209.2 6214.1 6226.8 5129.5 5135.7 5158.9 5168.5 5311.6 6422.6 6447.8 6469.3 6512.7 6541.1 6300.6 6312.8 6320.9 6321.7 6328.8 6423.2 6512.1 6586.1 6621.1 6711.8 6355.6 6377.7 6383.7 6384.3 6385.6 6124.8 6407.1 6448.4 6449.9 6457.1 6079.2 6109.1 6115.9 6143.8 6158.3 6159.0 6161.6 6191.3 6195.2 6199.5 5927.5 6003.6 6097.7 6110.6 6133.0 6117.0 6159.5 6218.4 6262.8 6293.4 6084.6 6120.8 6122.7 6129.9 6136.7 14:49:11 INFO - PROCESS | 21117 | 14:49:11 INFO - PROCESS | 21117 | [#1] ext.html Cycles:180 Average:77426.12 Median:24453.78 stddev:176774.17 (722.9%) stddev-sans-first:177175.96 14:49:11 INFO - PROCESS | 21117 | Values: 600.3 641.7 650.1 658.7 662.7 46120.5 47883.5 47901.5 48347.0 51470.5 45862.0 46425.3 46687.5 46806.5 46918.8 9118.2 9275.9 9316.4 9320.1 9323.8 8894.0 8949.7 8992.1 9000.4 9014.1 9186.9 9218.5 9219.8 9241.9 9285.9 9160.8 9216.8 9225.3 9231.4 9234.5 9086.3 9209.4 9214.6 9216.3 9231.1 44878.3 45085.5 45521.8 45540.8 45668.3 3591.9 3792.3 4302.7 4402.3 4429.0 35101.5 35189.0 35342.3 35346.8 35358.5 3904.0 4051.3 4051.4 4061.4 4251.0 402265.0 402765.0 403280.0 404016.0 406211.0 68949.0 69172.7 69395.0 69647.3 69709.7 39591.8 40498.2 40642.8 42097.9 71702.0 19288.7 19357.6 19464.3 19486.8 19534.0 14703.3 14833.3 14881.9 14934.6 14937.7 21335.6 21446.2 21470.5 21471.4 21659.5 7393.8 7589.8 7643.4 7816.6 7857.2 1019.9 1138.4 1142.7 1154.8 1170.4 32921.7 33116.8 33152.0 33291.2 34265.7 1134.5 1136.3 1190.7 1253.5 1257.1 17414.5 17604.2 17820.9 17832.3 17905.6 897699.0 913061.0 915248.0 917198.0 917483.0 63993.7 64759.7 64845.7 64957.7 64959.4 1466.6 1470.2 1477.8 1495.5 1508.6 32651.0 32970.3 33514.8 33543.5 33635.3 55783.7 62784.0 62912.4 63554.7 63682.4 543824.0 544205.0 544392.0 550837.0 551834.0 46499.0 46527.0 47983.3 48290.3 48301.0 51959.2 52104.0 52984.0 53070.7 53516.0 43162.8 43885.8 43944.1 44187.6 44729.6 43474.8 43489.8 43591.0 43977.1 44114.3 39543.6 43214.6 44203.8 44478.6 44724.3 38267.8 38329.4 38642.8 39012.2 39537.4 29758.7 29949.4 30050.2 30061.5 30524.4 14:49:11 INFO - PROCESS | 21117 | 14:49:11 INFO - PROCESS | 21117 | [#2] jquery.html Cycles:180 Average:29301.19 Median:23983.34 stddev:81521.11 (339.9%) stddev-sans-first:81720.97 14:49:11 INFO - PROCESS | 21117 | Values: 431.8 437.5 438.2 439.8 453.1 18700.5 20411.8 20749.7 21601.8 21647.7 19379.0 19773.0 20377.9 20473.2 20475.6 5774.9 6012.5 6012.8 6043.0 6051.1 5502.6 5784.8 5788.0 5854.6 5949.9 5867.6 5873.0 5884.2 5942.7 6478.6 6584.7 6586.6 6594.4 6609.5 6612.8 5082.2 5363.4 5388.4 5457.2 5936.2 14501.6 14664.0 21271.4 23890.3 24076.4 2248.7 2267.5 2289.4 2375.4 2584.6 10793.5 12196.6 13104.3 14621.9 15309.0 2020.3 2058.5 2064.8 2084.6 2119.5 83785.0 85117.6 87219.0 87551.1 88117.1 11479.0 11890.0 12212.2 12463.5 12699.2 16733.3 16871.9 16900.2 16909.4 16959.3 8807.4 8905.3 9015.2 9104.6 9231.4 8706.7 8766.4 8836.8 8839.2 8909.2 5026.4 5059.5 5146.4 5164.5 5223.8 2094.7 2136.3 2147.0 2153.1 2167.0 960.7 1042.3 1067.9 1082.0 1137.4 19429.9 19612.7 20198.1 20208.2 20263.4 1030.7 1031.2 1040.0 1044.8 1045.2 11014.2 11380.7 11396.4 11399.9 11432.9 486419.0 487707.0 491122.0 494113.0 515997.0 66908.3 71072.6 88925.6 94079.0 95857.5 979.1 980.7 989.4 998.0 1063.0 18438.7 18471.4 18506.4 18765.4 18900.9 40760.4 41896.8 42028.8 42457.4 43491.3 54246.0 58453.0 58786.7 59013.5 59040.7 7185.2 7830.6 8227.6 8984.2 9018.1 12451.1 13047.5 13082.8 13265.8 13345.7 11841.3 11886.5 12021.1 12229.3 12233.6 5605.3 11181.2 11219.7 11370.6 11721.5 11644.3 11678.8 11700.8 11770.9 11856.5 7599.4 7990.6 8046.5 8920.7 8957.4 9017.0 11305.9 11457.9 11632.2 11881.4 14:49:11 INFO - PROCESS | 21117 | 14:49:11 INFO - PROCESS | 21117 | [#3] mootools.html Cycles:180 Average:6466.46 Median:3656.61 stddev:3796.97 (103.8%) stddev-sans-first:3790.04 14:49:11 INFO - PROCESS | 21117 | Values: 1604.6 1625.5 1848.7 1947.1 1953.7 9487.7 9784.3 10054.6 10180.7 10255.1 10048.2 10103.0 10165.5 10185.3 10191.7 2499.9 2532.5 2532.9 2556.8 2560.6 2478.8 2541.4 2544.8 2553.6 2558.5 2521.7 2532.9 2548.8 2554.7 2557.3 2518.1 2518.9 2523.2 2551.5 2551.6 2428.1 2428.2 2454.7 2465.6 2496.9 9969.8 10074.7 10100.3 10104.1 10133.5 5731.9 5843.6 5857.9 5861.2 5868.0 3466.5 3614.0 3620.2 3635.9 3677.4 1212.2 1220.0 1224.7 1244.0 1255.0 13821.6 14014.8 14108.6 14114.6 14193.6 4893.4 4948.9 5212.8 5216.8 5302.7 11018.5 11035.6 11072.3 11117.1 11133.9 5824.2 5846.8 5863.9 5876.5 5881.9 4800.4 5372.4 5410.3 5440.2 5486.3 4347.0 4350.1 4378.2 4409.3 4411.1 1301.6 1314.6 1333.6 1335.7 1337.3 1015.8 1030.5 1030.8 1033.6 1068.4 6328.6 6350.2 6367.6 6420.9 6484.6 449.9 451.1 454.5 462.7 466.4 4362.8 4429.1 4494.2 4513.3 4532.2 12058.3 12314.4 12358.9 12405.6 12429.5 11679.9 12285.1 12317.9 12380.8 12497.9 9222.4 9306.8 9352.6 9411.7 9432.7 6351.8 6361.1 6598.5 6627.7 6668.3 11120.6 11376.4 11540.8 11546.1 11558.7 11496.9 11681.1 11729.8 11878.5 11895.1 8547.6 8813.8 8867.7 8885.2 9032.6 9753.6 9773.2 9814.8 9872.4 9890.6 8461.3 8747.9 8760.6 8785.6 8793.3 8539.5 8542.3 8736.9 8741.4 8834.9 7631.1 7640.4 7661.7 7687.8 7731.9 5296.6 5315.2 5414.9 5471.3 5535.5 5319.3 5344.2 5379.7 5464.5 5551.7 14:49:11 INFO - PROCESS | 21117 | 14:49:11 INFO - PROCESS | 21117 | [#4] prototype.html Cycles:180 Average:5171.83 Median:5784.81 stddev:1529.98 (26.4%) stddev-sans-first:1490.96 14:49:11 INFO - PROCESS | 21117 | Values: 356.0 359.1 362.5 363.3 366.8 5710.3 5862.6 5890.0 5963.7 6009.2 5818.9 5838.5 5856.2 5859.4 5869.2 4578.2 4578.9 4588.5 4597.5 4628.4 4453.5 4590.6 4603.5 4607.3 4642.6 4520.5 4536.3 4567.1 4577.9 4593.0 4580.7 4581.4 4582.4 4589.1 4624.6 3747.9 3948.8 3972.5 4079.8 4103.7 5679.9 5685.7 5694.5 5750.3 5750.8 5264.2 5272.0 5273.5 5281.4 5308.2 5878.7 6194.3 6202.0 6215.8 6233.3 4380.2 4386.2 4403.9 4421.0 4439.2 6110.6 6422.9 6426.4 6429.3 6451.0 4442.3 4456.9 4471.9 4479.4 4502.9 4529.4 4545.3 4553.3 4558.9 4567.9 4958.4 5122.7 5167.8 5222.2 5250.3 5968.3 6105.6 6105.8 6150.6 6165.5 1556.5 1568.6 1572.6 1584.7 1586.4 980.2 988.9 993.3 1001.5 1015.9 5380.3 5381.1 5404.3 5405.4 5445.6 5582.4 5679.2 5685.6 5698.2 5750.3 5407.8 5450.2 5645.7 6193.3 6204.8 3411.5 3422.5 3432.7 3452.6 3464.6 6314.9 6626.9 6629.2 6634.4 6694.3 6410.3 6443.3 6510.9 6512.1 6537.4 6368.6 6515.2 6589.7 6635.4 6643.9 6429.9 6430.6 6444.7 6473.4 6499.6 6287.3 6304.3 6310.7 6339.4 6345.0 6421.3 6629.5 6637.1 6656.5 6666.8 4482.3 4535.6 4542.4 4549.5 4564.4 6144.8 6413.3 6505.8 6519.8 6523.4 6188.5 6191.3 6233.3 6233.5 6233.8 6058.6 6152.3 6162.4 6180.3 6181.1 6103.4 6109.3 6110.2 6127.3 6140.5 6215.1 6223.2 6224.2 6297.7 6300.2 5919.4 6059.5 6100.7 6119.6 6153.2 14:49:11 INFO - PROCESS | 21117 | 14:49:11 INFO - PROCESS | 21117 | [#5] yui.html Cycles:180 Average:20973.22 Median:25738.69 stddev:29617.58 (115.1%) stddev-sans-first:29661.88 14:49:11 INFO - PROCESS | 21117 | Values: 787.6 823.4 880.1 886.6 919.5 14455.9 15389.0 15583.7 15626.0 15684.5 14194.6 14195.8 14207.6 14268.4 14364.5 728.1 856.0 856.8 859.8 866.0 866.6 872.3 873.2 873.4 876.5 915.4 919.6 922.0 922.6 925.3 915.6 917.0 917.4 919.6 921.1 673.9 675.4 676.7 678.1 678.6 14120.2 14202.7 14204.4 14213.8 14235.1 12587.2 13779.2 14272.4 14970.3 16326.8 13799.9 14022.8 14092.1 14209.5 14348.6 4710.9 4733.5 4777.7 4791.1 4888.2 80955.0 82089.0 84373.6 84921.0 85177.0 11735.8 11844.8 11880.7 11983.2 12154.1 21190.2 21209.9 21233.6 21298.9 21347.4 7380.4 7564.9 7637.3 7682.7 7800.9 5022.5 5050.3 5087.1 5100.1 5117.0 3519.4 3632.5 3639.1 3639.2 3641.0 627.2 645.8 659.8 664.5 665.6 590.2 610.9 618.1 667.6 685.5 9149.2 9214.0 9250.1 9377.5 9622.1 491.9 579.2 594.5 676.5 778.4 4062.7 4268.1 4328.1 4365.1 4415.1 73269.0 74112.0 75027.6 126709.4 132316.0 62678.4 85248.0 86575.0 91389.0 108300.0 91865.0 97246.5 98347.5 100299.5 102060.5 10377.2 10534.3 10943.0 10992.9 11013.3 41560.0 47062.3 51454.2 54591.7 55866.2 81369.2 81888.0 82569.6 84745.6 85760.0 13856.0 14008.9 14078.3 14196.3 14369.4 15758.8 15956.9 16146.8 16618.0 16723.7 14765.7 15037.5 15351.4 15543.9 15614.1 14631.4 14754.4 14907.8 15556.5 16087.0 14678.3 15266.2 15272.8 15318.3 15632.3 10812.4 10937.5 11191.2 11191.5 11688.0 11313.3 11662.2 11809.6 12057.4 13038.3 14:49:11 INFO - PROCESS | 21117 | -------- Summary: end -------- 14:49:11 INFO - PROCESS | 21117 | 14:49:11 INFO - TEST-INFO | 21117: exit 0 14:49:11 INFO - TEST-OK | dromaeo_css | took 1110666ms 14:49:11 INFO - TEST-START | kraken 14:49:11 INFO - operating with platform_type : linux_ 14:49:11 INFO - Initialising browser for kraken test... 14:49:11 INFO - TEST-INFO | started process 21360 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFlQYeR/profile http://localhost:60779/getInfo.html) 14:49:16 INFO - PROCESS | 21360 | __metrics Screen width/height:1600/1200 14:49:16 INFO - PROCESS | 21360 | colorDepth:24 14:49:16 INFO - PROCESS | 21360 | Browser inner width/height: 1024/697 14:49:16 INFO - PROCESS | 21360 | __metrics 14:49:17 ERROR - PROCESS | 21360 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:49:17 INFO - TEST-INFO | 21360: exit 0 14:49:17 INFO - Browser initialized. 14:49:17 INFO - Running cycle 1/1 for kraken test... 14:49:17 INFO - TEST-INFO | started process 21487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFlQYeR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:49:29 INFO - PROCESS | 21487 | RSS: Main: 155922432 14:49:29 INFO - PROCESS | 21487 | 14:49:32 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60779/tests/kraken/driver.html?testName=audio-beat-detection) 14:49:33 INFO - PROCESS | 21487 | RSS: Main: 160743424 14:49:33 INFO - PROCESS | 21487 | 14:49:35 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60779/tests/kraken/driver.html?testName=audio-dft) 14:49:36 INFO - PROCESS | 21487 | RSS: Main: 160190464 14:49:36 INFO - PROCESS | 21487 | 14:49:39 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60779/tests/kraken/driver.html?testName=audio-fft) 14:49:39 INFO - PROCESS | 21487 | RSS: Main: 160841728 14:49:39 INFO - PROCESS | 21487 | 14:49:41 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60779/tests/kraken/driver.html?testName=audio-oscillator) 14:49:42 INFO - PROCESS | 21487 | RSS: Main: 160505856 14:49:42 INFO - PROCESS | 21487 | 14:49:44 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60779/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:49:45 INFO - PROCESS | 21487 | RSS: Main: 160395264 14:49:45 INFO - PROCESS | 21487 | 14:49:48 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60779/tests/kraken/driver.html?testName=imaging-darkroom) 14:49:49 INFO - PROCESS | 21487 | RSS: Main: 160526336 14:49:49 INFO - PROCESS | 21487 | 14:49:52 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60779/tests/kraken/driver.html?testName=imaging-desaturate) 14:49:53 INFO - PROCESS | 21487 | RSS: Main: 160989184 14:49:53 INFO - PROCESS | 21487 | 14:49:55 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60779/tests/kraken/driver.html?testName=json-parse-financial) 14:49:56 INFO - PROCESS | 21487 | RSS: Main: 160776192 14:49:56 INFO - PROCESS | 21487 | 14:49:58 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60779/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:49:58 INFO - PROCESS | 21487 | RSS: Main: 160538624 14:49:58 INFO - PROCESS | 21487 | 14:50:00 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:50:01 INFO - PROCESS | 21487 | RSS: Main: 161128448 14:50:01 INFO - PROCESS | 21487 | 14:50:03 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:50:03 INFO - PROCESS | 21487 | RSS: Main: 160931840 14:50:03 INFO - PROCESS | 21487 | 14:50:06 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:50:06 INFO - PROCESS | 21487 | RSS: Main: 161263616 14:50:06 INFO - PROCESS | 21487 | 14:50:09 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:50:10 INFO - PROCESS | 21487 | RSS: Main: 160804864 14:50:10 INFO - PROCESS | 21487 | 14:50:11 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:60779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60779/tests/kraken/driver.html?testName=ai-astar) 14:50:12 INFO - PROCESS | 21487 | RSS: Main: 161599488 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | __start_tp_report 14:50:12 INFO - PROCESS | 21487 | _x_x_mozilla_page_load 14:50:12 INFO - PROCESS | 21487 | _x_x_mozilla_page_load_details 14:50:12 INFO - PROCESS | 21487 | |i|pagename|runs| 14:50:12 INFO - PROCESS | 21487 | |0;ai-astar;113;105;110;110;111;113;112;110;113;110 14:50:12 INFO - PROCESS | 21487 | |1;audio-beat-detection;152;124;151;176;134;152;159;127;194;135 14:50:12 INFO - PROCESS | 21487 | |2;audio-dft;163;163;161;161;162;163;162;165;164;166 14:50:12 INFO - PROCESS | 21487 | |3;audio-fft;74;73;75;176;76;74;74;75;180;75 14:50:12 INFO - PROCESS | 21487 | |4;audio-oscillator;83;83;150;84;83;84;134;83;84;145 14:50:12 INFO - PROCESS | 21487 | |5;imaging-gaussian-blur;120;118;118;117;117;117;117;117;117;118 14:50:12 INFO - PROCESS | 21487 | |6;imaging-darkroom;146;148;145;146;147;147;147;148;146;146 14:50:12 INFO - PROCESS | 21487 | |7;imaging-desaturate;95;95;97;95;94;95;95;95;95;95 14:50:12 INFO - PROCESS | 21487 | |8;json-parse-financial;51;51;52;52;57;53;52;52;52;58 14:50:12 INFO - PROCESS | 21487 | |9;json-stringify-tinderbox;61;61;61;61;60;61;63;62;60;60 14:50:12 INFO - PROCESS | 21487 | |10;stanford-crypto-aes;78;77;78;77;78;77;79;78;106;75 14:50:12 INFO - PROCESS | 21487 | |11;stanford-crypto-ccm;129;133;132;118;123;119;117;141;132;124 14:50:12 INFO - PROCESS | 21487 | |12;stanford-crypto-pbkdf2;158;155;157;155;159;154;156;155;157;151 14:50:12 INFO - PROCESS | 21487 | |13;stanford-crypto-sha256-iterative;62;61;61;67;63;62;63;61;63;59 14:50:12 INFO - PROCESS | 21487 | __end_tp_report 14:50:12 INFO - PROCESS | 21487 | __start_cc_report 14:50:12 INFO - PROCESS | 21487 | _x_x_mozilla_cycle_collect,903 14:50:12 INFO - PROCESS | 21487 | __end_cc_report 14:50:12 INFO - PROCESS | 21487 | __startTimestamp1466459412143__endTimestamp 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | ------- Summary: start ------- 14:50:12 INFO - PROCESS | 21487 | Number of tests: 14 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.41 (2.2%) stddev-sans-first:2.40 14:50:12 INFO - PROCESS | 21487 | Values: 113.0 105.0 110.0 110.0 111.0 113.0 112.0 110.0 113.0 110.0 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:152.00 stddev:22.08 (14.5%) stddev-sans-first:23.41 14:50:12 INFO - PROCESS | 21487 | Values: 152.0 124.0 151.0 176.0 134.0 152.0 159.0 127.0 194.0 135.0 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.63 (1.0%) stddev-sans-first:1.73 14:50:12 INFO - PROCESS | 21487 | Values: 163.0 163.0 161.0 161.0 162.0 163.0 162.0 165.0 164.0 166.0 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | [#3] audio-fft Cycles:10 Average:95.20 Median:74.50 stddev:43.66 (58.6%) stddev-sans-first:45.63 14:50:12 INFO - PROCESS | 21487 | Values: 74.0 73.0 75.0 176.0 76.0 74.0 74.0 75.0 180.0 75.0 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:83.00 stddev:29.04 (35.0%) stddev-sans-first:30.03 14:50:12 INFO - PROCESS | 21487 | Values: 83.0 83.0 150.0 84.0 83.0 84.0 134.0 83.0 84.0 145.0 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.97 (0.8%) stddev-sans-first:0.50 14:50:12 INFO - PROCESS | 21487 | Values: 120.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 14:50:12 INFO - PROCESS | 21487 | Values: 146.0 148.0 145.0 146.0 147.0 147.0 147.0 148.0 146.0 146.0 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 14:50:12 INFO - PROCESS | 21487 | Values: 95.0 95.0 97.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:52.00 stddev:2.45 (4.7%) stddev-sans-first:2.49 14:50:12 INFO - PROCESS | 21487 | Values: 51.0 51.0 52.0 52.0 57.0 53.0 52.0 52.0 52.0 58.0 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 14:50:12 INFO - PROCESS | 21487 | Values: 61.0 61.0 61.0 61.0 60.0 61.0 63.0 62.0 60.0 60.0 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:78.00 stddev:9.09 (11.7%) stddev-sans-first:9.61 14:50:12 INFO - PROCESS | 21487 | Values: 78.0 77.0 78.0 77.0 78.0 77.0 79.0 78.0 106.0 75.0 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:130.50 stddev:7.86 (6.0%) stddev-sans-first:8.29 14:50:12 INFO - PROCESS | 21487 | Values: 129.0 133.0 132.0 118.0 123.0 119.0 117.0 141.0 132.0 124.0 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:156.50 stddev:2.26 (1.4%) stddev-sans-first:2.24 14:50:12 INFO - PROCESS | 21487 | Values: 158.0 155.0 157.0 155.0 159.0 154.0 156.0 155.0 157.0 151.0 14:50:12 INFO - PROCESS | 21487 | 14:50:12 INFO - PROCESS | 21487 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:2.10 (3.4%) stddev-sans-first:2.22 14:50:12 INFO - PROCESS | 21487 | Values: 62.0 61.0 61.0 67.0 63.0 62.0 63.0 61.0 63.0 59.0 14:50:12 INFO - PROCESS | 21487 | -------- Summary: end -------- 14:50:12 INFO - PROCESS | 21487 | 14:50:13 INFO - TEST-INFO | 21487: exit 0 14:50:13 INFO - TEST-OK | kraken | took 61401ms 14:50:13 INFO - SUITE-END | took 1172s 14:50:13 INFO - Completed test suite (00:19:32) 14:50:13 INFO - javascript benchmark 14:50:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7808.045793762103, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3432.3650124726923, 3443.1908501502157, 3488.197714525659, 3492.266624008958, 3502.1594817243863, 5887.470127688507, 5915.556333275005, 5948.672822994734, 5990.550708696844, 6000.819975400734, 5980.073088671252, 5980.372060933593, 5982.521398288138, 6027.156198132265, 6027.578069535134, 5283.128283833163, 5419.295491586108, 5441.455854414567, 5471.261379713747, 5514.6691198528215, 5289.603279754015, 5306.628536002462, 5505.889882202354, 5509.862253443676, 5556.0, 5371.865703357408, 5387.757550910199, 5401.054815407308, 5416.485433883775, 5431.266778984846, 5387.488188622075, 5397.4062853086125, 5484.369297530795, 5487.094629386186, 5490.945090549083, 5355.571554275649, 5364.865878353034, 5393.1370980643305, 5421.620486565942, 5449.100898351767, 5582.553395728372, 5585.636933599303, 5643.661380317194, 5683.318001839764, 5720.427957204288, 6303.747850085991, 6322.336154703736, 6323.30443651198, 6334.0, 6342.460890824285, 6138.9095594588325, 6388.1695379600815, 6394.456471199907, 6399.552031357807, 6399.9040014399825, 5813.8953598816515, 5860.003799354077, 5906.911396329058, 5971.402859714038, 5980.342162362137, 6500.414962653384, 6502.44729198014, 6535.771248006297, 6542.607443553402, 6550.312217217219, 6117.632942023404, 6132.722655450988, 6222.253329600477, 6274.090256912722, 6276.748930042839, 6210.192674952317, 6411.3909178627955, 6414.61512309263, 6415.13395691585, 6421.4541763949655, 6355.618662880242, 6359.650219237987, 6362.045693145972, 6371.490280777527, 6379.457746091634, 6059.606125601822, 6206.0, 6297.905531417033, 6362.363763623601, 6367.777127800505, 4799.0641824844515, 4805.327254184417, 4806.663533552688, 4834.903301933941, 4847.903041939212, 4280.700350975402, 4301.354796780508, 4315.741055536678, 4331.978340108342, 4350.477942646839, 5961.493273071837, 5984.042553191555, 6017.819465416044, 6034.09488576717, 6210.068489726577, 6223.96888015557, 6295.307516173218, 6307.148534947723, 6365.427111559982, 6504.869902601921, 6147.0, 6190.535709821691, 6209.192804935329, 6214.098955651405, 6226.813195604139, 5129.487051294841, 5135.666181698178, 5158.948410515847, 5168.508991645787, 5311.628186027018, 6422.6467544285515, 6447.806565803034, 6469.256035555877, 6512.706928188148, 6541.084248205255, 6300.558960872695, 6312.8321260566945, 6320.873582528416, 6321.747130114744, 6328.778492752732, 6423.164988551458, 6512.05575191604, 6586.110875031809, 6621.139251897415, 6711.798646040626, 6355.586886852339, 6377.681115944091, 6383.712732926937, 6384.297727249906, 6385.584936979081, 6124.777645458507, 6407.103005579316, 6448.419642232222, 6449.871002580016, 6457.128287681103, 6079.209702738615, 6109.144719739151, 6115.879294474783, 6143.815685529441, 6158.291796443466, 6159.0, 6161.630302181883, 6191.318954915046, 6195.1636529068, 6199.535034872312, 5927.525797936069, 6003.609765365412, 6097.725602347817, 6110.602810817282, 6133.0, 6117.005394430456, 6159.507239420746, 6218.378162183745, 6262.843428914313, 6293.37066293367, 6084.60450070744, 6120.7857724981195, 6122.6938653068055, 6129.908051379144, 6136.723847426787], "value": 5838.796017100682, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.267673438405, 641.7272659119873, 650.1255810934292, 658.6574981009875, 662.7349060375849, 46120.53879461208, 47883.521164788384, 47901.52098479014, 48346.99999999991, 51470.48529514704, 45862.0, 46425.303620445724, 46687.53312466874, 46806.53193468064, 46918.765406173006, 9118.179363857269, 9275.860862087075, 9316.441013539175, 9320.067993200693, 9323.76690582734, 8894.0, 8949.731508054769, 8992.05583413742, 9000.414973026765, 9014.143656352637, 9186.86219706705, 9218.492982885939, 9219.815603687955, 9241.861372079391, 9285.907140928606, 9160.770980725469, 9216.815663686755, 9225.308101892386, 9231.353805233637, 9234.492102934337, 9086.273098152133, 9209.447433154031, 9214.585343659552, 9216.308776841764, 9231.076892310783, 44878.32682509765, 45085.54914450846, 45521.77239113816, 45540.772296138304, 45668.314975275396, 3591.910202244939, 3792.27946690128, 4302.677299202573, 4402.295632698785, 4429.003474218307, 35101.47347789785, 35189.0, 35342.29315413703, 35346.823265883766, 35358.46962295568, 3903.98048009761, 4051.2910240707756, 4051.351783714621, 4061.3501839705505, 4250.957490425087, 402265.0, 402765.0, 403280.0, 404016.0, 406211.0, 68949.0, 69172.65413672899, 69395.0, 69647.30352696408, 69709.65145174343, 39591.80204098961, 40498.190036199114, 40642.79678601588, 42097.94755131146, 71702.0, 19288.710669339973, 19357.612847742967, 19464.31874884372, 19486.805131948782, 19534.0, 14703.338349774285, 14833.332500037524, 14881.851181488262, 14934.626634334229, 14937.70124597502, 21335.573288534142, 21446.24938127158, 21470.463238419165, 21471.355859324245, 21659.458513537287, 7393.778186654409, 7589.810254743566, 7643.40124357721, 7816.648250828726, 7857.1749966253865, 1019.8572199892021, 1138.4080278255426, 1142.714321419645, 1154.8325492803497, 1170.3621526268205, 32921.67078329234, 33116.83441582777, 33152.0, 33291.16772080717, 34265.65734342675, 1134.5291703942937, 1136.2614300704608, 1190.7261329894172, 1253.523661008829, 1257.0697683713986, 17414.511759943092, 17604.207810648553, 17820.91089544544, 17832.286708531512, 17905.552361190814, 897699.0, 913061.0, 915248.0, 917198.0, 917483.0, 63993.680031600474, 64759.67620161869, 64845.67577162084, 64957.67521162364, 64959.350406496276, 1466.5600319903986, 1470.2207829849983, 1477.7857210704387, 1495.53638372105, 1508.5700575336195, 32651.0, 32970.340593187524, 33514.83242583772, 33543.49684754682, 33635.32729345448, 55783.72108139433, 62784.0, 62912.37087629065, 63554.68222658857, 63682.363176367646, 543824.0, 544205.0, 544392.0, 550837.0, 551834.0, 46499.0, 46527.0, 47983.28025079557, 48290.27564586464, 48301.0, 51959.2206116901, 52104.0, 52984.0, 53070.67323316794, 53516.0, 43162.78418607887, 43885.78057109694, 43944.121117578106, 44187.55812441834, 44729.55270447254, 43474.782626086664, 43489.78255108704, 43591.0, 43977.12045759131, 44114.33828492511, 39543.604563953995, 43214.56785432105, 44203.778981104886, 44478.55521444874, 44724.32913506235, 38267.808660956514, 38329.4250586247, 38642.80678596701, 39012.2197556053, 39537.406938895365, 29758.702412976458, 29949.401011980073, 30050.24874378158, 30061.549076764302, 30524.389512210077], "value": 22207.427851776756, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.83835482551933, 437.5012485766229, 438.2396541999631, 439.83506185180556, 453.143558674106, 18700.53248668784, 20411.795882041177, 20749.688754668674, 21601.783982160174, 21647.67528487074, 19379.0, 19773.0, 20377.898110509464, 20473.18107275707, 20475.590488190264, 5774.855628609276, 6012.458878700916, 6012.75948962041, 6042.9726946419, 6051.092336149591, 5502.5597952163735, 5784.768609255625, 5787.971060144714, 5854.560907931901, 5949.85125371867, 5867.55993300502, 5873.0, 5884.2056322396575, 5942.732577034022, 6478.643674597895, 6584.703688334036, 6586.604803711793, 6594.406503414716, 6609.471242300629, 6612.768553100643, 5082.23766435034, 5363.436839131913, 5388.407275199725, 5457.2359869618285, 5936.228290322274, 14501.564953051426, 14664.046836955671, 21271.36185914425, 23890.283291501284, 24076.398090047715, 2248.651459023854, 2267.478479949621, 2289.4161988692777, 2375.3705268103968, 2584.612308153773, 10793.514291856807, 12196.57311994076, 13104.34478276092, 14621.92689036548, 15309.0, 2020.2626041494748, 2058.4853786553363, 2064.762552306474, 2084.603925254212, 2119.481551373082, 83785.0, 85117.57441212755, 87219.0, 87551.12448875494, 88117.11882881218, 11479.0, 11890.0, 12212.206206596542, 12463.501459941683, 12699.174553653984, 16733.330666773192, 16871.91564042172, 16900.15499225034, 16909.408170713967, 16959.321627135025, 8807.383483156245, 8905.332100092519, 9015.188633022928, 9104.635814567475, 9231.446113233227, 8706.73752305912, 8766.430182038148, 8836.823263534694, 8839.248663863644, 8909.153630405232, 5026.421961474477, 5059.494050594984, 5146.382434107856, 5164.535191832753, 5223.764930578133, 2094.6749108489566, 2136.2736669532123, 2146.967795483069, 2153.1279831667885, 2167.0248388225364, 960.6685693435753, 1042.2860340666668, 1067.8878717734526, 1082.0153660169208, 1137.3687603380204, 19429.902850485658, 19612.70580941287, 20198.09108590117, 20208.191672333236, 20263.392098237076, 1030.6547306652205, 1031.242037102729, 1040.0171837613534, 1044.827603445423, 1045.163868904873, 11014.1739369546, 11380.658580242605, 11396.430178491042, 11399.943000284946, 11432.885671143182, 486419.0, 487707.0, 491122.0, 494113.0, 515997.0, 66908.33091669118, 71072.64463677649, 88925.55537222272, 94079.0, 95857.52071239738, 979.1334668818147, 980.666573365045, 989.351974456732, 997.9750506237402, 1063.0379506546742, 18438.72341914899, 18471.353502627342, 18506.352277670216, 18765.437036888914, 18900.905495472434, 40760.388594170516, 41896.790516048444, 42028.78985605053, 42457.36313955231, 43491.347629786214, 54246.0, 58453.0, 58786.7060664711, 59013.5246618838, 59040.704796475744, 7185.209626940928, 7830.569318687527, 8227.588620568828, 8984.191422771983, 9018.09819018093, 12451.128421010442, 13047.478100875858, 13082.803757943448, 13265.80101298462, 13345.66635834073, 11841.28952262867, 11886.465109069939, 12021.098417618889, 12229.266244025386, 12233.571824986082, 5605.299337582802, 11181.161412894227, 11219.71950701239, 11370.602028928948, 11721.531138754695, 11644.301341919512, 11678.824817627572, 11700.765984680089, 11770.882291176978, 11856.525738970344, 7599.430042746705, 7990.640421181177, 8046.517208967481, 8920.73237802867, 8957.372983891066, 9017.0, 11305.943470282597, 11457.942710286396, 11632.18574699763, 11881.405929703307], "value": 9530.704337691514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1604.558746344755, 1625.4798464491362, 1848.7134494153402, 1947.09460101053, 1953.6581098307793, 9487.715368538946, 9784.315097943147, 10054.597816087366, 10180.694579162619, 10255.077043066123, 10048.246381521396, 10103.0, 10165.542550585224, 10185.28702990791, 10191.745206369844, 2499.8625075620835, 2532.531481675896, 2532.936676583082, 2556.75710807473, 2560.5519034168947, 2478.8016958643266, 2541.3519552514176, 2544.7836933860644, 2553.5531282025663, 2558.5010922870047, 2521.747825217473, 2532.8606926619027, 2548.8215824892263, 2554.7317531659187, 2557.2839604910655, 2518.055729101587, 2518.874056297187, 2523.2430270918653, 2551.4897020595768, 2551.5917453207585, 2428.113738485458, 2428.235105941623, 2454.656348111248, 2465.630155476675, 2496.8876400561835, 9969.75075623108, 10074.69775906724, 10100.343477673927, 10104.141148002429, 10133.543990520444, 5731.885362292731, 5843.590948633555, 5857.85355366115, 5861.150133230658, 5867.970660146715, 3466.5493485846678, 3613.9819300903328, 3620.203555217874, 3635.8545658173643, 3677.3748462761396, 1212.1514939542355, 1220.0020829303858, 1224.687704635321, 1243.9937800311031, 1255.0, 13821.585352439442, 14014.789778153336, 14108.647283817987, 14114.647133821634, 14193.57419277413, 4893.412790465096, 4948.851534453972, 5212.8175513857595, 5216.765245563959, 5302.655327403706, 11018.50416731249, 11035.558577656964, 11072.335659860435, 11117.055050320652, 11133.888661113448, 5824.184614154022, 5846.795362162304, 5863.912041319383, 5876.471117599436, 5881.911771323434, 4800.447948485899, 5372.409035006146, 5410.296661433988, 5440.183972404171, 5486.286782718221, 4346.978265108654, 4350.129974005212, 4378.1900348435, 4409.316555933835, 4411.073674528321, 1301.5899991502647, 1314.6056183145017, 1333.5665908579751, 1335.6527302901316, 1337.2578219088305, 1015.7562185075528, 1030.5002073994108, 1030.7732298894232, 1033.6330602636106, 1068.433730123036, 6328.6202827830475, 6350.174477318012, 6367.56729735815, 6420.903686444707, 6484.578502397329, 449.9113585237387, 451.1405772004337, 454.45919355966294, 462.7131178669179, 466.3587567095244, 4362.76004819738, 4429.136318417942, 4494.191045611821, 4513.300438432048, 4532.1842068427995, 12058.336791476377, 12314.445849936774, 12358.876411235953, 12405.565805196775, 12429.502819887284, 11679.941600291944, 12285.140040197279, 12317.876821231674, 12380.81428778569, 12497.87502124967, 9222.40054396462, 9306.813863722824, 9352.625894964125, 9411.717648470556, 9432.717018489457, 6351.777687780906, 6361.14124593174, 6598.505112116514, 6627.668616569249, 6668.29982851813, 11120.61077862271, 11376.43117844088, 11540.826887596524, 11546.13403994687, 11558.711032223926, 11496.850314968437, 11681.06551475863, 11729.824052639047, 11878.46546905374, 11895.107866909842, 8547.57262136903, 8813.779655508664, 8867.68963086289, 8885.244754195966, 9032.645103234567, 9753.561089750836, 9773.218142548722, 9814.803703926023, 9872.35829671069, 9890.554925028247, 8461.280791132576, 8747.912520874965, 8760.649574016968, 8785.648574056966, 8793.340499462438, 8539.487630741927, 8542.316614670686, 8736.91263087361, 8741.388102832741, 8834.867476987722, 7631.122420921443, 7640.3505702015955, 7661.693532258647, 7687.769366919001, 7731.884021739791, 5296.576273898156, 5315.176147697113, 5414.864628384322, 5471.343438787371, 5535.474129957647, 5319.308489896289, 5344.171653393731, 5379.681977915279, 5464.453554644504, 5551.722413879371], "value": 5020.962139052402, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.95016697662317, 359.1022443890274, 362.50156035451243, 363.29883325182385, 366.79642798246977, 5710.314762228539, 5862.560307976908, 5889.9692553803125, 5963.701814909254, 6009.1587177795145, 5818.854528636786, 5838.474537291643, 5856.150858125569, 5859.384764599719, 5869.23699919011, 4578.1759283329075, 4578.908421831561, 4588.49526552079, 4597.471390735082, 4628.398308219927, 4453.465584129909, 4590.632749380042, 4603.480851319074, 4607.2858706900315, 4642.628589712815, 4520.547945205486, 4536.34223037661, 4567.13224487348, 4577.885552861172, 4592.97703511482, 4580.748058856761, 4581.427321584802, 4582.381378513891, 4589.105124500724, 4624.583787459128, 3747.9437808432895, 3948.802559871995, 3972.483577134983, 4079.8368065277355, 4103.651189648884, 5679.914801277984, 5685.715714214314, 5694.487496125327, 5750.281214848144, 5750.769969201227, 5264.184051472028, 5272.0, 5273.472652734734, 5281.419043905167, 5308.203769434577, 5878.735456904449, 6194.287656919422, 6201.96899015502, 6215.7513699451965, 6233.34549872266, 4380.233459144637, 4386.232409328355, 4403.933940990888, 4421.049474363027, 4439.178751930903, 6110.63336199825, 6422.871542569169, 6426.357364263583, 6429.292777794439, 6450.967945097279, 4442.267025940748, 4456.866294011184, 4471.888202794891, 4479.372887795711, 4502.864914052584, 4529.365888775574, 4545.2954792007295, 4553.2942393929, 4558.931616025762, 4567.885802854888, 4958.355413796256, 5122.692638441706, 5167.767450464738, 5222.164453687392, 5250.317458730341, 5968.313643930916, 6105.603135796159, 6105.8168254952425, 6150.569460137837, 6165.475934545614, 1556.4630202580092, 1568.6235303527071, 1572.5832654346607, 1584.6909852578638, 1586.397169075744, 980.1913421427352, 988.8776238968823, 993.279872092727, 1001.5142655811925, 1015.8730158730159, 5380.282957106636, 5381.0583147948955, 5404.32445944257, 5405.405405405402, 5445.618806683573, 5582.441755824385, 5679.2333035040565, 5685.630434021776, 5698.230738850285, 5750.30996280449, 5407.756650950717, 5450.236966824647, 5645.745941432563, 6193.349698281616, 6204.7828326008375, 3411.5053317269353, 3422.5037369581273, 3432.6567343265474, 3452.5684289463816, 3464.601570819388, 6314.873702525923, 6626.867462650816, 6629.204495460575, 6634.369734875179, 6694.297098804653, 6410.326915673881, 6443.29123796382, 6510.869782604322, 6512.120863683437, 6537.444317232993, 6368.554201205871, 6515.198464660147, 6589.703463344161, 6635.435987940982, 6643.867122657616, 6429.871402571829, 6430.614163150226, 6444.677766111769, 6473.385028422293, 6499.5775274607, 6287.30839607652, 6304.306526282014, 6310.6529140895855, 6339.383457218564, 6344.96827515878, 6421.261554921244, 6629.5359324846795, 6637.059831450921, 6656.5401181207735, 6666.76666316696, 4482.260427029503, 4535.591796738309, 4542.432195975503, 4549.499555048876, 4564.383808185985, 6144.846378840565, 6413.326600706859, 6505.837354065997, 6519.771807986698, 6523.380278873499, 6188.504919606331, 6191.288001879841, 6233.314335423009, 6233.470155036873, 6233.844153896189, 6058.606190597597, 6152.292486363946, 6162.383761623802, 6180.289266734203, 6181.134641150153, 6103.389661033861, 6109.2974307955155, 6110.205673262448, 6127.325994140552, 6140.5394595406415, 6215.10439316013, 6223.222097237845, 6224.230217553145, 6297.748090076346, 6300.21247344082, 5919.378465261086, 6059.484943779828, 6100.664463454553, 6119.571629985859, 6153.230846144232], "value": 4680.041183351257, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.5904529644581, 823.435946376732, 880.141861684857, 886.6187539358075, 919.4804935211607, 14455.855441445583, 15389.0, 15583.688326233469, 15626.0, 15684.451044213427, 14194.574162775134, 14195.78706319406, 14207.573772786833, 14268.4292628295, 14364.497242596484, 728.1335211098802, 855.9529225892574, 856.7601071699934, 859.759267405126, 866.0213958227195, 866.5883705239992, 872.2847265242503, 873.2271939333704, 873.4409977614332, 876.4609764994547, 915.4049867586056, 919.6045700348848, 921.9907800921972, 922.575615217001, 925.3291363761286, 915.629170186069, 917.0416914324513, 917.4449458077867, 919.6321471411422, 921.1203300847675, 673.9494537909627, 675.3988949834651, 676.6650507998523, 678.131991051455, 678.5962352400314, 14120.152790832582, 14202.715945681131, 14204.431822727078, 14213.78679319811, 14235.145891246455, 12587.181833180814, 13779.173249605055, 14272.357743901446, 14970.326335314938, 16326.75509867353, 13799.862001379957, 14022.789658155136, 14092.084014539023, 14209.502667406694, 14348.569542913625, 4710.882227944295, 4733.502982186856, 4777.689450185727, 4791.065742180276, 4888.169011268093, 80955.0, 82089.0, 84373.57813210956, 84921.0, 85177.0, 11735.823962640567, 11844.822327665092, 11880.702982425508, 11983.16117871758, 12154.149209555246, 21190.15239390438, 21209.89395053015, 21233.57532849365, 21298.893505532375, 21347.359579212647, 7380.446466515033, 7564.9243507565325, 7637.274458926393, 7682.654280557388, 7800.92199078002, 5022.497750225021, 5050.318207042076, 5087.058894104529, 5100.1074811907765, 5117.02776472469, 3519.3841077811794, 3632.4914511968345, 3639.1084184375, 3639.1811842335264, 3641.035125691694, 627.244170774225, 645.8159424563977, 659.8152517295165, 664.5281849886538, 665.6072916978909, 590.1590233916652, 610.8930937086081, 618.1085877215734, 667.5927684112687, 685.540687739216, 9149.222316103205, 9214.0, 9250.121238482334, 9377.484238366955, 9622.085901839455, 491.930654604299, 579.1631093070473, 594.5392320951297, 676.5095305903279, 778.4395235430482, 4062.6749860011128, 4268.103698223345, 4328.09110086879, 4365.1051534436, 4415.09490554442, 73269.0, 74112.0, 75027.62486187535, 126709.36645316899, 132316.0, 62678.37321626725, 85248.0, 86575.0, 91389.0, 108300.0, 91865.0, 97246.51376743213, 98347.50826245823, 100299.49850250702, 102060.48969755252, 10377.221708372053, 10534.262601617813, 10943.0, 10992.890071099506, 11013.2841365311, 41560.0, 47062.29406558836, 51454.22818657798, 54591.72704136454, 55866.1620075691, 81369.18630813852, 81888.0, 82569.58715206386, 84745.57627211824, 85760.0, 13856.0, 14008.894218757481, 14078.296085195903, 14196.290185490478, 14369.425222991382, 15758.76361854596, 15956.920215398848, 16146.838531614534, 16618.0, 16723.66552668964, 14765.704685906006, 15037.473688420852, 15351.385944562093, 15543.922280388526, 15614.141222232885, 14631.414743410145, 14754.409823606935, 14907.776383354041, 15556.455524056604, 16087.0, 14678.339474723449, 15266.160361180242, 15272.77090843616, 15318.310676019382, 15632.2965466552, 10812.405317707287, 10937.45312734376, 11191.216614837209, 11191.496382662963, 11688.0, 11313.264637798517, 11662.241954272946, 11809.586664467046, 12057.397130143634, 13038.282894440517], "value": 7802.4358715954695, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 110.0, 110.0, 111.0, 113.0, 112.0, 110.0, 113.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 151.0, 176.0, 134.0, 152.0, 159.0, 127.0, 194.0, 135.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 161.0, 162.0, 163.0, 162.0, 165.0, 164.0, 166.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 176.0, 76.0, 74.0, 74.0, 75.0, 180.0, 75.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 150.0, 84.0, 83.0, 84.0, 134.0, 83.0, 84.0, 145.0], "value": 101.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 145.0, 146.0, 147.0, 147.0, 147.0, 148.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 52.0, 57.0, 53.0, 52.0, 52.0, 52.0, 58.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 63.0, 62.0, 60.0, 60.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 78.0, 77.0, 78.0, 77.0, 79.0, 78.0, 106.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 133.0, 132.0, 118.0, 123.0, 119.0, 117.0, 141.0, 132.0, 124.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 155.0, 157.0, 155.0, 159.0, 154.0, 156.0, 155.0, 157.0, 151.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 67.0, 63.0, 62.0, 63.0, 61.0, 63.0, 59.0], "value": 62.2, "unit": "score"}]}]} 14:50:13 INFO - Return code: 0 14:50:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:50:13 ERROR - # TBPL SUCCESS # 14:50:13 INFO - Running post-action listener: _resource_record_post_action 14:50:13 INFO - ##### 14:50:13 INFO - ##### Finished run-tests step (success) 14:50:13 INFO - ##### 14:50:13 INFO - Running post-run listener: _resource_record_post_run 14:50:13 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 503734272; Read time: 312; Write time: 369348 14:50:13 INFO - TinderboxPrint: CPU usage
13.4% 14:50:13 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 312 14:50:13 INFO - TinderboxPrint: I/O write bytes / time
503,734,272 / 369,348 14:50:13 INFO - TinderboxPrint: CPU idle
8,217.6 (86.6%) 14:50:13 INFO - TinderboxPrint: CPU user
1,212.5 (12.8%) 14:50:13 INFO - TinderboxPrint: Swap in / out
0 / 0 14:50:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 240119808; Read time: 164; Write time: 220032 14:50:13 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250912768; Read time: 148; Write time: 147812 14:50:14 INFO - Running post-run listener: _upload_blobber_files 14:50:14 INFO - Blob upload gear active. 14:50:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:50:14 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 14:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:50:14 INFO - (blobuploader) - INFO - Open directory for files ... 14:50:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:50:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:50:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:50:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:50:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:50:17 INFO - (blobuploader) - INFO - Done attempting. 14:50:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:50:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:50:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:50:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:50:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:50:18 INFO - (blobuploader) - INFO - Done attempting. 14:50:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:50:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:50:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:50:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:50:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:50:19 INFO - (blobuploader) - INFO - Done attempting. 14:50:19 INFO - (blobuploader) - INFO - Iteration through files over. 14:50:19 INFO - Return code: 0 14:50:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:50:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:50:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5de30f915e1f89af659f5a3348feca2688c8b211ef5cfaa7bfe7d79e8eebe9da73a93dde08f24b9d56870e1883e45aa3ec49865ba51c9e31f1e0cb940a99992", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab6f68cdcf2ec21951f9e118dd0307ec59887136dfc6c38171b35332cb21ba54b2e96a04a3627c1de35855662088396e504c15f64f4c02f6076f839cb49827e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df111b09939d17a61528b295a93cb0294bb14536caba5693024208f56ce8e656d8100a450ce1f022620b74a3afc6ab33bb8653a28b1423259e54891b2c240ca1"} 14:50:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:50:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:50:19 INFO - Contents: 14:50:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5de30f915e1f89af659f5a3348feca2688c8b211ef5cfaa7bfe7d79e8eebe9da73a93dde08f24b9d56870e1883e45aa3ec49865ba51c9e31f1e0cb940a99992", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab6f68cdcf2ec21951f9e118dd0307ec59887136dfc6c38171b35332cb21ba54b2e96a04a3627c1de35855662088396e504c15f64f4c02f6076f839cb49827e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df111b09939d17a61528b295a93cb0294bb14536caba5693024208f56ce8e656d8100a450ce1f022620b74a3afc6ab33bb8653a28b1423259e54891b2c240ca1"} 14:50:19 INFO - Running post-run listener: copy_logs_to_upload_dir 14:50:19 INFO - Copying logs to upload dir... 14:50:19 INFO - mkdir: /builds/slave/test/build/upload/logs 14:50:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.080215 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-20 14:50:19.216082) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 14:50:19.219924) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5de30f915e1f89af659f5a3348feca2688c8b211ef5cfaa7bfe7d79e8eebe9da73a93dde08f24b9d56870e1883e45aa3ec49865ba51c9e31f1e0cb940a99992", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab6f68cdcf2ec21951f9e118dd0307ec59887136dfc6c38171b35332cb21ba54b2e96a04a3627c1de35855662088396e504c15f64f4c02f6076f839cb49827e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df111b09939d17a61528b295a93cb0294bb14536caba5693024208f56ce8e656d8100a450ce1f022620b74a3afc6ab33bb8653a28b1423259e54891b2c240ca1"} build_url:https://queue.taskcluster.net/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011195 build_url: 'https://queue.taskcluster.net/v1/task/N2zcwoffSDWCaC34sUQSZw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5de30f915e1f89af659f5a3348feca2688c8b211ef5cfaa7bfe7d79e8eebe9da73a93dde08f24b9d56870e1883e45aa3ec49865ba51c9e31f1e0cb940a99992", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab6f68cdcf2ec21951f9e118dd0307ec59887136dfc6c38171b35332cb21ba54b2e96a04a3627c1de35855662088396e504c15f64f4c02f6076f839cb49827e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df111b09939d17a61528b295a93cb0294bb14536caba5693024208f56ce8e656d8100a450ce1f022620b74a3afc6ab33bb8653a28b1423259e54891b2c240ca1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 14:50:19.245111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 14:50:19.245446) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466457266.981684-1909452496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 14:50:19.336505) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 14:50:19.336867) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 14:50:19.337186) ========= ========= Total master_lag: 0.18 =========