builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1467823944.65 results: success (0) buildid: 20160706071423 builduid: e79b1ae117c244349c0131cafaf9768d revision: 6eaa86d11a5c5dad67d5ca343e5d9226ff524517 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:24.646301) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:24.646745) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:24.647018) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:24.748905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:24.749225) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 09:52:25-- 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% 397M=0s 2016-07-06 09:52:25 (397 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097818 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:24.857736) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:24.858071) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022294 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:24.907621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 09:52:24.907949) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 09:52:25,492 truncating revision to first 12 chars 2016-07-06 09:52:25,493 Setting DEBUG logging. 2016-07-06 09:52:25,493 attempt 1/10 2016-07-06 09:52:25,493 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:26,836 unpacking tar archive at: mozilla-aurora-6eaa86d11a5c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.683798 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 09:52:26.605093) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:26.605441) ========= script_repo_revision: 6eaa86d11a5c5dad67d5ca343e5d9226ff524517 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:26.605815) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:26.606091) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 09:52:26.615866) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-06 09:52:26.616146) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:52:27 INFO - MultiFileLogger online at 20160706 09:52:27 in /builds/slave/test 09:52:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:52:27 INFO - {'append_to_log': False, 09:52:27 INFO - 'base_work_dir': '/builds/slave/test', 09:52:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:52:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:52:27 INFO - 'branch': 'Mozilla-Aurora', 09:52:27 INFO - 'buildbot_json_path': 'buildprops.json', 09:52:27 INFO - 'config_files': ('talos/linux_config.py',), 09:52:27 INFO - 'default_actions': ('clobber', 09:52:27 INFO - 'read-buildbot-config', 09:52:27 INFO - 'download-and-extract', 09:52:27 INFO - 'populate-webroot', 09:52:27 INFO - 'create-virtualenv', 09:52:27 INFO - 'install', 09:52:27 INFO - 'run-tests'), 09:52:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:52:27 INFO - 'download_minidump_stackwalk': True, 09:52:27 INFO - 'download_symbols': 'ondemand', 09:52:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:52:27 INFO - 'tooltool.py': '/tools/tooltool.py', 09:52:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:52:27 INFO - '/tools/misc-python/virtualenv.py')}, 09:52:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:52:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:52:27 INFO - 'installer_path': 'installer.exe', 09:52:27 INFO - 'log_level': 'info', 09:52:27 INFO - 'log_name': 'talos', 09:52:27 INFO - 'log_to_console': True, 09:52:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:52:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:52:27 INFO - 'opt_config_files': (), 09:52:27 INFO - 'pip_index': False, 09:52:27 INFO - 'sps_profile': False, 09:52:27 INFO - 'sps_profile_interval': 0, 09:52:27 INFO - 'suite': 'dromaeojs', 09:52:27 INFO - 'system_bits': '32', 09:52:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:52:27 INFO - 'title': 'talos-linux64-ix-062', 09:52:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:52:27 INFO - 'use_talos_json': True, 09:52:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:52:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:52:27 INFO - 'work_dir': 'build'} 09:52:27 INFO - ##### 09:52:27 INFO - ##### Running clobber step. 09:52:27 INFO - ##### 09:52:27 INFO - Running pre-action listener: _resource_record_pre_action 09:52:27 INFO - Running main action method: clobber 09:52:27 INFO - rmtree: /builds/slave/test/build 09:52:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:52:28 INFO - Running post-action listener: _resource_record_post_action 09:52:28 INFO - ##### 09:52:28 INFO - ##### Finished clobber step (success) 09:52:28 INFO - ##### 09:52:28 INFO - ##### 09:52:28 INFO - ##### Running read-buildbot-config step. 09:52:28 INFO - ##### 09:52:28 INFO - Running pre-action listener: _resource_record_pre_action 09:52:28 INFO - Running main action method: read_buildbot_config 09:52:28 INFO - Using buildbot properties: 09:52:28 INFO - { 09:52:28 INFO - "project": "", 09:52:28 INFO - "product": "firefox", 09:52:28 INFO - "script_repo_revision": "production", 09:52:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:52:28 INFO - "repository": "", 09:52:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:52:28 INFO - "buildid": "20160706071423", 09:52:28 INFO - "pgo_build": "True", 09:52:28 INFO - "basedir": "/builds/slave/test", 09:52:28 INFO - "buildnumber": 593, 09:52:28 INFO - "slavename": "talos-linux64-ix-062", 09:52:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:52:28 INFO - "platform": "ubuntu64_hw", 09:52:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:52:28 INFO - "branch": "mozilla-aurora", 09:52:28 INFO - "repo_path": "releases/mozilla-aurora", 09:52:28 INFO - "revision": "6eaa86d11a5c5dad67d5ca343e5d9226ff524517", 09:52:28 INFO - "stage_platform": "linux64-pgo", 09:52:28 INFO - "builduid": "e79b1ae117c244349c0131cafaf9768d", 09:52:28 INFO - "slavebuilddir": "test" 09:52:28 INFO - } 09:52:28 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:28 INFO - Running post-action listener: _resource_record_post_action 09:52:28 INFO - ##### 09:52:28 INFO - ##### Finished read-buildbot-config step (success) 09:52:28 INFO - ##### 09:52:28 INFO - ##### 09:52:28 INFO - ##### Running download-and-extract step. 09:52:28 INFO - ##### 09:52:28 INFO - Running pre-action listener: _resource_record_pre_action 09:52:28 INFO - Running main action method: download_and_extract 09:52:28 INFO - mkdir: /builds/slave/test/build/tests 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.test_packages.json 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.test_packages.json 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.test_packages.json 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.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:52:28 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:34 INFO - Downloaded 1361 bytes. 09:52:34 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:52:34 INFO - Using the following test package requirements: 09:52:34 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 09:52:34 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:52:34 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:52:34 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:34 INFO - u'jsshell-linux-x86_64.zip'], 09:52:34 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:52:34 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 09:52:34 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:52:34 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:52:34 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:52:34 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:52:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:52:34 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:52:34 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:34 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:34 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:34 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:34 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:34 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:35 INFO - Downloaded 24526481 bytes. 09:52:35 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:35 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:36 INFO - Return code: 0 09:52:36 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:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:36 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:36 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:36 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:36 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:36 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:37 INFO - Downloaded 24526481 bytes. 09:52:37 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:37 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:39 INFO - Return code: 0 09:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:39 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:39 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:39 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:39 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:39 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:40 INFO - Downloaded 10833369 bytes. 09:52:40 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:40 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:40 INFO - Return code: 0 09:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:40 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:40 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:40 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:40 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:40 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:41 INFO - Downloaded 63638120 bytes. 09:52:41 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:41 INFO - mkdir: /builds/slave/test/properties 09:52:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:52:41 INFO - Writing to file /builds/slave/test/properties/build_url 09:52:41 INFO - Contents: 09:52:41 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:42 INFO - Running post-action listener: _resource_record_post_action 09:52:42 INFO - Running post-action listener: set_extra_try_arguments 09:52:42 INFO - ##### 09:52:42 INFO - ##### Finished download-and-extract step (success) 09:52:42 INFO - ##### 09:52:42 INFO - ##### 09:52:42 INFO - ##### Running populate-webroot step. 09:52:42 INFO - ##### 09:52:42 INFO - Running pre-action listener: _resource_record_pre_action 09:52:42 INFO - Running main action method: populate_webroot 09:52:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:52:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:52:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:52:42 INFO - '--tppagecycles', 09:52:42 INFO - '7'], 09:52:42 INFO - 'tests': ['tsvgm']}}, 09:52:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:52:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:52:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:52:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:52:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:52:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:52:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:42 INFO - 'talos_options': ['--disable-e10s'], 09:52:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:42 INFO - 'talos_options': ['--disable-e10s'], 09:52:42 INFO - 'tests': ['damp', 'tps']}, 09:52:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:42 INFO - 'tests': ['damp', 'tps']}, 09:52:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:52:42 INFO - 'tests': ['dromaeo_dom']}, 09:52:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:52:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:52:42 INFO - 'tests': ['a11yr', 09:52:42 INFO - 'ts_paint', 09:52:42 INFO - 'tpaint', 09:52:42 INFO - 'sessionrestore', 09:52:42 INFO - 'sessionrestore_no_auto_restore', 09:52:42 INFO - 'tabpaint']}, 09:52:42 INFO - 'other-e10s': {'tests': ['a11yr', 09:52:42 INFO - 'ts_paint', 09:52:42 INFO - 'tpaint', 09:52:42 INFO - 'sessionrestore', 09:52:42 INFO - 'sessionrestore_no_auto_restore', 09:52:42 INFO - 'tabpaint']}, 09:52:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:52:42 INFO - 'ts_paint', 09:52:42 INFO - 'tpaint', 09:52:42 INFO - 'sessionrestore', 09:52:42 INFO - 'sessionrestore_no_auto_restore', 09:52:42 INFO - 'tabpaint']}, 09:52:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:52:42 INFO - 'ts_paint', 09:52:42 INFO - 'tpaint', 09:52:42 INFO - 'sessionrestore', 09:52:42 INFO - 'sessionrestore_no_auto_restore', 09:52:42 INFO - 'tabpaint']}, 09:52:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:52:42 INFO - 'tests': ['a11yr', 09:52:42 INFO - 'ts_paint', 09:52:42 INFO - 'tpaint', 09:52:42 INFO - 'sessionrestore', 09:52:42 INFO - 'sessionrestore_no_auto_restore', 09:52:42 INFO - 'tabpaint']}, 09:52:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:52:42 INFO - 'tests': ['a11yr', 09:52:42 INFO - 'ts_paint', 09:52:42 INFO - 'tpaint', 09:52:42 INFO - 'sessionrestore', 09:52:42 INFO - 'sessionrestore_no_auto_restore', 09:52:42 INFO - 'tabpaint']}, 09:52:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:52:42 INFO - 'tests': ['tsvgx', 09:52:42 INFO - 'tsvgr_opacity', 09:52:42 INFO - 'tart', 09:52:42 INFO - 'tscrollx', 09:52:42 INFO - 'cart']}, 09:52:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:52:42 INFO - 'tsvgr_opacity', 09:52:42 INFO - 'tart', 09:52:42 INFO - 'tscrollx', 09:52:42 INFO - 'cart']}, 09:52:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:42 INFO - 'talos_options': ['--disable-e10s'], 09:52:42 INFO - 'tests': ['tp5o']}, 09:52:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:42 INFO - 'tests': ['tp5o']}, 09:52:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:42 INFO - 'talos_options': ['--disable-e10s', 09:52:42 INFO - '--xperf_path', 09:52:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:42 INFO - 'tests': ['tp5n']}, 09:52:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:42 INFO - 'talos_options': ['--xperf_path', 09:52:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:42 INFO - 'tests': ['tp5n']}}, 09:52:42 INFO - 'talos.zip': {'path': '', 09:52:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:52:42 INFO - Running post-action listener: _resource_record_post_action 09:52:42 INFO - ##### 09:52:42 INFO - ##### Finished populate-webroot step (success) 09:52:42 INFO - ##### 09:52:42 INFO - ##### 09:52:42 INFO - ##### Running create-virtualenv step. 09:52:42 INFO - ##### 09:52:42 INFO - Running pre-action listener: _resource_record_pre_action 09:52:42 INFO - Running main action method: create_virtualenv 09:52:42 INFO - Creating virtualenv /builds/slave/test/build/venv 09:52:42 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:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:52:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:52:42 INFO - Using real prefix '/usr' 09:52:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:52:43 INFO - Installing distribute.............................................................................................................................................................................................done. 09:52:45 INFO - Installing pip.................done. 09:52:45 INFO - Return code: 0 09:52:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:52:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:45 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 0x7f9333987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1c0>, '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 0x10fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 09:52:45 INFO - 'HOME': '/home/cltbld', 09:52:45 INFO - 'LANG': 'en_US.UTF-8', 09:52:45 INFO - 'LANGUAGE': 'en_US:en', 09:52:45 INFO - 'LOGNAME': 'cltbld', 09:52:45 INFO - 'MAIL': '/var/mail/cltbld', 09:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:45 INFO - 'MOZ_NO_REMOTE': '1', 09:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:45 INFO - 'NO_EM_RESTART': '1', 09:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:45 INFO - 'PWD': '/builds/slave/test', 09:52:45 INFO - 'SHELL': '/bin/bash', 09:52:45 INFO - 'SHLVL': '1', 09:52:45 INFO - 'TERM': 'linux', 09:52:45 INFO - 'TMOUT': '86400', 09:52:45 INFO - 'USER': 'cltbld', 09:52:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', 09:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:45 INFO - '_': '/tools/buildbot/bin/python'} 09:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:45 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:45 INFO - Cleaning up... 09:52:45 INFO - Return code: 0 09:52:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:52:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:45 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 0x7f9333987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1c0>, '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 0x10fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 09:52:45 INFO - 'HOME': '/home/cltbld', 09:52:45 INFO - 'LANG': 'en_US.UTF-8', 09:52:45 INFO - 'LANGUAGE': 'en_US:en', 09:52:45 INFO - 'LOGNAME': 'cltbld', 09:52:45 INFO - 'MAIL': '/var/mail/cltbld', 09:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:45 INFO - 'MOZ_NO_REMOTE': '1', 09:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:45 INFO - 'NO_EM_RESTART': '1', 09:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:45 INFO - 'PWD': '/builds/slave/test', 09:52:45 INFO - 'SHELL': '/bin/bash', 09:52:45 INFO - 'SHLVL': '1', 09:52:45 INFO - 'TERM': 'linux', 09:52:45 INFO - 'TMOUT': '86400', 09:52:45 INFO - 'USER': 'cltbld', 09:52:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', 09:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:45 INFO - '_': '/tools/buildbot/bin/python'} 09:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:45 INFO - Downloading/unpacking psutil>=3.1.1 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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:52:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:47 INFO - Installing collected packages: psutil 09:52:47 INFO - Running setup.py install for psutil 09:52:47 INFO - building 'psutil._psutil_linux' extension 09:52:47 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:47 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:47 INFO - building 'psutil._psutil_posix' extension 09:52:47 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:47 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:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:48 INFO - Successfully installed psutil 09:52:48 INFO - Cleaning up... 09:52:48 INFO - Return code: 0 09:52:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9333987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1c0>, '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 0x10fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', '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:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:52:48 INFO - Using env: {'DISPLAY': ':0', 09:52:48 INFO - 'HOME': '/home/cltbld', 09:52:48 INFO - 'LANG': 'en_US.UTF-8', 09:52:48 INFO - 'LANGUAGE': 'en_US:en', 09:52:48 INFO - 'LOGNAME': 'cltbld', 09:52:48 INFO - 'MAIL': '/var/mail/cltbld', 09:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:48 INFO - 'MOZ_NO_REMOTE': '1', 09:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:48 INFO - 'NO_EM_RESTART': '1', 09:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:48 INFO - 'PWD': '/builds/slave/test', 09:52:48 INFO - 'SHELL': '/bin/bash', 09:52:48 INFO - 'SHLVL': '1', 09:52:48 INFO - 'TERM': 'linux', 09:52:48 INFO - 'TMOUT': '86400', 09:52:48 INFO - 'USER': 'cltbld', 09:52:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', 09:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:48 INFO - '_': '/tools/buildbot/bin/python'} 09:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:52:50 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:50 INFO - Installing collected packages: mozsystemmonitor 09:52:50 INFO - Running setup.py install for mozsystemmonitor 09:52:50 INFO - Successfully installed mozsystemmonitor 09:52:50 INFO - Cleaning up... 09:52:50 INFO - Return code: 0 09:52:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:52:50 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:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:50 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:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:50 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 0x7f9333987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1c0>, '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 0x10fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', '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:50 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:50 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:50 INFO - Using env: {'DISPLAY': ':0', 09:52:50 INFO - 'HOME': '/home/cltbld', 09:52:50 INFO - 'LANG': 'en_US.UTF-8', 09:52:50 INFO - 'LANGUAGE': 'en_US:en', 09:52:50 INFO - 'LOGNAME': 'cltbld', 09:52:50 INFO - 'MAIL': '/var/mail/cltbld', 09:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:50 INFO - 'MOZ_NO_REMOTE': '1', 09:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:50 INFO - 'NO_EM_RESTART': '1', 09:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:50 INFO - 'PWD': '/builds/slave/test', 09:52:50 INFO - 'SHELL': '/bin/bash', 09:52:50 INFO - 'SHLVL': '1', 09:52:50 INFO - 'TERM': 'linux', 09:52:50 INFO - 'TMOUT': '86400', 09:52:50 INFO - 'USER': 'cltbld', 09:52:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', 09:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:50 INFO - '_': '/tools/buildbot/bin/python'} 09:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:50 INFO - Downloading/unpacking jsonschema==2.5.1 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:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:52:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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 functools32-3.2.3-2.tar.gz 09:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:52:52 INFO - warning: no files found matching '*.txt' 09:52:52 INFO - no previously-included directories found matching 'build' 09:52:52 INFO - no previously-included directories found matching 'dist' 09:52:52 INFO - no previously-included directories found matching '.git*' 09:52:52 INFO - Installing collected packages: jsonschema, functools32 09:52:52 INFO - Running setup.py install for functools32 09:52:52 INFO - warning: no files found matching '*.txt' 09:52:52 INFO - no previously-included directories found matching 'build' 09:52:52 INFO - no previously-included directories found matching 'dist' 09:52:52 INFO - no previously-included directories found matching '.git*' 09:52:52 INFO - Successfully installed jsonschema functools32 09:52:52 INFO - Cleaning up... 09:52:53 INFO - Return code: 0 09:52:53 INFO - Installing blobuploader==1.2.4 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', '--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 0x7f9333987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1c0>, '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 0x10fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', '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', '--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:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 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': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', 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 - Downloading/unpacking blobuploader==1.2.4 09:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:55 INFO - Downloading blobuploader-1.2.4.tar.gz 09:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:52:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:52:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:55 INFO - Downloading docopt-0.6.1.tar.gz 09:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:52:55 INFO - Installing collected packages: blobuploader, requests, docopt 09:52:55 INFO - Running setup.py install for blobuploader 09:52:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:52:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:52:56 INFO - Running setup.py install for requests 09:52:56 INFO - Running setup.py install for docopt 09:52:56 INFO - Successfully installed blobuploader requests docopt 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', '--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 0x7f9333987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1c0>, '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 0x10fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', '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', '--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:56 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: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': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', 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-fH5YZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:52:56 INFO - Running setup.py (path:/tmp/pip-ZrCnMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:52:56 INFO - Running setup.py (path:/tmp/pip-Z9mQSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:52:56 INFO - Running setup.py (path:/tmp/pip-2qdRCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:52:57 INFO - Running setup.py (path:/tmp/pip-3Ee2Wh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:52:57 INFO - Running setup.py (path:/tmp/pip-ST5hUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:52:57 INFO - Running setup.py (path:/tmp/pip-doiF4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:52:57 INFO - Running setup.py (path:/tmp/pip-HBL2O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:52:57 INFO - Running setup.py (path:/tmp/pip-uEmTcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:52:57 INFO - Running setup.py (path:/tmp/pip-8sdNxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:52:57 INFO - Running setup.py (path:/tmp/pip-78tIZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:52:57 INFO - Running setup.py (path:/tmp/pip-wS9l3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:52:57 INFO - Running setup.py (path:/tmp/pip-PxC8jB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:52:57 INFO - Running setup.py (path:/tmp/pip-wsr3gW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:57 INFO - Running setup.py (path:/tmp/pip-5rf7_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:52:57 INFO - Running setup.py (path:/tmp/pip-iGUf7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:52:57 INFO - Running setup.py (path:/tmp/pip-ALwtmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:52:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:52:57 INFO - Running setup.py install for manifestparser 09:52:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:52:58 INFO - Running setup.py install for mozcrash 09:52:58 INFO - Running setup.py install for mozdebug 09:52:58 INFO - Running setup.py install for mozdevice 09:52:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:52:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:52:58 INFO - Running setup.py install for mozfile 09:52:58 INFO - Running setup.py install for mozhttpd 09:52:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:52:58 INFO - Running setup.py install for mozinfo 09:52:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:52:58 INFO - Running setup.py install for mozInstall 09:52:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:52:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:52:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:52:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:52:58 INFO - Running setup.py install for mozleak 09:52:58 INFO - Running setup.py install for mozlog 09:52:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:52:59 INFO - Running setup.py install for moznetwork 09:52:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:52:59 INFO - Running setup.py install for mozprocess 09:52:59 INFO - Running setup.py install for mozprofile 09:52:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:52:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:52:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:52:59 INFO - Running setup.py install for mozrunner 09:52:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:52:59 INFO - Running setup.py install for mozscreenshot 09:52:59 INFO - Running setup.py install for moztest 09:52:59 INFO - Running setup.py install for mozversion 09:52:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:52:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:52:59 INFO - Cleaning up... 09:52:59 INFO - Return code: 0 09:52:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:59 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 0x7f9333987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1c0>, '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 0x10fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', '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:59 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:59 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:59 INFO - Using env: {'DISPLAY': ':0', 09:52:59 INFO - 'HOME': '/home/cltbld', 09:52:59 INFO - 'LANG': 'en_US.UTF-8', 09:52:59 INFO - 'LANGUAGE': 'en_US:en', 09:52:59 INFO - 'LOGNAME': 'cltbld', 09:52:59 INFO - 'MAIL': '/var/mail/cltbld', 09:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:59 INFO - 'MOZ_NO_REMOTE': '1', 09:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:59 INFO - 'NO_EM_RESTART': '1', 09:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:59 INFO - 'PWD': '/builds/slave/test', 09:52:59 INFO - 'SHELL': '/bin/bash', 09:52:59 INFO - 'SHLVL': '1', 09:52:59 INFO - 'TERM': 'linux', 09:52:59 INFO - 'TMOUT': '86400', 09:52:59 INFO - 'USER': 'cltbld', 09:52:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', 09:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:59 INFO - '_': '/tools/buildbot/bin/python'} 09:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:52:59 INFO - Running setup.py (path:/tmp/pip-VUNqhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:53:00 INFO - Running setup.py (path:/tmp/pip-czVD_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:53:00 INFO - Running setup.py (path:/tmp/pip-8Z8C09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:53:00 INFO - Running setup.py (path:/tmp/pip-k8sI11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:53:00 INFO - Running setup.py (path:/tmp/pip-T4t4bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:53:00 INFO - Running setup.py (path:/tmp/pip-bggwRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:53:00 INFO - Running setup.py (path:/tmp/pip-uA1Oin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:53:00 INFO - Running setup.py (path:/tmp/pip-q4n124-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:53:00 INFO - Running setup.py (path:/tmp/pip-8bvnW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:53:00 INFO - Running setup.py (path:/tmp/pip-POmXcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:53:00 INFO - Running setup.py (path:/tmp/pip-Hqs0A3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:53:00 INFO - Running setup.py (path:/tmp/pip-6CKIai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:53:00 INFO - Running setup.py (path:/tmp/pip-gVGqqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:53:00 INFO - Running setup.py (path:/tmp/pip-5GknHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:53:01 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:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:01 INFO - Running setup.py (path:/tmp/pip-aSawuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:01 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:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:53:01 INFO - Running setup.py (path:/tmp/pip-N9NjMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:53:01 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:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:53:01 INFO - Running setup.py (path:/tmp/pip-IuLOIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:53:01 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:53:01 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:53:01 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:53:01 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:53:01 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:53:01 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:53:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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 blessings-1.6.tar.gz 09:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:53:03 INFO - Installing collected packages: blessings 09:53:03 INFO - Running setup.py install for blessings 09:53:03 INFO - Successfully installed blessings 09:53:03 INFO - Cleaning up... 09:53:03 INFO - Return code: 0 09:53:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:53:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:03 INFO - Reading from file tmpfile_stdout 09:53:03 INFO - Current package versions: 09:53:03 INFO - argparse == 1.2.1 09:53:03 INFO - blessings == 1.6 09:53:03 INFO - blobuploader == 1.2.4 09:53:03 INFO - docopt == 0.6.1 09:53:03 INFO - functools32 == 3.2.3-2 09:53:03 INFO - jsonschema == 2.5.1 09:53:03 INFO - manifestparser == 1.1 09:53:03 INFO - mozInstall == 1.12 09:53:03 INFO - mozcrash == 0.17 09:53:03 INFO - mozdebug == 0.1 09:53:03 INFO - mozdevice == 0.48 09:53:03 INFO - mozfile == 1.2 09:53:03 INFO - mozhttpd == 0.7 09:53:03 INFO - mozinfo == 0.9 09:53:03 INFO - mozleak == 0.1 09:53:03 INFO - mozlog == 3.2 09:53:03 INFO - moznetwork == 0.27 09:53:03 INFO - mozprocess == 0.22 09:53:03 INFO - mozprofile == 0.28 09:53:03 INFO - mozrunner == 6.11 09:53:03 INFO - mozscreenshot == 0.1 09:53:03 INFO - mozsystemmonitor == 0.3 09:53:03 INFO - moztest == 0.7 09:53:03 INFO - mozversion == 1.4 09:53:03 INFO - psutil == 3.1.1 09:53:03 INFO - requests == 1.2.3 09:53:03 INFO - wsgiref == 0.1.2 09:53:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:03 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 0x7f9333987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1c0>, '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 0x10fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', '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:03 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:03 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:03 INFO - Using env: {'DISPLAY': ':0', 09:53:03 INFO - 'HOME': '/home/cltbld', 09:53:03 INFO - 'LANG': 'en_US.UTF-8', 09:53:03 INFO - 'LANGUAGE': 'en_US:en', 09:53:03 INFO - 'LOGNAME': 'cltbld', 09:53:03 INFO - 'MAIL': '/var/mail/cltbld', 09:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:03 INFO - 'MOZ_NO_REMOTE': '1', 09:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:03 INFO - 'NO_EM_RESTART': '1', 09:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:03 INFO - 'PWD': '/builds/slave/test', 09:53:03 INFO - 'SHELL': '/bin/bash', 09:53:03 INFO - 'SHLVL': '1', 09:53:03 INFO - 'TERM': 'linux', 09:53:03 INFO - 'TMOUT': '86400', 09:53:03 INFO - 'USER': 'cltbld', 09:53:03 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', 09:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:03 INFO - '_': '/tools/buildbot/bin/python'} 09:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:03 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:03 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:03 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:03 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:03 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:03 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:03 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:03 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:03 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:03 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:03 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:03 INFO - Cleaning up... 09:53:03 INFO - Return code: 0 09:53:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9333987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1c0>, '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 0x10fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', '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:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:53:03 INFO - Using env: {'DISPLAY': ':0', 09:53:03 INFO - 'HOME': '/home/cltbld', 09:53:03 INFO - 'LANG': 'en_US.UTF-8', 09:53:03 INFO - 'LANGUAGE': 'en_US:en', 09:53:03 INFO - 'LOGNAME': 'cltbld', 09:53:03 INFO - 'MAIL': '/var/mail/cltbld', 09:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:03 INFO - 'MOZ_NO_REMOTE': '1', 09:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:03 INFO - 'NO_EM_RESTART': '1', 09:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:03 INFO - 'PWD': '/builds/slave/test', 09:53:03 INFO - 'SHELL': '/bin/bash', 09:53:03 INFO - 'SHLVL': '1', 09:53:03 INFO - 'TERM': 'linux', 09:53:03 INFO - 'TMOUT': '86400', 09:53:03 INFO - 'USER': 'cltbld', 09:53:03 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', 09:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:03 INFO - '_': '/tools/buildbot/bin/python'} 09:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:53:04 INFO - Cleaning up... 09:53:04 INFO - Return code: 0 09:53:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9333987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd1c0>, '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 0x10fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', '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:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:53:04 INFO - Using env: {'DISPLAY': ':0', 09:53:04 INFO - 'HOME': '/home/cltbld', 09:53:04 INFO - 'LANG': 'en_US.UTF-8', 09:53:04 INFO - 'LANGUAGE': 'en_US:en', 09:53:04 INFO - 'LOGNAME': 'cltbld', 09:53:04 INFO - 'MAIL': '/var/mail/cltbld', 09:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:04 INFO - 'MOZ_NO_REMOTE': '1', 09:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:04 INFO - 'NO_EM_RESTART': '1', 09:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:04 INFO - 'PWD': '/builds/slave/test', 09:53:04 INFO - 'SHELL': '/bin/bash', 09:53:04 INFO - 'SHLVL': '1', 09:53:04 INFO - 'TERM': 'linux', 09:53:04 INFO - 'TMOUT': '86400', 09:53:04 INFO - 'USER': 'cltbld', 09:53:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', 09:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:04 INFO - '_': '/tools/buildbot/bin/python'} 09:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:04 INFO - Downloading/unpacking flake8 09:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:53:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:53:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:53:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:53:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:53:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:53:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:53:06 INFO - no previously-included directories found matching 'docs/_build' 09:53:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:53:06 INFO - Running setup.py install for pep8 09:53:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:53:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:53:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:53:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:53:07 INFO - no previously-included directories found matching 'docs/_build' 09:53:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:53:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:53:07 INFO - Cleaning up... 09:53:07 INFO - Return code: 0 09:53:07 INFO - Running post-action listener: _resource_record_post_action 09:53:07 INFO - Running post-action listener: _start_resource_monitoring 09:53:07 INFO - Starting resource monitoring. 09:53:07 INFO - ##### 09:53:07 INFO - ##### Finished create-virtualenv step (success) 09:53:07 INFO - ##### 09:53:07 INFO - ##### 09:53:07 INFO - ##### Running install step. 09:53:07 INFO - ##### 09:53:07 INFO - Running pre-action listener: _resource_record_pre_action 09:53:07 INFO - Running main action method: install 09:53:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:07 INFO - Reading from file tmpfile_stdout 09:53:07 INFO - Detecting whether we're running mozinstall >=1.0... 09:53:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:53:07 INFO - Reading from file tmpfile_stdout 09:53:07 INFO - Output received: 09:53:07 INFO - Usage: mozinstall [options] installer 09:53:07 INFO - Options: 09:53:07 INFO - -h, --help show this help message and exit 09:53:07 INFO - -d DEST, --destination=DEST 09:53:07 INFO - Directory to install application into. [default: 09:53:07 INFO - "/builds/slave/test"] 09:53:07 INFO - --app=APP Application being installed. [default: firefox] 09:53:07 INFO - mkdir: /builds/slave/test/build/application 09:53:07 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:07 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:23 INFO - Reading from file tmpfile_stdout 09:53:23 INFO - Output received: 09:53:23 INFO - /builds/slave/test/build/application/firefox/firefox 09:53:23 INFO - Running post-action listener: _resource_record_post_action 09:53:23 INFO - ##### 09:53:23 INFO - ##### Finished install step (success) 09:53:23 INFO - ##### 09:53:23 INFO - ##### 09:53:23 INFO - ##### Running run-tests step. 09:53:23 INFO - ##### 09:53:23 INFO - Running pre-action listener: _resource_record_pre_action 09:53:23 INFO - Running main action method: run_tests 09:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:53:23 INFO - Python 2.7.3 09:53:23 INFO - Return code: 0 09:53:23 INFO - grabbing minidump binary from tooltool 09:53:23 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:23 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 0x10fd1c0>, '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 0x10fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:53:23 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:23 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:23 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:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:53:23 INFO - Return code: 0 09:53:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:53:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:53:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:53:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:53:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:53:24 INFO - Return code: 0 09:53:24 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', '--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-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:53:24 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 --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-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:53:24 INFO - Using env: {'DISPLAY': ':0', 09:53:24 INFO - 'HOME': '/home/cltbld', 09:53:24 INFO - 'LANG': 'en_US.UTF-8', 09:53:24 INFO - 'LANGUAGE': 'en_US:en', 09:53:24 INFO - 'LOGNAME': 'cltbld', 09:53:24 INFO - 'MAIL': '/var/mail/cltbld', 09:53:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:53:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:24 INFO - 'MOZ_NO_REMOTE': '1', 09:53:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:24 INFO - 'NO_EM_RESTART': '1', 09:53:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:24 INFO - 'PWD': '/builds/slave/test', 09:53:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:53:24 INFO - 'SHELL': '/bin/bash', 09:53:24 INFO - 'SHLVL': '1', 09:53:24 INFO - 'TERM': 'linux', 09:53:24 INFO - 'TMOUT': '86400', 09:53:24 INFO - 'USER': 'cltbld', 09:53:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898', 09:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:24 INFO - '_': '/tools/buildbot/bin/python'} 09:53:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--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-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:53:24 INFO - mozversion application_buildid: 20160706071423 09:53:24 INFO - mozversion application_changeset: 6eaa86d11a5c5dad67d5ca343e5d9226ff524517 09:53:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:53:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:53:24 INFO - mozversion application_name: Firefox 09:53:24 INFO - mozversion application_remotingname: firefox-dev 09:53:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:53:24 INFO - mozversion application_vendor: Mozilla 09:53:24 INFO - mozversion application_version: 49.0a2 09:53:24 INFO - mozversion platform_buildid: 20160706071423 09:53:24 INFO - mozversion platform_changeset: 6eaa86d11a5c5dad67d5ca343e5d9226ff524517 09:53:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:53:24 INFO - mozversion platform_version: 49.0a2 09:53:24 INFO - using testdate: 1467824004 09:53:24 INFO - actual date: 1467824004 09:53:24 INFO - starting webserver on 'localhost:35313' 09:53:24 INFO - SUITE-START | Running 2 tests 09:53:24 INFO - TEST-START | dromaeo_css 09:53:24 INFO - operating with platform_type : linux_ 09:53:24 INFO - Initialising browser for dromaeo_css test... 09:53:24 INFO - TEST-INFO | started process 17146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAfJWen/profile http://localhost:35313/getInfo.html) 09:53:28 INFO - PROCESS | 17146 | __metrics Screen width/height:1600/1200 09:53:28 INFO - PROCESS | 17146 | colorDepth:24 09:53:28 INFO - PROCESS | 17146 | Browser inner width/height: 1024/697 09:53:28 INFO - PROCESS | 17146 | __metrics 09:53:29 ERROR - PROCESS | 17146 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:53:29 INFO - TEST-INFO | 17146: 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 17236 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAfJWen/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 | 17236 | RSS: Main: 145354752 09:53:41 INFO - PROCESS | 17236 | 09:54:32 INFO - PROCESS | 17236 | 1467824072550 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:40 INFO - PROCESS | 17236 | Cycle 1(1): loaded http://localhost:35313/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35313/tests/dromaeo/cssquery-ext.html) 09:56:41 INFO - PROCESS | 17236 | RSS: Main: 251412480 09:56:41 INFO - PROCESS | 17236 | 09:59:44 INFO - PROCESS | 17236 | Cycle 1(1): loaded http://localhost:35313/tests/dromaeo/cssquery-ext.html (next: http://localhost:35313/tests/dromaeo/cssquery-jquery.html) 09:59:45 INFO - PROCESS | 17236 | RSS: Main: 223047680 09:59:45 INFO - PROCESS | 17236 | 10:02:46 INFO - PROCESS | 17236 | Cycle 1(1): loaded http://localhost:35313/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35313/tests/dromaeo/cssquery-mootools.html) 10:02:47 INFO - PROCESS | 17236 | RSS: Main: 230539264 10:02:47 INFO - PROCESS | 17236 | 10:05:49 INFO - PROCESS | 17236 | Cycle 1(1): loaded http://localhost:35313/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35313/tests/dromaeo/cssquery-prototype.html) 10:05:50 INFO - PROCESS | 17236 | RSS: Main: 225492992 10:05:50 INFO - PROCESS | 17236 | 10:08:52 INFO - PROCESS | 17236 | Cycle 1(1): loaded http://localhost:35313/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35313/tests/dromaeo/cssquery-yui.html) 10:08:53 INFO - PROCESS | 17236 | RSS: Main: 216539136 10:08:53 INFO - PROCESS | 17236 | 10:11:55 INFO - PROCESS | 17236 | Cycle 1(1): loaded http://localhost:35313/tests/dromaeo/cssquery-yui.html (next: http://localhost:35313/tests/dromaeo/cssquery-dojo.html) 10:11:56 INFO - PROCESS | 17236 | RSS: Main: 251654144 10:11:56 INFO - PROCESS | 17236 | 10:11:56 INFO - PROCESS | 17236 | __start_tp_report 10:11:56 INFO - PROCESS | 17236 | _x_x_mozilla_page_load 10:11:56 INFO - PROCESS | 17236 | _x_x_mozilla_page_load_details 10:11:56 INFO - PROCESS | 17236 | |i|pagename|runs| 10:11:56 INFO - PROCESS | 17236 | |0;dojo.html;3253.4469140246156;3280.1307653471827;3323.11937336606;3348.9162770930707;3355.748318876085;5416.07926652469;5425.0506161421745;5449.5367893729035;5453.509184173424;5462.945370546293;5422.996745602067;5481.588880833943;5486.177073438977;5490.094134467818;5525.889482210353;4890.290907818364;4914.999999999991;4929.260610908356;4959.603231741452;5025.447200807908;4831.782569784368;4904.558589726924;4940.6788558743565;4946.72792996385;5019.573336266421;4951.900961980758;4969.130402179622;4995.175795993657;5067.49325067494;5068.341115654978;4958.454569997298;4994.525520075587;4995.60035197187;4998.10034193845;5077.669951453144;4761;4766.928496072562;4871.074495845778;4888.853334399938;4946.72792996385;5378.838634840961;5421.186821976696;5428;5428.131498960187;5434.619576629638;5856.180134781134;5889.057750759901;5902.026165682657;5906.291245050621;5912.379200183962;5709.400512946122;5722.227499287626;5748.626339287975;5771.365149833515;5821.3596504384905;5507.449255074501;5525.475079867406;5530.6128571000445;5533.363663178706;5539.695316757537;5721.971390143106;5954.642721436641;6000.429959153874;6012.368701286389;6015.969920150459;5638.182463542846;5674.943250567524;5676.574256930747;5742.425757424224;5763.740631671585;5761.85595360111;5762.078067509262;5782.10377391505;5808.796692115756;5822.359540450547;5735.397783232784;5766.94233057664;5787.247657804459;5789.942100579025;5790.218320526675;5766.4233576642;5819.650820950672;5828.067509198592;5880.176775251468;5885.823425297248;4512.142692888341;4537.977310113428;4540.250858608359;4540.750258735735;4567.543245675406;4013.3578627419474;4018.8593399230886;4068.247374235776;4082;4092.3452247640234;5608.298962629671;5655.688937108416;5672.234248376499;5674.177244299553;5703.74333155009;5896;5903.468687818117;5924.111383292455;5947.732352044169;5967.731452084667;5454.127339625641;5460.972695136578;5544.695041772741;5609;5648.350439699405;5005.974970125126;5007.37407824022;5012.172991456442;5012.874678133003;5033.471485494044;6047.758089676364;6057.00059490188;6110.205673262448;6118.847028824226;6120.7452472243085;5719.027765279996;5860.912086318624;5886.146508756292;5930.673812940157;5931.110333450017;6206.627602343874;6235.220597425322;6238.6605023116335;6264.34224406449;6265.812025639056;5708.743106560298;5791.189233507396;5827.24245848037;5842.591018628656;5850.180974663635;5702;5754.597178197486;5805.448482394166;5840.591158619026;5908.025175846109;5677.403872593318;5743.42565743439;5748.6838223898085;5762.481376676119;5762.683052432157;5611.943880561143;5666.291713535808;5683.516901063456;5685.260916080883;5700.372958974426;5546.084895992116;5567.248421463212;5595.63628364155;5635.6618602883955;5643.971780141073;5808.30300363959;5823.82528524145;5849.678267695147;5860.706964651836;5862.296524417097;5438.048341540136;5538.584606154635;5668.461496157858;5687.919295334039;5700.059490184073 10:11:56 INFO - PROCESS | 17236 | |1;ext.html;575.1774961804617;633.2685747961103;642.2293248102278;653.6502970910562;656.6388486332515;32200.677993220062;35619.465708014366;45545.54454455454;46025.539744602625;46146.307805382945;48950;49492.50507494924;49506.50493495064;49540.75229623847;49972.75013624927;8980.506072166028;9129.817403651923;9143.817123657524;9144.908550914506;9146.31402644801;8174.100848906615;10528;10692.946535267312;10767.569297228141;11033.889661103407;11014;11022.559097636085;11027.22809403342;11038.11695064393;11058.944705276463;8298.792530186733;8489.066202717697;10369.585216591366;10456.738581535485;10500.474976251156;10322.948385258102;10671.519781609846;10681.305715128492;10985.670429887115;11005.394703291317;45566.31650525245;45739.77130114328;46056.53943460556;46057.07885842265;46099.30851037237;3665.102049997741;3848.9223017555128;3877.689784817208;3954.525456945185;4360.040791025969;33796.15509612255;34319;34401.332355215236;34703.132421689406;35142.82428587841;4510.706804057726;4683.672142949995;4695.272232803921;4699.647526435531;4771.594414474774;388510;394503;394720;394800;395172;37402.251954960746;38567.80716096402;64680;65581.34418655753;65740.67129664321;40525.79737101296;40582;40598.79700601478;40828;40835.38746918739;16043.679126417639;16182.595435114215;16238.431654892021;16251.756223656655;16255.105969171573;12180.695482613006;13000.544980925622;13042.804357934638;13159.342032898508;13368.799468007988;9258.583363748647;9262.768430789285;9274.397164184307;9290.72127836166;9366;3469.340825243196;3473.1317170707325;3524.7180225582406;3545.9290814183573;3595.388783906742;1083.5394957143183;1139.7093741096132;1172.783035138485;1240.1752834365227;1241.1746188784357;34503.65496345054;34650;35194.29611407757;36082;36330.818345908105;1170.3369541560405;1190.5594929875829;1238.746057058301;1257.1765493601706;1300.6033159886135;17537.386191483238;17821.7326740099;17946.19242134107;18085.276588936296;18123.818761812214;596853;602210;607513;608032;608421;63303.36696633067;63674;63785;63787.36212637814;63868.36131638717;1373.086897213342;1437.4322142753763;1454.8690617844445;1456.7450696128135;1506.164078936201;33640.831795840866;35147.472787908715;35315.64684353226;35403.645963541065;35436.11409714778;54271;54462.18306725323;54930.45069549253;55001.72499137479;55175;466589;467799;472084;472238;472733;26493.33766655772;49875;50336;50820.49179508157;55869.720651396485;49976.75011624918;50363.24455133102;51553;55600.72199638976;56246;44091.59484368288;45122.77438612786;45655.543444565126;46539.30191047069;47249.527504724516;44466.77766611146;45120;45208;46076;46926.29610555776;45674.31488527741;46027.53972460367;46503.53496465128;47192.7640361796;47290.52709472861;38951.41572876466;40233.195336092525;40400.79799600983;41329.793351033055;41517.79241103775;29916.551251730805;30377.646147308784;30507.389852203276;30627.23431914131;31073.53389699111 10:11:56 INFO - PROCESS | 17236 | |2;jquery.html;390.377348129733;394.5758309816946;402.65371780268975;410.9630133288004;414.9896252593685;13897.791533126985;19308.3242086527;20860.791392086074;20891.373258802243;21022.36932892016;15021.32404041818;19713.211471541155;19846.50383740407;19956;19974.70037949432;5561.610687251884;5683.715814209294;5725.914111288334;5739.426057394269;5743;5633.070543360341;5658.519025882805;5658.7170641467765;5690.516306113986;5730.68481233532;3589.712822974169;3751.3997760358347;5348.3849357323825;6250.593711408744;6274.874502509947;6148.047052706837;6184.56708030438;6319.336469670688;6338.049292606077;6341.619502829822;5528.253685752412;5558.972205138989;5559.416261292547;5565.693886836222;5569.164625306196;22361;22975.655365169536;23341.53316933669;23610;23647.172348967702;2367.112332875172;2403.639454081884;2414.082648593523;2550.5409026375246;2837.7020412856764;13664.863351366459;14493.71012579753;14513.709725805425;14778.482753103697;14926.40294388223;1927.6241132979076;1937.3800383877165;1976.6619344179614;2058.763242227133;2080.573482436097;78967.6051619744;80576.59711701462;81116.59441702813;81245.59377203076;82390.9999999994;10136.594536218616;10239.84640230397;10246.53890574926;10311.123554497952;10498.475076246157;14428.278586070655;14520;14522.056066355864;14525;14551.199684017269;7857.567833769198;7900.881486777588;7903.525788452711;7941.324987376138;8086.272235498834;7811.882821757678;7915;7993.8401231976195;7997.880031799527;8006.239407256301;5732.484076433141;6702.765403210864;6718.529702920847;6720;6780.32196780318;1719.759233707282;1794.5693033672085;1809.7104463286075;1840.7975122736489;1852.8054554271607;1068.9625863094755;1129.8757136714955;1159.562142942745;1163.7381589142544;1166.067146282987;18012.819871801377;19385.90307048484;19596.020198989994;20427.591448170955;20524.589508209752;1025.6717850287837;1090.231386872253;1096.8957948994832;1102.9779404411868;1148.6841118692425;10496.580136794595;11190.048845848194;11267.267627604344;11286.266392684449;11326.660200193843;394876;395218;398175;488015;507687;99067;104825;106136.46931765447;108003.45998269958;108514;1063.7127975446585;1067.391586795519;1101.5869049106584;1103.4703342395694;1108.772701596171;17595.208215630584;17797.822021779615;17937.103144842968;18163.36428225006;18257.908710456362;41483.58516414918;42459.787701061294;44101.55898441103;44557.10885782331;45013.549864500936;60030.69984650049;60602.09096863462;60624;61807;61978.0703289442;8345.707900223462;8401.747947561584;8446;8596.35527335465;8603.612837422206;10622;10885.836712449161;12652.493900244255;13166.934165329112;13637.113587616774;11544.076473882238;11801.822972655245;12041.759164816829;12159.392030398622;12310.384480776105;12068.215565988183;12101.334426606621;12216.14486985938;12287.569935052588;12549.058820588674;11834.11244156709;11855.466504007512;11962.401879905796;12004.279743215435;12034.097442691658;8268.049174344787;8422.377119574947;8527.445716028438;8618.569071546523;8697.95651021741;8360.205780450848;11632.387554248799;11806.645800625995;12301.384930753606;12398.81401778992 10:11:56 INFO - PROCESS | 17236 | |3;mootools.html;1428.2787192467802;1553.5882991007386;1604.3662753212482;1812.7462155298251;1947.8799690178141;8554.615042323096;8893.333000024999;8929.508877011769;9199.034101419338;9247.167754902057;8928.687495937644;9111.179993800557;9130.863037054449;9137.360384773068;9145.588448519817;2152.9138834446603;2337.801286890616;2356.6582845487437;2387.0451819272257;2433.7809597136256;2462.384403899025;2467.925962221136;2469.4320306329555;2472.5673007223663;2473.4311108445067;2371.5968285391523;2385.6302273147603;2390.95218095638;2394.8802559872024;2397.2089210560475;2094.9581008379823;2258.7515373308925;2302.435903203709;2303.8041766449874;2326.720793504782;2338.3452633262714;2342.051469154995;2359.8820058997153;2363.078399424226;2363.3737059679197;9267.675631352939;9355.859662105075;9363;9378.343515953886;9392.62429502819;5383.730813459311;5544.750486228089;5574.498295153415;5575.135853942646;5577.386487486373;3345.498175273704;3354.111160542458;3379.4086034943784;3391.576052993376;3540.7521473496868;1127.1827924754568;1173.2139466557342;1177.9293242405483;1199.4842217846322;1204.5061524774887;13043.217406955613;13072.08495405322;13073.934630326787;13076.411561479756;13102.934485327607;4819.662623616313;4882.365292512021;4946.678465899705;4955.702657840541;4971.552560269593;11077.335359878432;11171;11207.60773372928;11217.270877392943;11218.214724969337;5424.105022671294;5500.697461639648;5504.0643090674685;5509.146082357241;5510.752016159283;4458.799354029076;4898.657094003385;5004.9499505005215;5013.473585273567;5074.16276314404;4177.394277829698;4177.684029530688;4244.617984381421;4272.081502476983;4279.5934386233885;1273.0961017677369;1277.2783377391745;1280.2766436963086;1282.9166104203198;1295.935203239853;925.3291363761219;953.3993584042009;972.1202311907734;984.3700031979539;1006.3408467453829;6142.262928448615;6247.781327653511;6433.260175079832;6450.129232553639;6487.935120648827;455.63321526171086;458.67892475267445;460.06606588625147;460.82718980382356;469.6313393985773;4253.893652658647;4307.633851122627;4421.690481666253;4486.730796152241;4488.708233964782;11075.50160242791;11401.657950261506;11404.429778511041;11462.426878656033;11482.655520334403;11030.172737044593;11206.719832004264;11328.773424531464;11334.376609286404;11337.489812958436;8450.323974082059;8711.693246013276;8724.345674074342;8770.210681038738;8772.649094036295;6326.9683651581445;6421.775237866652;6513.990331498625;6518.478521718346;6527.608343499405;10632.787344253225;10639.89360106389;10754.085902698358;10834.295770774874;10958.28771129874;10949.124070074535;11027.393493357622;11050.502727377127;11135.164862635173;11146.275492092987;7388.1503627083575;7388.519746216479;7678.692852285846;8364.665413383396;8460.788480288042;8761.956190219264;9175.357724959189;9204.217641500547;9208.447493150432;9234.907650923406;7820.726274580363;7935;8019.719309824128;8029.799255018671;8035.196480351918;7751.147373788766;7843.450958432855;7877.6455059523605;7895.234399100618;8036.678532858854;7293.744718934812;7358;7366.926330736838;7377.1885092638695;7418.96290518544;5427.158790387496;5526.088195447706;5545.805896793754;5575.358833734011;5635.577331700057;5585.609007369445;5610.214569960127;5642.88714225705;5699.173619825185;5829.183914251923 10:11:56 INFO - PROCESS | 17236 | |4;prototype.html;333.5606856414571;338.4297458781952;348.93195826813775;351.20276971275223;351.32019542185856;5285.225256740208;5389.137737961927;5394.568434525238;5421.593380496469;5426.864328391792;5034.295198672189;5167.250748641445;5171.250168725542;5194.818181363653;5314.681119132845;4039.5354534228645;4091.3249313863253;4113.239050775616;4193.790310484464;4200.222958752625;4085.897852553695;4137.441445404862;4140.337545992642;4140.937885931713;4147.253494371012;4075.9592404075875;4103.384492326145;4135.751854888701;4156.750594964312;4161.148289011391;4083.203775263825;4091.4067460218102;4116.526599441057;4132.214879172948;4132.2561938850995;3685.9262814743556;3705.2959937611768;3712.461693054492;3719.800971164796;3726.4037753959506;5041.319421878036;5050.520200580939;5155.226715992593;5166.586673066184;5178.275041494194;4739.668223224376;4769.833055843029;4782.497837727058;4790.736509491977;4796.808127674889;5488.765027868738;5532.585056120807;5542.750576224039;5546.389897111315;5593.021221286259;3800.8669696560487;4080.4491393661774;4091.079507110906;4099.344104943195;4103.763448920346;5754.136879468071;5755.654660720328;5769.249997500298;5771.682557459338;5786.942130578683;4057.8376864925663;4066;4071.91856162881;4076.2051399977313;4082.4488694025927;4096.344584866467;4128.401381799622;4137.834486620562;4142.896427589334;4149.356849688304;4500.594946454835;4706.3411122442885;4707.905841883212;4730.574248317668;4757.476677565465;5592.804251851166;5621.90795062722;5661.160122960055;5670.773169073191;5677.233573467529;1353.1204716934071;1388.7430825297151;1416.4192681000945;1432.584550480349;1439.5825210688783;892.8258989496986;896.2561074308309;916.6470908700198;917.6512925088424;920.5581320965974;4866.6106711463;4874.82938097172;4916.237983112552;4926.581240594518;4930.235813448921;5125.513076257749;5153.4073581538605;5153.845384638467;5166.43169251382;5204.297419848348;4621.976890115528;4910.729909854992;4957.3555437793575;4968.90062198754;4974.5873251473;2698.311930457721;2708.3770732731186;2730.1809457163167;2734.8632568371504;2748.35098940634;5295.6169723624525;5311.946880531145;5364.7049412282695;5383.67697938125;5401.594880383908;4969.378827646544;4970.22036926745;5160.638755287094;5201.843944681666;5205.085152314716;5304.045271851027;5319.601029922771;5355.892882142335;5372.677639341652;5438.401775804658;5091.210862316347;5092.923606145985;5105.897882042264;5182.714950677598;5188.636795424284;5033.47148549397;5077.6290401592105;5319.228711836685;5759.539236860957;5760.020796464527;6102.908456373247;6111.083337499411;6118.5411094169;6118.674903536627;6124.724387402666;4076.8381011411607;4111.835526579023;4115.382692596135;4119.691023173334;4119.8352065918225;5593.972030139823;5806;5821.185034095145;5866.384029676993;5872.500837428695;5568.77724891016;5635.83092507209;5689.630174038674;5691.288588926384;5709.314882214161;5613.831585052455;5637.49262566371;5644.8024319148635;5665.518430933417;5667.234923285304;5388.515033646834;5431.4840090191365;5534.7509362078;5544.758259931075;5569.136783798518;5656.925184214986;5658.490735833795;5707.486326230659;5711.685857277889;5722.227499287709;5402.811381496064;5546.084895992116;5559.916601251065;5599.188117722826;5617.6236821977245 10:11:56 INFO - PROCESS | 17236 | |5;yui.html;825.7068740597088;825.8843761873338;869.2698133567802;872.6858331000841;922.7163265407039;14141.15153090814;15089.773653395208;15105.697886042273;15308.770368444482;16003.199840007983;16856.24146913389;16904;17065.14674266288;17093;17146.399876004343;720.8702433561957;850.8808766772656;865.2947847504296;872.4808738800403;873.9388242823005;876.198278575103;879.6261588824756;881.2421317666801;882.1443200095897;882.5895958379352;928.1646518133666;929.0384452092052;932.580338847518;933.7385532051003;933.8319102561536;744.9962750186241;891.8706787515839;918.728974952384;925.773185569533;926.3654396738223;679.6194131286446;680.6392611915693;680.7549282258383;681.7204945972128;682.2154522299346;15457.304421301069;15530.61173470661;15530.611734706723;15544.61138471536;15571.688566228611;14212.928935355361;14521.20133392663;14531.854681453156;14547.418103275962;14623.268836558236;14008.719825603534;14041.719165616732;14076;14199.148051116863;14476.927615361856;4686.742229177394;4707.952920470786;4736.478987311393;4835.371401717789;4852.393450818648;66437;68475.65762171257;78090.6095469519;78630;78962;11976.221545599508;12054.216475929037;12110.878891211152;12405.069619778373;12517.749645007048;22457.213997510007;22828.771712282996;22852.65721014186;22878;22897.771022289562;9121.179093881583;9124.270058395312;9166.94580123281;9295.953520232355;9646.324757266924;4919.1539494506205;4946.282788995647;5072.746362681851;5142.460041695568;5273.288106105627;3651.8904432867057;3757.7181711371754;3762.191128907243;3763.34141525232;3767.020574650611;570.6319423971515;617.4350469320522;627.0938493876396;645.8320836582523;646.4795839349368;718.7664009197032;791.6330172783337;808.2604416958535;819.5287709567023;830.0869044051495;10400.323978941344;10442.68671939843;10615.787684246272;10635.202359823044;10767.676969690921;714.8856183010694;767.5202998126172;787.1498781316164;814.4909431605247;845.2899564365962;4652.371929789435;4901;4906.215005599087;4927.286074241553;4954.405471343462;75245;85773;108812;109100.90899091067;130483.34758326148;65507.67246163739;95585.5220723892;96168;109262;109928;72727.27272727205;75718;77052.22947770562;78007.21992780112;79329.20670793334;9938.453385063602;10206.183505319705;10330;10363.63727269542;10516.631917882838;39981;49718;50751.746241268556;50975.23537146871;53674;78365.60817195878;78722;79290;79653.60173199097;82672.58663706883;11698.94150529242;12131.636050918487;12203;12869.420876060412;13190.868091319348;14452.566423007327;14778.926105369404;14990.925045374703;15060.698786024437;15095.4716584919;13784.862151378358;13807.654808629864;13896;14159.787603186167;14319.642008949859;13463.663408414868;13589.456421743414;14389.136651800925;14389.712205756035;14616.488422905148;12245.265284082983;12490.063245256824;12691.365431728562;14438.061526000776;14589.124652520883;11631.709207269885;11660.591879284184;11791.705207369541;11866.347350895783;12218.755624887275;11596.884031159918;11604.883951160718;12059.879401205875;12109.320392227095;12123.636290911287 10:11:56 INFO - PROCESS | 17236 | __end_tp_report 10:11:56 INFO - PROCESS | 17236 | __start_cc_report 10:11:56 INFO - PROCESS | 17236 | _x_x_mozilla_cycle_collect,821 10:11:56 INFO - PROCESS | 17236 | __end_cc_report 10:11:56 INFO - PROCESS | 17236 | __startTimestamp1467825116227__endTimestamp 10:11:56 INFO - PROCESS | 17236 | 10:11:56 INFO - PROCESS | 17236 | ------- Summary: start ------- 10:11:56 INFO - PROCESS | 17236 | Number of tests: 6 10:11:56 INFO - PROCESS | 17236 | 10:11:56 INFO - PROCESS | 17236 | [#0] dojo.html Cycles:165 Average:5442.49 Median:5668.46 stddev:603.20 (10.6%) stddev-sans-first:580.09 10:11:56 INFO - PROCESS | 17236 | Values: 3253.4 3280.1 3323.1 3348.9 3355.7 5416.1 5425.1 5449.5 5453.5 5462.9 5423.0 5481.6 5486.2 5490.1 5525.9 4890.3 4915.0 4929.3 4959.6 5025.4 4831.8 4904.6 4940.7 4946.7 5019.6 4951.9 4969.1 4995.2 5067.5 5068.3 4958.5 4994.5 4995.6 4998.1 5077.7 4761.0 4766.9 4871.1 4888.9 4946.7 5378.8 5421.2 5428.0 5428.1 5434.6 5856.2 5889.1 5902.0 5906.3 5912.4 5709.4 5722.2 5748.6 5771.4 5821.4 5507.4 5525.5 5530.6 5533.4 5539.7 5722.0 5954.6 6000.4 6012.4 6016.0 5638.2 5674.9 5676.6 5742.4 5763.7 5761.9 5762.1 5782.1 5808.8 5822.4 5735.4 5766.9 5787.2 5789.9 5790.2 5766.4 5819.7 5828.1 5880.2 5885.8 4512.1 4538.0 4540.3 4540.8 4567.5 4013.4 4018.9 4068.2 4082.0 4092.3 5608.3 5655.7 5672.2 5674.2 5703.7 5896.0 5903.5 5924.1 5947.7 5967.7 5454.1 5461.0 5544.7 5609.0 5648.4 5006.0 5007.4 5012.2 5012.9 5033.5 6047.8 6057.0 6110.2 6118.8 6120.7 5719.0 5860.9 5886.1 5930.7 5931.1 6206.6 6235.2 6238.7 6264.3 6265.8 5708.7 5791.2 5827.2 5842.6 5850.2 5702.0 5754.6 5805.4 5840.6 5908.0 5677.4 5743.4 5748.7 5762.5 5762.7 5611.9 5666.3 5683.5 5685.3 5700.4 5546.1 5567.2 5595.6 5635.7 5644.0 5808.3 5823.8 5849.7 5860.7 5862.3 5438.0 5538.6 5668.5 5687.9 5700.1 10:11:56 INFO - PROCESS | 17236 | 10:11:56 INFO - PROCESS | 17236 | [#1] ext.html Cycles:180 Average:65422.51 Median:40590.40 stddev:132100.53 (325.4%) stddev-sans-first:132381.38 10:11:56 INFO - PROCESS | 17236 | Values: 575.2 633.3 642.2 653.7 656.6 32200.7 35619.5 45545.5 46025.5 46146.3 48950.0 49492.5 49506.5 49540.8 49972.8 8980.5 9129.8 9143.8 9144.9 9146.3 8174.1 10528.0 10692.9 10767.6 11033.9 11014.0 11022.6 11027.2 11038.1 11058.9 8298.8 8489.1 10369.6 10456.7 10500.5 10322.9 10671.5 10681.3 10985.7 11005.4 45566.3 45739.8 46056.5 46057.1 46099.3 3665.1 3848.9 3877.7 3954.5 4360.0 33796.2 34319.0 34401.3 34703.1 35142.8 4510.7 4683.7 4695.3 4699.6 4771.6 388510.0 394503.0 394720.0 394800.0 395172.0 37402.3 38567.8 64680.0 65581.3 65740.7 40525.8 40582.0 40598.8 40828.0 40835.4 16043.7 16182.6 16238.4 16251.8 16255.1 12180.7 13000.5 13042.8 13159.3 13368.8 9258.6 9262.8 9274.4 9290.7 9366.0 3469.3 3473.1 3524.7 3545.9 3595.4 1083.5 1139.7 1172.8 1240.2 1241.2 34503.7 34650.0 35194.3 36082.0 36330.8 1170.3 1190.6 1238.7 1257.2 1300.6 17537.4 17821.7 17946.2 18085.3 18123.8 596853.0 602210.0 607513.0 608032.0 608421.0 63303.4 63674.0 63785.0 63787.4 63868.4 1373.1 1437.4 1454.9 1456.7 1506.2 33640.8 35147.5 35315.6 35403.6 35436.1 54271.0 54462.2 54930.5 55001.7 55175.0 466589.0 467799.0 472084.0 472238.0 472733.0 26493.3 49875.0 50336.0 50820.5 55869.7 49976.8 50363.2 51553.0 55600.7 56246.0 44091.6 45122.8 45655.5 46539.3 47249.5 44466.8 45120.0 45208.0 46076.0 46926.3 45674.3 46027.5 46503.5 47192.8 47290.5 38951.4 40233.2 40400.8 41329.8 41517.8 29916.6 30377.6 30507.4 30627.2 31073.5 10:11:56 INFO - PROCESS | 17236 | 10:11:56 INFO - PROCESS | 17236 | [#2] jquery.html Cycles:180 Average:28167.15 Median:20876.08 stddev:73205.09 (350.7%) stddev-sans-first:73380.74 10:11:56 INFO - PROCESS | 17236 | Values: 390.4 394.6 402.7 411.0 415.0 13897.8 19308.3 20860.8 20891.4 21022.4 15021.3 19713.2 19846.5 19956.0 19974.7 5561.6 5683.7 5725.9 5739.4 5743.0 5633.1 5658.5 5658.7 5690.5 5730.7 3589.7 3751.4 5348.4 6250.6 6274.9 6148.0 6184.6 6319.3 6338.0 6341.6 5528.3 5559.0 5559.4 5565.7 5569.2 22361.0 22975.7 23341.5 23610.0 23647.2 2367.1 2403.6 2414.1 2550.5 2837.7 13664.9 14493.7 14513.7 14778.5 14926.4 1927.6 1937.4 1976.7 2058.8 2080.6 78967.6 80576.6 81116.6 81245.6 82391.0 10136.6 10239.8 10246.5 10311.1 10498.5 14428.3 14520.0 14522.1 14525.0 14551.2 7857.6 7900.9 7903.5 7941.3 8086.3 7811.9 7915.0 7993.8 7997.9 8006.2 5732.5 6702.8 6718.5 6720.0 6780.3 1719.8 1794.6 1809.7 1840.8 1852.8 1069.0 1129.9 1159.6 1163.7 1166.1 18012.8 19385.9 19596.0 20427.6 20524.6 1025.7 1090.2 1096.9 1103.0 1148.7 10496.6 11190.0 11267.3 11286.3 11326.7 394876.0 395218.0 398175.0 488015.0 507687.0 99067.0 104825.0 106136.5 108003.5 108514.0 1063.7 1067.4 1101.6 1103.5 1108.8 17595.2 17797.8 17937.1 18163.4 18257.9 41483.6 42459.8 44101.6 44557.1 45013.5 60030.7 60602.1 60624.0 61807.0 61978.1 8345.7 8401.7 8446.0 8596.4 8603.6 10622.0 10885.8 12652.5 13166.9 13637.1 11544.1 11801.8 12041.8 12159.4 12310.4 12068.2 12101.3 12216.1 12287.6 12549.1 11834.1 11855.5 11962.4 12004.3 12034.1 8268.0 8422.4 8527.4 8618.6 8698.0 8360.2 11632.4 11806.6 12301.4 12398.8 10:11:56 INFO - PROCESS | 17236 | 10:11:56 INFO - PROCESS | 17236 | [#3] mootools.html Cycles:180 Average:6089.07 Median:465.23 stddev:3519.90 (756.6%) stddev-sans-first:3512.34 10:11:56 INFO - PROCESS | 17236 | Values: 1428.3 1553.6 1604.4 1812.7 1947.9 8554.6 8893.3 8929.5 9199.0 9247.2 8928.7 9111.2 9130.9 9137.4 9145.6 2152.9 2337.8 2356.7 2387.0 2433.8 2462.4 2467.9 2469.4 2472.6 2473.4 2371.6 2385.6 2391.0 2394.9 2397.2 2095.0 2258.8 2302.4 2303.8 2326.7 2338.3 2342.1 2359.9 2363.1 2363.4 9267.7 9355.9 9363.0 9378.3 9392.6 5383.7 5544.8 5574.5 5575.1 5577.4 3345.5 3354.1 3379.4 3391.6 3540.8 1127.2 1173.2 1177.9 1199.5 1204.5 13043.2 13072.1 13073.9 13076.4 13102.9 4819.7 4882.4 4946.7 4955.7 4971.6 11077.3 11171.0 11207.6 11217.3 11218.2 5424.1 5500.7 5504.1 5509.1 5510.8 4458.8 4898.7 5004.9 5013.5 5074.2 4177.4 4177.7 4244.6 4272.1 4279.6 1273.1 1277.3 1280.3 1282.9 1295.9 925.3 953.4 972.1 984.4 1006.3 6142.3 6247.8 6433.3 6450.1 6487.9 455.6 458.7 460.1 460.8 469.6 4253.9 4307.6 4421.7 4486.7 4488.7 11075.5 11401.7 11404.4 11462.4 11482.7 11030.2 11206.7 11328.8 11334.4 11337.5 8450.3 8711.7 8724.3 8770.2 8772.6 6327.0 6421.8 6514.0 6518.5 6527.6 10632.8 10639.9 10754.1 10834.3 10958.3 10949.1 11027.4 11050.5 11135.2 11146.3 7388.2 7388.5 7678.7 8364.7 8460.8 8762.0 9175.4 9204.2 9208.4 9234.9 7820.7 7935.0 8019.7 8029.8 8035.2 7751.1 7843.5 7877.6 7895.2 8036.7 7293.7 7358.0 7366.9 7377.2 7419.0 5427.2 5526.1 5545.8 5575.4 5635.6 5585.6 5610.2 5642.9 5699.2 5829.2 10:11:56 INFO - PROCESS | 17236 | 10:11:56 INFO - PROCESS | 17236 | [#4] prototype.html Cycles:180 Average:4590.24 Median:5139.46 stddev:1343.43 (26.1%) stddev-sans-first:1308.66 10:11:56 INFO - PROCESS | 17236 | Values: 333.6 338.4 348.9 351.2 351.3 5285.2 5389.1 5394.6 5421.6 5426.9 5034.3 5167.3 5171.3 5194.8 5314.7 4039.5 4091.3 4113.2 4193.8 4200.2 4085.9 4137.4 4140.3 4140.9 4147.3 4076.0 4103.4 4135.8 4156.8 4161.1 4083.2 4091.4 4116.5 4132.2 4132.3 3685.9 3705.3 3712.5 3719.8 3726.4 5041.3 5050.5 5155.2 5166.6 5178.3 4739.7 4769.8 4782.5 4790.7 4796.8 5488.8 5532.6 5542.8 5546.4 5593.0 3800.9 4080.4 4091.1 4099.3 4103.8 5754.1 5755.7 5769.2 5771.7 5786.9 4057.8 4066.0 4071.9 4076.2 4082.4 4096.3 4128.4 4137.8 4142.9 4149.4 4500.6 4706.3 4707.9 4730.6 4757.5 5592.8 5621.9 5661.2 5670.8 5677.2 1353.1 1388.7 1416.4 1432.6 1439.6 892.8 896.3 916.6 917.7 920.6 4866.6 4874.8 4916.2 4926.6 4930.2 5125.5 5153.4 5153.8 5166.4 5204.3 4622.0 4910.7 4957.4 4968.9 4974.6 2698.3 2708.4 2730.2 2734.9 2748.4 5295.6 5311.9 5364.7 5383.7 5401.6 4969.4 4970.2 5160.6 5201.8 5205.1 5304.0 5319.6 5355.9 5372.7 5438.4 5091.2 5092.9 5105.9 5182.7 5188.6 5033.5 5077.6 5319.2 5759.5 5760.0 6102.9 6111.1 6118.5 6118.7 6124.7 4076.8 4111.8 4115.4 4119.7 4119.8 5594.0 5806.0 5821.2 5866.4 5872.5 5568.8 5635.8 5689.6 5691.3 5709.3 5613.8 5637.5 5644.8 5665.5 5667.2 5388.5 5431.5 5534.8 5544.8 5569.1 5656.9 5658.5 5707.5 5711.7 5722.2 5402.8 5546.1 5559.9 5599.2 5617.6 10:11:56 INFO - PROCESS | 17236 | 10:11:56 INFO - PROCESS | 17236 | [#5] yui.html Cycles:180 Average:20449.08 Median:4669.56 stddev:28306.20 (606.2%) stddev-sans-first:28347.26 10:11:56 INFO - PROCESS | 17236 | Values: 825.7 825.9 869.3 872.7 922.7 14141.2 15089.8 15105.7 15308.8 16003.2 16856.2 16904.0 17065.1 17093.0 17146.4 720.9 850.9 865.3 872.5 873.9 876.2 879.6 881.2 882.1 882.6 928.2 929.0 932.6 933.7 933.8 745.0 891.9 918.7 925.8 926.4 679.6 680.6 680.8 681.7 682.2 15457.3 15530.6 15530.6 15544.6 15571.7 14212.9 14521.2 14531.9 14547.4 14623.3 14008.7 14041.7 14076.0 14199.1 14476.9 4686.7 4708.0 4736.5 4835.4 4852.4 66437.0 68475.7 78090.6 78630.0 78962.0 11976.2 12054.2 12110.9 12405.1 12517.7 22457.2 22828.8 22852.7 22878.0 22897.8 9121.2 9124.3 9166.9 9296.0 9646.3 4919.2 4946.3 5072.7 5142.5 5273.3 3651.9 3757.7 3762.2 3763.3 3767.0 570.6 617.4 627.1 645.8 646.5 718.8 791.6 808.3 819.5 830.1 10400.3 10442.7 10615.8 10635.2 10767.7 714.9 767.5 787.1 814.5 845.3 4652.4 4901.0 4906.2 4927.3 4954.4 75245.0 85773.0 108812.0 109100.9 130483.3 65507.7 95585.5 96168.0 109262.0 109928.0 72727.3 75718.0 77052.2 78007.2 79329.2 9938.5 10206.2 10330.0 10363.6 10516.6 39981.0 49718.0 50751.7 50975.2 53674.0 78365.6 78722.0 79290.0 79653.6 82672.6 11698.9 12131.6 12203.0 12869.4 13190.9 14452.6 14778.9 14990.9 15060.7 15095.5 13784.9 13807.7 13896.0 14159.8 14319.6 13463.7 13589.5 14389.1 14389.7 14616.5 12245.3 12490.1 12691.4 14438.1 14589.1 11631.7 11660.6 11791.7 11866.3 12218.8 11596.9 11604.9 12059.9 12109.3 12123.6 10:11:56 INFO - PROCESS | 17236 | -------- Summary: end -------- 10:11:56 INFO - PROCESS | 17236 | 10:11:56 INFO - TEST-INFO | 17236: exit 0 10:11:56 INFO - TEST-OK | dromaeo_css | took 1112409ms 10:11:56 INFO - TEST-START | kraken 10:11:56 INFO - operating with platform_type : linux_ 10:11:56 INFO - Initialising browser for kraken test... 10:11:56 INFO - TEST-INFO | started process 17420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpULMCjR/profile http://localhost:35313/getInfo.html) 10:12:00 INFO - PROCESS | 17420 | __metrics Screen width/height:1600/1200 10:12:00 INFO - PROCESS | 17420 | colorDepth:24 10:12:00 INFO - PROCESS | 17420 | Browser inner width/height: 1024/697 10:12:00 INFO - PROCESS | 17420 | __metrics 10:12:01 ERROR - PROCESS | 17420 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:12:02 INFO - TEST-INFO | 17420: exit 0 10:12:02 INFO - Browser initialized. 10:12:02 INFO - Running cycle 1/1 for kraken test... 10:12:02 INFO - TEST-INFO | started process 17510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpULMCjR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:14 INFO - PROCESS | 17510 | RSS: Main: 145494016 10:12:14 INFO - PROCESS | 17510 | 10:12:16 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:35313/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35313/tests/kraken/driver.html?testName=audio-beat-detection) 10:12:17 INFO - PROCESS | 17510 | RSS: Main: 194572288 10:12:17 INFO - PROCESS | 17510 | 10:12:20 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:35313/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35313/tests/kraken/driver.html?testName=audio-dft) 10:12:20 INFO - PROCESS | 17510 | RSS: Main: 188772352 10:12:20 INFO - PROCESS | 17510 | 10:12:23 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:35313/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35313/tests/kraken/driver.html?testName=audio-fft) 10:12:24 INFO - PROCESS | 17510 | RSS: Main: 278962176 10:12:24 INFO - PROCESS | 17510 | 10:12:26 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:35313/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35313/tests/kraken/driver.html?testName=audio-oscillator) 10:12:26 INFO - PROCESS | 17510 | RSS: Main: 187424768 10:12:26 INFO - PROCESS | 17510 | 10:12:28 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:35313/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35313/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:12:29 INFO - PROCESS | 17510 | RSS: Main: 188243968 10:12:29 INFO - PROCESS | 17510 | 10:12:32 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:35313/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35313/tests/kraken/driver.html?testName=imaging-darkroom) 10:12:33 INFO - PROCESS | 17510 | RSS: Main: 222859264 10:12:33 INFO - PROCESS | 17510 | 10:12:36 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:35313/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35313/tests/kraken/driver.html?testName=imaging-desaturate) 10:12:37 INFO - PROCESS | 17510 | RSS: Main: 223469568 10:12:37 INFO - PROCESS | 17510 | 10:12:39 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:35313/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35313/tests/kraken/driver.html?testName=json-parse-financial) 10:12:40 INFO - PROCESS | 17510 | RSS: Main: 224030720 10:12:40 INFO - PROCESS | 17510 | 10:12:41 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:35313/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35313/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:12:42 INFO - PROCESS | 17510 | RSS: Main: 201252864 10:12:42 INFO - PROCESS | 17510 | 10:12:44 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:35313/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35313/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:12:44 INFO - PROCESS | 17510 | RSS: Main: 202530816 10:12:44 INFO - PROCESS | 17510 | 10:12:46 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:35313/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35313/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:12:47 INFO - PROCESS | 17510 | RSS: Main: 208457728 10:12:47 INFO - PROCESS | 17510 | 10:12:50 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:35313/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35313/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:12:50 INFO - PROCESS | 17510 | RSS: Main: 216584192 10:12:50 INFO - PROCESS | 17510 | 10:12:53 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:35313/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35313/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:12:53 INFO - PROCESS | 17510 | RSS: Main: 218787840 10:12:53 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | Cycle 1(1): loaded http://localhost:35313/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35313/tests/kraken/driver.html?testName=ai-astar) 10:12:55 INFO - PROCESS | 17510 | RSS: Main: 261316608 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | __start_tp_report 10:12:55 INFO - PROCESS | 17510 | _x_x_mozilla_page_load 10:12:55 INFO - PROCESS | 17510 | _x_x_mozilla_page_load_details 10:12:55 INFO - PROCESS | 17510 | |i|pagename|runs| 10:12:55 INFO - PROCESS | 17510 | |0;ai-astar;113;105;113;110;111;110;111;110;110;110 10:12:55 INFO - PROCESS | 17510 | |1;audio-beat-detection;163;128;126;176;124;131;158;131;162;134 10:12:55 INFO - PROCESS | 17510 | |2;audio-dft;161;161;162;162;161;160;162;161;162;162 10:12:55 INFO - PROCESS | 17510 | |3;audio-fft;75;76;75;126;76;76;75;75;100;75 10:12:55 INFO - PROCESS | 17510 | |4;audio-oscillator;86;86;119;83;85;86;121;85;85;122 10:12:55 INFO - PROCESS | 17510 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;117;117 10:12:55 INFO - PROCESS | 17510 | |6;imaging-darkroom;146;146;146;147;146;146;146;146;145;147 10:12:55 INFO - PROCESS | 17510 | |7;imaging-desaturate;95;95;95;95;94;95;95;94;95;95 10:12:55 INFO - PROCESS | 17510 | |8;json-parse-financial;50;50;50;53;51;53;54;51;51;50 10:12:55 INFO - PROCESS | 17510 | |9;json-stringify-tinderbox;61;61;63;62;60;60;59;61;61;62 10:12:55 INFO - PROCESS | 17510 | |10;stanford-crypto-aes;78;81;80;76;77;78;76;78;105;76 10:12:55 INFO - PROCESS | 17510 | |11;stanford-crypto-ccm;120;119;116;124;120;122;124;129;142;122 10:12:55 INFO - PROCESS | 17510 | |12;stanford-crypto-pbkdf2;157;158;156;156;157;155;156;155;153;154 10:12:55 INFO - PROCESS | 17510 | |13;stanford-crypto-sha256-iterative;62;66;63;62;61;70;61;60;59;60 10:12:55 INFO - PROCESS | 17510 | __end_tp_report 10:12:55 INFO - PROCESS | 17510 | __start_cc_report 10:12:55 INFO - PROCESS | 17510 | _x_x_mozilla_cycle_collect,1598 10:12:55 INFO - PROCESS | 17510 | __end_cc_report 10:12:55 INFO - PROCESS | 17510 | __startTimestamp1467825175789__endTimestamp 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | ------- Summary: start ------- 10:12:55 INFO - PROCESS | 17510 | Number of tests: 14 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:2.21 (2.0%) stddev-sans-first:2.12 10:12:55 INFO - PROCESS | 17510 | Values: 113.0 105.0 113.0 110.0 111.0 110.0 111.0 110.0 110.0 110.0 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:146.00 stddev:19.20 (13.2%) stddev-sans-first:19.00 10:12:55 INFO - PROCESS | 17510 | Values: 163.0 128.0 126.0 176.0 124.0 131.0 158.0 131.0 162.0 134.0 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 10:12:55 INFO - PROCESS | 17510 | Values: 161.0 161.0 162.0 162.0 161.0 160.0 162.0 161.0 162.0 162.0 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.00 stddev:17.01 (22.7%) stddev-sans-first:17.80 10:12:55 INFO - PROCESS | 17510 | Values: 75.0 76.0 75.0 126.0 76.0 76.0 75.0 75.0 100.0 75.0 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:85.00 stddev:17.20 (20.2%) stddev-sans-first:17.87 10:12:55 INFO - PROCESS | 17510 | Values: 86.0 86.0 119.0 83.0 85.0 86.0 121.0 85.0 85.0 122.0 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:12:55 INFO - PROCESS | 17510 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 10:12:55 INFO - PROCESS | 17510 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 147.0 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:12:55 INFO - PROCESS | 17510 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:1.49 (2.9%) stddev-sans-first:1.51 10:12:55 INFO - PROCESS | 17510 | Values: 50.0 50.0 50.0 53.0 51.0 53.0 54.0 51.0 51.0 50.0 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:1.15 (1.9%) stddev-sans-first:1.22 10:12:55 INFO - PROCESS | 17510 | Values: 61.0 61.0 63.0 62.0 60.0 60.0 59.0 61.0 61.0 62.0 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:78.00 stddev:8.77 (11.2%) stddev-sans-first:9.26 10:12:55 INFO - PROCESS | 17510 | Values: 78.0 81.0 80.0 76.0 77.0 78.0 76.0 78.0 105.0 76.0 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:123.00 stddev:7.28 (5.9%) stddev-sans-first:7.60 10:12:55 INFO - PROCESS | 17510 | Values: 120.0 119.0 116.0 124.0 120.0 122.0 124.0 129.0 142.0 122.0 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:156.00 stddev:1.49 (1.0%) stddev-sans-first:1.51 10:12:55 INFO - PROCESS | 17510 | Values: 157.0 158.0 156.0 156.0 157.0 155.0 156.0 155.0 153.0 154.0 10:12:55 INFO - PROCESS | 17510 | 10:12:55 INFO - PROCESS | 17510 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:3.31 (5.3%) stddev-sans-first:3.50 10:12:55 INFO - PROCESS | 17510 | Values: 62.0 66.0 63.0 62.0 61.0 70.0 61.0 60.0 59.0 60.0 10:12:55 INFO - PROCESS | 17510 | -------- Summary: end -------- 10:12:55 INFO - PROCESS | 17510 | 10:12:56 INFO - TEST-INFO | 17510: exit 0 10:12:56 INFO - TEST-OK | kraken | took 59866ms 10:12:56 INFO - SUITE-END | took 1172s 10:12:56 INFO - Completed test suite (00:19:32) 10:12:56 INFO - javascript benchmark 10:12:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3253.4469140246156, 3280.1307653471827, 3323.11937336606, 3348.9162770930707, 3355.748318876085, 5416.07926652469, 5425.0506161421745, 5449.5367893729035, 5453.509184173424, 5462.945370546293, 5422.996745602067, 5481.588880833943, 5486.177073438977, 5490.094134467818, 5525.889482210353, 4890.290907818364, 4914.999999999991, 4929.260610908356, 4959.603231741452, 5025.447200807908, 4831.782569784368, 4904.558589726924, 4940.6788558743565, 4946.72792996385, 5019.573336266421, 4951.900961980758, 4969.130402179622, 4995.175795993657, 5067.49325067494, 5068.341115654978, 4958.454569997298, 4994.525520075587, 4995.60035197187, 4998.10034193845, 5077.669951453144, 4761.0, 4766.928496072562, 4871.074495845778, 4888.853334399938, 4946.72792996385, 5378.838634840961, 5421.186821976696, 5428.0, 5428.131498960187, 5434.619576629638, 5856.180134781134, 5889.057750759901, 5902.026165682657, 5906.291245050621, 5912.379200183962, 5709.400512946122, 5722.227499287626, 5748.626339287975, 5771.365149833515, 5821.3596504384905, 5507.449255074501, 5525.475079867406, 5530.6128571000445, 5533.363663178706, 5539.695316757537, 5721.971390143106, 5954.642721436641, 6000.429959153874, 6012.368701286389, 6015.969920150459, 5638.182463542846, 5674.943250567524, 5676.574256930747, 5742.425757424224, 5763.740631671585, 5761.85595360111, 5762.078067509262, 5782.10377391505, 5808.796692115756, 5822.359540450547, 5735.397783232784, 5766.94233057664, 5787.247657804459, 5789.942100579025, 5790.218320526675, 5766.4233576642, 5819.650820950672, 5828.067509198592, 5880.176775251468, 5885.823425297248, 4512.142692888341, 4537.977310113428, 4540.250858608359, 4540.750258735735, 4567.543245675406, 4013.3578627419474, 4018.8593399230886, 4068.247374235776, 4082.0, 4092.3452247640234, 5608.298962629671, 5655.688937108416, 5672.234248376499, 5674.177244299553, 5703.74333155009, 5896.0, 5903.468687818117, 5924.111383292455, 5947.732352044169, 5967.731452084667, 5454.127339625641, 5460.972695136578, 5544.695041772741, 5609.0, 5648.350439699405, 5005.974970125126, 5007.37407824022, 5012.172991456442, 5012.874678133003, 5033.471485494044, 6047.758089676364, 6057.00059490188, 6110.205673262448, 6118.847028824226, 6120.7452472243085, 5719.027765279996, 5860.912086318624, 5886.146508756292, 5930.673812940157, 5931.110333450017, 6206.627602343874, 6235.220597425322, 6238.6605023116335, 6264.34224406449, 6265.812025639056, 5708.743106560298, 5791.189233507396, 5827.24245848037, 5842.591018628656, 5850.180974663635, 5702.0, 5754.597178197486, 5805.448482394166, 5840.591158619026, 5908.025175846109, 5677.403872593318, 5743.42565743439, 5748.6838223898085, 5762.481376676119, 5762.683052432157, 5611.943880561143, 5666.291713535808, 5683.516901063456, 5685.260916080883, 5700.372958974426, 5546.084895992116, 5567.248421463212, 5595.63628364155, 5635.6618602883955, 5643.971780141073, 5808.30300363959, 5823.82528524145, 5849.678267695147, 5860.706964651836, 5862.296524417097, 5438.048341540136, 5538.584606154635, 5668.461496157858, 5687.919295334039, 5700.059490184073], "value": 5403.739943997065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.1774961804617, 633.2685747961103, 642.2293248102278, 653.6502970910562, 656.6388486332515, 32200.677993220062, 35619.465708014366, 45545.54454455454, 46025.539744602625, 46146.307805382945, 48950.0, 49492.50507494924, 49506.50493495064, 49540.75229623847, 49972.75013624927, 8980.506072166028, 9129.817403651923, 9143.817123657524, 9144.908550914506, 9146.31402644801, 8174.100848906615, 10528.0, 10692.946535267312, 10767.569297228141, 11033.889661103407, 11014.0, 11022.559097636085, 11027.22809403342, 11038.11695064393, 11058.944705276463, 8298.792530186733, 8489.066202717697, 10369.585216591366, 10456.738581535485, 10500.474976251156, 10322.948385258102, 10671.519781609846, 10681.305715128492, 10985.670429887115, 11005.394703291317, 45566.31650525245, 45739.77130114328, 46056.53943460556, 46057.07885842265, 46099.30851037237, 3665.102049997741, 3848.9223017555128, 3877.689784817208, 3954.525456945185, 4360.040791025969, 33796.15509612255, 34319.0, 34401.332355215236, 34703.132421689406, 35142.82428587841, 4510.706804057726, 4683.672142949995, 4695.272232803921, 4699.647526435531, 4771.594414474774, 388510.0, 394503.0, 394720.0, 394800.0, 395172.0, 37402.251954960746, 38567.80716096402, 64680.0, 65581.34418655753, 65740.67129664321, 40525.79737101296, 40582.0, 40598.79700601478, 40828.0, 40835.38746918739, 16043.679126417639, 16182.595435114215, 16238.431654892021, 16251.756223656655, 16255.105969171573, 12180.695482613006, 13000.544980925622, 13042.804357934638, 13159.342032898508, 13368.799468007988, 9258.583363748647, 9262.768430789285, 9274.397164184307, 9290.72127836166, 9366.0, 3469.340825243196, 3473.1317170707325, 3524.7180225582406, 3545.9290814183573, 3595.388783906742, 1083.5394957143183, 1139.7093741096132, 1172.783035138485, 1240.1752834365227, 1241.1746188784357, 34503.65496345054, 34650.0, 35194.29611407757, 36082.0, 36330.818345908105, 1170.3369541560405, 1190.5594929875829, 1238.746057058301, 1257.1765493601706, 1300.6033159886135, 17537.386191483238, 17821.7326740099, 17946.19242134107, 18085.276588936296, 18123.818761812214, 596853.0, 602210.0, 607513.0, 608032.0, 608421.0, 63303.36696633067, 63674.0, 63785.0, 63787.36212637814, 63868.36131638717, 1373.086897213342, 1437.4322142753763, 1454.8690617844445, 1456.7450696128135, 1506.164078936201, 33640.831795840866, 35147.472787908715, 35315.64684353226, 35403.645963541065, 35436.11409714778, 54271.0, 54462.18306725323, 54930.45069549253, 55001.72499137479, 55175.0, 466589.0, 467799.0, 472084.0, 472238.0, 472733.0, 26493.33766655772, 49875.0, 50336.0, 50820.49179508157, 55869.720651396485, 49976.75011624918, 50363.24455133102, 51553.0, 55600.72199638976, 56246.0, 44091.59484368288, 45122.77438612786, 45655.543444565126, 46539.30191047069, 47249.527504724516, 44466.77766611146, 45120.0, 45208.0, 46076.0, 46926.29610555776, 45674.31488527741, 46027.53972460367, 46503.53496465128, 47192.7640361796, 47290.52709472861, 38951.41572876466, 40233.195336092525, 40400.79799600983, 41329.793351033055, 41517.79241103775, 29916.551251730805, 30377.646147308784, 30507.389852203276, 30627.23431914131, 31073.53389699111], "value": 20879.93992796543, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.377348129733, 394.5758309816946, 402.65371780268975, 410.9630133288004, 414.9896252593685, 13897.791533126985, 19308.3242086527, 20860.791392086074, 20891.373258802243, 21022.36932892016, 15021.32404041818, 19713.211471541155, 19846.50383740407, 19956.0, 19974.70037949432, 5561.610687251884, 5683.715814209294, 5725.914111288334, 5739.426057394269, 5743.0, 5633.070543360341, 5658.519025882805, 5658.7170641467765, 5690.516306113986, 5730.68481233532, 3589.712822974169, 3751.3997760358347, 5348.3849357323825, 6250.593711408744, 6274.874502509947, 6148.047052706837, 6184.56708030438, 6319.336469670688, 6338.049292606077, 6341.619502829822, 5528.253685752412, 5558.972205138989, 5559.416261292547, 5565.693886836222, 5569.164625306196, 22361.0, 22975.655365169536, 23341.53316933669, 23610.0, 23647.172348967702, 2367.112332875172, 2403.639454081884, 2414.082648593523, 2550.5409026375246, 2837.7020412856764, 13664.863351366459, 14493.71012579753, 14513.709725805425, 14778.482753103697, 14926.40294388223, 1927.6241132979076, 1937.3800383877165, 1976.6619344179614, 2058.763242227133, 2080.573482436097, 78967.6051619744, 80576.59711701462, 81116.59441702813, 81245.59377203076, 82390.9999999994, 10136.594536218616, 10239.84640230397, 10246.53890574926, 10311.123554497952, 10498.475076246157, 14428.278586070655, 14520.0, 14522.056066355864, 14525.0, 14551.199684017269, 7857.567833769198, 7900.881486777588, 7903.525788452711, 7941.324987376138, 8086.272235498834, 7811.882821757678, 7915.0, 7993.8401231976195, 7997.880031799527, 8006.239407256301, 5732.484076433141, 6702.765403210864, 6718.529702920847, 6720.0, 6780.32196780318, 1719.759233707282, 1794.5693033672085, 1809.7104463286075, 1840.7975122736489, 1852.8054554271607, 1068.9625863094755, 1129.8757136714955, 1159.562142942745, 1163.7381589142544, 1166.067146282987, 18012.819871801377, 19385.90307048484, 19596.020198989994, 20427.591448170955, 20524.589508209752, 1025.6717850287837, 1090.231386872253, 1096.8957948994832, 1102.9779404411868, 1148.6841118692425, 10496.580136794595, 11190.048845848194, 11267.267627604344, 11286.266392684449, 11326.660200193843, 394876.0, 395218.0, 398175.0, 488015.0, 507687.0, 99067.0, 104825.0, 106136.46931765447, 108003.45998269958, 108514.0, 1063.7127975446585, 1067.391586795519, 1101.5869049106584, 1103.4703342395694, 1108.772701596171, 17595.208215630584, 17797.822021779615, 17937.103144842968, 18163.36428225006, 18257.908710456362, 41483.58516414918, 42459.787701061294, 44101.55898441103, 44557.10885782331, 45013.549864500936, 60030.69984650049, 60602.09096863462, 60624.0, 61807.0, 61978.0703289442, 8345.707900223462, 8401.747947561584, 8446.0, 8596.35527335465, 8603.612837422206, 10622.0, 10885.836712449161, 12652.493900244255, 13166.934165329112, 13637.113587616774, 11544.076473882238, 11801.822972655245, 12041.759164816829, 12159.392030398622, 12310.384480776105, 12068.215565988183, 12101.334426606621, 12216.14486985938, 12287.569935052588, 12549.058820588674, 11834.11244156709, 11855.466504007512, 11962.401879905796, 12004.279743215435, 12034.097442691658, 8268.049174344787, 8422.377119574947, 8527.445716028438, 8618.569071546523, 8697.95651021741, 8360.205780450848, 11632.387554248799, 11806.645800625995, 12301.384930753606, 12398.81401778992], "value": 9471.113465289396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.2787192467802, 1553.5882991007386, 1604.3662753212482, 1812.7462155298251, 1947.8799690178141, 8554.615042323096, 8893.333000024999, 8929.508877011769, 9199.034101419338, 9247.167754902057, 8928.687495937644, 9111.179993800557, 9130.863037054449, 9137.360384773068, 9145.588448519817, 2152.9138834446603, 2337.801286890616, 2356.6582845487437, 2387.0451819272257, 2433.7809597136256, 2462.384403899025, 2467.925962221136, 2469.4320306329555, 2472.5673007223663, 2473.4311108445067, 2371.5968285391523, 2385.6302273147603, 2390.95218095638, 2394.8802559872024, 2397.2089210560475, 2094.9581008379823, 2258.7515373308925, 2302.435903203709, 2303.8041766449874, 2326.720793504782, 2338.3452633262714, 2342.051469154995, 2359.8820058997153, 2363.078399424226, 2363.3737059679197, 9267.675631352939, 9355.859662105075, 9363.0, 9378.343515953886, 9392.62429502819, 5383.730813459311, 5544.750486228089, 5574.498295153415, 5575.135853942646, 5577.386487486373, 3345.498175273704, 3354.111160542458, 3379.4086034943784, 3391.576052993376, 3540.7521473496868, 1127.1827924754568, 1173.2139466557342, 1177.9293242405483, 1199.4842217846322, 1204.5061524774887, 13043.217406955613, 13072.08495405322, 13073.934630326787, 13076.411561479756, 13102.934485327607, 4819.662623616313, 4882.365292512021, 4946.678465899705, 4955.702657840541, 4971.552560269593, 11077.335359878432, 11171.0, 11207.60773372928, 11217.270877392943, 11218.214724969337, 5424.105022671294, 5500.697461639648, 5504.0643090674685, 5509.146082357241, 5510.752016159283, 4458.799354029076, 4898.657094003385, 5004.9499505005215, 5013.473585273567, 5074.16276314404, 4177.394277829698, 4177.684029530688, 4244.617984381421, 4272.081502476983, 4279.5934386233885, 1273.0961017677369, 1277.2783377391745, 1280.2766436963086, 1282.9166104203198, 1295.935203239853, 925.3291363761219, 953.3993584042009, 972.1202311907734, 984.3700031979539, 1006.3408467453829, 6142.262928448615, 6247.781327653511, 6433.260175079832, 6450.129232553639, 6487.935120648827, 455.63321526171086, 458.67892475267445, 460.06606588625147, 460.82718980382356, 469.6313393985773, 4253.893652658647, 4307.633851122627, 4421.690481666253, 4486.730796152241, 4488.708233964782, 11075.50160242791, 11401.657950261506, 11404.429778511041, 11462.426878656033, 11482.655520334403, 11030.172737044593, 11206.719832004264, 11328.773424531464, 11334.376609286404, 11337.489812958436, 8450.323974082059, 8711.693246013276, 8724.345674074342, 8770.210681038738, 8772.649094036295, 6326.9683651581445, 6421.775237866652, 6513.990331498625, 6518.478521718346, 6527.608343499405, 10632.787344253225, 10639.89360106389, 10754.085902698358, 10834.295770774874, 10958.28771129874, 10949.124070074535, 11027.393493357622, 11050.502727377127, 11135.164862635173, 11146.275492092987, 7388.1503627083575, 7388.519746216479, 7678.692852285846, 8364.665413383396, 8460.788480288042, 8761.956190219264, 9175.357724959189, 9204.217641500547, 9208.447493150432, 9234.907650923406, 7820.726274580363, 7935.0, 8019.719309824128, 8029.799255018671, 8035.196480351918, 7751.147373788766, 7843.450958432855, 7877.6455059523605, 7895.234399100618, 8036.678532858854, 7293.744718934812, 7358.0, 7366.926330736838, 7377.1885092638695, 7418.96290518544, 5427.158790387496, 5526.088195447706, 5545.805896793754, 5575.358833734011, 5635.577331700057, 5585.609007369445, 5610.214569960127, 5642.88714225705, 5699.173619825185, 5829.183914251923], "value": 4755.5012084694845, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.5606856414571, 338.4297458781952, 348.93195826813775, 351.20276971275223, 351.32019542185856, 5285.225256740208, 5389.137737961927, 5394.568434525238, 5421.593380496469, 5426.864328391792, 5034.295198672189, 5167.250748641445, 5171.250168725542, 5194.818181363653, 5314.681119132845, 4039.5354534228645, 4091.3249313863253, 4113.239050775616, 4193.790310484464, 4200.222958752625, 4085.897852553695, 4137.441445404862, 4140.337545992642, 4140.937885931713, 4147.253494371012, 4075.9592404075875, 4103.384492326145, 4135.751854888701, 4156.750594964312, 4161.148289011391, 4083.203775263825, 4091.4067460218102, 4116.526599441057, 4132.214879172948, 4132.2561938850995, 3685.9262814743556, 3705.2959937611768, 3712.461693054492, 3719.800971164796, 3726.4037753959506, 5041.319421878036, 5050.520200580939, 5155.226715992593, 5166.586673066184, 5178.275041494194, 4739.668223224376, 4769.833055843029, 4782.497837727058, 4790.736509491977, 4796.808127674889, 5488.765027868738, 5532.585056120807, 5542.750576224039, 5546.389897111315, 5593.021221286259, 3800.8669696560487, 4080.4491393661774, 4091.079507110906, 4099.344104943195, 4103.763448920346, 5754.136879468071, 5755.654660720328, 5769.249997500298, 5771.682557459338, 5786.942130578683, 4057.8376864925663, 4066.0, 4071.91856162881, 4076.2051399977313, 4082.4488694025927, 4096.344584866467, 4128.401381799622, 4137.834486620562, 4142.896427589334, 4149.356849688304, 4500.594946454835, 4706.3411122442885, 4707.905841883212, 4730.574248317668, 4757.476677565465, 5592.804251851166, 5621.90795062722, 5661.160122960055, 5670.773169073191, 5677.233573467529, 1353.1204716934071, 1388.7430825297151, 1416.4192681000945, 1432.584550480349, 1439.5825210688783, 892.8258989496986, 896.2561074308309, 916.6470908700198, 917.6512925088424, 920.5581320965974, 4866.6106711463, 4874.82938097172, 4916.237983112552, 4926.581240594518, 4930.235813448921, 5125.513076257749, 5153.4073581538605, 5153.845384638467, 5166.43169251382, 5204.297419848348, 4621.976890115528, 4910.729909854992, 4957.3555437793575, 4968.90062198754, 4974.5873251473, 2698.311930457721, 2708.3770732731186, 2730.1809457163167, 2734.8632568371504, 2748.35098940634, 5295.6169723624525, 5311.946880531145, 5364.7049412282695, 5383.67697938125, 5401.594880383908, 4969.378827646544, 4970.22036926745, 5160.638755287094, 5201.843944681666, 5205.085152314716, 5304.045271851027, 5319.601029922771, 5355.892882142335, 5372.677639341652, 5438.401775804658, 5091.210862316347, 5092.923606145985, 5105.897882042264, 5182.714950677598, 5188.636795424284, 5033.47148549397, 5077.6290401592105, 5319.228711836685, 5759.539236860957, 5760.020796464527, 6102.908456373247, 6111.083337499411, 6118.5411094169, 6118.674903536627, 6124.724387402666, 4076.8381011411607, 4111.835526579023, 4115.382692596135, 4119.691023173334, 4119.8352065918225, 5593.972030139823, 5806.0, 5821.185034095145, 5866.384029676993, 5872.500837428695, 5568.77724891016, 5635.83092507209, 5689.630174038674, 5691.288588926384, 5709.314882214161, 5613.831585052455, 5637.49262566371, 5644.8024319148635, 5665.518430933417, 5667.234923285304, 5388.515033646834, 5431.4840090191365, 5534.7509362078, 5544.758259931075, 5569.136783798518, 5656.925184214986, 5658.490735833795, 5707.486326230659, 5711.685857277889, 5722.227499287709, 5402.811381496064, 5546.084895992116, 5559.916601251065, 5599.188117722826, 5617.6236821977245], "value": 4165.50854284926, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.7068740597088, 825.8843761873338, 869.2698133567802, 872.6858331000841, 922.7163265407039, 14141.15153090814, 15089.773653395208, 15105.697886042273, 15308.770368444482, 16003.199840007983, 16856.24146913389, 16904.0, 17065.14674266288, 17093.0, 17146.399876004343, 720.8702433561957, 850.8808766772656, 865.2947847504296, 872.4808738800403, 873.9388242823005, 876.198278575103, 879.6261588824756, 881.2421317666801, 882.1443200095897, 882.5895958379352, 928.1646518133666, 929.0384452092052, 932.580338847518, 933.7385532051003, 933.8319102561536, 744.9962750186241, 891.8706787515839, 918.728974952384, 925.773185569533, 926.3654396738223, 679.6194131286446, 680.6392611915693, 680.7549282258383, 681.7204945972128, 682.2154522299346, 15457.304421301069, 15530.61173470661, 15530.611734706723, 15544.61138471536, 15571.688566228611, 14212.928935355361, 14521.20133392663, 14531.854681453156, 14547.418103275962, 14623.268836558236, 14008.719825603534, 14041.719165616732, 14076.0, 14199.148051116863, 14476.927615361856, 4686.742229177394, 4707.952920470786, 4736.478987311393, 4835.371401717789, 4852.393450818648, 66437.0, 68475.65762171257, 78090.6095469519, 78630.0, 78962.0, 11976.221545599508, 12054.216475929037, 12110.878891211152, 12405.069619778373, 12517.749645007048, 22457.213997510007, 22828.771712282996, 22852.65721014186, 22878.0, 22897.771022289562, 9121.179093881583, 9124.270058395312, 9166.94580123281, 9295.953520232355, 9646.324757266924, 4919.1539494506205, 4946.282788995647, 5072.746362681851, 5142.460041695568, 5273.288106105627, 3651.8904432867057, 3757.7181711371754, 3762.191128907243, 3763.34141525232, 3767.020574650611, 570.6319423971515, 617.4350469320522, 627.0938493876396, 645.8320836582523, 646.4795839349368, 718.7664009197032, 791.6330172783337, 808.2604416958535, 819.5287709567023, 830.0869044051495, 10400.323978941344, 10442.68671939843, 10615.787684246272, 10635.202359823044, 10767.676969690921, 714.8856183010694, 767.5202998126172, 787.1498781316164, 814.4909431605247, 845.2899564365962, 4652.371929789435, 4901.0, 4906.215005599087, 4927.286074241553, 4954.405471343462, 75245.0, 85773.0, 108812.0, 109100.90899091067, 130483.34758326148, 65507.67246163739, 95585.5220723892, 96168.0, 109262.0, 109928.0, 72727.27272727205, 75718.0, 77052.22947770562, 78007.21992780112, 79329.20670793334, 9938.453385063602, 10206.183505319705, 10330.0, 10363.63727269542, 10516.631917882838, 39981.0, 49718.0, 50751.746241268556, 50975.23537146871, 53674.0, 78365.60817195878, 78722.0, 79290.0, 79653.60173199097, 82672.58663706883, 11698.94150529242, 12131.636050918487, 12203.0, 12869.420876060412, 13190.868091319348, 14452.566423007327, 14778.926105369404, 14990.925045374703, 15060.698786024437, 15095.4716584919, 13784.862151378358, 13807.654808629864, 13896.0, 14159.787603186167, 14319.642008949859, 13463.663408414868, 13589.456421743414, 14389.136651800925, 14389.712205756035, 14616.488422905148, 12245.265284082983, 12490.063245256824, 12691.365431728562, 14438.061526000776, 14589.124652520883, 11631.709207269885, 11660.591879284184, 11791.705207369541, 11866.347350895783, 12218.755624887275, 11596.884031159918, 11604.883951160718, 12059.879401205875, 12109.320392227095, 12123.636290911287], "value": 7899.914103463648, "unit": "score"}], "name": "dromaeo_css", "value": 7422.661501620293, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 113.0, 110.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 128.0, 126.0, 176.0, 124.0, 131.0, 158.0, 131.0, 162.0, 134.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 161.0, 160.0, 162.0, 161.0, 162.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 126.0, 76.0, 76.0, 75.0, 75.0, 100.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 119.0, 83.0, 85.0, 86.0, 121.0, 85.0, 85.0, 122.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 53.0, 51.0, 53.0, 54.0, 51.0, 51.0, 50.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 63.0, 62.0, 60.0, 60.0, 59.0, 61.0, 61.0, 62.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 80.0, 76.0, 77.0, 78.0, 76.0, 78.0, 105.0, 76.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 116.0, 124.0, 120.0, 122.0, 124.0, 129.0, 142.0, 122.0], "value": 123.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 156.0, 156.0, 157.0, 155.0, 156.0, 155.0, 153.0, 154.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 63.0, 62.0, 61.0, 70.0, 61.0, 60.0, 59.0, 60.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1486.4, "alertThreshold": 2.0}]} 10:12:57 INFO - Return code: 0 10:12:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:12:57 ERROR - # TBPL SUCCESS # 10:12:57 INFO - Running post-action listener: _resource_record_post_action 10:12:57 INFO - ##### 10:12:57 INFO - ##### Finished run-tests step (success) 10:12:57 INFO - ##### 10:12:57 INFO - Running post-run listener: _resource_record_post_run 10:12:57 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 290816; Write bytes: 514097152; Read time: 28; Write time: 482988 10:12:57 INFO - TinderboxPrint: CPU usage
13.1% 10:12:57 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 28 10:12:57 INFO - TinderboxPrint: I/O write bytes / time
514,097,152 / 482,988 10:12:57 INFO - TinderboxPrint: CPU idle
8,238.7 (86.8%) 10:12:57 INFO - TinderboxPrint: CPU user
1,202.0 (12.7%) 10:12:57 INFO - TinderboxPrint: Swap in / out
0 / 0 10:12:57 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 242454528; Read time: 0; Write time: 272152 10:12:57 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253739008; Read time: 20; Write time: 207440 10:12:57 INFO - Running post-run listener: _upload_blobber_files 10:12:57 INFO - Blob upload gear active. 10:12:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:12:57 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:57 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:57 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:58 INFO - (blobuploader) - INFO - Open directory for files ... 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:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:13:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:01 INFO - (blobuploader) - INFO - Done attempting. 10:13:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:13:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: 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 - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:13:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:13:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:03 INFO - (blobuploader) - INFO - Done attempting. 10:13:03 INFO - (blobuploader) - INFO - Iteration through files over. 10:13:03 INFO - Return code: 0 10:13:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:13:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:13:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/882b47668334b44829cf12eb986beb0dc80c5b5baf4c68c4c44dac4020c9a56aedb6e16d1e6397a1101357e59a803c036c463481c4be10f599594d7f7950d413", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4753b02977c2c15c525da5cf5ae4381ceb07d65ea153b5bafb2d65d05c1b8dcdf4ba4200b8d36d4b4ab28623aa5047748be99c84b5fa525116c96d40f842be92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfd98e9f976a14f59ce3f6699b82d25956bb5e4ec81adbbbcddda21ea368156283957f1c20ec89d3d4311bb72d58e80d05128f208e45f74e344cabe6f2df49d3"} 10:13:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:13:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:13:03 INFO - Contents: 10:13:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/882b47668334b44829cf12eb986beb0dc80c5b5baf4c68c4c44dac4020c9a56aedb6e16d1e6397a1101357e59a803c036c463481c4be10f599594d7f7950d413", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4753b02977c2c15c525da5cf5ae4381ceb07d65ea153b5bafb2d65d05c1b8dcdf4ba4200b8d36d4b4ab28623aa5047748be99c84b5fa525116c96d40f842be92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfd98e9f976a14f59ce3f6699b82d25956bb5e4ec81adbbbcddda21ea368156283957f1c20ec89d3d4311bb72d58e80d05128f208e45f74e344cabe6f2df49d3"} 10:13:03 INFO - Running post-run listener: copy_logs_to_upload_dir 10:13:03 INFO - Copying logs to upload dir... 10:13:03 INFO - mkdir: /builds/slave/test/build/upload/logs 10:13:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.007231 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-06 10:13:02.635820) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 10:13:02.639493) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/882b47668334b44829cf12eb986beb0dc80c5b5baf4c68c4c44dac4020c9a56aedb6e16d1e6397a1101357e59a803c036c463481c4be10f599594d7f7950d413", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4753b02977c2c15c525da5cf5ae4381ceb07d65ea153b5bafb2d65d05c1b8dcdf4ba4200b8d36d4b4ab28623aa5047748be99c84b5fa525116c96d40f842be92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfd98e9f976a14f59ce3f6699b82d25956bb5e4ec81adbbbcddda21ea368156283957f1c20ec89d3d4311bb72d58e80d05128f208e45f74e344cabe6f2df49d3"} 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.011246 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/882b47668334b44829cf12eb986beb0dc80c5b5baf4c68c4c44dac4020c9a56aedb6e16d1e6397a1101357e59a803c036c463481c4be10f599594d7f7950d413", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4753b02977c2c15c525da5cf5ae4381ceb07d65ea153b5bafb2d65d05c1b8dcdf4ba4200b8d36d4b4ab28623aa5047748be99c84b5fa525116c96d40f842be92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bfd98e9f976a14f59ce3f6699b82d25956bb5e4ec81adbbbcddda21ea368156283957f1c20ec89d3d4311bb72d58e80d05128f208e45f74e344cabe6f2df49d3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 10:13:02.664624) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:13:02.664956) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467823944.106794-533956898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004371 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:13:02.747817) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 10:13:02.748152) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 10:13:02.748441) ========= ========= Total master_lag: 0.16 =========