builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1467542039.49 results: success (0) buildid: 20160703004921 builduid: 2916d3fb19594bd79bc0048addbc1e97 revision: 01f2dde06c5fd93b38c0d80b6028210b48dd3f4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.487738) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.488701) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.489018) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.542536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.542826) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-03 03:33:59-- 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% 220M=0s 2016-07-03 03:33:59 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.235354 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.801626) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.801928) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015919 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.915391) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:33:59.915711) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 01f2dde06c5fd93b38c0d80b6028210b48dd3f4a --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 01f2dde06c5fd93b38c0d80b6028210b48dd3f4a --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=56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-03 03:33:59,991 truncating revision to first 12 chars 2016-07-03 03:33:59,991 Setting DEBUG logging. 2016-07-03 03:33:59,992 attempt 1/10 2016-07-03 03:33:59,992 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/01f2dde06c5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-03 03:34:00,461 unpacking tar archive at: mozilla-aurora-01f2dde06c5f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.803758 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:34:00.735837) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 03:34:00.736136) ========= script_repo_revision: 01f2dde06c5fd93b38c0d80b6028210b48dd3f4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 03:34:00.736552) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 03:34:00.736840) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 03:34:00.747644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-03 03:34:00.747988) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:34:00 INFO - MultiFileLogger online at 20160703 03:34:00 in /builds/slave/test 03:34:00 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 03:34:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:34:00 INFO - {'append_to_log': False, 03:34:00 INFO - 'base_work_dir': '/builds/slave/test', 03:34:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:34:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:34:00 INFO - 'branch': 'Mozilla-Aurora', 03:34:00 INFO - 'buildbot_json_path': 'buildprops.json', 03:34:00 INFO - 'config_files': ('talos/linux_config.py',), 03:34:00 INFO - 'default_actions': ('clobber', 03:34:00 INFO - 'read-buildbot-config', 03:34:00 INFO - 'download-and-extract', 03:34:00 INFO - 'populate-webroot', 03:34:00 INFO - 'create-virtualenv', 03:34:00 INFO - 'install', 03:34:00 INFO - 'run-tests'), 03:34:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:34:00 INFO - 'download_minidump_stackwalk': True, 03:34:00 INFO - 'download_symbols': 'ondemand', 03:34:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:34:00 INFO - 'tooltool.py': '/tools/tooltool.py', 03:34:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:34:00 INFO - '/tools/misc-python/virtualenv.py')}, 03:34:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:34:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:34:00 INFO - 'installer_path': 'installer.exe', 03:34:00 INFO - 'log_level': 'info', 03:34:00 INFO - 'log_name': 'talos', 03:34:00 INFO - 'log_to_console': True, 03:34:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:34:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:34:00 INFO - 'opt_config_files': (), 03:34:00 INFO - 'pip_index': False, 03:34:00 INFO - 'sps_profile': False, 03:34:00 INFO - 'sps_profile_interval': 0, 03:34:00 INFO - 'suite': 'dromaeojs', 03:34:00 INFO - 'system_bits': '32', 03:34:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:34:00 INFO - 'title': 'talos-linux64-ix-037', 03:34:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:34:00 INFO - 'use_talos_json': True, 03:34:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:34:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:34:00 INFO - 'work_dir': 'build'} 03:34:00 INFO - ##### 03:34:00 INFO - ##### Running clobber step. 03:34:00 INFO - ##### 03:34:00 INFO - Running pre-action listener: _resource_record_pre_action 03:34:00 INFO - Running main action method: clobber 03:34:00 INFO - rmtree: /builds/slave/test/build 03:34:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:34:01 INFO - Running post-action listener: _resource_record_post_action 03:34:01 INFO - ##### 03:34:01 INFO - ##### Finished clobber step (success) 03:34:01 INFO - ##### 03:34:01 INFO - ##### 03:34:01 INFO - ##### Running read-buildbot-config step. 03:34:01 INFO - ##### 03:34:01 INFO - Running pre-action listener: _resource_record_pre_action 03:34:01 INFO - Running main action method: read_buildbot_config 03:34:01 INFO - Using buildbot properties: 03:34:01 INFO - { 03:34:01 INFO - "project": "", 03:34:01 INFO - "product": "firefox", 03:34:01 INFO - "script_repo_revision": "production", 03:34:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:34:01 INFO - "repository": "", 03:34:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:34:01 INFO - "buildid": "20160703004921", 03:34:01 INFO - "pgo_build": "True", 03:34:01 INFO - "basedir": "/builds/slave/test", 03:34:01 INFO - "buildnumber": 401, 03:34:01 INFO - "slavename": "talos-linux64-ix-037", 03:34:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:34:01 INFO - "platform": "ubuntu64_hw", 03:34:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:34:01 INFO - "branch": "mozilla-aurora", 03:34:01 INFO - "repo_path": "releases/mozilla-aurora", 03:34:01 INFO - "revision": "01f2dde06c5fd93b38c0d80b6028210b48dd3f4a", 03:34:01 INFO - "stage_platform": "linux64-pgo", 03:34:01 INFO - "builduid": "2916d3fb19594bd79bc0048addbc1e97", 03:34:01 INFO - "slavebuilddir": "test" 03:34:01 INFO - } 03:34:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:34:01 INFO - Running post-action listener: _resource_record_post_action 03:34:01 INFO - ##### 03:34:01 INFO - ##### Finished read-buildbot-config step (success) 03:34:01 INFO - ##### 03:34:01 INFO - ##### 03:34:01 INFO - ##### Running download-and-extract step. 03:34:01 INFO - ##### 03:34:01 INFO - Running pre-action listener: _resource_record_pre_action 03:34:01 INFO - Running main action method: download_and_extract 03:34:01 INFO - mkdir: /builds/slave/test/build/tests 03:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:01 INFO - https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:34:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:34:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:34:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/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 03:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/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 03:34:10 INFO - Downloaded 1361 bytes. 03:34:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:34:10 INFO - Using the following test package requirements: 03:34:10 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:34:10 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:34:10 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:34:10 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:10 INFO - u'jsshell-linux-x86_64.zip'], 03:34:10 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:34:10 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:34:10 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:34:10 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:34:10 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:34:10 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:34:10 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:34:10 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')]} 03:34:10 INFO - https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:34:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:34:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:34:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/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 03:34:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/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 03:34:17 INFO - Downloaded 24525288 bytes. 03:34:17 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'] 03:34:17 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 03:34:19 INFO - Return code: 0 03:34:19 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 03:34:19 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')]} 03:34:19 INFO - https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:34:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:34:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:34:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/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 03:34:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/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 03:34:20 INFO - Downloaded 24525288 bytes. 03:34:20 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'] 03:34:20 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 03:34:21 INFO - Return code: 0 03:34:21 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')]} 03:34:21 INFO - https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:34:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:34:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:34:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/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 03:34:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/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 03:34:22 INFO - Downloaded 10833369 bytes. 03:34:22 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'] 03:34:22 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 03:34:23 INFO - Return code: 0 03:34: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')]} 03:34:23 INFO - https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:34:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:34:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:34:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/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 03:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HntX6dLQRiihjeyH7uG-uw/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 03:34:24 INFO - Downloaded 63629607 bytes. 03:34:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:34:24 INFO - mkdir: /builds/slave/test/properties 03:34:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:34:24 INFO - Writing to file /builds/slave/test/properties/build_url 03:34:24 INFO - Contents: 03:34:24 INFO - build_url:https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:34:25 INFO - Running post-action listener: _resource_record_post_action 03:34:25 INFO - Running post-action listener: set_extra_try_arguments 03:34:25 INFO - ##### 03:34:25 INFO - ##### Finished download-and-extract step (success) 03:34:25 INFO - ##### 03:34:25 INFO - ##### 03:34:25 INFO - ##### Running populate-webroot step. 03:34:25 INFO - ##### 03:34:25 INFO - Running pre-action listener: _resource_record_pre_action 03:34:25 INFO - Running main action method: populate_webroot 03:34:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:34:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:34:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:34:25 INFO - '--tppagecycles', 03:34:25 INFO - '7'], 03:34:25 INFO - 'tests': ['tsvgm']}}, 03:34:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:34:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:34:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:34:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:34:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:34:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:34:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:25 INFO - 'talos_options': ['--disable-e10s'], 03:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:25 INFO - 'talos_options': ['--disable-e10s'], 03:34:25 INFO - 'tests': ['damp', 'tps']}, 03:34:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:25 INFO - 'tests': ['damp', 'tps']}, 03:34:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:34:25 INFO - 'tests': ['dromaeo_dom']}, 03:34:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:34:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:34:25 INFO - 'tests': ['a11yr', 03:34:25 INFO - 'ts_paint', 03:34:25 INFO - 'tpaint', 03:34:25 INFO - 'sessionrestore', 03:34:25 INFO - 'sessionrestore_no_auto_restore', 03:34:25 INFO - 'tabpaint']}, 03:34:25 INFO - 'other-e10s': {'tests': ['a11yr', 03:34:25 INFO - 'ts_paint', 03:34:25 INFO - 'tpaint', 03:34:25 INFO - 'sessionrestore', 03:34:25 INFO - 'sessionrestore_no_auto_restore', 03:34:25 INFO - 'tabpaint']}, 03:34:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:34:25 INFO - 'ts_paint', 03:34:25 INFO - 'tpaint', 03:34:25 INFO - 'sessionrestore', 03:34:25 INFO - 'sessionrestore_no_auto_restore', 03:34:25 INFO - 'tabpaint']}, 03:34:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:34:25 INFO - 'ts_paint', 03:34:25 INFO - 'tpaint', 03:34:25 INFO - 'sessionrestore', 03:34:25 INFO - 'sessionrestore_no_auto_restore', 03:34:25 INFO - 'tabpaint']}, 03:34:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:34:25 INFO - 'tests': ['a11yr', 03:34:25 INFO - 'ts_paint', 03:34:25 INFO - 'tpaint', 03:34:25 INFO - 'sessionrestore', 03:34:25 INFO - 'sessionrestore_no_auto_restore', 03:34:25 INFO - 'tabpaint']}, 03:34:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:34:25 INFO - 'tests': ['a11yr', 03:34:25 INFO - 'ts_paint', 03:34:25 INFO - 'tpaint', 03:34:25 INFO - 'sessionrestore', 03:34:25 INFO - 'sessionrestore_no_auto_restore', 03:34:25 INFO - 'tabpaint']}, 03:34:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:34:25 INFO - 'tests': ['tsvgx', 03:34:25 INFO - 'tsvgr_opacity', 03:34:25 INFO - 'tart', 03:34:25 INFO - 'tscrollx', 03:34:25 INFO - 'cart']}, 03:34:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:34:25 INFO - 'tsvgr_opacity', 03:34:25 INFO - 'tart', 03:34:25 INFO - 'tscrollx', 03:34:25 INFO - 'cart']}, 03:34:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:25 INFO - 'talos_options': ['--disable-e10s'], 03:34:25 INFO - 'tests': ['tp5o']}, 03:34:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:25 INFO - 'tests': ['tp5o']}, 03:34:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:25 INFO - 'talos_options': ['--disable-e10s', 03:34:25 INFO - '--xperf_path', 03:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:25 INFO - 'tests': ['tp5n']}, 03:34:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:25 INFO - 'talos_options': ['--xperf_path', 03:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:25 INFO - 'tests': ['tp5n']}}, 03:34:25 INFO - 'talos.zip': {'path': '', 03:34:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:34:25 INFO - Running post-action listener: _resource_record_post_action 03:34:25 INFO - ##### 03:34:25 INFO - ##### Finished populate-webroot step (success) 03:34:25 INFO - ##### 03:34:25 INFO - ##### 03:34:25 INFO - ##### Running create-virtualenv step. 03:34:25 INFO - ##### 03:34:25 INFO - Running pre-action listener: _resource_record_pre_action 03:34:25 INFO - Running main action method: create_virtualenv 03:34:25 INFO - Creating virtualenv /builds/slave/test/build/venv 03:34:25 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 03:34:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:34:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:34:25 INFO - Using real prefix '/usr' 03:34:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:34:25 INFO - Installing distribute.............................................................................................................................................................................................done. 03:34:27 INFO - Installing pip.................done. 03:34:27 INFO - Return code: 0 03:34:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:27 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 0x7f53787c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1c0>, '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 0x26fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fe550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', '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 03:34:27 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 03:34:27 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 03:34:27 INFO - Using env: {'DISPLAY': ':0', 03:34:27 INFO - 'HOME': '/home/cltbld', 03:34:27 INFO - 'LANG': 'en_US.UTF-8', 03:34:27 INFO - 'LANGUAGE': 'en_US:en', 03:34:27 INFO - 'LOGNAME': 'cltbld', 03:34:27 INFO - 'MAIL': '/var/mail/cltbld', 03:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:27 INFO - 'MOZ_NO_REMOTE': '1', 03:34:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:27 INFO - 'NO_EM_RESTART': '1', 03:34:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:27 INFO - 'PWD': '/builds/slave/test', 03:34:27 INFO - 'SHELL': '/bin/bash', 03:34:27 INFO - 'SHLVL': '1', 03:34:27 INFO - 'TERM': 'linux', 03:34:27 INFO - 'TMOUT': '86400', 03:34:27 INFO - 'USER': 'cltbld', 03:34:27 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', 03:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:27 INFO - '_': '/tools/buildbot/bin/python'} 03:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:28 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 03:34:28 INFO - Cleaning up... 03:34:28 INFO - Return code: 0 03:34:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:28 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 0x7f53787c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1c0>, '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 0x26fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fe550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', '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 03:34:28 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 03:34:28 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 03:34:28 INFO - Using env: {'DISPLAY': ':0', 03:34:28 INFO - 'HOME': '/home/cltbld', 03:34:28 INFO - 'LANG': 'en_US.UTF-8', 03:34:28 INFO - 'LANGUAGE': 'en_US:en', 03:34:28 INFO - 'LOGNAME': 'cltbld', 03:34:28 INFO - 'MAIL': '/var/mail/cltbld', 03:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:28 INFO - 'MOZ_NO_REMOTE': '1', 03:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:28 INFO - 'NO_EM_RESTART': '1', 03:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:28 INFO - 'PWD': '/builds/slave/test', 03:34:28 INFO - 'SHELL': '/bin/bash', 03:34:28 INFO - 'SHLVL': '1', 03:34:28 INFO - 'TERM': 'linux', 03:34:28 INFO - 'TMOUT': '86400', 03:34:28 INFO - 'USER': 'cltbld', 03:34:28 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', 03:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:28 INFO - '_': '/tools/buildbot/bin/python'} 03:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:28 INFO - Downloading/unpacking psutil>=3.1.1 03:34:28 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 03:34:28 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 03:34:28 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 03:34:28 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 03:34:28 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 03:34:28 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 03:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:34:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:30 INFO - Installing collected packages: psutil 03:34:30 INFO - Running setup.py install for psutil 03:34:30 INFO - building 'psutil._psutil_linux' extension 03:34:30 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 03:34:30 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 03:34:30 INFO - building 'psutil._psutil_posix' extension 03:34:30 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 03:34:30 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 03:34:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:30 INFO - Successfully installed psutil 03:34:30 INFO - Cleaning up... 03:34:30 INFO - Return code: 0 03:34:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:34:30 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')]} 03:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:30 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')]} 03:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:30 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 0x7f53787c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1c0>, '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 0x26fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fe550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', '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 03:34:30 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 03:34:30 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 03:34:30 INFO - Using env: {'DISPLAY': ':0', 03:34:30 INFO - 'HOME': '/home/cltbld', 03:34:30 INFO - 'LANG': 'en_US.UTF-8', 03:34:30 INFO - 'LANGUAGE': 'en_US:en', 03:34:30 INFO - 'LOGNAME': 'cltbld', 03:34:30 INFO - 'MAIL': '/var/mail/cltbld', 03:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:30 INFO - 'MOZ_NO_REMOTE': '1', 03:34:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:30 INFO - 'NO_EM_RESTART': '1', 03:34:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:30 INFO - 'PWD': '/builds/slave/test', 03:34:30 INFO - 'SHELL': '/bin/bash', 03:34:30 INFO - 'SHLVL': '1', 03:34:30 INFO - 'TERM': 'linux', 03:34:30 INFO - 'TMOUT': '86400', 03:34:30 INFO - 'USER': 'cltbld', 03:34:30 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', 03:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:30 INFO - '_': '/tools/buildbot/bin/python'} 03:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:34:31 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 03:34:31 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 03:34:31 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 03:34:31 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 03:34:31 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 03:34:31 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 03:34:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:34:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:34:33 INFO - Installing collected packages: mozsystemmonitor 03:34:33 INFO - Running setup.py install for mozsystemmonitor 03:34:33 INFO - Successfully installed mozsystemmonitor 03:34:33 INFO - Cleaning up... 03:34:33 INFO - Return code: 0 03:34:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:33 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 0x7f53787c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1c0>, '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 0x26fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fe550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', '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 03:34:33 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 03:34:33 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 03:34:33 INFO - Using env: {'DISPLAY': ':0', 03:34:33 INFO - 'HOME': '/home/cltbld', 03:34:33 INFO - 'LANG': 'en_US.UTF-8', 03:34:33 INFO - 'LANGUAGE': 'en_US:en', 03:34:33 INFO - 'LOGNAME': 'cltbld', 03:34:33 INFO - 'MAIL': '/var/mail/cltbld', 03:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:33 INFO - 'MOZ_NO_REMOTE': '1', 03:34:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:33 INFO - 'NO_EM_RESTART': '1', 03:34:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:33 INFO - 'PWD': '/builds/slave/test', 03:34:33 INFO - 'SHELL': '/bin/bash', 03:34:33 INFO - 'SHLVL': '1', 03:34:33 INFO - 'TERM': 'linux', 03:34:33 INFO - 'TMOUT': '86400', 03:34:33 INFO - 'USER': 'cltbld', 03:34:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', 03:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:33 INFO - '_': '/tools/buildbot/bin/python'} 03:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:33 INFO - Downloading/unpacking jsonschema==2.5.1 03:34:33 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 03:34:33 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 03:34:33 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 03:34:33 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 03:34:33 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 03:34:33 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 03:34:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:34:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:34:35 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 03:34:35 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 03:34:35 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 03:34:35 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 03:34:35 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 03:34:35 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 03:34:35 INFO - Downloading functools32-3.2.3-2.tar.gz 03:34:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:34:35 INFO - warning: no files found matching '*.txt' 03:34:35 INFO - no previously-included directories found matching 'build' 03:34:35 INFO - no previously-included directories found matching 'dist' 03:34:35 INFO - no previously-included directories found matching '.git*' 03:34:35 INFO - Installing collected packages: jsonschema, functools32 03:34:36 INFO - Running setup.py install for functools32 03:34:36 INFO - warning: no files found matching '*.txt' 03:34:36 INFO - no previously-included directories found matching 'build' 03:34:36 INFO - no previously-included directories found matching 'dist' 03:34:36 INFO - no previously-included directories found matching '.git*' 03:34:36 INFO - Successfully installed jsonschema functools32 03:34:36 INFO - Cleaning up... 03:34:36 INFO - Return code: 0 03:34:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:36 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 0x7f53787c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1c0>, '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 0x26fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fe550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', '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 03:34:36 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 03:34:36 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 03:34:36 INFO - Using env: {'DISPLAY': ':0', 03:34:36 INFO - 'HOME': '/home/cltbld', 03:34:36 INFO - 'LANG': 'en_US.UTF-8', 03:34:36 INFO - 'LANGUAGE': 'en_US:en', 03:34:36 INFO - 'LOGNAME': 'cltbld', 03:34:36 INFO - 'MAIL': '/var/mail/cltbld', 03:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:36 INFO - 'MOZ_NO_REMOTE': '1', 03:34:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:36 INFO - 'NO_EM_RESTART': '1', 03:34:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:36 INFO - 'PWD': '/builds/slave/test', 03:34:36 INFO - 'SHELL': '/bin/bash', 03:34:36 INFO - 'SHLVL': '1', 03:34:36 INFO - 'TERM': 'linux', 03:34:36 INFO - 'TMOUT': '86400', 03:34:36 INFO - 'USER': 'cltbld', 03:34:36 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', 03:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:36 INFO - '_': '/tools/buildbot/bin/python'} 03:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:36 INFO - Downloading/unpacking blobuploader==1.2.4 03:34:36 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 03:34:36 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 03:34:36 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 03:34:36 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 03:34:36 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 03:34:36 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 03:34:38 INFO - Downloading blobuploader-1.2.4.tar.gz 03:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:34:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:34:38 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 03:34:38 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 03:34:38 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 03:34:38 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 03:34:38 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 03:34:38 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 03:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:34:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:34:38 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 03:34:38 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 03:34:38 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 03:34:38 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 03:34:38 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 03:34:38 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 03:34:38 INFO - Downloading docopt-0.6.1.tar.gz 03:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:34:39 INFO - Installing collected packages: blobuploader, requests, docopt 03:34:39 INFO - Running setup.py install for blobuploader 03:34:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:34:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:34:39 INFO - Running setup.py install for requests 03:34:39 INFO - Running setup.py install for docopt 03:34:39 INFO - Successfully installed blobuploader requests docopt 03:34:39 INFO - Cleaning up... 03:34:39 INFO - Return code: 0 03:34:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:39 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 0x7f53787c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1c0>, '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 0x26fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fe550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', '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 03:34:39 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 03:34:39 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 03:34:39 INFO - Using env: {'DISPLAY': ':0', 03:34:39 INFO - 'HOME': '/home/cltbld', 03:34:39 INFO - 'LANG': 'en_US.UTF-8', 03:34:39 INFO - 'LANGUAGE': 'en_US:en', 03:34:39 INFO - 'LOGNAME': 'cltbld', 03:34:39 INFO - 'MAIL': '/var/mail/cltbld', 03:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:39 INFO - 'MOZ_NO_REMOTE': '1', 03:34:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:39 INFO - 'NO_EM_RESTART': '1', 03:34:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:39 INFO - 'PWD': '/builds/slave/test', 03:34:39 INFO - 'SHELL': '/bin/bash', 03:34:39 INFO - 'SHLVL': '1', 03:34:39 INFO - 'TERM': 'linux', 03:34:39 INFO - 'TMOUT': '86400', 03:34:39 INFO - 'USER': 'cltbld', 03:34:39 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', 03:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:39 INFO - '_': '/tools/buildbot/bin/python'} 03:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:39 INFO - Running setup.py (path:/tmp/pip-ScFSo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:39 INFO - Running setup.py (path:/tmp/pip-pwDz8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:39 INFO - Running setup.py (path:/tmp/pip-MmY7eZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:40 INFO - Running setup.py (path:/tmp/pip-QubV4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:40 INFO - Running setup.py (path:/tmp/pip-SaRXKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:40 INFO - Running setup.py (path:/tmp/pip-_xCwSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:40 INFO - Running setup.py (path:/tmp/pip-zXdLZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:40 INFO - Running setup.py (path:/tmp/pip-H3Ekaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:40 INFO - Running setup.py (path:/tmp/pip-4YSYi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:40 INFO - Running setup.py (path:/tmp/pip-TJ_5CC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:40 INFO - Running setup.py (path:/tmp/pip-l7YZ3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:40 INFO - Running setup.py (path:/tmp/pip-Djrek_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:40 INFO - Running setup.py (path:/tmp/pip-G05Ntv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:40 INFO - Running setup.py (path:/tmp/pip-eX5w1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:40 INFO - Running setup.py (path:/tmp/pip-mnfp62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:40 INFO - Running setup.py (path:/tmp/pip-TvlTDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:40 INFO - Running setup.py (path:/tmp/pip-kXo6jF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:34:41 INFO - Running setup.py install for manifestparser 03:34:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:34:41 INFO - Running setup.py install for mozcrash 03:34:41 INFO - Running setup.py install for mozdebug 03:34:41 INFO - Running setup.py install for mozdevice 03:34:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:34:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:34:41 INFO - Running setup.py install for mozfile 03:34:41 INFO - Running setup.py install for mozhttpd 03:34:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:34:41 INFO - Running setup.py install for mozinfo 03:34:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:34:41 INFO - Running setup.py install for mozInstall 03:34:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:34:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:34:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:34:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:34:41 INFO - Running setup.py install for mozleak 03:34:41 INFO - Running setup.py install for mozlog 03:34:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:34:42 INFO - Running setup.py install for moznetwork 03:34:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:34:42 INFO - Running setup.py install for mozprocess 03:34:42 INFO - Running setup.py install for mozprofile 03:34:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:34:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:34:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:34:42 INFO - Running setup.py install for mozrunner 03:34:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:34:42 INFO - Running setup.py install for mozscreenshot 03:34:42 INFO - Running setup.py install for moztest 03:34:42 INFO - Running setup.py install for mozversion 03:34:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:34:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:34:42 INFO - Cleaning up... 03:34:42 INFO - Return code: 0 03:34:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:42 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 0x7f53787c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1c0>, '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 0x26fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fe550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', '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 03:34:42 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 03:34:42 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 03:34:42 INFO - Using env: {'DISPLAY': ':0', 03:34:42 INFO - 'HOME': '/home/cltbld', 03:34:42 INFO - 'LANG': 'en_US.UTF-8', 03:34:42 INFO - 'LANGUAGE': 'en_US:en', 03:34:42 INFO - 'LOGNAME': 'cltbld', 03:34:42 INFO - 'MAIL': '/var/mail/cltbld', 03:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:42 INFO - 'MOZ_NO_REMOTE': '1', 03:34:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:42 INFO - 'NO_EM_RESTART': '1', 03:34:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:42 INFO - 'PWD': '/builds/slave/test', 03:34:42 INFO - 'SHELL': '/bin/bash', 03:34:42 INFO - 'SHLVL': '1', 03:34:42 INFO - 'TERM': 'linux', 03:34:42 INFO - 'TMOUT': '86400', 03:34:42 INFO - 'USER': 'cltbld', 03:34:42 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', 03:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:42 INFO - '_': '/tools/buildbot/bin/python'} 03:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:43 INFO - Running setup.py (path:/tmp/pip-D7gzLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:43 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)) 03:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:43 INFO - Running setup.py (path:/tmp/pip-HSteXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:43 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)) 03:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:43 INFO - Running setup.py (path:/tmp/pip-G1742M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:43 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)) 03:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:43 INFO - Running setup.py (path:/tmp/pip-QNPKtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:43 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)) 03:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:43 INFO - Running setup.py (path:/tmp/pip-uDBjTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:43 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)) 03:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:43 INFO - Running setup.py (path:/tmp/pip-ch6PIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:43 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)) 03:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:43 INFO - Running setup.py (path:/tmp/pip-QpeAYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:43 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)) 03:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:43 INFO - Running setup.py (path:/tmp/pip-tZDKxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:43 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)) 03:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:43 INFO - Running setup.py (path:/tmp/pip-Y_tMBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:43 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)) 03:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:43 INFO - Running setup.py (path:/tmp/pip-rKE2JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:43 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)) 03:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:43 INFO - Running setup.py (path:/tmp/pip-etMOic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:43 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)) 03:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:43 INFO - Running setup.py (path:/tmp/pip-xnjqKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:43 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)) 03:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:43 INFO - Running setup.py (path:/tmp/pip-f_cYDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:44 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)) 03:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:44 INFO - Running setup.py (path:/tmp/pip-TLsKKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:44 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)) 03:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:44 INFO - Running setup.py (path:/tmp/pip-QNgpNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:44 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)) 03:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:44 INFO - Running setup.py (path:/tmp/pip-rxRhPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:44 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)) 03:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:44 INFO - Running setup.py (path:/tmp/pip-LvqNRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:44 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)) 03:34:44 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)) 03:34:44 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)) 03:34:44 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)) 03:34:44 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)) 03:34:44 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)) 03:34:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:44 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 03:34:44 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 03:34:44 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 03:34:44 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 03:34:44 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 03:34:44 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 03:34:46 INFO - Downloading blessings-1.6.tar.gz 03:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:34:46 INFO - Installing collected packages: blessings 03:34:46 INFO - Running setup.py install for blessings 03:34:46 INFO - Successfully installed blessings 03:34:46 INFO - Cleaning up... 03:34:46 INFO - Return code: 0 03:34:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:34:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:46 INFO - Reading from file tmpfile_stdout 03:34:46 INFO - Current package versions: 03:34:46 INFO - argparse == 1.2.1 03:34:46 INFO - blessings == 1.6 03:34:46 INFO - blobuploader == 1.2.4 03:34:46 INFO - docopt == 0.6.1 03:34:46 INFO - functools32 == 3.2.3-2 03:34:46 INFO - jsonschema == 2.5.1 03:34:46 INFO - manifestparser == 1.1 03:34:46 INFO - mozInstall == 1.12 03:34:46 INFO - mozcrash == 0.17 03:34:46 INFO - mozdebug == 0.1 03:34:46 INFO - mozdevice == 0.48 03:34:46 INFO - mozfile == 1.2 03:34:46 INFO - mozhttpd == 0.7 03:34:46 INFO - mozinfo == 0.9 03:34:46 INFO - mozleak == 0.1 03:34:46 INFO - mozlog == 3.2 03:34:46 INFO - moznetwork == 0.27 03:34:46 INFO - mozprocess == 0.22 03:34:46 INFO - mozprofile == 0.28 03:34:46 INFO - mozrunner == 6.11 03:34:46 INFO - mozscreenshot == 0.1 03:34:46 INFO - mozsystemmonitor == 0.3 03:34:46 INFO - moztest == 0.7 03:34:46 INFO - mozversion == 1.4 03:34:46 INFO - psutil == 3.1.1 03:34:46 INFO - requests == 1.2.3 03:34:46 INFO - wsgiref == 0.1.2 03:34:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:46 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 0x7f53787c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1c0>, '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 0x26fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fe550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', '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 03:34:46 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 03:34:46 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 03:34:46 INFO - Using env: {'DISPLAY': ':0', 03:34:46 INFO - 'HOME': '/home/cltbld', 03:34:46 INFO - 'LANG': 'en_US.UTF-8', 03:34:46 INFO - 'LANGUAGE': 'en_US:en', 03:34:46 INFO - 'LOGNAME': 'cltbld', 03:34:46 INFO - 'MAIL': '/var/mail/cltbld', 03:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:46 INFO - 'MOZ_NO_REMOTE': '1', 03:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:46 INFO - 'NO_EM_RESTART': '1', 03:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:46 INFO - 'PWD': '/builds/slave/test', 03:34:46 INFO - 'SHELL': '/bin/bash', 03:34:46 INFO - 'SHLVL': '1', 03:34:46 INFO - 'TERM': 'linux', 03:34:46 INFO - 'TMOUT': '86400', 03:34:46 INFO - 'USER': 'cltbld', 03:34:46 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', 03:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:46 INFO - '_': '/tools/buildbot/bin/python'} 03:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:46 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)) 03:34:46 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)) 03:34:46 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)) 03:34:46 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)) 03:34:46 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)) 03:34:46 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)) 03:34:46 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)) 03:34:46 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)) 03:34:46 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)) 03:34:46 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)) 03:34:46 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)) 03:34:46 INFO - Cleaning up... 03:34:46 INFO - Return code: 0 03:34:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:46 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 0x7f53787c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1c0>, '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 0x26fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fe550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', '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 03:34:46 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 03:34:46 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 03:34:46 INFO - Using env: {'DISPLAY': ':0', 03:34:46 INFO - 'HOME': '/home/cltbld', 03:34:46 INFO - 'LANG': 'en_US.UTF-8', 03:34:46 INFO - 'LANGUAGE': 'en_US:en', 03:34:46 INFO - 'LOGNAME': 'cltbld', 03:34:46 INFO - 'MAIL': '/var/mail/cltbld', 03:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:46 INFO - 'MOZ_NO_REMOTE': '1', 03:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:46 INFO - 'NO_EM_RESTART': '1', 03:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:46 INFO - 'PWD': '/builds/slave/test', 03:34:46 INFO - 'SHELL': '/bin/bash', 03:34:46 INFO - 'SHLVL': '1', 03:34:46 INFO - 'TERM': 'linux', 03:34:46 INFO - 'TMOUT': '86400', 03:34:46 INFO - 'USER': 'cltbld', 03:34:46 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', 03:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:46 INFO - '_': '/tools/buildbot/bin/python'} 03:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:34:47 INFO - Cleaning up... 03:34:47 INFO - Return code: 0 03:34:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53787c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x266e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fd1c0>, '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 0x26fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fe550>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', '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 03:34:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:34:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:34:47 INFO - Using env: {'DISPLAY': ':0', 03:34:47 INFO - 'HOME': '/home/cltbld', 03:34:47 INFO - 'LANG': 'en_US.UTF-8', 03:34:47 INFO - 'LANGUAGE': 'en_US:en', 03:34:47 INFO - 'LOGNAME': 'cltbld', 03:34:47 INFO - 'MAIL': '/var/mail/cltbld', 03:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:47 INFO - 'MOZ_NO_REMOTE': '1', 03:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:47 INFO - 'NO_EM_RESTART': '1', 03:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:47 INFO - 'PWD': '/builds/slave/test', 03:34:47 INFO - 'SHELL': '/bin/bash', 03:34:47 INFO - 'SHLVL': '1', 03:34:47 INFO - 'TERM': 'linux', 03:34:47 INFO - 'TMOUT': '86400', 03:34:47 INFO - 'USER': 'cltbld', 03:34:47 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', 03:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:47 INFO - '_': '/tools/buildbot/bin/python'} 03:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:47 INFO - Downloading/unpacking flake8 03:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:34:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:34:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:34:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:34:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:34:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:34:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:34:49 INFO - no previously-included directories found matching 'docs/_build' 03:34:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:34:49 INFO - Running setup.py install for pep8 03:34:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:34:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:34:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:34:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:34:50 INFO - no previously-included directories found matching 'docs/_build' 03:34:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:34:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:34:50 INFO - Cleaning up... 03:34:50 INFO - Return code: 0 03:34:50 INFO - Running post-action listener: _resource_record_post_action 03:34:50 INFO - Running post-action listener: _start_resource_monitoring 03:34:50 INFO - Starting resource monitoring. 03:34:50 INFO - ##### 03:34:50 INFO - ##### Finished create-virtualenv step (success) 03:34:50 INFO - ##### 03:34:50 INFO - ##### 03:34:50 INFO - ##### Running install step. 03:34:50 INFO - ##### 03:34:50 INFO - Running pre-action listener: _resource_record_pre_action 03:34:50 INFO - Running main action method: install 03:34:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:50 INFO - Reading from file tmpfile_stdout 03:34:50 INFO - Detecting whether we're running mozinstall >=1.0... 03:34:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:34:50 INFO - Reading from file tmpfile_stdout 03:34:50 INFO - Output received: 03:34:50 INFO - Usage: mozinstall [options] installer 03:34:50 INFO - Options: 03:34:50 INFO - -h, --help show this help message and exit 03:34:50 INFO - -d DEST, --destination=DEST 03:34:50 INFO - Directory to install application into. [default: 03:34:50 INFO - "/builds/slave/test"] 03:34:50 INFO - --app=APP Application being installed. [default: firefox] 03:34:50 INFO - mkdir: /builds/slave/test/build/application 03:34:50 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'] 03:34:50 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 03:35:06 INFO - Reading from file tmpfile_stdout 03:35:06 INFO - Output received: 03:35:06 INFO - /builds/slave/test/build/application/firefox/firefox 03:35:06 INFO - Running post-action listener: _resource_record_post_action 03:35:06 INFO - ##### 03:35:06 INFO - ##### Finished install step (success) 03:35:06 INFO - ##### 03:35:06 INFO - ##### 03:35:06 INFO - ##### Running run-tests step. 03:35:06 INFO - ##### 03:35:06 INFO - Running pre-action listener: _resource_record_pre_action 03:35:06 INFO - Running main action method: run_tests 03:35:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:06 INFO - Python 2.7.3 03:35:06 INFO - Return code: 0 03:35:06 INFO - grabbing minidump binary from tooltool 03:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:06 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 0x26fd1c0>, '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 0x26fe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fe550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:06 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 03:35:06 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 03:35:06 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 03:35:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:06 INFO - Return code: 0 03:35:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:35:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:35:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:35:07 INFO - Return code: 0 03:35:07 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/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 03:35:07 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/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 03:35:07 INFO - Using env: {'DISPLAY': ':0', 03:35:07 INFO - 'HOME': '/home/cltbld', 03:35:07 INFO - 'LANG': 'en_US.UTF-8', 03:35:07 INFO - 'LANGUAGE': 'en_US:en', 03:35:07 INFO - 'LOGNAME': 'cltbld', 03:35:07 INFO - 'MAIL': '/var/mail/cltbld', 03:35:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:07 INFO - 'MOZ_NO_REMOTE': '1', 03:35:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:07 INFO - 'NO_EM_RESTART': '1', 03:35:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:07 INFO - 'PWD': '/builds/slave/test', 03:35:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:07 INFO - 'SHELL': '/bin/bash', 03:35:07 INFO - 'SHLVL': '1', 03:35:07 INFO - 'TERM': 'linux', 03:35:07 INFO - 'TMOUT': '86400', 03:35:07 INFO - 'USER': 'cltbld', 03:35:07 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241', 03:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:07 INFO - '_': '/tools/buildbot/bin/python'} 03:35:07 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/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 03:35:07 INFO - mozversion application_buildid: 20160703004921 03:35:07 INFO - mozversion application_changeset: 01f2dde06c5fd93b38c0d80b6028210b48dd3f4a 03:35:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:35:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:07 INFO - mozversion application_name: Firefox 03:35:07 INFO - mozversion application_remotingname: firefox-dev 03:35:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:35:07 INFO - mozversion application_vendor: Mozilla 03:35:07 INFO - mozversion application_version: 49.0a2 03:35:07 INFO - mozversion platform_buildid: 20160703004921 03:35:07 INFO - mozversion platform_changeset: 01f2dde06c5fd93b38c0d80b6028210b48dd3f4a 03:35:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:35:07 INFO - mozversion platform_version: 49.0a2 03:35:07 INFO - using testdate: 1467542107 03:35:07 INFO - actual date: 1467542107 03:35:07 INFO - starting webserver on 'localhost:40464' 03:35:07 INFO - SUITE-START | Running 2 tests 03:35:07 INFO - TEST-START | dromaeo_css 03:35:07 INFO - operating with platform_type : linux_ 03:35:07 INFO - Initialising browser for dromaeo_css test... 03:35:07 INFO - TEST-INFO | started process 4601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprZ_9og/profile http://localhost:40464/getInfo.html) 03:35:11 INFO - PROCESS | 4601 | __metrics Screen width/height:1600/1200 03:35:11 INFO - PROCESS | 4601 | colorDepth:24 03:35:11 INFO - PROCESS | 4601 | Browser inner width/height: 1024/697 03:35:11 INFO - PROCESS | 4601 | __metrics 03:35:12 ERROR - PROCESS | 4601 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:35:13 INFO - TEST-INFO | 4601: exit 0 03:35:13 INFO - Browser initialized. 03:35:13 INFO - Running cycle 1/1 for dromaeo_css test... 03:35:13 INFO - TEST-INFO | started process 4692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprZ_9og/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:25 INFO - PROCESS | 4692 | RSS: Main: 145522688 03:35:25 INFO - PROCESS | 4692 | 03:36:16 INFO - PROCESS | 4692 | 1467542176646 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] 03:38:24 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:40464/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40464/tests/dromaeo/cssquery-ext.html) 03:38:25 INFO - PROCESS | 4692 | RSS: Main: 256311296 03:38:25 INFO - PROCESS | 4692 | 03:41:28 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:40464/tests/dromaeo/cssquery-ext.html (next: http://localhost:40464/tests/dromaeo/cssquery-jquery.html) 03:41:28 INFO - PROCESS | 4692 | RSS: Main: 227758080 03:41:28 INFO - PROCESS | 4692 | 03:44:30 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:40464/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40464/tests/dromaeo/cssquery-mootools.html) 03:44:31 INFO - PROCESS | 4692 | RSS: Main: 232960000 03:44:31 INFO - PROCESS | 4692 | 03:47:33 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:40464/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40464/tests/dromaeo/cssquery-prototype.html) 03:47:34 INFO - PROCESS | 4692 | RSS: Main: 223625216 03:47:34 INFO - PROCESS | 4692 | 03:50:36 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:40464/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40464/tests/dromaeo/cssquery-yui.html) 03:50:37 INFO - PROCESS | 4692 | RSS: Main: 218112000 03:50:37 INFO - PROCESS | 4692 | 03:53:39 INFO - PROCESS | 4692 | Cycle 1(1): loaded http://localhost:40464/tests/dromaeo/cssquery-yui.html (next: http://localhost:40464/tests/dromaeo/cssquery-dojo.html) 03:53:40 INFO - PROCESS | 4692 | RSS: Main: 258183168 03:53:40 INFO - PROCESS | 4692 | 03:53:40 INFO - PROCESS | 4692 | __start_tp_report 03:53:40 INFO - PROCESS | 4692 | _x_x_mozilla_page_load 03:53:40 INFO - PROCESS | 4692 | _x_x_mozilla_page_load_details 03:53:40 INFO - PROCESS | 4692 | |i|pagename|runs| 03:53:40 INFO - PROCESS | 4692 | |0;dojo.html;3428.3314753623044;3453.343864665713;3458.377492051431;3473.826308684565;3504.6495350464957;5673.120666296725;5751.453611906867;5757.222774925383;5774.307083150017;5775.624584402011;5707.4577915098;5776.39347868473;5781.277340332458;5782.653040817554;5789.334226563947;5046.621503387242;5179;5207.505286997748;5285.550728188108;5302.6023048271345;5108.4125325587665;5217.087009773293;5254.080535906221;5256.053910296145;5261.1319132343115;5159.432462429129;5192.065428222937;5206.635535512516;5216.374035115791;5218.269442278084;5314.893702125955;5323.307969963918;5331.280277162592;5335.359756829205;5362.624616276862;5034.043531728959;5088.542031217208;5121.718305493234;5221;5224.111900976843;5549.223108764776;5587.245721827582;5593;5602.299712535933;5637.126245431965;6042.758289668408;6091.695415229266;6093.268807743055;6094.6952652367645;6098.756049758004;6065.4844338231305;6076.239324751655;6089.718063077438;6101.51187904971;6154.661493617849;5749.166370876242;5792.739326730307;5798.507126894219;5798.652080875161;5805.36141024487;6096;6296.5592408531875;6303.558750887394;6303.621782693053;6305.180326557518;5998.040313549811;6047.576669633171;6054.939450605526;6098.4343605148715;6098.749756299948;6212.658303793244;6214.9689251554355;6218.036204388327;6218.595791273553;6222.191115155001;5907.409259074058;6035.637861728311;6176.166217560662;6177.96911015451;6179.660118693515;6078.270607527125;6141.977005061692;6142.038385241494;6145.801568694062;6145.846353841101;4646.697964632288;4687.789049492781;4691.601213896857;4710.623150148049;4718.174319494144;4112.485939257593;4122.031322639177;4155.252054630135;4199.643030342394;4212.641925436372;5906.114082887601;5911.083782013795;5911.852203694856;5912.615679980873;5930.436608522184;6159.784407545714;6200.100985357189;6201;6211.130441738161;6217.160683307786;5717.571182161271;5768.971155144198;5809.186713860063;5813.59304848665;5917.112433135064;5289.021531016774;5290.867728306746;5290.867728306823;5291.312129423227;5292.52367286946;6315.494760419156;6335.493160547145;6337.207849018965;6341.492680585542;6344.651044192614;6016.548758843017;6093.146959425772;6127.111568822585;6134.987697083834;6203.069539569101;6408.455281301141;6414.550981431255;6424.261209960728;6431.067495213074;6431.742730290923;5904.143899134688;6123.663198524124;6133.938660613337;6134.447899689049;6139.079138129137;5964.761409543569;5970.432808883149;6007.339192688713;6064;6068.908966365596;5917.615355001911;5932.584719069624;5933.347331793413;5934.9406505934385;5937.109433584997;5751.309842818889;5849.707514624167;5919.763209471573;5923.052311630118;5923.318818335946;5852.619579727474;5913.6747478887355;5915.40845915405;5952.375000624872;5980.222571065734;6013;6049.481245011831;6074.892107125429;6094.177286066324;6104.236970378703;5732.226149469769;5778;5794.5364370851075;5910.881782364415;5921.5558833086825 03:53:40 INFO - PROCESS | 4692 | |1;ext.html;607.2773399654411;646.1987135951421;659.3735950846694;666.1040899989514;681.2472218198888;35917.64082359179;47584;48364.51635483653;48456.515434845685;52030.73984630081;48797;49266.50733492664;49283;49322.260166097534;49332;8395.076541580453;9067.410618309805;9206.401583897059;10903.727406814814;11185.496652650609;10619.044286014258;11102;11103.72240693981;11106.555737770479;11107.166962477806;11136.888631113707;11238.943805280962;11240.662780116569;11240.775184496306;11246.156538259622;8454.74635760925;10816.242862999594;11027.61403350879;11072;11366.602168924132;11044.558217671283;11130.554777808959;11147.108231341474;11148.052415544607;11151.219414640978;46032.53967460316;46247.30629040567;46374;46449;46567.767161163974;3811.0091376242376;4015.959840401588;4239.59723826236;4262.318029115358;4627.467841198238;36418.81790591057;36633.45049824255;36916.261674766356;37245.441318380246;37380.252394951945;4700.1539722849875;4749.905001899977;4876.512348765095;4933.629977751647;4965.82619608312;392865;399792;400078;400950;401259;71189;72282;72456.63771681108;72513.2748672517;72557.6372118136;37844;38327.23345533074;38367;38399.232015359536;77465;16934.661306773796;18109.275628974694;18129.546761331072;18130.09349532518;18190.363337283397;13808.861911380958;14184.290785460893;14195.645108872155;14474.927625361806;14504.564863054125;22694.773052269597;22738.886305568365;22777.88611056934;22795.544089118124;22798.31605051818;8126.512409255463;8199.590020498952;8331.583840686255;8348.749537513884;8455.95772021136;1050.8318669012922;1057.3338796558119;1088.9237753357347;1098.747288123736;1158.5887010111458;34499;34636.30727385489;34852.30295394129;34902.476462853076;35178.29643407118;1131.9886801131884;1176.4705882352976;1195.9162858599989;1258.4148371007525;1273.6752128207247;16867.254794031393;17147.828521714873;17629.647407052045;17657.38199163023;17665.82334176642;613957;618046;621203;621558;622422;64011;64322;64336.35663643397;64438.67780661066;64588.67705661442;1374.6219789557952;1418.7091646212707;1466.911985280865;1483.4807817264086;1507.216247551267;31100.82294239472;35522.28955420929;35525.82237088798;35765.64234357623;36089.81955090313;53826.461735382145;54628.45371546234;54748.72625636846;54839.177412338046;54975.450245497035;430472;435706;436623;437265;438072;30712.846435768573;32141.839290803397;32190.67809321877;32254;32285.51571726379;51366.74316628393;53148.2027769576;53763;53859.461405385446;54035.729821350644;44205.55794442143;44369.55630443654;44583.33125003063;45309.32036019397;48158.759206203744;45333.78661453843;46177.30734038925;46692.53307466882;47233;47338.763306183246;45569;46397;46428;47324.52675473201;47372.7631361841;39562.2087558253;41010.384844227956;41303;41316.07442655177;41728;30352.84823575868;30747.562729742833;30812.53781193329;31153.8442307787;31165.376692466478 03:53:40 INFO - PROCESS | 4692 | |2;jquery.html;428.2420116393983;428.3125583438583;428.49009678482605;439.8306651939005;446.8570057581575;18675.346362877284;19735.605287894232;20094.296699615497;21295.68056479154;21314.680279795775;16606.83393166068;18665.440036798886;19461.416157515298;19559.608807823835;19860.70208946867;5192.350956130493;5399.244105825188;5453.318335208099;5464.6994415307145;5465.453454654543;3974.503187101612;4771.832985845496;5318.9202161967405;5325.600579956499;6463.289038205794;6370.6177629342155;6483.319251478598;6509.088727578142;6544.0511125886715;6556.934430655704;5799.88400231993;5939.762409503658;5965.701714914258;6179.845503862417;6464.644444555547;3918.4318273850417;4128.896777580554;4132.876013719563;5744.511716504102;5757.942420575782;26142;27264.863675681692;28985.710142898723;29237.70762292371;29588.112356629335;2636.49906517761;2676.464707058596;2729.249456399506;2826.844523551204;2845.260232339586;15754.606134846606;15855.52433426999;16332.265048072746;16627.667446650998;16849.83150168495;2118.396257066744;2163.253677481282;2205.59196548639;2219.0679914435814;2272.2047283450825;64013.67993160051;72120;74062.62968685175;80817;84702.57648711717;16781.496555103367;18219.90890045541;19135.617287654168;19153.904230478758;19160;34936.825315873764;35390.46914296287;35398.82300588532;35758.64241357605;35805;10358.741031474123;10378.532966016548;10583.735406614896;10981.505832237568;11140.554377824958;8911.688090916787;9064.54677266134;9080.500572468445;9084.727458176265;9214.953925230331;9313.441193528275;9405.341626086245;9520.714378568655;9651.806963860683;9659.71020869375;3042.710942460463;3431.519587257786;3579.8926032219074;3587.157018100744;3685.3182161300247;972.3873959405529;1046.7121541575975;1058.878229003659;1084.4686103809076;1174.5595401724354;19537.706934395996;19743.703844442345;20874.165033398494;21289.59061170829;21306.254281100086;1030.8711411073616;1038.5897570459776;1063.622414043019;1079.9730006749894;1083.983740243897;10958.342499450058;11241.943790280997;11289.435528223721;11293.491792869341;11300.491477883515;506499;533274;538201;543838;544701;102308;102441.63994002635;103185;104866.47566762117;105068;1119.4514687802919;1121.315997241682;1153.411760002405;1157.8726340102583;1159;17527.298908043536;17629.03040332794;17737.556561086076;17840;17884.10579470995;42692.78653606712;43163.35254971115;43380.78309608432;44125.77937110294;45245.77377113093;55459.445405545426;61525.69237153786;62937.685311574984;64334.03498947613;64356.67821660862;8346.081930987466;9129.224015958718;9320.860187097334;9366.297527685314;9404.811903761749;10644.946775266075;13916.860831391961;14020;14158.362873670503;14221.644458888197;12314.199577027464;12348.938255308665;12425.565105221274;12587.433565489759;12655.11414201034;5825.126231065374;11009.394483303495;12220.75558488843;12280.789457897665;12326.691832703895;12556.86988171069;12616.053795965156;12649.87350126487;12736.23582585048;12795.42420591057;8903.154200350957;8928.642854285756;9179.357444978787;9325.813483730151;9360.11078947499;11495.022923051634;12388.938055309665;12426.378681066091;12507.374631268582;12543.12198146121 03:53:40 INFO - PROCESS | 4692 | |3;mootools.html;1417.411774113743;1597.512758608624;1624.5370069530184;1823.6535058338923;1934.2166422598843;9207.493587852665;9544.427334359943;9575.473348965805;9761;9800.901990980106;9474.573644186012;9665.275104367183;9670;9686.951565242163;9712.85430718538;2158.438805910459;2416.250962201714;2464.2484042367028;2500.0749722602663;2501.8248722589424;2516.19481765835;2535.1887396033185;2551.311145990591;2560.0783717861555;2560.987195064022;2489.0914816092086;2509.0841842727455;2510.5104504621604;2512.849229046263;2513.28371414147;2090.4982804127053;2439.2682195341417;2500.9874950625313;2501.187114187878;2507.6865391826022;2325.383773300077;2345.2260753951327;2345.7419683834764;2347.882605869717;2349.847259928099;9719;9784.168345690625;9788.168005719523;9803.117719405216;9891.90108098917;5710.942890571083;5877.882442351171;5883.79406720767;5885.646861188342;5887.293524777011;3447.5690538682666;3508.614052454228;3546.2730140321432;3693.2244228712;3699.9815000924823;1200.6758175292623;1237.876212378764;1253.4547471849774;1261.249556513882;1273.6624794429483;13953;13958.930205348908;14002.439902403892;14006.719865602732;14011.859881401055;5063.088644044107;5070.7464626768515;5162.6128040397125;5171.50870667286;5191.714455704972;11767.76464470723;11831.112666550043;11853.525858965544;11868.643940681794;11876.703082422835;5341.465853414705;5831.88336233273;5848.415158484203;5852.297724273029;5860.619059761102;4875.293082503017;4928.778204980785;5214;5316.548093412026;5346.705931173823;4400.9119817604105;4419.911601768011;4477.6417886569;4500.774961251925;4513.368128462018;1387.8750912417931;1425.7861320801755;1433.9139651620728;1437.8705916467568;1449.3333066789396;939.5771902643701;970.7815741458256;976.9804603908024;979.2019504104132;988.8566157907063;6056.9697151513965;6151.3541078186145;6163.7842675506145;6175.104609831639;6335.208098987627;482.351237585447;493.979931441572;500.7796569509404;502.2140350351688;502.2566601429904;4246.617804397619;4263.850765223202;4344.804483798237;4407.955920440754;4420.557944205554;12062;12514.687132821753;12556.309402982924;12585.496580136874;12592.496300148076;11578.76842463163;12205.45075471606;12297;12375.566855160207;12389.256644601353;8706.95646521776;9008.774780630536;9022;9046.909530904606;9069.31980101495;6343.52423568225;6481.708323125376;6491.870162596816;6593.604383736991;6610.338966103352;11013.504392302526;11425.657230283105;11506.827397588875;11508.88491115078;11658.417079146178;11662.94168529152;11685.824712629488;11783.587574434854;11787.469563869818;11806.763864722829;8320.959880014998;8419.789505262417;8530.445521041112;8628.309735221043;8659.740207793777;9362.531873406166;9435;9453.716388508356;9474.005229451084;9555.952220238854;8349.457285276438;8557.272631826365;8572.957135214285;8624.827503449771;8722.08418116114;8335;8336.541490218096;8337.833243334979;8366.581670916552;8475.957620212106;7487.8876816846705;7489.400847932261;7568.091828980558;7575.659095340833;7581.962090189514;5394.271773310553;5420.457954204548;5483.698396588226;5564.109742441352;5592.133219351007;5319.6808191508635;5340.759665815125;5421.728913554385;5462.016836969384;5473.124300111963 03:53:40 INFO - PROCESS | 4692 | |4;prototype.html;343.91230236289744;344.2838895098196;349.1062879029686;352.6244549554726;354.43113802347233;5476.233327334171;5545.473180047889;5556.361018482876;5557.972210138949;5579.274694289747;5485.945140548603;5497.5601951843855;5518.310211223597;5536.197251398545;5536.916946245809;3886.8250928708135;4096.610821971908;4265.850695225668;4292.763897985609;4303.35449682547;4236.258654735424;4258.5954334338185;4276.016516201275;4285.721428107178;4288.69979101463;4051.2910240707756;4247.723897946639;4271.402003719481;4299.591538803808;4306.224879521685;4196.244675958326;4265.701400901922;4266.743995360288;4271.786410679485;4281.443412356373;3805.2579746949355;3817.2938006468894;3839.9808000960097;3851.480050193244;3867.149227170018;5273.129933560957;5282.498162674539;5288.365396152448;5306.7611957462;5335.839924802262;4932.926006109911;4942.9258561121615;4951.480094590052;4964.379452568429;4975.179095449246;5443.482869127466;5618.522425593829;5660.235868157787;5703.144528320744;5746.454086861741;4009.639132478091;4087.2234275487563;4122.628963393279;4209.873703788891;4221.134667393208;5852.531797456193;5931.317898441648;5932.495737862287;5945.394743419252;5976.850578735566;4090.427340172378;4237.152569486115;4240.448741663564;4275.593818587229;4298.356510745869;4328;4343.782810859444;4345.435093437896;4351.782410879443;4352.521222665504;4906.460289368167;4924.261360795909;4934.407871055425;4946.752662366867;4947.82682606107;5493.48929044516;5786.537077033827;5808.3901190375245;5811.767529298865;5821.825345239649;1500.5873384819263;1509.871660908813;1517.4157949189641;1519.8100237470317;1520.4754359746091;964.81668482988;980.6616717232544;983.2822039910762;989.2531138990016;991.5438898106808;4996.475370086161;5020.497950205024;5025.597952163818;5060.974695126501;5079.72061536619;5181.5077567631015;5214.45248248936;5219.42586315505;5219.765110570033;5227.294315267466;4954.232094025359;5002.224655178453;5058.241263810384;5277.656952298088;5766.336871259775;3153.921151971219;3159;3160.8893688720786;3179.6184457865206;3189.569408129873;6136.110264011782;6140.815775526741;6178.196834411498;6179.81460556184;6193.225846769154;5723.885522289531;6045.939540604626;6073.301570319381;6093.451589356979;6096.481799047131;5895.764169433174;6016.969915150396;6151.108089327023;6153.2616086069065;6170.568060235741;5917.881642367214;5936.079907614327;5964.701764911824;5968.463403053772;5985.790497332572;5830.871731817771;5839.445252700986;5840.766369345179;5841.591088623755;5860.413958604106;5961.225040744675;6123.418275263843;6131.283240692614;6132.589504414099;6138.723757431016;4149.958500414958;4171.728837625545;4190.958090419179;4194.706370554032;4211.347241177622;5769.701817091121;5812.447817457335;5893.941060589339;5919.230500034968;5952.464278214981;5755.251817263729;5756.71216439168;5790.884182316246;5797.565182611237;5807.041838096836;5641.915371269352;5716.314042314949;5718.370979192202;5738.598298119092;5772.682502462237;5502.972485137549;5606.103023516381;5671.517920976598;5680.176374425602;5696.829095127153;5763.769449221984;5768.6925229908375;5787.421257874179;5797.246357973437;5807.216025836458;5440.211169380497;5659.688717120598;5676.318841739017;5678.801241956512;5682.573806964577 03:53:40 INFO - PROCESS | 4692 | |5;yui.html;863.1239292118499;888.5246393179642;894.2979760887705;906.1391677905987;908.0919080919083;14359.928200358996;14710.63223419415;14908.62728431787;14909.925450372733;15107.471238506654;16005.83994160061;16756.748648770248;16770.916145419254;17349.7397539037;17362;730.9926900731004;852.9147085291452;869.9478031318109;874.2656168818191;876.2114097312437;869.6956065377099;875.0811647769848;877.3814460805149;879.7932485865816;880.5113162194979;917.4862077236735;922.8108237811233;924.9676261330854;927.508420537113;931.4783721116163;764.1708746010585;781.3866115099648;901.5672477210976;918.1644703319947;924.16824857628;670.7887015590122;672.0691841799095;673.8315421144714;674.1034424215782;674.308833445722;14830.851691483054;14902.925485372503;14936.551903442805;14938.32777525014;14942.70114597702;15535.300911458899;16141.596460088474;16491.09298988555;16544.75182872258;16571.17144142788;13357.732845343038;14071.50749723765;14296.92851535746;14412.207328596924;14606.19665918374;4735.289706544011;4735.857924262244;4766.38037055184;4829.10661527615;4858.951410485885;67594;69611.30388696099;69995.30004699939;79158.20841791623;80031.59984200042;13023.283719395524;13320.134191277535;13394.732105358033;13532.120412173177;13700.3834827433;24466;24495.755042449702;24605.261842144766;24645.753542464703;24646.753532464445;9706.320557561045;9742.95128524353;9826.852597211047;10086.546105425126;10089.596416143419;5197.948020519822;5281.894362112736;5291.444398338119;5509;5580.358258800209;4165.083681590046;4363.345498175299;4389.4513185851765;4449.510553839075;4457.64338852891;719.8380364418069;728.1880703016204;735.9080114985627;747.5049900199601;753.3558807219857;777.8872063550754;786.3512602103174;794.2057942057942;796.4619281304407;802.5906787538397;10293.073623373932;10818.567257309776;10843;10886.346819190874;10984.725381865517;620.602814198913;736.9940031856478;737.3511310047231;747.6000339818171;765.6937225109889;4237.978810105929;4240.194363071007;4274.893127671771;4379.4525684289465;4403.207422663887;95417.522912385;96901;98080;104485.47757261165;105257;91960;94434.5278273618;94880;95136;96945.51527242319;87003.56498217594;87054.56472717595;87551;89024;91340.54329728441;10383.169346452416;10449.68650940473;10485.842712359474;10507.632232871812;10690.305130166826;49626.75186624044;49920.25119623281;49941.25088123608;50577.74711126568;50828.237576437125;70803;71457.28542714714;72722.63638681773;72792.27207728066;76073.23926760661;13321.333933303102;13572.253526056162;13703.725925481634;13762;13851.376688049264;14869;15317;15384.230788460309;15629.843701562839;15929.761053584438;14845.628859278604;14928.776068358766;14951.925240373728;15053.6989260212;15098;14347.497837575635;14745.557633271019;14791.408343666133;14835.554933352018;14854.480093196686;14003;14208.502702405367;14367.784483232968;14524;14630.926845365704;11420.828687569527;11879;12435.875641243472;12502.499900003899;12532.937335313265;12336.136470446983;12476.09871045385;12529.561465348668;12641.304728239667;12654.240745555297 03:53:40 INFO - PROCESS | 4692 | __end_tp_report 03:53:40 INFO - PROCESS | 4692 | __start_cc_report 03:53:40 INFO - PROCESS | 4692 | _x_x_mozilla_cycle_collect,915 03:53:40 INFO - PROCESS | 4692 | __end_cc_report 03:53:40 INFO - PROCESS | 4692 | __startTimestamp1467543220022__endTimestamp 03:53:40 INFO - PROCESS | 4692 | 03:53:40 INFO - PROCESS | 4692 | ------- Summary: start ------- 03:53:40 INFO - PROCESS | 4692 | Number of tests: 6 03:53:40 INFO - PROCESS | 4692 | 03:53:40 INFO - PROCESS | 4692 | [#0] dojo.html Cycles:165 Average:5698.64 Median:5913.67 stddev:632.79 (10.7%) stddev-sans-first:609.15 03:53:40 INFO - PROCESS | 4692 | Values: 3428.3 3453.3 3458.4 3473.8 3504.6 5673.1 5751.5 5757.2 5774.3 5775.6 5707.5 5776.4 5781.3 5782.7 5789.3 5046.6 5179.0 5207.5 5285.6 5302.6 5108.4 5217.1 5254.1 5256.1 5261.1 5159.4 5192.1 5206.6 5216.4 5218.3 5314.9 5323.3 5331.3 5335.4 5362.6 5034.0 5088.5 5121.7 5221.0 5224.1 5549.2 5587.2 5593.0 5602.3 5637.1 6042.8 6091.7 6093.3 6094.7 6098.8 6065.5 6076.2 6089.7 6101.5 6154.7 5749.2 5792.7 5798.5 5798.7 5805.4 6096.0 6296.6 6303.6 6303.6 6305.2 5998.0 6047.6 6054.9 6098.4 6098.7 6212.7 6215.0 6218.0 6218.6 6222.2 5907.4 6035.6 6176.2 6178.0 6179.7 6078.3 6142.0 6142.0 6145.8 6145.8 4646.7 4687.8 4691.6 4710.6 4718.2 4112.5 4122.0 4155.3 4199.6 4212.6 5906.1 5911.1 5911.9 5912.6 5930.4 6159.8 6200.1 6201.0 6211.1 6217.2 5717.6 5769.0 5809.2 5813.6 5917.1 5289.0 5290.9 5290.9 5291.3 5292.5 6315.5 6335.5 6337.2 6341.5 6344.7 6016.5 6093.1 6127.1 6135.0 6203.1 6408.5 6414.6 6424.3 6431.1 6431.7 5904.1 6123.7 6133.9 6134.4 6139.1 5964.8 5970.4 6007.3 6064.0 6068.9 5917.6 5932.6 5933.3 5934.9 5937.1 5751.3 5849.7 5919.8 5923.1 5923.3 5852.6 5913.7 5915.4 5952.4 5980.2 6013.0 6049.5 6074.9 6094.2 6104.2 5732.2 5778.0 5794.5 5910.9 5921.6 03:53:40 INFO - PROCESS | 4692 | 03:53:40 INFO - PROCESS | 4692 | [#1] ext.html Cycles:180 Average:66193.44 Median:400514.00 stddev:131081.62 (32.7%) stddev-sans-first:131356.84 03:53:40 INFO - PROCESS | 4692 | Values: 607.3 646.2 659.4 666.1 681.2 35917.6 47584.0 48364.5 48456.5 52030.7 48797.0 49266.5 49283.0 49322.3 49332.0 8395.1 9067.4 9206.4 10903.7 11185.5 10619.0 11102.0 11103.7 11106.6 11107.2 11136.9 11238.9 11240.7 11240.8 11246.2 8454.7 10816.2 11027.6 11072.0 11366.6 11044.6 11130.6 11147.1 11148.1 11151.2 46032.5 46247.3 46374.0 46449.0 46567.8 3811.0 4016.0 4239.6 4262.3 4627.5 36418.8 36633.5 36916.3 37245.4 37380.3 4700.2 4749.9 4876.5 4933.6 4965.8 392865.0 399792.0 400078.0 400950.0 401259.0 71189.0 72282.0 72456.6 72513.3 72557.6 37844.0 38327.2 38367.0 38399.2 77465.0 16934.7 18109.3 18129.5 18130.1 18190.4 13808.9 14184.3 14195.6 14474.9 14504.6 22694.8 22738.9 22777.9 22795.5 22798.3 8126.5 8199.6 8331.6 8348.7 8456.0 1050.8 1057.3 1088.9 1098.7 1158.6 34499.0 34636.3 34852.3 34902.5 35178.3 1132.0 1176.5 1195.9 1258.4 1273.7 16867.3 17147.8 17629.6 17657.4 17665.8 613957.0 618046.0 621203.0 621558.0 622422.0 64011.0 64322.0 64336.4 64438.7 64588.7 1374.6 1418.7 1466.9 1483.5 1507.2 31100.8 35522.3 35525.8 35765.6 36089.8 53826.5 54628.5 54748.7 54839.2 54975.5 430472.0 435706.0 436623.0 437265.0 438072.0 30712.8 32141.8 32190.7 32254.0 32285.5 51366.7 53148.2 53763.0 53859.5 54035.7 44205.6 44369.6 44583.3 45309.3 48158.8 45333.8 46177.3 46692.5 47233.0 47338.8 45569.0 46397.0 46428.0 47324.5 47372.8 39562.2 41010.4 41303.0 41316.1 41728.0 30352.8 30747.6 30812.5 31153.8 31165.4 03:53:40 INFO - PROCESS | 4692 | 03:53:40 INFO - PROCESS | 4692 | [#2] jquery.html Cycles:180 Average:32042.05 Median:14970.66 stddev:87725.97 (586.0%) stddev-sans-first:87939.95 03:53:40 INFO - PROCESS | 4692 | Values: 428.2 428.3 428.5 439.8 446.9 18675.3 19735.6 20094.3 21295.7 21314.7 16606.8 18665.4 19461.4 19559.6 19860.7 5192.4 5399.2 5453.3 5464.7 5465.5 3974.5 4771.8 5318.9 5325.6 6463.3 6370.6 6483.3 6509.1 6544.1 6556.9 5799.9 5939.8 5965.7 6179.8 6464.6 3918.4 4128.9 4132.9 5744.5 5757.9 26142.0 27264.9 28985.7 29237.7 29588.1 2636.5 2676.5 2729.2 2826.8 2845.3 15754.6 15855.5 16332.3 16627.7 16849.8 2118.4 2163.3 2205.6 2219.1 2272.2 64013.7 72120.0 74062.6 80817.0 84702.6 16781.5 18219.9 19135.6 19153.9 19160.0 34936.8 35390.5 35398.8 35758.6 35805.0 10358.7 10378.5 10583.7 10981.5 11140.6 8911.7 9064.5 9080.5 9084.7 9215.0 9313.4 9405.3 9520.7 9651.8 9659.7 3042.7 3431.5 3579.9 3587.2 3685.3 972.4 1046.7 1058.9 1084.5 1174.6 19537.7 19743.7 20874.2 21289.6 21306.3 1030.9 1038.6 1063.6 1080.0 1084.0 10958.3 11241.9 11289.4 11293.5 11300.5 506499.0 533274.0 538201.0 543838.0 544701.0 102308.0 102441.6 103185.0 104866.5 105068.0 1119.5 1121.3 1153.4 1157.9 1159.0 17527.3 17629.0 17737.6 17840.0 17884.1 42692.8 43163.4 43380.8 44125.8 45245.8 55459.4 61525.7 62937.7 64334.0 64356.7 8346.1 9129.2 9320.9 9366.3 9404.8 10644.9 13916.9 14020.0 14158.4 14221.6 12314.2 12348.9 12425.6 12587.4 12655.1 5825.1 11009.4 12220.8 12280.8 12326.7 12556.9 12616.1 12649.9 12736.2 12795.4 8903.2 8928.6 9179.4 9325.8 9360.1 11495.0 12388.9 12426.4 12507.4 12543.1 03:53:40 INFO - PROCESS | 4692 | 03:53:40 INFO - PROCESS | 4692 | [#3] mootools.html Cycles:180 Average:6386.26 Median:502.24 stddev:3781.59 (753.0%) stddev-sans-first:3773.77 03:53:40 INFO - PROCESS | 4692 | Values: 1417.4 1597.5 1624.5 1823.7 1934.2 9207.5 9544.4 9575.5 9761.0 9800.9 9474.6 9665.3 9670.0 9687.0 9712.9 2158.4 2416.3 2464.2 2500.1 2501.8 2516.2 2535.2 2551.3 2560.1 2561.0 2489.1 2509.1 2510.5 2512.8 2513.3 2090.5 2439.3 2501.0 2501.2 2507.7 2325.4 2345.2 2345.7 2347.9 2349.8 9719.0 9784.2 9788.2 9803.1 9891.9 5710.9 5877.9 5883.8 5885.6 5887.3 3447.6 3508.6 3546.3 3693.2 3700.0 1200.7 1237.9 1253.5 1261.2 1273.7 13953.0 13958.9 14002.4 14006.7 14011.9 5063.1 5070.7 5162.6 5171.5 5191.7 11767.8 11831.1 11853.5 11868.6 11876.7 5341.5 5831.9 5848.4 5852.3 5860.6 4875.3 4928.8 5214.0 5316.5 5346.7 4400.9 4419.9 4477.6 4500.8 4513.4 1387.9 1425.8 1433.9 1437.9 1449.3 939.6 970.8 977.0 979.2 988.9 6057.0 6151.4 6163.8 6175.1 6335.2 482.4 494.0 500.8 502.2 502.3 4246.6 4263.9 4344.8 4408.0 4420.6 12062.0 12514.7 12556.3 12585.5 12592.5 11578.8 12205.5 12297.0 12375.6 12389.3 8707.0 9008.8 9022.0 9046.9 9069.3 6343.5 6481.7 6491.9 6593.6 6610.3 11013.5 11425.7 11506.8 11508.9 11658.4 11662.9 11685.8 11783.6 11787.5 11806.8 8321.0 8419.8 8530.4 8628.3 8659.7 9362.5 9435.0 9453.7 9474.0 9556.0 8349.5 8557.3 8573.0 8624.8 8722.1 8335.0 8336.5 8337.8 8366.6 8476.0 7487.9 7489.4 7568.1 7575.7 7582.0 5394.3 5420.5 5483.7 5564.1 5592.1 5319.7 5340.8 5421.7 5462.0 5473.1 03:53:40 INFO - PROCESS | 4692 | 03:53:40 INFO - PROCESS | 4692 | [#4] prototype.html Cycles:180 Average:4811.96 Median:5459.86 stddev:1404.51 (25.7%) stddev-sans-first:1367.82 03:53:40 INFO - PROCESS | 4692 | Values: 343.9 344.3 349.1 352.6 354.4 5476.2 5545.5 5556.4 5558.0 5579.3 5485.9 5497.6 5518.3 5536.2 5536.9 3886.8 4096.6 4265.9 4292.8 4303.4 4236.3 4258.6 4276.0 4285.7 4288.7 4051.3 4247.7 4271.4 4299.6 4306.2 4196.2 4265.7 4266.7 4271.8 4281.4 3805.3 3817.3 3840.0 3851.5 3867.1 5273.1 5282.5 5288.4 5306.8 5335.8 4932.9 4942.9 4951.5 4964.4 4975.2 5443.5 5618.5 5660.2 5703.1 5746.5 4009.6 4087.2 4122.6 4209.9 4221.1 5852.5 5931.3 5932.5 5945.4 5976.9 4090.4 4237.2 4240.4 4275.6 4298.4 4328.0 4343.8 4345.4 4351.8 4352.5 4906.5 4924.3 4934.4 4946.8 4947.8 5493.5 5786.5 5808.4 5811.8 5821.8 1500.6 1509.9 1517.4 1519.8 1520.5 964.8 980.7 983.3 989.3 991.5 4996.5 5020.5 5025.6 5061.0 5079.7 5181.5 5214.5 5219.4 5219.8 5227.3 4954.2 5002.2 5058.2 5277.7 5766.3 3153.9 3159.0 3160.9 3179.6 3189.6 6136.1 6140.8 6178.2 6179.8 6193.2 5723.9 6045.9 6073.3 6093.5 6096.5 5895.8 6017.0 6151.1 6153.3 6170.6 5917.9 5936.1 5964.7 5968.5 5985.8 5830.9 5839.4 5840.8 5841.6 5860.4 5961.2 6123.4 6131.3 6132.6 6138.7 4150.0 4171.7 4191.0 4194.7 4211.3 5769.7 5812.4 5893.9 5919.2 5952.5 5755.3 5756.7 5790.9 5797.6 5807.0 5641.9 5716.3 5718.4 5738.6 5772.7 5503.0 5606.1 5671.5 5680.2 5696.8 5763.8 5768.7 5787.4 5797.2 5807.2 5440.2 5659.7 5676.3 5678.8 5682.6 03:53:40 INFO - PROCESS | 4692 | 03:53:40 INFO - PROCESS | 4692 | [#5] yui.html Cycles:180 Average:20815.05 Median:4396.33 stddev:28060.60 (638.3%) stddev-sans-first:28099.32 03:53:40 INFO - PROCESS | 4692 | Values: 863.1 888.5 894.3 906.1 908.1 14359.9 14710.6 14908.6 14909.9 15107.5 16005.8 16756.7 16770.9 17349.7 17362.0 731.0 852.9 869.9 874.3 876.2 869.7 875.1 877.4 879.8 880.5 917.5 922.8 925.0 927.5 931.5 764.2 781.4 901.6 918.2 924.2 670.8 672.1 673.8 674.1 674.3 14830.9 14902.9 14936.6 14938.3 14942.7 15535.3 16141.6 16491.1 16544.8 16571.2 13357.7 14071.5 14296.9 14412.2 14606.2 4735.3 4735.9 4766.4 4829.1 4859.0 67594.0 69611.3 69995.3 79158.2 80031.6 13023.3 13320.1 13394.7 13532.1 13700.4 24466.0 24495.8 24605.3 24645.8 24646.8 9706.3 9743.0 9826.9 10086.5 10089.6 5197.9 5281.9 5291.4 5509.0 5580.4 4165.1 4363.3 4389.5 4449.5 4457.6 719.8 728.2 735.9 747.5 753.4 777.9 786.4 794.2 796.5 802.6 10293.1 10818.6 10843.0 10886.3 10984.7 620.6 737.0 737.4 747.6 765.7 4238.0 4240.2 4274.9 4379.5 4403.2 95417.5 96901.0 98080.0 104485.5 105257.0 91960.0 94434.5 94880.0 95136.0 96945.5 87003.6 87054.6 87551.0 89024.0 91340.5 10383.2 10449.7 10485.8 10507.6 10690.3 49626.8 49920.3 49941.3 50577.7 50828.2 70803.0 71457.3 72722.6 72792.3 76073.2 13321.3 13572.3 13703.7 13762.0 13851.4 14869.0 15317.0 15384.2 15629.8 15929.8 14845.6 14928.8 14951.9 15053.7 15098.0 14347.5 14745.6 14791.4 14835.6 14854.5 14003.0 14208.5 14367.8 14524.0 14630.9 11420.8 11879.0 12435.9 12502.5 12532.9 12336.1 12476.1 12529.6 12641.3 12654.2 03:53:40 INFO - PROCESS | 4692 | -------- Summary: end -------- 03:53:40 INFO - PROCESS | 4692 | 03:53:40 INFO - TEST-INFO | 4692: exit 0 03:53:40 INFO - TEST-OK | dromaeo_css | took 1113242ms 03:53:40 INFO - TEST-START | kraken 03:53:40 INFO - operating with platform_type : linux_ 03:53:40 INFO - Initialising browser for kraken test... 03:53:40 INFO - TEST-INFO | started process 4881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp90qpZn/profile http://localhost:40464/getInfo.html) 03:53:44 INFO - PROCESS | 4881 | __metrics Screen width/height:1600/1200 03:53:44 INFO - PROCESS | 4881 | colorDepth:24 03:53:44 INFO - PROCESS | 4881 | Browser inner width/height: 1024/697 03:53:44 INFO - PROCESS | 4881 | __metrics 03:53:45 ERROR - PROCESS | 4881 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:53:46 INFO - TEST-INFO | 4881: exit 0 03:53:46 INFO - Browser initialized. 03:53:46 INFO - Running cycle 1/1 for kraken test... 03:53:46 INFO - TEST-INFO | started process 4973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp90qpZn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:58 INFO - PROCESS | 4973 | RSS: Main: 145276928 03:53:58 INFO - PROCESS | 4973 | 03:54:00 INFO - PROCESS | 4973 | Cycle 1(1): loaded http://localhost:40464/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40464/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:01 INFO - PROCESS | 4973 | RSS: Main: 194134016 03:54:01 INFO - PROCESS | 4973 | 03:54:04 INFO - PROCESS | 4973 | Cycle 1(1): loaded http://localhost:40464/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40464/tests/kraken/driver.html?testName=audio-dft) 03:54:04 INFO - PROCESS | 4973 | RSS: Main: 193093632 03:54:04 INFO - PROCESS | 4973 | 03:54:07 INFO - PROCESS | 4973 | Cycle 1(1): loaded http://localhost:40464/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40464/tests/kraken/driver.html?testName=audio-fft) 03:54:08 INFO - PROCESS | 4973 | RSS: Main: 279318528 03:54:08 INFO - PROCESS | 4973 | 03:54:10 INFO - PROCESS | 4973 | Cycle 1(1): loaded http://localhost:40464/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40464/tests/kraken/driver.html?testName=audio-oscillator) 03:54:11 INFO - PROCESS | 4973 | RSS: Main: 187650048 03:54:11 INFO - PROCESS | 4973 | 03:54:13 INFO - PROCESS | 4973 | Cycle 1(1): loaded http://localhost:40464/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40464/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:13 INFO - PROCESS | 4973 | RSS: Main: 188583936 03:54:13 INFO - PROCESS | 4973 | 03:54:16 INFO - PROCESS | 4973 | Cycle 1(1): loaded http://localhost:40464/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40464/tests/kraken/driver.html?testName=imaging-darkroom) 03:54:17 INFO - PROCESS | 4973 | RSS: Main: 222674944 03:54:17 INFO - PROCESS | 4973 | 03:54:20 INFO - PROCESS | 4973 | Cycle 1(1): loaded http://localhost:40464/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40464/tests/kraken/driver.html?testName=imaging-desaturate) 03:54:21 INFO - PROCESS | 4973 | RSS: Main: 222703616 03:54:21 INFO - PROCESS | 4973 | 03:54:24 INFO - PROCESS | 4973 | Cycle 1(1): loaded http://localhost:40464/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40464/tests/kraken/driver.html?testName=json-parse-financial) 03:54:24 INFO - PROCESS | 4973 | RSS: Main: 222633984 03:54:24 INFO - PROCESS | 4973 | 03:54:26 INFO - PROCESS | 4973 | Cycle 1(1): loaded http://localhost:40464/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40464/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:54:26 INFO - PROCESS | 4973 | RSS: Main: 201527296 03:54:26 INFO - PROCESS | 4973 | 03:54:28 INFO - PROCESS | 4973 | Cycle 1(1): loaded http://localhost:40464/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40464/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:29 INFO - PROCESS | 4973 | RSS: Main: 202092544 03:54:29 INFO - PROCESS | 4973 | 03:54:31 INFO - PROCESS | 4973 | Cycle 1(1): loaded http://localhost:40464/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40464/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:54:31 INFO - PROCESS | 4973 | RSS: Main: 208048128 03:54:31 INFO - PROCESS | 4973 | 03:54:34 INFO - PROCESS | 4973 | Cycle 1(1): loaded http://localhost:40464/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:54:35 INFO - PROCESS | 4973 | RSS: Main: 213012480 03:54:35 INFO - PROCESS | 4973 | 03:54:37 INFO - PROCESS | 4973 | Cycle 1(1): loaded http://localhost:40464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:38 INFO - PROCESS | 4973 | RSS: Main: 211525632 03:54:38 INFO - PROCESS | 4973 | 03:54:39 INFO - PROCESS | 4973 | Cycle 1(1): loaded http://localhost:40464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40464/tests/kraken/driver.html?testName=ai-astar) 03:54:40 INFO - PROCESS | 4973 | RSS: Main: 253255680 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | __start_tp_report 03:54:40 INFO - PROCESS | 4973 | _x_x_mozilla_page_load 03:54:40 INFO - PROCESS | 4973 | _x_x_mozilla_page_load_details 03:54:40 INFO - PROCESS | 4973 | |i|pagename|runs| 03:54:40 INFO - PROCESS | 4973 | |0;ai-astar;110;103;109;108;109;109;114;108;108;109 03:54:40 INFO - PROCESS | 4973 | |1;audio-beat-detection;152;123;124;174;132;131;149;131;157;122 03:54:40 INFO - PROCESS | 4973 | |2;audio-dft;161;160;162;160;160;161;160;160;159;161 03:54:40 INFO - PROCESS | 4973 | |3;audio-fft;74;76;75;129;74;75;75;73;111;75 03:54:40 INFO - PROCESS | 4973 | |4;audio-oscillator;84;84;118;83;84;85;111;83;84;133 03:54:40 INFO - PROCESS | 4973 | |5;imaging-gaussian-blur;116;117;117;118;117;117;117;117;116;116 03:54:40 INFO - PROCESS | 4973 | |6;imaging-darkroom;177;145;146;146;176;146;146;146;145;145 03:54:40 INFO - PROCESS | 4973 | |7;imaging-desaturate;95;95;95;95;95;95;94;94;94;94 03:54:40 INFO - PROCESS | 4973 | |8;json-parse-financial;52;52;51;53;52;54;53;52;52;52 03:54:40 INFO - PROCESS | 4973 | |9;json-stringify-tinderbox;60;60;59;59;59;60;59;60;60;59 03:54:40 INFO - PROCESS | 4973 | |10;stanford-crypto-aes;77;76;80;78;77;76;77;77;113;76 03:54:40 INFO - PROCESS | 4973 | |11;stanford-crypto-ccm;136;116;119;114;128;120;115;122;128;124 03:54:40 INFO - PROCESS | 4973 | |12;stanford-crypto-pbkdf2;153;153;155;158;153;155;152;151;151;155 03:54:40 INFO - PROCESS | 4973 | |13;stanford-crypto-sha256-iterative;63;62;64;60;60;64;61;60;60;60 03:54:40 INFO - PROCESS | 4973 | __end_tp_report 03:54:40 INFO - PROCESS | 4973 | __start_cc_report 03:54:40 INFO - PROCESS | 4973 | _x_x_mozilla_cycle_collect,1561 03:54:40 INFO - PROCESS | 4973 | __end_cc_report 03:54:40 INFO - PROCESS | 4973 | __startTimestamp1467543280182__endTimestamp 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | ------- Summary: start ------- 03:54:40 INFO - PROCESS | 4973 | Number of tests: 14 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | [#0] ai-astar Cycles:10 Average:108.70 Median:109.00 stddev:2.67 (2.4%) stddev-sans-first:2.79 03:54:40 INFO - PROCESS | 4973 | Values: 110.0 103.0 109.0 108.0 109.0 109.0 114.0 108.0 108.0 109.0 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:140.50 stddev:17.52 (12.5%) stddev-sans-first:17.99 03:54:40 INFO - PROCESS | 4973 | Values: 152.0 123.0 124.0 174.0 132.0 131.0 149.0 131.0 157.0 122.0 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 03:54:40 INFO - PROCESS | 4973 | Values: 161.0 160.0 162.0 160.0 160.0 161.0 160.0 160.0 159.0 161.0 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | [#3] audio-fft Cycles:10 Average:83.70 Median:75.00 stddev:19.61 (26.2%) stddev-sans-first:20.49 03:54:40 INFO - PROCESS | 4973 | Values: 74.0 76.0 75.0 129.0 74.0 75.0 75.0 73.0 111.0 75.0 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.00 stddev:18.56 (22.1%) stddev-sans-first:19.26 03:54:40 INFO - PROCESS | 4973 | Values: 84.0 84.0 118.0 83.0 84.0 85.0 111.0 83.0 84.0 133.0 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 03:54:40 INFO - PROCESS | 4973 | Values: 116.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 116.0 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:146.00 stddev:13.03 (8.9%) stddev-sans-first:10.14 03:54:40 INFO - PROCESS | 4973 | Values: 177.0 145.0 146.0 146.0 176.0 146.0 146.0 146.0 145.0 145.0 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:54:40 INFO - PROCESS | 4973 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 94.0 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 03:54:40 INFO - PROCESS | 4973 | Values: 52.0 52.0 51.0 53.0 52.0 54.0 53.0 52.0 52.0 52.0 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 03:54:40 INFO - PROCESS | 4973 | Values: 60.0 60.0 59.0 59.0 59.0 60.0 59.0 60.0 60.0 59.0 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:77.00 stddev:11.41 (14.8%) stddev-sans-first:12.03 03:54:40 INFO - PROCESS | 4973 | Values: 77.0 76.0 80.0 78.0 77.0 76.0 77.0 77.0 113.0 76.0 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | [#11] stanford-crypto-ccm Cycles:10 Average:122.20 Median:123.00 stddev:6.94 (5.6%) stddev-sans-first:5.27 03:54:40 INFO - PROCESS | 4973 | Values: 136.0 116.0 119.0 114.0 128.0 120.0 115.0 122.0 128.0 124.0 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:154.00 stddev:2.17 (1.4%) stddev-sans-first:2.29 03:54:40 INFO - PROCESS | 4973 | Values: 153.0 153.0 155.0 158.0 153.0 155.0 152.0 151.0 151.0 155.0 03:54:40 INFO - PROCESS | 4973 | 03:54:40 INFO - PROCESS | 4973 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.50 stddev:1.71 (2.8%) stddev-sans-first:1.72 03:54:40 INFO - PROCESS | 4973 | Values: 63.0 62.0 64.0 60.0 60.0 64.0 61.0 60.0 60.0 60.0 03:54:40 INFO - PROCESS | 4973 | -------- Summary: end -------- 03:54:40 INFO - PROCESS | 4973 | 03:54:41 INFO - TEST-INFO | 4973: exit 0 03:54:41 INFO - TEST-OK | kraken | took 60364ms 03:54:41 INFO - SUITE-END | took 1173s 03:54:41 INFO - Completed test suite (00:19:33) 03:54:41 INFO - javascript benchmark 03:54:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3428.3314753623044, 3453.343864665713, 3458.377492051431, 3473.826308684565, 3504.6495350464957, 5673.120666296725, 5751.453611906867, 5757.222774925383, 5774.307083150017, 5775.624584402011, 5707.4577915098, 5776.39347868473, 5781.277340332458, 5782.653040817554, 5789.334226563947, 5046.621503387242, 5179.0, 5207.505286997748, 5285.550728188108, 5302.6023048271345, 5108.4125325587665, 5217.087009773293, 5254.080535906221, 5256.053910296145, 5261.1319132343115, 5159.432462429129, 5192.065428222937, 5206.635535512516, 5216.374035115791, 5218.269442278084, 5314.893702125955, 5323.307969963918, 5331.280277162592, 5335.359756829205, 5362.624616276862, 5034.043531728959, 5088.542031217208, 5121.718305493234, 5221.0, 5224.111900976843, 5549.223108764776, 5587.245721827582, 5593.0, 5602.299712535933, 5637.126245431965, 6042.758289668408, 6091.695415229266, 6093.268807743055, 6094.6952652367645, 6098.756049758004, 6065.4844338231305, 6076.239324751655, 6089.718063077438, 6101.51187904971, 6154.661493617849, 5749.166370876242, 5792.739326730307, 5798.507126894219, 5798.652080875161, 5805.36141024487, 6096.0, 6296.5592408531875, 6303.558750887394, 6303.621782693053, 6305.180326557518, 5998.040313549811, 6047.576669633171, 6054.939450605526, 6098.4343605148715, 6098.749756299948, 6212.658303793244, 6214.9689251554355, 6218.036204388327, 6218.595791273553, 6222.191115155001, 5907.409259074058, 6035.637861728311, 6176.166217560662, 6177.96911015451, 6179.660118693515, 6078.270607527125, 6141.977005061692, 6142.038385241494, 6145.801568694062, 6145.846353841101, 4646.697964632288, 4687.789049492781, 4691.601213896857, 4710.623150148049, 4718.174319494144, 4112.485939257593, 4122.031322639177, 4155.252054630135, 4199.643030342394, 4212.641925436372, 5906.114082887601, 5911.083782013795, 5911.852203694856, 5912.615679980873, 5930.436608522184, 6159.784407545714, 6200.100985357189, 6201.0, 6211.130441738161, 6217.160683307786, 5717.571182161271, 5768.971155144198, 5809.186713860063, 5813.59304848665, 5917.112433135064, 5289.021531016774, 5290.867728306746, 5290.867728306823, 5291.312129423227, 5292.52367286946, 6315.494760419156, 6335.493160547145, 6337.207849018965, 6341.492680585542, 6344.651044192614, 6016.548758843017, 6093.146959425772, 6127.111568822585, 6134.987697083834, 6203.069539569101, 6408.455281301141, 6414.550981431255, 6424.261209960728, 6431.067495213074, 6431.742730290923, 5904.143899134688, 6123.663198524124, 6133.938660613337, 6134.447899689049, 6139.079138129137, 5964.761409543569, 5970.432808883149, 6007.339192688713, 6064.0, 6068.908966365596, 5917.615355001911, 5932.584719069624, 5933.347331793413, 5934.9406505934385, 5937.109433584997, 5751.309842818889, 5849.707514624167, 5919.763209471573, 5923.052311630118, 5923.318818335946, 5852.619579727474, 5913.6747478887355, 5915.40845915405, 5952.375000624872, 5980.222571065734, 6013.0, 6049.481245011831, 6074.892107125429, 6094.177286066324, 6104.236970378703, 5732.226149469769, 5778.0, 5794.5364370851075, 5910.881782364415, 5921.5558833086825], "value": 5657.58771710153, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.2773399654411, 646.1987135951421, 659.3735950846694, 666.1040899989514, 681.2472218198888, 35917.64082359179, 47584.0, 48364.51635483653, 48456.515434845685, 52030.73984630081, 48797.0, 49266.50733492664, 49283.0, 49322.260166097534, 49332.0, 8395.076541580453, 9067.410618309805, 9206.401583897059, 10903.727406814814, 11185.496652650609, 10619.044286014258, 11102.0, 11103.72240693981, 11106.555737770479, 11107.166962477806, 11136.888631113707, 11238.943805280962, 11240.662780116569, 11240.775184496306, 11246.156538259622, 8454.74635760925, 10816.242862999594, 11027.61403350879, 11072.0, 11366.602168924132, 11044.558217671283, 11130.554777808959, 11147.108231341474, 11148.052415544607, 11151.219414640978, 46032.53967460316, 46247.30629040567, 46374.0, 46449.0, 46567.767161163974, 3811.0091376242376, 4015.959840401588, 4239.59723826236, 4262.318029115358, 4627.467841198238, 36418.81790591057, 36633.45049824255, 36916.261674766356, 37245.441318380246, 37380.252394951945, 4700.1539722849875, 4749.905001899977, 4876.512348765095, 4933.629977751647, 4965.82619608312, 392865.0, 399792.0, 400078.0, 400950.0, 401259.0, 71189.0, 72282.0, 72456.63771681108, 72513.2748672517, 72557.6372118136, 37844.0, 38327.23345533074, 38367.0, 38399.232015359536, 77465.0, 16934.661306773796, 18109.275628974694, 18129.546761331072, 18130.09349532518, 18190.363337283397, 13808.861911380958, 14184.290785460893, 14195.645108872155, 14474.927625361806, 14504.564863054125, 22694.773052269597, 22738.886305568365, 22777.88611056934, 22795.544089118124, 22798.31605051818, 8126.512409255463, 8199.590020498952, 8331.583840686255, 8348.749537513884, 8455.95772021136, 1050.8318669012922, 1057.3338796558119, 1088.9237753357347, 1098.747288123736, 1158.5887010111458, 34499.0, 34636.30727385489, 34852.30295394129, 34902.476462853076, 35178.29643407118, 1131.9886801131884, 1176.4705882352976, 1195.9162858599989, 1258.4148371007525, 1273.6752128207247, 16867.254794031393, 17147.828521714873, 17629.647407052045, 17657.38199163023, 17665.82334176642, 613957.0, 618046.0, 621203.0, 621558.0, 622422.0, 64011.0, 64322.0, 64336.35663643397, 64438.67780661066, 64588.67705661442, 1374.6219789557952, 1418.7091646212707, 1466.911985280865, 1483.4807817264086, 1507.216247551267, 31100.82294239472, 35522.28955420929, 35525.82237088798, 35765.64234357623, 36089.81955090313, 53826.461735382145, 54628.45371546234, 54748.72625636846, 54839.177412338046, 54975.450245497035, 430472.0, 435706.0, 436623.0, 437265.0, 438072.0, 30712.846435768573, 32141.839290803397, 32190.67809321877, 32254.0, 32285.51571726379, 51366.74316628393, 53148.2027769576, 53763.0, 53859.461405385446, 54035.729821350644, 44205.55794442143, 44369.55630443654, 44583.33125003063, 45309.32036019397, 48158.759206203744, 45333.78661453843, 46177.30734038925, 46692.53307466882, 47233.0, 47338.763306183246, 45569.0, 46397.0, 46428.0, 47324.52675473201, 47372.7631361841, 39562.2087558253, 41010.384844227956, 41303.0, 41316.07442655177, 41728.0, 30352.84823575868, 30747.562729742833, 30812.53781193329, 31153.8442307787, 31165.376692466478], "value": 22355.255498494593, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.2420116393983, 428.3125583438583, 428.49009678482605, 439.8306651939005, 446.8570057581575, 18675.346362877284, 19735.605287894232, 20094.296699615497, 21295.68056479154, 21314.680279795775, 16606.83393166068, 18665.440036798886, 19461.416157515298, 19559.608807823835, 19860.70208946867, 5192.350956130493, 5399.244105825188, 5453.318335208099, 5464.6994415307145, 5465.453454654543, 3974.503187101612, 4771.832985845496, 5318.9202161967405, 5325.600579956499, 6463.289038205794, 6370.6177629342155, 6483.319251478598, 6509.088727578142, 6544.0511125886715, 6556.934430655704, 5799.88400231993, 5939.762409503658, 5965.701714914258, 6179.845503862417, 6464.644444555547, 3918.4318273850417, 4128.896777580554, 4132.876013719563, 5744.511716504102, 5757.942420575782, 26142.0, 27264.863675681692, 28985.710142898723, 29237.70762292371, 29588.112356629335, 2636.49906517761, 2676.464707058596, 2729.249456399506, 2826.844523551204, 2845.260232339586, 15754.606134846606, 15855.52433426999, 16332.265048072746, 16627.667446650998, 16849.83150168495, 2118.396257066744, 2163.253677481282, 2205.59196548639, 2219.0679914435814, 2272.2047283450825, 64013.67993160051, 72120.0, 74062.62968685175, 80817.0, 84702.57648711717, 16781.496555103367, 18219.90890045541, 19135.617287654168, 19153.904230478758, 19160.0, 34936.825315873764, 35390.46914296287, 35398.82300588532, 35758.64241357605, 35805.0, 10358.741031474123, 10378.532966016548, 10583.735406614896, 10981.505832237568, 11140.554377824958, 8911.688090916787, 9064.54677266134, 9080.500572468445, 9084.727458176265, 9214.953925230331, 9313.441193528275, 9405.341626086245, 9520.714378568655, 9651.806963860683, 9659.71020869375, 3042.710942460463, 3431.519587257786, 3579.8926032219074, 3587.157018100744, 3685.3182161300247, 972.3873959405529, 1046.7121541575975, 1058.878229003659, 1084.4686103809076, 1174.5595401724354, 19537.706934395996, 19743.703844442345, 20874.165033398494, 21289.59061170829, 21306.254281100086, 1030.8711411073616, 1038.5897570459776, 1063.622414043019, 1079.9730006749894, 1083.983740243897, 10958.342499450058, 11241.943790280997, 11289.435528223721, 11293.491792869341, 11300.491477883515, 506499.0, 533274.0, 538201.0, 543838.0, 544701.0, 102308.0, 102441.63994002635, 103185.0, 104866.47566762117, 105068.0, 1119.4514687802919, 1121.315997241682, 1153.411760002405, 1157.8726340102583, 1159.0, 17527.298908043536, 17629.03040332794, 17737.556561086076, 17840.0, 17884.10579470995, 42692.78653606712, 43163.35254971115, 43380.78309608432, 44125.77937110294, 45245.77377113093, 55459.445405545426, 61525.69237153786, 62937.685311574984, 64334.03498947613, 64356.67821660862, 8346.081930987466, 9129.224015958718, 9320.860187097334, 9366.297527685314, 9404.811903761749, 10644.946775266075, 13916.860831391961, 14020.0, 14158.362873670503, 14221.644458888197, 12314.199577027464, 12348.938255308665, 12425.565105221274, 12587.433565489759, 12655.11414201034, 5825.126231065374, 11009.394483303495, 12220.75558488843, 12280.789457897665, 12326.691832703895, 12556.86988171069, 12616.053795965156, 12649.87350126487, 12736.23582585048, 12795.42420591057, 8903.154200350957, 8928.642854285756, 9179.357444978787, 9325.813483730151, 9360.11078947499, 11495.022923051634, 12388.938055309665, 12426.378681066091, 12507.374631268582, 12543.12198146121], "value": 10550.822807686425, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.411774113743, 1597.512758608624, 1624.5370069530184, 1823.6535058338923, 1934.2166422598843, 9207.493587852665, 9544.427334359943, 9575.473348965805, 9761.0, 9800.901990980106, 9474.573644186012, 9665.275104367183, 9670.0, 9686.951565242163, 9712.85430718538, 2158.438805910459, 2416.250962201714, 2464.2484042367028, 2500.0749722602663, 2501.8248722589424, 2516.19481765835, 2535.1887396033185, 2551.311145990591, 2560.0783717861555, 2560.987195064022, 2489.0914816092086, 2509.0841842727455, 2510.5104504621604, 2512.849229046263, 2513.28371414147, 2090.4982804127053, 2439.2682195341417, 2500.9874950625313, 2501.187114187878, 2507.6865391826022, 2325.383773300077, 2345.2260753951327, 2345.7419683834764, 2347.882605869717, 2349.847259928099, 9719.0, 9784.168345690625, 9788.168005719523, 9803.117719405216, 9891.90108098917, 5710.942890571083, 5877.882442351171, 5883.79406720767, 5885.646861188342, 5887.293524777011, 3447.5690538682666, 3508.614052454228, 3546.2730140321432, 3693.2244228712, 3699.9815000924823, 1200.6758175292623, 1237.876212378764, 1253.4547471849774, 1261.249556513882, 1273.6624794429483, 13953.0, 13958.930205348908, 14002.439902403892, 14006.719865602732, 14011.859881401055, 5063.088644044107, 5070.7464626768515, 5162.6128040397125, 5171.50870667286, 5191.714455704972, 11767.76464470723, 11831.112666550043, 11853.525858965544, 11868.643940681794, 11876.703082422835, 5341.465853414705, 5831.88336233273, 5848.415158484203, 5852.297724273029, 5860.619059761102, 4875.293082503017, 4928.778204980785, 5214.0, 5316.548093412026, 5346.705931173823, 4400.9119817604105, 4419.911601768011, 4477.6417886569, 4500.774961251925, 4513.368128462018, 1387.8750912417931, 1425.7861320801755, 1433.9139651620728, 1437.8705916467568, 1449.3333066789396, 939.5771902643701, 970.7815741458256, 976.9804603908024, 979.2019504104132, 988.8566157907063, 6056.9697151513965, 6151.3541078186145, 6163.7842675506145, 6175.104609831639, 6335.208098987627, 482.351237585447, 493.979931441572, 500.7796569509404, 502.2140350351688, 502.2566601429904, 4246.617804397619, 4263.850765223202, 4344.804483798237, 4407.955920440754, 4420.557944205554, 12062.0, 12514.687132821753, 12556.309402982924, 12585.496580136874, 12592.496300148076, 11578.76842463163, 12205.45075471606, 12297.0, 12375.566855160207, 12389.256644601353, 8706.95646521776, 9008.774780630536, 9022.0, 9046.909530904606, 9069.31980101495, 6343.52423568225, 6481.708323125376, 6491.870162596816, 6593.604383736991, 6610.338966103352, 11013.504392302526, 11425.657230283105, 11506.827397588875, 11508.88491115078, 11658.417079146178, 11662.94168529152, 11685.824712629488, 11783.587574434854, 11787.469563869818, 11806.763864722829, 8320.959880014998, 8419.789505262417, 8530.445521041112, 8628.309735221043, 8659.740207793777, 9362.531873406166, 9435.0, 9453.716388508356, 9474.005229451084, 9555.952220238854, 8349.457285276438, 8557.272631826365, 8572.957135214285, 8624.827503449771, 8722.08418116114, 8335.0, 8336.541490218096, 8337.833243334979, 8366.581670916552, 8475.957620212106, 7487.8876816846705, 7489.400847932261, 7568.091828980558, 7575.659095340833, 7581.962090189514, 5394.271773310553, 5420.457954204548, 5483.698396588226, 5564.109742441352, 5592.133219351007, 5319.6808191508635, 5340.759665815125, 5421.728913554385, 5462.016836969384, 5473.124300111963], "value": 4959.921193274078, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.91230236289744, 344.2838895098196, 349.1062879029686, 352.6244549554726, 354.43113802347233, 5476.233327334171, 5545.473180047889, 5556.361018482876, 5557.972210138949, 5579.274694289747, 5485.945140548603, 5497.5601951843855, 5518.310211223597, 5536.197251398545, 5536.916946245809, 3886.8250928708135, 4096.610821971908, 4265.850695225668, 4292.763897985609, 4303.35449682547, 4236.258654735424, 4258.5954334338185, 4276.016516201275, 4285.721428107178, 4288.69979101463, 4051.2910240707756, 4247.723897946639, 4271.402003719481, 4299.591538803808, 4306.224879521685, 4196.244675958326, 4265.701400901922, 4266.743995360288, 4271.786410679485, 4281.443412356373, 3805.2579746949355, 3817.2938006468894, 3839.9808000960097, 3851.480050193244, 3867.149227170018, 5273.129933560957, 5282.498162674539, 5288.365396152448, 5306.7611957462, 5335.839924802262, 4932.926006109911, 4942.9258561121615, 4951.480094590052, 4964.379452568429, 4975.179095449246, 5443.482869127466, 5618.522425593829, 5660.235868157787, 5703.144528320744, 5746.454086861741, 4009.639132478091, 4087.2234275487563, 4122.628963393279, 4209.873703788891, 4221.134667393208, 5852.531797456193, 5931.317898441648, 5932.495737862287, 5945.394743419252, 5976.850578735566, 4090.427340172378, 4237.152569486115, 4240.448741663564, 4275.593818587229, 4298.356510745869, 4328.0, 4343.782810859444, 4345.435093437896, 4351.782410879443, 4352.521222665504, 4906.460289368167, 4924.261360795909, 4934.407871055425, 4946.752662366867, 4947.82682606107, 5493.48929044516, 5786.537077033827, 5808.3901190375245, 5811.767529298865, 5821.825345239649, 1500.5873384819263, 1509.871660908813, 1517.4157949189641, 1519.8100237470317, 1520.4754359746091, 964.81668482988, 980.6616717232544, 983.2822039910762, 989.2531138990016, 991.5438898106808, 4996.475370086161, 5020.497950205024, 5025.597952163818, 5060.974695126501, 5079.72061536619, 5181.5077567631015, 5214.45248248936, 5219.42586315505, 5219.765110570033, 5227.294315267466, 4954.232094025359, 5002.224655178453, 5058.241263810384, 5277.656952298088, 5766.336871259775, 3153.921151971219, 3159.0, 3160.8893688720786, 3179.6184457865206, 3189.569408129873, 6136.110264011782, 6140.815775526741, 6178.196834411498, 6179.81460556184, 6193.225846769154, 5723.885522289531, 6045.939540604626, 6073.301570319381, 6093.451589356979, 6096.481799047131, 5895.764169433174, 6016.969915150396, 6151.108089327023, 6153.2616086069065, 6170.568060235741, 5917.881642367214, 5936.079907614327, 5964.701764911824, 5968.463403053772, 5985.790497332572, 5830.871731817771, 5839.445252700986, 5840.766369345179, 5841.591088623755, 5860.413958604106, 5961.225040744675, 6123.418275263843, 6131.283240692614, 6132.589504414099, 6138.723757431016, 4149.958500414958, 4171.728837625545, 4190.958090419179, 4194.706370554032, 4211.347241177622, 5769.701817091121, 5812.447817457335, 5893.941060589339, 5919.230500034968, 5952.464278214981, 5755.251817263729, 5756.71216439168, 5790.884182316246, 5797.565182611237, 5807.041838096836, 5641.915371269352, 5716.314042314949, 5718.370979192202, 5738.598298119092, 5772.682502462237, 5502.972485137549, 5606.103023516381, 5671.517920976598, 5680.176374425602, 5696.829095127153, 5763.769449221984, 5768.6925229908375, 5787.421257874179, 5797.246357973437, 5807.216025836458, 5440.211169380497, 5659.688717120598, 5676.318841739017, 5678.801241956512, 5682.573806964577], "value": 4369.388177701794, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [863.1239292118499, 888.5246393179642, 894.2979760887705, 906.1391677905987, 908.0919080919083, 14359.928200358996, 14710.63223419415, 14908.62728431787, 14909.925450372733, 15107.471238506654, 16005.83994160061, 16756.748648770248, 16770.916145419254, 17349.7397539037, 17362.0, 730.9926900731004, 852.9147085291452, 869.9478031318109, 874.2656168818191, 876.2114097312437, 869.6956065377099, 875.0811647769848, 877.3814460805149, 879.7932485865816, 880.5113162194979, 917.4862077236735, 922.8108237811233, 924.9676261330854, 927.508420537113, 931.4783721116163, 764.1708746010585, 781.3866115099648, 901.5672477210976, 918.1644703319947, 924.16824857628, 670.7887015590122, 672.0691841799095, 673.8315421144714, 674.1034424215782, 674.308833445722, 14830.851691483054, 14902.925485372503, 14936.551903442805, 14938.32777525014, 14942.70114597702, 15535.300911458899, 16141.596460088474, 16491.09298988555, 16544.75182872258, 16571.17144142788, 13357.732845343038, 14071.50749723765, 14296.92851535746, 14412.207328596924, 14606.19665918374, 4735.289706544011, 4735.857924262244, 4766.38037055184, 4829.10661527615, 4858.951410485885, 67594.0, 69611.30388696099, 69995.30004699939, 79158.20841791623, 80031.59984200042, 13023.283719395524, 13320.134191277535, 13394.732105358033, 13532.120412173177, 13700.3834827433, 24466.0, 24495.755042449702, 24605.261842144766, 24645.753542464703, 24646.753532464445, 9706.320557561045, 9742.95128524353, 9826.852597211047, 10086.546105425126, 10089.596416143419, 5197.948020519822, 5281.894362112736, 5291.444398338119, 5509.0, 5580.358258800209, 4165.083681590046, 4363.345498175299, 4389.4513185851765, 4449.510553839075, 4457.64338852891, 719.8380364418069, 728.1880703016204, 735.9080114985627, 747.5049900199601, 753.3558807219857, 777.8872063550754, 786.3512602103174, 794.2057942057942, 796.4619281304407, 802.5906787538397, 10293.073623373932, 10818.567257309776, 10843.0, 10886.346819190874, 10984.725381865517, 620.602814198913, 736.9940031856478, 737.3511310047231, 747.6000339818171, 765.6937225109889, 4237.978810105929, 4240.194363071007, 4274.893127671771, 4379.4525684289465, 4403.207422663887, 95417.522912385, 96901.0, 98080.0, 104485.47757261165, 105257.0, 91960.0, 94434.5278273618, 94880.0, 95136.0, 96945.51527242319, 87003.56498217594, 87054.56472717595, 87551.0, 89024.0, 91340.54329728441, 10383.169346452416, 10449.68650940473, 10485.842712359474, 10507.632232871812, 10690.305130166826, 49626.75186624044, 49920.25119623281, 49941.25088123608, 50577.74711126568, 50828.237576437125, 70803.0, 71457.28542714714, 72722.63638681773, 72792.27207728066, 76073.23926760661, 13321.333933303102, 13572.253526056162, 13703.725925481634, 13762.0, 13851.376688049264, 14869.0, 15317.0, 15384.230788460309, 15629.843701562839, 15929.761053584438, 14845.628859278604, 14928.776068358766, 14951.925240373728, 15053.6989260212, 15098.0, 14347.497837575635, 14745.557633271019, 14791.408343666133, 14835.554933352018, 14854.480093196686, 14003.0, 14208.502702405367, 14367.784483232968, 14524.0, 14630.926845365704, 11420.828687569527, 11879.0, 12435.875641243472, 12502.499900003899, 12532.937335313265, 12336.136470446983, 12476.09871045385, 12529.561465348668, 12641.304728239667, 12654.240745555297], "value": 8103.131938635874, "unit": "score"}], "name": "dromaeo_css", "value": 7852.029731746125, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 109.0, 108.0, 109.0, 109.0, 114.0, 108.0, 108.0, 109.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 124.0, 174.0, 132.0, 131.0, 149.0, 131.0, 157.0, 122.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 160.0, 161.0, 160.0, 160.0, 159.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 129.0, 74.0, 75.0, 75.0, 73.0, 111.0, 75.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 118.0, 83.0, 84.0, 85.0, 111.0, 83.0, 84.0, 133.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 145.0, 146.0, 146.0, 176.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 53.0, 52.0, 54.0, 53.0, 52.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 59.0, 60.0, 59.0, 60.0, 60.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 80.0, 78.0, 77.0, 76.0, 77.0, 77.0, 113.0, 76.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 116.0, 119.0, 114.0, 128.0, 120.0, 115.0, 122.0, 128.0, 124.0], "value": 122.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 155.0, 158.0, 153.0, 155.0, 152.0, 151.0, 151.0, 155.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 60.0, 60.0, 64.0, 61.0, 60.0, 60.0, 60.0], "value": 61.4, "unit": "score"}], "name": "kraken", "value": 1480.1, "alertThreshold": 2.0}]} 03:54:41 INFO - Return code: 0 03:54:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:54:41 ERROR - # TBPL SUCCESS # 03:54:41 INFO - Running post-action listener: _resource_record_post_action 03:54:41 INFO - ##### 03:54:41 INFO - ##### Finished run-tests step (success) 03:54:41 INFO - ##### 03:54:41 INFO - Running post-run listener: _resource_record_post_run 03:54:41 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 421888; Write bytes: 255377408; Read time: 36; Write time: 239412 03:54:41 INFO - TinderboxPrint: CPU usage
13.1% 03:54:41 INFO - TinderboxPrint: I/O read bytes / time
421,888 / 36 03:54:41 INFO - TinderboxPrint: I/O write bytes / time
255,377,408 / 239,412 03:54:41 INFO - TinderboxPrint: CPU idle
8,264.2 (86.9%) 03:54:41 INFO - TinderboxPrint: CPU user
1,197.5 (12.6%) 03:54:41 INFO - TinderboxPrint: Swap in / out
0 / 0 03:54:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5156864; Read time: 0; Write time: 424 03:54:41 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 421888; Write bytes: 250220544; Read time: 36; Write time: 238988 03:54:42 INFO - Running post-run listener: _upload_blobber_files 03:54:42 INFO - Blob upload gear active. 03:54:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:54:42 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 03:54:42 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'] 03:54:42 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 03:54:42 INFO - (blobuploader) - INFO - Open directory for files ... 03:54:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:54:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:54:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:43 INFO - (blobuploader) - INFO - Done attempting. 03:54:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:54:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:54:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:44 INFO - (blobuploader) - INFO - Done attempting. 03:54:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:54:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:54:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:47 INFO - (blobuploader) - INFO - Done attempting. 03:54:47 INFO - (blobuploader) - INFO - Iteration through files over. 03:54:47 INFO - Return code: 0 03:54:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:54:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:54:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1a3aa09f73d1f71ea029339e2c522019ac9683ac74c4bb0045d6f9ecb3c09ebc6fc4e38a462ca447bd990cd27b8b8c2f85f1de181762b5d1b0e321652c39ee7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be8abc7145c020a6067d3acdd6c50f285782772927c4ef4a1975cfe47ea3475c9c8021d3ec2e2163e126696d8d6ad1efbb2c41b1bdf116fbaeb8edaccc33cc59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e0998a7e4d8f2b7f890ced3887a99fecc404d545bd00880cc98576bcd1bb6c02413752eed0b733ca1c70a6e7b9ad057403ffe8ea25172caf7a7952669af2286"} 03:54:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:54:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:54:47 INFO - Contents: 03:54:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1a3aa09f73d1f71ea029339e2c522019ac9683ac74c4bb0045d6f9ecb3c09ebc6fc4e38a462ca447bd990cd27b8b8c2f85f1de181762b5d1b0e321652c39ee7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be8abc7145c020a6067d3acdd6c50f285782772927c4ef4a1975cfe47ea3475c9c8021d3ec2e2163e126696d8d6ad1efbb2c41b1bdf116fbaeb8edaccc33cc59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e0998a7e4d8f2b7f890ced3887a99fecc404d545bd00880cc98576bcd1bb6c02413752eed0b733ca1c70a6e7b9ad057403ffe8ea25172caf7a7952669af2286"} 03:54:47 INFO - Running post-run listener: copy_logs_to_upload_dir 03:54:47 INFO - Copying logs to upload dir... 03:54:47 INFO - mkdir: /builds/slave/test/build/upload/logs 03:54:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.696013 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-03 03:54:47.467034) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 03:54:47.470771) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241 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/e1a3aa09f73d1f71ea029339e2c522019ac9683ac74c4bb0045d6f9ecb3c09ebc6fc4e38a462ca447bd990cd27b8b8c2f85f1de181762b5d1b0e321652c39ee7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be8abc7145c020a6067d3acdd6c50f285782772927c4ef4a1975cfe47ea3475c9c8021d3ec2e2163e126696d8d6ad1efbb2c41b1bdf116fbaeb8edaccc33cc59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e0998a7e4d8f2b7f890ced3887a99fecc404d545bd00880cc98576bcd1bb6c02413752eed0b733ca1c70a6e7b9ad057403ffe8ea25172caf7a7952669af2286"} build_url:https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/HntX6dLQRiihjeyH7uG-uw/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/e1a3aa09f73d1f71ea029339e2c522019ac9683ac74c4bb0045d6f9ecb3c09ebc6fc4e38a462ca447bd990cd27b8b8c2f85f1de181762b5d1b0e321652c39ee7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be8abc7145c020a6067d3acdd6c50f285782772927c4ef4a1975cfe47ea3475c9c8021d3ec2e2163e126696d8d6ad1efbb2c41b1bdf116fbaeb8edaccc33cc59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e0998a7e4d8f2b7f890ced3887a99fecc404d545bd00880cc98576bcd1bb6c02413752eed0b733ca1c70a6e7b9ad057403ffe8ea25172caf7a7952669af2286"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 03:54:47.496684) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:54:47.497029) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467542038.659566-696695241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:54:47.579525) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 03:54:47.579859) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 03:54:47.580238) ========= ========= Total master_lag: 0.25 =========