builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1466507619.02 results: success (0) buildid: 20160621025605 builduid: 18c7bc5306884d04b4a6e8cd47f1f130 revision: 027db1e33f89606c4996feae0203e5f3bb5db43d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 04:13:39.018118) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 04:13:39.018625) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 04:13:39.018913) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 04:13:39.033559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:13:39.033963) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 04:13:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-06-21 04:13:39 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111924 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:13:39.160143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:13:39.160538) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018838 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:13:39.210739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:13:39.211224) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 027db1e33f89606c4996feae0203e5f3bb5db43d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 027db1e33f89606c4996feae0203e5f3bb5db43d --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=14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 04:13:39,358 truncating revision to first 12 chars 2016-06-21 04:13:39,358 Setting DEBUG logging. 2016-06-21 04:13:39,358 attempt 1/10 2016-06-21 04:13:39,358 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/027db1e33f89?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 04:13:39,668 unpacking tar archive at: mozilla-central-027db1e33f89/testing/mozharness/ program finished with exit code 0 elapsedTime=0.708230 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:13:39.933268) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 04:13:39.933693) ========= script_repo_revision: 027db1e33f89606c4996feae0203e5f3bb5db43d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 04:13:39.934158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 04:13:39.934515) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 04:13:39.945465) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-21 04:13:39.945908) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:13:40 INFO - MultiFileLogger online at 20160621 04:13:40 in /builds/slave/test 04:13:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:13:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:40 INFO - {'append_to_log': False, 04:13:40 INFO - 'base_work_dir': '/builds/slave/test', 04:13:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:13:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:40 INFO - 'branch': 'Firefox-Non-PGO', 04:13:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:40 INFO - 'config_files': ('talos/linux_config.py',), 04:13:40 INFO - 'default_actions': ('clobber', 04:13:40 INFO - 'read-buildbot-config', 04:13:40 INFO - 'download-and-extract', 04:13:40 INFO - 'populate-webroot', 04:13:40 INFO - 'create-virtualenv', 04:13:40 INFO - 'install', 04:13:40 INFO - 'run-tests'), 04:13:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:40 INFO - 'download_minidump_stackwalk': True, 04:13:40 INFO - 'download_symbols': 'ondemand', 04:13:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:40 INFO - 'installer_path': 'installer.exe', 04:13:40 INFO - 'log_level': 'info', 04:13:40 INFO - 'log_name': 'talos', 04:13:40 INFO - 'log_to_console': True, 04:13:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:13:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:13:40 INFO - 'opt_config_files': (), 04:13:40 INFO - 'pip_index': False, 04:13:40 INFO - 'sps_profile': False, 04:13:40 INFO - 'sps_profile_interval': 0, 04:13:40 INFO - 'suite': 'dromaeojs-e10s', 04:13:40 INFO - 'system_bits': '32', 04:13:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:40 INFO - 'title': 'talos-linux64-ix-036', 04:13:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:40 INFO - 'use_talos_json': True, 04:13:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:40 INFO - 'work_dir': 'build'} 04:13:40 INFO - ##### 04:13:40 INFO - ##### Running clobber step. 04:13:40 INFO - ##### 04:13:40 INFO - Running pre-action listener: _resource_record_pre_action 04:13:40 INFO - Running main action method: clobber 04:13:40 INFO - rmtree: /builds/slave/test/build 04:13:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:40 INFO - Running post-action listener: _resource_record_post_action 04:13:40 INFO - ##### 04:13:40 INFO - ##### Finished clobber step (success) 04:13:40 INFO - ##### 04:13:40 INFO - ##### 04:13:40 INFO - ##### Running read-buildbot-config step. 04:13:40 INFO - ##### 04:13:40 INFO - Running pre-action listener: _resource_record_pre_action 04:13:40 INFO - Running main action method: read_buildbot_config 04:13:40 INFO - Using buildbot properties: 04:13:40 INFO - { 04:13:40 INFO - "project": "", 04:13:40 INFO - "product": "firefox", 04:13:40 INFO - "script_repo_revision": "production", 04:13:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:13:40 INFO - "repository": "", 04:13:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:13:40 INFO - "buildid": "20160621025605", 04:13:40 INFO - "pgo_build": "False", 04:13:40 INFO - "basedir": "/builds/slave/test", 04:13:40 INFO - "buildnumber": 351, 04:13:40 INFO - "slavename": "talos-linux64-ix-036", 04:13:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:13:40 INFO - "platform": "ubuntu64_hw", 04:13:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:13:40 INFO - "branch": "mozilla-central", 04:13:40 INFO - "repo_path": "mozilla-central", 04:13:40 INFO - "revision": "027db1e33f89606c4996feae0203e5f3bb5db43d", 04:13:40 INFO - "stage_platform": "linux64", 04:13:40 INFO - "builduid": "18c7bc5306884d04b4a6e8cd47f1f130", 04:13:40 INFO - "slavebuilddir": "test" 04:13:40 INFO - } 04:13:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:13:40 INFO - Running post-action listener: _resource_record_post_action 04:13:40 INFO - ##### 04:13:40 INFO - ##### Finished read-buildbot-config step (success) 04:13:40 INFO - ##### 04:13:40 INFO - ##### 04:13:40 INFO - ##### Running download-and-extract step. 04:13:40 INFO - ##### 04:13:40 INFO - Running pre-action listener: _resource_record_pre_action 04:13:40 INFO - Running main action method: download_and_extract 04:13:40 INFO - mkdir: /builds/slave/test/build/tests 04:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:40 INFO - https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:13:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:13:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:13:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:13:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:13:41 INFO - Downloaded 1361 bytes. 04:13:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:13:41 INFO - Using the following test package requirements: 04:13:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:13:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:13:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:41 INFO - u'jsshell-linux-x86_64.zip'], 04:13:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:13:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:13:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:13:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:13:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:13:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:41 INFO - https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:13:43 INFO - Downloaded 22654924 bytes. 04:13:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:13:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:13:44 INFO - Return code: 0 04:13:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:44 INFO - https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:13:45 INFO - Downloaded 22654924 bytes. 04:13:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:13:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:13:46 INFO - Return code: 0 04:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:46 INFO - https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:13:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:13:47 INFO - Downloaded 14405384 bytes. 04:13:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:13:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:13:48 INFO - Return code: 0 04:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:48 INFO - https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:13:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:13:53 INFO - Downloaded 56228248 bytes. 04:13:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:53 INFO - mkdir: /builds/slave/test/properties 04:13:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:53 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:53 INFO - Contents: 04:13:53 INFO - build_url:https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:54 INFO - Running post-action listener: _resource_record_post_action 04:13:54 INFO - Running post-action listener: set_extra_try_arguments 04:13:54 INFO - ##### 04:13:54 INFO - ##### Finished download-and-extract step (success) 04:13:54 INFO - ##### 04:13:54 INFO - ##### 04:13:54 INFO - ##### Running populate-webroot step. 04:13:54 INFO - ##### 04:13:54 INFO - Running pre-action listener: _resource_record_pre_action 04:13:54 INFO - Running main action method: populate_webroot 04:13:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:54 INFO - '--tppagecycles', 04:13:54 INFO - '7'], 04:13:54 INFO - 'tests': ['tsvgm']}}, 04:13:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:54 INFO - 'talos_options': ['--disable-e10s'], 04:13:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:54 INFO - 'talos_options': ['--disable-e10s'], 04:13:54 INFO - 'tests': ['damp', 'tps']}, 04:13:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:54 INFO - 'tests': ['damp', 'tps']}, 04:13:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:54 INFO - 'tests': ['dromaeo_dom']}, 04:13:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:13:54 INFO - 'tests': ['basic_compositor_video']}, 04:13:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:13:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:54 INFO - 'tests': ['a11yr', 04:13:54 INFO - 'ts_paint', 04:13:54 INFO - 'tpaint', 04:13:54 INFO - 'sessionrestore', 04:13:54 INFO - 'sessionrestore_no_auto_restore', 04:13:54 INFO - 'tabpaint']}, 04:13:54 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:54 INFO - 'ts_paint', 04:13:54 INFO - 'tpaint', 04:13:54 INFO - 'sessionrestore', 04:13:54 INFO - 'sessionrestore_no_auto_restore', 04:13:54 INFO - 'tabpaint']}, 04:13:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:54 INFO - 'ts_paint', 04:13:54 INFO - 'tpaint', 04:13:54 INFO - 'sessionrestore', 04:13:54 INFO - 'sessionrestore_no_auto_restore', 04:13:54 INFO - 'tabpaint']}, 04:13:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:54 INFO - 'ts_paint', 04:13:54 INFO - 'tpaint', 04:13:54 INFO - 'sessionrestore', 04:13:54 INFO - 'sessionrestore_no_auto_restore', 04:13:54 INFO - 'tabpaint']}, 04:13:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:54 INFO - 'tests': ['a11yr', 04:13:54 INFO - 'ts_paint', 04:13:54 INFO - 'tpaint', 04:13:54 INFO - 'sessionrestore', 04:13:54 INFO - 'sessionrestore_no_auto_restore', 04:13:54 INFO - 'tabpaint']}, 04:13:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:54 INFO - 'tests': ['a11yr', 04:13:54 INFO - 'ts_paint', 04:13:54 INFO - 'tpaint', 04:13:54 INFO - 'sessionrestore', 04:13:54 INFO - 'sessionrestore_no_auto_restore', 04:13:54 INFO - 'tabpaint']}, 04:13:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:54 INFO - 'tests': ['tsvgx', 04:13:54 INFO - 'tsvgr_opacity', 04:13:54 INFO - 'tart', 04:13:54 INFO - 'tscrollx', 04:13:54 INFO - 'cart']}, 04:13:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:54 INFO - 'tsvgr_opacity', 04:13:54 INFO - 'tart', 04:13:54 INFO - 'tscrollx', 04:13:54 INFO - 'cart']}, 04:13:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:54 INFO - 'talos_options': ['--disable-e10s'], 04:13:54 INFO - 'tests': ['tp5o']}, 04:13:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:54 INFO - 'tests': ['tp5o']}, 04:13:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:54 INFO - 'talos_options': ['--disable-e10s', 04:13:54 INFO - '--xperf_path', 04:13:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:54 INFO - 'tests': ['tp5n']}, 04:13:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:54 INFO - 'talos_options': ['--xperf_path', 04:13:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:54 INFO - 'tests': ['tp5n']}}, 04:13:54 INFO - 'talos.zip': {'path': '', 04:13:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:54 INFO - Running post-action listener: _resource_record_post_action 04:13:54 INFO - ##### 04:13:54 INFO - ##### Finished populate-webroot step (success) 04:13:54 INFO - ##### 04:13:54 INFO - ##### 04:13:54 INFO - ##### Running create-virtualenv step. 04:13:54 INFO - ##### 04:13:54 INFO - Running pre-action listener: _resource_record_pre_action 04:13:54 INFO - Running main action method: create_virtualenv 04:13:54 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:54 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 04:13:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:54 INFO - Using real prefix '/usr' 04:13:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:56 INFO - Installing pip.................done. 04:13:56 INFO - Return code: 0 04:13:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:56 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 0x7f078bbbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa71c0>, '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 0xfa80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', '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 04:13:56 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 04:13:56 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 04:13:56 INFO - Using env: {'DISPLAY': ':0', 04:13:56 INFO - 'HOME': '/home/cltbld', 04:13:56 INFO - 'LANG': 'en_US.UTF-8', 04:13:56 INFO - 'LANGUAGE': 'en_US:en', 04:13:56 INFO - 'LOGNAME': 'cltbld', 04:13:56 INFO - 'MAIL': '/var/mail/cltbld', 04:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:56 INFO - 'MOZ_NO_REMOTE': '1', 04:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:56 INFO - 'NO_EM_RESTART': '1', 04:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:56 INFO - 'PWD': '/builds/slave/test', 04:13:56 INFO - 'SHELL': '/bin/bash', 04:13:56 INFO - 'SHLVL': '1', 04:13:56 INFO - 'TERM': 'linux', 04:13:56 INFO - 'TMOUT': '86400', 04:13:56 INFO - 'USER': 'cltbld', 04:13:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', 04:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:56 INFO - '_': '/tools/buildbot/bin/python'} 04:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:56 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 04:13:56 INFO - Cleaning up... 04:13:56 INFO - Return code: 0 04:13:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:56 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 0x7f078bbbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa71c0>, '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 0xfa80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', '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 04:13:56 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 04:13:56 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 04:13:56 INFO - Using env: {'DISPLAY': ':0', 04:13:56 INFO - 'HOME': '/home/cltbld', 04:13:56 INFO - 'LANG': 'en_US.UTF-8', 04:13:56 INFO - 'LANGUAGE': 'en_US:en', 04:13:56 INFO - 'LOGNAME': 'cltbld', 04:13:56 INFO - 'MAIL': '/var/mail/cltbld', 04:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:56 INFO - 'MOZ_NO_REMOTE': '1', 04:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:56 INFO - 'NO_EM_RESTART': '1', 04:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:56 INFO - 'PWD': '/builds/slave/test', 04:13:56 INFO - 'SHELL': '/bin/bash', 04:13:56 INFO - 'SHLVL': '1', 04:13:56 INFO - 'TERM': 'linux', 04:13:56 INFO - 'TMOUT': '86400', 04:13:56 INFO - 'USER': 'cltbld', 04:13:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', 04:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:56 INFO - '_': '/tools/buildbot/bin/python'} 04:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:57 INFO - Downloading/unpacking psutil>=3.1.1 04:13:57 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 04:13:57 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 04:13:57 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 04:13:57 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 04:13:57 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 04:13:57 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 04:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:59 INFO - Installing collected packages: psutil 04:13:59 INFO - Running setup.py install for psutil 04:13:59 INFO - building 'psutil._psutil_linux' extension 04:13:59 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 04:13:59 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 04:13:59 INFO - building 'psutil._psutil_posix' extension 04:13:59 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 04:13:59 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 04:13:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:59 INFO - Successfully installed psutil 04:13:59 INFO - Cleaning up... 04:13:59 INFO - Return code: 0 04:13:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:59 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 0x7f078bbbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa71c0>, '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 0xfa80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', '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 04:13:59 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 04:13:59 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 04:13:59 INFO - Using env: {'DISPLAY': ':0', 04:13:59 INFO - 'HOME': '/home/cltbld', 04:13:59 INFO - 'LANG': 'en_US.UTF-8', 04:13:59 INFO - 'LANGUAGE': 'en_US:en', 04:13:59 INFO - 'LOGNAME': 'cltbld', 04:13:59 INFO - 'MAIL': '/var/mail/cltbld', 04:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:59 INFO - 'MOZ_NO_REMOTE': '1', 04:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:59 INFO - 'NO_EM_RESTART': '1', 04:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:59 INFO - 'PWD': '/builds/slave/test', 04:13:59 INFO - 'SHELL': '/bin/bash', 04:13:59 INFO - 'SHLVL': '1', 04:13:59 INFO - 'TERM': 'linux', 04:13:59 INFO - 'TMOUT': '86400', 04:13:59 INFO - 'USER': 'cltbld', 04:13:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', 04:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:59 INFO - '_': '/tools/buildbot/bin/python'} 04:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:13:59 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 04:13:59 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 04:13:59 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 04:13:59 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 04:13:59 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 04:13:59 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 04:14:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:14:01 INFO - Installing collected packages: mozsystemmonitor 04:14:01 INFO - Running setup.py install for mozsystemmonitor 04:14:01 INFO - Successfully installed mozsystemmonitor 04:14:01 INFO - Cleaning up... 04:14:01 INFO - Return code: 0 04:14:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f078bbbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa71c0>, '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 0xfa80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', '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 04:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:14:01 INFO - Using env: {'DISPLAY': ':0', 04:14:01 INFO - 'HOME': '/home/cltbld', 04:14:01 INFO - 'LANG': 'en_US.UTF-8', 04:14:01 INFO - 'LANGUAGE': 'en_US:en', 04:14:01 INFO - 'LOGNAME': 'cltbld', 04:14:01 INFO - 'MAIL': '/var/mail/cltbld', 04:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:01 INFO - 'MOZ_NO_REMOTE': '1', 04:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:01 INFO - 'NO_EM_RESTART': '1', 04:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:01 INFO - 'PWD': '/builds/slave/test', 04:14:01 INFO - 'SHELL': '/bin/bash', 04:14:01 INFO - 'SHLVL': '1', 04:14:01 INFO - 'TERM': 'linux', 04:14:01 INFO - 'TMOUT': '86400', 04:14:01 INFO - 'USER': 'cltbld', 04:14:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', 04:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:01 INFO - '_': '/tools/buildbot/bin/python'} 04:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:02 INFO - Downloading/unpacking jsonschema==2.5.1 04:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:04 INFO - warning: no files found matching '*.txt' 04:14:04 INFO - no previously-included directories found matching 'build' 04:14:04 INFO - no previously-included directories found matching 'dist' 04:14:04 INFO - no previously-included directories found matching '.git*' 04:14:04 INFO - Installing collected packages: jsonschema, functools32 04:14:04 INFO - Running setup.py install for functools32 04:14:04 INFO - warning: no files found matching '*.txt' 04:14:04 INFO - no previously-included directories found matching 'build' 04:14:04 INFO - no previously-included directories found matching 'dist' 04:14:04 INFO - no previously-included directories found matching '.git*' 04:14:04 INFO - Successfully installed jsonschema functools32 04:14:04 INFO - Cleaning up... 04:14:04 INFO - Return code: 0 04:14:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f078bbbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa71c0>, '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 0xfa80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', '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 04:14:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:14:04 INFO - Using env: {'DISPLAY': ':0', 04:14:04 INFO - 'HOME': '/home/cltbld', 04:14:04 INFO - 'LANG': 'en_US.UTF-8', 04:14:04 INFO - 'LANGUAGE': 'en_US:en', 04:14:04 INFO - 'LOGNAME': 'cltbld', 04:14:04 INFO - 'MAIL': '/var/mail/cltbld', 04:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:04 INFO - 'MOZ_NO_REMOTE': '1', 04:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:04 INFO - 'NO_EM_RESTART': '1', 04:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:04 INFO - 'PWD': '/builds/slave/test', 04:14:04 INFO - 'SHELL': '/bin/bash', 04:14:04 INFO - 'SHLVL': '1', 04:14:04 INFO - 'TERM': 'linux', 04:14:04 INFO - 'TMOUT': '86400', 04:14:04 INFO - 'USER': 'cltbld', 04:14:04 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', 04:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:04 INFO - '_': '/tools/buildbot/bin/python'} 04:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:04 INFO - Downloading/unpacking blobuploader==1.2.4 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:06 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:07 INFO - Downloading docopt-0.6.1.tar.gz 04:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:07 INFO - Running setup.py install for blobuploader 04:14:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:07 INFO - Running setup.py install for requests 04:14:07 INFO - Running setup.py install for docopt 04:14:07 INFO - Successfully installed blobuploader requests docopt 04:14:07 INFO - Cleaning up... 04:14:07 INFO - Return code: 0 04:14:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:07 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 0x7f078bbbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa71c0>, '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 0xfa80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', '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 04:14:07 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 04:14:07 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 04:14:07 INFO - Using env: {'DISPLAY': ':0', 04:14:07 INFO - 'HOME': '/home/cltbld', 04:14:07 INFO - 'LANG': 'en_US.UTF-8', 04:14:07 INFO - 'LANGUAGE': 'en_US:en', 04:14:07 INFO - 'LOGNAME': 'cltbld', 04:14:07 INFO - 'MAIL': '/var/mail/cltbld', 04:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:07 INFO - 'MOZ_NO_REMOTE': '1', 04:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:07 INFO - 'NO_EM_RESTART': '1', 04:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:07 INFO - 'PWD': '/builds/slave/test', 04:14:07 INFO - 'SHELL': '/bin/bash', 04:14:07 INFO - 'SHLVL': '1', 04:14:07 INFO - 'TERM': 'linux', 04:14:07 INFO - 'TMOUT': '86400', 04:14:07 INFO - 'USER': 'cltbld', 04:14:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', 04:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:07 INFO - '_': '/tools/buildbot/bin/python'} 04:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:08 INFO - Running setup.py (path:/tmp/pip-8Gio1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:08 INFO - Running setup.py (path:/tmp/pip-FM_8zA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:08 INFO - Running setup.py (path:/tmp/pip-L1A5Th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:08 INFO - Running setup.py (path:/tmp/pip-VaPY2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:08 INFO - Running setup.py (path:/tmp/pip-NwsnsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:08 INFO - Running setup.py (path:/tmp/pip-WSP94I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:08 INFO - Running setup.py (path:/tmp/pip-IW5NaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:08 INFO - Running setup.py (path:/tmp/pip-0VLwaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:08 INFO - Running setup.py (path:/tmp/pip-3azUzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:08 INFO - Running setup.py (path:/tmp/pip-rE0Vde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:08 INFO - Running setup.py (path:/tmp/pip-31wskQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:08 INFO - Running setup.py (path:/tmp/pip-DlI20W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:09 INFO - Running setup.py (path:/tmp/pip-1RFn_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:09 INFO - Running setup.py (path:/tmp/pip-wlQ2gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:09 INFO - Running setup.py (path:/tmp/pip-OsjsGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:09 INFO - Running setup.py (path:/tmp/pip-bNPOGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:09 INFO - Running setup.py (path:/tmp/pip-sDfiTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:09 INFO - Running setup.py install for manifestparser 04:14:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:09 INFO - Running setup.py install for mozcrash 04:14:09 INFO - Running setup.py install for mozdebug 04:14:09 INFO - Running setup.py install for mozdevice 04:14:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:14:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:09 INFO - Running setup.py install for mozfile 04:14:09 INFO - Running setup.py install for mozhttpd 04:14:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Running setup.py install for mozinfo 04:14:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Running setup.py install for mozInstall 04:14:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Running setup.py install for mozleak 04:14:10 INFO - Running setup.py install for mozlog 04:14:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Running setup.py install for moznetwork 04:14:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Running setup.py install for mozprocess 04:14:10 INFO - Running setup.py install for mozprofile 04:14:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Running setup.py install for mozrunner 04:14:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Running setup.py install for mozscreenshot 04:14:10 INFO - Running setup.py install for moztest 04:14:11 INFO - Running setup.py install for mozversion 04:14:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:11 INFO - Cleaning up... 04:14:11 INFO - Return code: 0 04:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:11 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')]} 04:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:11 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')]} 04:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:11 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 0x7f078bbbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa71c0>, '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 0xfa80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', '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 04:14:11 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 04:14:11 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 04:14:11 INFO - Using env: {'DISPLAY': ':0', 04:14:11 INFO - 'HOME': '/home/cltbld', 04:14:11 INFO - 'LANG': 'en_US.UTF-8', 04:14:11 INFO - 'LANGUAGE': 'en_US:en', 04:14:11 INFO - 'LOGNAME': 'cltbld', 04:14:11 INFO - 'MAIL': '/var/mail/cltbld', 04:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:11 INFO - 'MOZ_NO_REMOTE': '1', 04:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:11 INFO - 'NO_EM_RESTART': '1', 04:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:11 INFO - 'PWD': '/builds/slave/test', 04:14:11 INFO - 'SHELL': '/bin/bash', 04:14:11 INFO - 'SHLVL': '1', 04:14:11 INFO - 'TERM': 'linux', 04:14:11 INFO - 'TMOUT': '86400', 04:14:11 INFO - 'USER': 'cltbld', 04:14:11 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', 04:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:11 INFO - '_': '/tools/buildbot/bin/python'} 04:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:11 INFO - Running setup.py (path:/tmp/pip-zbgXb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:11 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)) 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:11 INFO - Running setup.py (path:/tmp/pip-arrDtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:11 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)) 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:11 INFO - Running setup.py (path:/tmp/pip-m1b4rR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:11 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)) 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:11 INFO - Running setup.py (path:/tmp/pip-NdX0Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:11 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)) 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:11 INFO - Running setup.py (path:/tmp/pip-WozJhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:11 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)) 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:11 INFO - Running setup.py (path:/tmp/pip-htR3mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:11 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)) 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:11 INFO - Running setup.py (path:/tmp/pip-CqME43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:11 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)) 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:11 INFO - Running setup.py (path:/tmp/pip-zk3xMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:11 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)) 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:11 INFO - Running setup.py (path:/tmp/pip-geGfYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:12 INFO - Running setup.py (path:/tmp/pip-5NKIZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:12 INFO - Running setup.py (path:/tmp/pip-XBya5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:12 INFO - Running setup.py (path:/tmp/pip-3AHoKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:12 INFO - Running setup.py (path:/tmp/pip-n5yRCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:12 INFO - Running setup.py (path:/tmp/pip-2qgMmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:12 INFO - Running setup.py (path:/tmp/pip-APEMhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:12 INFO - Running setup.py (path:/tmp/pip-QhZD27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:12 INFO - Running setup.py (path:/tmp/pip-cbmYxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:12 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)) 04:14:12 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)) 04:14:12 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)) 04:14:12 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)) 04:14:12 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)) 04:14:12 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)) 04:14:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:14 INFO - Downloading blessings-1.6.tar.gz 04:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:14 INFO - Installing collected packages: blessings 04:14:14 INFO - Running setup.py install for blessings 04:14:14 INFO - Successfully installed blessings 04:14:14 INFO - Cleaning up... 04:14:14 INFO - Return code: 0 04:14:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:15 INFO - Reading from file tmpfile_stdout 04:14:15 INFO - Current package versions: 04:14:15 INFO - argparse == 1.2.1 04:14:15 INFO - blessings == 1.6 04:14:15 INFO - blobuploader == 1.2.4 04:14:15 INFO - docopt == 0.6.1 04:14:15 INFO - functools32 == 3.2.3-2 04:14:15 INFO - jsonschema == 2.5.1 04:14:15 INFO - manifestparser == 1.1 04:14:15 INFO - mozInstall == 1.12 04:14:15 INFO - mozcrash == 0.17 04:14:15 INFO - mozdebug == 0.1 04:14:15 INFO - mozdevice == 0.48 04:14:15 INFO - mozfile == 1.2 04:14:15 INFO - mozhttpd == 0.7 04:14:15 INFO - mozinfo == 0.9 04:14:15 INFO - mozleak == 0.1 04:14:15 INFO - mozlog == 3.2 04:14:15 INFO - moznetwork == 0.27 04:14:15 INFO - mozprocess == 0.22 04:14:15 INFO - mozprofile == 0.28 04:14:15 INFO - mozrunner == 6.11 04:14:15 INFO - mozscreenshot == 0.1 04:14:15 INFO - mozsystemmonitor == 0.3 04:14:15 INFO - moztest == 0.7 04:14:15 INFO - mozversion == 1.4 04:14:15 INFO - psutil == 3.1.1 04:14:15 INFO - requests == 1.2.3 04:14:15 INFO - wsgiref == 0.1.2 04:14:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:15 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 0x7f078bbbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa71c0>, '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 0xfa80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', '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 04:14:15 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 04:14:15 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 04:14:15 INFO - Using env: {'DISPLAY': ':0', 04:14:15 INFO - 'HOME': '/home/cltbld', 04:14:15 INFO - 'LANG': 'en_US.UTF-8', 04:14:15 INFO - 'LANGUAGE': 'en_US:en', 04:14:15 INFO - 'LOGNAME': 'cltbld', 04:14:15 INFO - 'MAIL': '/var/mail/cltbld', 04:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:15 INFO - 'MOZ_NO_REMOTE': '1', 04:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:15 INFO - 'NO_EM_RESTART': '1', 04:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:15 INFO - 'PWD': '/builds/slave/test', 04:14:15 INFO - 'SHELL': '/bin/bash', 04:14:15 INFO - 'SHLVL': '1', 04:14:15 INFO - 'TERM': 'linux', 04:14:15 INFO - 'TMOUT': '86400', 04:14:15 INFO - 'USER': 'cltbld', 04:14:15 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', 04:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:15 INFO - '_': '/tools/buildbot/bin/python'} 04:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:15 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)) 04:14:15 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)) 04:14:15 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)) 04:14:15 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)) 04:14:15 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)) 04:14:15 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)) 04:14:15 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)) 04:14:15 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)) 04:14:15 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)) 04:14:15 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)) 04:14:15 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)) 04:14:15 INFO - Cleaning up... 04:14:15 INFO - Return code: 0 04:14:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:15 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 0x7f078bbbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa71c0>, '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 0xfa80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', '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 04:14:15 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 04:14:15 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 04:14:15 INFO - Using env: {'DISPLAY': ':0', 04:14:15 INFO - 'HOME': '/home/cltbld', 04:14:15 INFO - 'LANG': 'en_US.UTF-8', 04:14:15 INFO - 'LANGUAGE': 'en_US:en', 04:14:15 INFO - 'LOGNAME': 'cltbld', 04:14:15 INFO - 'MAIL': '/var/mail/cltbld', 04:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:15 INFO - 'MOZ_NO_REMOTE': '1', 04:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:15 INFO - 'NO_EM_RESTART': '1', 04:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:15 INFO - 'PWD': '/builds/slave/test', 04:14:15 INFO - 'SHELL': '/bin/bash', 04:14:15 INFO - 'SHLVL': '1', 04:14:15 INFO - 'TERM': 'linux', 04:14:15 INFO - 'TMOUT': '86400', 04:14:15 INFO - 'USER': 'cltbld', 04:14:15 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', 04:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:15 INFO - '_': '/tools/buildbot/bin/python'} 04:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:14:15 INFO - Cleaning up... 04:14:15 INFO - Return code: 0 04:14:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:15 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 0x7f078bbbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf18350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa71c0>, '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 0xfa80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', '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 04:14:15 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 04:14:15 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 04:14:15 INFO - Using env: {'DISPLAY': ':0', 04:14:15 INFO - 'HOME': '/home/cltbld', 04:14:15 INFO - 'LANG': 'en_US.UTF-8', 04:14:15 INFO - 'LANGUAGE': 'en_US:en', 04:14:15 INFO - 'LOGNAME': 'cltbld', 04:14:15 INFO - 'MAIL': '/var/mail/cltbld', 04:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:15 INFO - 'MOZ_NO_REMOTE': '1', 04:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:15 INFO - 'NO_EM_RESTART': '1', 04:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:15 INFO - 'PWD': '/builds/slave/test', 04:14:15 INFO - 'SHELL': '/bin/bash', 04:14:15 INFO - 'SHLVL': '1', 04:14:15 INFO - 'TERM': 'linux', 04:14:15 INFO - 'TMOUT': '86400', 04:14:15 INFO - 'USER': 'cltbld', 04:14:15 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', 04:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:15 INFO - '_': '/tools/buildbot/bin/python'} 04:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:15 INFO - Downloading/unpacking flake8 04:14:15 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 04:14:15 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 04:14:15 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 04:14:15 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 04:14:15 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 04:14:15 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 04:14:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:14:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:14:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:14:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:18 INFO - no previously-included directories found matching 'docs/_build' 04:14:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:14:18 INFO - Running setup.py install for pep8 04:14:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:18 INFO - no previously-included directories found matching 'docs/_build' 04:14:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:14:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:14:18 INFO - Cleaning up... 04:14:18 INFO - Return code: 0 04:14:18 INFO - Running post-action listener: _resource_record_post_action 04:14:18 INFO - Running post-action listener: _start_resource_monitoring 04:14:18 INFO - Starting resource monitoring. 04:14:18 INFO - ##### 04:14:18 INFO - ##### Finished create-virtualenv step (success) 04:14:18 INFO - ##### 04:14:18 INFO - ##### 04:14:18 INFO - ##### Running install step. 04:14:18 INFO - ##### 04:14:18 INFO - Running pre-action listener: _resource_record_pre_action 04:14:18 INFO - Running main action method: install 04:14:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:18 INFO - Reading from file tmpfile_stdout 04:14:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:18 INFO - Reading from file tmpfile_stdout 04:14:18 INFO - Output received: 04:14:18 INFO - Usage: mozinstall [options] installer 04:14:18 INFO - Options: 04:14:18 INFO - -h, --help show this help message and exit 04:14:18 INFO - -d DEST, --destination=DEST 04:14:18 INFO - Directory to install application into. [default: 04:14:18 INFO - "/builds/slave/test"] 04:14:18 INFO - --app=APP Application being installed. [default: firefox] 04:14:18 INFO - mkdir: /builds/slave/test/build/application 04:14:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:14:35 INFO - Reading from file tmpfile_stdout 04:14:35 INFO - Output received: 04:14:35 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:35 INFO - Running post-action listener: _resource_record_post_action 04:14:35 INFO - ##### 04:14:35 INFO - ##### Finished install step (success) 04:14:35 INFO - ##### 04:14:35 INFO - ##### 04:14:35 INFO - ##### Running run-tests step. 04:14:35 INFO - ##### 04:14:35 INFO - Running pre-action listener: _resource_record_pre_action 04:14:35 INFO - Running main action method: run_tests 04:14:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:35 INFO - Python 2.7.3 04:14:35 INFO - Return code: 0 04:14:35 INFO - grabbing minidump binary from tooltool 04:14: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')]} 04:14:35 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 0xfa71c0>, '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 0xfa80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa8550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:35 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 04:14:35 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 04:14:35 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 04:14:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:35 INFO - Return code: 0 04:14:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:14:36 INFO - Return code: 0 04:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:14:36 INFO - Using env: {'DISPLAY': ':0', 04:14:36 INFO - 'HOME': '/home/cltbld', 04:14:36 INFO - 'LANG': 'en_US.UTF-8', 04:14:36 INFO - 'LANGUAGE': 'en_US:en', 04:14:36 INFO - 'LOGNAME': 'cltbld', 04:14:36 INFO - 'MAIL': '/var/mail/cltbld', 04:14:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:36 INFO - 'MOZ_NO_REMOTE': '1', 04:14:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:36 INFO - 'NO_EM_RESTART': '1', 04:14:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:36 INFO - 'PWD': '/builds/slave/test', 04:14:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:36 INFO - 'SHELL': '/bin/bash', 04:14:36 INFO - 'SHLVL': '1', 04:14:36 INFO - 'TERM': 'linux', 04:14:36 INFO - 'TMOUT': '86400', 04:14:36 INFO - 'USER': 'cltbld', 04:14:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968', 04:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:36 INFO - '_': '/tools/buildbot/bin/python'} 04:14:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:14:36 INFO - mozversion application_buildid: 20160621025605 04:14:36 INFO - mozversion application_changeset: 027db1e33f89606c4996feae0203e5f3bb5db43d 04:14:36 INFO - mozversion application_display_name: Nightly 04:14:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:36 INFO - mozversion application_name: Firefox 04:14:36 INFO - mozversion application_remotingname: firefox 04:14:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:14:36 INFO - mozversion application_vendor: Mozilla 04:14:36 INFO - mozversion application_version: 50.0a1 04:14:36 INFO - mozversion platform_buildid: 20160621025605 04:14:36 INFO - mozversion platform_changeset: 027db1e33f89606c4996feae0203e5f3bb5db43d 04:14:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:14:36 INFO - mozversion platform_version: 50.0a1 04:14:36 INFO - using testdate: 1466507676 04:14:36 INFO - actual date: 1466507676 04:14:36 INFO - starting webserver on 'localhost:55013' 04:14:36 INFO - SUITE-START | Running 2 tests 04:14:36 INFO - TEST-START | dromaeo_css 04:14:36 INFO - operating with platform_type : linux_ 04:14:36 INFO - Initialising browser for dromaeo_css test... 04:14:36 INFO - TEST-INFO | started process 23342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6mioUH/profile http://localhost:55013/getInfo.html) 04:14:41 INFO - PROCESS | 23342 | __metrics Screen width/height:1600/1200 04:14:41 INFO - PROCESS | 23342 | colorDepth:24 04:14:41 INFO - PROCESS | 23342 | Browser inner width/height: 1024/697 04:14:41 INFO - PROCESS | 23342 | __metrics 04:14:42 ERROR - PROCESS | 23342 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:14:43 INFO - TEST-INFO | 23342: exit 0 04:14:43 INFO - Browser initialized. 04:14:43 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:43 INFO - TEST-INFO | started process 23462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6mioUH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:55 INFO - PROCESS | 23462 | RSS: Main: 185729024 04:14:55 INFO - PROCESS | 23462 | 04:15:45 INFO - PROCESS | 23462 | 1466507745070 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] 04:17:57 INFO - PROCESS | 23462 | Cycle 1(1): loaded http://localhost:55013/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55013/tests/dromaeo/cssquery-ext.html) 04:17:58 INFO - PROCESS | 23462 | RSS: Main: 189239296 04:17:58 INFO - PROCESS | 23462 | 04:21:00 INFO - PROCESS | 23462 | Cycle 1(1): loaded http://localhost:55013/tests/dromaeo/cssquery-ext.html (next: http://localhost:55013/tests/dromaeo/cssquery-jquery.html) 04:21:01 INFO - PROCESS | 23462 | RSS: Main: 188305408 04:21:01 INFO - PROCESS | 23462 | 04:24:03 INFO - PROCESS | 23462 | Cycle 1(1): loaded http://localhost:55013/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55013/tests/dromaeo/cssquery-mootools.html) 04:24:03 INFO - PROCESS | 23462 | RSS: Main: 189607936 04:24:03 INFO - PROCESS | 23462 | 04:27:05 INFO - PROCESS | 23462 | Cycle 1(1): loaded http://localhost:55013/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55013/tests/dromaeo/cssquery-prototype.html) 04:27:06 INFO - PROCESS | 23462 | RSS: Main: 186859520 04:27:06 INFO - PROCESS | 23462 | 04:30:09 INFO - PROCESS | 23462 | Cycle 1(1): loaded http://localhost:55013/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55013/tests/dromaeo/cssquery-yui.html) 04:30:09 INFO - PROCESS | 23462 | RSS: Main: 188805120 04:30:09 INFO - PROCESS | 23462 | 04:33:12 INFO - PROCESS | 23462 | Cycle 1(1): loaded http://localhost:55013/tests/dromaeo/cssquery-yui.html (next: http://localhost:55013/tests/dromaeo/cssquery-dojo.html) 04:33:12 INFO - PROCESS | 23462 | RSS: Main: 189980672 04:33:12 INFO - PROCESS | 23462 | 04:33:12 INFO - PROCESS | 23462 | __start_tp_report 04:33:12 INFO - PROCESS | 23462 | _x_x_mozilla_page_load 04:33:12 INFO - PROCESS | 23462 | _x_x_mozilla_page_load_details 04:33:12 INFO - PROCESS | 23462 | |i|pagename|runs| 04:33:12 INFO - PROCESS | 23462 | |0;dojo.html;2606.1660268714013;2669.5061413638477;2673.8796754146074;2681.785457163427;2698.6221928929967;4667.906641867165;4686.133065382906;4744.739039352834;4774.7851346689395;4810.39870016248;4658.417697787777;4674.088552732219;4684.320773487851;4705.129551033061;4743.549362810528;4272.82908683653;4362.781860906958;4425.800838962255;4448.466184057917;4450.287953927373;616.7617555785855;4267.167902259061;4312.97843510782;4353.760543170124;4412.073464572443;4343.956560434387;4350.456192975878;4377.890552736175;4383.0357321389565;4432.800523976396;4358.934615980731;4365.716228445141;4377.102693947765;4400.339949007643;4427.40230068943;4232.026633874226;4258.744475331459;4266.168097221043;4332.458442694663;4348.934765978513;4728.527147285278;4797.472278049412;4803.063402636487;4807.158747219222;4824.7828847701585;5075.289459475676;5158.3552055993005;5184.922934233537;5220.504052115043;5256.027634887558;5166.974165129188;5234.764435600369;5236.554892834076;5240.554552863011;5267.762950667191;4854.689233906861;4866.908801432886;4874.975625121851;4880.145974454456;4889.2910527973245;5151.304573882478;5226.790928362823;5286.444923283077;5350.250964864922;5351.652142610717;5041.59667226621;5059.962707644998;5082.593392528589;5108.744562771921;5124.897502050013;5141.2545180948555;5176.223566464985;5181.35233095863;5183.248428977852;5231.267622532849;4982.8754281143265;5016.197408414636;5042.4957504250015;5069.03688299222;5106.361704786902;5069.011542749128;5074.467180945948;5074.67014644047;5085.160948443539;5130.666506677054;4261.722988005769;4267.466566679165;4267.722598031118;4269.082147338338;4306.160298741778;3704.351738445815;3714.6285371462636;3747.643973822537;3752.7185461090526;3761.4169803680475;4392.714473559208;4427.424434823517;4481.663875209372;4482.618977386958;4524.886877828015;5213.895722085537;5225.451327610622;5225.634205605571;5225.817096401684;5276.234945932895;4379.948812285029;4427.623651989553;4490.079533695584;4499.302608095751;4533.38799262102;4569.702969306984;4570.588647021784;4572.291294849304;4607.562281583244;4614.377059097046;4866.562009419169;4907.55831975124;4921.581665558325;4923.852284431473;4970.701757894538;5037.118504261813;5171.224316352577;5218.008578370098;5226.817061402832;5254.97372513135;4934.383202099738;4935.235038569028;4940.160172770566;4951.579115775199;5006.023825354021;5002.474740152232;5141.7686204120155;5144.6913185209005;5146.871328216825;5148.742562871917;5155.381354237516;5171.92242116361;5198.74006299676;5200.6879587224885;5211.530962213419;5035;5049.495050495068;5062.696238225718;5080.314157588678;5110.48895110486;4910.852674419773;4916.827911023097;5032;5036;5051;4909.1654418748185;4940.308356830118;4962.106820772296;4977.377827771528;4994.475580064186;5037.420696619935;5084.542391184811;5087.3386459759995;5095.847124586268;5146.382434107931;4905.828296009622;4940.827071052496;4978.502149784992;4981.053599816023;4987.9750601248215 04:33:12 INFO - PROCESS | 23462 | |1;ext.html;537.5289926113677;561.6433564686425;584.3163498706514;598.3776872053065;608.5466327585949;34103;38868.61131388685;39053.218935621306;39107.21785564287;39124.60875391245;39130.413043804365;39382.40926386107;39805.80097099511;39819;39913.20173596526;7690.6154692265445;7758.146603873598;7763.340116090111;7776.4945278557;7777.766666999999;7870.252326029046;7893.763187104396;7941.64262608184;7982.521048737065;7986.281234688877;7873;7931.762047138595;7958.52248865067;7959.880601790977;8013.2387423195;7857.960710196412;7882.330001949841;7900.209979002111;7907.446478746519;7913.723019694312;7780.14418413974;7916.247956444128;7936.841263174704;7940.682372705085;7960.442769006172;29330.266743331373;36811.447828282595;37148;37201.81399092987;37205;2974.8363839988792;3030.636323641177;3156.368726254735;3162.6362968258713;3474.722022238215;27027;30077.849610752026;30095.849520752257;30187.849060754557;30449.695503044906;3052.2521982114304;3089.3203495231237;3097.334073174256;3118.033409643018;3126.718595326409;242613;245295;246396;248358;248662.9999999982;55393;56094.15858762122;56133.43866561364;56287;56364;33569.66430335665;34120;34388.48417273743;36270.81864590713;36612;13620.65948351299;13829.79255311151;13833.584992450242;13865.653358665912;13904.58286251414;10059.497025148714;10080.798384032278;10098.242631802645;10237.18102551794;10237.692869213935;19201.007916509516;19352.225910963687;19414.611707765765;19427.902860485607;19624.822510649406;7272.345488906024;7353.23522354631;7376.7418140364825;7612.429067819936;7695.307422331905;804.6781287485053;896.6413434626202;904.326276923696;969.4328817641617;997.2869398380193;26867;28033.71966280352;28203.15390538287;28221.294467638472;28413;921.3228277216241;933.2300851797158;943.6791490893129;958.4057884111895;974.3228456222857;14002.299885005708;14267;14311.57065288043;14618.415263389557;14644.707105857824;397712;658834;672563;675587;675782;50665.746671267145;51159.488405116215;51368.74315628398;51601;51802;1185.4902391971364;1194.325206258461;1197.2995797458584;1201.3632774629461;1207.106741011645;26936.730632693423;27441.980864387955;28164.71835281621;28454.57318140188;28570.285742856595;41406.894482913296;42033;42055;42094;42192.578074218865;347867;351152.1981510787;353358;353682;355481;25264.115755948453;25547.105851295117;25598.872005639852;25604;25707.87146064258;40647.596661420335;41250.1749965005;41367;41929.37105943352;42241.78879105585;34923.126921827155;34944.65055349414;34971.825140874134;35202.64797351994;35429.645703542636;31695;34987.82506087453;35061.64938350686;35242;35288.647113529565;30324.69675303219;34286.31427371489;34444.82777586096;34582.48126278057;34950.30099397947;30757.846210768803;31667.52498712475;31833.204169895937;31957.65503246407;32042.679573203968;24731.258062258163;24976.625350620117;24999.250022499353;25054.248372548853;25131.24606261815 04:33:12 INFO - PROCESS | 23462 | |2;jquery.html;366.4594722783894;366.5210874122915;366.53816191598594;383.53975229724335;385.458430904579;15401;16213.756793648105;16581.41965031224;17054.82945170551;17072.743908841345;15617.453389131382;15923.681526369466;16690.24893879775;16725.16374181292;16754.66490670186;4932.704037757737;5105.234214867763;5118.974405127988;5126.6923984561045;5155.381354237496;5052.469490703478;5081.034603425356;5114.207297868837;5114.488551144893;5134.563562097226;5005.6496045276845;5033.320501732256;5061.670991385567;5069.974650126745;5083;4875.58557522611;4933.7286449245275;5013.323201367805;5032.6477146599755;5059.11465493539;4382.320740285261;4477.194105061088;4496.64026877849;4498.415206023196;4498.595126438636;20069.1972321107;20107.899460502606;20454.795452045437;20611.278605248743;20674.58650826975;2032.9186832526682;2155.6227660159566;2290.9541809163725;2342.7422983471806;2508.297676650541;12850.742985140338;13115.606531804062;13199.40602672882;13295.20228786276;13486.325683715775;1713.9143042847932;1805.6749785038687;1828.8445482134034;1844.0687452836232;1849.519125027489;62106.68946655283;63616.68191659058;63790.68104659493;64650.676746615965;65413.67293163504;9277.628894844265;9482.241420686329;9704.369216000938;9971.950140249251;10369.274150809522;12786.424610892533;12863.099583029098;12905.225686458842;12921.935390322988;12933.870661293455;6913.930860691429;6915.4121899638085;6921.204061532888;7089.716411343488;7157.642117894085;6688.665566721645;6692.59844409337;6750.83122921921;6788.524803263724;6839.0425340452375;5960.374160713062;5960.970195148997;6129.877402451926;6157.7229024694;6224.346443623445;1735.2278236184777;1793.0586442117992;1801.9549511262062;1815.8093400193054;1825.1877914328263;817.627979269431;854.2994744309607;860.2687715441824;899.4333569850952;926.3376685669779;16799.50827782299;16839.158042097846;17124.058176800394;17278.568035799206;17311.56721081983;829.5644786487143;855.619249433996;863.0334025890917;875.4047247871508;884.5046773806689;6940.444764418834;9364.672236471826;9892.505374731234;10024.097831195082;10103.292769506212;395230;400358;403656;406110;409635;50973;61637.38362616406;76639.61680191675;77535.61232193916;81960;926.990730092704;940.9811803764023;957.3729207369184;963.7976025034822;970.6602689058773;15552.222388880284;15662.216889155725;15802.209889505708;15831.129287889276;16122.355105795637;25982.870085650207;27380.45239095247;27719.445611087263;34136.778570359456;39644;50447.74776126096;51098.48901511086;51379;52086.73956630344;52414.737926310125;7447.404207663266;7539.359154471931;7582.658780355007;7627.656755445907;7980.840383192188;11284.492197850952;11744.530218791153;11779.941100294443;11904.345261010727;12163.148579599698;9772.85340719904;9813.950930245303;9840.950795245977;10000.099991000845;10086.949565252127;10605.151587873106;10738.033576978109;10825.133989280996;10847.891521085005;10891.618793342195;9795.265355098254;9849;9989.400635961865;10221.897781022095;10248;6840.623765692934;7136;7417.48077634582;7671.808204794925;7709.151993280622;10280.897191027994;10461.633842815769;10653.627123050655;10718;10797.514111865143 04:33:12 INFO - PROCESS | 23462 | |3;mootools.html;1374.5738820965498;1422.943082276709;1482.2810936695707;1625.8049034115909;1680.6974744545985;6657.966710166443;7408.259174082603;7409;7898.170692077335;7907.683692652294;7486.588237646927;7566.470347075693;7743.225677432254;7759.107702614201;7764.417668674858;2145.313499680099;2179.1174574297434;2179.7929196726286;2180.6510958246686;2190.37574291327;2139.2619546256515;2145.5601601671697;2208.182972300243;2211.060299372768;2212.424769559918;2167.4147980045377;2170.316350349635;2181.7163768710125;2182.138055468089;2221.244776775896;2077.3767869639123;2081.4484161697164;2092.3618296419586;2095.1514636572138;2111.324376199617;2075.8754474731563;2122.8301735861096;2141.314779270634;2144.9571008579896;2145.249162793026;7561.659725312375;7572;7586.962065189638;7661.387089032864;7689.5001824881765;4409.867703968886;4494.640428765691;4509.413776209105;4544.295634176708;4552.226121559343;2740.821846579966;2817.464681710489;2895.174875160569;2908.0839535546233;2908.621879155696;807.1242701668697;843.6625349860044;843.6625349860044;849.6558893648082;852.7782776478099;10155.187584993182;10246.48767561619;10250.846237306447;10305.896941030569;10348.689539313833;3975;3997.6601988830694;4089.9182016359505;4100.425940368351;4145.046639272984;8737.781555461037;8760.649574017096;8763.780905477413;8770.956145219361;8783.91216087831;4551.590356867898;4559.293309537027;4563.863084107482;4568.383268258809;4569.29175977724;3605.963940360615;4096.610821971908;4145.54399016108;4239.194553034913;4249.447571815645;3492.650734926487;3519.7536172468194;3589.407747721649;3627.038834708804;3722.6091260417807;1118.1278602689915;1128.1707944660668;1139.3847322445952;1141.6689160143465;1144.3248483394837;665.6106177885991;777.6383981448654;780.4224873593613;796.3907610677836;796.7649543384715;4756.429228492603;4853.490383509751;4872.8781780455065;4898.926516102261;4956.281339205795;384.7172328338669;389.9493065901415;391.2292783217058;394.91706741584017;399.8120883184898;3186.028261380255;3229.4187046331417;3241.222106694376;3253.3818574470774;3350.27968986669;8887.422317549339;9283.303752218475;9346.626134954662;9365.672201472917;9391.154796068387;8665.090165532529;9083.636654533877;9084.772880677903;9285.535723213812;9346.252299815998;7013.509054366247;7149.89275160873;7158.033665455201;7164.570125792469;7168.53404528704;5160.380754309507;5315.760790764348;5363.946360536344;5486.423925487767;5501;8258.545779982158;8772.078931712334;8784.121587841164;8820.514871682119;8843.204111629726;8739.224511420389;8788.340874434316;8817.25053370445;8829.205371516595;9020.639174433212;6040.2147720797775;6572.901406478811;6599.637019963948;6791.762288319885;6801.421879140328;7442.62786860644;7482.476226664081;7506.512076714996;7522;7549.471536992358;6638.867222655424;6775.525713200029;6785.084013658093;6902.137232845895;6914.654267286515;6485.708143133476;6551.312112228147;6563.113979612691;6565.868682626226;6707.631080290631;5951.940480595312;5983.640981541122;5986.55100867428;5988.131720900532;6035.517158627387;4158.334666453353;4285.400043993781;4328.329108988112;4335.393044973644;4361.847335343247;4318.762468064161;4374.365716971085;4377.802998864995;4474.284114541658;4553.9089218214785 04:33:12 INFO - PROCESS | 23462 | |4;prototype.html;279.9195106887414;290.5467470745637;296.9554566814978;297.7662534910096;302.09221290023476;5091.770870310836;5125.5643270322025;5141.254518094874;5145.768440420181;5165.741712914358;4950.480199579047;4968.1554135797005;5005.674631148972;5017.473165317635;5018.397792264934;3932.6067393260732;3934.5835499220257;3937.1535119949203;3951.960480395188;3980.263651224518;3519.8064106474135;3831.0230891122724;3960.811756473061;3982.721209515335;3985.5217373915025;3766.717496187783;3849.615038496156;3850.0557218604567;3851.133494963625;3863.8840834775;3849.826757795906;3856.633619806142;3862.2854771867014;3864.439656249856;3874.7093967952233;3410.7782994105305;3414.3171365726953;3436.621971583124;3441.2601290722364;3444.621091679913;4732.645051621108;4896.534829191221;4904.852854414337;4920;4938.753062346868;4486.416765820455;4502.7973741181395;4539.479274443065;4542.954570454286;4543.5002149763495;4990.82532111378;5254.605904557174;5267.367915850123;5268.971445993282;5283.9471605284225;3665.450182472624;3748.744170702818;3751;3755.6244375562496;3764.0778009387877;5456.290682211326;5461.126219804852;5504.669719816784;5517.917231241495;5561.416051314634;3885.611438856092;3905.804709764557;3915.8237879295502;3921.313770090223;3935.4293627423863;3855.9588910994435;3932.4297976793778;3933.0364060804714;3941.4481972523868;3942.6003768662285;4454.732716037048;4463.460106263334;4483.19302525542;4485.775711214426;4499.6400287976885;5263.26314315996;5271.710055946883;5277.944411117792;5290.180022096504;5300.814471493479;1320.0627554436267;1355.6475316417802;1359.327133069137;1360.3810266328796;1375.2259585135064;853.2406158518924;869.7303835810792;883.5008220355479;888.395890794266;890.5057692980329;4123.628873401408;4167.604077612622;4189.282394218356;4192.224438478891;4213.220554197422;4768.690035147704;4791.388693162235;4792.100779028707;4876.463589005207;4918.409790825124;4167.874963751093;4185.916281674349;4220.198162349206;4247.173715302388;4253.404523366731;2615.3069436599317;2657.774089202401;2891.956620650692;2908.185708001763;2942.764578833688;5187.792488300502;5194.870128246748;5204.557612602971;5205.55752761012;5208.869778255574;5397.568194544427;5623.297087864017;5654.717264136859;5663.971680141655;5665.348484924287;5078.314427552307;5130.769115389817;5188.662736922088;5202.791888324425;5217.8173763918085;5267.841964741064;5330.946690533045;5498.422665620053;5535.667859928417;5557.693941923564;5261.868453288698;5285.286486324297;5347.893042139213;5349.491798279158;5370.2213179089595;5128.435872053997;5129.410117836496;5165.483451654804;5200.2199670049795;5206.817761378486;3493.5633045869267;3693.316736403774;3709.7959612220507;3710.7959062251834;3759.3233218019923;5448.237246785374;5453.972730136483;5461.5357694596405;5464.2076898848645;5486.177073439016;5305.434896705404;5321.787128514816;5327.147656374961;5339.893202136013;5361.731913404236;5137.614678899172;5160.741962901915;5253.185756207794;5263.815766448156;5305.249267741713;5134.281200631989;5156.458571849902;5159.845204643867;5190.870228244173;5226.634135610623;5184.096905732802;5312.831177141023;5338.772082420987;5355.196720491957;5361.597880158925;5112.185174263083;5172.922406163835;5176.7152806594495;5196.298499702491;5220.660657057279 04:33:12 INFO - PROCESS | 23462 | |5;yui.html;621.2593362022061;671.3085521912432;678.3115138134795;727.3926271563241;739.9160230262664;12481.188722733028;12656.177348472344;12668.049896257771;12762.872371276284;14748.483803066869;14518.782218266735;14788.334524946376;15494.767578486304;15498.845011549882;15537.689246215068;626.4487251218922;778.4356341652285;785.512981951191;791.76247125862;795.4431897671624;782.909965353983;786.4691333349995;789.3685051958439;796.8725003999361;796.8764841449556;829.4525613095358;831.2850948184587;834.0950069174952;835.4527784301262;839.6809212499242;823.9052508961427;824.08938123374;824.1387749801441;824.686619084747;827.4828232354809;605.4218221598363;605.6729366142278;608.1334098909036;609.0346800321452;612.834534675635;12099;12178.512859485698;12209.755804883942;12250.203736757083;12326.753464930742;13519.188848669111;13739.106958047794;14028.158310501403;14442.638934026734;14506.202158881257;10783.730406739816;10826.24216304859;10869.565217391295;10907.727306817314;10913.072388846958;3352.5474061001696;3368.242145517239;3446.8965931022108;3468.0982944434627;3472.392331342005;61786;62232.68883655598;63064;63345.366546334866;63658.68170659117;10586.417747023988;10696;10781.460926953778;10870.891291087146;11173;19964.50088747793;20041.899790500953;20181.39455816328;20223.898880505505;20520.179192832416;7000.92999070013;7015.543989640657;7078.92921070793;7110.075690160246;7225.385842203472;3748.3253014457114;3758.3986562149926;3825.3688141456905;3827.27281816454;3827.8086095695103;2950.4836653585535;3018.2907016851022;3070.677578854188;3074.6310442747013;3082.9537556936666;481.5016457966058;500.3445486412811;504.1152776876558;511.73645572530177;512.3288492075393;544.3848451250062;552.2710022769905;570.9286339207599;592.733270028489;593.6260156101629;7776.144624091346;7811.843763124706;7816.6091695415;7859.253370929752;7918.326942209861;461.76938459007044;479.7361451201825;541.1990254423475;544.8392724146387;569.7863301262026;3548.716102711777;3644.1982763791925;3757.887263382103;3801.2207497462955;3925.6270654287796;54522;54614;54722.17916731252;88793.55603221942;93772.53113734524;62201.68899155566;76470.47059058788;76836.61581692056;78191;78246;73002;74896.25103748892;75847;75897.24102759012;76154;7326.413886889142;7345.192028876712;7348.706051758084;7435.8141046474275;7520.661570229462;42065.57934420617;42394;43621.56378436302;43798.78100609604;43897.12205755931;62265.37734622777;66062.66968665126;66128;66176.33823661895;66209.33790662032;8480.703175388831;8680.088590698138;8788.956055219938;8875.28997680171;8963.641454342014;11049.668509944715;11321.830172547583;11449.42752862337;11485.540578376771;11511.712207194887;11246.550137994716;11270.774584508099;11467.713307167387;11571.247868888495;12335.876641233473;10971.780564388508;11380.715482113013;11489.655310340702;11538.942305288756;11897.643070707893;10950.890491094988;10987.945060274647;11054.557817687202;11058.612948546763;11467.827982580435;10062.245331600305;10608.257421980696;10689.51897164645;10829.24195306321;10855.945720271347;10098.646547370807;10318;10384.740381490523;10497.580096796042;10596.841047384141 04:33:12 INFO - PROCESS | 23462 | __end_tp_report 04:33:12 INFO - PROCESS | 23462 | __start_cc_report 04:33:12 INFO - PROCESS | 23462 | _x_x_mozilla_cycle_collect,379 04:33:12 INFO - PROCESS | 23462 | __end_cc_report 04:33:12 INFO - PROCESS | 23462 | __startTimestamp1466508792602__endTimestamp 04:33:12 INFO - PROCESS | 23462 | 04:33:12 INFO - PROCESS | 23462 | ------- Summary: start ------- 04:33:12 INFO - PROCESS | 23462 | Number of tests: 6 04:33:12 INFO - PROCESS | 23462 | 04:33:12 INFO - PROCESS | 23462 | [#0] dojo.html Cycles:165 Average:4728.92 Median:4934.38 stddev:614.33 (12.4%) stddev-sans-first:593.21 04:33:12 INFO - PROCESS | 23462 | Values: 2606.2 2669.5 2673.9 2681.8 2698.6 4667.9 4686.1 4744.7 4774.8 4810.4 4658.4 4674.1 4684.3 4705.1 4743.5 4272.8 4362.8 4425.8 4448.5 4450.3 616.8 4267.2 4313.0 4353.8 4412.1 4344.0 4350.5 4377.9 4383.0 4432.8 4358.9 4365.7 4377.1 4400.3 4427.4 4232.0 4258.7 4266.2 4332.5 4348.9 4728.5 4797.5 4803.1 4807.2 4824.8 5075.3 5158.4 5184.9 5220.5 5256.0 5167.0 5234.8 5236.6 5240.6 5267.8 4854.7 4866.9 4875.0 4880.1 4889.3 5151.3 5226.8 5286.4 5350.3 5351.7 5041.6 5060.0 5082.6 5108.7 5124.9 5141.3 5176.2 5181.4 5183.2 5231.3 4982.9 5016.2 5042.5 5069.0 5106.4 5069.0 5074.5 5074.7 5085.2 5130.7 4261.7 4267.5 4267.7 4269.1 4306.2 3704.4 3714.6 3747.6 3752.7 3761.4 4392.7 4427.4 4481.7 4482.6 4524.9 5213.9 5225.5 5225.6 5225.8 5276.2 4379.9 4427.6 4490.1 4499.3 4533.4 4569.7 4570.6 4572.3 4607.6 4614.4 4866.6 4907.6 4921.6 4923.9 4970.7 5037.1 5171.2 5218.0 5226.8 5255.0 4934.4 4935.2 4940.2 4951.6 5006.0 5002.5 5141.8 5144.7 5146.9 5148.7 5155.4 5171.9 5198.7 5200.7 5211.5 5035.0 5049.5 5062.7 5080.3 5110.5 4910.9 4916.8 5032.0 5036.0 5051.0 4909.2 4940.3 4962.1 4977.4 4994.5 5037.4 5084.5 5087.3 5095.8 5146.4 4905.8 4940.8 4978.5 4981.1 4988.0 04:33:12 INFO - PROCESS | 23462 | 04:33:12 INFO - PROCESS | 23462 | [#1] ext.html Cycles:180 Average:53862.92 Median:194323.32 stddev:117728.82 (60.6%) stddev-sans-first:117991.00 04:33:12 INFO - PROCESS | 23462 | Values: 537.5 561.6 584.3 598.4 608.5 34103.0 38868.6 39053.2 39107.2 39124.6 39130.4 39382.4 39805.8 39819.0 39913.2 7690.6 7758.1 7763.3 7776.5 7777.8 7870.3 7893.8 7941.6 7982.5 7986.3 7873.0 7931.8 7958.5 7959.9 8013.2 7858.0 7882.3 7900.2 7907.4 7913.7 7780.1 7916.2 7936.8 7940.7 7960.4 29330.3 36811.4 37148.0 37201.8 37205.0 2974.8 3030.6 3156.4 3162.6 3474.7 27027.0 30077.8 30095.8 30187.8 30449.7 3052.3 3089.3 3097.3 3118.0 3126.7 242613.0 245295.0 246396.0 248358.0 248663.0 55393.0 56094.2 56133.4 56287.0 56364.0 33569.7 34120.0 34388.5 36270.8 36612.0 13620.7 13829.8 13833.6 13865.7 13904.6 10059.5 10080.8 10098.2 10237.2 10237.7 19201.0 19352.2 19414.6 19427.9 19624.8 7272.3 7353.2 7376.7 7612.4 7695.3 804.7 896.6 904.3 969.4 997.3 26867.0 28033.7 28203.2 28221.3 28413.0 921.3 933.2 943.7 958.4 974.3 14002.3 14267.0 14311.6 14618.4 14644.7 397712.0 658834.0 672563.0 675587.0 675782.0 50665.7 51159.5 51368.7 51601.0 51802.0 1185.5 1194.3 1197.3 1201.4 1207.1 26936.7 27442.0 28164.7 28454.6 28570.3 41406.9 42033.0 42055.0 42094.0 42192.6 347867.0 351152.2 353358.0 353682.0 355481.0 25264.1 25547.1 25598.9 25604.0 25707.9 40647.6 41250.2 41367.0 41929.4 42241.8 34923.1 34944.7 34971.8 35202.6 35429.6 31695.0 34987.8 35061.6 35242.0 35288.6 30324.7 34286.3 34444.8 34582.5 34950.3 30757.8 31667.5 31833.2 31957.7 32042.7 24731.3 24976.6 24999.3 25054.2 25131.2 04:33:12 INFO - PROCESS | 23462 | 04:33:12 INFO - PROCESS | 23462 | [#2] jquery.html Cycles:180 Average:24216.23 Median:4498.51 stddev:66224.61 (1472.1%) stddev-sans-first:66386.18 04:33:12 INFO - PROCESS | 23462 | Values: 366.5 366.5 366.5 383.5 385.5 15401.0 16213.8 16581.4 17054.8 17072.7 15617.5 15923.7 16690.2 16725.2 16754.7 4932.7 5105.2 5119.0 5126.7 5155.4 5052.5 5081.0 5114.2 5114.5 5134.6 5005.6 5033.3 5061.7 5070.0 5083.0 4875.6 4933.7 5013.3 5032.6 5059.1 4382.3 4477.2 4496.6 4498.4 4498.6 20069.2 20107.9 20454.8 20611.3 20674.6 2032.9 2155.6 2291.0 2342.7 2508.3 12850.7 13115.6 13199.4 13295.2 13486.3 1713.9 1805.7 1828.8 1844.1 1849.5 62106.7 63616.7 63790.7 64650.7 65413.7 9277.6 9482.2 9704.4 9972.0 10369.3 12786.4 12863.1 12905.2 12921.9 12933.9 6913.9 6915.4 6921.2 7089.7 7157.6 6688.7 6692.6 6750.8 6788.5 6839.0 5960.4 5961.0 6129.9 6157.7 6224.3 1735.2 1793.1 1802.0 1815.8 1825.2 817.6 854.3 860.3 899.4 926.3 16799.5 16839.2 17124.1 17278.6 17311.6 829.6 855.6 863.0 875.4 884.5 6940.4 9364.7 9892.5 10024.1 10103.3 395230.0 400358.0 403656.0 406110.0 409635.0 50973.0 61637.4 76639.6 77535.6 81960.0 927.0 941.0 957.4 963.8 970.7 15552.2 15662.2 15802.2 15831.1 16122.4 25982.9 27380.5 27719.4 34136.8 39644.0 50447.7 51098.5 51379.0 52086.7 52414.7 7447.4 7539.4 7582.7 7627.7 7980.8 11284.5 11744.5 11779.9 11904.3 12163.1 9772.9 9814.0 9841.0 10000.1 10086.9 10605.2 10738.0 10825.1 10847.9 10891.6 9795.3 9849.0 9989.4 10221.9 10248.0 6840.6 7136.0 7417.5 7671.8 7709.2 10280.9 10461.6 10653.6 10718.0 10797.5 04:33:12 INFO - PROCESS | 23462 | 04:33:12 INFO - PROCESS | 23462 | [#3] mootools.html Cycles:180 Average:4984.59 Median:4804.96 stddev:2809.34 (58.5%) stddev-sans-first:2804.12 04:33:12 INFO - PROCESS | 23462 | Values: 1374.6 1422.9 1482.3 1625.8 1680.7 6658.0 7408.3 7409.0 7898.2 7907.7 7486.6 7566.5 7743.2 7759.1 7764.4 2145.3 2179.1 2179.8 2180.7 2190.4 2139.3 2145.6 2208.2 2211.1 2212.4 2167.4 2170.3 2181.7 2182.1 2221.2 2077.4 2081.4 2092.4 2095.2 2111.3 2075.9 2122.8 2141.3 2145.0 2145.2 7561.7 7572.0 7587.0 7661.4 7689.5 4409.9 4494.6 4509.4 4544.3 4552.2 2740.8 2817.5 2895.2 2908.1 2908.6 807.1 843.7 843.7 849.7 852.8 10155.2 10246.5 10250.8 10305.9 10348.7 3975.0 3997.7 4089.9 4100.4 4145.0 8737.8 8760.6 8763.8 8771.0 8783.9 4551.6 4559.3 4563.9 4568.4 4569.3 3606.0 4096.6 4145.5 4239.2 4249.4 3492.7 3519.8 3589.4 3627.0 3722.6 1118.1 1128.2 1139.4 1141.7 1144.3 665.6 777.6 780.4 796.4 796.8 4756.4 4853.5 4872.9 4898.9 4956.3 384.7 389.9 391.2 394.9 399.8 3186.0 3229.4 3241.2 3253.4 3350.3 8887.4 9283.3 9346.6 9365.7 9391.2 8665.1 9083.6 9084.8 9285.5 9346.3 7013.5 7149.9 7158.0 7164.6 7168.5 5160.4 5315.8 5363.9 5486.4 5501.0 8258.5 8772.1 8784.1 8820.5 8843.2 8739.2 8788.3 8817.3 8829.2 9020.6 6040.2 6572.9 6599.6 6791.8 6801.4 7442.6 7482.5 7506.5 7522.0 7549.5 6638.9 6775.5 6785.1 6902.1 6914.7 6485.7 6551.3 6563.1 6565.9 6707.6 5951.9 5983.6 5986.6 5988.1 6035.5 4158.3 4285.4 4328.3 4335.4 4361.8 4318.8 4374.4 4377.8 4474.3 4553.9 04:33:12 INFO - PROCESS | 23462 | 04:33:12 INFO - PROCESS | 23462 | [#4] prototype.html Cycles:180 Average:4341.49 Median:4959.32 stddev:1278.73 (25.8%) stddev-sans-first:1245.45 04:33:12 INFO - PROCESS | 23462 | Values: 279.9 290.5 297.0 297.8 302.1 5091.8 5125.6 5141.3 5145.8 5165.7 4950.5 4968.2 5005.7 5017.5 5018.4 3932.6 3934.6 3937.2 3952.0 3980.3 3519.8 3831.0 3960.8 3982.7 3985.5 3766.7 3849.6 3850.1 3851.1 3863.9 3849.8 3856.6 3862.3 3864.4 3874.7 3410.8 3414.3 3436.6 3441.3 3444.6 4732.6 4896.5 4904.9 4920.0 4938.8 4486.4 4502.8 4539.5 4543.0 4543.5 4990.8 5254.6 5267.4 5269.0 5283.9 3665.5 3748.7 3751.0 3755.6 3764.1 5456.3 5461.1 5504.7 5517.9 5561.4 3885.6 3905.8 3915.8 3921.3 3935.4 3856.0 3932.4 3933.0 3941.4 3942.6 4454.7 4463.5 4483.2 4485.8 4499.6 5263.3 5271.7 5277.9 5290.2 5300.8 1320.1 1355.6 1359.3 1360.4 1375.2 853.2 869.7 883.5 888.4 890.5 4123.6 4167.6 4189.3 4192.2 4213.2 4768.7 4791.4 4792.1 4876.5 4918.4 4167.9 4185.9 4220.2 4247.2 4253.4 2615.3 2657.8 2892.0 2908.2 2942.8 5187.8 5194.9 5204.6 5205.6 5208.9 5397.6 5623.3 5654.7 5664.0 5665.3 5078.3 5130.8 5188.7 5202.8 5217.8 5267.8 5330.9 5498.4 5535.7 5557.7 5261.9 5285.3 5347.9 5349.5 5370.2 5128.4 5129.4 5165.5 5200.2 5206.8 3493.6 3693.3 3709.8 3710.8 3759.3 5448.2 5454.0 5461.5 5464.2 5486.2 5305.4 5321.8 5327.1 5339.9 5361.7 5137.6 5160.7 5253.2 5263.8 5305.2 5134.3 5156.5 5159.8 5190.9 5226.6 5184.1 5312.8 5338.8 5355.2 5361.6 5112.2 5172.9 5176.7 5196.3 5220.7 04:33:12 INFO - PROCESS | 23462 | 04:33:12 INFO - PROCESS | 23462 | [#5] yui.html Cycles:180 Average:16782.95 Median:470.75 stddev:22865.89 (4857.3%) stddev-sans-first:22897.83 04:33:12 INFO - PROCESS | 23462 | Values: 621.3 671.3 678.3 727.4 739.9 12481.2 12656.2 12668.0 12762.9 14748.5 14518.8 14788.3 15494.8 15498.8 15537.7 626.4 778.4 785.5 791.8 795.4 782.9 786.5 789.4 796.9 796.9 829.5 831.3 834.1 835.5 839.7 823.9 824.1 824.1 824.7 827.5 605.4 605.7 608.1 609.0 612.8 12099.0 12178.5 12209.8 12250.2 12326.8 13519.2 13739.1 14028.2 14442.6 14506.2 10783.7 10826.2 10869.6 10907.7 10913.1 3352.5 3368.2 3446.9 3468.1 3472.4 61786.0 62232.7 63064.0 63345.4 63658.7 10586.4 10696.0 10781.5 10870.9 11173.0 19964.5 20041.9 20181.4 20223.9 20520.2 7000.9 7015.5 7078.9 7110.1 7225.4 3748.3 3758.4 3825.4 3827.3 3827.8 2950.5 3018.3 3070.7 3074.6 3083.0 481.5 500.3 504.1 511.7 512.3 544.4 552.3 570.9 592.7 593.6 7776.1 7811.8 7816.6 7859.3 7918.3 461.8 479.7 541.2 544.8 569.8 3548.7 3644.2 3757.9 3801.2 3925.6 54522.0 54614.0 54722.2 88793.6 93772.5 62201.7 76470.5 76836.6 78191.0 78246.0 73002.0 74896.3 75847.0 75897.2 76154.0 7326.4 7345.2 7348.7 7435.8 7520.7 42065.6 42394.0 43621.6 43798.8 43897.1 62265.4 66062.7 66128.0 66176.3 66209.3 8480.7 8680.1 8789.0 8875.3 8963.6 11049.7 11321.8 11449.4 11485.5 11511.7 11246.6 11270.8 11467.7 11571.2 12335.9 10971.8 11380.7 11489.7 11538.9 11897.6 10950.9 10987.9 11054.6 11058.6 11467.8 10062.2 10608.3 10689.5 10829.2 10855.9 10098.6 10318.0 10384.7 10497.6 10596.8 04:33:12 INFO - PROCESS | 23462 | -------- Summary: end -------- 04:33:12 INFO - PROCESS | 23462 | 04:33:13 INFO - TEST-INFO | 23462: exit 0 04:33:13 INFO - TEST-OK | dromaeo_css | took 1117168ms 04:33:13 INFO - TEST-START | kraken 04:33:13 INFO - operating with platform_type : linux_ 04:33:13 INFO - Initialising browser for kraken test... 04:33:13 INFO - TEST-INFO | started process 23699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvn9UpZ/profile http://localhost:55013/getInfo.html) 04:33:18 INFO - PROCESS | 23699 | __metrics Screen width/height:1600/1200 04:33:18 INFO - PROCESS | 23699 | colorDepth:24 04:33:18 INFO - PROCESS | 23699 | Browser inner width/height: 1024/697 04:33:18 INFO - PROCESS | 23699 | __metrics 04:33:19 ERROR - PROCESS | 23699 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:33:20 INFO - TEST-INFO | 23699: exit 0 04:33:20 INFO - Browser initialized. 04:33:20 INFO - Running cycle 1/1 for kraken test... 04:33:20 INFO - TEST-INFO | started process 23819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvn9UpZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:32 INFO - PROCESS | 23819 | RSS: Main: 186646528 04:33:32 INFO - PROCESS | 23819 | 04:33:35 INFO - PROCESS | 23819 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55013/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:36 INFO - PROCESS | 23819 | RSS: Main: 191045632 04:33:36 INFO - PROCESS | 23819 | 04:33:38 INFO - PROCESS | 23819 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55013/tests/kraken/driver.html?testName=audio-dft) 04:33:39 INFO - PROCESS | 23819 | RSS: Main: 190406656 04:33:39 INFO - PROCESS | 23819 | 04:33:42 INFO - PROCESS | 23819 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55013/tests/kraken/driver.html?testName=audio-fft) 04:33:43 INFO - PROCESS | 23819 | RSS: Main: 186572800 04:33:43 INFO - PROCESS | 23819 | 04:33:45 INFO - PROCESS | 23819 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55013/tests/kraken/driver.html?testName=audio-oscillator) 04:33:45 INFO - PROCESS | 23819 | RSS: Main: 187248640 04:33:45 INFO - PROCESS | 23819 | 04:33:48 INFO - PROCESS | 23819 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55013/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:48 INFO - PROCESS | 23819 | RSS: Main: 187412480 04:33:48 INFO - PROCESS | 23819 | 04:33:52 INFO - PROCESS | 23819 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55013/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:52 INFO - PROCESS | 23819 | RSS: Main: 188129280 04:33:52 INFO - PROCESS | 23819 | 04:33:56 INFO - PROCESS | 23819 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55013/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:56 INFO - PROCESS | 23819 | RSS: Main: 185028608 04:33:56 INFO - PROCESS | 23819 | 04:33:59 INFO - PROCESS | 23819 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55013/tests/kraken/driver.html?testName=json-parse-financial) 04:34:00 INFO - PROCESS | 23819 | RSS: Main: 186572800 04:34:00 INFO - PROCESS | 23819 | 04:34:02 INFO - PROCESS | 23819 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55013/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:34:02 INFO - PROCESS | 23819 | RSS: Main: 186798080 04:34:02 INFO - PROCESS | 23819 | 04:34:04 INFO - PROCESS | 23819 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:34:05 INFO - PROCESS | 23819 | RSS: Main: 186560512 04:34:05 INFO - PROCESS | 23819 | 04:34:07 INFO - PROCESS | 23819 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:08 INFO - PROCESS | 23819 | RSS: Main: 186814464 04:34:08 INFO - PROCESS | 23819 | 04:34:11 INFO - PROCESS | 23819 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:11 INFO - PROCESS | 23819 | RSS: Main: 187285504 04:34:11 INFO - PROCESS | 23819 | 04:34:14 INFO - PROCESS | 23819 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:15 INFO - PROCESS | 23819 | RSS: Main: 187117568 04:34:15 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55013/tests/kraken/driver.html?testName=ai-astar) 04:34:17 INFO - PROCESS | 23819 | RSS: Main: 187936768 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | __start_tp_report 04:34:17 INFO - PROCESS | 23819 | _x_x_mozilla_page_load 04:34:17 INFO - PROCESS | 23819 | _x_x_mozilla_page_load_details 04:34:17 INFO - PROCESS | 23819 | |i|pagename|runs| 04:34:17 INFO - PROCESS | 23819 | |0;ai-astar;115;109;113;117;116;114;112;113;113;112 04:34:17 INFO - PROCESS | 23819 | |1;audio-beat-detection;161;137;169;188;132;162;161;138;201;134 04:34:17 INFO - PROCESS | 23819 | |2;audio-dft;164;167;172;163;163;167;161;162;161;161 04:34:17 INFO - PROCESS | 23819 | |3;audio-fft;76;77;76;175;77;77;76;75;163;76 04:34:17 INFO - PROCESS | 23819 | |4;audio-oscillator;87;85;143;86;87;86;139;87;87;145 04:34:17 INFO - PROCESS | 23819 | |5;imaging-gaussian-blur;117;118;118;119;118;118;117;119;118;119 04:34:17 INFO - PROCESS | 23819 | |6;imaging-darkroom;148;148;147;147;146;147;147;148;148;147 04:34:17 INFO - PROCESS | 23819 | |7;imaging-desaturate;95;96;95;96;95;96;95;95;97;95 04:34:17 INFO - PROCESS | 23819 | |8;json-parse-financial;65;63;65;64;64;65;66;65;64;65 04:34:17 INFO - PROCESS | 23819 | |9;json-stringify-tinderbox;66;65;66;66;66;66;65;65;66;66 04:34:17 INFO - PROCESS | 23819 | |10;stanford-crypto-aes;84;83;85;85;89;85;86;85;106;83 04:34:17 INFO - PROCESS | 23819 | |11;stanford-crypto-ccm;144;131;138;140;131;135;144;144;136;136 04:34:17 INFO - PROCESS | 23819 | |12;stanford-crypto-pbkdf2;172;174;169;175;170;173;181;170;172;181 04:34:17 INFO - PROCESS | 23819 | |13;stanford-crypto-sha256-iterative;73;69;70;67;67;68;68;70;67;67 04:34:17 INFO - PROCESS | 23819 | __end_tp_report 04:34:17 INFO - PROCESS | 23819 | __start_cc_report 04:34:17 INFO - PROCESS | 23819 | _x_x_mozilla_cycle_collect,977 04:34:17 INFO - PROCESS | 23819 | __end_cc_report 04:34:17 INFO - PROCESS | 23819 | __startTimestamp1466508857336__endTimestamp 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | ------- Summary: start ------- 04:34:17 INFO - PROCESS | 23819 | Number of tests: 14 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.50 stddev:2.27 (2.0%) stddev-sans-first:2.33 04:34:17 INFO - PROCESS | 23819 | Values: 115.0 109.0 113.0 117.0 116.0 114.0 112.0 113.0 113.0 112.0 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | [#1] audio-beat-detection Cycles:10 Average:158.30 Median:161.50 stddev:23.56 (14.6%) stddev-sans-first:24.97 04:34:17 INFO - PROCESS | 23819 | Values: 161.0 137.0 169.0 188.0 132.0 162.0 161.0 138.0 201.0 134.0 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:3.57 (2.2%) stddev-sans-first:3.79 04:34:17 INFO - PROCESS | 23819 | Values: 164.0 167.0 172.0 163.0 163.0 167.0 161.0 162.0 161.0 161.0 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:39.21 (51.6%) stddev-sans-first:41.00 04:34:17 INFO - PROCESS | 23819 | Values: 76.0 77.0 76.0 175.0 77.0 77.0 76.0 75.0 163.0 76.0 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:86.50 stddev:27.05 (31.3%) stddev-sans-first:28.05 04:34:17 INFO - PROCESS | 23819 | Values: 87.0 85.0 143.0 86.0 87.0 86.0 139.0 87.0 87.0 145.0 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 04:34:17 INFO - PROCESS | 23819 | Values: 117.0 118.0 118.0 119.0 118.0 118.0 117.0 119.0 118.0 119.0 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 04:34:17 INFO - PROCESS | 23819 | Values: 148.0 148.0 147.0 147.0 146.0 147.0 147.0 148.0 148.0 147.0 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 04:34:17 INFO - PROCESS | 23819 | Values: 95.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 97.0 95.0 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 04:34:17 INFO - PROCESS | 23819 | Values: 65.0 63.0 65.0 64.0 64.0 65.0 66.0 65.0 64.0 65.0 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 04:34:17 INFO - PROCESS | 23819 | Values: 66.0 65.0 66.0 66.0 66.0 66.0 65.0 65.0 66.0 66.0 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:85.00 stddev:6.85 (8.1%) stddev-sans-first:7.18 04:34:17 INFO - PROCESS | 23819 | Values: 84.0 83.0 85.0 85.0 89.0 85.0 86.0 85.0 106.0 83.0 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:139.00 stddev:5.02 (3.6%) stddev-sans-first:4.82 04:34:17 INFO - PROCESS | 23819 | Values: 144.0 131.0 138.0 140.0 131.0 135.0 144.0 144.0 136.0 136.0 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:173.50 stddev:4.27 (2.5%) stddev-sans-first:4.48 04:34:17 INFO - PROCESS | 23819 | Values: 172.0 174.0 169.0 175.0 170.0 173.0 181.0 170.0 172.0 181.0 04:34:17 INFO - PROCESS | 23819 | 04:34:17 INFO - PROCESS | 23819 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.96 (2.9%) stddev-sans-first:1.27 04:34:17 INFO - PROCESS | 23819 | Values: 73.0 69.0 70.0 67.0 67.0 68.0 68.0 70.0 67.0 67.0 04:34:17 INFO - PROCESS | 23819 | -------- Summary: end -------- 04:34:17 INFO - PROCESS | 23819 | 04:34:18 INFO - TEST-INFO | 23819: exit 0 04:34:18 INFO - TEST-OK | kraken | took 64999ms 04:34:18 INFO - SUITE-END | took 1182s 04:34:18 INFO - Completed test suite (00:19:42) 04:34:18 INFO - javascript benchmark 04:34:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6373.482327210147, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2606.1660268714013, 2669.5061413638477, 2673.8796754146074, 2681.785457163427, 2698.6221928929967, 4667.906641867165, 4686.133065382906, 4744.739039352834, 4774.7851346689395, 4810.39870016248, 4658.417697787777, 4674.088552732219, 4684.320773487851, 4705.129551033061, 4743.549362810528, 4272.82908683653, 4362.781860906958, 4425.800838962255, 4448.466184057917, 4450.287953927373, 616.7617555785855, 4267.167902259061, 4312.97843510782, 4353.760543170124, 4412.073464572443, 4343.956560434387, 4350.456192975878, 4377.890552736175, 4383.0357321389565, 4432.800523976396, 4358.934615980731, 4365.716228445141, 4377.102693947765, 4400.339949007643, 4427.40230068943, 4232.026633874226, 4258.744475331459, 4266.168097221043, 4332.458442694663, 4348.934765978513, 4728.527147285278, 4797.472278049412, 4803.063402636487, 4807.158747219222, 4824.7828847701585, 5075.289459475676, 5158.3552055993005, 5184.922934233537, 5220.504052115043, 5256.027634887558, 5166.974165129188, 5234.764435600369, 5236.554892834076, 5240.554552863011, 5267.762950667191, 4854.689233906861, 4866.908801432886, 4874.975625121851, 4880.145974454456, 4889.2910527973245, 5151.304573882478, 5226.790928362823, 5286.444923283077, 5350.250964864922, 5351.652142610717, 5041.59667226621, 5059.962707644998, 5082.593392528589, 5108.744562771921, 5124.897502050013, 5141.2545180948555, 5176.223566464985, 5181.35233095863, 5183.248428977852, 5231.267622532849, 4982.8754281143265, 5016.197408414636, 5042.4957504250015, 5069.03688299222, 5106.361704786902, 5069.011542749128, 5074.467180945948, 5074.67014644047, 5085.160948443539, 5130.666506677054, 4261.722988005769, 4267.466566679165, 4267.722598031118, 4269.082147338338, 4306.160298741778, 3704.351738445815, 3714.6285371462636, 3747.643973822537, 3752.7185461090526, 3761.4169803680475, 4392.714473559208, 4427.424434823517, 4481.663875209372, 4482.618977386958, 4524.886877828015, 5213.895722085537, 5225.451327610622, 5225.634205605571, 5225.817096401684, 5276.234945932895, 4379.948812285029, 4427.623651989553, 4490.079533695584, 4499.302608095751, 4533.38799262102, 4569.702969306984, 4570.588647021784, 4572.291294849304, 4607.562281583244, 4614.377059097046, 4866.562009419169, 4907.55831975124, 4921.581665558325, 4923.852284431473, 4970.701757894538, 5037.118504261813, 5171.224316352577, 5218.008578370098, 5226.817061402832, 5254.97372513135, 4934.383202099738, 4935.235038569028, 4940.160172770566, 4951.579115775199, 5006.023825354021, 5002.474740152232, 5141.7686204120155, 5144.6913185209005, 5146.871328216825, 5148.742562871917, 5155.381354237516, 5171.92242116361, 5198.74006299676, 5200.6879587224885, 5211.530962213419, 5035.0, 5049.495050495068, 5062.696238225718, 5080.314157588678, 5110.48895110486, 4910.852674419773, 4916.827911023097, 5032.0, 5036.0, 5051.0, 4909.1654418748185, 4940.308356830118, 4962.106820772296, 4977.377827771528, 4994.475580064186, 5037.420696619935, 5084.542391184811, 5087.3386459759995, 5095.847124586268, 5146.382434107931, 4905.828296009622, 4940.827071052496, 4978.502149784992, 4981.053599816023, 4987.9750601248215], "value": 4689.70126448568, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.5289926113677, 561.6433564686425, 584.3163498706514, 598.3776872053065, 608.5466327585949, 34103.0, 38868.61131388685, 39053.218935621306, 39107.21785564287, 39124.60875391245, 39130.413043804365, 39382.40926386107, 39805.80097099511, 39819.0, 39913.20173596526, 7690.6154692265445, 7758.146603873598, 7763.340116090111, 7776.4945278557, 7777.766666999999, 7870.252326029046, 7893.763187104396, 7941.64262608184, 7982.521048737065, 7986.281234688877, 7873.0, 7931.762047138595, 7958.52248865067, 7959.880601790977, 8013.2387423195, 7857.960710196412, 7882.330001949841, 7900.209979002111, 7907.446478746519, 7913.723019694312, 7780.14418413974, 7916.247956444128, 7936.841263174704, 7940.682372705085, 7960.442769006172, 29330.266743331373, 36811.447828282595, 37148.0, 37201.81399092987, 37205.0, 2974.8363839988792, 3030.636323641177, 3156.368726254735, 3162.6362968258713, 3474.722022238215, 27027.0, 30077.849610752026, 30095.849520752257, 30187.849060754557, 30449.695503044906, 3052.2521982114304, 3089.3203495231237, 3097.334073174256, 3118.033409643018, 3126.718595326409, 242613.0, 245295.0, 246396.0, 248358.0, 248662.9999999982, 55393.0, 56094.15858762122, 56133.43866561364, 56287.0, 56364.0, 33569.66430335665, 34120.0, 34388.48417273743, 36270.81864590713, 36612.0, 13620.65948351299, 13829.79255311151, 13833.584992450242, 13865.653358665912, 13904.58286251414, 10059.497025148714, 10080.798384032278, 10098.242631802645, 10237.18102551794, 10237.692869213935, 19201.007916509516, 19352.225910963687, 19414.611707765765, 19427.902860485607, 19624.822510649406, 7272.345488906024, 7353.23522354631, 7376.7418140364825, 7612.429067819936, 7695.307422331905, 804.6781287485053, 896.6413434626202, 904.326276923696, 969.4328817641617, 997.2869398380193, 26867.0, 28033.71966280352, 28203.15390538287, 28221.294467638472, 28413.0, 921.3228277216241, 933.2300851797158, 943.6791490893129, 958.4057884111895, 974.3228456222857, 14002.299885005708, 14267.0, 14311.57065288043, 14618.415263389557, 14644.707105857824, 397712.0, 658834.0, 672563.0, 675587.0, 675782.0, 50665.746671267145, 51159.488405116215, 51368.74315628398, 51601.0, 51802.0, 1185.4902391971364, 1194.325206258461, 1197.2995797458584, 1201.3632774629461, 1207.106741011645, 26936.730632693423, 27441.980864387955, 28164.71835281621, 28454.57318140188, 28570.285742856595, 41406.894482913296, 42033.0, 42055.0, 42094.0, 42192.578074218865, 347867.0, 351152.1981510787, 353358.0, 353682.0, 355481.0, 25264.115755948453, 25547.105851295117, 25598.872005639852, 25604.0, 25707.87146064258, 40647.596661420335, 41250.1749965005, 41367.0, 41929.37105943352, 42241.78879105585, 34923.126921827155, 34944.65055349414, 34971.825140874134, 35202.64797351994, 35429.645703542636, 31695.0, 34987.82506087453, 35061.64938350686, 35242.0, 35288.647113529565, 30324.69675303219, 34286.31427371489, 34444.82777586096, 34582.48126278057, 34950.30099397947, 30757.846210768803, 31667.52498712475, 31833.204169895937, 31957.65503246407, 32042.679573203968, 24731.258062258163, 24976.625350620117, 24999.250022499353, 25054.248372548853, 25131.24606261815], "value": 17442.563089338633, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.4594722783894, 366.5210874122915, 366.53816191598594, 383.53975229724335, 385.458430904579, 15401.0, 16213.756793648105, 16581.41965031224, 17054.82945170551, 17072.743908841345, 15617.453389131382, 15923.681526369466, 16690.24893879775, 16725.16374181292, 16754.66490670186, 4932.704037757737, 5105.234214867763, 5118.974405127988, 5126.6923984561045, 5155.381354237496, 5052.469490703478, 5081.034603425356, 5114.207297868837, 5114.488551144893, 5134.563562097226, 5005.6496045276845, 5033.320501732256, 5061.670991385567, 5069.974650126745, 5083.0, 4875.58557522611, 4933.7286449245275, 5013.323201367805, 5032.6477146599755, 5059.11465493539, 4382.320740285261, 4477.194105061088, 4496.64026877849, 4498.415206023196, 4498.595126438636, 20069.1972321107, 20107.899460502606, 20454.795452045437, 20611.278605248743, 20674.58650826975, 2032.9186832526682, 2155.6227660159566, 2290.9541809163725, 2342.7422983471806, 2508.297676650541, 12850.742985140338, 13115.606531804062, 13199.40602672882, 13295.20228786276, 13486.325683715775, 1713.9143042847932, 1805.6749785038687, 1828.8445482134034, 1844.0687452836232, 1849.519125027489, 62106.68946655283, 63616.68191659058, 63790.68104659493, 64650.676746615965, 65413.67293163504, 9277.628894844265, 9482.241420686329, 9704.369216000938, 9971.950140249251, 10369.274150809522, 12786.424610892533, 12863.099583029098, 12905.225686458842, 12921.935390322988, 12933.870661293455, 6913.930860691429, 6915.4121899638085, 6921.204061532888, 7089.716411343488, 7157.642117894085, 6688.665566721645, 6692.59844409337, 6750.83122921921, 6788.524803263724, 6839.0425340452375, 5960.374160713062, 5960.970195148997, 6129.877402451926, 6157.7229024694, 6224.346443623445, 1735.2278236184777, 1793.0586442117992, 1801.9549511262062, 1815.8093400193054, 1825.1877914328263, 817.627979269431, 854.2994744309607, 860.2687715441824, 899.4333569850952, 926.3376685669779, 16799.50827782299, 16839.158042097846, 17124.058176800394, 17278.568035799206, 17311.56721081983, 829.5644786487143, 855.619249433996, 863.0334025890917, 875.4047247871508, 884.5046773806689, 6940.444764418834, 9364.672236471826, 9892.505374731234, 10024.097831195082, 10103.292769506212, 395230.0, 400358.0, 403656.0, 406110.0, 409635.0, 50973.0, 61637.38362616406, 76639.61680191675, 77535.61232193916, 81960.0, 926.990730092704, 940.9811803764023, 957.3729207369184, 963.7976025034822, 970.6602689058773, 15552.222388880284, 15662.216889155725, 15802.209889505708, 15831.129287889276, 16122.355105795637, 25982.870085650207, 27380.45239095247, 27719.445611087263, 34136.778570359456, 39644.0, 50447.74776126096, 51098.48901511086, 51379.0, 52086.73956630344, 52414.737926310125, 7447.404207663266, 7539.359154471931, 7582.658780355007, 7627.656755445907, 7980.840383192188, 11284.492197850952, 11744.530218791153, 11779.941100294443, 11904.345261010727, 12163.148579599698, 9772.85340719904, 9813.950930245303, 9840.950795245977, 10000.099991000845, 10086.949565252127, 10605.151587873106, 10738.033576978109, 10825.133989280996, 10847.891521085005, 10891.618793342195, 9795.265355098254, 9849.0, 9989.400635961865, 10221.897781022095, 10248.0, 6840.623765692934, 7136.0, 7417.48077634582, 7671.808204794925, 7709.151993280622, 10280.897191027994, 10461.633842815769, 10653.627123050655, 10718.0, 10797.514111865143], "value": 8205.569102352412, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.5738820965498, 1422.943082276709, 1482.2810936695707, 1625.8049034115909, 1680.6974744545985, 6657.966710166443, 7408.259174082603, 7409.0, 7898.170692077335, 7907.683692652294, 7486.588237646927, 7566.470347075693, 7743.225677432254, 7759.107702614201, 7764.417668674858, 2145.313499680099, 2179.1174574297434, 2179.7929196726286, 2180.6510958246686, 2190.37574291327, 2139.2619546256515, 2145.5601601671697, 2208.182972300243, 2211.060299372768, 2212.424769559918, 2167.4147980045377, 2170.316350349635, 2181.7163768710125, 2182.138055468089, 2221.244776775896, 2077.3767869639123, 2081.4484161697164, 2092.3618296419586, 2095.1514636572138, 2111.324376199617, 2075.8754474731563, 2122.8301735861096, 2141.314779270634, 2144.9571008579896, 2145.249162793026, 7561.659725312375, 7572.0, 7586.962065189638, 7661.387089032864, 7689.5001824881765, 4409.867703968886, 4494.640428765691, 4509.413776209105, 4544.295634176708, 4552.226121559343, 2740.821846579966, 2817.464681710489, 2895.174875160569, 2908.0839535546233, 2908.621879155696, 807.1242701668697, 843.6625349860044, 843.6625349860044, 849.6558893648082, 852.7782776478099, 10155.187584993182, 10246.48767561619, 10250.846237306447, 10305.896941030569, 10348.689539313833, 3975.0, 3997.6601988830694, 4089.9182016359505, 4100.425940368351, 4145.046639272984, 8737.781555461037, 8760.649574017096, 8763.780905477413, 8770.956145219361, 8783.91216087831, 4551.590356867898, 4559.293309537027, 4563.863084107482, 4568.383268258809, 4569.29175977724, 3605.963940360615, 4096.610821971908, 4145.54399016108, 4239.194553034913, 4249.447571815645, 3492.650734926487, 3519.7536172468194, 3589.407747721649, 3627.038834708804, 3722.6091260417807, 1118.1278602689915, 1128.1707944660668, 1139.3847322445952, 1141.6689160143465, 1144.3248483394837, 665.6106177885991, 777.6383981448654, 780.4224873593613, 796.3907610677836, 796.7649543384715, 4756.429228492603, 4853.490383509751, 4872.8781780455065, 4898.926516102261, 4956.281339205795, 384.7172328338669, 389.9493065901415, 391.2292783217058, 394.91706741584017, 399.8120883184898, 3186.028261380255, 3229.4187046331417, 3241.222106694376, 3253.3818574470774, 3350.27968986669, 8887.422317549339, 9283.303752218475, 9346.626134954662, 9365.672201472917, 9391.154796068387, 8665.090165532529, 9083.636654533877, 9084.772880677903, 9285.535723213812, 9346.252299815998, 7013.509054366247, 7149.89275160873, 7158.033665455201, 7164.570125792469, 7168.53404528704, 5160.380754309507, 5315.760790764348, 5363.946360536344, 5486.423925487767, 5501.0, 8258.545779982158, 8772.078931712334, 8784.121587841164, 8820.514871682119, 8843.204111629726, 8739.224511420389, 8788.340874434316, 8817.25053370445, 8829.205371516595, 9020.639174433212, 6040.2147720797775, 6572.901406478811, 6599.637019963948, 6791.762288319885, 6801.421879140328, 7442.62786860644, 7482.476226664081, 7506.512076714996, 7522.0, 7549.471536992358, 6638.867222655424, 6775.525713200029, 6785.084013658093, 6902.137232845895, 6914.654267286515, 6485.708143133476, 6551.312112228147, 6563.113979612691, 6565.868682626226, 6707.631080290631, 5951.940480595312, 5983.640981541122, 5986.55100867428, 5988.131720900532, 6035.517158627387, 4158.334666453353, 4285.400043993781, 4328.329108988112, 4335.393044973644, 4361.847335343247, 4318.762468064161, 4374.365716971085, 4377.802998864995, 4474.284114541658, 4553.9089218214785], "value": 3937.2197551887793, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.9195106887414, 290.5467470745637, 296.9554566814978, 297.7662534910096, 302.09221290023476, 5091.770870310836, 5125.5643270322025, 5141.254518094874, 5145.768440420181, 5165.741712914358, 4950.480199579047, 4968.1554135797005, 5005.674631148972, 5017.473165317635, 5018.397792264934, 3932.6067393260732, 3934.5835499220257, 3937.1535119949203, 3951.960480395188, 3980.263651224518, 3519.8064106474135, 3831.0230891122724, 3960.811756473061, 3982.721209515335, 3985.5217373915025, 3766.717496187783, 3849.615038496156, 3850.0557218604567, 3851.133494963625, 3863.8840834775, 3849.826757795906, 3856.633619806142, 3862.2854771867014, 3864.439656249856, 3874.7093967952233, 3410.7782994105305, 3414.3171365726953, 3436.621971583124, 3441.2601290722364, 3444.621091679913, 4732.645051621108, 4896.534829191221, 4904.852854414337, 4920.0, 4938.753062346868, 4486.416765820455, 4502.7973741181395, 4539.479274443065, 4542.954570454286, 4543.5002149763495, 4990.82532111378, 5254.605904557174, 5267.367915850123, 5268.971445993282, 5283.9471605284225, 3665.450182472624, 3748.744170702818, 3751.0, 3755.6244375562496, 3764.0778009387877, 5456.290682211326, 5461.126219804852, 5504.669719816784, 5517.917231241495, 5561.416051314634, 3885.611438856092, 3905.804709764557, 3915.8237879295502, 3921.313770090223, 3935.4293627423863, 3855.9588910994435, 3932.4297976793778, 3933.0364060804714, 3941.4481972523868, 3942.6003768662285, 4454.732716037048, 4463.460106263334, 4483.19302525542, 4485.775711214426, 4499.6400287976885, 5263.26314315996, 5271.710055946883, 5277.944411117792, 5290.180022096504, 5300.814471493479, 1320.0627554436267, 1355.6475316417802, 1359.327133069137, 1360.3810266328796, 1375.2259585135064, 853.2406158518924, 869.7303835810792, 883.5008220355479, 888.395890794266, 890.5057692980329, 4123.628873401408, 4167.604077612622, 4189.282394218356, 4192.224438478891, 4213.220554197422, 4768.690035147704, 4791.388693162235, 4792.100779028707, 4876.463589005207, 4918.409790825124, 4167.874963751093, 4185.916281674349, 4220.198162349206, 4247.173715302388, 4253.404523366731, 2615.3069436599317, 2657.774089202401, 2891.956620650692, 2908.185708001763, 2942.764578833688, 5187.792488300502, 5194.870128246748, 5204.557612602971, 5205.55752761012, 5208.869778255574, 5397.568194544427, 5623.297087864017, 5654.717264136859, 5663.971680141655, 5665.348484924287, 5078.314427552307, 5130.769115389817, 5188.662736922088, 5202.791888324425, 5217.8173763918085, 5267.841964741064, 5330.946690533045, 5498.422665620053, 5535.667859928417, 5557.693941923564, 5261.868453288698, 5285.286486324297, 5347.893042139213, 5349.491798279158, 5370.2213179089595, 5128.435872053997, 5129.410117836496, 5165.483451654804, 5200.2199670049795, 5206.817761378486, 3493.5633045869267, 3693.316736403774, 3709.7959612220507, 3710.7959062251834, 3759.3233218019923, 5448.237246785374, 5453.972730136483, 5461.5357694596405, 5464.2076898848645, 5486.177073439016, 5305.434896705404, 5321.787128514816, 5327.147656374961, 5339.893202136013, 5361.731913404236, 5137.614678899172, 5160.741962901915, 5253.185756207794, 5263.815766448156, 5305.249267741713, 5134.281200631989, 5156.458571849902, 5159.845204643867, 5190.870228244173, 5226.634135610623, 5184.096905732802, 5312.831177141023, 5338.772082420987, 5355.196720491957, 5361.597880158925, 5112.185174263083, 5172.922406163835, 5176.7152806594495, 5196.298499702491, 5220.660657057279], "value": 3931.37499327489, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.2593362022061, 671.3085521912432, 678.3115138134795, 727.3926271563241, 739.9160230262664, 12481.188722733028, 12656.177348472344, 12668.049896257771, 12762.872371276284, 14748.483803066869, 14518.782218266735, 14788.334524946376, 15494.767578486304, 15498.845011549882, 15537.689246215068, 626.4487251218922, 778.4356341652285, 785.512981951191, 791.76247125862, 795.4431897671624, 782.909965353983, 786.4691333349995, 789.3685051958439, 796.8725003999361, 796.8764841449556, 829.4525613095358, 831.2850948184587, 834.0950069174952, 835.4527784301262, 839.6809212499242, 823.9052508961427, 824.08938123374, 824.1387749801441, 824.686619084747, 827.4828232354809, 605.4218221598363, 605.6729366142278, 608.1334098909036, 609.0346800321452, 612.834534675635, 12099.0, 12178.512859485698, 12209.755804883942, 12250.203736757083, 12326.753464930742, 13519.188848669111, 13739.106958047794, 14028.158310501403, 14442.638934026734, 14506.202158881257, 10783.730406739816, 10826.24216304859, 10869.565217391295, 10907.727306817314, 10913.072388846958, 3352.5474061001696, 3368.242145517239, 3446.8965931022108, 3468.0982944434627, 3472.392331342005, 61786.0, 62232.68883655598, 63064.0, 63345.366546334866, 63658.68170659117, 10586.417747023988, 10696.0, 10781.460926953778, 10870.891291087146, 11173.0, 19964.50088747793, 20041.899790500953, 20181.39455816328, 20223.898880505505, 20520.179192832416, 7000.92999070013, 7015.543989640657, 7078.92921070793, 7110.075690160246, 7225.385842203472, 3748.3253014457114, 3758.3986562149926, 3825.3688141456905, 3827.27281816454, 3827.8086095695103, 2950.4836653585535, 3018.2907016851022, 3070.677578854188, 3074.6310442747013, 3082.9537556936666, 481.5016457966058, 500.3445486412811, 504.1152776876558, 511.73645572530177, 512.3288492075393, 544.3848451250062, 552.2710022769905, 570.9286339207599, 592.733270028489, 593.6260156101629, 7776.144624091346, 7811.843763124706, 7816.6091695415, 7859.253370929752, 7918.326942209861, 461.76938459007044, 479.7361451201825, 541.1990254423475, 544.8392724146387, 569.7863301262026, 3548.716102711777, 3644.1982763791925, 3757.887263382103, 3801.2207497462955, 3925.6270654287796, 54522.0, 54614.0, 54722.17916731252, 88793.55603221942, 93772.53113734524, 62201.68899155566, 76470.47059058788, 76836.61581692056, 78191.0, 78246.0, 73002.0, 74896.25103748892, 75847.0, 75897.24102759012, 76154.0, 7326.413886889142, 7345.192028876712, 7348.706051758084, 7435.8141046474275, 7520.661570229462, 42065.57934420617, 42394.0, 43621.56378436302, 43798.78100609604, 43897.12205755931, 62265.37734622777, 66062.66968665126, 66128.0, 66176.33823661895, 66209.33790662032, 8480.703175388831, 8680.088590698138, 8788.956055219938, 8875.28997680171, 8963.641454342014, 11049.668509944715, 11321.830172547583, 11449.42752862337, 11485.540578376771, 11511.712207194887, 11246.550137994716, 11270.774584508099, 11467.713307167387, 11571.247868888495, 12335.876641233473, 10971.780564388508, 11380.715482113013, 11489.655310340702, 11538.942305288756, 11897.643070707893, 10950.890491094988, 10987.945060274647, 11054.557817687202, 11058.612948546763, 11467.827982580435, 10062.245331600305, 10608.257421980696, 10689.51897164645, 10829.24195306321, 10855.945720271347, 10098.646547370807, 10318.0, 10384.740381490523, 10497.580096796042, 10596.841047384141], "value": 6450.787433335957, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 113.0, 117.0, 116.0, 114.0, 112.0, 113.0, 113.0, 112.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 137.0, 169.0, 188.0, 132.0, 162.0, 161.0, 138.0, 201.0, 134.0], "value": 158.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 172.0, 163.0, 163.0, 167.0, 161.0, 162.0, 161.0, 161.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 175.0, 77.0, 77.0, 76.0, 75.0, 163.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 143.0, 86.0, 87.0, 86.0, 139.0, 87.0, 87.0, 145.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 119.0, 118.0, 118.0, 117.0, 119.0, 118.0, 119.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 97.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 64.0, 64.0, 65.0, 66.0, 65.0, 64.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 85.0, 85.0, 89.0, 85.0, 86.0, 85.0, 106.0, 83.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 131.0, 138.0, 140.0, 131.0, 135.0, 144.0, 144.0, 136.0, 136.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 169.0, 175.0, 170.0, 173.0, 181.0, 170.0, 172.0, 181.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 70.0, 67.0, 67.0, 68.0, 68.0, 70.0, 67.0, 67.0], "value": 68.6, "unit": "score"}]}]} 04:34:18 INFO - Return code: 0 04:34:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:34:18 ERROR - # TBPL SUCCESS # 04:34:18 INFO - Running post-action listener: _resource_record_post_action 04:34:18 INFO - ##### 04:34:18 INFO - ##### Finished run-tests step (success) 04:34:18 INFO - ##### 04:34:18 INFO - Running post-run listener: _resource_record_post_run 04:34:18 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 550518784; Read time: 32; Write time: 764360 04:34:18 INFO - TinderboxPrint: CPU usage
13.5% 04:34:18 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 32 04:34:18 INFO - TinderboxPrint: I/O write bytes / time
550,518,784 / 764,360 04:34:18 INFO - TinderboxPrint: CPU idle
8,279.0 (86.5%) 04:34:18 INFO - TinderboxPrint: CPU user
1,233.2 (12.9%) 04:34:18 INFO - TinderboxPrint: Swap in / out
0 / 0 04:34:18 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 252575744; Read time: 0; Write time: 444464 04:34:18 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 297943040; Read time: 32; Write time: 319896 04:34:19 INFO - Running post-run listener: _upload_blobber_files 04:34:19 INFO - Blob upload gear active. 04:34:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:34:19 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 04:34:19 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:34:19 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:34:19 INFO - (blobuploader) - INFO - Open directory for files ... 04:34:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:34:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:34:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:20 INFO - (blobuploader) - INFO - Done attempting. 04:34:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:34:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:21 INFO - (blobuploader) - INFO - Done attempting. 04:34:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:34:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:34:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:24 INFO - (blobuploader) - INFO - Done attempting. 04:34:24 INFO - (blobuploader) - INFO - Iteration through files over. 04:34:24 INFO - Return code: 0 04:34:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:34:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:34:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23e38a746a7b9dd792cc2da9ab770e85f853a2743f0e4d249fb7202b80e8c104085df285f02fbc6f2e79eada48c61408fc15f740d74b08921fd0b6f4f91bba45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f346a2ce6a801a42fe7018de78fc9e09157a0f19b1a332c921f557fc59f7ab0479106e087329e1fcf1dcc466068a372fd6b5827004c131e6dc1c8ddf78a5cde1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a99dca2bb029e4883bd57a529305fe532c95d81f5539fd4848dddb8bfc16b120a3712823c68b632ef4b3e4f13326cbb6e07058b4ce8fae4cacbda681d4c5a3a2"} 04:34:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:34:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:34:24 INFO - Contents: 04:34:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23e38a746a7b9dd792cc2da9ab770e85f853a2743f0e4d249fb7202b80e8c104085df285f02fbc6f2e79eada48c61408fc15f740d74b08921fd0b6f4f91bba45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f346a2ce6a801a42fe7018de78fc9e09157a0f19b1a332c921f557fc59f7ab0479106e087329e1fcf1dcc466068a372fd6b5827004c131e6dc1c8ddf78a5cde1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a99dca2bb029e4883bd57a529305fe532c95d81f5539fd4848dddb8bfc16b120a3712823c68b632ef4b3e4f13326cbb6e07058b4ce8fae4cacbda681d4c5a3a2"} 04:34:24 INFO - Running post-run listener: copy_logs_to_upload_dir 04:34:24 INFO - Copying logs to upload dir... 04:34:24 INFO - mkdir: /builds/slave/test/build/upload/logs 04:34:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.509826 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-21 04:34:24.475093) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 04:34:24.478915) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23e38a746a7b9dd792cc2da9ab770e85f853a2743f0e4d249fb7202b80e8c104085df285f02fbc6f2e79eada48c61408fc15f740d74b08921fd0b6f4f91bba45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f346a2ce6a801a42fe7018de78fc9e09157a0f19b1a332c921f557fc59f7ab0479106e087329e1fcf1dcc466068a372fd6b5827004c131e6dc1c8ddf78a5cde1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a99dca2bb029e4883bd57a529305fe532c95d81f5539fd4848dddb8bfc16b120a3712823c68b632ef4b3e4f13326cbb6e07058b4ce8fae4cacbda681d4c5a3a2"} build_url:https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011385 build_url: 'https://queue.taskcluster.net/v1/task/DmmVVZJ2Tjq2XRPyyOHAGw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23e38a746a7b9dd792cc2da9ab770e85f853a2743f0e4d249fb7202b80e8c104085df285f02fbc6f2e79eada48c61408fc15f740d74b08921fd0b6f4f91bba45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f346a2ce6a801a42fe7018de78fc9e09157a0f19b1a332c921f557fc59f7ab0479106e087329e1fcf1dcc466068a372fd6b5827004c131e6dc1c8ddf78a5cde1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a99dca2bb029e4883bd57a529305fe532c95d81f5539fd4848dddb8bfc16b120a3712823c68b632ef4b3e4f13326cbb6e07058b4ce8fae4cacbda681d4c5a3a2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 04:34:24.504644) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:34:24.504947) ========= 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=14ef55db36f7623abb31b9cf000001d5-1466507618.432810-1875368968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:34:24.589210) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 04:34:24.589530) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 04:34:24.589797) ========= ========= Total master_lag: 0.17 =========