builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1467368410.67 results: success (0) buildid: 20160701004039 builduid: 8a51597d37fa4f45b26de26de4f2910c revision: ab7833ced02512db316393e8186982172159af79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 03:20:10.667771) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 03:20:10.668360) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 03:20:10.668674) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 03:20:10.684356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 03:20:10.684714) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 03:20:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-07-01 03:20:10 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110647 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 03:20:10.812317) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 03:20:10.813027) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020924 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 03:20:10.863891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 03:20:10.864298) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ab7833ced02512db316393e8186982172159af79 --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 ab7833ced02512db316393e8186982172159af79 --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=78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 03:20:11,049 truncating revision to first 12 chars 2016-07-01 03:20:11,049 Setting DEBUG logging. 2016-07-01 03:20:11,049 attempt 1/10 2016-07-01 03:20:11,049 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ab7833ced025?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 03:20:11,394 unpacking tar archive at: mozilla-aurora-ab7833ced025/testing/mozharness/ program finished with exit code 0 elapsedTime=0.697245 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 03:20:11.575625) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 03:20:11.575997) ========= script_repo_revision: ab7833ced02512db316393e8186982172159af79 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 03:20:11.576415) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 03:20:11.576712) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 03:20:11.588260) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-01 03:20:11.588691) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:20:11 INFO - MultiFileLogger online at 20160701 03:20:11 in /builds/slave/test 03:20:11 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:20:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:20:11 INFO - {'append_to_log': False, 03:20:11 INFO - 'base_work_dir': '/builds/slave/test', 03:20:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:20:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:20:11 INFO - 'branch': 'Mozilla-Aurora', 03:20:11 INFO - 'buildbot_json_path': 'buildprops.json', 03:20:11 INFO - 'config_files': ('talos/linux_config.py',), 03:20:11 INFO - 'default_actions': ('clobber', 03:20:11 INFO - 'read-buildbot-config', 03:20:11 INFO - 'download-and-extract', 03:20:11 INFO - 'populate-webroot', 03:20:11 INFO - 'create-virtualenv', 03:20:11 INFO - 'install', 03:20:11 INFO - 'run-tests'), 03:20:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:20:11 INFO - 'download_minidump_stackwalk': True, 03:20:11 INFO - 'download_symbols': 'ondemand', 03:20:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:20:11 INFO - 'tooltool.py': '/tools/tooltool.py', 03:20:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:20:11 INFO - '/tools/misc-python/virtualenv.py')}, 03:20:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:20:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:20:11 INFO - 'installer_path': 'installer.exe', 03:20:11 INFO - 'log_level': 'info', 03:20:11 INFO - 'log_name': 'talos', 03:20:11 INFO - 'log_to_console': True, 03:20:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:20:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:20:11 INFO - 'opt_config_files': (), 03:20:11 INFO - 'pip_index': False, 03:20:11 INFO - 'sps_profile': False, 03:20:11 INFO - 'sps_profile_interval': 0, 03:20:11 INFO - 'suite': 'dromaeojs', 03:20:11 INFO - 'system_bits': '32', 03:20:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:20:11 INFO - 'title': 'talos-linux64-ix-019', 03:20:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:20:11 INFO - 'use_talos_json': True, 03:20:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:20:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:20:11 INFO - 'work_dir': 'build'} 03:20:11 INFO - ##### 03:20:11 INFO - ##### Running clobber step. 03:20:11 INFO - ##### 03:20:11 INFO - Running pre-action listener: _resource_record_pre_action 03:20:11 INFO - Running main action method: clobber 03:20:11 INFO - rmtree: /builds/slave/test/build 03:20:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:20:12 INFO - Running post-action listener: _resource_record_post_action 03:20:12 INFO - ##### 03:20:12 INFO - ##### Finished clobber step (success) 03:20:12 INFO - ##### 03:20:12 INFO - ##### 03:20:12 INFO - ##### Running read-buildbot-config step. 03:20:12 INFO - ##### 03:20:12 INFO - Running pre-action listener: _resource_record_pre_action 03:20:12 INFO - Running main action method: read_buildbot_config 03:20:12 INFO - Using buildbot properties: 03:20:12 INFO - { 03:20:12 INFO - "project": "", 03:20:12 INFO - "product": "firefox", 03:20:12 INFO - "script_repo_revision": "production", 03:20:12 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:20:12 INFO - "repository": "", 03:20:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:20:12 INFO - "buildid": "20160701004039", 03:20:12 INFO - "stage_platform": "linux64-pgo", 03:20:12 INFO - "basedir": "/builds/slave/test", 03:20:12 INFO - "nightly_build": "True", 03:20:12 INFO - "buildnumber": 330, 03:20:12 INFO - "slavename": "talos-linux64-ix-019", 03:20:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:20:12 INFO - "platform": "ubuntu64_hw", 03:20:12 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:20:12 INFO - "branch": "mozilla-aurora", 03:20:12 INFO - "repo_path": "releases/mozilla-aurora", 03:20:12 INFO - "revision": "ab7833ced02512db316393e8186982172159af79", 03:20:12 INFO - "pgo_build": "True", 03:20:12 INFO - "builduid": "8a51597d37fa4f45b26de26de4f2910c", 03:20:12 INFO - "slavebuilddir": "test" 03:20:12 INFO - } 03:20:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:20:12 INFO - Running post-action listener: _resource_record_post_action 03:20:12 INFO - ##### 03:20:12 INFO - ##### Finished read-buildbot-config step (success) 03:20:12 INFO - ##### 03:20:12 INFO - ##### 03:20:12 INFO - ##### Running download-and-extract step. 03:20:12 INFO - ##### 03:20:12 INFO - Running pre-action listener: _resource_record_pre_action 03:20:12 INFO - Running main action method: download_and_extract 03:20:12 INFO - mkdir: /builds/slave/test/build/tests 03:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:12 INFO - https://queue.taskcluster.net/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:20:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:20:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:20:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/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:20:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/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:20:12 INFO - Downloaded 1361 bytes. 03:20:12 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:20:12 INFO - Using the following test package requirements: 03:20:12 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:20:12 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:20:12 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:20:12 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:12 INFO - u'jsshell-linux-x86_64.zip'], 03:20:12 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:20:12 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:20:12 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:20:12 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:20:12 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:20:12 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:20:12 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:12 INFO - https://queue.taskcluster.net/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:20:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:20:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:20:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/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:20:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/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:20:14 INFO - Downloaded 24525242 bytes. 03:20:14 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:20:14 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:20:15 INFO - Return code: 0 03:20:15 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:20:15 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:20:15 INFO - https://queue.taskcluster.net/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:20:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:20:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:20:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/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:20:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/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:20:16 INFO - Downloaded 24525242 bytes. 03:20:16 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:20:16 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:20:17 INFO - Return code: 0 03:20:17 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:20:17 INFO - https://queue.taskcluster.net/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:20:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:20:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:20:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/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:20:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/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:20:18 INFO - Downloaded 10833369 bytes. 03:20:18 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:20:18 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:20:18 INFO - Return code: 0 03:20:18 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:20:18 INFO - https://queue.taskcluster.net/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:20:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:20:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:20:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/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:20:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XzUuSDFpSvKVfHr3R6zsjA/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:20:21 INFO - Downloaded 63603517 bytes. 03:20:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:20:21 INFO - mkdir: /builds/slave/test/properties 03:20:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:20:21 INFO - Writing to file /builds/slave/test/properties/build_url 03:20:21 INFO - Contents: 03:20:21 INFO - build_url:https://queue.taskcluster.net/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:20:21 INFO - Running post-action listener: _resource_record_post_action 03:20:21 INFO - Running post-action listener: set_extra_try_arguments 03:20:21 INFO - ##### 03:20:21 INFO - ##### Finished download-and-extract step (success) 03:20:21 INFO - ##### 03:20:21 INFO - ##### 03:20:21 INFO - ##### Running populate-webroot step. 03:20:21 INFO - ##### 03:20:21 INFO - Running pre-action listener: _resource_record_pre_action 03:20:21 INFO - Running main action method: populate_webroot 03:20:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:20:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:20:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:20:21 INFO - '--tppagecycles', 03:20:21 INFO - '7'], 03:20:21 INFO - 'tests': ['tsvgm']}}, 03:20:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:20:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:20:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:20:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:20:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:20:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:20:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:21 INFO - 'talos_options': ['--disable-e10s'], 03:20:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:21 INFO - 'talos_options': ['--disable-e10s'], 03:20:21 INFO - 'tests': ['damp', 'tps']}, 03:20:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:21 INFO - 'tests': ['damp', 'tps']}, 03:20:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:20:21 INFO - 'tests': ['dromaeo_dom']}, 03:20:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:20:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:20:21 INFO - 'tests': ['a11yr', 03:20:21 INFO - 'ts_paint', 03:20:21 INFO - 'tpaint', 03:20:21 INFO - 'sessionrestore', 03:20:21 INFO - 'sessionrestore_no_auto_restore', 03:20:21 INFO - 'tabpaint']}, 03:20:21 INFO - 'other-e10s': {'tests': ['a11yr', 03:20:21 INFO - 'ts_paint', 03:20:21 INFO - 'tpaint', 03:20:21 INFO - 'sessionrestore', 03:20:21 INFO - 'sessionrestore_no_auto_restore', 03:20:21 INFO - 'tabpaint']}, 03:20:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:20:21 INFO - 'ts_paint', 03:20:21 INFO - 'tpaint', 03:20:21 INFO - 'sessionrestore', 03:20:21 INFO - 'sessionrestore_no_auto_restore', 03:20:21 INFO - 'tabpaint']}, 03:20:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:20:21 INFO - 'ts_paint', 03:20:21 INFO - 'tpaint', 03:20:21 INFO - 'sessionrestore', 03:20:21 INFO - 'sessionrestore_no_auto_restore', 03:20:21 INFO - 'tabpaint']}, 03:20:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:20:21 INFO - 'tests': ['a11yr', 03:20:21 INFO - 'ts_paint', 03:20:21 INFO - 'tpaint', 03:20:21 INFO - 'sessionrestore', 03:20:21 INFO - 'sessionrestore_no_auto_restore', 03:20:21 INFO - 'tabpaint']}, 03:20:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:20:21 INFO - 'tests': ['a11yr', 03:20:21 INFO - 'ts_paint', 03:20:21 INFO - 'tpaint', 03:20:21 INFO - 'sessionrestore', 03:20:21 INFO - 'sessionrestore_no_auto_restore', 03:20:21 INFO - 'tabpaint']}, 03:20:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:20:21 INFO - 'tests': ['tsvgx', 03:20:21 INFO - 'tsvgr_opacity', 03:20:21 INFO - 'tart', 03:20:21 INFO - 'tscrollx', 03:20:21 INFO - 'cart']}, 03:20:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:20:21 INFO - 'tsvgr_opacity', 03:20:21 INFO - 'tart', 03:20:21 INFO - 'tscrollx', 03:20:21 INFO - 'cart']}, 03:20:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:21 INFO - 'talos_options': ['--disable-e10s'], 03:20:21 INFO - 'tests': ['tp5o']}, 03:20:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:21 INFO - 'tests': ['tp5o']}, 03:20:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:21 INFO - 'talos_options': ['--disable-e10s', 03:20:21 INFO - '--xperf_path', 03:20:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:21 INFO - 'tests': ['tp5n']}, 03:20:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:21 INFO - 'talos_options': ['--xperf_path', 03:20:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:21 INFO - 'tests': ['tp5n']}}, 03:20:21 INFO - 'talos.zip': {'path': '', 03:20:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:20:21 INFO - Running post-action listener: _resource_record_post_action 03:20:21 INFO - ##### 03:20:21 INFO - ##### Finished populate-webroot step (success) 03:20:21 INFO - ##### 03:20:21 INFO - ##### 03:20:21 INFO - ##### Running create-virtualenv step. 03:20:21 INFO - ##### 03:20:21 INFO - Running pre-action listener: _resource_record_pre_action 03:20:21 INFO - Running main action method: create_virtualenv 03:20:21 INFO - Creating virtualenv /builds/slave/test/build/venv 03:20:21 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:20:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:20:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:20:22 INFO - Using real prefix '/usr' 03:20:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:20:22 INFO - Installing distribute.............................................................................................................................................................................................done. 03:20:24 INFO - Installing pip.................done. 03:20:24 INFO - Return code: 0 03:20:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:20:24 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:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:24 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:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:24 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 0x7ff4dbfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc21c0>, '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 0xfc30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', '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:20:24 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:20:24 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:20:24 INFO - Using env: {'DISPLAY': ':0', 03:20:24 INFO - 'HOME': '/home/cltbld', 03:20:24 INFO - 'LANG': 'en_US.UTF-8', 03:20:24 INFO - 'LANGUAGE': 'en_US:en', 03:20:24 INFO - 'LOGNAME': 'cltbld', 03:20:24 INFO - 'MAIL': '/var/mail/cltbld', 03:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:24 INFO - 'MOZ_NO_REMOTE': '1', 03:20:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:24 INFO - 'NO_EM_RESTART': '1', 03:20:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:24 INFO - 'PWD': '/builds/slave/test', 03:20:24 INFO - 'SHELL': '/bin/bash', 03:20:24 INFO - 'SHLVL': '1', 03:20:24 INFO - 'TERM': 'linux', 03:20:24 INFO - 'TMOUT': '86400', 03:20:24 INFO - 'USER': 'cltbld', 03:20:24 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', 03:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:24 INFO - '_': '/tools/buildbot/bin/python'} 03:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:24 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:20:24 INFO - Cleaning up... 03:20:24 INFO - Return code: 0 03:20:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:20:24 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:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:24 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:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:24 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 0x7ff4dbfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc21c0>, '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 0xfc30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', '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:20:24 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:20:24 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:20:24 INFO - Using env: {'DISPLAY': ':0', 03:20:24 INFO - 'HOME': '/home/cltbld', 03:20:24 INFO - 'LANG': 'en_US.UTF-8', 03:20:24 INFO - 'LANGUAGE': 'en_US:en', 03:20:24 INFO - 'LOGNAME': 'cltbld', 03:20:24 INFO - 'MAIL': '/var/mail/cltbld', 03:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:24 INFO - 'MOZ_NO_REMOTE': '1', 03:20:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:24 INFO - 'NO_EM_RESTART': '1', 03:20:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:24 INFO - 'PWD': '/builds/slave/test', 03:20:24 INFO - 'SHELL': '/bin/bash', 03:20:24 INFO - 'SHLVL': '1', 03:20:24 INFO - 'TERM': 'linux', 03:20:24 INFO - 'TMOUT': '86400', 03:20:24 INFO - 'USER': 'cltbld', 03:20:24 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', 03:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:24 INFO - '_': '/tools/buildbot/bin/python'} 03:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:24 INFO - Downloading/unpacking psutil>=3.1.1 03:20:24 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:20:24 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:20:24 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:20:24 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:20:24 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:20:24 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:20:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:20:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:26 INFO - Installing collected packages: psutil 03:20:26 INFO - Running setup.py install for psutil 03:20:27 INFO - building 'psutil._psutil_linux' extension 03:20:27 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:20:27 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:20:27 INFO - building 'psutil._psutil_posix' extension 03:20:27 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:20:27 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:20:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:27 INFO - Successfully installed psutil 03:20:27 INFO - Cleaning up... 03:20:27 INFO - Return code: 0 03:20:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:20: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:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20: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:20:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4dbfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc21c0>, '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 0xfc30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', '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:20: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:20: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 mozsystemmonitor==0.3 03:20:27 INFO - Using env: {'DISPLAY': ':0', 03:20:27 INFO - 'HOME': '/home/cltbld', 03:20:27 INFO - 'LANG': 'en_US.UTF-8', 03:20:27 INFO - 'LANGUAGE': 'en_US:en', 03:20:27 INFO - 'LOGNAME': 'cltbld', 03:20:27 INFO - 'MAIL': '/var/mail/cltbld', 03:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:27 INFO - 'MOZ_NO_REMOTE': '1', 03:20:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:27 INFO - 'NO_EM_RESTART': '1', 03:20:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:27 INFO - 'PWD': '/builds/slave/test', 03:20:27 INFO - 'SHELL': '/bin/bash', 03:20:27 INFO - 'SHLVL': '1', 03:20:27 INFO - 'TERM': 'linux', 03:20:27 INFO - 'TMOUT': '86400', 03:20:27 INFO - 'USER': 'cltbld', 03:20:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', 03:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:27 INFO - '_': '/tools/buildbot/bin/python'} 03:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:20:27 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:20:27 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:20:27 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:20:27 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:20:27 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:20:27 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:20:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:20:29 INFO - Installing collected packages: mozsystemmonitor 03:20:29 INFO - Running setup.py install for mozsystemmonitor 03:20:29 INFO - Successfully installed mozsystemmonitor 03:20:29 INFO - Cleaning up... 03:20:29 INFO - Return code: 0 03:20:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:20:29 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:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:29 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:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:29 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 0x7ff4dbfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc21c0>, '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 0xfc30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', '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:20:29 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:20:29 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:20:29 INFO - Using env: {'DISPLAY': ':0', 03:20:29 INFO - 'HOME': '/home/cltbld', 03:20:29 INFO - 'LANG': 'en_US.UTF-8', 03:20:29 INFO - 'LANGUAGE': 'en_US:en', 03:20:29 INFO - 'LOGNAME': 'cltbld', 03:20:29 INFO - 'MAIL': '/var/mail/cltbld', 03:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:29 INFO - 'MOZ_NO_REMOTE': '1', 03:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:29 INFO - 'NO_EM_RESTART': '1', 03:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:29 INFO - 'PWD': '/builds/slave/test', 03:20:29 INFO - 'SHELL': '/bin/bash', 03:20:29 INFO - 'SHLVL': '1', 03:20:29 INFO - 'TERM': 'linux', 03:20:29 INFO - 'TMOUT': '86400', 03:20:29 INFO - 'USER': 'cltbld', 03:20:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', 03:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:29 INFO - '_': '/tools/buildbot/bin/python'} 03:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:30 INFO - Downloading/unpacking jsonschema==2.5.1 03:20:30 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:20:30 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:20:30 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:20:30 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:20:30 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:20:30 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:20:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:20:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:20: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:20: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:20: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:20: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:20: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:20: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:20:32 INFO - Downloading functools32-3.2.3-2.tar.gz 03:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:20:32 INFO - warning: no files found matching '*.txt' 03:20:32 INFO - no previously-included directories found matching 'build' 03:20:32 INFO - no previously-included directories found matching 'dist' 03:20:32 INFO - no previously-included directories found matching '.git*' 03:20:32 INFO - Installing collected packages: jsonschema, functools32 03:20:32 INFO - Running setup.py install for functools32 03:20:32 INFO - warning: no files found matching '*.txt' 03:20:32 INFO - no previously-included directories found matching 'build' 03:20:32 INFO - no previously-included directories found matching 'dist' 03:20:32 INFO - no previously-included directories found matching '.git*' 03:20:32 INFO - Successfully installed jsonschema functools32 03:20:32 INFO - Cleaning up... 03:20:32 INFO - Return code: 0 03:20:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:20:32 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:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:32 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:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:32 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 0x7ff4dbfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc21c0>, '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 0xfc30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', '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:20:32 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:20:32 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:20:32 INFO - Using env: {'DISPLAY': ':0', 03:20:32 INFO - 'HOME': '/home/cltbld', 03:20:32 INFO - 'LANG': 'en_US.UTF-8', 03:20:32 INFO - 'LANGUAGE': 'en_US:en', 03:20:32 INFO - 'LOGNAME': 'cltbld', 03:20:32 INFO - 'MAIL': '/var/mail/cltbld', 03:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:32 INFO - 'MOZ_NO_REMOTE': '1', 03:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:32 INFO - 'NO_EM_RESTART': '1', 03:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:32 INFO - 'PWD': '/builds/slave/test', 03:20:32 INFO - 'SHELL': '/bin/bash', 03:20:32 INFO - 'SHLVL': '1', 03:20:32 INFO - 'TERM': 'linux', 03:20:32 INFO - 'TMOUT': '86400', 03:20:32 INFO - 'USER': 'cltbld', 03:20:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', 03:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:32 INFO - '_': '/tools/buildbot/bin/python'} 03:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:32 INFO - Downloading/unpacking blobuploader==1.2.4 03:20:32 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:20:32 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:20:32 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:20:32 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:20:32 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:20:32 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:20:34 INFO - Downloading blobuploader-1.2.4.tar.gz 03:20:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:20:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:20:34 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:20:34 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:20:34 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:20:34 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:20:34 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:20:34 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:20:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:20:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:20:34 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:20:34 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:20:34 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:20:34 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:20:34 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:20:34 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:20:35 INFO - Downloading docopt-0.6.1.tar.gz 03:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:20:35 INFO - Installing collected packages: blobuploader, requests, docopt 03:20:35 INFO - Running setup.py install for blobuploader 03:20:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:20:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:20:35 INFO - Running setup.py install for requests 03:20:35 INFO - Running setup.py install for docopt 03:20:35 INFO - Successfully installed blobuploader requests docopt 03:20:35 INFO - Cleaning up... 03:20:35 INFO - Return code: 0 03:20:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:35 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 0x7ff4dbfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc21c0>, '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 0xfc30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', '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:20:35 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:20:35 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:20:35 INFO - Using env: {'DISPLAY': ':0', 03:20:35 INFO - 'HOME': '/home/cltbld', 03:20:35 INFO - 'LANG': 'en_US.UTF-8', 03:20:35 INFO - 'LANGUAGE': 'en_US:en', 03:20:35 INFO - 'LOGNAME': 'cltbld', 03:20:35 INFO - 'MAIL': '/var/mail/cltbld', 03:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:35 INFO - 'MOZ_NO_REMOTE': '1', 03:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:35 INFO - 'NO_EM_RESTART': '1', 03:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:35 INFO - 'PWD': '/builds/slave/test', 03:20:35 INFO - 'SHELL': '/bin/bash', 03:20:35 INFO - 'SHLVL': '1', 03:20:35 INFO - 'TERM': 'linux', 03:20:35 INFO - 'TMOUT': '86400', 03:20:35 INFO - 'USER': 'cltbld', 03:20:35 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', 03:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:35 INFO - '_': '/tools/buildbot/bin/python'} 03:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:36 INFO - Running setup.py (path:/tmp/pip-RaOiy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:36 INFO - Running setup.py (path:/tmp/pip-pDJYRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:36 INFO - Running setup.py (path:/tmp/pip-cXzxHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:36 INFO - Running setup.py (path:/tmp/pip-p3hBgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:36 INFO - Running setup.py (path:/tmp/pip-1WFpPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:36 INFO - Running setup.py (path:/tmp/pip-OZyHMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:36 INFO - Running setup.py (path:/tmp/pip-Y8x4EA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:36 INFO - Running setup.py (path:/tmp/pip-LVMYZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:36 INFO - Running setup.py (path:/tmp/pip-7RwPvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:36 INFO - Running setup.py (path:/tmp/pip-UfQOu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:36 INFO - Running setup.py (path:/tmp/pip-XX6Rd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:36 INFO - Running setup.py (path:/tmp/pip-qE3ooh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:36 INFO - Running setup.py (path:/tmp/pip-P64HGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:37 INFO - Running setup.py (path:/tmp/pip-lCeY_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:37 INFO - Running setup.py (path:/tmp/pip-uCZvvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:37 INFO - Running setup.py (path:/tmp/pip-4gyfqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:37 INFO - Running setup.py (path:/tmp/pip-GEcfhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:20:37 INFO - Running setup.py install for manifestparser 03:20:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:20:37 INFO - Running setup.py install for mozcrash 03:20:37 INFO - Running setup.py install for mozdebug 03:20:37 INFO - Running setup.py install for mozdevice 03:20:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:20:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:20:37 INFO - Running setup.py install for mozfile 03:20:37 INFO - Running setup.py install for mozhttpd 03:20:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:20:37 INFO - Running setup.py install for mozinfo 03:20:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:20:38 INFO - Running setup.py install for mozInstall 03:20:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:20:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:20:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:20:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:20:38 INFO - Running setup.py install for mozleak 03:20:38 INFO - Running setup.py install for mozlog 03:20:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:20:38 INFO - Running setup.py install for moznetwork 03:20:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:20:38 INFO - Running setup.py install for mozprocess 03:20:38 INFO - Running setup.py install for mozprofile 03:20:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:20:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:20:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:20:38 INFO - Running setup.py install for mozrunner 03:20:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:20:38 INFO - Running setup.py install for mozscreenshot 03:20:38 INFO - Running setup.py install for moztest 03:20:38 INFO - Running setup.py install for mozversion 03:20:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:20:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:20:39 INFO - Cleaning up... 03:20:39 INFO - Return code: 0 03:20:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20: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:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20: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:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:39 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 0x7ff4dbfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc21c0>, '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 0xfc30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', '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:20:39 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:20:39 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:20:39 INFO - Using env: {'DISPLAY': ':0', 03:20:39 INFO - 'HOME': '/home/cltbld', 03:20:39 INFO - 'LANG': 'en_US.UTF-8', 03:20:39 INFO - 'LANGUAGE': 'en_US:en', 03:20:39 INFO - 'LOGNAME': 'cltbld', 03:20:39 INFO - 'MAIL': '/var/mail/cltbld', 03:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:39 INFO - 'MOZ_NO_REMOTE': '1', 03:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:39 INFO - 'NO_EM_RESTART': '1', 03:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:39 INFO - 'PWD': '/builds/slave/test', 03:20:39 INFO - 'SHELL': '/bin/bash', 03:20:39 INFO - 'SHLVL': '1', 03:20:39 INFO - 'TERM': 'linux', 03:20:39 INFO - 'TMOUT': '86400', 03:20:39 INFO - 'USER': 'cltbld', 03:20:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', 03:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:39 INFO - '_': '/tools/buildbot/bin/python'} 03:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:39 INFO - Running setup.py (path:/tmp/pip-lT3eEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:39 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:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:39 INFO - Running setup.py (path:/tmp/pip-FSJVRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:39 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:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:39 INFO - Running setup.py (path:/tmp/pip-O1Kwwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:39 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:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:39 INFO - Running setup.py (path:/tmp/pip-IE9Gci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:39 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:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:39 INFO - Running setup.py (path:/tmp/pip-BNKFDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:39 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:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:39 INFO - Running setup.py (path:/tmp/pip-are4Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:39 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:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:39 INFO - Running setup.py (path:/tmp/pip-9oDrhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:39 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:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:39 INFO - Running setup.py (path:/tmp/pip-vOaxxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:39 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:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:39 INFO - Running setup.py (path:/tmp/pip-YA5KX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:39 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:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:39 INFO - Running setup.py (path:/tmp/pip-0QJvzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:40 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:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:40 INFO - Running setup.py (path:/tmp/pip-Me4791-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:40 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:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:40 INFO - Running setup.py (path:/tmp/pip-1CW5c4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:40 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:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:40 INFO - Running setup.py (path:/tmp/pip-hMP90d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:40 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:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:40 INFO - Running setup.py (path:/tmp/pip-ecc6bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:40 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:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:40 INFO - Running setup.py (path:/tmp/pip-ipotnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:40 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:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:40 INFO - Running setup.py (path:/tmp/pip-i2_BwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:40 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:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:40 INFO - Running setup.py (path:/tmp/pip-HlqnMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:40 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:20:40 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:20:40 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:20:40 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:20:40 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:20:40 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:20:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:20:40 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:20:40 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:20:40 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:20:40 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:20:40 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:20:40 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:20:42 INFO - Downloading blessings-1.6.tar.gz 03:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:20:42 INFO - Installing collected packages: blessings 03:20:42 INFO - Running setup.py install for blessings 03:20:42 INFO - Successfully installed blessings 03:20:42 INFO - Cleaning up... 03:20:42 INFO - Return code: 0 03:20:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:42 INFO - Reading from file tmpfile_stdout 03:20:42 INFO - Current package versions: 03:20:42 INFO - argparse == 1.2.1 03:20:42 INFO - blessings == 1.6 03:20:42 INFO - blobuploader == 1.2.4 03:20:42 INFO - docopt == 0.6.1 03:20:42 INFO - functools32 == 3.2.3-2 03:20:42 INFO - jsonschema == 2.5.1 03:20:42 INFO - manifestparser == 1.1 03:20:42 INFO - mozInstall == 1.12 03:20:42 INFO - mozcrash == 0.17 03:20:42 INFO - mozdebug == 0.1 03:20:42 INFO - mozdevice == 0.48 03:20:42 INFO - mozfile == 1.2 03:20:42 INFO - mozhttpd == 0.7 03:20:42 INFO - mozinfo == 0.9 03:20:42 INFO - mozleak == 0.1 03:20:42 INFO - mozlog == 3.2 03:20:42 INFO - moznetwork == 0.27 03:20:42 INFO - mozprocess == 0.22 03:20:42 INFO - mozprofile == 0.28 03:20:42 INFO - mozrunner == 6.11 03:20:42 INFO - mozscreenshot == 0.1 03:20:42 INFO - mozsystemmonitor == 0.3 03:20:42 INFO - moztest == 0.7 03:20:42 INFO - mozversion == 1.4 03:20:42 INFO - psutil == 3.1.1 03:20:42 INFO - requests == 1.2.3 03:20:42 INFO - wsgiref == 0.1.2 03:20:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20: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:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20: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:20:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:42 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 0x7ff4dbfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc21c0>, '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 0xfc30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', '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:20:42 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:20:42 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:20:42 INFO - Using env: {'DISPLAY': ':0', 03:20:42 INFO - 'HOME': '/home/cltbld', 03:20:42 INFO - 'LANG': 'en_US.UTF-8', 03:20:42 INFO - 'LANGUAGE': 'en_US:en', 03:20:42 INFO - 'LOGNAME': 'cltbld', 03:20:42 INFO - 'MAIL': '/var/mail/cltbld', 03:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:42 INFO - 'MOZ_NO_REMOTE': '1', 03:20:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:42 INFO - 'NO_EM_RESTART': '1', 03:20:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:42 INFO - 'PWD': '/builds/slave/test', 03:20:42 INFO - 'SHELL': '/bin/bash', 03:20:42 INFO - 'SHLVL': '1', 03:20:42 INFO - 'TERM': 'linux', 03:20:42 INFO - 'TMOUT': '86400', 03:20:42 INFO - 'USER': 'cltbld', 03:20:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', 03:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:42 INFO - '_': '/tools/buildbot/bin/python'} 03:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:43 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:20:43 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:20:43 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:20:43 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:20:43 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:20:43 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:20:43 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:20:43 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:20:43 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:20:43 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:20:43 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:20:43 INFO - Cleaning up... 03:20:43 INFO - Return code: 0 03:20:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:20:43 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:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:43 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:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:43 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 0x7ff4dbfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc21c0>, '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 0xfc30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', '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:20:43 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:20:43 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:20:43 INFO - Using env: {'DISPLAY': ':0', 03:20:43 INFO - 'HOME': '/home/cltbld', 03:20:43 INFO - 'LANG': 'en_US.UTF-8', 03:20:43 INFO - 'LANGUAGE': 'en_US:en', 03:20:43 INFO - 'LOGNAME': 'cltbld', 03:20:43 INFO - 'MAIL': '/var/mail/cltbld', 03:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:43 INFO - 'MOZ_NO_REMOTE': '1', 03:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:43 INFO - 'NO_EM_RESTART': '1', 03:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:43 INFO - 'PWD': '/builds/slave/test', 03:20:43 INFO - 'SHELL': '/bin/bash', 03:20:43 INFO - 'SHLVL': '1', 03:20:43 INFO - 'TERM': 'linux', 03:20:43 INFO - 'TMOUT': '86400', 03:20:43 INFO - 'USER': 'cltbld', 03:20:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', 03:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:43 INFO - '_': '/tools/buildbot/bin/python'} 03:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:20:43 INFO - Cleaning up... 03:20:43 INFO - Return code: 0 03:20:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:20:43 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:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:43 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:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:43 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 0x7ff4dbfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc21c0>, '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 0xfc30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', '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:20:43 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:20:43 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:20:43 INFO - Using env: {'DISPLAY': ':0', 03:20:43 INFO - 'HOME': '/home/cltbld', 03:20:43 INFO - 'LANG': 'en_US.UTF-8', 03:20:43 INFO - 'LANGUAGE': 'en_US:en', 03:20:43 INFO - 'LOGNAME': 'cltbld', 03:20:43 INFO - 'MAIL': '/var/mail/cltbld', 03:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:43 INFO - 'MOZ_NO_REMOTE': '1', 03:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:43 INFO - 'NO_EM_RESTART': '1', 03:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:43 INFO - 'PWD': '/builds/slave/test', 03:20:43 INFO - 'SHELL': '/bin/bash', 03:20:43 INFO - 'SHLVL': '1', 03:20:43 INFO - 'TERM': 'linux', 03:20:43 INFO - 'TMOUT': '86400', 03:20:43 INFO - 'USER': 'cltbld', 03:20:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', 03:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:43 INFO - '_': '/tools/buildbot/bin/python'} 03:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:43 INFO - Downloading/unpacking flake8 03:20:43 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:20:43 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:20:43 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:20:43 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:20:43 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:20:43 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:20:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:20:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:20:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:20:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:20:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:20:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:20:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:20:46 INFO - no previously-included directories found matching 'docs/_build' 03:20:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:20:46 INFO - Running setup.py install for pep8 03:20:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:20:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:20:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:20:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:20:46 INFO - no previously-included directories found matching 'docs/_build' 03:20:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:20:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:20:46 INFO - Cleaning up... 03:20:46 INFO - Return code: 0 03:20:46 INFO - Running post-action listener: _resource_record_post_action 03:20:46 INFO - Running post-action listener: _start_resource_monitoring 03:20:46 INFO - Starting resource monitoring. 03:20:46 INFO - ##### 03:20:46 INFO - ##### Finished create-virtualenv step (success) 03:20:46 INFO - ##### 03:20:46 INFO - ##### 03:20:46 INFO - ##### Running install step. 03:20:46 INFO - ##### 03:20:46 INFO - Running pre-action listener: _resource_record_pre_action 03:20:46 INFO - Running main action method: install 03:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:46 INFO - Reading from file tmpfile_stdout 03:20:46 INFO - Detecting whether we're running mozinstall >=1.0... 03:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:20:46 INFO - Reading from file tmpfile_stdout 03:20:46 INFO - Output received: 03:20:46 INFO - Usage: mozinstall [options] installer 03:20:46 INFO - Options: 03:20:46 INFO - -h, --help show this help message and exit 03:20:46 INFO - -d DEST, --destination=DEST 03:20:46 INFO - Directory to install application into. [default: 03:20:46 INFO - "/builds/slave/test"] 03:20:46 INFO - --app=APP Application being installed. [default: firefox] 03:20:46 INFO - mkdir: /builds/slave/test/build/application 03:20:46 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:20:46 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:21:02 INFO - Reading from file tmpfile_stdout 03:21:02 INFO - Output received: 03:21:02 INFO - /builds/slave/test/build/application/firefox/firefox 03:21:02 INFO - Running post-action listener: _resource_record_post_action 03:21:02 INFO - ##### 03:21:02 INFO - ##### Finished install step (success) 03:21:02 INFO - ##### 03:21:02 INFO - ##### 03:21:02 INFO - ##### Running run-tests step. 03:21:02 INFO - ##### 03:21:02 INFO - Running pre-action listener: _resource_record_pre_action 03:21:02 INFO - Running main action method: run_tests 03:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:21:02 INFO - Python 2.7.3 03:21:02 INFO - Return code: 0 03:21:02 INFO - grabbing minidump binary from tooltool 03:21:02 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:21:02 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 0xfc21c0>, '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 0xfc30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc3550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:21:02 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:21:02 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:21:02 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:21:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:21:02 INFO - Return code: 0 03:21:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:21:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:21:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:21:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:21:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:21:03 INFO - Return code: 0 03:21:03 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/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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:21:03 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/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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:21:03 INFO - Using env: {'DISPLAY': ':0', 03:21:03 INFO - 'HOME': '/home/cltbld', 03:21:03 INFO - 'LANG': 'en_US.UTF-8', 03:21:03 INFO - 'LANGUAGE': 'en_US:en', 03:21:03 INFO - 'LOGNAME': 'cltbld', 03:21:03 INFO - 'MAIL': '/var/mail/cltbld', 03:21:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:03 INFO - 'MOZ_NO_REMOTE': '1', 03:21:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:03 INFO - 'NO_EM_RESTART': '1', 03:21:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:03 INFO - 'PWD': '/builds/slave/test', 03:21:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:03 INFO - 'SHELL': '/bin/bash', 03:21:03 INFO - 'SHLVL': '1', 03:21:03 INFO - 'TERM': 'linux', 03:21:03 INFO - 'TMOUT': '86400', 03:21:03 INFO - 'USER': 'cltbld', 03:21:03 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785', 03:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:03 INFO - '_': '/tools/buildbot/bin/python'} 03:21:03 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/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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:21:03 INFO - mozversion application_buildid: 20160701004039 03:21:03 INFO - mozversion application_changeset: ab7833ced02512db316393e8186982172159af79 03:21:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:21:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:21:03 INFO - mozversion application_name: Firefox 03:21:03 INFO - mozversion application_remotingname: firefox-dev 03:21:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:21:03 INFO - mozversion application_vendor: Mozilla 03:21:03 INFO - mozversion application_version: 49.0a2 03:21:03 INFO - mozversion platform_buildid: 20160701004039 03:21:03 INFO - mozversion platform_changeset: ab7833ced02512db316393e8186982172159af79 03:21:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:21:03 INFO - mozversion platform_version: 49.0a2 03:21:03 INFO - using testdate: 1467368463 03:21:03 INFO - actual date: 1467368463 03:21:03 INFO - starting webserver on 'localhost:47361' 03:21:03 INFO - SUITE-START | Running 2 tests 03:21:03 INFO - TEST-START | dromaeo_css 03:21:03 INFO - operating with platform_type : linux_ 03:21:03 INFO - Initialising browser for dromaeo_css test... 03:21:03 INFO - TEST-INFO | started process 19380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaH43yi/profile http://localhost:47361/getInfo.html) 03:21:07 INFO - PROCESS | 19380 | __metrics Screen width/height:1600/1200 03:21:07 INFO - PROCESS | 19380 | colorDepth:24 03:21:07 INFO - PROCESS | 19380 | Browser inner width/height: 1024/697 03:21:07 INFO - PROCESS | 19380 | __metrics 03:21:09 ERROR - PROCESS | 19380 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:21:10 INFO - TEST-INFO | 19380: exit 0 03:21:10 INFO - Browser initialized. 03:21:10 INFO - Running cycle 1/1 for dromaeo_css test... 03:21:10 INFO - TEST-INFO | started process 19473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaH43yi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:21 INFO - PROCESS | 19473 | RSS: Main: 145002496 03:21:21 INFO - PROCESS | 19473 | 03:22:13 INFO - PROCESS | 19473 | 1467368533194 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:24:21 INFO - PROCESS | 19473 | Cycle 1(1): loaded http://localhost:47361/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47361/tests/dromaeo/cssquery-ext.html) 03:24:22 INFO - PROCESS | 19473 | RSS: Main: 256335872 03:24:22 INFO - PROCESS | 19473 | 03:27:25 INFO - PROCESS | 19473 | Cycle 1(1): loaded http://localhost:47361/tests/dromaeo/cssquery-ext.html (next: http://localhost:47361/tests/dromaeo/cssquery-jquery.html) 03:27:25 INFO - PROCESS | 19473 | RSS: Main: 229564416 03:27:25 INFO - PROCESS | 19473 | 03:30:27 INFO - PROCESS | 19473 | Cycle 1(1): loaded http://localhost:47361/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47361/tests/dromaeo/cssquery-mootools.html) 03:30:28 INFO - PROCESS | 19473 | RSS: Main: 224399360 03:30:28 INFO - PROCESS | 19473 | 03:33:29 INFO - PROCESS | 19473 | Cycle 1(1): loaded http://localhost:47361/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47361/tests/dromaeo/cssquery-prototype.html) 03:33:30 INFO - PROCESS | 19473 | RSS: Main: 226754560 03:33:30 INFO - PROCESS | 19473 | 03:36:33 INFO - PROCESS | 19473 | Cycle 1(1): loaded http://localhost:47361/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47361/tests/dromaeo/cssquery-yui.html) 03:36:33 INFO - PROCESS | 19473 | RSS: Main: 215404544 03:36:33 INFO - PROCESS | 19473 | 03:39:36 INFO - PROCESS | 19473 | Cycle 1(1): loaded http://localhost:47361/tests/dromaeo/cssquery-yui.html (next: http://localhost:47361/tests/dromaeo/cssquery-dojo.html) 03:39:36 INFO - PROCESS | 19473 | RSS: Main: 261263360 03:39:36 INFO - PROCESS | 19473 | 03:39:36 INFO - PROCESS | 19473 | __start_tp_report 03:39:36 INFO - PROCESS | 19473 | _x_x_mozilla_page_load 03:39:36 INFO - PROCESS | 19473 | _x_x_mozilla_page_load_details 03:39:36 INFO - PROCESS | 19473 | |i|pagename|runs| 03:39:36 INFO - PROCESS | 19473 | |0;dojo.html;3370.9831450842744;3405.7615966882327;3415.129142068772;3436.4673475611257;3452.5511683481145;5613.494785469307;5696.487316141546;5715.199872017921;5717.085266357383;5720.5995580309345;5650.773969041244;5657.094864821629;5701.372848986619;5705.800296989606;5707.800226992056;5019.071471777715;5132.589392848572;5176.922346164811;5182.041322355358;5222.425533191365;5075.746212689369;5169.172932330828;5207.973960130194;5217.895642087156;5219.869503262411;5139.049275883955;5184.507471790174;5218.452062533436;5221.71280579568;5240.240165176047;5258.789648414078;5271.051210782058;5272.261883336336;5283.63014588979;5300.549453296474;5014.548690617826;5057.848264552069;5081.79672813087;5173.974130129325;5175.767090480937;5472.644278121909;5472.72636368184;5488.53347465466;5505.091659876116;5525.475079867447;6017.699115044274;6019.909701354483;6056.6063205891915;6057.969710151465;6058.27300723916;6055.484582921135;6059.848503787396;6138.786925362681;6145.4161854623735;6236.469900058455;5824.534037277008;5871.588988770788;5874.676892770896;5879.882402351929;5880.0885862691775;6135.07973803933;6356.269029061625;6360.586561873463;6367.267764207083;6367.395097465734;5853.0635098384055;5907.940920590825;5910.083936989773;5978.342382337939;5979.1928089707335;6041.033434650435;6041.667708276087;6048.425399587032;6064.575479716465;6071.726772295257;5909.881802363929;5999.160117583542;6005.669688167105;6021.397860214031;6023.578349515579;6040.788572399945;6101.359357267423;6119.106526814713;6120.660465672121;6144.109104179869;4592.655550833634;4639;4646;4646.697964632288;4657.394538710014;4088.0801819590356;4097.7541347519245;4114.321137012359;4133.111381053088;4147.792610369469;5840.503557197686;5843.18195452637;5845.853853653693;5854.882902341929;5880.7353669085;6131.816045518642;6150.969245153746;6166.229221347332;6172.845678858064;6195.31851496335;5707.200991861143;5719;5722;5724.856878578069;5880.353161152269;5237.057329680694;5238.188080847474;5239.554637855825;5247.10799164143;5249.055170069348;6317.399847014526;6326.905096423558;6327.936720632827;6328.398802113792;6331.3352098029045;5934.970325148347;6036.3661815510495;6071.574989750675;6084.513238940785;6122.448979591858;6296.716647750954;6306.65313407767;6319.936800631935;6336.809895703136;6339.017452294902;5908.911366329595;5977.7310021050025;5981.282246130492;5981.401859814157;5988.131720900532;6024.487918526975;6058.787942421994;6100.481459076028;6123.785667501616;6138.600990935575;5984.491318237824;5989;5992.64044157352;5993.490553302844;6021.126936594257;5832;5892.086726557391;5915.994280972331;5977.850553736192;5984.102384642339;5811.476967072984;5865.5600829937075;5907.940920590911;5917.497012753965;5945.821625351246;6029.668368239789;6065.3934606539;6066.7269972850445;6069.635821850703;6076.878462430638;5755.971220143872;5786.30564332266;5794.101914203306;5896.086106653475;5904.0553511437965 03:39:36 INFO - PROCESS | 19473 | |1;ext.html;592.8073376152752;631.4159402552639;650.3853858104092;657.658017830728;682.5563383800526;32929.83535082324;46282.30576541355;46861.0627787444;47005;47114.2932856007;49424.752876235565;49620.50379496204;49703.50296497034;49753.50246497534;49972.75013624936;8399.37004724645;8959.193672569467;9199.402038867453;9200.309976751736;10940.3982780947;10635.468226588679;10744.086752626035;11058.668239952814;11070.944645276762;11071.778564428707;11109.44452777362;11177.7205569861;11181.44092795361;11188.66434006981;11189.216754827165;8608.870866937032;8830.42602230853;10739.677809665722;10980.615678451215;11042.227044106916;10911.618093366773;10960.28758130727;10985.066269367033;10987.450627468674;10989.835152472719;45380.092398152185;45580.772096139306;45840;45908.770456147504;45935;3859.3439115350457;3899.6880249579967;3937.960620393788;3941.625545573166;3999.2201520703475;35394.46908296378;36426.45360319597;36489.452658210146;36561;36675.26649467022;4752.120857641347;4863.781129849165;4911;4912.459629440758;4963.602911767086;130874;131293.34353328173;390151;392007;393355.0332248349;38920.610793892265;39724.2055158901;39995.40006899899;71023;71581;42285.1542969145;42392.36411453831;42515.7874210627;42563.51027714077;42577.36133957993;17671.38150164738;17881.642367152584;17883.552911177325;17883.642327153386;17884.821151788576;13327.866721332857;14045.648858778612;14440.566782996528;14475.203863787592;14868.479603213835;9525.523723813782;9527.809443811086;9537.952310238405;9548.761280968032;9623.989481104523;3561.893143205708;3602.081469225383;3619.2399596084592;3625.619309972468;3707.7404581679025;1036.7978244242452;1142.1719253541282;1146.3179408252242;1170.9004734597484;1233.586748439265;34517.65482345144;34659;34661.133471662906;34875;34988.43014858414;1198.0954379443465;1206.4510647655295;1228.784962631536;1242.4595301044076;1252.9686757830946;17771.200295986713;17794.733079003825;18329.90835045816;18331.17509712066;18539.165737541574;630015;636092;637011;637968;639179.8041009766;63727.36272637214;64602.353976459635;64793.67603161954;64854.67572662201;64908.35091649023;1359.6532884114488;1466.2375564706292;1471.4702707025463;1522.7563589825575;1522.7791970164485;33721.3255734879;34778.82610586931;35384.46923296204;35640.4653930186;35972.82013589915;54016.18975715289;54910;54928;54985;55012.44987550073;343851;345459;345834;346756;346977;27924.162275131777;30147.69852301449;30918;31492.842535787175;33013.83493082519;52248;52970.73514632402;53524.732376337866;53594.73202634118;54030.729846350514;43744.343834841864;44042.779786100866;44433.77783111064;44945.32582011338;46183.76908115438;43414.15269276025;43978.56021439745;44179.337309939736;44823.32765008593;45367.09265814731;43458;44277.11445771131;44657;45052.774736126106;45182.77408612936;37989;39611.60388396079;39882;39889;39892.401613975235;29250.853745731987;29501.409971800014;29607.85196074006;29736;29860 03:39:36 INFO - PROCESS | 19473 | |2;jquery.html;427.70060957329866;429.8581468115522;437.85719272698253;443.5077064458451;449.3260109835247;18812.059397030163;19586.608267834654;19605.50986225345;21301.360959171212;21408.464788380297;20122.094505747238;20390;20691.689624655606;20729.170833166656;20741.896290518525;5644.887102257962;5877.118432235156;5901.645901245917;5907.970460147715;5909.940900591004;5737.196792449061;5773.249477567911;5828.621139625932;5838.766449342022;5839.824805255849;5774.769009239625;5778.624389414675;5790.420957904197;5792.6524408535415;5808.709564521778;5579.9163012554845;5752.424757524256;5757.050086735683;5762.51018663412;5764.365919748824;5040.621953353477;5048.495150484959;5231.633785635007;5231.843044708665;5235.973820130913;23463.253829746023;23507.76492235073;23568.175113870933;23571.7642823573;23726.288211353687;2567.8459292442512;2576.561984462646;2789.623400840901;2862.4990626640256;2947.513660246057;14156.433742650283;14647.12117272967;14800.185989770558;15302.464413745576;15509.767353489706;2056.8251698605636;2061.7835127311564;2075.937721868346;2130.7549631792385;2171.7393912730417;80239.5988020062;81245;81444;82218;82475.17524824735;10934.125269978382;11161.776764464828;11411.828822567668;11464.25482343645;11476.54093836254;15983.760243596354;16080.919595402182;16147.596310092342;16185.59536011609;16213.837861621469;8657.61040753155;8837.204651581389;8864.468131912106;8983.326250531236;8983.775405614912;8678.739637810875;8701.216890479887;8748.737537873747;8858.955705221562;8861.556922153866;6983.755568555178;7011.509194356346;7063.71745130189;7096.219415864251;7184.856302873914;2045.5499790046167;2073.8548301619044;2089.6865470179596;2125.4686328417897;2141.785821417846;1030.9793804124026;1053.947302634865;1065.4299949526967;1131.598282609678;1137.7838210739933;19213.135408906353;19536.218551258076;19892.70160947587;19919.900400498194;19960.401187964384;1086.413336798136;1101.8787933327328;1104.4091411095026;1118.9776204476027;1139.7036770439745;11118.499667514981;11554.133439992034;11593.6521904343;11641.825372619418;11690.70773230676;464044;468327;468377;477245;479469;44660.356979044365;83671;87091;87136;90216.78544412083;1124.6288724720823;1141.3323205924462;1170.3259981682647;1199.9100067494974;1203.8976686981705;17738.91130544339;17829.197686104417;18139.637207255517;18296.542586435444;18500.537486562942;37793;39172.6082739169;39643.207135856544;40307.3953890686;41351.7932410336;54124.729376352865;54240;54242;54290.185647216116;54426.45573544214;6530.346965303432;8953.59708813118;9126.954365228132;9244.630214791334;9369.15677588993;12139.332336721565;13431.112310853214;13972.231527266098;13998.580042598738;14238.928805355907;11783.52865885355;12068;12175;12260.938695306466;12443.93778031104;11783.175177737476;11880;11937.582184623496;12072.3360215189;12081.69795755078;12232.633021009384;12301.261924284214;12375;12406.193597416139;12598.748025039631;9042.367034307536;9148.908510915071;9183.311251656287;9211.907880921373;9230.35387522867;12427.813582796085;12460;12586.118971671895;12634.87365126337;12649.304288264233 03:39:36 INFO - PROCESS | 19473 | |3;mootools.html;1429.5711286614014;1592.6416556274835;1637.8525932666057;1808.6834803909312;1965.9901700491496;9087.818243635124;9507.952460237697;9546.093121153488;9722.125008749212;9776.071273229032;9437.622495100204;9704;9721.805563888718;9724.756881077976;9748;2219.9223027194053;2282.7374851891996;2492.1152990688315;2503.874806259684;2568.768810807027;2560.539102961466;2591.844489330637;2599.2072417912623;2601.856897870616;2605.387733882536;2509.5357358888664;2564.2307307807678;2565.102214225016;2567.165671156872;2567.679040119985;2159.4601349662585;2368.95262094758;2447.5839107351794;2464.002079157926;2464.963025554618;2493.5012997400413;2498.5877330240487;2511.7739403453775;2523.6340730594143;2538.7588179122954;9823.410595364301;9912.752181195456;9921.057499537605;9923.305368624198;9924.950375248078;5625;5750.769969201227;5754.050581654022;5754.3094828620415;5756.309242890838;3611.56661200655;3692.1138926657677;3706.314331848617;3719.144596742737;3749.5875453700073;1317.0583033131356;1321.7752981992987;1337.4650139944004;1338.1502745756516;1358.1647286918574;14159.22124283164;14474.638134046627;14514.201718905457;14544.345504452325;14596;5095.745212739423;5124.436312005676;5154.664946778447;5167.199084141964;5188.610854185951;11066.28069175501;11122.221444498808;11131.385949037507;11181.776364472827;11186.664400068012;5826.329972053268;5828.154917536934;5832.737526811304;5836.678982655994;5838.153467747153;4806.807727690853;5315.73421328932;5475.397706252309;5480.068388373986;5551.583631227674;4009.4186342980106;4038.2013450758814;4049.190161967618;4067.9593204067583;4073.653739432122;1148.3511815824033;1148.7013376522164;1153.6596703972348;1158.5539567266662;1159.5825502818977;1044.770150566874;1046.3251202974038;1049.522467277387;1057.6456886942806;1059.364381371171;6255.24937007562;6270.529710271657;6308.968455157695;6342.016987366966;6431.646259455775;508.1387048951991;514.087494696916;514.6577525945279;524.5881982643683;530.4774796825125;4134.91730165395;4147.543770185277;4217.641500472433;4264.211120942636;4274.422952901318;12461.06542009353;12739.745205095845;12911.096223264281;12936.935315323362;12946.029047821263;12711.936440317924;12760.55338063182;12877;12890.935545322214;12913.935430322976;8771.298296136294;9114.453132812052;9185.081491850895;9311.580978856104;9444.197243234265;6510.21877374718;6722.596644201363;6724.394804467622;6738.528303018742;6753.122094127929;11572.768544628892;11802.524684414448;11898.821517677068;12023.21849079807;12068;11898.345590992232;12009;12061.819072714092;12195.390230488263;12204.145709800583;8075.555844428378;8494.447860889022;8772.91227087721;8874.334424918028;9020.819583608421;9887.110160085627;9901.455419951684;9915;9938.801223975624;9978.451185184884;8701;8908.86636700437;8945;9001.459912405277;9046.638134474548;8496.702615408678;8548.273396761346;8607.096254893146;8623.051464339043;8657.740267791976;7543.622818859145;7582.052243469567;7626.122995855548;7631.809204769703;7640.961795190989;5326.707031113326;5454.100073487989;5541.556675465872;5621.887562248814;5674.517665998436;5373.946260537345;5602.13166959122;5691.117876729114;5741.13882917549;5785.652860828363 03:39:36 INFO - PROCESS | 19473 | |4;prototype.html;358.5070528023967;364.8175912043978;370.7979151362507;373.8934403694947;375.761391516387;5403.324584426947;5528.419515950827;5567.33192016958;5568.582356323272;5577.330720313563;5463.9180412293845;5522.806701765439;5527.613067085305;5540.861478463041;5582.218489411485;4092.7953602319913;4239.618434340909;4281.379200015996;4297.78511074445;4326.805293761789;4312;4314.1156063007165;4318.568143185687;4332.870013899588;4337.891552711191;4292.334688123346;4297.269464191079;4310.655147588185;4317.589828966259;4327.156204540116;4099.1801639672185;4309.892252693677;4334.176506463793;4336.457942757155;4337.240982827992;3783.772973621564;3804.448354988539;3807.809609519513;3813.036286312551;3814.6757525610356;5147.279380886679;5332.200169974496;5359;5371.529096615562;5385.219143224211;4936.48166942473;4962.206047032493;4967.900641987176;4971.850844474671;4980.676256043345;5779.595428320019;5799.826005219808;5825.1844741736195;5877.147813567009;5917.437843404869;4088.366303223005;4242.660587153051;4249.2563801334645;4255.3829694694095;4258.893527661802;5945.435183657545;6002.249718785152;6005.258475042233;6048.485878700316;6052.394760523956;4305.48334199898;4338.652907767371;4342.913141737147;4353.651707863363;4365.80353884076;4268.466441694788;4415.801288942005;4418.513963464016;4419.756913369732;4423.51341352451;4890.462049174588;4942.851714448572;4944.678595891256;4949.727764972889;4981.626378021663;5528.695921724263;5606.187102870143;5810.709464526757;5848.122781582797;5855.502282306052;1494.8505149484965;1502.3089378885616;1502.646877983673;1506.2995706996298;1506.7117614439715;899.7448559259796;922.6355589542228;934.1639232886529;955.1356022799378;958.7075941837807;4985.501449855058;4990.727364522024;5008.6243531734535;5015.423226328946;5110.923336149961;5265.631405801557;5277.997180535686;5278.841634750886;5280.630355875129;5299.284596579412;4824.372831531949;4868.391451068616;5012.724300163526;5044.873878153002;5054.974725126351;2815.6198913146463;2826.491231578336;2829.3872492678975;2829.6745874224316;2845.8292502449917;5355.44692039312;5378.9462105379225;5384.6499977501335;5425.647332923348;5433.402325744165;4969.950300496948;5302.496262855023;5309;5332.014072119626;5389.51494365509;5361.946380536223;5384.353877534721;5400.405955344909;5413.269208656939;5438.619296649196;5254.422013578427;5266.8946621068135;5278.736063196901;5318.840434786963;5356.437574054668;5518.599409256986;5923.5853490256995;5965.522758179249;5975.133605627247;5987.191729116514;6159.291681456511;6170.444659980623;6177.413145751147;6184.474319682878;6244.190114448607;4149.8962525937095;4282.80727367263;4294.29144191205;4297.140571885573;4317.179735850178;5811.970940145272;5936.465718085393;6031.185789918305;6035.69821508914;6049.183360246487;5685.204071430086;5710.37185909558;5742.511886489695;5754.884902302014;5824.728355941271;5786.826395208151;5804.419558044331;5809.76760929575;5826.242588463472;5850.473457388855;5563.276774019351;5691.971540142273;5708.457696518824;5715.685637289823;5730.71346432685;5750.482456578928;5787.9421205789085;5811.680357580204;5823.388544202798;5824.194499705105;5425.186222066722;5679.261695979496;5739;5740.167675687086;5746.367899530965 03:39:36 INFO - PROCESS | 19473 | |5;yui.html;825.5459497276496;863.4344504349651;864.2826454043145;876.4741155306815;893.3478560650728;15772;16784.664306713858;16963.236654350552;16969.575760605992;16972.23624936876;15781.28984195711;15933.84066159338;15940.043597384136;15951.920240398782;15963.680726385466;718.5185925429975;849.1975083546051;870.5647176411794;884.9292056635486;891;877.9517126558037;882.2148288023632;885.0574138542464;885.4687187687368;885.8848349714528;923.0354279777615;925.0749250749251;927.3276874266137;928.04875003122;928.3176865004217;754.7245255481764;876.5091548732698;913.0230653201078;913.3195769152024;916.4501299220481;675.5946432140726;677.2956125629339;677.6374639567857;677.6916502991177;677.7966610017024;13346;13353.332333383292;13368.799468007988;13403.731925361535;13472.461101555926;15311.617209569738;16076.678466430723;16124.838751612568;16410;16449;12552.748945021049;13095.607131786062;13279.86720132796;13383.397747101404;13506.527271545448;4803.18345881201;4804.327394164785;4861.805527778884;4930.4330002049865;4967.776450059756;78865.05674716241;79061;79372;79951.60024199841;80850.19149808485;12162.270263784201;12278.877211227951;12331.260124392566;12339.50641974311;12349.19730217533;20778.064987075315;20778.584428311653;20800.271990480564;20815.479613009797;20855.47861303449;8903.955480222687;8921.509316987498;9158.542072896329;9168.31237657165;9267.026962168875;5163.199704045879;5277.788888444419;5351.839444816662;5360.785568577291;5447.618666693294;3870.07118291608;4004.9199016019516;4016.959830401717;4021.3967904814513;4058.512978442606;625.5933643131909;721.7185297733888;740.6926125657792;753.4123383760675;755.2938002967243;694.9027136200936;695.9721611135498;775.8719811231197;799.476342995339;804.3444592656966;11360.1479889007;11370.374629395463;11486.712832179262;11728.824067638992;11809.291442513477;748.8614606297853;761.8819083042138;785.1951749456853;788.3417346515723;802.7431222008901;5240.502152295526;5309.177077552986;5329.491901310873;5374.54316383104;5420.078586640202;128232;140011;141398;141834;145115;62126;78076;94149;105097;106063.46968265109;71441;76004.23995759971;88838.11161888427;91145.54427227954;95000.52499737595;10399.58401663925;10487.318324308895;10625.521851516545;10666.89333106659;10757.46212689378;54435;55080.724596376764;55491;55895;56238;72871;80611.19388806037;80963;82136.58931705303;82605;15250.237488125771;15303.540893773205;15318.234088295763;15355.692886142439;15420.84579154194;16001.599960001093;16154.919225403797;16438.013719176888;16920.407785727934;16940.745888811925;15242.618934526725;15751.842481575037;15778;16012.839871601134;16150.353985840435;14497.85502144965;15021.849781502046;15155.393784248507;15748.370065197721;15798.684026319639;14880.107193568421;14945;15099.698006039598;15252.847471525587;15726;11884.405779710807;11935.940320298343;12178.391080445765;12233.388330583257;12668.176568523017;12216.144869859025;12303.692407689521;12321.44553495077;12511.749765004832;12860.678483037998 03:39:36 INFO - PROCESS | 19473 | __end_tp_report 03:39:36 INFO - PROCESS | 19473 | __start_cc_report 03:39:36 INFO - PROCESS | 19473 | _x_x_mozilla_cycle_collect,935 03:39:36 INFO - PROCESS | 19473 | __end_cc_report 03:39:36 INFO - PROCESS | 19473 | __startTimestamp1467369576767__endTimestamp 03:39:36 INFO - PROCESS | 19473 | 03:39:36 INFO - PROCESS | 19473 | ------- Summary: start ------- 03:39:36 INFO - PROCESS | 19473 | Number of tests: 6 03:39:36 INFO - PROCESS | 19473 | 03:39:36 INFO - PROCESS | 19473 | [#0] dojo.html Cycles:165 Average:5661.48 Median:5892.09 stddev:636.75 (10.8%) stddev-sans-first:612.83 03:39:36 INFO - PROCESS | 19473 | Values: 3371.0 3405.8 3415.1 3436.5 3452.6 5613.5 5696.5 5715.2 5717.1 5720.6 5650.8 5657.1 5701.4 5705.8 5707.8 5019.1 5132.6 5176.9 5182.0 5222.4 5075.7 5169.2 5208.0 5217.9 5219.9 5139.0 5184.5 5218.5 5221.7 5240.2 5258.8 5271.1 5272.3 5283.6 5300.5 5014.5 5057.8 5081.8 5174.0 5175.8 5472.6 5472.7 5488.5 5505.1 5525.5 6017.7 6019.9 6056.6 6058.0 6058.3 6055.5 6059.8 6138.8 6145.4 6236.5 5824.5 5871.6 5874.7 5879.9 5880.1 6135.1 6356.3 6360.6 6367.3 6367.4 5853.1 5907.9 5910.1 5978.3 5979.2 6041.0 6041.7 6048.4 6064.6 6071.7 5909.9 5999.2 6005.7 6021.4 6023.6 6040.8 6101.4 6119.1 6120.7 6144.1 4592.7 4639.0 4646.0 4646.7 4657.4 4088.1 4097.8 4114.3 4133.1 4147.8 5840.5 5843.2 5845.9 5854.9 5880.7 6131.8 6151.0 6166.2 6172.8 6195.3 5707.2 5719.0 5722.0 5724.9 5880.4 5237.1 5238.2 5239.6 5247.1 5249.1 6317.4 6326.9 6327.9 6328.4 6331.3 5935.0 6036.4 6071.6 6084.5 6122.4 6296.7 6306.7 6319.9 6336.8 6339.0 5908.9 5977.7 5981.3 5981.4 5988.1 6024.5 6058.8 6100.5 6123.8 6138.6 5984.5 5989.0 5992.6 5993.5 6021.1 5832.0 5892.1 5916.0 5977.9 5984.1 5811.5 5865.6 5907.9 5917.5 5945.8 6029.7 6065.4 6066.7 6069.6 6076.9 5756.0 5786.3 5794.1 5896.1 5904.1 03:39:36 INFO - PROCESS | 19473 | 03:39:36 INFO - PROCESS | 19473 | [#1] ext.html Cycles:180 Average:59575.85 Median:197025.34 stddev:121823.90 (61.8%) stddev-sans-first:122085.16 03:39:36 INFO - PROCESS | 19473 | Values: 592.8 631.4 650.4 657.7 682.6 32929.8 46282.3 46861.1 47005.0 47114.3 49424.8 49620.5 49703.5 49753.5 49972.8 8399.4 8959.2 9199.4 9200.3 10940.4 10635.5 10744.1 11058.7 11070.9 11071.8 11109.4 11177.7 11181.4 11188.7 11189.2 8608.9 8830.4 10739.7 10980.6 11042.2 10911.6 10960.3 10985.1 10987.5 10989.8 45380.1 45580.8 45840.0 45908.8 45935.0 3859.3 3899.7 3938.0 3941.6 3999.2 35394.5 36426.5 36489.5 36561.0 36675.3 4752.1 4863.8 4911.0 4912.5 4963.6 130874.0 131293.3 390151.0 392007.0 393355.0 38920.6 39724.2 39995.4 71023.0 71581.0 42285.2 42392.4 42515.8 42563.5 42577.4 17671.4 17881.6 17883.6 17883.6 17884.8 13327.9 14045.6 14440.6 14475.2 14868.5 9525.5 9527.8 9538.0 9548.8 9624.0 3561.9 3602.1 3619.2 3625.6 3707.7 1036.8 1142.2 1146.3 1170.9 1233.6 34517.7 34659.0 34661.1 34875.0 34988.4 1198.1 1206.5 1228.8 1242.5 1253.0 17771.2 17794.7 18329.9 18331.2 18539.2 630015.0 636092.0 637011.0 637968.0 639179.8 63727.4 64602.4 64793.7 64854.7 64908.4 1359.7 1466.2 1471.5 1522.8 1522.8 33721.3 34778.8 35384.5 35640.5 35972.8 54016.2 54910.0 54928.0 54985.0 55012.4 343851.0 345459.0 345834.0 346756.0 346977.0 27924.2 30147.7 30918.0 31492.8 33013.8 52248.0 52970.7 53524.7 53594.7 54030.7 43744.3 44042.8 44433.8 44945.3 46183.8 43414.2 43978.6 44179.3 44823.3 45367.1 43458.0 44277.1 44657.0 45052.8 45182.8 37989.0 39611.6 39882.0 39889.0 39892.4 29250.9 29501.4 29607.9 29736.0 29860.0 03:39:36 INFO - PROCESS | 19473 | 03:39:36 INFO - PROCESS | 19473 | [#2] jquery.html Cycles:180 Average:28486.67 Median:23485.51 stddev:77482.67 (329.9%) stddev-sans-first:77671.39 03:39:36 INFO - PROCESS | 19473 | Values: 427.7 429.9 437.9 443.5 449.3 18812.1 19586.6 19605.5 21301.4 21408.5 20122.1 20390.0 20691.7 20729.2 20741.9 5644.9 5877.1 5901.6 5908.0 5909.9 5737.2 5773.2 5828.6 5838.8 5839.8 5774.8 5778.6 5790.4 5792.7 5808.7 5579.9 5752.4 5757.1 5762.5 5764.4 5040.6 5048.5 5231.6 5231.8 5236.0 23463.3 23507.8 23568.2 23571.8 23726.3 2567.8 2576.6 2789.6 2862.5 2947.5 14156.4 14647.1 14800.2 15302.5 15509.8 2056.8 2061.8 2075.9 2130.8 2171.7 80239.6 81245.0 81444.0 82218.0 82475.2 10934.1 11161.8 11411.8 11464.3 11476.5 15983.8 16080.9 16147.6 16185.6 16213.8 8657.6 8837.2 8864.5 8983.3 8983.8 8678.7 8701.2 8748.7 8859.0 8861.6 6983.8 7011.5 7063.7 7096.2 7184.9 2045.5 2073.9 2089.7 2125.5 2141.8 1031.0 1053.9 1065.4 1131.6 1137.8 19213.1 19536.2 19892.7 19919.9 19960.4 1086.4 1101.9 1104.4 1119.0 1139.7 11118.5 11554.1 11593.7 11641.8 11690.7 464044.0 468327.0 468377.0 477245.0 479469.0 44660.4 83671.0 87091.0 87136.0 90216.8 1124.6 1141.3 1170.3 1199.9 1203.9 17738.9 17829.2 18139.6 18296.5 18500.5 37793.0 39172.6 39643.2 40307.4 41351.8 54124.7 54240.0 54242.0 54290.2 54426.5 6530.3 8953.6 9127.0 9244.6 9369.2 12139.3 13431.1 13972.2 13998.6 14238.9 11783.5 12068.0 12175.0 12260.9 12443.9 11783.2 11880.0 11937.6 12072.3 12081.7 12232.6 12301.3 12375.0 12406.2 12598.7 9042.4 9148.9 9183.3 9211.9 9230.4 12427.8 12460.0 12586.1 12634.9 12649.3 03:39:36 INFO - PROCESS | 19473 | 03:39:36 INFO - PROCESS | 19473 | [#3] mootools.html Cycles:180 Average:6485.41 Median:2657.47 stddev:3884.40 (146.2%) stddev-sans-first:3876.71 03:39:36 INFO - PROCESS | 19473 | Values: 1429.6 1592.6 1637.9 1808.7 1966.0 9087.8 9508.0 9546.1 9722.1 9776.1 9437.6 9704.0 9721.8 9724.8 9748.0 2219.9 2282.7 2492.1 2503.9 2568.8 2560.5 2591.8 2599.2 2601.9 2605.4 2509.5 2564.2 2565.1 2567.2 2567.7 2159.5 2369.0 2447.6 2464.0 2465.0 2493.5 2498.6 2511.8 2523.6 2538.8 9823.4 9912.8 9921.1 9923.3 9925.0 5625.0 5750.8 5754.1 5754.3 5756.3 3611.6 3692.1 3706.3 3719.1 3749.6 1317.1 1321.8 1337.5 1338.2 1358.2 14159.2 14474.6 14514.2 14544.3 14596.0 5095.7 5124.4 5154.7 5167.2 5188.6 11066.3 11122.2 11131.4 11181.8 11186.7 5826.3 5828.2 5832.7 5836.7 5838.2 4806.8 5315.7 5475.4 5480.1 5551.6 4009.4 4038.2 4049.2 4068.0 4073.7 1148.4 1148.7 1153.7 1158.6 1159.6 1044.8 1046.3 1049.5 1057.6 1059.4 6255.2 6270.5 6309.0 6342.0 6431.6 508.1 514.1 514.7 524.6 530.5 4134.9 4147.5 4217.6 4264.2 4274.4 12461.1 12739.7 12911.1 12936.9 12946.0 12711.9 12760.6 12877.0 12890.9 12913.9 8771.3 9114.5 9185.1 9311.6 9444.2 6510.2 6722.6 6724.4 6738.5 6753.1 11572.8 11802.5 11898.8 12023.2 12068.0 11898.3 12009.0 12061.8 12195.4 12204.1 8075.6 8494.4 8772.9 8874.3 9020.8 9887.1 9901.5 9915.0 9938.8 9978.5 8701.0 8908.9 8945.0 9001.5 9046.6 8496.7 8548.3 8607.1 8623.1 8657.7 7543.6 7582.1 7626.1 7631.8 7641.0 5326.7 5454.1 5541.6 5621.9 5674.5 5373.9 5602.1 5691.1 5741.1 5785.7 03:39:36 INFO - PROCESS | 19473 | 03:39:36 INFO - PROCESS | 19473 | [#4] prototype.html Cycles:180 Average:4751.04 Median:5305.75 stddev:1374.30 (25.9%) stddev-sans-first:1338.03 03:39:36 INFO - PROCESS | 19473 | Values: 358.5 364.8 370.8 373.9 375.8 5403.3 5528.4 5567.3 5568.6 5577.3 5463.9 5522.8 5527.6 5540.9 5582.2 4092.8 4239.6 4281.4 4297.8 4326.8 4312.0 4314.1 4318.6 4332.9 4337.9 4292.3 4297.3 4310.7 4317.6 4327.2 4099.2 4309.9 4334.2 4336.5 4337.2 3783.8 3804.4 3807.8 3813.0 3814.7 5147.3 5332.2 5359.0 5371.5 5385.2 4936.5 4962.2 4967.9 4971.9 4980.7 5779.6 5799.8 5825.2 5877.1 5917.4 4088.4 4242.7 4249.3 4255.4 4258.9 5945.4 6002.2 6005.3 6048.5 6052.4 4305.5 4338.7 4342.9 4353.7 4365.8 4268.5 4415.8 4418.5 4419.8 4423.5 4890.5 4942.9 4944.7 4949.7 4981.6 5528.7 5606.2 5810.7 5848.1 5855.5 1494.9 1502.3 1502.6 1506.3 1506.7 899.7 922.6 934.2 955.1 958.7 4985.5 4990.7 5008.6 5015.4 5110.9 5265.6 5278.0 5278.8 5280.6 5299.3 4824.4 4868.4 5012.7 5044.9 5055.0 2815.6 2826.5 2829.4 2829.7 2845.8 5355.4 5378.9 5384.6 5425.6 5433.4 4970.0 5302.5 5309.0 5332.0 5389.5 5361.9 5384.4 5400.4 5413.3 5438.6 5254.4 5266.9 5278.7 5318.8 5356.4 5518.6 5923.6 5965.5 5975.1 5987.2 6159.3 6170.4 6177.4 6184.5 6244.2 4149.9 4282.8 4294.3 4297.1 4317.2 5812.0 5936.5 6031.2 6035.7 6049.2 5685.2 5710.4 5742.5 5754.9 5824.7 5786.8 5804.4 5809.8 5826.2 5850.5 5563.3 5692.0 5708.5 5715.7 5730.7 5750.5 5787.9 5811.7 5823.4 5824.2 5425.2 5679.3 5739.0 5740.2 5746.4 03:39:36 INFO - PROCESS | 19473 | 03:39:36 INFO - PROCESS | 19473 | [#5] yui.html Cycles:180 Average:22134.55 Median:4039.95 stddev:32030.54 (792.8%) stddev-sans-first:32080.43 03:39:36 INFO - PROCESS | 19473 | Values: 825.5 863.4 864.3 876.5 893.3 15772.0 16784.7 16963.2 16969.6 16972.2 15781.3 15933.8 15940.0 15951.9 15963.7 718.5 849.2 870.6 884.9 891.0 878.0 882.2 885.1 885.5 885.9 923.0 925.1 927.3 928.0 928.3 754.7 876.5 913.0 913.3 916.5 675.6 677.3 677.6 677.7 677.8 13346.0 13353.3 13368.8 13403.7 13472.5 15311.6 16076.7 16124.8 16410.0 16449.0 12552.7 13095.6 13279.9 13383.4 13506.5 4803.2 4804.3 4861.8 4930.4 4967.8 78865.1 79061.0 79372.0 79951.6 80850.2 12162.3 12278.9 12331.3 12339.5 12349.2 20778.1 20778.6 20800.3 20815.5 20855.5 8904.0 8921.5 9158.5 9168.3 9267.0 5163.2 5277.8 5351.8 5360.8 5447.6 3870.1 4004.9 4017.0 4021.4 4058.5 625.6 721.7 740.7 753.4 755.3 694.9 696.0 775.9 799.5 804.3 11360.1 11370.4 11486.7 11728.8 11809.3 748.9 761.9 785.2 788.3 802.7 5240.5 5309.2 5329.5 5374.5 5420.1 128232.0 140011.0 141398.0 141834.0 145115.0 62126.0 78076.0 94149.0 105097.0 106063.5 71441.0 76004.2 88838.1 91145.5 95000.5 10399.6 10487.3 10625.5 10666.9 10757.5 54435.0 55080.7 55491.0 55895.0 56238.0 72871.0 80611.2 80963.0 82136.6 82605.0 15250.2 15303.5 15318.2 15355.7 15420.8 16001.6 16154.9 16438.0 16920.4 16940.7 15242.6 15751.8 15778.0 16012.8 16150.4 14497.9 15021.8 15155.4 15748.4 15798.7 14880.1 14945.0 15099.7 15252.8 15726.0 11884.4 11935.9 12178.4 12233.4 12668.2 12216.1 12303.7 12321.4 12511.7 12860.7 03:39:36 INFO - PROCESS | 19473 | -------- Summary: end -------- 03:39:36 INFO - PROCESS | 19473 | 03:39:37 INFO - TEST-INFO | 19473: exit 0 03:39:37 INFO - TEST-OK | dromaeo_css | took 1113633ms 03:39:37 INFO - TEST-START | kraken 03:39:37 INFO - operating with platform_type : linux_ 03:39:37 INFO - Initialising browser for kraken test... 03:39:37 INFO - TEST-INFO | started process 19665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz_W5KD/profile http://localhost:47361/getInfo.html) 03:39:41 INFO - PROCESS | 19665 | __metrics Screen width/height:1600/1200 03:39:41 INFO - PROCESS | 19665 | colorDepth:24 03:39:41 INFO - PROCESS | 19665 | Browser inner width/height: 1024/697 03:39:41 INFO - PROCESS | 19665 | __metrics 03:39:42 ERROR - PROCESS | 19665 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:39:43 INFO - TEST-INFO | 19665: exit 0 03:39:43 INFO - Browser initialized. 03:39:43 INFO - Running cycle 1/1 for kraken test... 03:39:43 INFO - TEST-INFO | started process 19756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz_W5KD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:55 INFO - PROCESS | 19756 | RSS: Main: 145469440 03:39:55 INFO - PROCESS | 19756 | 03:39:57 INFO - PROCESS | 19756 | Cycle 1(1): loaded http://localhost:47361/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47361/tests/kraken/driver.html?testName=audio-beat-detection) 03:39:58 INFO - PROCESS | 19756 | RSS: Main: 195211264 03:39:58 INFO - PROCESS | 19756 | 03:40:01 INFO - PROCESS | 19756 | Cycle 1(1): loaded http://localhost:47361/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47361/tests/kraken/driver.html?testName=audio-dft) 03:40:01 INFO - PROCESS | 19756 | RSS: Main: 193118208 03:40:01 INFO - PROCESS | 19756 | 03:40:04 INFO - PROCESS | 19756 | Cycle 1(1): loaded http://localhost:47361/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47361/tests/kraken/driver.html?testName=audio-fft) 03:40:05 INFO - PROCESS | 19756 | RSS: Main: 278679552 03:40:05 INFO - PROCESS | 19756 | 03:40:07 INFO - PROCESS | 19756 | Cycle 1(1): loaded http://localhost:47361/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47361/tests/kraken/driver.html?testName=audio-oscillator) 03:40:07 INFO - PROCESS | 19756 | RSS: Main: 187609088 03:40:07 INFO - PROCESS | 19756 | 03:40:10 INFO - PROCESS | 19756 | Cycle 1(1): loaded http://localhost:47361/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47361/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:40:10 INFO - PROCESS | 19756 | RSS: Main: 188735488 03:40:10 INFO - PROCESS | 19756 | 03:40:13 INFO - PROCESS | 19756 | Cycle 1(1): loaded http://localhost:47361/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47361/tests/kraken/driver.html?testName=imaging-darkroom) 03:40:14 INFO - PROCESS | 19756 | RSS: Main: 223358976 03:40:14 INFO - PROCESS | 19756 | 03:40:17 INFO - PROCESS | 19756 | Cycle 1(1): loaded http://localhost:47361/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47361/tests/kraken/driver.html?testName=imaging-desaturate) 03:40:18 INFO - PROCESS | 19756 | RSS: Main: 223191040 03:40:18 INFO - PROCESS | 19756 | 03:40:21 INFO - PROCESS | 19756 | Cycle 1(1): loaded http://localhost:47361/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47361/tests/kraken/driver.html?testName=json-parse-financial) 03:40:21 INFO - PROCESS | 19756 | RSS: Main: 222949376 03:40:21 INFO - PROCESS | 19756 | 03:40:23 INFO - PROCESS | 19756 | Cycle 1(1): loaded http://localhost:47361/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47361/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:40:23 INFO - PROCESS | 19756 | RSS: Main: 200916992 03:40:23 INFO - PROCESS | 19756 | 03:40:25 INFO - PROCESS | 19756 | Cycle 1(1): loaded http://localhost:47361/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47361/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:40:26 INFO - PROCESS | 19756 | RSS: Main: 202694656 03:40:26 INFO - PROCESS | 19756 | 03:40:28 INFO - PROCESS | 19756 | Cycle 1(1): loaded http://localhost:47361/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47361/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:40:28 INFO - PROCESS | 19756 | RSS: Main: 207900672 03:40:28 INFO - PROCESS | 19756 | 03:40:31 INFO - PROCESS | 19756 | Cycle 1(1): loaded http://localhost:47361/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:40:31 INFO - PROCESS | 19756 | RSS: Main: 214052864 03:40:31 INFO - PROCESS | 19756 | 03:40:34 INFO - PROCESS | 19756 | Cycle 1(1): loaded http://localhost:47361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:40:34 INFO - PROCESS | 19756 | RSS: Main: 212877312 03:40:34 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | Cycle 1(1): loaded http://localhost:47361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47361/tests/kraken/driver.html?testName=ai-astar) 03:40:36 INFO - PROCESS | 19756 | RSS: Main: 256397312 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | __start_tp_report 03:40:36 INFO - PROCESS | 19756 | _x_x_mozilla_page_load 03:40:36 INFO - PROCESS | 19756 | _x_x_mozilla_page_load_details 03:40:36 INFO - PROCESS | 19756 | |i|pagename|runs| 03:40:36 INFO - PROCESS | 19756 | |0;ai-astar;111;104;109;110;110;110;110;113;111;111 03:40:36 INFO - PROCESS | 19756 | |1;audio-beat-detection;151;125;124;175;122;125;150;122;154;123 03:40:36 INFO - PROCESS | 19756 | |2;audio-dft;167;161;160;160;161;159;160;161;160;159 03:40:36 INFO - PROCESS | 19756 | |3;audio-fft;75;75;75;126;74;76;74;76;97;74 03:40:36 INFO - PROCESS | 19756 | |4;audio-oscillator;83;83;113;84;84;85;114;85;85;125 03:40:36 INFO - PROCESS | 19756 | |5;imaging-gaussian-blur;117;116;117;117;116;117;116;117;117;117 03:40:36 INFO - PROCESS | 19756 | |6;imaging-darkroom;145;146;147;146;146;146;146;146;146;146 03:40:36 INFO - PROCESS | 19756 | |7;imaging-desaturate;95;95;95;95;94;95;94;95;95;94 03:40:36 INFO - PROCESS | 19756 | |8;json-parse-financial;52;49;52;51;52;51;51;50;50;51 03:40:36 INFO - PROCESS | 19756 | |9;json-stringify-tinderbox;59;59;59;59;59;59;58;59;61;60 03:40:36 INFO - PROCESS | 19756 | |10;stanford-crypto-aes;75;75;75;77;75;76;77;81;115;76 03:40:36 INFO - PROCESS | 19756 | |11;stanford-crypto-ccm;119;127;122;122;116;115;119;124;119;116 03:40:36 INFO - PROCESS | 19756 | |12;stanford-crypto-pbkdf2;152;152;153;151;153;150;151;151;150;154 03:40:36 INFO - PROCESS | 19756 | |13;stanford-crypto-sha256-iterative;61;63;60;62;61;61;60;60;62;65 03:40:36 INFO - PROCESS | 19756 | __end_tp_report 03:40:36 INFO - PROCESS | 19756 | __start_cc_report 03:40:36 INFO - PROCESS | 19756 | _x_x_mozilla_cycle_collect,1593 03:40:36 INFO - PROCESS | 19756 | __end_cc_report 03:40:36 INFO - PROCESS | 19756 | __startTimestamp1467369636880__endTimestamp 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | ------- Summary: start ------- 03:40:36 INFO - PROCESS | 19756 | Number of tests: 14 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:2.33 (2.1%) stddev-sans-first:2.44 03:40:36 INFO - PROCESS | 19756 | Values: 111.0 104.0 109.0 110.0 110.0 110.0 110.0 113.0 111.0 111.0 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:137.50 stddev:18.86 (13.7%) stddev-sans-first:19.32 03:40:36 INFO - PROCESS | 19756 | Values: 151.0 125.0 124.0 175.0 122.0 125.0 150.0 122.0 154.0 123.0 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | [#2] audio-dft Cycles:10 Average:160.80 Median:160.50 stddev:2.30 (1.4%) stddev-sans-first:0.78 03:40:36 INFO - PROCESS | 19756 | Values: 167.0 161.0 160.0 160.0 161.0 159.0 160.0 161.0 160.0 159.0 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.00 stddev:16.90 (22.5%) stddev-sans-first:17.73 03:40:36 INFO - PROCESS | 19756 | Values: 75.0 75.0 75.0 126.0 74.0 76.0 74.0 76.0 97.0 74.0 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:84.00 stddev:16.35 (19.5%) stddev-sans-first:16.84 03:40:36 INFO - PROCESS | 19756 | Values: 83.0 83.0 113.0 84.0 84.0 85.0 114.0 85.0 85.0 125.0 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:40:36 INFO - PROCESS | 19756 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 03:40:36 INFO - PROCESS | 19756 | Values: 145.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:40:36 INFO - PROCESS | 19756 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:0.99 (1.9%) stddev-sans-first:0.97 03:40:36 INFO - PROCESS | 19756 | Values: 52.0 49.0 52.0 51.0 52.0 51.0 51.0 50.0 50.0 51.0 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 03:40:36 INFO - PROCESS | 19756 | Values: 59.0 59.0 59.0 59.0 59.0 59.0 58.0 59.0 61.0 60.0 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:76.00 stddev:12.36 (16.3%) stddev-sans-first:12.97 03:40:36 INFO - PROCESS | 19756 | Values: 75.0 75.0 75.0 77.0 75.0 76.0 77.0 81.0 115.0 76.0 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:120.50 stddev:3.84 (3.2%) stddev-sans-first:4.06 03:40:36 INFO - PROCESS | 19756 | Values: 119.0 127.0 122.0 122.0 116.0 115.0 119.0 124.0 119.0 116.0 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.70 Median:152.00 stddev:1.34 (0.9%) stddev-sans-first:1.41 03:40:36 INFO - PROCESS | 19756 | Values: 152.0 152.0 153.0 151.0 153.0 150.0 151.0 151.0 150.0 154.0 03:40:36 INFO - PROCESS | 19756 | 03:40:36 INFO - PROCESS | 19756 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.50 stddev:1.58 (2.6%) stddev-sans-first:1.67 03:40:36 INFO - PROCESS | 19756 | Values: 61.0 63.0 60.0 62.0 61.0 61.0 60.0 60.0 62.0 65.0 03:40:36 INFO - PROCESS | 19756 | -------- Summary: end -------- 03:40:36 INFO - PROCESS | 19756 | 03:40:37 INFO - TEST-INFO | 19756: exit 0 03:40:37 INFO - TEST-OK | kraken | took 60264ms 03:40:37 INFO - SUITE-END | took 1173s 03:40:38 INFO - Completed test suite (00:19:34) 03:40:38 INFO - javascript benchmark 03:40:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.9831450842744, 3405.7615966882327, 3415.129142068772, 3436.4673475611257, 3452.5511683481145, 5613.494785469307, 5696.487316141546, 5715.199872017921, 5717.085266357383, 5720.5995580309345, 5650.773969041244, 5657.094864821629, 5701.372848986619, 5705.800296989606, 5707.800226992056, 5019.071471777715, 5132.589392848572, 5176.922346164811, 5182.041322355358, 5222.425533191365, 5075.746212689369, 5169.172932330828, 5207.973960130194, 5217.895642087156, 5219.869503262411, 5139.049275883955, 5184.507471790174, 5218.452062533436, 5221.71280579568, 5240.240165176047, 5258.789648414078, 5271.051210782058, 5272.261883336336, 5283.63014588979, 5300.549453296474, 5014.548690617826, 5057.848264552069, 5081.79672813087, 5173.974130129325, 5175.767090480937, 5472.644278121909, 5472.72636368184, 5488.53347465466, 5505.091659876116, 5525.475079867447, 6017.699115044274, 6019.909701354483, 6056.6063205891915, 6057.969710151465, 6058.27300723916, 6055.484582921135, 6059.848503787396, 6138.786925362681, 6145.4161854623735, 6236.469900058455, 5824.534037277008, 5871.588988770788, 5874.676892770896, 5879.882402351929, 5880.0885862691775, 6135.07973803933, 6356.269029061625, 6360.586561873463, 6367.267764207083, 6367.395097465734, 5853.0635098384055, 5907.940920590825, 5910.083936989773, 5978.342382337939, 5979.1928089707335, 6041.033434650435, 6041.667708276087, 6048.425399587032, 6064.575479716465, 6071.726772295257, 5909.881802363929, 5999.160117583542, 6005.669688167105, 6021.397860214031, 6023.578349515579, 6040.788572399945, 6101.359357267423, 6119.106526814713, 6120.660465672121, 6144.109104179869, 4592.655550833634, 4639.0, 4646.0, 4646.697964632288, 4657.394538710014, 4088.0801819590356, 4097.7541347519245, 4114.321137012359, 4133.111381053088, 4147.792610369469, 5840.503557197686, 5843.18195452637, 5845.853853653693, 5854.882902341929, 5880.7353669085, 6131.816045518642, 6150.969245153746, 6166.229221347332, 6172.845678858064, 6195.31851496335, 5707.200991861143, 5719.0, 5722.0, 5724.856878578069, 5880.353161152269, 5237.057329680694, 5238.188080847474, 5239.554637855825, 5247.10799164143, 5249.055170069348, 6317.399847014526, 6326.905096423558, 6327.936720632827, 6328.398802113792, 6331.3352098029045, 5934.970325148347, 6036.3661815510495, 6071.574989750675, 6084.513238940785, 6122.448979591858, 6296.716647750954, 6306.65313407767, 6319.936800631935, 6336.809895703136, 6339.017452294902, 5908.911366329595, 5977.7310021050025, 5981.282246130492, 5981.401859814157, 5988.131720900532, 6024.487918526975, 6058.787942421994, 6100.481459076028, 6123.785667501616, 6138.600990935575, 5984.491318237824, 5989.0, 5992.64044157352, 5993.490553302844, 6021.126936594257, 5832.0, 5892.086726557391, 5915.994280972331, 5977.850553736192, 5984.102384642339, 5811.476967072984, 5865.5600829937075, 5907.940920590911, 5917.497012753965, 5945.821625351246, 6029.668368239789, 6065.3934606539, 6066.7269972850445, 6069.635821850703, 6076.878462430638, 5755.971220143872, 5786.30564332266, 5794.101914203306, 5896.086106653475, 5904.0553511437965], "value": 5619.4842592663235, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.8073376152752, 631.4159402552639, 650.3853858104092, 657.658017830728, 682.5563383800526, 32929.83535082324, 46282.30576541355, 46861.0627787444, 47005.0, 47114.2932856007, 49424.752876235565, 49620.50379496204, 49703.50296497034, 49753.50246497534, 49972.75013624936, 8399.37004724645, 8959.193672569467, 9199.402038867453, 9200.309976751736, 10940.3982780947, 10635.468226588679, 10744.086752626035, 11058.668239952814, 11070.944645276762, 11071.778564428707, 11109.44452777362, 11177.7205569861, 11181.44092795361, 11188.66434006981, 11189.216754827165, 8608.870866937032, 8830.42602230853, 10739.677809665722, 10980.615678451215, 11042.227044106916, 10911.618093366773, 10960.28758130727, 10985.066269367033, 10987.450627468674, 10989.835152472719, 45380.092398152185, 45580.772096139306, 45840.0, 45908.770456147504, 45935.0, 3859.3439115350457, 3899.6880249579967, 3937.960620393788, 3941.625545573166, 3999.2201520703475, 35394.46908296378, 36426.45360319597, 36489.452658210146, 36561.0, 36675.26649467022, 4752.120857641347, 4863.781129849165, 4911.0, 4912.459629440758, 4963.602911767086, 130874.0, 131293.34353328173, 390151.0, 392007.0, 393355.0332248349, 38920.610793892265, 39724.2055158901, 39995.40006899899, 71023.0, 71581.0, 42285.1542969145, 42392.36411453831, 42515.7874210627, 42563.51027714077, 42577.36133957993, 17671.38150164738, 17881.642367152584, 17883.552911177325, 17883.642327153386, 17884.821151788576, 13327.866721332857, 14045.648858778612, 14440.566782996528, 14475.203863787592, 14868.479603213835, 9525.523723813782, 9527.809443811086, 9537.952310238405, 9548.761280968032, 9623.989481104523, 3561.893143205708, 3602.081469225383, 3619.2399596084592, 3625.619309972468, 3707.7404581679025, 1036.7978244242452, 1142.1719253541282, 1146.3179408252242, 1170.9004734597484, 1233.586748439265, 34517.65482345144, 34659.0, 34661.133471662906, 34875.0, 34988.43014858414, 1198.0954379443465, 1206.4510647655295, 1228.784962631536, 1242.4595301044076, 1252.9686757830946, 17771.200295986713, 17794.733079003825, 18329.90835045816, 18331.17509712066, 18539.165737541574, 630015.0, 636092.0, 637011.0, 637968.0, 639179.8041009766, 63727.36272637214, 64602.353976459635, 64793.67603161954, 64854.67572662201, 64908.35091649023, 1359.6532884114488, 1466.2375564706292, 1471.4702707025463, 1522.7563589825575, 1522.7791970164485, 33721.3255734879, 34778.82610586931, 35384.46923296204, 35640.4653930186, 35972.82013589915, 54016.18975715289, 54910.0, 54928.0, 54985.0, 55012.44987550073, 343851.0, 345459.0, 345834.0, 346756.0, 346977.0, 27924.162275131777, 30147.69852301449, 30918.0, 31492.842535787175, 33013.83493082519, 52248.0, 52970.73514632402, 53524.732376337866, 53594.73202634118, 54030.729846350514, 43744.343834841864, 44042.779786100866, 44433.77783111064, 44945.32582011338, 46183.76908115438, 43414.15269276025, 43978.56021439745, 44179.337309939736, 44823.32765008593, 45367.09265814731, 43458.0, 44277.11445771131, 44657.0, 45052.774736126106, 45182.77408612936, 37989.0, 39611.60388396079, 39882.0, 39889.0, 39892.401613975235, 29250.853745731987, 29501.409971800014, 29607.85196074006, 29736.0, 29860.0], "value": 20570.477408073057, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.70060957329866, 429.8581468115522, 437.85719272698253, 443.5077064458451, 449.3260109835247, 18812.059397030163, 19586.608267834654, 19605.50986225345, 21301.360959171212, 21408.464788380297, 20122.094505747238, 20390.0, 20691.689624655606, 20729.170833166656, 20741.896290518525, 5644.887102257962, 5877.118432235156, 5901.645901245917, 5907.970460147715, 5909.940900591004, 5737.196792449061, 5773.249477567911, 5828.621139625932, 5838.766449342022, 5839.824805255849, 5774.769009239625, 5778.624389414675, 5790.420957904197, 5792.6524408535415, 5808.709564521778, 5579.9163012554845, 5752.424757524256, 5757.050086735683, 5762.51018663412, 5764.365919748824, 5040.621953353477, 5048.495150484959, 5231.633785635007, 5231.843044708665, 5235.973820130913, 23463.253829746023, 23507.76492235073, 23568.175113870933, 23571.7642823573, 23726.288211353687, 2567.8459292442512, 2576.561984462646, 2789.623400840901, 2862.4990626640256, 2947.513660246057, 14156.433742650283, 14647.12117272967, 14800.185989770558, 15302.464413745576, 15509.767353489706, 2056.8251698605636, 2061.7835127311564, 2075.937721868346, 2130.7549631792385, 2171.7393912730417, 80239.5988020062, 81245.0, 81444.0, 82218.0, 82475.17524824735, 10934.125269978382, 11161.776764464828, 11411.828822567668, 11464.25482343645, 11476.54093836254, 15983.760243596354, 16080.919595402182, 16147.596310092342, 16185.59536011609, 16213.837861621469, 8657.61040753155, 8837.204651581389, 8864.468131912106, 8983.326250531236, 8983.775405614912, 8678.739637810875, 8701.216890479887, 8748.737537873747, 8858.955705221562, 8861.556922153866, 6983.755568555178, 7011.509194356346, 7063.71745130189, 7096.219415864251, 7184.856302873914, 2045.5499790046167, 2073.8548301619044, 2089.6865470179596, 2125.4686328417897, 2141.785821417846, 1030.9793804124026, 1053.947302634865, 1065.4299949526967, 1131.598282609678, 1137.7838210739933, 19213.135408906353, 19536.218551258076, 19892.70160947587, 19919.900400498194, 19960.401187964384, 1086.413336798136, 1101.8787933327328, 1104.4091411095026, 1118.9776204476027, 1139.7036770439745, 11118.499667514981, 11554.133439992034, 11593.6521904343, 11641.825372619418, 11690.70773230676, 464044.0, 468327.0, 468377.0, 477245.0, 479469.0, 44660.356979044365, 83671.0, 87091.0, 87136.0, 90216.78544412083, 1124.6288724720823, 1141.3323205924462, 1170.3259981682647, 1199.9100067494974, 1203.8976686981705, 17738.91130544339, 17829.197686104417, 18139.637207255517, 18296.542586435444, 18500.537486562942, 37793.0, 39172.6082739169, 39643.207135856544, 40307.3953890686, 41351.7932410336, 54124.729376352865, 54240.0, 54242.0, 54290.185647216116, 54426.45573544214, 6530.346965303432, 8953.59708813118, 9126.954365228132, 9244.630214791334, 9369.15677588993, 12139.332336721565, 13431.112310853214, 13972.231527266098, 13998.580042598738, 14238.928805355907, 11783.52865885355, 12068.0, 12175.0, 12260.938695306466, 12443.93778031104, 11783.175177737476, 11880.0, 11937.582184623496, 12072.3360215189, 12081.69795755078, 12232.633021009384, 12301.261924284214, 12375.0, 12406.193597416139, 12598.748025039631, 9042.367034307536, 9148.908510915071, 9183.311251656287, 9211.907880921373, 9230.35387522867, 12427.813582796085, 12460.0, 12586.118971671895, 12634.87365126337, 12649.304288264233], "value": 9753.395497502735, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.5711286614014, 1592.6416556274835, 1637.8525932666057, 1808.6834803909312, 1965.9901700491496, 9087.818243635124, 9507.952460237697, 9546.093121153488, 9722.125008749212, 9776.071273229032, 9437.622495100204, 9704.0, 9721.805563888718, 9724.756881077976, 9748.0, 2219.9223027194053, 2282.7374851891996, 2492.1152990688315, 2503.874806259684, 2568.768810807027, 2560.539102961466, 2591.844489330637, 2599.2072417912623, 2601.856897870616, 2605.387733882536, 2509.5357358888664, 2564.2307307807678, 2565.102214225016, 2567.165671156872, 2567.679040119985, 2159.4601349662585, 2368.95262094758, 2447.5839107351794, 2464.002079157926, 2464.963025554618, 2493.5012997400413, 2498.5877330240487, 2511.7739403453775, 2523.6340730594143, 2538.7588179122954, 9823.410595364301, 9912.752181195456, 9921.057499537605, 9923.305368624198, 9924.950375248078, 5625.0, 5750.769969201227, 5754.050581654022, 5754.3094828620415, 5756.309242890838, 3611.56661200655, 3692.1138926657677, 3706.314331848617, 3719.144596742737, 3749.5875453700073, 1317.0583033131356, 1321.7752981992987, 1337.4650139944004, 1338.1502745756516, 1358.1647286918574, 14159.22124283164, 14474.638134046627, 14514.201718905457, 14544.345504452325, 14596.0, 5095.745212739423, 5124.436312005676, 5154.664946778447, 5167.199084141964, 5188.610854185951, 11066.28069175501, 11122.221444498808, 11131.385949037507, 11181.776364472827, 11186.664400068012, 5826.329972053268, 5828.154917536934, 5832.737526811304, 5836.678982655994, 5838.153467747153, 4806.807727690853, 5315.73421328932, 5475.397706252309, 5480.068388373986, 5551.583631227674, 4009.4186342980106, 4038.2013450758814, 4049.190161967618, 4067.9593204067583, 4073.653739432122, 1148.3511815824033, 1148.7013376522164, 1153.6596703972348, 1158.5539567266662, 1159.5825502818977, 1044.770150566874, 1046.3251202974038, 1049.522467277387, 1057.6456886942806, 1059.364381371171, 6255.24937007562, 6270.529710271657, 6308.968455157695, 6342.016987366966, 6431.646259455775, 508.1387048951991, 514.087494696916, 514.6577525945279, 524.5881982643683, 530.4774796825125, 4134.91730165395, 4147.543770185277, 4217.641500472433, 4264.211120942636, 4274.422952901318, 12461.06542009353, 12739.745205095845, 12911.096223264281, 12936.935315323362, 12946.029047821263, 12711.936440317924, 12760.55338063182, 12877.0, 12890.935545322214, 12913.935430322976, 8771.298296136294, 9114.453132812052, 9185.081491850895, 9311.580978856104, 9444.197243234265, 6510.21877374718, 6722.596644201363, 6724.394804467622, 6738.528303018742, 6753.122094127929, 11572.768544628892, 11802.524684414448, 11898.821517677068, 12023.21849079807, 12068.0, 11898.345590992232, 12009.0, 12061.819072714092, 12195.390230488263, 12204.145709800583, 8075.555844428378, 8494.447860889022, 8772.91227087721, 8874.334424918028, 9020.819583608421, 9887.110160085627, 9901.455419951684, 9915.0, 9938.801223975624, 9978.451185184884, 8701.0, 8908.86636700437, 8945.0, 9001.459912405277, 9046.638134474548, 8496.702615408678, 8548.273396761346, 8607.096254893146, 8623.051464339043, 8657.740267791976, 7543.622818859145, 7582.052243469567, 7626.122995855548, 7631.809204769703, 7640.961795190989, 5326.707031113326, 5454.100073487989, 5541.556675465872, 5621.887562248814, 5674.517665998436, 5373.946260537345, 5602.13166959122, 5691.117876729114, 5741.13882917549, 5785.652860828363], "value": 5016.125770149879, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.5070528023967, 364.8175912043978, 370.7979151362507, 373.8934403694947, 375.761391516387, 5403.324584426947, 5528.419515950827, 5567.33192016958, 5568.582356323272, 5577.330720313563, 5463.9180412293845, 5522.806701765439, 5527.613067085305, 5540.861478463041, 5582.218489411485, 4092.7953602319913, 4239.618434340909, 4281.379200015996, 4297.78511074445, 4326.805293761789, 4312.0, 4314.1156063007165, 4318.568143185687, 4332.870013899588, 4337.891552711191, 4292.334688123346, 4297.269464191079, 4310.655147588185, 4317.589828966259, 4327.156204540116, 4099.1801639672185, 4309.892252693677, 4334.176506463793, 4336.457942757155, 4337.240982827992, 3783.772973621564, 3804.448354988539, 3807.809609519513, 3813.036286312551, 3814.6757525610356, 5147.279380886679, 5332.200169974496, 5359.0, 5371.529096615562, 5385.219143224211, 4936.48166942473, 4962.206047032493, 4967.900641987176, 4971.850844474671, 4980.676256043345, 5779.595428320019, 5799.826005219808, 5825.1844741736195, 5877.147813567009, 5917.437843404869, 4088.366303223005, 4242.660587153051, 4249.2563801334645, 4255.3829694694095, 4258.893527661802, 5945.435183657545, 6002.249718785152, 6005.258475042233, 6048.485878700316, 6052.394760523956, 4305.48334199898, 4338.652907767371, 4342.913141737147, 4353.651707863363, 4365.80353884076, 4268.466441694788, 4415.801288942005, 4418.513963464016, 4419.756913369732, 4423.51341352451, 4890.462049174588, 4942.851714448572, 4944.678595891256, 4949.727764972889, 4981.626378021663, 5528.695921724263, 5606.187102870143, 5810.709464526757, 5848.122781582797, 5855.502282306052, 1494.8505149484965, 1502.3089378885616, 1502.646877983673, 1506.2995706996298, 1506.7117614439715, 899.7448559259796, 922.6355589542228, 934.1639232886529, 955.1356022799378, 958.7075941837807, 4985.501449855058, 4990.727364522024, 5008.6243531734535, 5015.423226328946, 5110.923336149961, 5265.631405801557, 5277.997180535686, 5278.841634750886, 5280.630355875129, 5299.284596579412, 4824.372831531949, 4868.391451068616, 5012.724300163526, 5044.873878153002, 5054.974725126351, 2815.6198913146463, 2826.491231578336, 2829.3872492678975, 2829.6745874224316, 2845.8292502449917, 5355.44692039312, 5378.9462105379225, 5384.6499977501335, 5425.647332923348, 5433.402325744165, 4969.950300496948, 5302.496262855023, 5309.0, 5332.014072119626, 5389.51494365509, 5361.946380536223, 5384.353877534721, 5400.405955344909, 5413.269208656939, 5438.619296649196, 5254.422013578427, 5266.8946621068135, 5278.736063196901, 5318.840434786963, 5356.437574054668, 5518.599409256986, 5923.5853490256995, 5965.522758179249, 5975.133605627247, 5987.191729116514, 6159.291681456511, 6170.444659980623, 6177.413145751147, 6184.474319682878, 6244.190114448607, 4149.8962525937095, 4282.80727367263, 4294.29144191205, 4297.140571885573, 4317.179735850178, 5811.970940145272, 5936.465718085393, 6031.185789918305, 6035.69821508914, 6049.183360246487, 5685.204071430086, 5710.37185909558, 5742.511886489695, 5754.884902302014, 5824.728355941271, 5786.826395208151, 5804.419558044331, 5809.76760929575, 5826.242588463472, 5850.473457388855, 5563.276774019351, 5691.971540142273, 5708.457696518824, 5715.685637289823, 5730.71346432685, 5750.482456578928, 5787.9421205789085, 5811.680357580204, 5823.388544202798, 5824.194499705105, 5425.186222066722, 5679.261695979496, 5739.0, 5740.167675687086, 5746.367899530965], "value": 4319.871394745253, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.5459497276496, 863.4344504349651, 864.2826454043145, 876.4741155306815, 893.3478560650728, 15772.0, 16784.664306713858, 16963.236654350552, 16969.575760605992, 16972.23624936876, 15781.28984195711, 15933.84066159338, 15940.043597384136, 15951.920240398782, 15963.680726385466, 718.5185925429975, 849.1975083546051, 870.5647176411794, 884.9292056635486, 891.0, 877.9517126558037, 882.2148288023632, 885.0574138542464, 885.4687187687368, 885.8848349714528, 923.0354279777615, 925.0749250749251, 927.3276874266137, 928.04875003122, 928.3176865004217, 754.7245255481764, 876.5091548732698, 913.0230653201078, 913.3195769152024, 916.4501299220481, 675.5946432140726, 677.2956125629339, 677.6374639567857, 677.6916502991177, 677.7966610017024, 13346.0, 13353.332333383292, 13368.799468007988, 13403.731925361535, 13472.461101555926, 15311.617209569738, 16076.678466430723, 16124.838751612568, 16410.0, 16449.0, 12552.748945021049, 13095.607131786062, 13279.86720132796, 13383.397747101404, 13506.527271545448, 4803.18345881201, 4804.327394164785, 4861.805527778884, 4930.4330002049865, 4967.776450059756, 78865.05674716241, 79061.0, 79372.0, 79951.60024199841, 80850.19149808485, 12162.270263784201, 12278.877211227951, 12331.260124392566, 12339.50641974311, 12349.19730217533, 20778.064987075315, 20778.584428311653, 20800.271990480564, 20815.479613009797, 20855.47861303449, 8903.955480222687, 8921.509316987498, 9158.542072896329, 9168.31237657165, 9267.026962168875, 5163.199704045879, 5277.788888444419, 5351.839444816662, 5360.785568577291, 5447.618666693294, 3870.07118291608, 4004.9199016019516, 4016.959830401717, 4021.3967904814513, 4058.512978442606, 625.5933643131909, 721.7185297733888, 740.6926125657792, 753.4123383760675, 755.2938002967243, 694.9027136200936, 695.9721611135498, 775.8719811231197, 799.476342995339, 804.3444592656966, 11360.1479889007, 11370.374629395463, 11486.712832179262, 11728.824067638992, 11809.291442513477, 748.8614606297853, 761.8819083042138, 785.1951749456853, 788.3417346515723, 802.7431222008901, 5240.502152295526, 5309.177077552986, 5329.491901310873, 5374.54316383104, 5420.078586640202, 128232.0, 140011.0, 141398.0, 141834.0, 145115.0, 62126.0, 78076.0, 94149.0, 105097.0, 106063.46968265109, 71441.0, 76004.23995759971, 88838.11161888427, 91145.54427227954, 95000.52499737595, 10399.58401663925, 10487.318324308895, 10625.521851516545, 10666.89333106659, 10757.46212689378, 54435.0, 55080.724596376764, 55491.0, 55895.0, 56238.0, 72871.0, 80611.19388806037, 80963.0, 82136.58931705303, 82605.0, 15250.237488125771, 15303.540893773205, 15318.234088295763, 15355.692886142439, 15420.84579154194, 16001.599960001093, 16154.919225403797, 16438.013719176888, 16920.407785727934, 16940.745888811925, 15242.618934526725, 15751.842481575037, 15778.0, 16012.839871601134, 16150.353985840435, 14497.85502144965, 15021.849781502046, 15155.393784248507, 15748.370065197721, 15798.684026319639, 14880.107193568421, 14945.0, 15099.698006039598, 15252.847471525587, 15726.0, 11884.405779710807, 11935.940320298343, 12178.391080445765, 12233.388330583257, 12668.176568523017, 12216.144869859025, 12303.692407689521, 12321.44553495077, 12511.749765004832, 12860.678483037998], "value": 8234.571735603418, "unit": "score"}], "name": "dromaeo_css", "value": 7654.847553969672, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 109.0, 110.0, 110.0, 110.0, 110.0, 113.0, 111.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 124.0, 175.0, 122.0, 125.0, 150.0, 122.0, 154.0, 123.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 161.0, 160.0, 160.0, 161.0, 159.0, 160.0, 161.0, 160.0, 159.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 126.0, 74.0, 76.0, 74.0, 76.0, 97.0, 74.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 113.0, 84.0, 84.0, 85.0, 114.0, 85.0, 85.0, 125.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 52.0, 51.0, 52.0, 51.0, 51.0, 50.0, 50.0, 51.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 61.0, 60.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 77.0, 75.0, 76.0, 77.0, 81.0, 115.0, 76.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 127.0, 122.0, 122.0, 116.0, 115.0, 119.0, 124.0, 119.0, 116.0], "value": 119.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 153.0, 151.0, 153.0, 150.0, 151.0, 151.0, 150.0, 154.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 60.0, 62.0, 61.0, 61.0, 60.0, 60.0, 62.0, 65.0], "value": 61.5, "unit": "score"}], "name": "kraken", "value": 1464.9000000000003, "alertThreshold": 2.0}]} 03:40:38 INFO - Return code: 0 03:40:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:40:38 ERROR - # TBPL SUCCESS # 03:40:38 INFO - Running post-action listener: _resource_record_post_action 03:40:38 INFO - ##### 03:40:38 INFO - ##### Finished run-tests step (success) 03:40:38 INFO - ##### 03:40:38 INFO - Running post-run listener: _resource_record_post_run 03:40:38 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 290816; Write bytes: 505626624; Read time: 48; Write time: 404028 03:40:38 INFO - TinderboxPrint: CPU usage
13.1% 03:40:38 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 48 03:40:38 INFO - TinderboxPrint: I/O write bytes / time
505,626,624 / 404,028 03:40:38 INFO - TinderboxPrint: CPU idle
8,258.4 (86.9%) 03:40:38 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 03:40:38 INFO - TinderboxPrint: Swap in / out
0 / 0 03:40:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 259403776; Read time: 0; Write time: 228140 03:40:38 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 246222848; Read time: 32; Write time: 175888 03:40:38 INFO - Running post-run listener: _upload_blobber_files 03:40:38 INFO - Blob upload gear active. 03:40:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:40:38 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:40:38 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:40:38 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:40:39 INFO - (blobuploader) - INFO - Open directory for files ... 03:40:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:40:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:40:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:39 INFO - (blobuploader) - INFO - Done attempting. 03:40:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:40:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:40:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:40 INFO - (blobuploader) - INFO - Done attempting. 03:40:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:40:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:40:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:44 INFO - (blobuploader) - INFO - Done attempting. 03:40:44 INFO - (blobuploader) - INFO - Iteration through files over. 03:40:44 INFO - Return code: 0 03:40:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:40:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:40:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20f24ad60ebcc11a0b6a862874611ec33257078f9a1cdd827b5777e94dc7bf12702a4f503dba15ed123224457607aaa081bdfe74b4ae8e631fb77411fb05eb8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9edbf673cc8c1de1be280844902679b6104dbdf23eeea5e07073ab22a09b7bfbc0b2189d57208521df00d3ae3b956583d624c90697977720bf661a54f924a2fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56b57fc8fa1d59c59986a2dcfd671bba38ffd78b9493853270428d6a7cea214861004ee3b85ee58b2b7aa2915ebe4cbe5b44fa2610a2da51086bf58d8b3d4007"} 03:40:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:40:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:40:44 INFO - Contents: 03:40:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20f24ad60ebcc11a0b6a862874611ec33257078f9a1cdd827b5777e94dc7bf12702a4f503dba15ed123224457607aaa081bdfe74b4ae8e631fb77411fb05eb8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9edbf673cc8c1de1be280844902679b6104dbdf23eeea5e07073ab22a09b7bfbc0b2189d57208521df00d3ae3b956583d624c90697977720bf661a54f924a2fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56b57fc8fa1d59c59986a2dcfd671bba38ffd78b9493853270428d6a7cea214861004ee3b85ee58b2b7aa2915ebe4cbe5b44fa2610a2da51086bf58d8b3d4007"} 03:40:44 INFO - Running post-run listener: copy_logs_to_upload_dir 03:40:44 INFO - Copying logs to upload dir... 03:40:44 INFO - mkdir: /builds/slave/test/build/upload/logs 03:40:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.726034 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-01 03:40:44.333391) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 03:40:44.336974) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785 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/20f24ad60ebcc11a0b6a862874611ec33257078f9a1cdd827b5777e94dc7bf12702a4f503dba15ed123224457607aaa081bdfe74b4ae8e631fb77411fb05eb8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9edbf673cc8c1de1be280844902679b6104dbdf23eeea5e07073ab22a09b7bfbc0b2189d57208521df00d3ae3b956583d624c90697977720bf661a54f924a2fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56b57fc8fa1d59c59986a2dcfd671bba38ffd78b9493853270428d6a7cea214861004ee3b85ee58b2b7aa2915ebe4cbe5b44fa2610a2da51086bf58d8b3d4007"} build_url:https://queue.taskcluster.net/v1/task/XzUuSDFpSvKVfHr3R6zsjA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011424 build_url: 'https://queue.taskcluster.net/v1/task/XzUuSDFpSvKVfHr3R6zsjA/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/20f24ad60ebcc11a0b6a862874611ec33257078f9a1cdd827b5777e94dc7bf12702a4f503dba15ed123224457607aaa081bdfe74b4ae8e631fb77411fb05eb8b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9edbf673cc8c1de1be280844902679b6104dbdf23eeea5e07073ab22a09b7bfbc0b2189d57208521df00d3ae3b956583d624c90697977720bf661a54f924a2fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56b57fc8fa1d59c59986a2dcfd671bba38ffd78b9493853270428d6a7cea214861004ee3b85ee58b2b7aa2915ebe4cbe5b44fa2610a2da51086bf58d8b3d4007"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 03:40:44.362616) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 03:40:44.362951) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467368409.832820-306801785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 03:40:44.446763) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 03:40:44.447106) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 03:40:44.447416) ========= ========= Total master_lag: 0.17 =========