builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1467823941.54 results: success (0) buildid: 20160706071423 builduid: e79b1ae117c244349c0131cafaf9768d revision: 6eaa86d11a5c5dad67d5ca343e5d9226ff524517 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:21.536471) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:21.537031) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:21.537377) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:21.555742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:21.556117) ========= 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=523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 09:52:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 231M=0s 2016-07-06 09:52:21 (231 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195116 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:21.766721) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:21.767119) ========= 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=523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.116112 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:21.893908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:21.894356) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6eaa86d11a5c5dad67d5ca343e5d9226ff524517 --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 6eaa86d11a5c5dad67d5ca343e5d9226ff524517 --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=523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 09:52:21,953 truncating revision to first 12 chars 2016-07-06 09:52:21,953 Setting DEBUG logging. 2016-07-06 09:52:21,953 attempt 1/10 2016-07-06 09:52:21,953 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6eaa86d11a5c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 09:52:22,478 unpacking tar archive at: mozilla-aurora-6eaa86d11a5c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.925040 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:22.833990) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:22.834400) ========= script_repo_revision: 6eaa86d11a5c5dad67d5ca343e5d9226ff524517 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:22.834867) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:22.835341) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:22.845480) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-06 09:52:22.845834) ========= /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=523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:52:23 INFO - MultiFileLogger online at 20160706 09:52:23 in /builds/slave/test 09:52:23 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 09:52:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:52:23 INFO - {'append_to_log': False, 09:52:23 INFO - 'base_work_dir': '/builds/slave/test', 09:52:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:52:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:52:23 INFO - 'branch': 'Mozilla-Aurora', 09:52:23 INFO - 'buildbot_json_path': 'buildprops.json', 09:52:23 INFO - 'config_files': ('talos/linux_config.py',), 09:52:23 INFO - 'default_actions': ('clobber', 09:52:23 INFO - 'read-buildbot-config', 09:52:23 INFO - 'download-and-extract', 09:52:23 INFO - 'populate-webroot', 09:52:23 INFO - 'create-virtualenv', 09:52:23 INFO - 'install', 09:52:23 INFO - 'run-tests'), 09:52:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:52:23 INFO - 'download_minidump_stackwalk': True, 09:52:23 INFO - 'download_symbols': 'ondemand', 09:52:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:52:23 INFO - 'tooltool.py': '/tools/tooltool.py', 09:52:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:52:23 INFO - '/tools/misc-python/virtualenv.py')}, 09:52:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:52:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:52:23 INFO - 'installer_path': 'installer.exe', 09:52:23 INFO - 'log_level': 'info', 09:52:23 INFO - 'log_name': 'talos', 09:52:23 INFO - 'log_to_console': True, 09:52:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:52:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:52:23 INFO - 'opt_config_files': (), 09:52:23 INFO - 'pip_index': False, 09:52:23 INFO - 'sps_profile': False, 09:52:23 INFO - 'sps_profile_interval': 0, 09:52:23 INFO - 'suite': 'dromaeojs-e10s', 09:52:23 INFO - 'system_bits': '32', 09:52:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:52:23 INFO - 'title': 'talos-linux64-ix-065', 09:52:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:52:23 INFO - 'use_talos_json': True, 09:52:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:52:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:52:23 INFO - 'work_dir': 'build'} 09:52:23 INFO - ##### 09:52:23 INFO - ##### Running clobber step. 09:52:23 INFO - ##### 09:52:23 INFO - Running pre-action listener: _resource_record_pre_action 09:52:23 INFO - Running main action method: clobber 09:52:23 INFO - rmtree: /builds/slave/test/build 09:52:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:52:25 INFO - Running post-action listener: _resource_record_post_action 09:52:25 INFO - ##### 09:52:25 INFO - ##### Finished clobber step (success) 09:52:25 INFO - ##### 09:52:25 INFO - ##### 09:52:25 INFO - ##### Running read-buildbot-config step. 09:52:25 INFO - ##### 09:52:25 INFO - Running pre-action listener: _resource_record_pre_action 09:52:25 INFO - Running main action method: read_buildbot_config 09:52:25 INFO - Using buildbot properties: 09:52:25 INFO - { 09:52:25 INFO - "project": "", 09:52:25 INFO - "product": "firefox", 09:52:25 INFO - "script_repo_revision": "production", 09:52:25 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:52:25 INFO - "repository": "", 09:52:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:52:25 INFO - "buildid": "20160706071423", 09:52:25 INFO - "pgo_build": "True", 09:52:25 INFO - "basedir": "/builds/slave/test", 09:52:25 INFO - "buildnumber": 387, 09:52:25 INFO - "slavename": "talos-linux64-ix-065", 09:52:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:52:25 INFO - "platform": "ubuntu64_hw", 09:52:25 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:52:25 INFO - "branch": "mozilla-aurora", 09:52:25 INFO - "repo_path": "releases/mozilla-aurora", 09:52:25 INFO - "revision": "6eaa86d11a5c5dad67d5ca343e5d9226ff524517", 09:52:25 INFO - "stage_platform": "linux64-pgo", 09:52:25 INFO - "builduid": "e79b1ae117c244349c0131cafaf9768d", 09:52:25 INFO - "slavebuilddir": "test" 09:52:25 INFO - } 09:52:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 09:52:25 INFO - Running post-action listener: _resource_record_post_action 09:52:25 INFO - ##### 09:52:25 INFO - ##### Finished read-buildbot-config step (success) 09:52:25 INFO - ##### 09:52:25 INFO - ##### 09:52:25 INFO - ##### Running download-and-extract step. 09:52:25 INFO - ##### 09:52:25 INFO - Running pre-action listener: _resource_record_pre_action 09:52:25 INFO - Running main action method: download_and_extract 09:52:25 INFO - mkdir: /builds/slave/test/build/tests 09:52:25 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')]} 09:52:25 INFO - https://queue.taskcluster.net/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:52:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:52:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:52:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/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 09:52:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/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 09:52:25 INFO - Downloaded 1361 bytes. 09:52:25 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:52:25 INFO - Using the following test package requirements: 09:52:25 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 09:52:25 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:25 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:52:25 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:25 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:52:25 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:25 INFO - u'jsshell-linux-x86_64.zip'], 09:52:25 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:25 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:52:25 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 09:52:25 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:25 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:52:25 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:25 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:52:25 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:25 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:52:25 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:25 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:52:25 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:52:25 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')]} 09:52:25 INFO - https://queue.taskcluster.net/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:52:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:52:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:52:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/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 09:52:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/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 09:52:26 INFO - Downloaded 24526481 bytes. 09:52:26 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'] 09:52:26 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 09:52:28 INFO - Return code: 0 09:52:28 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 09:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:28 INFO - https://queue.taskcluster.net/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:52:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:52:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:52:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/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 09:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/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 09:52:32 INFO - Downloaded 24526481 bytes. 09:52:32 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'] 09:52:32 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 09:52:33 INFO - Return code: 0 09:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:33 INFO - https://queue.taskcluster.net/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:52:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 09:52:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 09:52:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/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 09:52:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/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 09:52:34 INFO - Downloaded 10833369 bytes. 09:52:34 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'] 09:52:34 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 09:52:35 INFO - Return code: 0 09:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:35 INFO - https://queue.taskcluster.net/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:52:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:52:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:52:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/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 09:52:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KXMC135eQ2iyjXRcNVKzWA/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 09:52:36 INFO - Downloaded 63638120 bytes. 09:52:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:52:36 INFO - mkdir: /builds/slave/test/properties 09:52:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:52:36 INFO - Writing to file /builds/slave/test/properties/build_url 09:52:36 INFO - Contents: 09:52:36 INFO - build_url:https://queue.taskcluster.net/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:52:37 INFO - Running post-action listener: _resource_record_post_action 09:52:37 INFO - Running post-action listener: set_extra_try_arguments 09:52:37 INFO - ##### 09:52:37 INFO - ##### Finished download-and-extract step (success) 09:52:37 INFO - ##### 09:52:37 INFO - ##### 09:52:37 INFO - ##### Running populate-webroot step. 09:52:37 INFO - ##### 09:52:37 INFO - Running pre-action listener: _resource_record_pre_action 09:52:37 INFO - Running main action method: populate_webroot 09:52:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:52:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:52:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:52:37 INFO - '--tppagecycles', 09:52:37 INFO - '7'], 09:52:37 INFO - 'tests': ['tsvgm']}}, 09:52:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:52:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:52:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:52:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:52:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:52:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:52:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:37 INFO - 'talos_options': ['--disable-e10s'], 09:52:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:37 INFO - 'talos_options': ['--disable-e10s'], 09:52:37 INFO - 'tests': ['damp', 'tps']}, 09:52:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:37 INFO - 'tests': ['damp', 'tps']}, 09:52:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:52:37 INFO - 'tests': ['dromaeo_dom']}, 09:52:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:52:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:52:37 INFO - 'tests': ['a11yr', 09:52:37 INFO - 'ts_paint', 09:52:37 INFO - 'tpaint', 09:52:37 INFO - 'sessionrestore', 09:52:37 INFO - 'sessionrestore_no_auto_restore', 09:52:37 INFO - 'tabpaint']}, 09:52:37 INFO - 'other-e10s': {'tests': ['a11yr', 09:52:37 INFO - 'ts_paint', 09:52:37 INFO - 'tpaint', 09:52:37 INFO - 'sessionrestore', 09:52:37 INFO - 'sessionrestore_no_auto_restore', 09:52:37 INFO - 'tabpaint']}, 09:52:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:52:37 INFO - 'ts_paint', 09:52:37 INFO - 'tpaint', 09:52:37 INFO - 'sessionrestore', 09:52:37 INFO - 'sessionrestore_no_auto_restore', 09:52:37 INFO - 'tabpaint']}, 09:52:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:52:37 INFO - 'ts_paint', 09:52:37 INFO - 'tpaint', 09:52:37 INFO - 'sessionrestore', 09:52:37 INFO - 'sessionrestore_no_auto_restore', 09:52:37 INFO - 'tabpaint']}, 09:52:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:52:37 INFO - 'tests': ['a11yr', 09:52:37 INFO - 'ts_paint', 09:52:37 INFO - 'tpaint', 09:52:37 INFO - 'sessionrestore', 09:52:37 INFO - 'sessionrestore_no_auto_restore', 09:52:37 INFO - 'tabpaint']}, 09:52:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:52:37 INFO - 'tests': ['a11yr', 09:52:37 INFO - 'ts_paint', 09:52:37 INFO - 'tpaint', 09:52:37 INFO - 'sessionrestore', 09:52:37 INFO - 'sessionrestore_no_auto_restore', 09:52:37 INFO - 'tabpaint']}, 09:52:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:52:37 INFO - 'tests': ['tsvgx', 09:52:37 INFO - 'tsvgr_opacity', 09:52:37 INFO - 'tart', 09:52:37 INFO - 'tscrollx', 09:52:37 INFO - 'cart']}, 09:52:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:52:37 INFO - 'tsvgr_opacity', 09:52:37 INFO - 'tart', 09:52:37 INFO - 'tscrollx', 09:52:37 INFO - 'cart']}, 09:52:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:37 INFO - 'talos_options': ['--disable-e10s'], 09:52:37 INFO - 'tests': ['tp5o']}, 09:52:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:37 INFO - 'tests': ['tp5o']}, 09:52:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:37 INFO - 'talos_options': ['--disable-e10s', 09:52:37 INFO - '--xperf_path', 09:52:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:37 INFO - 'tests': ['tp5n']}, 09:52:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:37 INFO - 'talos_options': ['--xperf_path', 09:52:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:37 INFO - 'tests': ['tp5n']}}, 09:52:37 INFO - 'talos.zip': {'path': '', 09:52:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:52:37 INFO - Running post-action listener: _resource_record_post_action 09:52:37 INFO - ##### 09:52:37 INFO - ##### Finished populate-webroot step (success) 09:52:37 INFO - ##### 09:52:37 INFO - ##### 09:52:37 INFO - ##### Running create-virtualenv step. 09:52:37 INFO - ##### 09:52:37 INFO - Running pre-action listener: _resource_record_pre_action 09:52:37 INFO - Running main action method: create_virtualenv 09:52:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:52:37 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 09:52:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:52:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:52:38 INFO - Using real prefix '/usr' 09:52:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:52:39 INFO - Installing distribute.............................................................................................................................................................................................done. 09:52:41 INFO - Installing pip.................done. 09:52:41 INFO - Return code: 0 09:52:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:41 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 0x7fa97a471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d92e0>, '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 0x2245140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22455d0>, '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': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', '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 09:52:41 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 09:52:41 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 09:52:41 INFO - Using env: {'DISPLAY': ':0', 09:52:41 INFO - 'HOME': '/home/cltbld', 09:52:41 INFO - 'LANG': 'en_US.UTF-8', 09:52:41 INFO - 'LANGUAGE': 'en_US:en', 09:52:41 INFO - 'LOGNAME': 'cltbld', 09:52:41 INFO - 'MAIL': '/var/mail/cltbld', 09:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:41 INFO - 'MOZ_NO_REMOTE': '1', 09:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:41 INFO - 'NO_EM_RESTART': '1', 09:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:41 INFO - 'PWD': '/builds/slave/test', 09:52:41 INFO - 'SHELL': '/bin/bash', 09:52:41 INFO - 'SHLVL': '1', 09:52:41 INFO - 'TERM': 'linux', 09:52:41 INFO - 'TMOUT': '86400', 09:52:41 INFO - 'USER': 'cltbld', 09:52:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', 09:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:41 INFO - '_': '/tools/buildbot/bin/python'} 09:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:41 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 09:52:41 INFO - Cleaning up... 09:52:41 INFO - Return code: 0 09:52:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:41 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 0x7fa97a471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d92e0>, '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 0x2245140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22455d0>, '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': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', '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 09:52:41 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 09:52:41 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 09:52:41 INFO - Using env: {'DISPLAY': ':0', 09:52:41 INFO - 'HOME': '/home/cltbld', 09:52:41 INFO - 'LANG': 'en_US.UTF-8', 09:52:41 INFO - 'LANGUAGE': 'en_US:en', 09:52:41 INFO - 'LOGNAME': 'cltbld', 09:52:41 INFO - 'MAIL': '/var/mail/cltbld', 09:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:41 INFO - 'MOZ_NO_REMOTE': '1', 09:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:41 INFO - 'NO_EM_RESTART': '1', 09:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:41 INFO - 'PWD': '/builds/slave/test', 09:52:41 INFO - 'SHELL': '/bin/bash', 09:52:41 INFO - 'SHLVL': '1', 09:52:41 INFO - 'TERM': 'linux', 09:52:41 INFO - 'TMOUT': '86400', 09:52:41 INFO - 'USER': 'cltbld', 09:52:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', 09:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:41 INFO - '_': '/tools/buildbot/bin/python'} 09:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:41 INFO - Downloading/unpacking psutil>=3.1.1 09:52:41 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 09:52:41 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 09:52:41 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 09:52:41 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 09:52:41 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 09:52:41 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 09:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:52:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:43 INFO - Installing collected packages: psutil 09:52:43 INFO - Running setup.py install for psutil 09:52:43 INFO - building 'psutil._psutil_linux' extension 09:52:43 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 09:52:44 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 09:52:44 INFO - building 'psutil._psutil_posix' extension 09:52:44 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 09:52:44 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 09:52:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:44 INFO - Successfully installed psutil 09:52:44 INFO - Cleaning up... 09:52:44 INFO - Return code: 0 09:52:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:52:44 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')]} 09:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:44 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')]} 09:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:44 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 0x7fa97a471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d92e0>, '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 0x2245140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22455d0>, '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': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', '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 09:52:44 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 09:52:44 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 09:52:44 INFO - Using env: {'DISPLAY': ':0', 09:52:44 INFO - 'HOME': '/home/cltbld', 09:52:44 INFO - 'LANG': 'en_US.UTF-8', 09:52:44 INFO - 'LANGUAGE': 'en_US:en', 09:52:44 INFO - 'LOGNAME': 'cltbld', 09:52:44 INFO - 'MAIL': '/var/mail/cltbld', 09:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:44 INFO - 'MOZ_NO_REMOTE': '1', 09:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:44 INFO - 'NO_EM_RESTART': '1', 09:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:44 INFO - 'PWD': '/builds/slave/test', 09:52:44 INFO - 'SHELL': '/bin/bash', 09:52:44 INFO - 'SHLVL': '1', 09:52:44 INFO - 'TERM': 'linux', 09:52:44 INFO - 'TMOUT': '86400', 09:52:44 INFO - 'USER': 'cltbld', 09:52:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', 09:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:44 INFO - '_': '/tools/buildbot/bin/python'} 09:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:52:45 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 09:52:45 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 09:52:45 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 09:52:45 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 09:52:45 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 09:52:45 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 09:52:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:52:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:52:47 INFO - Installing collected packages: mozsystemmonitor 09:52:47 INFO - Running setup.py install for mozsystemmonitor 09:52:47 INFO - Successfully installed mozsystemmonitor 09:52:47 INFO - Cleaning up... 09:52:47 INFO - Return code: 0 09:52:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:52:47 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')]} 09:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:47 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')]} 09:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:47 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 0x7fa97a471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d92e0>, '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 0x2245140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22455d0>, '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': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', '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 09:52:47 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 09:52:47 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 09:52:47 INFO - Using env: {'DISPLAY': ':0', 09:52:47 INFO - 'HOME': '/home/cltbld', 09:52:47 INFO - 'LANG': 'en_US.UTF-8', 09:52:47 INFO - 'LANGUAGE': 'en_US:en', 09:52:47 INFO - 'LOGNAME': 'cltbld', 09:52:47 INFO - 'MAIL': '/var/mail/cltbld', 09:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:47 INFO - 'MOZ_NO_REMOTE': '1', 09:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:47 INFO - 'NO_EM_RESTART': '1', 09:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:47 INFO - 'PWD': '/builds/slave/test', 09:52:47 INFO - 'SHELL': '/bin/bash', 09:52:47 INFO - 'SHLVL': '1', 09:52:47 INFO - 'TERM': 'linux', 09:52:47 INFO - 'TMOUT': '86400', 09:52:47 INFO - 'USER': 'cltbld', 09:52:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', 09:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:47 INFO - '_': '/tools/buildbot/bin/python'} 09:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:47 INFO - Downloading/unpacking jsonschema==2.5.1 09:52:47 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 09:52:47 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 09:52:47 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 09:52:47 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 09:52:47 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 09:52:47 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 09:52:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:52:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:52:49 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 09:52:49 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 09:52:49 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 09:52:49 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 09:52:49 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 09:52:49 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 09:52:49 INFO - Downloading functools32-3.2.3-2.tar.gz 09:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:52:49 INFO - warning: no files found matching '*.txt' 09:52:49 INFO - no previously-included directories found matching 'build' 09:52:49 INFO - no previously-included directories found matching 'dist' 09:52:49 INFO - no previously-included directories found matching '.git*' 09:52:49 INFO - Installing collected packages: jsonschema, functools32 09:52:49 INFO - Running setup.py install for functools32 09:52:49 INFO - warning: no files found matching '*.txt' 09:52:49 INFO - no previously-included directories found matching 'build' 09:52:49 INFO - no previously-included directories found matching 'dist' 09:52:49 INFO - no previously-included directories found matching '.git*' 09:52:49 INFO - Successfully installed jsonschema functools32 09:52:49 INFO - Cleaning up... 09:52:49 INFO - Return code: 0 09:52:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa97a471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d92e0>, '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 0x2245140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22455d0>, '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': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', '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 09:52:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:52:49 INFO - Using env: {'DISPLAY': ':0', 09:52:49 INFO - 'HOME': '/home/cltbld', 09:52:49 INFO - 'LANG': 'en_US.UTF-8', 09:52:49 INFO - 'LANGUAGE': 'en_US:en', 09:52:49 INFO - 'LOGNAME': 'cltbld', 09:52:49 INFO - 'MAIL': '/var/mail/cltbld', 09:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:49 INFO - 'MOZ_NO_REMOTE': '1', 09:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:49 INFO - 'NO_EM_RESTART': '1', 09:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:49 INFO - 'PWD': '/builds/slave/test', 09:52:49 INFO - 'SHELL': '/bin/bash', 09:52:49 INFO - 'SHLVL': '1', 09:52:49 INFO - 'TERM': 'linux', 09:52:49 INFO - 'TMOUT': '86400', 09:52:49 INFO - 'USER': 'cltbld', 09:52:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', 09:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:49 INFO - '_': '/tools/buildbot/bin/python'} 09:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:50 INFO - Downloading/unpacking blobuploader==1.2.4 09:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:51 INFO - Downloading blobuploader-1.2.4.tar.gz 09:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:52:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:52:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:52 INFO - Downloading docopt-0.6.1.tar.gz 09:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:52:52 INFO - Installing collected packages: blobuploader, requests, docopt 09:52:52 INFO - Running setup.py install for blobuploader 09:52:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:52:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:52:52 INFO - Running setup.py install for requests 09:52:53 INFO - Running setup.py install for docopt 09:52:53 INFO - Successfully installed blobuploader requests docopt 09:52:53 INFO - Cleaning up... 09:52:53 INFO - Return code: 0 09:52:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:53 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 0x7fa97a471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d92e0>, '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 0x2245140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22455d0>, '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': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', '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 09:52:53 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 09:52:53 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 09:52:53 INFO - Using env: {'DISPLAY': ':0', 09:52:53 INFO - 'HOME': '/home/cltbld', 09:52:53 INFO - 'LANG': 'en_US.UTF-8', 09:52:53 INFO - 'LANGUAGE': 'en_US:en', 09:52:53 INFO - 'LOGNAME': 'cltbld', 09:52:53 INFO - 'MAIL': '/var/mail/cltbld', 09:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:53 INFO - 'MOZ_NO_REMOTE': '1', 09:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:53 INFO - 'NO_EM_RESTART': '1', 09:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:53 INFO - 'PWD': '/builds/slave/test', 09:52:53 INFO - 'SHELL': '/bin/bash', 09:52:53 INFO - 'SHLVL': '1', 09:52:53 INFO - 'TERM': 'linux', 09:52:53 INFO - 'TMOUT': '86400', 09:52:53 INFO - 'USER': 'cltbld', 09:52:53 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', 09:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:53 INFO - '_': '/tools/buildbot/bin/python'} 09:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:52:53 INFO - Running setup.py (path:/tmp/pip-Dsb1eA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:52:53 INFO - Running setup.py (path:/tmp/pip-5HCKIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:52:53 INFO - Running setup.py (path:/tmp/pip-b8ygXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:52:53 INFO - Running setup.py (path:/tmp/pip-WVIQFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:52:53 INFO - Running setup.py (path:/tmp/pip-_MbiUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:52:53 INFO - Running setup.py (path:/tmp/pip-4qtZYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:52:54 INFO - Running setup.py (path:/tmp/pip-3wNoC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:52:54 INFO - Running setup.py (path:/tmp/pip-X1uLli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:52:54 INFO - Running setup.py (path:/tmp/pip-B0Xf8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:52:54 INFO - Running setup.py (path:/tmp/pip-pcf7vN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:52:54 INFO - Running setup.py (path:/tmp/pip-bgJ0Hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:52:54 INFO - Running setup.py (path:/tmp/pip-gsp57c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:52:54 INFO - Running setup.py (path:/tmp/pip-xlvwn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:52:54 INFO - Running setup.py (path:/tmp/pip-4gw08v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:54 INFO - Running setup.py (path:/tmp/pip-I18TDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:52:54 INFO - Running setup.py (path:/tmp/pip-aZhJa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:52:54 INFO - Running setup.py (path:/tmp/pip-xwuUYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:52:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:52:54 INFO - Running setup.py install for manifestparser 09:52:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:52:54 INFO - Running setup.py install for mozcrash 09:52:55 INFO - Running setup.py install for mozdebug 09:52:55 INFO - Running setup.py install for mozdevice 09:52:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:52:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:52:55 INFO - Running setup.py install for mozfile 09:52:55 INFO - Running setup.py install for mozhttpd 09:52:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:52:55 INFO - Running setup.py install for mozinfo 09:52:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:52:55 INFO - Running setup.py install for mozInstall 09:52:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:52:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:52:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:52:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:52:55 INFO - Running setup.py install for mozleak 09:52:55 INFO - Running setup.py install for mozlog 09:52:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:52:55 INFO - Running setup.py install for moznetwork 09:52:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:52:55 INFO - Running setup.py install for mozprocess 09:52:56 INFO - Running setup.py install for mozprofile 09:52:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:52:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:52:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:52:56 INFO - Running setup.py install for mozrunner 09:52:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:52:56 INFO - Running setup.py install for mozscreenshot 09:52:56 INFO - Running setup.py install for moztest 09:52:56 INFO - Running setup.py install for mozversion 09:52:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:52:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:52:56 INFO - Cleaning up... 09:52:56 INFO - Return code: 0 09:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:56 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 0x7fa97a471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d92e0>, '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 0x2245140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22455d0>, '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': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', '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 09:52:56 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 09:52:56 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 09:52:56 INFO - Using env: {'DISPLAY': ':0', 09:52:56 INFO - 'HOME': '/home/cltbld', 09:52:56 INFO - 'LANG': 'en_US.UTF-8', 09:52:56 INFO - 'LANGUAGE': 'en_US:en', 09:52:56 INFO - 'LOGNAME': 'cltbld', 09:52:56 INFO - 'MAIL': '/var/mail/cltbld', 09:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:56 INFO - 'MOZ_NO_REMOTE': '1', 09:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:56 INFO - 'NO_EM_RESTART': '1', 09:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:56 INFO - 'PWD': '/builds/slave/test', 09:52:56 INFO - 'SHELL': '/bin/bash', 09:52:56 INFO - 'SHLVL': '1', 09:52:56 INFO - 'TERM': 'linux', 09:52:56 INFO - 'TMOUT': '86400', 09:52:56 INFO - 'USER': 'cltbld', 09:52:56 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', 09:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:56 INFO - '_': '/tools/buildbot/bin/python'} 09:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:52:56 INFO - Running setup.py (path:/tmp/pip-aZWCsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:52:56 INFO - Running setup.py (path:/tmp/pip-9ayy2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:52:56 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)) 09:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:52:56 INFO - Running setup.py (path:/tmp/pip-NSfmjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:52:57 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)) 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:52:57 INFO - Running setup.py (path:/tmp/pip-iL9c7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:52:57 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)) 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:52:57 INFO - Running setup.py (path:/tmp/pip-R4RRXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:52:57 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)) 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:52:57 INFO - Running setup.py (path:/tmp/pip-tLV519-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:52:57 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)) 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:52:57 INFO - Running setup.py (path:/tmp/pip-MA8SG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:52:57 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)) 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:52:57 INFO - Running setup.py (path:/tmp/pip-7Arskg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:52:57 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)) 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:52:57 INFO - Running setup.py (path:/tmp/pip-RF7kXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:52:57 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)) 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:52:57 INFO - Running setup.py (path:/tmp/pip-qODK1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:52:57 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)) 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:52:57 INFO - Running setup.py (path:/tmp/pip-js_Wq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:52:57 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)) 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:52:57 INFO - Running setup.py (path:/tmp/pip-SD01S2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:52:57 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)) 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:52:57 INFO - Running setup.py (path:/tmp/pip-fCtcfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:52:57 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)) 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:52:57 INFO - Running setup.py (path:/tmp/pip-YozIeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:52:57 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)) 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:57 INFO - Running setup.py (path:/tmp/pip-dLxJIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:57 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)) 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:52:57 INFO - Running setup.py (path:/tmp/pip-Ng1pxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:52:58 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)) 09:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:52:58 INFO - Running setup.py (path:/tmp/pip-9e6S48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:52:58 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)) 09:52:58 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)) 09:52:58 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)) 09:52:58 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)) 09:52:58 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)) 09:52:58 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)) 09:52:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:00 INFO - Downloading blessings-1.6.tar.gz 09:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:53:00 INFO - Installing collected packages: blessings 09:53:00 INFO - Running setup.py install for blessings 09:53:00 INFO - Successfully installed blessings 09:53:00 INFO - Cleaning up... 09:53:00 INFO - Return code: 0 09:53:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:53:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:00 INFO - Reading from file tmpfile_stdout 09:53:00 INFO - Current package versions: 09:53:00 INFO - argparse == 1.2.1 09:53:00 INFO - blessings == 1.6 09:53:00 INFO - blobuploader == 1.2.4 09:53:00 INFO - docopt == 0.6.1 09:53:00 INFO - functools32 == 3.2.3-2 09:53:00 INFO - jsonschema == 2.5.1 09:53:00 INFO - manifestparser == 1.1 09:53:00 INFO - mozInstall == 1.12 09:53:00 INFO - mozcrash == 0.17 09:53:00 INFO - mozdebug == 0.1 09:53:00 INFO - mozdevice == 0.48 09:53:00 INFO - mozfile == 1.2 09:53:00 INFO - mozhttpd == 0.7 09:53:00 INFO - mozinfo == 0.9 09:53:00 INFO - mozleak == 0.1 09:53:00 INFO - mozlog == 3.2 09:53:00 INFO - moznetwork == 0.27 09:53:00 INFO - mozprocess == 0.22 09:53:00 INFO - mozprofile == 0.28 09:53:00 INFO - mozrunner == 6.11 09:53:00 INFO - mozscreenshot == 0.1 09:53:00 INFO - mozsystemmonitor == 0.3 09:53:00 INFO - moztest == 0.7 09:53:00 INFO - mozversion == 1.4 09:53:00 INFO - psutil == 3.1.1 09:53:00 INFO - requests == 1.2.3 09:53:00 INFO - wsgiref == 0.1.2 09:53:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:00 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 0x7fa97a471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d92e0>, '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 0x2245140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22455d0>, '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': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', '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 09:53:00 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 09:53:00 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 09:53:00 INFO - Using env: {'DISPLAY': ':0', 09:53:00 INFO - 'HOME': '/home/cltbld', 09:53:00 INFO - 'LANG': 'en_US.UTF-8', 09:53:00 INFO - 'LANGUAGE': 'en_US:en', 09:53:00 INFO - 'LOGNAME': 'cltbld', 09:53:00 INFO - 'MAIL': '/var/mail/cltbld', 09:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:00 INFO - 'MOZ_NO_REMOTE': '1', 09:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:00 INFO - 'NO_EM_RESTART': '1', 09:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:00 INFO - 'PWD': '/builds/slave/test', 09:53:00 INFO - 'SHELL': '/bin/bash', 09:53:00 INFO - 'SHLVL': '1', 09:53:00 INFO - 'TERM': 'linux', 09:53:00 INFO - 'TMOUT': '86400', 09:53:00 INFO - 'USER': 'cltbld', 09:53:00 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', 09:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:00 INFO - '_': '/tools/buildbot/bin/python'} 09:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:00 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)) 09:53:00 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)) 09:53:00 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)) 09:53:00 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)) 09:53:00 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)) 09:53:00 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)) 09:53:00 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)) 09:53:00 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)) 09:53:00 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)) 09:53:00 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)) 09:53:00 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)) 09:53:00 INFO - Cleaning up... 09:53:00 INFO - Return code: 0 09:53:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:00 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 0x7fa97a471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d92e0>, '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 0x2245140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22455d0>, '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': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', '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 09:53:00 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 09:53:00 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 09:53:00 INFO - Using env: {'DISPLAY': ':0', 09:53:00 INFO - 'HOME': '/home/cltbld', 09:53:00 INFO - 'LANG': 'en_US.UTF-8', 09:53:00 INFO - 'LANGUAGE': 'en_US:en', 09:53:00 INFO - 'LOGNAME': 'cltbld', 09:53:00 INFO - 'MAIL': '/var/mail/cltbld', 09:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:00 INFO - 'MOZ_NO_REMOTE': '1', 09:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:00 INFO - 'NO_EM_RESTART': '1', 09:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:00 INFO - 'PWD': '/builds/slave/test', 09:53:00 INFO - 'SHELL': '/bin/bash', 09:53:00 INFO - 'SHLVL': '1', 09:53:00 INFO - 'TERM': 'linux', 09:53:00 INFO - 'TMOUT': '86400', 09:53:00 INFO - 'USER': 'cltbld', 09:53:00 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', 09:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:00 INFO - '_': '/tools/buildbot/bin/python'} 09:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:53:00 INFO - Cleaning up... 09:53:00 INFO - Return code: 0 09:53:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:00 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 0x7fa97a471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2247020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d92e0>, '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 0x2245140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22455d0>, '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': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', '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 09:53:00 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 09:53:00 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 09:53:00 INFO - Using env: {'DISPLAY': ':0', 09:53:00 INFO - 'HOME': '/home/cltbld', 09:53:00 INFO - 'LANG': 'en_US.UTF-8', 09:53:00 INFO - 'LANGUAGE': 'en_US:en', 09:53:00 INFO - 'LOGNAME': 'cltbld', 09:53:00 INFO - 'MAIL': '/var/mail/cltbld', 09:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:00 INFO - 'MOZ_NO_REMOTE': '1', 09:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:00 INFO - 'NO_EM_RESTART': '1', 09:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:00 INFO - 'PWD': '/builds/slave/test', 09:53:00 INFO - 'SHELL': '/bin/bash', 09:53:00 INFO - 'SHLVL': '1', 09:53:00 INFO - 'TERM': 'linux', 09:53:00 INFO - 'TMOUT': '86400', 09:53:00 INFO - 'USER': 'cltbld', 09:53:00 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', 09:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:00 INFO - '_': '/tools/buildbot/bin/python'} 09:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:01 INFO - Downloading/unpacking flake8 09:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:53:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:53:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:53:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:53:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:53:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:53:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:53:03 INFO - no previously-included directories found matching 'docs/_build' 09:53:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:53:03 INFO - Running setup.py install for pep8 09:53:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:53:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:53:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:53:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:53:03 INFO - no previously-included directories found matching 'docs/_build' 09:53:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:53:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:53:03 INFO - Cleaning up... 09:53:04 INFO - Return code: 0 09:53:04 INFO - Running post-action listener: _resource_record_post_action 09:53:04 INFO - Running post-action listener: _start_resource_monitoring 09:53:04 INFO - Starting resource monitoring. 09:53:04 INFO - ##### 09:53:04 INFO - ##### Finished create-virtualenv step (success) 09:53:04 INFO - ##### 09:53:04 INFO - ##### 09:53:04 INFO - ##### Running install step. 09:53:04 INFO - ##### 09:53:04 INFO - Running pre-action listener: _resource_record_pre_action 09:53:04 INFO - Running main action method: install 09:53:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:04 INFO - Reading from file tmpfile_stdout 09:53:04 INFO - Detecting whether we're running mozinstall >=1.0... 09:53:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:53:04 INFO - Reading from file tmpfile_stdout 09:53:04 INFO - Output received: 09:53:04 INFO - Usage: mozinstall [options] installer 09:53:04 INFO - Options: 09:53:04 INFO - -h, --help show this help message and exit 09:53:04 INFO - -d DEST, --destination=DEST 09:53:04 INFO - Directory to install application into. [default: 09:53:04 INFO - "/builds/slave/test"] 09:53:04 INFO - --app=APP Application being installed. [default: firefox] 09:53:04 INFO - mkdir: /builds/slave/test/build/application 09:53:04 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'] 09:53:04 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 09:53:20 INFO - Reading from file tmpfile_stdout 09:53:20 INFO - Output received: 09:53:20 INFO - /builds/slave/test/build/application/firefox/firefox 09:53:20 INFO - Running post-action listener: _resource_record_post_action 09:53:20 INFO - ##### 09:53:20 INFO - ##### Finished install step (success) 09:53:20 INFO - ##### 09:53:20 INFO - ##### 09:53:20 INFO - ##### Running run-tests step. 09:53:20 INFO - ##### 09:53:20 INFO - Running pre-action listener: _resource_record_pre_action 09:53:20 INFO - Running main action method: run_tests 09:53:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:53:20 INFO - Python 2.7.3 09:53:20 INFO - Return code: 0 09:53:20 INFO - grabbing minidump binary from tooltool 09:53: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')]} 09:53:20 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 0x22d92e0>, '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 0x2245140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22455d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:53:20 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 09:53:20 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 09:53:20 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 09:53:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:53:20 INFO - Return code: 0 09:53:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:53:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:53:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:53:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:53:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:53:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:53:21 INFO - Return code: 0 09:53:21 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/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 09:53:21 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/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 09:53:21 INFO - Using env: {'DISPLAY': ':0', 09:53:21 INFO - 'HOME': '/home/cltbld', 09:53:21 INFO - 'LANG': 'en_US.UTF-8', 09:53:21 INFO - 'LANGUAGE': 'en_US:en', 09:53:21 INFO - 'LOGNAME': 'cltbld', 09:53:21 INFO - 'MAIL': '/var/mail/cltbld', 09:53:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:53:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:21 INFO - 'MOZ_NO_REMOTE': '1', 09:53:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:21 INFO - 'NO_EM_RESTART': '1', 09:53:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:21 INFO - 'PWD': '/builds/slave/test', 09:53:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:53:21 INFO - 'SHELL': '/bin/bash', 09:53:21 INFO - 'SHLVL': '1', 09:53:21 INFO - 'TERM': 'linux', 09:53:21 INFO - 'TMOUT': '86400', 09:53:21 INFO - 'USER': 'cltbld', 09:53:21 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049', 09:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:21 INFO - '_': '/tools/buildbot/bin/python'} 09:53:21 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/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 09:53:21 INFO - mozversion application_buildid: 20160706071423 09:53:21 INFO - mozversion application_changeset: 6eaa86d11a5c5dad67d5ca343e5d9226ff524517 09:53:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:53:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:53:21 INFO - mozversion application_name: Firefox 09:53:21 INFO - mozversion application_remotingname: firefox-dev 09:53:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:53:21 INFO - mozversion application_vendor: Mozilla 09:53:21 INFO - mozversion application_version: 49.0a2 09:53:21 INFO - mozversion platform_buildid: 20160706071423 09:53:21 INFO - mozversion platform_changeset: 6eaa86d11a5c5dad67d5ca343e5d9226ff524517 09:53:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:53:21 INFO - mozversion platform_version: 49.0a2 09:53:21 INFO - using testdate: 1467824001 09:53:21 INFO - actual date: 1467824001 09:53:21 INFO - starting webserver on 'localhost:56427' 09:53:21 INFO - SUITE-START | Running 2 tests 09:53:21 INFO - TEST-START | dromaeo_css 09:53:21 INFO - operating with platform_type : linux_ 09:53:21 INFO - Initialising browser for dromaeo_css test... 09:53:21 INFO - TEST-INFO | started process 3332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkaoQXf/profile http://localhost:56427/getInfo.html) 09:53:28 INFO - PROCESS | 3332 | __metrics Screen width/height:1600/1200 09:53:28 INFO - PROCESS | 3332 | colorDepth:24 09:53:28 INFO - PROCESS | 3332 | Browser inner width/height: 1024/697 09:53:28 INFO - PROCESS | 3332 | __metrics 09:53:29 ERROR - PROCESS | 3332 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 09:53:29 INFO - TEST-INFO | 3332: exit 0 09:53:29 INFO - Browser initialized. 09:53:29 INFO - Running cycle 1/1 for dromaeo_css test... 09:53:29 INFO - TEST-INFO | started process 3461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkaoQXf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:53:41 INFO - PROCESS | 3461 | RSS: Main: 156143616 09:53:41 INFO - PROCESS | 3461 | 09:54:31 INFO - PROCESS | 3461 | 1467824071299 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] 09:56:39 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:56427/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56427/tests/dromaeo/cssquery-ext.html) 09:56:40 INFO - PROCESS | 3461 | RSS: Main: 160112640 09:56:40 INFO - PROCESS | 3461 | 09:59:42 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:56427/tests/dromaeo/cssquery-ext.html (next: http://localhost:56427/tests/dromaeo/cssquery-jquery.html) 09:59:43 INFO - PROCESS | 3461 | RSS: Main: 157745152 09:59:43 INFO - PROCESS | 3461 | 10:02:44 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:56427/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56427/tests/dromaeo/cssquery-mootools.html) 10:02:45 INFO - PROCESS | 3461 | RSS: Main: 157986816 10:02:45 INFO - PROCESS | 3461 | 10:05:47 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:56427/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56427/tests/dromaeo/cssquery-prototype.html) 10:05:47 INFO - PROCESS | 3461 | RSS: Main: 156921856 10:05:47 INFO - PROCESS | 3461 | 10:08:50 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:56427/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56427/tests/dromaeo/cssquery-yui.html) 10:08:50 INFO - PROCESS | 3461 | RSS: Main: 158924800 10:08:50 INFO - PROCESS | 3461 | 10:11:53 INFO - PROCESS | 3461 | Cycle 1(1): loaded http://localhost:56427/tests/dromaeo/cssquery-yui.html (next: http://localhost:56427/tests/dromaeo/cssquery-dojo.html) 10:11:53 INFO - PROCESS | 3461 | RSS: Main: 159535104 10:11:53 INFO - PROCESS | 3461 | 10:11:53 INFO - PROCESS | 3461 | __start_tp_report 10:11:53 INFO - PROCESS | 3461 | _x_x_mozilla_page_load 10:11:53 INFO - PROCESS | 3461 | _x_x_mozilla_page_load_details 10:11:53 INFO - PROCESS | 3461 | |i|pagename|runs| 10:11:53 INFO - PROCESS | 3461 | |0;dojo.html;3325.418051840928;3370.966290337097;3375.2911888503445;3384.627690953996;3388.2715216228507;5490.80782172624;5497.587680923927;5513.44865513449;5551.916721249175;5591;5512.476314750093;5593.776248950047;5603.467670571299;5613.410591887854;5624;5031.572316353106;5066.771995260204;5113.386393632769;5115.9744201278945;5140.074786538422;4972.726500042496;5100.33695619569;5134.486551344873;5134.948650513503;5152.278680984665;4979.551840334369;5083.872903177413;5090.949090509084;5110.514501122388;5121.56466700329;5063.518965698253;5079.8222062228015;5084.6440749147205;5140.357455318085;5175.974120129394;5039.521245481674;5108.872278193075;5117;5119.846404607868;5135.152699804527;5310;5433.864153396157;5456.945430545684;5491.148871924858;5503.532199763025;5973;6036.275646922353;6038.758449662008;6039;6043.033114701627;6046;6046.697665116727;6063.363346848561;6082.753035627686;6094.847628809315;5431.701256430894;5471.179323101527;5522.944770552283;5561.694106824082;5658.971705141489;6027;6039.48664363534;6047.183630209865;6053.424924632153;6073.605215661057;5796.0436527972415;5812.476877081083;5820.912686309709;5838.1242813577455;5839.795607153729;5851.1223316502865;5892.381299963442;5894.821035792858;5921.111833225051;5995;5928.584999050111;5937.584369094208;5937.910931336033;5938.406159384027;5942.970285148633;5877.089051197071;5896.439838215363;5955.791547295824;5997;5998.610090344114;4577.656675749266;4580.312953057068;4638.072385522909;4666.883327916761;4667.8599642010795;4166.937495937564;4168.979155104205;4170.061736109412;4176.415301857743;4205.306124489425;5792.9710351447975;5805.419458054161;5887.411258874164;5920.644761314335;5923.674197919069;5872.17789509469;5899.823005309848;5995.640261584319;6007.279126504847;6139.815805525842;5724.141378793214;5782.335031471434;5788.450097240755;5789.45000224978;5838;5031.295618613397;5166.870828229325;5180.4560521145495;5204.271402003723;5207;6227.688615569204;6397.96801015992;6403.295637479873;6405.3594640535575;6434.871302574016;6058.182145410489;6093.29927058394;6095.939040609537;6100.0849872519475;6124.173236613;6122.367660829107;6198.597091189058;6265.906011409924;6408.423241908251;6416.230052393743;5975.731092100779;5977.970110149421;5978;5982.850428739316;5987.101934709828;6062.545309101747;6112.908306375319;6135.84660383494;6136.539759518143;6137.96931015342;5784.94215057844;5809.50619197373;5841.912371314349;5858.5898987070495;5995.790147344822;5826;5838.912416313844;5855.180274761452;5878;5888.528917686661;5722.055860783091;5726.79956201531;5727.799527016535;5728.656280623176;5759;5735.512481438957;5778.191053252632;5840.123981402823;5908.852278693067;5976.462118409364;5804.6807425592;5823.301203855564;5826.388229235869;5829.2421985143355;5848.064309710426 10:11:53 INFO - PROCESS | 3461 | |1;ext.html;605.3039005144084;659.4065341192927;667.6928612838091;669.9933000669994;673.4074014866916;39658.801705991464;44923.32615010777;45254.54745452545;45365.546344536546;45466.545334546645;45389.319160212624;45931.54068459314;46089.769551152196;46100.3084953726;46226;9002.54987250638;9079.500627465486;9113.134252246025;9128.589213485377;9139.543022848864;8981.775455613597;9057.728268151966;9095;9097.681581144661;9100.681476148337;9112.8633070504;9119.224865886408;9135.04082071383;9147.679831205909;9156.359054866129;9097.317701172373;9105.317101217403;9116.58975346111;9129.680461183827;9158;8971.237444817198;9006.86489702655;9018.053104424072;9035.683751068747;9056.320775941766;43999.78000109979;44058.33912491315;44162.55837441649;44506.777466112464;44775.32837007415;3830.0807806126327;3867.3812190049457;3911.178652482982;4018.397240413932;4268.743875367488;33618.327633447436;33731.32537349239;34414.311713765586;35044.12389690253;35206.647933520595;4353.673474489426;4539;4539.500654927955;4601.240795268776;4659.627229821606;380631;382644;384503;386024.9999999972;386620;38114.2377152461;38824;69102;69426.30573694299;69776;41040.179196415906;41178;41325.58674413277;41449.378259326135;41468.585314146476;17694.292228310722;17798.822011779717;17811;17841.286348545913;17968.371107011193;14633.853661463461;14640.560783176521;14660.706785864222;14675.853241467663;14737.189454579886;9342.953285233667;9369.718908432622;9382.953085234667;9392.060793920553;9396.577154028086;3560.590532088791;3566.98216508921;3571.0715214044535;3592.2815436912724;3599.766015209003;1101.7686285880054;1137.5506674863548;1196.8384268123866;1230.926144431337;1238.8032204900535;34308.31383372319;34701.13247168841;34717.305653887284;35010;35213.64786352104;1169.2049406403557;1184.4373922386796;1236.4188831249298;1258.9972667159514;1281.6475469245845;17895.194716237802;17905.910470447823;18016.9099154506;18121.275148994155;18218.908905455653;573082;577968;578213;617031;647140;59332.70333648391;65258.34741652523;65535.34464655293;65729.67135164293;66074.66962665156;1451.4816792864372;1452.8256609206962;1457.7376072306874;1468.075112678984;1478.5416520878562;33868.49197262093;34401;34488.655113449546;34719.82640086783;34733.735148945016;56356.43643563512;57013.71493142508;57123.42876571181;57175.714121429126;57207.71396142992;608304;618052;619885;619902;620408;31409.685903140675;31797.523037154922;31854.522182167748;31873.840630796698;31942.201444964063;51776;52514;52778;52962.47037529575;53190;43151.35272970845;43537.78231108951;43864.561354387326;44033.339499908165;45225.32162017638;43632.78183609062;44271.55728442803;44418.33372499351;44495;45377.77311113424;44685.77657111824;45012.099758004;45115.097698045196;45153.54846451493;45466.545334547554;37160;37553;38039.61960380471;38529.2294154121;38884.805575971935;29791.85104074466;29894.25264368408;30069;30238.69761302447;30633.23416914595 10:11:53 INFO - PROCESS | 3461 | |2;jquery.html;418.1344616643549;421.42896375411334;423.15580417067946;424.99362509562343;438.8771144079657;18378;19044.238230470783;19674.508137296576;19745.617806753515;19819.702704459443;12788.16876903003;17997.820021799776;18661.906690466527;19314.227430902745;19360.128794204258;5319.840404787853;5446.346438427375;5456.890862182754;5512.944870551283;5524.861878453051;5298.4436634153435;5367.194920761897;5511.311086114236;5818.2145410369485;5832.387599302076;5720.08478643415;5828.125781132821;5879.088741245114;5926.170336152942;6004.699765011754;5980.252468441445;6030.457258846681;6055;6067.484263837579;6085.361037091086;5710.543156547507;5787.102999035156;5899.882002359972;5915.911261331041;5928.170056192136;14369.497067602688;14528.854711452856;14730.63173420673;19840.50398740043;23847.284581462583;2398.7406611528913;2400.1839374612714;2689.9731002690114;2692.3538350795666;2920.795544311899;10242.385456872611;10247.692569222936;10760.3543787373;11713.414329283587;15615.531534053996;2052.79472052795;2069.617120832651;2123.692064650617;2138.647123224666;2272.420532764151;83892.58053709692;87034;87426.56286718526;88627.55686221528;90776.54611726965;11511.827322590168;11798.174127811142;11873.287602743863;11910.940445297718;11936.598069550137;16973.236204370834;16992.405265815636;16998.57503562421;17051.062191579334;33232.66767332344;10444.164466842634;10779.730506737238;10823.783524329468;11122.110231181487;11328.433578321052;8837.204651581389;9147.679831205876;9197.586108625128;9251.583678734338;9841.212702983745;9225.21585665226;9235.261179105655;9306.488143152192;9496.382735122195;9779.462129582942;3409.3010932758725;3657.213699054716;3749.531308586427;3781.8487260509823;3879.7478163919254;994.9801003979879;1043.8486419469134;1048.4390850894736;1076.7684947736118;1115.4367044642404;19784.505387365432;20070.19719211215;20104.195832166843;20244.291449799188;20293.59412811765;1050.1283934334483;1075.1076606416655;1082.832161015044;1127.2447460201683;1167.5855071449682;11321.660350189508;11352.091832653368;11512.827307590393;11554;11661.766764664659;381426;383954;384402;544319;551272;96369.51815240878;103111;103429.48285258525;105103.47448262863;105235.42146867803;1046.3774054437597;1100.8183649697871;1135.5174051028114;1143.7769634921276;1162.84301619282;18369.908150459698;18677.159527821554;18851.622967540297;18938.621227575648;19114.904425477784;38571.421428679154;40563.188736225704;42518;43284.78357608192;43494.565054350314;53394.46605533895;54708;60850.695746520985;62934.92596740077;65039.67480162569;12688.74622507563;13364.465421383426;13401.66495837612;13441.932790335986;13544.661383465098;14410.495632652806;14652.487162949246;14706.264686765833;14744.852551474776;14761.704765904837;12711.745765084832;13027.47890084386;13037.348132593523;13337.266450345323;13353.799693004807;12552.560660376843;12571.93714031424;12630.494780208688;12636.620901372973;12985.091043627233;13083.542076027294;13126.868731312565;13141.802872957105;13276.668083297609;13357.866421335662;13292.468301267842;13296.202227866359;13428.328583570978;13459.528916487876;13470.326483675974;13264.933675331562;13290.936725062165;13355.3990070449;13453.394597243343;13502.45990160422 10:11:53 INFO - PROCESS | 3461 | |3;mootools.html;1571.4578470427703;1622.4667689033863;1731.1863424190626;1835.6879330513812;1899.2497963304504;8350.457220280692;8831.293496520278;8984;9580.329376943617;9603.99999999999;8755.605997730101;9021.594028268728;9069.229115525171;9076.092390760921;9098.499582522974;2390.617501199804;2423.3820375804144;2442.53591817555;2442.658027876099;2444.535538247736;2303.3205204464725;2303.435658263728;2343.9296821095395;2360.0323867214447;2365.73976862545;2432.2824766693866;2453.3989172652723;2458.7418321076298;2485.8508489490596;2500.0249902538026;2356.3402247370764;2363.550925324183;2363.7636236376397;2376.9524609507885;2406.9037238510614;2272.3410211038777;2348;2348.0607756897207;2356.32844639277;2373.9525209495714;9044.819103617956;9070.365074444791;9084.954575227082;9109.180173784325;9137.131972462605;5520.972395138038;5616.241807355996;5620.381758006616;5634.211210430543;5668.57485688575;3389.1696534348994;3414.3854106260865;3446.0351101691317;3468.479728040789;3495.8426870790877;1186.4008675618757;1204.1570900369688;1219.664592237133;1230;1262.551794113095;13034.869651303556;13053.673658158526;13070.085094043421;13078.149920255153;13130.540431084866;4816.590589799836;4880.731559764247;4883.389576302962;4890.828820991248;4999.575036121971;11158.665240042812;11183.776324473465;11186.496607652674;11193.49629266685;11213.66359009231;5560.610757247035;5656.575756818255;5667.263255776805;5675.120356344773;5700.315962084576;4538.636909047268;4940.382452193476;5048.8232911848645;5049.419316778544;5198.480151984847;4184.309588917795;4220.155968806251;4310.892227694333;4311.33174357975;4343.305071188594;1318.235423454394;1333.5865881576742;1358.1375826350338;1364.099694201822;1371.3760239091189;1052.5842292294653;1057.735566108473;1057.8201705710048;1073.3398959639765;1075.2258373970728;6252.280987686383;6430.485561155097;6470.029495575702;6480.740770369227;6495.317991610813;456.07416943604534;466.9322948172496;469.77216050215617;478.5573344656249;485.980560777572;4200.789960502024;4215;4287.978560107242;4329.891752706145;4341.261985462479;11280.210385273116;11614.245074070159;11622;11627.069834413227;11815.704607384712;11487.655370338904;11492.827607585725;11552;11584.304941703525;11631.709207269885;8401.95799021001;8725.825483490295;8743.300535957109;8760.693375731818;8965.148310910583;6578.8355291118105;6684.097646817618;6730.562513436611;6810.9318906810295;6816.420604248496;10709.410982396043;10876.619318323821;10884.510197040994;10974.670759877217;11126.888731112585;11106.278091924;11118.555257789922;11184.94407527957;11259.155563332619;11302;7379.889301660372;8284.212999765012;8334.12491688364;8345.374096942633;8474.618642160995;9268.814623707352;9282.257419406296;9300.906990930003;9325.347225694137;9369.063093690576;8114.148014458633;8336.499810011419;8423.157684231528;8476.618552165044;8547.444416112932;7856.45004849655;7875.763727088197;8268.627911743866;8310.33517318601;8344.41589088758;7139.964300178466;7146.428285737233;7149.642517874189;7193.100862392201;7204.0994875640545;5399.217113518439;5405.729713514387;5447.455254474521;5509.47659972302;5515.448455154453;5652.63257888236;5678.6876721779045;5709.0865461525955;5796.913046304225;5843.181954526454 10:11:53 INFO - PROCESS | 3461 | |4;prototype.html;347.7808980342384;361.34055348988096;362.6156274349189;362.66815863484896;362.8911326602019;5467.835964921049;5523.199136125259;5627.2684551008415;5685.948099601572;5707.543396528278;5558.194061861028;5573.191887176357;5575.386707462176;5596.908602822441;5602.915956260659;4374.190774706682;4385.912281754363;4392.604665580097;4395.516493185747;4403.537628549005;4105.67154627629;4319.48166220054;4321.567843215685;4404.757738324391;4439.2453282941815;4255;4257.489101307832;4271.487421509408;4282.614564689177;4297.183535128332;4281.186574550841;4302;4310.676699247569;4320.438343015419;4325.134973005412;3740.8316625751636;3838.9232215355814;3842.2507611015862;3848.9615103849164;3853.2871418787613;5389.6285634320775;5415.539679127279;5440.347158340985;5447.428020057916;5461.1262198048125;5012.8496145115705;5016.398032236155;5068.4171320298265;5069.1129052416045;5125.282460455539;5610.719464026783;5815.185873977646;5846.269216347957;5867.501262392701;5874;4217.325227963511;4221.535631080578;4222.387753775716;4232.936505952413;4241.4698162729655;6042.456178943916;6139.539534534928;6141.727560802532;6170.6297622142365;6175.783847565313;4219.282721937278;4226.894327641772;4230.217409779139;4230.767307798101;4233.449651545279;4243.151369726067;4282.935755963663;4285.335772955197;4294.463192100988;4298.20483210607;4831.154547954094;4902.411710594752;4922.58158056562;4993.350864387607;5006.974965125151;5662.546996240291;5856.560757943172;5857.330660761662;5908.231929849092;5955.166276721263;1498.2658497336226;1532.1343440955825;1534.1562140822725;1534.8081489813774;1537.8769698424098;952.3000594562991;958.8130314588727;965.3339195954909;967.9951600242094;987.5654711926729;5219.582433405319;5278.313819203479;5282.709450980156;5284.550813180846;5290.576753859682;5392.276900165391;5429.864253393696;5437.619366644297;5442.720960574262;5456.399796022434;4899.211787697464;5172.741362931838;5192.740362981911;5230.241614965885;5253.973730131325;2859.613952116479;2867.1936679891533;2911.97088029117;2916.5187744022423;2917.6352955880516;5629.7185140742795;5642.887142257214;5644.250282412465;5675.404082571353;5680.517156041783;5083.771230294646;5413.512783849473;5437.900396773801;5484.670919744828;5532.336119665585;5634.85912852182;5656.604037717402;5662.66024038559;5688.77244910199;5704.629199102128;5248.396434410091;5372.910576418497;5419.729013549228;5429.864253393539;5462.525118217979;5357.946420535744;5388.488093631099;5417.214503896992;5428.022955867982;5465.72671366438;5577.247071645438;5642.266505354278;5669.716514174357;5676.971615141898;5678.346990096192;3747.5315585551807;3902.1220225449047;3917.666998305176;3963.5441924177935;3968.0476685595827;5443.7822487100075;5451.7274136292235;5459.590530710133;5756.280464941882;5991.281046274475;5930.644161350333;5964.493018093511;6033.155358249761;6043.637381757108;6045.758169673164;5928.436798504135;5935.258092738408;5947.791827286197;5984;6002.789902353396;5615.0173719599725;5758.596898217084;5789;5808.854778630568;5809.331926828469;5994;5996.280446346292;6033.396660333931;6048.243969503812;6061.787642471611;5721.284839395075;5841.415858414124;5861.589688721919;5898.8230353089475;5920.496757775637 10:11:53 INFO - PROCESS | 3461 | |5;yui.html;791.1416113516834;813.9593020348981;814.62934364864;827.4456114403351;863.3093525179856;14699.853001469983;15475.148866812335;15597.92201038996;16007.119608421532;16201.756973645404;15637.452689155882;16334.18329083544;16366.181690915437;16486.25811838467;16522.42171523997;857.7726902370877;870.7953630896734;874.1302404107921;875.7460336502406;882.0473888200728;881.497546398553;883.5626364949359;884.7611144990849;885.3802338363139;885.7431344909968;923.529000209891;924.2328867040374;924.9907500924971;925.694520808135;926.5645146781002;909.2907532124954;914.8536234202562;914.9359544831898;918.5728636184173;920.7652048727565;670.3564578005121;671.2414971082694;672.0893189727946;673.0173946038789;673.1215763428723;14643.41426342945;14660;14669.633259168499;14799.33402996857;14826.258687065603;14425.350859211361;14830.555083347517;15192.316345764468;15312.770308445382;15514.224288785628;12255.264684118982;12741.17182383142;12774.61676149717;13205.141665791693;13443.01525575828;3978.5424676162324;4032.778197199153;4071.470708807836;4086.264472394968;4120.567340429242;82093.58953205256;83846;84009.57995209986;85242;85310.01414950447;12391.876081239252;12422.689432764253;12538.247705137721;12645.494180232872;12767.042471814651;22339.776602234095;22538.436539086328;22598.548029039655;22612.321630351114;22702;8543.743687689379;8571.142885711379;8615.3107751381;8691.087435819149;8853.822923541622;4974.104661160954;4999.950000500021;5039.319691841628;5059.696418214919;5250.711210883362;3565.6790888820133;3673.8714145004797;3683.208110256308;3699.3711069118312;3700.0749812546865;623.9906401403982;649.4577028181427;656.1961597043584;657.1850904878013;662.8541720821412;732.5642239553506;742.6992068212382;792.7740593930818;794.8648729715962;850.5577099908013;10271.845922311171;10282.588696452058;10318.690439286833;10381.740456488647;10458.477076146162;775.7440044785208;818.1695578987333;823.1932705948204;826.5082276045744;834.3658819297377;4473.4408198975125;4532.614727748112;4544.113897789965;4559.749213793207;4575.725456472623;70412.64793675998;72721.63639181771;110582;118843;122768.38615806864;79396.20603793889;94356.52821735847;98301;99535;100484.4975775131;63268.36731632717;92925;93340;93708.53145734363;94662.52668736612;9977.151942085004;9991;10331;10364.844527332247;10379.792404151724;51433.48566514437;51501.7424912888;52286.215706763665;52367;52733.47266527286;47699.28451073306;48162.5183748158;57159;75978.62010690132;79126.20873791189;12567.371631418575;13078.934605326913;13270.668233294246;13410.530631427853;13742;13925;14714.779278311047;15097.169655669044;15155.621109472351;15305.846941530443;13575.79636305476;13824.930875345559;13918.234497102352;14210.28948552589;14214.147151170962;13529.120607160503;13702.177869327872;13804.585862424143;14277.571672849832;14290.42838286457;13630.795538066739;13755.931220343835;13888.236147012012;13965.092269002482;14445;10935.56257749681;11007.724806879893;11183.72040698989;11253;11297.322160670386;10545;11083.778324433304;11201.495932683212;11209.775804484028;11346.149038821955 10:11:53 INFO - PROCESS | 3461 | __end_tp_report 10:11:53 INFO - PROCESS | 3461 | __start_cc_report 10:11:53 INFO - PROCESS | 3461 | _x_x_mozilla_cycle_collect,354 10:11:53 INFO - PROCESS | 3461 | __end_cc_report 10:11:53 INFO - PROCESS | 3461 | __startTimestamp1467825113584__endTimestamp 10:11:53 INFO - PROCESS | 3461 | 10:11:53 INFO - PROCESS | 3461 | ------- Summary: start ------- 10:11:53 INFO - PROCESS | 3461 | Number of tests: 6 10:11:53 INFO - PROCESS | 3461 | 10:11:53 INFO - PROCESS | 3461 | [#0] dojo.html Cycles:165 Average:5583.62 Median:5812.48 stddev:623.22 (10.7%) stddev-sans-first:599.42 10:11:53 INFO - PROCESS | 3461 | Values: 3325.4 3371.0 3375.3 3384.6 3388.3 5490.8 5497.6 5513.4 5551.9 5591.0 5512.5 5593.8 5603.5 5613.4 5624.0 5031.6 5066.8 5113.4 5116.0 5140.1 4972.7 5100.3 5134.5 5134.9 5152.3 4979.6 5083.9 5090.9 5110.5 5121.6 5063.5 5079.8 5084.6 5140.4 5176.0 5039.5 5108.9 5117.0 5119.8 5135.2 5310.0 5433.9 5456.9 5491.1 5503.5 5973.0 6036.3 6038.8 6039.0 6043.0 6046.0 6046.7 6063.4 6082.8 6094.8 5431.7 5471.2 5522.9 5561.7 5659.0 6027.0 6039.5 6047.2 6053.4 6073.6 5796.0 5812.5 5820.9 5838.1 5839.8 5851.1 5892.4 5894.8 5921.1 5995.0 5928.6 5937.6 5937.9 5938.4 5943.0 5877.1 5896.4 5955.8 5997.0 5998.6 4577.7 4580.3 4638.1 4666.9 4667.9 4166.9 4169.0 4170.1 4176.4 4205.3 5793.0 5805.4 5887.4 5920.6 5923.7 5872.2 5899.8 5995.6 6007.3 6139.8 5724.1 5782.3 5788.5 5789.5 5838.0 5031.3 5166.9 5180.5 5204.3 5207.0 6227.7 6398.0 6403.3 6405.4 6434.9 6058.2 6093.3 6095.9 6100.1 6124.2 6122.4 6198.6 6265.9 6408.4 6416.2 5975.7 5978.0 5978.0 5982.9 5987.1 6062.5 6112.9 6135.8 6136.5 6138.0 5784.9 5809.5 5841.9 5858.6 5995.8 5826.0 5838.9 5855.2 5878.0 5888.5 5722.1 5726.8 5727.8 5728.7 5759.0 5735.5 5778.2 5840.1 5908.9 5976.5 5804.7 5823.3 5826.4 5829.2 5848.1 10:11:53 INFO - PROCESS | 3461 | 10:11:53 INFO - PROCESS | 3461 | [#1] ext.html Cycles:180 Average:68495.03 Median:44110.45 stddev:145190.30 (329.2%) stddev-sans-first:145508.12 10:11:53 INFO - PROCESS | 3461 | Values: 605.3 659.4 667.7 670.0 673.4 39658.8 44923.3 45254.5 45365.5 45466.5 45389.3 45931.5 46089.8 46100.3 46226.0 9002.5 9079.5 9113.1 9128.6 9139.5 8981.8 9057.7 9095.0 9097.7 9100.7 9112.9 9119.2 9135.0 9147.7 9156.4 9097.3 9105.3 9116.6 9129.7 9158.0 8971.2 9006.9 9018.1 9035.7 9056.3 43999.8 44058.3 44162.6 44506.8 44775.3 3830.1 3867.4 3911.2 4018.4 4268.7 33618.3 33731.3 34414.3 35044.1 35206.6 4353.7 4539.0 4539.5 4601.2 4659.6 380631.0 382644.0 384503.0 386025.0 386620.0 38114.2 38824.0 69102.0 69426.3 69776.0 41040.2 41178.0 41325.6 41449.4 41468.6 17694.3 17798.8 17811.0 17841.3 17968.4 14633.9 14640.6 14660.7 14675.9 14737.2 9343.0 9369.7 9383.0 9392.1 9396.6 3560.6 3567.0 3571.1 3592.3 3599.8 1101.8 1137.6 1196.8 1230.9 1238.8 34308.3 34701.1 34717.3 35010.0 35213.6 1169.2 1184.4 1236.4 1259.0 1281.6 17895.2 17905.9 18016.9 18121.3 18218.9 573082.0 577968.0 578213.0 617031.0 647140.0 59332.7 65258.3 65535.3 65729.7 66074.7 1451.5 1452.8 1457.7 1468.1 1478.5 33868.5 34401.0 34488.7 34719.8 34733.7 56356.4 57013.7 57123.4 57175.7 57207.7 608304.0 618052.0 619885.0 619902.0 620408.0 31409.7 31797.5 31854.5 31873.8 31942.2 51776.0 52514.0 52778.0 52962.5 53190.0 43151.4 43537.8 43864.6 44033.3 45225.3 43632.8 44271.6 44418.3 44495.0 45377.8 44685.8 45012.1 45115.1 45153.5 45466.5 37160.0 37553.0 38039.6 38529.2 38884.8 29791.9 29894.3 30069.0 30238.7 30633.2 10:11:53 INFO - PROCESS | 3461 | 10:11:53 INFO - PROCESS | 3461 | [#2] jquery.html Cycles:180 Average:29252.06 Median:19337.18 stddev:75718.03 (391.6%) stddev-sans-first:75899.49 10:11:53 INFO - PROCESS | 3461 | Values: 418.1 421.4 423.2 425.0 438.9 18378.0 19044.2 19674.5 19745.6 19819.7 12788.2 17997.8 18661.9 19314.2 19360.1 5319.8 5446.3 5456.9 5512.9 5524.9 5298.4 5367.2 5511.3 5818.2 5832.4 5720.1 5828.1 5879.1 5926.2 6004.7 5980.3 6030.5 6055.0 6067.5 6085.4 5710.5 5787.1 5899.9 5915.9 5928.2 14369.5 14528.9 14730.6 19840.5 23847.3 2398.7 2400.2 2690.0 2692.4 2920.8 10242.4 10247.7 10760.4 11713.4 15615.5 2052.8 2069.6 2123.7 2138.6 2272.4 83892.6 87034.0 87426.6 88627.6 90776.5 11511.8 11798.2 11873.3 11910.9 11936.6 16973.2 16992.4 16998.6 17051.1 33232.7 10444.2 10779.7 10823.8 11122.1 11328.4 8837.2 9147.7 9197.6 9251.6 9841.2 9225.2 9235.3 9306.5 9496.4 9779.5 3409.3 3657.2 3749.5 3781.8 3879.7 995.0 1043.8 1048.4 1076.8 1115.4 19784.5 20070.2 20104.2 20244.3 20293.6 1050.1 1075.1 1082.8 1127.2 1167.6 11321.7 11352.1 11512.8 11554.0 11661.8 381426.0 383954.0 384402.0 544319.0 551272.0 96369.5 103111.0 103429.5 105103.5 105235.4 1046.4 1100.8 1135.5 1143.8 1162.8 18369.9 18677.2 18851.6 18938.6 19114.9 38571.4 40563.2 42518.0 43284.8 43494.6 53394.5 54708.0 60850.7 62934.9 65039.7 12688.7 13364.5 13401.7 13441.9 13544.7 14410.5 14652.5 14706.3 14744.9 14761.7 12711.7 13027.5 13037.3 13337.3 13353.8 12552.6 12571.9 12630.5 12636.6 12985.1 13083.5 13126.9 13141.8 13276.7 13357.9 13292.5 13296.2 13428.3 13459.5 13470.3 13264.9 13290.9 13355.4 13453.4 13502.5 10:11:53 INFO - PROCESS | 3461 | 10:11:53 INFO - PROCESS | 3461 | [#3] mootools.html Cycles:180 Average:6160.29 Median:2497.36 stddev:3551.20 (142.2%) stddev-sans-first:3544.42 10:11:53 INFO - PROCESS | 3461 | Values: 1571.5 1622.5 1731.2 1835.7 1899.2 8350.5 8831.3 8984.0 9580.3 9604.0 8755.6 9021.6 9069.2 9076.1 9098.5 2390.6 2423.4 2442.5 2442.7 2444.5 2303.3 2303.4 2343.9 2360.0 2365.7 2432.3 2453.4 2458.7 2485.9 2500.0 2356.3 2363.6 2363.8 2377.0 2406.9 2272.3 2348.0 2348.1 2356.3 2374.0 9044.8 9070.4 9085.0 9109.2 9137.1 5521.0 5616.2 5620.4 5634.2 5668.6 3389.2 3414.4 3446.0 3468.5 3495.8 1186.4 1204.2 1219.7 1230.0 1262.6 13034.9 13053.7 13070.1 13078.1 13130.5 4816.6 4880.7 4883.4 4890.8 4999.6 11158.7 11183.8 11186.5 11193.5 11213.7 5560.6 5656.6 5667.3 5675.1 5700.3 4538.6 4940.4 5048.8 5049.4 5198.5 4184.3 4220.2 4310.9 4311.3 4343.3 1318.2 1333.6 1358.1 1364.1 1371.4 1052.6 1057.7 1057.8 1073.3 1075.2 6252.3 6430.5 6470.0 6480.7 6495.3 456.1 466.9 469.8 478.6 486.0 4200.8 4215.0 4288.0 4329.9 4341.3 11280.2 11614.2 11622.0 11627.1 11815.7 11487.7 11492.8 11552.0 11584.3 11631.7 8402.0 8725.8 8743.3 8760.7 8965.1 6578.8 6684.1 6730.6 6810.9 6816.4 10709.4 10876.6 10884.5 10974.7 11126.9 11106.3 11118.6 11184.9 11259.2 11302.0 7379.9 8284.2 8334.1 8345.4 8474.6 9268.8 9282.3 9300.9 9325.3 9369.1 8114.1 8336.5 8423.2 8476.6 8547.4 7856.5 7875.8 8268.6 8310.3 8344.4 7140.0 7146.4 7149.6 7193.1 7204.1 5399.2 5405.7 5447.5 5509.5 5515.4 5652.6 5678.7 5709.1 5796.9 5843.2 10:11:53 INFO - PROCESS | 3461 | 10:11:53 INFO - PROCESS | 3461 | [#4] prototype.html Cycles:180 Average:4781.01 Median:5423.88 stddev:1389.77 (25.6%) stddev-sans-first:1353.25 10:11:53 INFO - PROCESS | 3461 | Values: 347.8 361.3 362.6 362.7 362.9 5467.8 5523.2 5627.3 5685.9 5707.5 5558.2 5573.2 5575.4 5596.9 5602.9 4374.2 4385.9 4392.6 4395.5 4403.5 4105.7 4319.5 4321.6 4404.8 4439.2 4255.0 4257.5 4271.5 4282.6 4297.2 4281.2 4302.0 4310.7 4320.4 4325.1 3740.8 3838.9 3842.3 3849.0 3853.3 5389.6 5415.5 5440.3 5447.4 5461.1 5012.8 5016.4 5068.4 5069.1 5125.3 5610.7 5815.2 5846.3 5867.5 5874.0 4217.3 4221.5 4222.4 4232.9 4241.5 6042.5 6139.5 6141.7 6170.6 6175.8 4219.3 4226.9 4230.2 4230.8 4233.4 4243.2 4282.9 4285.3 4294.5 4298.2 4831.2 4902.4 4922.6 4993.4 5007.0 5662.5 5856.6 5857.3 5908.2 5955.2 1498.3 1532.1 1534.2 1534.8 1537.9 952.3 958.8 965.3 968.0 987.6 5219.6 5278.3 5282.7 5284.6 5290.6 5392.3 5429.9 5437.6 5442.7 5456.4 4899.2 5172.7 5192.7 5230.2 5254.0 2859.6 2867.2 2912.0 2916.5 2917.6 5629.7 5642.9 5644.3 5675.4 5680.5 5083.8 5413.5 5437.9 5484.7 5532.3 5634.9 5656.6 5662.7 5688.8 5704.6 5248.4 5372.9 5419.7 5429.9 5462.5 5357.9 5388.5 5417.2 5428.0 5465.7 5577.2 5642.3 5669.7 5677.0 5678.3 3747.5 3902.1 3917.7 3963.5 3968.0 5443.8 5451.7 5459.6 5756.3 5991.3 5930.6 5964.5 6033.2 6043.6 6045.8 5928.4 5935.3 5947.8 5984.0 6002.8 5615.0 5758.6 5789.0 5808.9 5809.3 5994.0 5996.3 6033.4 6048.2 6061.8 5721.3 5841.4 5861.6 5898.8 5920.5 10:11:53 INFO - PROCESS | 3461 | 10:11:53 INFO - PROCESS | 3461 | [#5] yui.html Cycles:180 Average:20400.81 Median:4103.42 stddev:28601.73 (697.0%) stddev-sans-first:28644.07 10:11:53 INFO - PROCESS | 3461 | Values: 791.1 814.0 814.6 827.4 863.3 14699.9 15475.1 15597.9 16007.1 16201.8 15637.5 16334.2 16366.2 16486.3 16522.4 857.8 870.8 874.1 875.7 882.0 881.5 883.6 884.8 885.4 885.7 923.5 924.2 925.0 925.7 926.6 909.3 914.9 914.9 918.6 920.8 670.4 671.2 672.1 673.0 673.1 14643.4 14660.0 14669.6 14799.3 14826.3 14425.4 14830.6 15192.3 15312.8 15514.2 12255.3 12741.2 12774.6 13205.1 13443.0 3978.5 4032.8 4071.5 4086.3 4120.6 82093.6 83846.0 84009.6 85242.0 85310.0 12391.9 12422.7 12538.2 12645.5 12767.0 22339.8 22538.4 22598.5 22612.3 22702.0 8543.7 8571.1 8615.3 8691.1 8853.8 4974.1 5000.0 5039.3 5059.7 5250.7 3565.7 3673.9 3683.2 3699.4 3700.1 624.0 649.5 656.2 657.2 662.9 732.6 742.7 792.8 794.9 850.6 10271.8 10282.6 10318.7 10381.7 10458.5 775.7 818.2 823.2 826.5 834.4 4473.4 4532.6 4544.1 4559.7 4575.7 70412.6 72721.6 110582.0 118843.0 122768.4 79396.2 94356.5 98301.0 99535.0 100484.5 63268.4 92925.0 93340.0 93708.5 94662.5 9977.2 9991.0 10331.0 10364.8 10379.8 51433.5 51501.7 52286.2 52367.0 52733.5 47699.3 48162.5 57159.0 75978.6 79126.2 12567.4 13078.9 13270.7 13410.5 13742.0 13925.0 14714.8 15097.2 15155.6 15305.8 13575.8 13824.9 13918.2 14210.3 14214.1 13529.1 13702.2 13804.6 14277.6 14290.4 13630.8 13755.9 13888.2 13965.1 14445.0 10935.6 11007.7 11183.7 11253.0 11297.3 10545.0 11083.8 11201.5 11209.8 11346.1 10:11:53 INFO - PROCESS | 3461 | -------- Summary: end -------- 10:11:53 INFO - PROCESS | 3461 | 10:11:54 INFO - TEST-INFO | 3461: exit 0 10:11:54 INFO - TEST-OK | dromaeo_css | took 1112720ms 10:11:54 INFO - TEST-START | kraken 10:11:54 INFO - operating with platform_type : linux_ 10:11:54 INFO - Initialising browser for kraken test... 10:11:54 INFO - TEST-INFO | started process 3701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprOKL6N/profile http://localhost:56427/getInfo.html) 10:11:58 INFO - PROCESS | 3701 | __metrics Screen width/height:1600/1200 10:11:58 INFO - PROCESS | 3701 | colorDepth:24 10:11:58 INFO - PROCESS | 3701 | Browser inner width/height: 1024/697 10:11:58 INFO - PROCESS | 3701 | __metrics 10:11:59 ERROR - PROCESS | 3701 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 10:12:00 INFO - TEST-INFO | 3701: exit 0 10:12:00 INFO - Browser initialized. 10:12:00 INFO - Running cycle 1/1 for kraken test... 10:12:00 INFO - TEST-INFO | started process 3830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprOKL6N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:12 INFO - PROCESS | 3830 | RSS: Main: 156164096 10:12:12 INFO - PROCESS | 3830 | 10:12:14 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:56427/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56427/tests/kraken/driver.html?testName=audio-beat-detection) 10:12:15 INFO - PROCESS | 3830 | RSS: Main: 161505280 10:12:15 INFO - PROCESS | 3830 | 10:12:18 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:56427/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56427/tests/kraken/driver.html?testName=audio-dft) 10:12:18 INFO - PROCESS | 3830 | RSS: Main: 160694272 10:12:18 INFO - PROCESS | 3830 | 10:12:21 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:56427/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56427/tests/kraken/driver.html?testName=audio-fft) 10:12:22 INFO - PROCESS | 3830 | RSS: Main: 161456128 10:12:22 INFO - PROCESS | 3830 | 10:12:24 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:56427/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56427/tests/kraken/driver.html?testName=audio-oscillator) 10:12:24 INFO - PROCESS | 3830 | RSS: Main: 160952320 10:12:24 INFO - PROCESS | 3830 | 10:12:27 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:56427/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56427/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:12:27 INFO - PROCESS | 3830 | RSS: Main: 161083392 10:12:27 INFO - PROCESS | 3830 | 10:12:30 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:56427/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56427/tests/kraken/driver.html?testName=imaging-darkroom) 10:12:31 INFO - PROCESS | 3830 | RSS: Main: 160747520 10:12:31 INFO - PROCESS | 3830 | 10:12:34 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:56427/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56427/tests/kraken/driver.html?testName=imaging-desaturate) 10:12:35 INFO - PROCESS | 3830 | RSS: Main: 161611776 10:12:35 INFO - PROCESS | 3830 | 10:12:38 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:56427/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56427/tests/kraken/driver.html?testName=json-parse-financial) 10:12:39 INFO - PROCESS | 3830 | RSS: Main: 161411072 10:12:39 INFO - PROCESS | 3830 | 10:12:40 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:56427/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56427/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:12:41 INFO - PROCESS | 3830 | RSS: Main: 160722944 10:12:41 INFO - PROCESS | 3830 | 10:12:42 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:56427/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56427/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:12:43 INFO - PROCESS | 3830 | RSS: Main: 161046528 10:12:43 INFO - PROCESS | 3830 | 10:12:45 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:56427/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56427/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:12:46 INFO - PROCESS | 3830 | RSS: Main: 161169408 10:12:46 INFO - PROCESS | 3830 | 10:12:48 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:56427/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56427/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:12:49 INFO - PROCESS | 3830 | RSS: Main: 161370112 10:12:49 INFO - PROCESS | 3830 | 10:12:52 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:56427/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56427/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:12:52 INFO - PROCESS | 3830 | RSS: Main: 160989184 10:12:52 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:56427/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56427/tests/kraken/driver.html?testName=ai-astar) 10:12:54 INFO - PROCESS | 3830 | RSS: Main: 161710080 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | __start_tp_report 10:12:54 INFO - PROCESS | 3830 | _x_x_mozilla_page_load 10:12:54 INFO - PROCESS | 3830 | _x_x_mozilla_page_load_details 10:12:54 INFO - PROCESS | 3830 | |i|pagename|runs| 10:12:54 INFO - PROCESS | 3830 | |0;ai-astar;112;105;110;111;114;110;111;112;111;111 10:12:54 INFO - PROCESS | 3830 | |1;audio-beat-detection;149;125;152;171;126;159;156;127;178;126 10:12:54 INFO - PROCESS | 3830 | |2;audio-dft;167;163;161;167;162;162;163;165;161;164 10:12:54 INFO - PROCESS | 3830 | |3;audio-fft;80;76;77;174;76;81;74;75;170;76 10:12:54 INFO - PROCESS | 3830 | |4;audio-oscillator;85;85;153;85;85;86;145;87;86;141 10:12:54 INFO - PROCESS | 3830 | |5;imaging-gaussian-blur;118;118;117;118;117;117;118;117;117;119 10:12:54 INFO - PROCESS | 3830 | |6;imaging-darkroom;146;147;148;147;146;147;147;147;147;150 10:12:54 INFO - PROCESS | 3830 | |7;imaging-desaturate;95;100;96;95;96;95;95;96;96;96 10:12:54 INFO - PROCESS | 3830 | |8;json-parse-financial;50;52;54;53;52;56;54;52;54;53 10:12:54 INFO - PROCESS | 3830 | |9;json-stringify-tinderbox;60;60;59;61;60;60;60;60;66;60 10:12:54 INFO - PROCESS | 3830 | |10;stanford-crypto-aes;81;78;76;76;79;83;77;78;101;75 10:12:54 INFO - PROCESS | 3830 | |11;stanford-crypto-ccm;127;120;130;119;133;127;118;128;130;125 10:12:54 INFO - PROCESS | 3830 | |12;stanford-crypto-pbkdf2;154;158;152;151;152;153;156;161;150;156 10:12:54 INFO - PROCESS | 3830 | |13;stanford-crypto-sha256-iterative;66;63;63;66;61;60;60;62;61;60 10:12:54 INFO - PROCESS | 3830 | __end_tp_report 10:12:54 INFO - PROCESS | 3830 | __start_cc_report 10:12:54 INFO - PROCESS | 3830 | _x_x_mozilla_cycle_collect,886 10:12:54 INFO - PROCESS | 3830 | __end_cc_report 10:12:54 INFO - PROCESS | 3830 | __startTimestamp1467825174538__endTimestamp 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | ------- Summary: start ------- 10:12:54 INFO - PROCESS | 3830 | Number of tests: 14 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.31 (2.1%) stddev-sans-first:2.40 10:12:54 INFO - PROCESS | 3830 | Values: 112.0 105.0 110.0 111.0 114.0 110.0 111.0 112.0 111.0 111.0 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:154.00 stddev:19.88 (12.9%) stddev-sans-first:21.07 10:12:54 INFO - PROCESS | 3830 | Values: 149.0 125.0 152.0 171.0 126.0 159.0 156.0 127.0 178.0 126.0 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:2.22 (1.4%) stddev-sans-first:1.96 10:12:54 INFO - PROCESS | 3830 | Values: 167.0 163.0 161.0 167.0 162.0 162.0 163.0 165.0 161.0 164.0 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | [#3] audio-fft Cycles:10 Average:95.90 Median:76.00 stddev:40.18 (52.9%) stddev-sans-first:42.20 10:12:54 INFO - PROCESS | 3830 | Values: 80.0 76.0 77.0 174.0 76.0 81.0 74.0 75.0 170.0 76.0 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:85.00 stddev:29.50 (34.7%) stddev-sans-first:30.49 10:12:54 INFO - PROCESS | 3830 | Values: 85.0 85.0 153.0 85.0 85.0 86.0 145.0 87.0 86.0 141.0 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 10:12:54 INFO - PROCESS | 3830 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 119.0 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.14 (0.8%) stddev-sans-first:1.12 10:12:54 INFO - PROCESS | 3830 | Values: 146.0 147.0 148.0 147.0 146.0 147.0 147.0 147.0 147.0 150.0 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.49 (1.6%) stddev-sans-first:1.54 10:12:54 INFO - PROCESS | 3830 | Values: 95.0 100.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.50 stddev:1.63 (3.1%) stddev-sans-first:1.32 10:12:54 INFO - PROCESS | 3830 | Values: 50.0 52.0 54.0 53.0 52.0 56.0 54.0 52.0 54.0 53.0 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.00 stddev:1.96 (3.3%) stddev-sans-first:2.06 10:12:54 INFO - PROCESS | 3830 | Values: 60.0 60.0 59.0 61.0 60.0 60.0 60.0 60.0 66.0 60.0 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:78.00 stddev:7.63 (9.8%) stddev-sans-first:8.09 10:12:54 INFO - PROCESS | 3830 | Values: 81.0 78.0 76.0 76.0 79.0 83.0 77.0 78.0 101.0 75.0 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:127.50 stddev:5.12 (4.0%) stddev-sans-first:5.41 10:12:54 INFO - PROCESS | 3830 | Values: 127.0 120.0 130.0 119.0 133.0 127.0 118.0 128.0 130.0 125.0 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:155.00 stddev:3.43 (2.2%) stddev-sans-first:3.64 10:12:54 INFO - PROCESS | 3830 | Values: 154.0 158.0 152.0 151.0 152.0 153.0 156.0 161.0 150.0 156.0 10:12:54 INFO - PROCESS | 3830 | 10:12:54 INFO - PROCESS | 3830 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:2.30 (3.7%) stddev-sans-first:1.99 10:12:54 INFO - PROCESS | 3830 | Values: 66.0 63.0 63.0 66.0 61.0 60.0 60.0 62.0 61.0 60.0 10:12:54 INFO - PROCESS | 3830 | -------- Summary: end -------- 10:12:54 INFO - PROCESS | 3830 | 10:12:55 INFO - TEST-INFO | 3830: exit 0 10:12:55 INFO - TEST-OK | kraken | took 61158ms 10:12:55 INFO - SUITE-END | took 1173s 10:12:55 INFO - Completed test suite (00:19:34) 10:12:55 INFO - javascript benchmark 10:12:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7608.910083962829, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.418051840928, 3370.966290337097, 3375.2911888503445, 3384.627690953996, 3388.2715216228507, 5490.80782172624, 5497.587680923927, 5513.44865513449, 5551.916721249175, 5591.0, 5512.476314750093, 5593.776248950047, 5603.467670571299, 5613.410591887854, 5624.0, 5031.572316353106, 5066.771995260204, 5113.386393632769, 5115.9744201278945, 5140.074786538422, 4972.726500042496, 5100.33695619569, 5134.486551344873, 5134.948650513503, 5152.278680984665, 4979.551840334369, 5083.872903177413, 5090.949090509084, 5110.514501122388, 5121.56466700329, 5063.518965698253, 5079.8222062228015, 5084.6440749147205, 5140.357455318085, 5175.974120129394, 5039.521245481674, 5108.872278193075, 5117.0, 5119.846404607868, 5135.152699804527, 5310.0, 5433.864153396157, 5456.945430545684, 5491.148871924858, 5503.532199763025, 5973.0, 6036.275646922353, 6038.758449662008, 6039.0, 6043.033114701627, 6046.0, 6046.697665116727, 6063.363346848561, 6082.753035627686, 6094.847628809315, 5431.701256430894, 5471.179323101527, 5522.944770552283, 5561.694106824082, 5658.971705141489, 6027.0, 6039.48664363534, 6047.183630209865, 6053.424924632153, 6073.605215661057, 5796.0436527972415, 5812.476877081083, 5820.912686309709, 5838.1242813577455, 5839.795607153729, 5851.1223316502865, 5892.381299963442, 5894.821035792858, 5921.111833225051, 5995.0, 5928.584999050111, 5937.584369094208, 5937.910931336033, 5938.406159384027, 5942.970285148633, 5877.089051197071, 5896.439838215363, 5955.791547295824, 5997.0, 5998.610090344114, 4577.656675749266, 4580.312953057068, 4638.072385522909, 4666.883327916761, 4667.8599642010795, 4166.937495937564, 4168.979155104205, 4170.061736109412, 4176.415301857743, 4205.306124489425, 5792.9710351447975, 5805.419458054161, 5887.411258874164, 5920.644761314335, 5923.674197919069, 5872.17789509469, 5899.823005309848, 5995.640261584319, 6007.279126504847, 6139.815805525842, 5724.141378793214, 5782.335031471434, 5788.450097240755, 5789.45000224978, 5838.0, 5031.295618613397, 5166.870828229325, 5180.4560521145495, 5204.271402003723, 5207.0, 6227.688615569204, 6397.96801015992, 6403.295637479873, 6405.3594640535575, 6434.871302574016, 6058.182145410489, 6093.29927058394, 6095.939040609537, 6100.0849872519475, 6124.173236613, 6122.367660829107, 6198.597091189058, 6265.906011409924, 6408.423241908251, 6416.230052393743, 5975.731092100779, 5977.970110149421, 5978.0, 5982.850428739316, 5987.101934709828, 6062.545309101747, 6112.908306375319, 6135.84660383494, 6136.539759518143, 6137.96931015342, 5784.94215057844, 5809.50619197373, 5841.912371314349, 5858.5898987070495, 5995.790147344822, 5826.0, 5838.912416313844, 5855.180274761452, 5878.0, 5888.528917686661, 5722.055860783091, 5726.79956201531, 5727.799527016535, 5728.656280623176, 5759.0, 5735.512481438957, 5778.191053252632, 5840.123981402823, 5908.852278693067, 5976.462118409364, 5804.6807425592, 5823.301203855564, 5826.388229235869, 5829.2421985143355, 5848.064309710426], "value": 5543.238863841611, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.3039005144084, 659.4065341192927, 667.6928612838091, 669.9933000669994, 673.4074014866916, 39658.801705991464, 44923.32615010777, 45254.54745452545, 45365.546344536546, 45466.545334546645, 45389.319160212624, 45931.54068459314, 46089.769551152196, 46100.3084953726, 46226.0, 9002.54987250638, 9079.500627465486, 9113.134252246025, 9128.589213485377, 9139.543022848864, 8981.775455613597, 9057.728268151966, 9095.0, 9097.681581144661, 9100.681476148337, 9112.8633070504, 9119.224865886408, 9135.04082071383, 9147.679831205909, 9156.359054866129, 9097.317701172373, 9105.317101217403, 9116.58975346111, 9129.680461183827, 9158.0, 8971.237444817198, 9006.86489702655, 9018.053104424072, 9035.683751068747, 9056.320775941766, 43999.78000109979, 44058.33912491315, 44162.55837441649, 44506.777466112464, 44775.32837007415, 3830.0807806126327, 3867.3812190049457, 3911.178652482982, 4018.397240413932, 4268.743875367488, 33618.327633447436, 33731.32537349239, 34414.311713765586, 35044.12389690253, 35206.647933520595, 4353.673474489426, 4539.0, 4539.500654927955, 4601.240795268776, 4659.627229821606, 380631.0, 382644.0, 384503.0, 386024.9999999972, 386620.0, 38114.2377152461, 38824.0, 69102.0, 69426.30573694299, 69776.0, 41040.179196415906, 41178.0, 41325.58674413277, 41449.378259326135, 41468.585314146476, 17694.292228310722, 17798.822011779717, 17811.0, 17841.286348545913, 17968.371107011193, 14633.853661463461, 14640.560783176521, 14660.706785864222, 14675.853241467663, 14737.189454579886, 9342.953285233667, 9369.718908432622, 9382.953085234667, 9392.060793920553, 9396.577154028086, 3560.590532088791, 3566.98216508921, 3571.0715214044535, 3592.2815436912724, 3599.766015209003, 1101.7686285880054, 1137.5506674863548, 1196.8384268123866, 1230.926144431337, 1238.8032204900535, 34308.31383372319, 34701.13247168841, 34717.305653887284, 35010.0, 35213.64786352104, 1169.2049406403557, 1184.4373922386796, 1236.4188831249298, 1258.9972667159514, 1281.6475469245845, 17895.194716237802, 17905.910470447823, 18016.9099154506, 18121.275148994155, 18218.908905455653, 573082.0, 577968.0, 578213.0, 617031.0, 647140.0, 59332.70333648391, 65258.34741652523, 65535.34464655293, 65729.67135164293, 66074.66962665156, 1451.4816792864372, 1452.8256609206962, 1457.7376072306874, 1468.075112678984, 1478.5416520878562, 33868.49197262093, 34401.0, 34488.655113449546, 34719.82640086783, 34733.735148945016, 56356.43643563512, 57013.71493142508, 57123.42876571181, 57175.714121429126, 57207.71396142992, 608304.0, 618052.0, 619885.0, 619902.0, 620408.0, 31409.685903140675, 31797.523037154922, 31854.522182167748, 31873.840630796698, 31942.201444964063, 51776.0, 52514.0, 52778.0, 52962.47037529575, 53190.0, 43151.35272970845, 43537.78231108951, 43864.561354387326, 44033.339499908165, 45225.32162017638, 43632.78183609062, 44271.55728442803, 44418.33372499351, 44495.0, 45377.77311113424, 44685.77657111824, 45012.099758004, 45115.097698045196, 45153.54846451493, 45466.545334547554, 37160.0, 37553.0, 38039.61960380471, 38529.2294154121, 38884.805575971935, 29791.85104074466, 29894.25264368408, 30069.0, 30238.69761302447, 30633.23416914595], "value": 20569.98187547792, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.1344616643549, 421.42896375411334, 423.15580417067946, 424.99362509562343, 438.8771144079657, 18378.0, 19044.238230470783, 19674.508137296576, 19745.617806753515, 19819.702704459443, 12788.16876903003, 17997.820021799776, 18661.906690466527, 19314.227430902745, 19360.128794204258, 5319.840404787853, 5446.346438427375, 5456.890862182754, 5512.944870551283, 5524.861878453051, 5298.4436634153435, 5367.194920761897, 5511.311086114236, 5818.2145410369485, 5832.387599302076, 5720.08478643415, 5828.125781132821, 5879.088741245114, 5926.170336152942, 6004.699765011754, 5980.252468441445, 6030.457258846681, 6055.0, 6067.484263837579, 6085.361037091086, 5710.543156547507, 5787.102999035156, 5899.882002359972, 5915.911261331041, 5928.170056192136, 14369.497067602688, 14528.854711452856, 14730.63173420673, 19840.50398740043, 23847.284581462583, 2398.7406611528913, 2400.1839374612714, 2689.9731002690114, 2692.3538350795666, 2920.795544311899, 10242.385456872611, 10247.692569222936, 10760.3543787373, 11713.414329283587, 15615.531534053996, 2052.79472052795, 2069.617120832651, 2123.692064650617, 2138.647123224666, 2272.420532764151, 83892.58053709692, 87034.0, 87426.56286718526, 88627.55686221528, 90776.54611726965, 11511.827322590168, 11798.174127811142, 11873.287602743863, 11910.940445297718, 11936.598069550137, 16973.236204370834, 16992.405265815636, 16998.57503562421, 17051.062191579334, 33232.66767332344, 10444.164466842634, 10779.730506737238, 10823.783524329468, 11122.110231181487, 11328.433578321052, 8837.204651581389, 9147.679831205876, 9197.586108625128, 9251.583678734338, 9841.212702983745, 9225.21585665226, 9235.261179105655, 9306.488143152192, 9496.382735122195, 9779.462129582942, 3409.3010932758725, 3657.213699054716, 3749.531308586427, 3781.8487260509823, 3879.7478163919254, 994.9801003979879, 1043.8486419469134, 1048.4390850894736, 1076.7684947736118, 1115.4367044642404, 19784.505387365432, 20070.19719211215, 20104.195832166843, 20244.291449799188, 20293.59412811765, 1050.1283934334483, 1075.1076606416655, 1082.832161015044, 1127.2447460201683, 1167.5855071449682, 11321.660350189508, 11352.091832653368, 11512.827307590393, 11554.0, 11661.766764664659, 381426.0, 383954.0, 384402.0, 544319.0, 551272.0, 96369.51815240878, 103111.0, 103429.48285258525, 105103.47448262863, 105235.42146867803, 1046.3774054437597, 1100.8183649697871, 1135.5174051028114, 1143.7769634921276, 1162.84301619282, 18369.908150459698, 18677.159527821554, 18851.622967540297, 18938.621227575648, 19114.904425477784, 38571.421428679154, 40563.188736225704, 42518.0, 43284.78357608192, 43494.565054350314, 53394.46605533895, 54708.0, 60850.695746520985, 62934.92596740077, 65039.67480162569, 12688.74622507563, 13364.465421383426, 13401.66495837612, 13441.932790335986, 13544.661383465098, 14410.495632652806, 14652.487162949246, 14706.264686765833, 14744.852551474776, 14761.704765904837, 12711.745765084832, 13027.47890084386, 13037.348132593523, 13337.266450345323, 13353.799693004807, 12552.560660376843, 12571.93714031424, 12630.494780208688, 12636.620901372973, 12985.091043627233, 13083.542076027294, 13126.868731312565, 13141.802872957105, 13276.668083297609, 13357.866421335662, 13292.468301267842, 13296.202227866359, 13428.328583570978, 13459.528916487876, 13470.326483675974, 13264.933675331562, 13290.936725062165, 13355.3990070449, 13453.394597243343, 13502.45990160422], "value": 10376.110635963953, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1571.4578470427703, 1622.4667689033863, 1731.1863424190626, 1835.6879330513812, 1899.2497963304504, 8350.457220280692, 8831.293496520278, 8984.0, 9580.329376943617, 9603.99999999999, 8755.605997730101, 9021.594028268728, 9069.229115525171, 9076.092390760921, 9098.499582522974, 2390.617501199804, 2423.3820375804144, 2442.53591817555, 2442.658027876099, 2444.535538247736, 2303.3205204464725, 2303.435658263728, 2343.9296821095395, 2360.0323867214447, 2365.73976862545, 2432.2824766693866, 2453.3989172652723, 2458.7418321076298, 2485.8508489490596, 2500.0249902538026, 2356.3402247370764, 2363.550925324183, 2363.7636236376397, 2376.9524609507885, 2406.9037238510614, 2272.3410211038777, 2348.0, 2348.0607756897207, 2356.32844639277, 2373.9525209495714, 9044.819103617956, 9070.365074444791, 9084.954575227082, 9109.180173784325, 9137.131972462605, 5520.972395138038, 5616.241807355996, 5620.381758006616, 5634.211210430543, 5668.57485688575, 3389.1696534348994, 3414.3854106260865, 3446.0351101691317, 3468.479728040789, 3495.8426870790877, 1186.4008675618757, 1204.1570900369688, 1219.664592237133, 1230.0, 1262.551794113095, 13034.869651303556, 13053.673658158526, 13070.085094043421, 13078.149920255153, 13130.540431084866, 4816.590589799836, 4880.731559764247, 4883.389576302962, 4890.828820991248, 4999.575036121971, 11158.665240042812, 11183.776324473465, 11186.496607652674, 11193.49629266685, 11213.66359009231, 5560.610757247035, 5656.575756818255, 5667.263255776805, 5675.120356344773, 5700.315962084576, 4538.636909047268, 4940.382452193476, 5048.8232911848645, 5049.419316778544, 5198.480151984847, 4184.309588917795, 4220.155968806251, 4310.892227694333, 4311.33174357975, 4343.305071188594, 1318.235423454394, 1333.5865881576742, 1358.1375826350338, 1364.099694201822, 1371.3760239091189, 1052.5842292294653, 1057.735566108473, 1057.8201705710048, 1073.3398959639765, 1075.2258373970728, 6252.280987686383, 6430.485561155097, 6470.029495575702, 6480.740770369227, 6495.317991610813, 456.07416943604534, 466.9322948172496, 469.77216050215617, 478.5573344656249, 485.980560777572, 4200.789960502024, 4215.0, 4287.978560107242, 4329.891752706145, 4341.261985462479, 11280.210385273116, 11614.245074070159, 11622.0, 11627.069834413227, 11815.704607384712, 11487.655370338904, 11492.827607585725, 11552.0, 11584.304941703525, 11631.709207269885, 8401.95799021001, 8725.825483490295, 8743.300535957109, 8760.693375731818, 8965.148310910583, 6578.8355291118105, 6684.097646817618, 6730.562513436611, 6810.9318906810295, 6816.420604248496, 10709.410982396043, 10876.619318323821, 10884.510197040994, 10974.670759877217, 11126.888731112585, 11106.278091924, 11118.555257789922, 11184.94407527957, 11259.155563332619, 11302.0, 7379.889301660372, 8284.212999765012, 8334.12491688364, 8345.374096942633, 8474.618642160995, 9268.814623707352, 9282.257419406296, 9300.906990930003, 9325.347225694137, 9369.063093690576, 8114.148014458633, 8336.499810011419, 8423.157684231528, 8476.618552165044, 8547.444416112932, 7856.45004849655, 7875.763727088197, 8268.627911743866, 8310.33517318601, 8344.41589088758, 7139.964300178466, 7146.428285737233, 7149.642517874189, 7193.100862392201, 7204.0994875640545, 5399.217113518439, 5405.729713514387, 5447.455254474521, 5509.47659972302, 5515.448455154453, 5652.63257888236, 5678.6876721779045, 5709.0865461525955, 5796.913046304225, 5843.181954526454], "value": 4830.049021059252, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.7808980342384, 361.34055348988096, 362.6156274349189, 362.66815863484896, 362.8911326602019, 5467.835964921049, 5523.199136125259, 5627.2684551008415, 5685.948099601572, 5707.543396528278, 5558.194061861028, 5573.191887176357, 5575.386707462176, 5596.908602822441, 5602.915956260659, 4374.190774706682, 4385.912281754363, 4392.604665580097, 4395.516493185747, 4403.537628549005, 4105.67154627629, 4319.48166220054, 4321.567843215685, 4404.757738324391, 4439.2453282941815, 4255.0, 4257.489101307832, 4271.487421509408, 4282.614564689177, 4297.183535128332, 4281.186574550841, 4302.0, 4310.676699247569, 4320.438343015419, 4325.134973005412, 3740.8316625751636, 3838.9232215355814, 3842.2507611015862, 3848.9615103849164, 3853.2871418787613, 5389.6285634320775, 5415.539679127279, 5440.347158340985, 5447.428020057916, 5461.1262198048125, 5012.8496145115705, 5016.398032236155, 5068.4171320298265, 5069.1129052416045, 5125.282460455539, 5610.719464026783, 5815.185873977646, 5846.269216347957, 5867.501262392701, 5874.0, 4217.325227963511, 4221.535631080578, 4222.387753775716, 4232.936505952413, 4241.4698162729655, 6042.456178943916, 6139.539534534928, 6141.727560802532, 6170.6297622142365, 6175.783847565313, 4219.282721937278, 4226.894327641772, 4230.217409779139, 4230.767307798101, 4233.449651545279, 4243.151369726067, 4282.935755963663, 4285.335772955197, 4294.463192100988, 4298.20483210607, 4831.154547954094, 4902.411710594752, 4922.58158056562, 4993.350864387607, 5006.974965125151, 5662.546996240291, 5856.560757943172, 5857.330660761662, 5908.231929849092, 5955.166276721263, 1498.2658497336226, 1532.1343440955825, 1534.1562140822725, 1534.8081489813774, 1537.8769698424098, 952.3000594562991, 958.8130314588727, 965.3339195954909, 967.9951600242094, 987.5654711926729, 5219.582433405319, 5278.313819203479, 5282.709450980156, 5284.550813180846, 5290.576753859682, 5392.276900165391, 5429.864253393696, 5437.619366644297, 5442.720960574262, 5456.399796022434, 4899.211787697464, 5172.741362931838, 5192.740362981911, 5230.241614965885, 5253.973730131325, 2859.613952116479, 2867.1936679891533, 2911.97088029117, 2916.5187744022423, 2917.6352955880516, 5629.7185140742795, 5642.887142257214, 5644.250282412465, 5675.404082571353, 5680.517156041783, 5083.771230294646, 5413.512783849473, 5437.900396773801, 5484.670919744828, 5532.336119665585, 5634.85912852182, 5656.604037717402, 5662.66024038559, 5688.77244910199, 5704.629199102128, 5248.396434410091, 5372.910576418497, 5419.729013549228, 5429.864253393539, 5462.525118217979, 5357.946420535744, 5388.488093631099, 5417.214503896992, 5428.022955867982, 5465.72671366438, 5577.247071645438, 5642.266505354278, 5669.716514174357, 5676.971615141898, 5678.346990096192, 3747.5315585551807, 3902.1220225449047, 3917.666998305176, 3963.5441924177935, 3968.0476685595827, 5443.7822487100075, 5451.7274136292235, 5459.590530710133, 5756.280464941882, 5991.281046274475, 5930.644161350333, 5964.493018093511, 6033.155358249761, 6043.637381757108, 6045.758169673164, 5928.436798504135, 5935.258092738408, 5947.791827286197, 5984.0, 6002.789902353396, 5615.0173719599725, 5758.596898217084, 5789.0, 5808.854778630568, 5809.331926828469, 5994.0, 5996.280446346292, 6033.396660333931, 6048.243969503812, 6061.787642471611, 5721.284839395075, 5841.415858414124, 5861.589688721919, 5898.8230353089475, 5920.496757775637], "value": 4344.696656014881, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.1416113516834, 813.9593020348981, 814.62934364864, 827.4456114403351, 863.3093525179856, 14699.853001469983, 15475.148866812335, 15597.92201038996, 16007.119608421532, 16201.756973645404, 15637.452689155882, 16334.18329083544, 16366.181690915437, 16486.25811838467, 16522.42171523997, 857.7726902370877, 870.7953630896734, 874.1302404107921, 875.7460336502406, 882.0473888200728, 881.497546398553, 883.5626364949359, 884.7611144990849, 885.3802338363139, 885.7431344909968, 923.529000209891, 924.2328867040374, 924.9907500924971, 925.694520808135, 926.5645146781002, 909.2907532124954, 914.8536234202562, 914.9359544831898, 918.5728636184173, 920.7652048727565, 670.3564578005121, 671.2414971082694, 672.0893189727946, 673.0173946038789, 673.1215763428723, 14643.41426342945, 14660.0, 14669.633259168499, 14799.33402996857, 14826.258687065603, 14425.350859211361, 14830.555083347517, 15192.316345764468, 15312.770308445382, 15514.224288785628, 12255.264684118982, 12741.17182383142, 12774.61676149717, 13205.141665791693, 13443.01525575828, 3978.5424676162324, 4032.778197199153, 4071.470708807836, 4086.264472394968, 4120.567340429242, 82093.58953205256, 83846.0, 84009.57995209986, 85242.0, 85310.01414950447, 12391.876081239252, 12422.689432764253, 12538.247705137721, 12645.494180232872, 12767.042471814651, 22339.776602234095, 22538.436539086328, 22598.548029039655, 22612.321630351114, 22702.0, 8543.743687689379, 8571.142885711379, 8615.3107751381, 8691.087435819149, 8853.822923541622, 4974.104661160954, 4999.950000500021, 5039.319691841628, 5059.696418214919, 5250.711210883362, 3565.6790888820133, 3673.8714145004797, 3683.208110256308, 3699.3711069118312, 3700.0749812546865, 623.9906401403982, 649.4577028181427, 656.1961597043584, 657.1850904878013, 662.8541720821412, 732.5642239553506, 742.6992068212382, 792.7740593930818, 794.8648729715962, 850.5577099908013, 10271.845922311171, 10282.588696452058, 10318.690439286833, 10381.740456488647, 10458.477076146162, 775.7440044785208, 818.1695578987333, 823.1932705948204, 826.5082276045744, 834.3658819297377, 4473.4408198975125, 4532.614727748112, 4544.113897789965, 4559.749213793207, 4575.725456472623, 70412.64793675998, 72721.63639181771, 110582.0, 118843.0, 122768.38615806864, 79396.20603793889, 94356.52821735847, 98301.0, 99535.0, 100484.4975775131, 63268.36731632717, 92925.0, 93340.0, 93708.53145734363, 94662.52668736612, 9977.151942085004, 9991.0, 10331.0, 10364.844527332247, 10379.792404151724, 51433.48566514437, 51501.7424912888, 52286.215706763665, 52367.0, 52733.47266527286, 47699.28451073306, 48162.5183748158, 57159.0, 75978.62010690132, 79126.20873791189, 12567.371631418575, 13078.934605326913, 13270.668233294246, 13410.530631427853, 13742.0, 13925.0, 14714.779278311047, 15097.169655669044, 15155.621109472351, 15305.846941530443, 13575.79636305476, 13824.930875345559, 13918.234497102352, 14210.28948552589, 14214.147151170962, 13529.120607160503, 13702.177869327872, 13804.585862424143, 14277.571672849832, 14290.42838286457, 13630.795538066739, 13755.931220343835, 13888.236147012012, 13965.092269002482, 14445.0, 10935.56257749681, 11007.724806879893, 11183.72040698989, 11253.0, 11297.322160670386, 10545.0, 11083.778324433304, 11201.495932683212, 11209.775804484028, 11346.149038821955], "value": 7815.330210768307, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 110.0, 111.0, 114.0, 110.0, 111.0, 112.0, 111.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 125.0, 152.0, 171.0, 126.0, 159.0, 156.0, 127.0, 178.0, 126.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 161.0, 167.0, 162.0, 162.0, 163.0, 165.0, 161.0, 164.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 77.0, 174.0, 76.0, 81.0, 74.0, 75.0, 170.0, 76.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 153.0, 85.0, 85.0, 86.0, 145.0, 87.0, 86.0, 141.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 150.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 54.0, 53.0, 52.0, 56.0, 54.0, 52.0, 54.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 61.0, 60.0, 60.0, 60.0, 60.0, 66.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 76.0, 76.0, 79.0, 83.0, 77.0, 78.0, 101.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 120.0, 130.0, 119.0, 133.0, 127.0, 118.0, 128.0, 130.0, 125.0], "value": 125.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 158.0, 152.0, 151.0, 152.0, 153.0, 156.0, 161.0, 150.0, 156.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 63.0, 66.0, 61.0, 60.0, 60.0, 62.0, 61.0, 60.0], "value": 62.2, "unit": "score"}]}]} 10:12:55 INFO - Return code: 0 10:12:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:12:55 ERROR - # TBPL SUCCESS # 10:12:55 INFO - Running post-action listener: _resource_record_post_action 10:12:55 INFO - ##### 10:12:55 INFO - ##### Finished run-tests step (success) 10:12:55 INFO - ##### 10:12:55 INFO - Running post-run listener: _resource_record_post_run 10:12:55 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 7925760; Write bytes: 463892480; Read time: 1596; Write time: 360712 10:12:55 INFO - TinderboxPrint: CPU usage
13.5% 10:12:55 INFO - TinderboxPrint: I/O read bytes / time
7,925,760 / 1,596 10:12:55 INFO - TinderboxPrint: I/O write bytes / time
463,892,480 / 360,712 10:12:55 INFO - TinderboxPrint: CPU idle
8,221.9 (86.5%) 10:12:55 INFO - TinderboxPrint: CPU user
1,219.1 (12.8%) 10:12:55 INFO - TinderboxPrint: Swap in / out
0 / 0 10:12:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 87461888; Read time: 0; Write time: 57612 10:12:55 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6164480; Write bytes: 376430592; Read time: 1548; Write time: 303100 10:12:56 INFO - Running post-run listener: _upload_blobber_files 10:12:56 INFO - Blob upload gear active. 10:12:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:12:56 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 10:12:56 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'] 10:12:56 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 10:12:56 INFO - (blobuploader) - INFO - Open directory for files ... 10:12:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:12:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:12:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:12:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:12:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:12:57 INFO - (blobuploader) - INFO - Done attempting. 10:12:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:12:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:12:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:12:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:12:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:12:58 INFO - (blobuploader) - INFO - Done attempting. 10:12:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:12:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:12:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:13:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:02 INFO - (blobuploader) - INFO - Done attempting. 10:13:02 INFO - (blobuploader) - INFO - Iteration through files over. 10:13:02 INFO - Return code: 0 10:13:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:13:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:13:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c1cfde9f441056534006f239356a7f24406d0ea2b99827f222bffed948f9a5559707db7949c75ccb32a388634eea53227bc44887425a2babe4fd8c90c25074b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6a5effd846e1271ccb19903d9bdeb167439316da776254580911bdd5011aa0198a0b2aa21b5031d506a77b30d2bdb85c187200c7793d012547745ff5420759d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1cac0472b2fa8394d12de977fd1ff2b04039bb0445ce0efcdea22a8e74102a46530a8373cc42899b475604494cc7a00773d4d8a20c2049fa5b1b465038396565"} 10:13:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:13:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:13:02 INFO - Contents: 10:13:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c1cfde9f441056534006f239356a7f24406d0ea2b99827f222bffed948f9a5559707db7949c75ccb32a388634eea53227bc44887425a2babe4fd8c90c25074b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6a5effd846e1271ccb19903d9bdeb167439316da776254580911bdd5011aa0198a0b2aa21b5031d506a77b30d2bdb85c187200c7793d012547745ff5420759d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1cac0472b2fa8394d12de977fd1ff2b04039bb0445ce0efcdea22a8e74102a46530a8373cc42899b475604494cc7a00773d4d8a20c2049fa5b1b465038396565"} 10:13:02 INFO - Running post-run listener: copy_logs_to_upload_dir 10:13:02 INFO - Copying logs to upload dir... 10:13:02 INFO - mkdir: /builds/slave/test/build/upload/logs 10:13:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.281002 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-06 10:13:02.133612) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 10:13:02.136683) ========= 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=523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049 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/8c1cfde9f441056534006f239356a7f24406d0ea2b99827f222bffed948f9a5559707db7949c75ccb32a388634eea53227bc44887425a2babe4fd8c90c25074b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6a5effd846e1271ccb19903d9bdeb167439316da776254580911bdd5011aa0198a0b2aa21b5031d506a77b30d2bdb85c187200c7793d012547745ff5420759d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1cac0472b2fa8394d12de977fd1ff2b04039bb0445ce0efcdea22a8e74102a46530a8373cc42899b475604494cc7a00773d4d8a20c2049fa5b1b465038396565"} build_url:https://queue.taskcluster.net/v1/task/KXMC135eQ2iyjXRcNVKzWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011167 build_url: 'https://queue.taskcluster.net/v1/task/KXMC135eQ2iyjXRcNVKzWA/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/8c1cfde9f441056534006f239356a7f24406d0ea2b99827f222bffed948f9a5559707db7949c75ccb32a388634eea53227bc44887425a2babe4fd8c90c25074b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6a5effd846e1271ccb19903d9bdeb167439316da776254580911bdd5011aa0198a0b2aa21b5031d506a77b30d2bdb85c187200c7793d012547745ff5420759d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1cac0472b2fa8394d12de977fd1ff2b04039bb0445ce0efcdea22a8e74102a46530a8373cc42899b475604494cc7a00773d4d8a20c2049fa5b1b465038396565"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 10:13:02.165797) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:13:02.166519) ========= 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=523ca41ca1e0623de333ad52000001bf-1467823928.198530-2084267049 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004653 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:13:02.252108) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 10:13:02.252812) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 10:13:02.253522) ========= ========= Total master_lag: 0.15 =========