builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1465470521.61 results: success (0) buildid: 20160609025732 builduid: 205932dec85b4236a23a26e7e25d27d7 revision: f8bdceb55c9d191380176ab25e2385737bd9e1ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 04:08:41.609736) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 04:08:41.611393) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 04:08:41.612404) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 04:08:41.640227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:08:41.640981) ========= 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=eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 04:08:41-- 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% 39.0M=0s 2016-06-09 04:08:41 (39.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074714 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:08:41.737458) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:08:41.738193) ========= 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=eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022890 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:08:41.803375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:08:41.804098) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8bdceb55c9d191380176ab25e2385737bd9e1ab --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 f8bdceb55c9d191380176ab25e2385737bd9e1ab --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=eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 04:08:42,035 truncating revision to first 12 chars 2016-06-09 04:08:42,035 Setting DEBUG logging. 2016-06-09 04:08:42,035 attempt 1/10 2016-06-09 04:08:42,035 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8bdceb55c9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 04:08:42,324 unpacking tar archive at: mozilla-central-f8bdceb55c9d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624796 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:08:42.443311) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 04:08:42.443714) ========= script_repo_revision: f8bdceb55c9d191380176ab25e2385737bd9e1ab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 04:08:42.444234) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 04:08:42.444573) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 04:08:42.459021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-09 04:08:42.459335) ========= /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=eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:08:42 INFO - MultiFileLogger online at 20160609 04:08:42 in /builds/slave/test 04:08:42 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:08:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:08:42 INFO - {'append_to_log': False, 04:08:42 INFO - 'base_work_dir': '/builds/slave/test', 04:08:42 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:08:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:08:42 INFO - 'branch': 'Firefox-Non-PGO', 04:08:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:42 INFO - 'config_files': ('talos/linux_config.py',), 04:08:42 INFO - 'default_actions': ('clobber', 04:08:42 INFO - 'read-buildbot-config', 04:08:42 INFO - 'download-and-extract', 04:08:42 INFO - 'populate-webroot', 04:08:42 INFO - 'create-virtualenv', 04:08:42 INFO - 'install', 04:08:42 INFO - 'run-tests'), 04:08:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:42 INFO - 'download_minidump_stackwalk': True, 04:08:42 INFO - 'download_symbols': 'ondemand', 04:08:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:08:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:08:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:08:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:08:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:42 INFO - 'installer_path': 'installer.exe', 04:08:42 INFO - 'log_level': 'info', 04:08:42 INFO - 'log_name': 'talos', 04:08:42 INFO - 'log_to_console': True, 04:08:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:08:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:08:42 INFO - 'opt_config_files': (), 04:08:42 INFO - 'pip_index': False, 04:08:42 INFO - 'sps_profile': False, 04:08:42 INFO - 'sps_profile_interval': 0, 04:08:42 INFO - 'suite': 'dromaeojs-e10s', 04:08:42 INFO - 'system_bits': '32', 04:08:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:42 INFO - 'title': 'talos-linux64-ix-010', 04:08:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:42 INFO - 'use_talos_json': True, 04:08:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:08:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:42 INFO - 'work_dir': 'build'} 04:08:42 INFO - ##### 04:08:42 INFO - ##### Running clobber step. 04:08:42 INFO - ##### 04:08:42 INFO - Running pre-action listener: _resource_record_pre_action 04:08:42 INFO - Running main action method: clobber 04:08:42 INFO - rmtree: /builds/slave/test/build 04:08:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:08:43 INFO - Running post-action listener: _resource_record_post_action 04:08:43 INFO - ##### 04:08:43 INFO - ##### Finished clobber step (success) 04:08:43 INFO - ##### 04:08:43 INFO - ##### 04:08:43 INFO - ##### Running read-buildbot-config step. 04:08:43 INFO - ##### 04:08:43 INFO - Running pre-action listener: _resource_record_pre_action 04:08:43 INFO - Running main action method: read_buildbot_config 04:08:43 INFO - Using buildbot properties: 04:08:43 INFO - { 04:08:43 INFO - "project": "", 04:08:43 INFO - "product": "firefox", 04:08:43 INFO - "script_repo_revision": "production", 04:08:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:08:43 INFO - "repository": "", 04:08:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:08:43 INFO - "buildid": "20160609025732", 04:08:43 INFO - "pgo_build": "False", 04:08:43 INFO - "basedir": "/builds/slave/test", 04:08:43 INFO - "buildnumber": 344, 04:08:43 INFO - "slavename": "talos-linux64-ix-010", 04:08:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:08:43 INFO - "platform": "ubuntu64_hw", 04:08:43 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:08:43 INFO - "branch": "mozilla-central", 04:08:43 INFO - "repo_path": "mozilla-central", 04:08:43 INFO - "revision": "f8bdceb55c9d191380176ab25e2385737bd9e1ab", 04:08:43 INFO - "stage_platform": "linux64", 04:08:43 INFO - "builduid": "205932dec85b4236a23a26e7e25d27d7", 04:08:43 INFO - "slavebuilddir": "test" 04:08:43 INFO - } 04:08:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:08:43 INFO - Running post-action listener: _resource_record_post_action 04:08:43 INFO - ##### 04:08:43 INFO - ##### Finished read-buildbot-config step (success) 04:08:43 INFO - ##### 04:08:43 INFO - ##### 04:08:43 INFO - ##### Running download-and-extract step. 04:08:43 INFO - ##### 04:08:43 INFO - Running pre-action listener: _resource_record_pre_action 04:08:43 INFO - Running main action method: download_and_extract 04:08:43 INFO - mkdir: /builds/slave/test/build/tests 04:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:43 INFO - https://queue.taskcluster.net/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/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:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/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:08:43 INFO - Downloaded 1361 bytes. 04:08:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:08:43 INFO - Using the following test package requirements: 04:08:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:08:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:08:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:43 INFO - u'jsshell-linux-x86_64.zip'], 04:08:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:08:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:08:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:08:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:08:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:08:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:43 INFO - https://queue.taskcluster.net/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/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:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/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:08:45 INFO - Downloaded 22879054 bytes. 04:08: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:08: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:08:46 INFO - Return code: 0 04:08:46 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:08: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:08:46 INFO - https://queue.taskcluster.net/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/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:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/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:08:56 INFO - Downloaded 22879054 bytes. 04:08:56 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:08:56 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:08:58 INFO - Return code: 0 04:08:58 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:08:58 INFO - https://queue.taskcluster.net/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:08:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/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:08:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/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:09:00 INFO - Downloaded 10833369 bytes. 04:09:00 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:09:00 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:09:00 INFO - Return code: 0 04:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:00 INFO - https://queue.taskcluster.net/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:09:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:09:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:09:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/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:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V0Pmgq4qSimolC9I12MQ3w/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:09:03 INFO - Downloaded 55336853 bytes. 04:09:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:09:03 INFO - mkdir: /builds/slave/test/properties 04:09:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:09:03 INFO - Writing to file /builds/slave/test/properties/build_url 04:09:03 INFO - Contents: 04:09:03 INFO - build_url:https://queue.taskcluster.net/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:09:04 INFO - Running post-action listener: _resource_record_post_action 04:09:04 INFO - Running post-action listener: set_extra_try_arguments 04:09:04 INFO - ##### 04:09:04 INFO - ##### Finished download-and-extract step (success) 04:09:04 INFO - ##### 04:09:04 INFO - ##### 04:09:04 INFO - ##### Running populate-webroot step. 04:09:04 INFO - ##### 04:09:04 INFO - Running pre-action listener: _resource_record_pre_action 04:09:04 INFO - Running main action method: populate_webroot 04:09:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:09:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:09:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:09:04 INFO - '--tppagecycles', 04:09:04 INFO - '7'], 04:09:04 INFO - 'tests': ['tsvgm']}}, 04:09:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:09:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:09:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:09:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:09:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:09:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:09:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'talos_options': ['--disable-e10s'], 04:09:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'talos_options': ['--disable-e10s'], 04:09:04 INFO - 'tests': ['damp', 'tps']}, 04:09:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'tests': ['damp', 'tps']}, 04:09:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:09:04 INFO - 'tests': ['dromaeo_dom']}, 04:09:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:09:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:09:04 INFO - 'tests': ['a11yr', 04:09:04 INFO - 'ts_paint', 04:09:04 INFO - 'tpaint', 04:09:04 INFO - 'sessionrestore', 04:09:04 INFO - 'sessionrestore_no_auto_restore', 04:09:04 INFO - 'tabpaint']}, 04:09:04 INFO - 'other-e10s': {'tests': ['a11yr', 04:09:04 INFO - 'ts_paint', 04:09:04 INFO - 'tpaint', 04:09:04 INFO - 'sessionrestore', 04:09:04 INFO - 'sessionrestore_no_auto_restore', 04:09:04 INFO - 'tabpaint']}, 04:09:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:09:04 INFO - 'ts_paint', 04:09:04 INFO - 'tpaint', 04:09:04 INFO - 'sessionrestore', 04:09:04 INFO - 'sessionrestore_no_auto_restore', 04:09:04 INFO - 'tabpaint']}, 04:09:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:09:04 INFO - 'ts_paint', 04:09:04 INFO - 'tpaint', 04:09:04 INFO - 'sessionrestore', 04:09:04 INFO - 'sessionrestore_no_auto_restore', 04:09:04 INFO - 'tabpaint']}, 04:09:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:09:04 INFO - 'tests': ['a11yr', 04:09:04 INFO - 'ts_paint', 04:09:04 INFO - 'tpaint', 04:09:04 INFO - 'sessionrestore', 04:09:04 INFO - 'sessionrestore_no_auto_restore', 04:09:04 INFO - 'tabpaint']}, 04:09:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:09:04 INFO - 'tests': ['a11yr', 04:09:04 INFO - 'ts_paint', 04:09:04 INFO - 'tpaint', 04:09:04 INFO - 'sessionrestore', 04:09:04 INFO - 'sessionrestore_no_auto_restore', 04:09:04 INFO - 'tabpaint']}, 04:09:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:09:04 INFO - 'tests': ['tsvgx', 04:09:04 INFO - 'tsvgr_opacity', 04:09:04 INFO - 'tart', 04:09:04 INFO - 'tscrollx', 04:09:04 INFO - 'cart']}, 04:09:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:09:04 INFO - 'tsvgr_opacity', 04:09:04 INFO - 'tart', 04:09:04 INFO - 'tscrollx', 04:09:04 INFO - 'cart']}, 04:09:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'talos_options': ['--disable-e10s'], 04:09:04 INFO - 'tests': ['tp5o']}, 04:09:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'tests': ['tp5o']}, 04:09:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'talos_options': ['--disable-e10s', 04:09:04 INFO - '--xperf_path', 04:09:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:04 INFO - 'tests': ['tp5n']}, 04:09:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'talos_options': ['--xperf_path', 04:09:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:04 INFO - 'tests': ['tp5n']}}, 04:09:04 INFO - 'talos.zip': {'path': '', 04:09:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:09:04 INFO - Running post-action listener: _resource_record_post_action 04:09:04 INFO - ##### 04:09:04 INFO - ##### Finished populate-webroot step (success) 04:09:04 INFO - ##### 04:09:04 INFO - ##### 04:09:04 INFO - ##### Running create-virtualenv step. 04:09:04 INFO - ##### 04:09:04 INFO - Running pre-action listener: _resource_record_pre_action 04:09:04 INFO - Running main action method: create_virtualenv 04:09:04 INFO - Creating virtualenv /builds/slave/test/build/venv 04:09:04 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:09:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:09:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:09:04 INFO - Using real prefix '/usr' 04:09:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:09:05 INFO - Installing distribute.............................................................................................................................................................................................done. 04:09:07 INFO - Installing pip.................done. 04:09:07 INFO - Return code: 0 04:09:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:09: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:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:07 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 0x7fecf8540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23682e0>, '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 0x22d4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d45d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', '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:09:07 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:09:07 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:09:07 INFO - Using env: {'DISPLAY': ':0', 04:09:07 INFO - 'HOME': '/home/cltbld', 04:09:07 INFO - 'LANG': 'en_US.UTF-8', 04:09:07 INFO - 'LANGUAGE': 'en_US:en', 04:09:07 INFO - 'LOGNAME': 'cltbld', 04:09:07 INFO - 'MAIL': '/var/mail/cltbld', 04:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:07 INFO - 'MOZ_NO_REMOTE': '1', 04:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:07 INFO - 'NO_EM_RESTART': '1', 04:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:07 INFO - 'PWD': '/builds/slave/test', 04:09:07 INFO - 'SHELL': '/bin/bash', 04:09:07 INFO - 'SHLVL': '1', 04:09:07 INFO - 'TERM': 'linux', 04:09:07 INFO - 'TMOUT': '86400', 04:09:07 INFO - 'USER': 'cltbld', 04:09:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', 04:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:07 INFO - '_': '/tools/buildbot/bin/python'} 04:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:07 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:09:07 INFO - Cleaning up... 04:09:07 INFO - Return code: 0 04:09:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:09: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:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:07 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 0x7fecf8540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23682e0>, '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 0x22d4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d45d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', '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:09:07 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:09:07 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:09:07 INFO - Using env: {'DISPLAY': ':0', 04:09:07 INFO - 'HOME': '/home/cltbld', 04:09:07 INFO - 'LANG': 'en_US.UTF-8', 04:09:07 INFO - 'LANGUAGE': 'en_US:en', 04:09:07 INFO - 'LOGNAME': 'cltbld', 04:09:07 INFO - 'MAIL': '/var/mail/cltbld', 04:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:07 INFO - 'MOZ_NO_REMOTE': '1', 04:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:07 INFO - 'NO_EM_RESTART': '1', 04:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:07 INFO - 'PWD': '/builds/slave/test', 04:09:07 INFO - 'SHELL': '/bin/bash', 04:09:07 INFO - 'SHLVL': '1', 04:09:07 INFO - 'TERM': 'linux', 04:09:07 INFO - 'TMOUT': '86400', 04:09:07 INFO - 'USER': 'cltbld', 04:09:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', 04:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:07 INFO - '_': '/tools/buildbot/bin/python'} 04:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:07 INFO - Downloading/unpacking psutil>=3.1.1 04:09: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:09: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:09: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:09: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:09: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:09: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:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:09:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:09 INFO - Installing collected packages: psutil 04:09:09 INFO - Running setup.py install for psutil 04:09:09 INFO - building 'psutil._psutil_linux' extension 04:09:09 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:09:09 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:09:09 INFO - building 'psutil._psutil_posix' extension 04:09:09 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:09:10 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:09:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:10 INFO - Successfully installed psutil 04:09:10 INFO - Cleaning up... 04:09:10 INFO - Return code: 0 04:09:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:10 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 0x7fecf8540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23682e0>, '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 0x22d4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d45d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', '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:09:10 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:09:10 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:09:10 INFO - Using env: {'DISPLAY': ':0', 04:09:10 INFO - 'HOME': '/home/cltbld', 04:09:10 INFO - 'LANG': 'en_US.UTF-8', 04:09:10 INFO - 'LANGUAGE': 'en_US:en', 04:09:10 INFO - 'LOGNAME': 'cltbld', 04:09:10 INFO - 'MAIL': '/var/mail/cltbld', 04:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:10 INFO - 'MOZ_NO_REMOTE': '1', 04:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:10 INFO - 'NO_EM_RESTART': '1', 04:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:10 INFO - 'PWD': '/builds/slave/test', 04:09:10 INFO - 'SHELL': '/bin/bash', 04:09:10 INFO - 'SHLVL': '1', 04:09:10 INFO - 'TERM': 'linux', 04:09:10 INFO - 'TMOUT': '86400', 04:09:10 INFO - 'USER': 'cltbld', 04:09:10 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', 04:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:10 INFO - '_': '/tools/buildbot/bin/python'} 04:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:09:10 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:09:10 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:09:10 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:09:10 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:09:10 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:09:10 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:09:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:09:12 INFO - Installing collected packages: mozsystemmonitor 04:09:12 INFO - Running setup.py install for mozsystemmonitor 04:09:12 INFO - Successfully installed mozsystemmonitor 04:09:12 INFO - Cleaning up... 04:09:12 INFO - Return code: 0 04:09:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:12 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 0x7fecf8540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23682e0>, '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 0x22d4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d45d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', '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:09:12 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:09:12 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:09:12 INFO - Using env: {'DISPLAY': ':0', 04:09:12 INFO - 'HOME': '/home/cltbld', 04:09:12 INFO - 'LANG': 'en_US.UTF-8', 04:09:12 INFO - 'LANGUAGE': 'en_US:en', 04:09:12 INFO - 'LOGNAME': 'cltbld', 04:09:12 INFO - 'MAIL': '/var/mail/cltbld', 04:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:12 INFO - 'MOZ_NO_REMOTE': '1', 04:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:12 INFO - 'NO_EM_RESTART': '1', 04:09:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:12 INFO - 'PWD': '/builds/slave/test', 04:09:12 INFO - 'SHELL': '/bin/bash', 04:09:12 INFO - 'SHLVL': '1', 04:09:12 INFO - 'TERM': 'linux', 04:09:12 INFO - 'TMOUT': '86400', 04:09:12 INFO - 'USER': 'cltbld', 04:09:12 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', 04:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:12 INFO - '_': '/tools/buildbot/bin/python'} 04:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:12 INFO - Downloading/unpacking jsonschema==2.5.1 04:09: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:09: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:09: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:09: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:09: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:09: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:09:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:09:14 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:09:14 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:09:14 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:09:14 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:09:14 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:09:14 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:09:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:14 INFO - warning: no files found matching '*.txt' 04:09:14 INFO - no previously-included directories found matching 'build' 04:09:14 INFO - no previously-included directories found matching 'dist' 04:09:14 INFO - no previously-included directories found matching '.git*' 04:09:14 INFO - Installing collected packages: jsonschema, functools32 04:09:14 INFO - Running setup.py install for functools32 04:09:15 INFO - warning: no files found matching '*.txt' 04:09:15 INFO - no previously-included directories found matching 'build' 04:09:15 INFO - no previously-included directories found matching 'dist' 04:09:15 INFO - no previously-included directories found matching '.git*' 04:09:15 INFO - Successfully installed jsonschema functools32 04:09:15 INFO - Cleaning up... 04:09:15 INFO - Return code: 0 04:09:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:09: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:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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', '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 0x7fecf8540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23682e0>, '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 0x22d4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d45d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', '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:09: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:09: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 blobuploader==1.2.4 04:09:15 INFO - Using env: {'DISPLAY': ':0', 04:09:15 INFO - 'HOME': '/home/cltbld', 04:09:15 INFO - 'LANG': 'en_US.UTF-8', 04:09:15 INFO - 'LANGUAGE': 'en_US:en', 04:09:15 INFO - 'LOGNAME': 'cltbld', 04:09:15 INFO - 'MAIL': '/var/mail/cltbld', 04:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:15 INFO - 'MOZ_NO_REMOTE': '1', 04:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:15 INFO - 'NO_EM_RESTART': '1', 04:09:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:15 INFO - 'PWD': '/builds/slave/test', 04:09:15 INFO - 'SHELL': '/bin/bash', 04:09:15 INFO - 'SHLVL': '1', 04:09:15 INFO - 'TERM': 'linux', 04:09:15 INFO - 'TMOUT': '86400', 04:09:15 INFO - 'USER': 'cltbld', 04:09:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', 04:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:15 INFO - '_': '/tools/buildbot/bin/python'} 04:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:15 INFO - Downloading/unpacking blobuploader==1.2.4 04:09: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:09: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:09: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:09: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:09: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:09: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:09:17 INFO - Downloading blobuploader-1.2.4.tar.gz 04:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:09:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:09: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:09: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:09: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:09: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:09: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:09: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:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:09:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:09: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:09: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:09: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:09: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:09: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:09: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:09:17 INFO - Downloading docopt-0.6.1.tar.gz 04:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:09:18 INFO - Installing collected packages: blobuploader, requests, docopt 04:09:18 INFO - Running setup.py install for blobuploader 04:09:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:09:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:09:18 INFO - Running setup.py install for requests 04:09:18 INFO - Running setup.py install for docopt 04:09:18 INFO - Successfully installed blobuploader requests docopt 04:09:18 INFO - Cleaning up... 04:09:18 INFO - Return code: 0 04:09:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:18 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 0x7fecf8540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23682e0>, '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 0x22d4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d45d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', '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:09:18 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:09:18 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:09:18 INFO - Using env: {'DISPLAY': ':0', 04:09:18 INFO - 'HOME': '/home/cltbld', 04:09:18 INFO - 'LANG': 'en_US.UTF-8', 04:09:18 INFO - 'LANGUAGE': 'en_US:en', 04:09:18 INFO - 'LOGNAME': 'cltbld', 04:09:18 INFO - 'MAIL': '/var/mail/cltbld', 04:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:18 INFO - 'MOZ_NO_REMOTE': '1', 04:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:18 INFO - 'NO_EM_RESTART': '1', 04:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:18 INFO - 'PWD': '/builds/slave/test', 04:09:18 INFO - 'SHELL': '/bin/bash', 04:09:18 INFO - 'SHLVL': '1', 04:09:18 INFO - 'TERM': 'linux', 04:09:18 INFO - 'TMOUT': '86400', 04:09:18 INFO - 'USER': 'cltbld', 04:09:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', 04:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:18 INFO - '_': '/tools/buildbot/bin/python'} 04:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:18 INFO - Running setup.py (path:/tmp/pip-NykQc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:18 INFO - Running setup.py (path:/tmp/pip-UPB6gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:18 INFO - Running setup.py (path:/tmp/pip-jTQyJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:19 INFO - Running setup.py (path:/tmp/pip-ckFosr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:19 INFO - Running setup.py (path:/tmp/pip-fJHbLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:19 INFO - Running setup.py (path:/tmp/pip-Aj9fcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:19 INFO - Running setup.py (path:/tmp/pip-SbbQYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:19 INFO - Running setup.py (path:/tmp/pip-RuIGtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:19 INFO - Running setup.py (path:/tmp/pip-uCQayk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:19 INFO - Running setup.py (path:/tmp/pip-3QfbGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:19 INFO - Running setup.py (path:/tmp/pip-cv67yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:19 INFO - Running setup.py (path:/tmp/pip-41Dkm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:19 INFO - Running setup.py (path:/tmp/pip-Ej2okj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:19 INFO - Running setup.py (path:/tmp/pip-yZUO2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:19 INFO - Running setup.py (path:/tmp/pip-x8zxAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:19 INFO - Running setup.py (path:/tmp/pip-_4yAlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:19 INFO - Running setup.py (path:/tmp/pip-dIZ779-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:09:20 INFO - Running setup.py install for manifestparser 04:09:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:09:20 INFO - Running setup.py install for mozcrash 04:09:20 INFO - Running setup.py install for mozdebug 04:09:20 INFO - Running setup.py install for mozdevice 04:09:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:09:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:09:20 INFO - Running setup.py install for mozfile 04:09:20 INFO - Running setup.py install for mozhttpd 04:09:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:09:20 INFO - Running setup.py install for mozinfo 04:09:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:09:20 INFO - Running setup.py install for mozInstall 04:09:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:09:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:09:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:09:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:09:20 INFO - Running setup.py install for mozleak 04:09:20 INFO - Running setup.py install for mozlog 04:09:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:09:21 INFO - Running setup.py install for moznetwork 04:09:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:09:21 INFO - Running setup.py install for mozprocess 04:09:21 INFO - Running setup.py install for mozprofile 04:09:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:09:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:09:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:09:21 INFO - Running setup.py install for mozrunner 04:09:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:09:21 INFO - Running setup.py install for mozscreenshot 04:09:21 INFO - Running setup.py install for moztest 04:09:21 INFO - Running setup.py install for mozversion 04:09:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:09:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:09:21 INFO - Cleaning up... 04:09:21 INFO - Return code: 0 04:09:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:21 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 0x7fecf8540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23682e0>, '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 0x22d4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d45d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', '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:09:21 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:09:21 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:09:21 INFO - Using env: {'DISPLAY': ':0', 04:09:21 INFO - 'HOME': '/home/cltbld', 04:09:21 INFO - 'LANG': 'en_US.UTF-8', 04:09:21 INFO - 'LANGUAGE': 'en_US:en', 04:09:21 INFO - 'LOGNAME': 'cltbld', 04:09:21 INFO - 'MAIL': '/var/mail/cltbld', 04:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:21 INFO - 'MOZ_NO_REMOTE': '1', 04:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:21 INFO - 'NO_EM_RESTART': '1', 04:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:21 INFO - 'PWD': '/builds/slave/test', 04:09:21 INFO - 'SHELL': '/bin/bash', 04:09:21 INFO - 'SHLVL': '1', 04:09:21 INFO - 'TERM': 'linux', 04:09:21 INFO - 'TMOUT': '86400', 04:09:21 INFO - 'USER': 'cltbld', 04:09:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', 04:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:21 INFO - '_': '/tools/buildbot/bin/python'} 04:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:22 INFO - Running setup.py (path:/tmp/pip-2M86zY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:22 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:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:22 INFO - Running setup.py (path:/tmp/pip-GaaVU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:22 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:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:22 INFO - Running setup.py (path:/tmp/pip-rTDJhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:22 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:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:22 INFO - Running setup.py (path:/tmp/pip-Ng7wc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:22 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:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:22 INFO - Running setup.py (path:/tmp/pip-Hdx2wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:22 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:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:22 INFO - Running setup.py (path:/tmp/pip-wbCJv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:22 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:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:22 INFO - Running setup.py (path:/tmp/pip-77W6lF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:22 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:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:22 INFO - Running setup.py (path:/tmp/pip-IwfJ31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:22 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:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:22 INFO - Running setup.py (path:/tmp/pip-wC44Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:22 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:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:22 INFO - Running setup.py (path:/tmp/pip-j3SDN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:22 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:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:22 INFO - Running setup.py (path:/tmp/pip-yr7EOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:22 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:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:22 INFO - Running setup.py (path:/tmp/pip-EXgFKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:22 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:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:22 INFO - Running setup.py (path:/tmp/pip-WZRtQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:23 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:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:23 INFO - Running setup.py (path:/tmp/pip-jbUtbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:23 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:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:23 INFO - Running setup.py (path:/tmp/pip-K1vJSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:23 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:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:23 INFO - Running setup.py (path:/tmp/pip-8vWG5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:23 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:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:23 INFO - Running setup.py (path:/tmp/pip-mK6NrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:23 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:09:23 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:09:23 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:09:23 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:09:23 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:09:23 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:09:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09:23 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:09:23 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:09:23 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:09:23 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:09:23 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:09:23 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:09:25 INFO - Downloading blessings-1.6.tar.gz 04:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:09:25 INFO - Installing collected packages: blessings 04:09:25 INFO - Running setup.py install for blessings 04:09:25 INFO - Successfully installed blessings 04:09:25 INFO - Cleaning up... 04:09:25 INFO - Return code: 0 04:09:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:09:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:25 INFO - Reading from file tmpfile_stdout 04:09:25 INFO - Current package versions: 04:09:25 INFO - argparse == 1.2.1 04:09:25 INFO - blessings == 1.6 04:09:25 INFO - blobuploader == 1.2.4 04:09:25 INFO - docopt == 0.6.1 04:09:25 INFO - functools32 == 3.2.3-2 04:09:25 INFO - jsonschema == 2.5.1 04:09:25 INFO - manifestparser == 1.1 04:09:25 INFO - mozInstall == 1.12 04:09:25 INFO - mozcrash == 0.17 04:09:25 INFO - mozdebug == 0.1 04:09:25 INFO - mozdevice == 0.48 04:09:25 INFO - mozfile == 1.2 04:09:25 INFO - mozhttpd == 0.7 04:09:25 INFO - mozinfo == 0.9 04:09:25 INFO - mozleak == 0.1 04:09:25 INFO - mozlog == 3.2 04:09:25 INFO - moznetwork == 0.27 04:09:25 INFO - mozprocess == 0.22 04:09:25 INFO - mozprofile == 0.28 04:09:25 INFO - mozrunner == 6.11 04:09:25 INFO - mozscreenshot == 0.1 04:09:25 INFO - mozsystemmonitor == 0.3 04:09:25 INFO - moztest == 0.7 04:09:25 INFO - mozversion == 1.4 04:09:25 INFO - psutil == 3.1.1 04:09:25 INFO - requests == 1.2.3 04:09:25 INFO - wsgiref == 0.1.2 04:09:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:25 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 0x7fecf8540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23682e0>, '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 0x22d4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d45d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', '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:09:25 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:09:25 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:09:25 INFO - Using env: {'DISPLAY': ':0', 04:09:25 INFO - 'HOME': '/home/cltbld', 04:09:25 INFO - 'LANG': 'en_US.UTF-8', 04:09:25 INFO - 'LANGUAGE': 'en_US:en', 04:09:25 INFO - 'LOGNAME': 'cltbld', 04:09:25 INFO - 'MAIL': '/var/mail/cltbld', 04:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:25 INFO - 'MOZ_NO_REMOTE': '1', 04:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:25 INFO - 'NO_EM_RESTART': '1', 04:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:25 INFO - 'PWD': '/builds/slave/test', 04:09:25 INFO - 'SHELL': '/bin/bash', 04:09:25 INFO - 'SHLVL': '1', 04:09:25 INFO - 'TERM': 'linux', 04:09:25 INFO - 'TMOUT': '86400', 04:09:25 INFO - 'USER': 'cltbld', 04:09:25 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', 04:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:25 INFO - '_': '/tools/buildbot/bin/python'} 04:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 INFO - Cleaning up... 04:09:25 INFO - Return code: 0 04:09:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:25 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 0x7fecf8540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23682e0>, '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 0x22d4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d45d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', '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:09:25 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:09:25 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:09:25 INFO - Using env: {'DISPLAY': ':0', 04:09:25 INFO - 'HOME': '/home/cltbld', 04:09:25 INFO - 'LANG': 'en_US.UTF-8', 04:09:25 INFO - 'LANGUAGE': 'en_US:en', 04:09:25 INFO - 'LOGNAME': 'cltbld', 04:09:25 INFO - 'MAIL': '/var/mail/cltbld', 04:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:25 INFO - 'MOZ_NO_REMOTE': '1', 04:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:25 INFO - 'NO_EM_RESTART': '1', 04:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:25 INFO - 'PWD': '/builds/slave/test', 04:09:25 INFO - 'SHELL': '/bin/bash', 04:09:25 INFO - 'SHLVL': '1', 04:09:25 INFO - 'TERM': 'linux', 04:09:25 INFO - 'TMOUT': '86400', 04:09:25 INFO - 'USER': 'cltbld', 04:09:25 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', 04:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:25 INFO - '_': '/tools/buildbot/bin/python'} 04:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:09:26 INFO - Cleaning up... 04:09:26 INFO - Return code: 0 04:09:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:09:26 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:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:26 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:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:26 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 0x7fecf8540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23682e0>, '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 0x22d4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d45d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', '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:09:26 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:09:26 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:09:26 INFO - Using env: {'DISPLAY': ':0', 04:09:26 INFO - 'HOME': '/home/cltbld', 04:09:26 INFO - 'LANG': 'en_US.UTF-8', 04:09:26 INFO - 'LANGUAGE': 'en_US:en', 04:09:26 INFO - 'LOGNAME': 'cltbld', 04:09:26 INFO - 'MAIL': '/var/mail/cltbld', 04:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:26 INFO - 'MOZ_NO_REMOTE': '1', 04:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:26 INFO - 'NO_EM_RESTART': '1', 04:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:26 INFO - 'PWD': '/builds/slave/test', 04:09:26 INFO - 'SHELL': '/bin/bash', 04:09:26 INFO - 'SHLVL': '1', 04:09:26 INFO - 'TERM': 'linux', 04:09:26 INFO - 'TMOUT': '86400', 04:09:26 INFO - 'USER': 'cltbld', 04:09:26 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', 04:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:26 INFO - '_': '/tools/buildbot/bin/python'} 04:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:26 INFO - Downloading/unpacking flake8 04:09:26 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:09:26 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:09:26 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:09:26 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:09:26 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:09:26 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:09:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:09:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:09:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:09:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:29 INFO - no previously-included directories found matching 'docs/_build' 04:09:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:09:29 INFO - Running setup.py install for pep8 04:09:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:29 INFO - no previously-included directories found matching 'docs/_build' 04:09:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:09:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:09:29 INFO - Cleaning up... 04:09:29 INFO - Return code: 0 04:09:29 INFO - Running post-action listener: _resource_record_post_action 04:09:29 INFO - Running post-action listener: _start_resource_monitoring 04:09:29 INFO - Starting resource monitoring. 04:09:29 INFO - ##### 04:09:29 INFO - ##### Finished create-virtualenv step (success) 04:09:29 INFO - ##### 04:09:29 INFO - ##### 04:09:29 INFO - ##### Running install step. 04:09:29 INFO - ##### 04:09:29 INFO - Running pre-action listener: _resource_record_pre_action 04:09:29 INFO - Running main action method: install 04:09:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:29 INFO - Reading from file tmpfile_stdout 04:09:29 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:09:29 INFO - Reading from file tmpfile_stdout 04:09:29 INFO - Output received: 04:09:29 INFO - Usage: mozinstall [options] installer 04:09:29 INFO - Options: 04:09:29 INFO - -h, --help show this help message and exit 04:09:29 INFO - -d DEST, --destination=DEST 04:09:29 INFO - Directory to install application into. [default: 04:09:29 INFO - "/builds/slave/test"] 04:09:29 INFO - --app=APP Application being installed. [default: firefox] 04:09:29 INFO - mkdir: /builds/slave/test/build/application 04:09:29 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:09:29 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:09:45 INFO - Reading from file tmpfile_stdout 04:09:45 INFO - Output received: 04:09:45 INFO - /builds/slave/test/build/application/firefox/firefox 04:09:45 INFO - Running post-action listener: _resource_record_post_action 04:09:45 INFO - ##### 04:09:45 INFO - ##### Finished install step (success) 04:09:45 INFO - ##### 04:09:45 INFO - ##### 04:09:45 INFO - ##### Running run-tests step. 04:09:45 INFO - ##### 04:09:45 INFO - Running pre-action listener: _resource_record_pre_action 04:09:45 INFO - Running main action method: run_tests 04:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:45 INFO - Python 2.7.3 04:09:45 INFO - Return code: 0 04:09:45 INFO - grabbing minidump binary from tooltool 04:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:45 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 0x23682e0>, '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 0x22d4140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d45d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09:45 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:09:45 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:09:45 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:09:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:45 INFO - Return code: 0 04:09:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:09:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:09:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:09:46 INFO - Return code: 0 04:09:46 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/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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:09:46 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/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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:09:46 INFO - Using env: {'DISPLAY': ':0', 04:09:46 INFO - 'HOME': '/home/cltbld', 04:09:46 INFO - 'LANG': 'en_US.UTF-8', 04:09:46 INFO - 'LANGUAGE': 'en_US:en', 04:09:46 INFO - 'LOGNAME': 'cltbld', 04:09:46 INFO - 'MAIL': '/var/mail/cltbld', 04:09:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:46 INFO - 'MOZ_NO_REMOTE': '1', 04:09:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:46 INFO - 'NO_EM_RESTART': '1', 04:09:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:46 INFO - 'PWD': '/builds/slave/test', 04:09:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:46 INFO - 'SHELL': '/bin/bash', 04:09:46 INFO - 'SHLVL': '1', 04:09:46 INFO - 'TERM': 'linux', 04:09:46 INFO - 'TMOUT': '86400', 04:09:46 INFO - 'USER': 'cltbld', 04:09:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568', 04:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:46 INFO - '_': '/tools/buildbot/bin/python'} 04:09:46 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/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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:09:46 INFO - mozversion application_buildid: 20160609025732 04:09:46 INFO - mozversion application_changeset: f8bdceb55c9d191380176ab25e2385737bd9e1ab 04:09:46 INFO - mozversion application_display_name: Nightly 04:09:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:46 INFO - mozversion application_name: Firefox 04:09:46 INFO - mozversion application_remotingname: firefox 04:09:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:09:46 INFO - mozversion application_vendor: Mozilla 04:09:46 INFO - mozversion application_version: 50.0a1 04:09:46 INFO - mozversion platform_buildid: 20160609025732 04:09:46 INFO - mozversion platform_changeset: f8bdceb55c9d191380176ab25e2385737bd9e1ab 04:09:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:09:46 INFO - mozversion platform_version: 50.0a1 04:09:46 INFO - using testdate: 1465470586 04:09:46 INFO - actual date: 1465470586 04:09:46 INFO - starting webserver on 'localhost:54145' 04:09:46 INFO - SUITE-START | Running 2 tests 04:09:46 INFO - TEST-START | dromaeo_css 04:09:46 INFO - operating with platform_type : linux_ 04:09:46 INFO - Initialising browser for dromaeo_css test... 04:09:46 INFO - TEST-INFO | started process 19790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwGMBay/profile http://localhost:54145/getInfo.html) 04:09:52 INFO - PROCESS | 19790 | __metrics Screen width/height:1600/1200 04:09:52 INFO - PROCESS | 19790 | colorDepth:24 04:09:52 INFO - PROCESS | 19790 | Browser inner width/height: 1024/697 04:09:52 INFO - PROCESS | 19790 | __metrics 04:09:53 ERROR - PROCESS | 19790 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:09:54 INFO - TEST-INFO | 19790: exit 0 04:09:54 INFO - Browser initialized. 04:09:54 INFO - Running cycle 1/1 for dromaeo_css test... 04:09:54 INFO - TEST-INFO | started process 19908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwGMBay/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:06 INFO - PROCESS | 19908 | RSS: Main: 168472576 04:10:06 INFO - PROCESS | 19908 | 04:10:55 INFO - PROCESS | 19908 | 1465470655827 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:13:07 INFO - PROCESS | 19908 | Cycle 1(1): loaded http://localhost:54145/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54145/tests/dromaeo/cssquery-ext.html) 04:13:08 INFO - PROCESS | 19908 | RSS: Main: 171573248 04:13:08 INFO - PROCESS | 19908 | 04:16:10 INFO - PROCESS | 19908 | Cycle 1(1): loaded http://localhost:54145/tests/dromaeo/cssquery-ext.html (next: http://localhost:54145/tests/dromaeo/cssquery-jquery.html) 04:16:11 INFO - PROCESS | 19908 | RSS: Main: 170536960 04:16:11 INFO - PROCESS | 19908 | 04:19:13 INFO - PROCESS | 19908 | Cycle 1(1): loaded http://localhost:54145/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54145/tests/dromaeo/cssquery-mootools.html) 04:19:14 INFO - PROCESS | 19908 | RSS: Main: 171835392 04:19:14 INFO - PROCESS | 19908 | 04:22:16 INFO - PROCESS | 19908 | Cycle 1(1): loaded http://localhost:54145/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54145/tests/dromaeo/cssquery-prototype.html) 04:22:16 INFO - PROCESS | 19908 | RSS: Main: 169193472 04:22:16 INFO - PROCESS | 19908 | 04:25:19 INFO - PROCESS | 19908 | Cycle 1(1): loaded http://localhost:54145/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54145/tests/dromaeo/cssquery-yui.html) 04:25:20 INFO - PROCESS | 19908 | RSS: Main: 170717184 04:25:20 INFO - PROCESS | 19908 | 04:28:22 INFO - PROCESS | 19908 | Cycle 1(1): loaded http://localhost:54145/tests/dromaeo/cssquery-yui.html (next: http://localhost:54145/tests/dromaeo/cssquery-dojo.html) 04:28:23 INFO - PROCESS | 19908 | RSS: Main: 172163072 04:28:23 INFO - PROCESS | 19908 | 04:28:23 INFO - PROCESS | 19908 | __start_tp_report 04:28:23 INFO - PROCESS | 19908 | _x_x_mozilla_page_load 04:28:23 INFO - PROCESS | 19908 | _x_x_mozilla_page_load_details 04:28:23 INFO - PROCESS | 19908 | |i|pagename|runs| 04:28:23 INFO - PROCESS | 19908 | |0;dojo.html;2634.841909485431;2693.0305090167535;2693.259353677737;2699.1767510909167;2729.3995321029365;4655.511171327008;4740.431148262209;4759.262314341274;4795.712257264567;4801.135795556803;4627.4447066352;4702.647301452388;4715.811367545302;4722.64580156488;4767.1657459944545;4328.156009578126;4387;4445.422095127629;4483.215437298476;4496.100779844028;4184.351425529047;4454.13144436835;4465.129299786543;4471.39636149119;4486.910261794778;4257.552956939508;4276.743395396255;4290.7985763986135;4312.266914624522;4392.407025051641;4338.652907767371;4360.607545320905;4380.102079073782;4418.1384629997165;4448.510663826976;4415.315626077963;4427.977860110679;4429.867103986886;4440;4452.799624016927;4625.352450656911;4636.513166117543;4656.511066338054;4662.067586482717;4777.378940737716;5050.823221187277;5061.44324124346;5077.946579287069;5080.060188865072;5083.593312535026;5038.546530812245;5050.545450909399;5095.898082038376;5110.029094472038;5145.30538377318;4731.124741922721;4746.905061898778;4783.928241076386;4784.473707892129;4786.569208771228;5203.271541984125;5210.7915683373;5231.084560201949;5233.084210263265;5263.6315457918345;4936.2102063669645;4974;4980.900381992412;5005.299258103868;5005.649604527721;5062.240663900371;5075.56857667095;5078.035173317058;5079.187330027178;5113.258577506241;4896.559309662148;4973.701577905337;4980.9252861207115;5016.423111342242;5036.471170527042;4853.296272040534;4854.514548545118;4881.4630390657;4969.503049695001;4983.825566105242;4146.37804329347;4182.477190351206;4214.220369231641;4234.491860976703;4235.02594403289;3710.4805327254207;3712.238991006891;3712.777233366007;3743.3262012837404;3750.5124333836425;4394.494633117169;4479.865604031885;4488.685791994529;4499.167653984024;4526.366308716782;5076;5152.4847515248175;5154.020736060136;5162.174052151638;5173.120569503193;4516.525764794715;4518.299663552155;4526.030874173364;4535.501094879561;4570.702904311209;4411.867643970686;4448.955510444919;4575.496695363508;4587.816487340536;4611.400517932714;4755.167845627001;4761.642876784255;4790.209615413488;4801.063792560417;4801.975990120027;5061.443241243386;5062.417821950376;5065.848024559269;5083.135866902561;5106.361704786902;4709.693869898446;4769.117713223065;4776.42682878043;4788.473267940454;4840.394950631171;4998.550130488274;5009.624278179078;5018.573421259234;5036.093503169464;5089.262057001788;5060.165072762953;5097.821576244962;5102.923456148086;5109.284700141909;5120.590352771695;4904.043711476371;4920.040592084652;4944.728039957693;4954.529319714621;4990.975045124751;4842.7820748065715;4865.343178670976;4887.169181239269;4906.681065730716;4940.036692845005;4847.587955023862;4857.077155340474;4876.487968763229;4877.268409738567;4924.7537623119415;4825.831095911626;4955.45489996093;4969.499029627381;4971.726555039508;4990.201567749143;4888.877778055577;4908.533689299511;4941.160002799461;4949.430815456269;5006.949930500648 04:28:23 INFO - PROCESS | 19908 | |1;ext.html;543.2589186517383;577.4369989260471;580.2196046317703;580.5413723158705;607.5838050935107;34010.829945850266;39263.60736392635;39339.40990885132;39390.60609393905;39507.20985580287;39817.20365592687;39993;40449.15733005367;40456;40503.392449113286;7623.504472209303;7741.264579864904;7800.648970796327;7811.453198276123;7812.570308633023;7690.346320562731;7774.067111946574;7782.922170778276;7786.8442631147345;7791.298783109547;7710.113336966237;7734.961325193366;7773.650185741627;7792.80517987052;7803.219678032208;7677.654505547263;7702.922970770276;7725;7727.72952946647;7737.845243095163;7678.424118191102;7764.805879853049;7806.258405451473;7809;7824.217578242187;29525.704742952727;36549.63450365489;36648.63351366479;36670.633293666986;36790.81604591987;2921.6640086390125;3084.98457507711;3253.381857447101;3291.53918451417;3490.336836001152;27818.3045423864;30513.084607461813;30621.693783062106;30636.38727225465;31185.844070779727;3542.2384187399575;3569.7679650822615;3593.964060359389;3616.222512159872;3631.7276204284785;104128.47935760349;105343.47328263386;105566;105659;105874.47062764714;58765;58985.41014589799;59224;59245;59325.703371482865;34177;35284;35300.29399411997;37088.25823483515;37349.626503735155;13823.51617693376;13839.238841863593;13861.376238069312;13868.93065534666;13882.51411200603;11161.441927903736;11175.050120739666;11198.720031999264;11240.325580465198;11261.198208286634;19481.31815386483;19686;19810.90094549518;19824.306149284996;19858;7583.924160758432;7586.431017673696;7660.502067365604;7723.7682869514;7729.536227826348;808.7290757596271;955.8900726416412;979.5494072726483;1018.6791160784477;1037.8806437259661;27741.167764967082;27996.72003279941;28419;29885.701142988728;32062;972.9854052189223;1001.6344034427527;1029.2023681646633;1042.62465512417;1065.5950738719237;14245;14523.564293071226;14525.636859078397;14573;14843.554693359216;382719;386611;390197;391202;392490;47530.28704569434;48904.26643600349;48939.26591101136;49026.75486622544;49079.26381104286;1222.54765736678;1226.9141160118884;1240.528599132342;1245.5329251530677;1261.6530454125188;26745.732542674323;27061.729382706708;27746.861265693544;27816.16551503458;27964.720352796212;42666.57333426626;43757.78121109374;43817.780911095244;43849.34225986677;43898.341524876516;277410;277539;278353;278728;341912;25131.371715707253;25318.620220696335;26391.736082638927;26476.338091547866;27574.310642234104;42281.365779513944;42315;42905.14189716251;43150.35274470948;43765.78117109394;35769;36508.81745591255;36529.63470365262;36887.81556092203;36930.07674808151;34054.65945340614;36424;36589.26821463609;36846.26307473782;37331;36367.27265454623;36393.454098189075;36429;36520;36587.63412365949;32602.673973259964;33483.33033339271;33498.33003339968;33690;33692.49461258034;25196;25680.229593112235;25855.095071673153;26103.869480652476;26330.341741456617 04:28:23 INFO - PROCESS | 19908 | |2;jquery.html;347.31232160322577;356.2945368171021;356.29631477831276;368.3020675819324;370.5701386391784;15484.303206355713;15920.601984950383;16922.492325230232;17023.744643830338;17025.148742562884;14589.9787014909;15277.465288714897;15544.611384715388;15601.14193719345;15644.765328520081;4888.706677599338;4961.280614310923;5266.92099618506;5273.815416460425;5349.170878513817;5189.792408303663;5227.79088836446;5245.921311180336;5252.973735131319;5528.032594295983;5476.67139971601;5496.945030549703;5501.119820828668;5512.944870551303;5514.80698175564;5208.270842082093;5401.3248343957;5410.48600382963;5480.232767412565;5499.477549632798;5217.817376391846;5219.42586315505;5222.895542089175;5246.632735708502;5258.710770907599;11574.421278936019;11678.824817627743;12312.630621081382;12360.25838449696;12416.379181041002;1906.5805522784965;1926.6532024235632;1930;2019.0409555461185;2036.431947400508;8999.19007289347;9034.32242581809;9348.672796452092;9432.292578056673;9497.335186536946;1777.919993600278;1823.188681036939;1837.7151541511087;1856.9814301856943;1863.7297591849242;69247.3075269251;70633.64683176551;71317.28682713158;71406.64296678535;71444.6427767863;9792.265580081379;9803.754906127262;10002.099811017044;10038.64864729731;10127.7468063299;13875.098118622258;13896.861031389557;13901.235432051335;13988.300584970913;14016.789748153786;6887.827804304832;6960.338767817049;7055.647217639097;7119.00333953247;7123.358897699232;6549.574277671936;6571.408573228432;6606.6036037837885;6699.698513566901;6726.260111387744;4257.6168144867115;4308.89227769302;4323.200207961537;4386;4415.889602759957;1747.6329970706295;1802.8016918138994;1821.3716267887557;1830.9359172428901;1854.8145185481344;861.5950503263456;869.2350731356366;932.8647346134773;936.0047846889979;974.605284859633;16284.430044948607;16720;17022.148892555324;17038.914805425895;17156.828431715774;846.4032856835915;850.7958090058341;859.4370687199894;865.16079402979;878.8769572259889;9423.38747981379;9537.761555961157;9749.07383798538;9769.655282732094;9778.168855647207;404102;408027;412910;414255;414352;49874.501254987714;68850.31149688539;71639.6418017917;79170;79296;897.7531178925848;902.0843843498853;957.095544710256;977.6040703515088;979.8285300072458;15869.682606347578;15891.205439728199;16000.839991599934;16110.919445403168;16252;36280.81859590685;37924;38154.42768358421;38305.80847095747;39458.60541394549;45166;46606.06787864291;47426.288605670255;52800.20799688085;53928.46071539234;7518.248175182438;7604.923950760643;7665.425093117927;7806.804829879298;8114.918850811417;9844.852327215242;12163.75672486563;12228.144029917821;12258.448369823202;12419.75160496803;9230.584623691815;9574.329796914428;9661.178799802095;10219.386836789816;10581;4953.876153096201;8999.830022097085;9267.490288034223;9760.755981100529;9983.650572229937;7563.016807814949;9697.32118751709;9744.902550974399;10037.44794036335;10257.435841028815;7197.748078817216;7240.710371585288;7265.164506081868;7620.618969051636;7781.5331080135375;9023.729288121367;10058.798824023625;10183.796324073624;10199.796004080024;10257.33327333721 04:28:23 INFO - PROCESS | 19908 | |3;mootools.html;1377.4283672276006;1402.5231421316753;1504.7441934871072;1680.563053606062;1690.822463641317;6683.69923353449;7363.5213711108745;7447.4786764926475;7886.093099293583;7916.604169791509;7520.661570229339;7638.274363935418;7726.536407815535;7729.690812367498;7753.340966017895;2131.3605918224507;2163.4158777130165;2167;2167.4039639099215;2168.945776355588;2133.040131940625;2174.652055671093;2181.923632672857;2189.069645400706;2197.890105494727;2155.2348916134783;2168.078566609193;2170.370592528165;2179.2372669565684;2180.2587120379067;2017.213286818142;2029.9492512687227;2033.2680235115272;2033.5424529480897;2035.9694604580943;2046.8669536480081;2073.807560652631;2079.6984437256665;2081.6149012432747;2139.2619546256515;7694.807629809244;7732.45872788905;7732.961335193288;7737.264959828807;7737.994060772064;4388.210122178007;4536.841210557614;4548.317752337143;4555.498895121534;4559.886002849922;2763.309172706823;2823.322402623376;2888.277930517371;2902.7968042237053;2921.941561168786;909.9772505687345;931.0875342164717;944.0889541592328;948.8102379524123;959.8800149981253;10344.482775861177;10400.583976640924;10408.635697750618;10411.323263987817;10421.114205292559;3958.5447673517915;4062.7968601569805;4065.593440655911;4123.546409894909;4130.215259100762;8953;8973.237274831581;8985.056569060154;9012.504312262758;9027.864582031143;4456.665750068758;4543.772811359485;4557.08858228349;4571.1543364477675;4578.450585929643;3555.6088830228655;4082.3672330788777;4113.506379234511;4184;4223.936640950388;3655.4151335786146;3679.576848662438;3724.5902950675404;3775.2826962876966;3811.9237615248094;1164.8019836627793;1177.7232350397649;1188.8989435898045;1200.9279443233434;1209.0448545649015;710.3535782437957;762.5615271219071;826.5247482697353;845.1675100026468;847.8516259654535;5270.525652691276;5283;5294.682319060792;5308.0710875596615;5359.705216213068;410.1202919737147;411.1612310885819;416.0763105904886;416.1552049339845;421.1198594936597;3438.381091403571;3573.8391772370305;3577.499150118985;3602.8919132426067;3638.9636103639154;9358.906410935939;9730.610775568897;9808.068233517804;9830.852537211947;9841.803163936682;9437.811243775086;9596.376235544667;9640.855387169198;9646.614135434504;9655.275854310954;7305.488615796843;7404.74083407089;7435.925640743631;7438;7458.2541745826065;5061.645684802176;5089.211172268304;5131.179011358165;5179.533841954242;5233.293505376725;9050.366474346733;9071.773205669648;9074.818503629758;9144.177024067865;9204.079592041011;8252.133525979925;8512;8583.313334933066;8815.823683526165;8820.603072861864;5975.462208401264;6692.498062645223;6838.589684618939;6859.416949559144;6966.3730264276455;7678.232176782277;7694.961525192338;7730.072391313079;7772.961135194288;7783.610819459118;6659.733610655519;6700.329967003261;6738.898916516354;6786.253512113565;6994.860102798018;6643.60138391698;6681.532292739462;6684.532082754355;6757.155355580552;6813.420859226823;5829.15477255804;6408;6465.127207826883;6476.935230647821;6486.675666216576;4447.73313601185;4452.532484089124;4561.771911404483;4566.360709500739;4583.610393116623;4182.2681030820095;4254.340577210537;4261.815786979065;4311.353297005474;4381.802818873222 04:28:23 INFO - PROCESS | 19908 | |4;prototype.html;276.65280073507745;279.6699894124933;282.1015067011568;285.67718478119724;287.17151019309284;4905.484924082969;4949.975250123744;4957.256411538271;4971.204607262839;4978.701277923323;4850.830220942268;4868.853934381966;4876.146674331995;4908.141075311824;4908.950910490894;3561.501389805423;3694.4458331250257;3799.3731034379293;3806.467094606757;3813.7711737295713;3788.3181027415194;3807.95281297644;3810.73324867258;3814.809259537026;3822.5153650127363;3781.413880848459;3788.867389641363;3790.9431358529646;3797.7531460454984;3799.4680744695765;3536.752427330088;3759.2669429461266;3782.602826703198;3791.50710407648;3809.638084381993;3222.726068284199;3226.935461290761;3229.5963004624423;3232.9838350808095;3236.72487838534;4639.260277395976;4641.907161856744;4647.744374059425;4648;4670.206064968964;4279.058607106432;4286.292761694348;4286.699931004831;4287.8284868605215;4299.247631664446;5005.724685142316;5016.849494515171;5066.164082926312;5080;5082.161443361841;3530.117470632342;3532.258225772591;3536.408616122755;3537.0626783902285;3547.5033495310417;5309.327561818053;5351.812686555952;5352.384475785296;5352.437994010612;5364.927014597096;3489.668481494254;3551.94672079919;3564.287142571496;3575.910602234965;3578.1054736315923;3561.1453251220037;3568.286342731464;3583.9820800895827;3600.5139306193328;3602.7838329700303;4143.129942712004;4148.79256037197;4162.334026555797;4191.224623444611;4198.160367926427;5009.472111006178;5094.286799848024;5124.052859913284;5134.358205224347;5138.691678499302;1248.182440501473;1258.5091814192472;1264.20986883198;1264.2793607643555;1265.4432049898016;788.113372455987;789.4079440419686;791.9049714034353;813.507827764206;818.4557269415772;4486.170058539181;4557.612602928722;4569.1547063793305;4582.5417458253905;4615.792289346988;5227.895442091137;5232.502912223333;5245.554127899171;5247.553957913544;5298.860744939857;4457.732536047847;4608.677392582554;4613.792379342871;4614.700044497097;4621.382516119332;2794.986025069902;2803.4393121375806;2817.3520090378915;2826.7314605112483;2830.7735381169455;5021.59827213822;5027.698338099725;5032.622553308516;5037.463573610011;5039.79840806371;5168.113638521912;5411.540019098342;5419.566434685215;5425.965263026365;5428.2900886221505;5015.498450155028;5040.59675225981;5040.697558146523;5041.470645582161;5051.848444546669;5276.604254680991;5285.524302812765;5292.391374991926;5305.363356397257;5312.362516498045;4943.431505376784;5204;5205;5210.635255532228;5233.7383130842545;5033.874153146055;5054.9494505055945;5070.4929507049;5077.365329333833;5088.651507350629;3591.3356029133647;3650.4889315496384;3657.1771351445714;3662.5788034376387;3663.9450408243365;5151.845444636667;5261.868453288698;5288.65623734456;5332.613520484624;5353.304070470969;5111.948880511147;5135.589152867687;5137.434882162885;5149.716765577929;5170.1727723564045;5114.923276150935;5128.974205158908;5134.639320580124;5170.2597623259735;5178.689278643294;4944.728039957693;5023.02051100032;5079.492050794891;5083.542481176712;5084.9745751271;4953.826616068421;5107.897842043212;5147.510986456281;5188.351456067991;5203.947960520346;4960.280759289955;5061.772220250024;5078.568321692697;5106.336176297058;5113.821016264413 04:28:23 INFO - PROCESS | 19908 | |5;yui.html;702.9156501219851;717.9482058783881;720.4956530428694;722.7181399254291;748.5695724958149;12797.168184068028;13132.540361087364;13435.126716763416;13482.258475783829;13526.932365338173;12599.937000314985;12673.176243544187;12786.744265114716;12788.808167877489;12856.67858303543;614.5790133758379;763.9083310002808;773.5706682791049;778.5367706214821;780.9219078092202;774.1059076766315;776.8795836645329;780.2197802197802;780.3445106110865;782.495290537603;823.127484866041;828.1345993436843;828.3373301358919;832.6169961817571;833.6207025803275;819.5779173725506;820.6430202861744;821.5276216175723;824.295227580416;826.0376661189707;599.1791245992974;602.3223873142714;603.6408337039454;604.9727762250709;606.5693357716027;12293.446794894251;12384;12400.62798116058;12447.502099915993;12555.811662825065;12827.230366178059;13155.408006639724;13393.19640821544;13461.730765384638;13508.864911350956;10256.743581410525;10284.485775711184;10288.79422411555;10381.532831022621;10509.159267258601;3383.4924761285756;3413.2832105257926;3424.7945123292684;3455.8617655293756;3531.788092714445;55993.76024959038;56196.157057644166;57189.714051429895;59189.40810591882;60333.396666033215;10442.843357349646;10538.104261137889;10542.42016689074;10545.525451354708;10551.1417578573;19290.903545482182;19292.710609340873;19321;19333.90333048326;19350.225990960203;6723.394894459522;6732.764353247613;6750.223724271772;6797.966010169917;6816.352446517573;3200.3279311344877;3236.3203727217547;3271.3457308538386;3276.737860971117;3394.321135772855;2673.492036513095;2737.8494182819736;2751.3534319434916;2763.737444942727;2789.1353680359152;482.27176962786444;482.4524165072598;483.7702091506506;488.0531768369352;496.82362761219247;534.5723421262974;556.1740814889886;586.2320360327984;609.9542534309855;618.3754408047814;7897.210278972172;8004.959975200087;8021.959890200512;8279.95860020696;8285.751427457186;496.6721963504142;575.7754475754459;578.4319057106578;597.6175247841385;599.6881621556853;4032.495938007749;4059.4722686050623;4075.612816782401;4149.854755083557;4214.7471151731;77138;77898;78492.60753696195;79129.60435197788;89307;70462.64768676124;73993.63003185057;81261.59369203234;82236.17763822405;83477.58261208655;47807;50862.23706644403;74602.6269868658;75659.62170189223;77605.22394776093;8501.489910605384;8729.956350218208;8780.209781119729;8850.557472126497;8959.955200223958;43475.34786978135;44367.556324436344;44650.77674611606;45330;45767.77116114398;59520.702396489476;63531.682341588;64302;64692;65013.67493162504;11607;11769.058475322125;11785.88214117848;12124.272543647057;12518.561850335194;12390.380480975735;12796.36018199105;12951.28767917736;12978.935105324414;13458.932705336802;11805.586804461802;12059.397030148282;12124.575639852563;12226.141388046955;12330.19853709506;11842.171048026556;12014.279143251084;12307.815382769444;12640.367981601066;12766.74466510646;12055.879441205476;12377.257364558156;12379.071569632493;12398.442070106687;12401.565945191875;9787.119159275699;9965.402075875181;10057.295989280972;10151.54318055704;10272.794544109225;9724.367916085432;9787.070228328297;9800.607975680892;9922.751931201778;9977.900220997697 04:28:23 INFO - PROCESS | 19908 | __end_tp_report 04:28:23 INFO - PROCESS | 19908 | __start_cc_report 04:28:23 INFO - PROCESS | 19908 | _x_x_mozilla_cycle_collect,395 04:28:23 INFO - PROCESS | 19908 | __end_cc_report 04:28:23 INFO - PROCESS | 19908 | __startTimestamp1465471702995__endTimestamp 04:28:23 INFO - PROCESS | 19908 | 04:28:23 INFO - PROCESS | 19908 | ------- Summary: start ------- 04:28:23 INFO - PROCESS | 19908 | Number of tests: 6 04:28:23 INFO - PROCESS | 19908 | 04:28:23 INFO - PROCESS | 19908 | [#0] dojo.html Cycles:165 Average:4692.60 Median:4801.14 stddev:483.43 (10.1%) stddev-sans-first:457.17 04:28:23 INFO - PROCESS | 19908 | Values: 2634.8 2693.0 2693.3 2699.2 2729.4 4655.5 4740.4 4759.3 4795.7 4801.1 4627.4 4702.6 4715.8 4722.6 4767.2 4328.2 4387.0 4445.4 4483.2 4496.1 4184.4 4454.1 4465.1 4471.4 4486.9 4257.6 4276.7 4290.8 4312.3 4392.4 4338.7 4360.6 4380.1 4418.1 4448.5 4415.3 4428.0 4429.9 4440.0 4452.8 4625.4 4636.5 4656.5 4662.1 4777.4 5050.8 5061.4 5077.9 5080.1 5083.6 5038.5 5050.5 5095.9 5110.0 5145.3 4731.1 4746.9 4783.9 4784.5 4786.6 5203.3 5210.8 5231.1 5233.1 5263.6 4936.2 4974.0 4980.9 5005.3 5005.6 5062.2 5075.6 5078.0 5079.2 5113.3 4896.6 4973.7 4980.9 5016.4 5036.5 4853.3 4854.5 4881.5 4969.5 4983.8 4146.4 4182.5 4214.2 4234.5 4235.0 3710.5 3712.2 3712.8 3743.3 3750.5 4394.5 4479.9 4488.7 4499.2 4526.4 5076.0 5152.5 5154.0 5162.2 5173.1 4516.5 4518.3 4526.0 4535.5 4570.7 4411.9 4449.0 4575.5 4587.8 4611.4 4755.2 4761.6 4790.2 4801.1 4802.0 5061.4 5062.4 5065.8 5083.1 5106.4 4709.7 4769.1 4776.4 4788.5 4840.4 4998.6 5009.6 5018.6 5036.1 5089.3 5060.2 5097.8 5102.9 5109.3 5120.6 4904.0 4920.0 4944.7 4954.5 4991.0 4842.8 4865.3 4887.2 4906.7 4940.0 4847.6 4857.1 4876.5 4877.3 4924.8 4825.8 4955.5 4969.5 4971.7 4990.2 4888.9 4908.5 4941.2 4949.4 5006.9 04:28:23 INFO - PROCESS | 19908 | 04:28:23 INFO - PROCESS | 19908 | [#1] ext.html Cycles:180 Average:42402.97 Median:36426.50 stddev:76249.11 (209.3%) stddev-sans-first:76398.24 04:28:23 INFO - PROCESS | 19908 | Values: 543.3 577.4 580.2 580.5 607.6 34010.8 39263.6 39339.4 39390.6 39507.2 39817.2 39993.0 40449.2 40456.0 40503.4 7623.5 7741.3 7800.6 7811.5 7812.6 7690.3 7774.1 7782.9 7786.8 7791.3 7710.1 7735.0 7773.7 7792.8 7803.2 7677.7 7702.9 7725.0 7727.7 7737.8 7678.4 7764.8 7806.3 7809.0 7824.2 29525.7 36549.6 36648.6 36670.6 36790.8 2921.7 3085.0 3253.4 3291.5 3490.3 27818.3 30513.1 30621.7 30636.4 31185.8 3542.2 3569.8 3594.0 3616.2 3631.7 104128.5 105343.5 105566.0 105659.0 105874.5 58765.0 58985.4 59224.0 59245.0 59325.7 34177.0 35284.0 35300.3 37088.3 37349.6 13823.5 13839.2 13861.4 13868.9 13882.5 11161.4 11175.1 11198.7 11240.3 11261.2 19481.3 19686.0 19810.9 19824.3 19858.0 7583.9 7586.4 7660.5 7723.8 7729.5 808.7 955.9 979.5 1018.7 1037.9 27741.2 27996.7 28419.0 29885.7 32062.0 973.0 1001.6 1029.2 1042.6 1065.6 14245.0 14523.6 14525.6 14573.0 14843.6 382719.0 386611.0 390197.0 391202.0 392490.0 47530.3 48904.3 48939.3 49026.8 49079.3 1222.5 1226.9 1240.5 1245.5 1261.7 26745.7 27061.7 27746.9 27816.2 27964.7 42666.6 43757.8 43817.8 43849.3 43898.3 277410.0 277539.0 278353.0 278728.0 341912.0 25131.4 25318.6 26391.7 26476.3 27574.3 42281.4 42315.0 42905.1 43150.4 43765.8 35769.0 36508.8 36529.6 36887.8 36930.1 34054.7 36424.0 36589.3 36846.3 37331.0 36367.3 36393.5 36429.0 36520.0 36587.6 32602.7 33483.3 33498.3 33690.0 33692.5 25196.0 25680.2 25855.1 26103.9 26330.3 04:28:23 INFO - PROCESS | 19908 | 04:28:23 INFO - PROCESS | 19908 | [#2] jquery.html Cycles:180 Average:24336.48 Median:5221.16 stddev:67646.19 (1295.6%) stddev-sans-first:67811.98 04:28:23 INFO - PROCESS | 19908 | Values: 347.3 356.3 356.3 368.3 370.6 15484.3 15920.6 16922.5 17023.7 17025.1 14590.0 15277.5 15544.6 15601.1 15644.8 4888.7 4961.3 5266.9 5273.8 5349.2 5189.8 5227.8 5245.9 5253.0 5528.0 5476.7 5496.9 5501.1 5512.9 5514.8 5208.3 5401.3 5410.5 5480.2 5499.5 5217.8 5219.4 5222.9 5246.6 5258.7 11574.4 11678.8 12312.6 12360.3 12416.4 1906.6 1926.7 1930.0 2019.0 2036.4 8999.2 9034.3 9348.7 9432.3 9497.3 1777.9 1823.2 1837.7 1857.0 1863.7 69247.3 70633.6 71317.3 71406.6 71444.6 9792.3 9803.8 10002.1 10038.6 10127.7 13875.1 13896.9 13901.2 13988.3 14016.8 6887.8 6960.3 7055.6 7119.0 7123.4 6549.6 6571.4 6606.6 6699.7 6726.3 4257.6 4308.9 4323.2 4386.0 4415.9 1747.6 1802.8 1821.4 1830.9 1854.8 861.6 869.2 932.9 936.0 974.6 16284.4 16720.0 17022.1 17038.9 17156.8 846.4 850.8 859.4 865.2 878.9 9423.4 9537.8 9749.1 9769.7 9778.2 404102.0 408027.0 412910.0 414255.0 414352.0 49874.5 68850.3 71639.6 79170.0 79296.0 897.8 902.1 957.1 977.6 979.8 15869.7 15891.2 16000.8 16110.9 16252.0 36280.8 37924.0 38154.4 38305.8 39458.6 45166.0 46606.1 47426.3 52800.2 53928.5 7518.2 7604.9 7665.4 7806.8 8114.9 9844.9 12163.8 12228.1 12258.4 12419.8 9230.6 9574.3 9661.2 10219.4 10581.0 4953.9 8999.8 9267.5 9760.8 9983.7 7563.0 9697.3 9744.9 10037.4 10257.4 7197.7 7240.7 7265.2 7620.6 7781.5 9023.7 10058.8 10183.8 10199.8 10257.3 04:28:23 INFO - PROCESS | 19908 | 04:28:23 INFO - PROCESS | 19908 | [#3] mootools.html Cycles:180 Average:5081.79 Median:5075.43 stddev:2883.28 (56.8%) stddev-sans-first:2877.93 04:28:23 INFO - PROCESS | 19908 | Values: 1377.4 1402.5 1504.7 1680.6 1690.8 6683.7 7363.5 7447.5 7886.1 7916.6 7520.7 7638.3 7726.5 7729.7 7753.3 2131.4 2163.4 2167.0 2167.4 2168.9 2133.0 2174.7 2181.9 2189.1 2197.9 2155.2 2168.1 2170.4 2179.2 2180.3 2017.2 2029.9 2033.3 2033.5 2036.0 2046.9 2073.8 2079.7 2081.6 2139.3 7694.8 7732.5 7733.0 7737.3 7738.0 4388.2 4536.8 4548.3 4555.5 4559.9 2763.3 2823.3 2888.3 2902.8 2921.9 910.0 931.1 944.1 948.8 959.9 10344.5 10400.6 10408.6 10411.3 10421.1 3958.5 4062.8 4065.6 4123.5 4130.2 8953.0 8973.2 8985.1 9012.5 9027.9 4456.7 4543.8 4557.1 4571.2 4578.5 3555.6 4082.4 4113.5 4184.0 4223.9 3655.4 3679.6 3724.6 3775.3 3811.9 1164.8 1177.7 1188.9 1200.9 1209.0 710.4 762.6 826.5 845.2 847.9 5270.5 5283.0 5294.7 5308.1 5359.7 410.1 411.2 416.1 416.2 421.1 3438.4 3573.8 3577.5 3602.9 3639.0 9358.9 9730.6 9808.1 9830.9 9841.8 9437.8 9596.4 9640.9 9646.6 9655.3 7305.5 7404.7 7435.9 7438.0 7458.3 5061.6 5089.2 5131.2 5179.5 5233.3 9050.4 9071.8 9074.8 9144.2 9204.1 8252.1 8512.0 8583.3 8815.8 8820.6 5975.5 6692.5 6838.6 6859.4 6966.4 7678.2 7695.0 7730.1 7773.0 7783.6 6659.7 6700.3 6738.9 6786.3 6994.9 6643.6 6681.5 6684.5 6757.2 6813.4 5829.2 6408.0 6465.1 6476.9 6486.7 4447.7 4452.5 4561.8 4566.4 4583.6 4182.3 4254.3 4261.8 4311.4 4381.8 04:28:23 INFO - PROCESS | 19908 | 04:28:23 INFO - PROCESS | 19908 | [#4] prototype.html Cycles:180 Average:4232.24 Median:4926.19 stddev:1262.89 (25.6%) stddev-sans-first:1231.04 04:28:23 INFO - PROCESS | 19908 | Values: 276.7 279.7 282.1 285.7 287.2 4905.5 4950.0 4957.3 4971.2 4978.7 4850.8 4868.9 4876.1 4908.1 4909.0 3561.5 3694.4 3799.4 3806.5 3813.8 3788.3 3808.0 3810.7 3814.8 3822.5 3781.4 3788.9 3790.9 3797.8 3799.5 3536.8 3759.3 3782.6 3791.5 3809.6 3222.7 3226.9 3229.6 3233.0 3236.7 4639.3 4641.9 4647.7 4648.0 4670.2 4279.1 4286.3 4286.7 4287.8 4299.2 5005.7 5016.8 5066.2 5080.0 5082.2 3530.1 3532.3 3536.4 3537.1 3547.5 5309.3 5351.8 5352.4 5352.4 5364.9 3489.7 3551.9 3564.3 3575.9 3578.1 3561.1 3568.3 3584.0 3600.5 3602.8 4143.1 4148.8 4162.3 4191.2 4198.2 5009.5 5094.3 5124.1 5134.4 5138.7 1248.2 1258.5 1264.2 1264.3 1265.4 788.1 789.4 791.9 813.5 818.5 4486.2 4557.6 4569.2 4582.5 4615.8 5227.9 5232.5 5245.6 5247.6 5298.9 4457.7 4608.7 4613.8 4614.7 4621.4 2795.0 2803.4 2817.4 2826.7 2830.8 5021.6 5027.7 5032.6 5037.5 5039.8 5168.1 5411.5 5419.6 5426.0 5428.3 5015.5 5040.6 5040.7 5041.5 5051.8 5276.6 5285.5 5292.4 5305.4 5312.4 4943.4 5204.0 5205.0 5210.6 5233.7 5033.9 5054.9 5070.5 5077.4 5088.7 3591.3 3650.5 3657.2 3662.6 3663.9 5151.8 5261.9 5288.7 5332.6 5353.3 5111.9 5135.6 5137.4 5149.7 5170.2 5114.9 5129.0 5134.6 5170.3 5178.7 4944.7 5023.0 5079.5 5083.5 5085.0 4953.8 5107.9 5147.5 5188.4 5203.9 4960.3 5061.8 5078.6 5106.3 5113.8 04:28:23 INFO - PROCESS | 19908 | 04:28:23 INFO - PROCESS | 19908 | [#5] yui.html Cycles:180 Average:16850.72 Median:483.11 stddev:22841.32 (4728.0%) stddev-sans-first:22873.21 04:28:23 INFO - PROCESS | 19908 | Values: 702.9 717.9 720.5 722.7 748.6 12797.2 13132.5 13435.1 13482.3 13526.9 12599.9 12673.2 12786.7 12788.8 12856.7 614.6 763.9 773.6 778.5 780.9 774.1 776.9 780.2 780.3 782.5 823.1 828.1 828.3 832.6 833.6 819.6 820.6 821.5 824.3 826.0 599.2 602.3 603.6 605.0 606.6 12293.4 12384.0 12400.6 12447.5 12555.8 12827.2 13155.4 13393.2 13461.7 13508.9 10256.7 10284.5 10288.8 10381.5 10509.2 3383.5 3413.3 3424.8 3455.9 3531.8 55993.8 56196.2 57189.7 59189.4 60333.4 10442.8 10538.1 10542.4 10545.5 10551.1 19290.9 19292.7 19321.0 19333.9 19350.2 6723.4 6732.8 6750.2 6798.0 6816.4 3200.3 3236.3 3271.3 3276.7 3394.3 2673.5 2737.8 2751.4 2763.7 2789.1 482.3 482.5 483.8 488.1 496.8 534.6 556.2 586.2 610.0 618.4 7897.2 8005.0 8022.0 8280.0 8285.8 496.7 575.8 578.4 597.6 599.7 4032.5 4059.5 4075.6 4149.9 4214.7 77138.0 77898.0 78492.6 79129.6 89307.0 70462.6 73993.6 81261.6 82236.2 83477.6 47807.0 50862.2 74602.6 75659.6 77605.2 8501.5 8730.0 8780.2 8850.6 8960.0 43475.3 44367.6 44650.8 45330.0 45767.8 59520.7 63531.7 64302.0 64692.0 65013.7 11607.0 11769.1 11785.9 12124.3 12518.6 12390.4 12796.4 12951.3 12978.9 13458.9 11805.6 12059.4 12124.6 12226.1 12330.2 11842.2 12014.3 12307.8 12640.4 12766.7 12055.9 12377.3 12379.1 12398.4 12401.6 9787.1 9965.4 10057.3 10151.5 10272.8 9724.4 9787.1 9800.6 9922.8 9977.9 04:28:23 INFO - PROCESS | 19908 | -------- Summary: end -------- 04:28:23 INFO - PROCESS | 19908 | 04:28:23 INFO - TEST-INFO | 19908: exit 0 04:28:23 INFO - TEST-OK | dromaeo_css | took 1116833ms 04:28:23 INFO - TEST-START | kraken 04:28:23 INFO - operating with platform_type : linux_ 04:28:23 INFO - Initialising browser for kraken test... 04:28:23 INFO - TEST-INFO | started process 20147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO95jaC/profile http://localhost:54145/getInfo.html) 04:28:29 INFO - PROCESS | 20147 | __metrics Screen width/height:1600/1200 04:28:29 INFO - PROCESS | 20147 | colorDepth:24 04:28:29 INFO - PROCESS | 20147 | Browser inner width/height: 1024/697 04:28:29 INFO - PROCESS | 20147 | __metrics 04:28:30 ERROR - PROCESS | 20147 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:28:30 INFO - TEST-INFO | 20147: exit 0 04:28:30 INFO - Browser initialized. 04:28:30 INFO - Running cycle 1/1 for kraken test... 04:28:30 INFO - TEST-INFO | started process 20265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO95jaC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:42 INFO - PROCESS | 20265 | RSS: Main: 168050688 04:28:42 INFO - PROCESS | 20265 | 04:28:45 INFO - PROCESS | 20265 | Cycle 1(1): loaded http://localhost:54145/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54145/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:46 INFO - PROCESS | 20265 | RSS: Main: 173125632 04:28:46 INFO - PROCESS | 20265 | 04:28:49 INFO - PROCESS | 20265 | Cycle 1(1): loaded http://localhost:54145/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54145/tests/kraken/driver.html?testName=audio-dft) 04:28:50 INFO - PROCESS | 20265 | RSS: Main: 172363776 04:28:50 INFO - PROCESS | 20265 | 04:28:52 INFO - PROCESS | 20265 | Cycle 1(1): loaded http://localhost:54145/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54145/tests/kraken/driver.html?testName=audio-fft) 04:28:53 INFO - PROCESS | 20265 | RSS: Main: 168304640 04:28:53 INFO - PROCESS | 20265 | 04:28:55 INFO - PROCESS | 20265 | Cycle 1(1): loaded http://localhost:54145/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54145/tests/kraken/driver.html?testName=audio-oscillator) 04:28:56 INFO - PROCESS | 20265 | RSS: Main: 169181184 04:28:56 INFO - PROCESS | 20265 | 04:28:58 INFO - PROCESS | 20265 | Cycle 1(1): loaded http://localhost:54145/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54145/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:59 INFO - PROCESS | 20265 | RSS: Main: 169308160 04:28:59 INFO - PROCESS | 20265 | 04:29:02 INFO - PROCESS | 20265 | Cycle 1(1): loaded http://localhost:54145/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54145/tests/kraken/driver.html?testName=imaging-darkroom) 04:29:03 INFO - PROCESS | 20265 | RSS: Main: 169721856 04:29:03 INFO - PROCESS | 20265 | 04:29:06 INFO - PROCESS | 20265 | Cycle 1(1): loaded http://localhost:54145/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54145/tests/kraken/driver.html?testName=imaging-desaturate) 04:29:07 INFO - PROCESS | 20265 | RSS: Main: 166555648 04:29:07 INFO - PROCESS | 20265 | 04:29:10 INFO - PROCESS | 20265 | Cycle 1(1): loaded http://localhost:54145/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54145/tests/kraken/driver.html?testName=json-parse-financial) 04:29:10 INFO - PROCESS | 20265 | RSS: Main: 167899136 04:29:10 INFO - PROCESS | 20265 | 04:29:12 INFO - PROCESS | 20265 | Cycle 1(1): loaded http://localhost:54145/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54145/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:29:13 INFO - PROCESS | 20265 | RSS: Main: 168427520 04:29:13 INFO - PROCESS | 20265 | 04:29:15 INFO - PROCESS | 20265 | Cycle 1(1): loaded http://localhost:54145/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54145/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:29:15 INFO - PROCESS | 20265 | RSS: Main: 168710144 04:29:15 INFO - PROCESS | 20265 | 04:29:18 INFO - PROCESS | 20265 | Cycle 1(1): loaded http://localhost:54145/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54145/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:29:18 INFO - PROCESS | 20265 | RSS: Main: 169222144 04:29:18 INFO - PROCESS | 20265 | 04:29:21 INFO - PROCESS | 20265 | Cycle 1(1): loaded http://localhost:54145/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:29:22 INFO - PROCESS | 20265 | RSS: Main: 169619456 04:29:22 INFO - PROCESS | 20265 | 04:29:25 INFO - PROCESS | 20265 | Cycle 1(1): loaded http://localhost:54145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:25 INFO - PROCESS | 20265 | RSS: Main: 169492480 04:29:25 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | Cycle 1(1): loaded http://localhost:54145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54145/tests/kraken/driver.html?testName=ai-astar) 04:29:27 INFO - PROCESS | 20265 | RSS: Main: 170127360 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | __start_tp_report 04:29:27 INFO - PROCESS | 20265 | _x_x_mozilla_page_load 04:29:27 INFO - PROCESS | 20265 | _x_x_mozilla_page_load_details 04:29:27 INFO - PROCESS | 20265 | |i|pagename|runs| 04:29:27 INFO - PROCESS | 20265 | |0;ai-astar;114;109;112;114;115;114;113;115;116;115 04:29:27 INFO - PROCESS | 20265 | |1;audio-beat-detection;155;136;157;190;133;164;165;133;204;131 04:29:27 INFO - PROCESS | 20265 | |2;audio-dft;162;162;164;176;162;169;163;163;162;163 04:29:27 INFO - PROCESS | 20265 | |3;audio-fft;77;77;77;160;77;76;76;76;175;77 04:29:27 INFO - PROCESS | 20265 | |4;audio-oscillator;86;85;149;87;88;86;133;87;91;128 04:29:27 INFO - PROCESS | 20265 | |5;imaging-gaussian-blur;118;118;117;117;118;118;119;120;119;119 04:29:27 INFO - PROCESS | 20265 | |6;imaging-darkroom;148;149;149;149;147;149;148;150;150;148 04:29:27 INFO - PROCESS | 20265 | |7;imaging-desaturate;95;96;96;96;95;96;96;95;95;96 04:29:27 INFO - PROCESS | 20265 | |8;json-parse-financial;64;63;64;64;65;64;65;64;63;64 04:29:27 INFO - PROCESS | 20265 | |9;json-stringify-tinderbox;65;66;66;65;66;65;65;64;66;66 04:29:27 INFO - PROCESS | 20265 | |10;stanford-crypto-aes;85;86;88;87;86;89;85;85;109;87 04:29:27 INFO - PROCESS | 20265 | |11;stanford-crypto-ccm;137;141;140;133;133;132;142;139;143;137 04:29:27 INFO - PROCESS | 20265 | |12;stanford-crypto-pbkdf2;170;182;167;174;170;168;168;171;167;168 04:29:27 INFO - PROCESS | 20265 | |13;stanford-crypto-sha256-iterative;68;71;68;70;68;69;73;68;66;67 04:29:27 INFO - PROCESS | 20265 | __end_tp_report 04:29:27 INFO - PROCESS | 20265 | __start_cc_report 04:29:27 INFO - PROCESS | 20265 | _x_x_mozilla_cycle_collect,1002 04:29:27 INFO - PROCESS | 20265 | __end_cc_report 04:29:27 INFO - PROCESS | 20265 | __startTimestamp1465471767745__endTimestamp 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | ------- Summary: start ------- 04:29:27 INFO - PROCESS | 20265 | Number of tests: 14 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.50 stddev:2.00 (1.7%) stddev-sans-first:2.12 04:29:27 INFO - PROCESS | 20265 | Values: 114.0 109.0 112.0 114.0 115.0 114.0 113.0 115.0 116.0 115.0 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | [#1] audio-beat-detection Cycles:10 Average:156.80 Median:160.50 stddev:25.13 (15.7%) stddev-sans-first:26.65 04:29:27 INFO - PROCESS | 20265 | Values: 155.0 136.0 157.0 190.0 133.0 164.0 165.0 133.0 204.0 131.0 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | [#2] audio-dft Cycles:10 Average:164.60 Median:163.00 stddev:4.53 (2.8%) stddev-sans-first:4.70 04:29:27 INFO - PROCESS | 20265 | Values: 162.0 162.0 164.0 176.0 162.0 169.0 163.0 163.0 162.0 163.0 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | [#3] audio-fft Cycles:10 Average:94.80 Median:77.00 stddev:38.48 (50.0%) stddev-sans-first:40.27 04:29:27 INFO - PROCESS | 20265 | Values: 77.0 77.0 77.0 160.0 77.0 76.0 76.0 76.0 175.0 77.0 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:86.50 stddev:24.53 (28.4%) stddev-sans-first:25.32 04:29:27 INFO - PROCESS | 20265 | Values: 86.0 85.0 149.0 87.0 88.0 86.0 133.0 87.0 91.0 128.0 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.50 stddev:0.95 (0.8%) stddev-sans-first:1.00 04:29:27 INFO - PROCESS | 20265 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 119.0 120.0 119.0 119.0 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 04:29:27 INFO - PROCESS | 20265 | Values: 148.0 149.0 149.0 149.0 147.0 149.0 148.0 150.0 150.0 148.0 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:29:27 INFO - PROCESS | 20265 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 04:29:27 INFO - PROCESS | 20265 | Values: 64.0 63.0 64.0 64.0 65.0 64.0 65.0 64.0 63.0 64.0 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 04:29:27 INFO - PROCESS | 20265 | Values: 65.0 66.0 66.0 65.0 66.0 65.0 65.0 64.0 66.0 66.0 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:86.50 stddev:7.26 (8.4%) stddev-sans-first:7.57 04:29:27 INFO - PROCESS | 20265 | Values: 85.0 86.0 88.0 87.0 86.0 89.0 85.0 85.0 109.0 87.0 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:139.50 stddev:3.97 (2.8%) stddev-sans-first:4.21 04:29:27 INFO - PROCESS | 20265 | Values: 137.0 141.0 140.0 133.0 133.0 132.0 142.0 139.0 143.0 137.0 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:170.00 stddev:4.58 (2.7%) stddev-sans-first:4.85 04:29:27 INFO - PROCESS | 20265 | Values: 170.0 182.0 167.0 174.0 170.0 168.0 168.0 171.0 167.0 168.0 04:29:27 INFO - PROCESS | 20265 | 04:29:27 INFO - PROCESS | 20265 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:2.04 (3.0%) stddev-sans-first:2.15 04:29:27 INFO - PROCESS | 20265 | Values: 68.0 71.0 68.0 70.0 68.0 69.0 73.0 68.0 66.0 67.0 04:29:27 INFO - PROCESS | 20265 | -------- Summary: end -------- 04:29:27 INFO - PROCESS | 20265 | 04:29:28 INFO - TEST-INFO | 20265: exit 0 04:29:28 INFO - TEST-OK | kraken | took 65108ms 04:29:28 INFO - SUITE-END | took 1181s 04:29:28 INFO - Completed test suite (00:19:41) 04:29:28 INFO - javascript benchmark 04:29:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6319.319445148489, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2634.841909485431, 2693.0305090167535, 2693.259353677737, 2699.1767510909167, 2729.3995321029365, 4655.511171327008, 4740.431148262209, 4759.262314341274, 4795.712257264567, 4801.135795556803, 4627.4447066352, 4702.647301452388, 4715.811367545302, 4722.64580156488, 4767.1657459944545, 4328.156009578126, 4387.0, 4445.422095127629, 4483.215437298476, 4496.100779844028, 4184.351425529047, 4454.13144436835, 4465.129299786543, 4471.39636149119, 4486.910261794778, 4257.552956939508, 4276.743395396255, 4290.7985763986135, 4312.266914624522, 4392.407025051641, 4338.652907767371, 4360.607545320905, 4380.102079073782, 4418.1384629997165, 4448.510663826976, 4415.315626077963, 4427.977860110679, 4429.867103986886, 4440.0, 4452.799624016927, 4625.352450656911, 4636.513166117543, 4656.511066338054, 4662.067586482717, 4777.378940737716, 5050.823221187277, 5061.44324124346, 5077.946579287069, 5080.060188865072, 5083.593312535026, 5038.546530812245, 5050.545450909399, 5095.898082038376, 5110.029094472038, 5145.30538377318, 4731.124741922721, 4746.905061898778, 4783.928241076386, 4784.473707892129, 4786.569208771228, 5203.271541984125, 5210.7915683373, 5231.084560201949, 5233.084210263265, 5263.6315457918345, 4936.2102063669645, 4974.0, 4980.900381992412, 5005.299258103868, 5005.649604527721, 5062.240663900371, 5075.56857667095, 5078.035173317058, 5079.187330027178, 5113.258577506241, 4896.559309662148, 4973.701577905337, 4980.9252861207115, 5016.423111342242, 5036.471170527042, 4853.296272040534, 4854.514548545118, 4881.4630390657, 4969.503049695001, 4983.825566105242, 4146.37804329347, 4182.477190351206, 4214.220369231641, 4234.491860976703, 4235.02594403289, 3710.4805327254207, 3712.238991006891, 3712.777233366007, 3743.3262012837404, 3750.5124333836425, 4394.494633117169, 4479.865604031885, 4488.685791994529, 4499.167653984024, 4526.366308716782, 5076.0, 5152.4847515248175, 5154.020736060136, 5162.174052151638, 5173.120569503193, 4516.525764794715, 4518.299663552155, 4526.030874173364, 4535.501094879561, 4570.702904311209, 4411.867643970686, 4448.955510444919, 4575.496695363508, 4587.816487340536, 4611.400517932714, 4755.167845627001, 4761.642876784255, 4790.209615413488, 4801.063792560417, 4801.975990120027, 5061.443241243386, 5062.417821950376, 5065.848024559269, 5083.135866902561, 5106.361704786902, 4709.693869898446, 4769.117713223065, 4776.42682878043, 4788.473267940454, 4840.394950631171, 4998.550130488274, 5009.624278179078, 5018.573421259234, 5036.093503169464, 5089.262057001788, 5060.165072762953, 5097.821576244962, 5102.923456148086, 5109.284700141909, 5120.590352771695, 4904.043711476371, 4920.040592084652, 4944.728039957693, 4954.529319714621, 4990.975045124751, 4842.7820748065715, 4865.343178670976, 4887.169181239269, 4906.681065730716, 4940.036692845005, 4847.587955023862, 4857.077155340474, 4876.487968763229, 4877.268409738567, 4924.7537623119415, 4825.831095911626, 4955.45489996093, 4969.499029627381, 4971.726555039508, 4990.201567749143, 4888.877778055577, 4908.533689299511, 4941.160002799461, 4949.430815456269, 5006.949930500648], "value": 4662.338798928222, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.2589186517383, 577.4369989260471, 580.2196046317703, 580.5413723158705, 607.5838050935107, 34010.829945850266, 39263.60736392635, 39339.40990885132, 39390.60609393905, 39507.20985580287, 39817.20365592687, 39993.0, 40449.15733005367, 40456.0, 40503.392449113286, 7623.504472209303, 7741.264579864904, 7800.648970796327, 7811.453198276123, 7812.570308633023, 7690.346320562731, 7774.067111946574, 7782.922170778276, 7786.8442631147345, 7791.298783109547, 7710.113336966237, 7734.961325193366, 7773.650185741627, 7792.80517987052, 7803.219678032208, 7677.654505547263, 7702.922970770276, 7725.0, 7727.72952946647, 7737.845243095163, 7678.424118191102, 7764.805879853049, 7806.258405451473, 7809.0, 7824.217578242187, 29525.704742952727, 36549.63450365489, 36648.63351366479, 36670.633293666986, 36790.81604591987, 2921.6640086390125, 3084.98457507711, 3253.381857447101, 3291.53918451417, 3490.336836001152, 27818.3045423864, 30513.084607461813, 30621.693783062106, 30636.38727225465, 31185.844070779727, 3542.2384187399575, 3569.7679650822615, 3593.964060359389, 3616.222512159872, 3631.7276204284785, 104128.47935760349, 105343.47328263386, 105566.0, 105659.0, 105874.47062764714, 58765.0, 58985.41014589799, 59224.0, 59245.0, 59325.703371482865, 34177.0, 35284.0, 35300.29399411997, 37088.25823483515, 37349.626503735155, 13823.51617693376, 13839.238841863593, 13861.376238069312, 13868.93065534666, 13882.51411200603, 11161.441927903736, 11175.050120739666, 11198.720031999264, 11240.325580465198, 11261.198208286634, 19481.31815386483, 19686.0, 19810.90094549518, 19824.306149284996, 19858.0, 7583.924160758432, 7586.431017673696, 7660.502067365604, 7723.7682869514, 7729.536227826348, 808.7290757596271, 955.8900726416412, 979.5494072726483, 1018.6791160784477, 1037.8806437259661, 27741.167764967082, 27996.72003279941, 28419.0, 29885.701142988728, 32062.0, 972.9854052189223, 1001.6344034427527, 1029.2023681646633, 1042.62465512417, 1065.5950738719237, 14245.0, 14523.564293071226, 14525.636859078397, 14573.0, 14843.554693359216, 382719.0, 386611.0, 390197.0, 391202.0, 392490.0, 47530.28704569434, 48904.26643600349, 48939.26591101136, 49026.75486622544, 49079.26381104286, 1222.54765736678, 1226.9141160118884, 1240.528599132342, 1245.5329251530677, 1261.6530454125188, 26745.732542674323, 27061.729382706708, 27746.861265693544, 27816.16551503458, 27964.720352796212, 42666.57333426626, 43757.78121109374, 43817.780911095244, 43849.34225986677, 43898.341524876516, 277410.0, 277539.0, 278353.0, 278728.0, 341912.0, 25131.371715707253, 25318.620220696335, 26391.736082638927, 26476.338091547866, 27574.310642234104, 42281.365779513944, 42315.0, 42905.14189716251, 43150.35274470948, 43765.78117109394, 35769.0, 36508.81745591255, 36529.63470365262, 36887.81556092203, 36930.07674808151, 34054.65945340614, 36424.0, 36589.26821463609, 36846.26307473782, 37331.0, 36367.27265454623, 36393.454098189075, 36429.0, 36520.0, 36587.63412365949, 32602.673973259964, 33483.33033339271, 33498.33003339968, 33690.0, 33692.49461258034, 25196.0, 25680.229593112235, 25855.095071673153, 26103.869480652476, 26330.341741456617], "value": 17122.65047298599, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.31232160322577, 356.2945368171021, 356.29631477831276, 368.3020675819324, 370.5701386391784, 15484.303206355713, 15920.601984950383, 16922.492325230232, 17023.744643830338, 17025.148742562884, 14589.9787014909, 15277.465288714897, 15544.611384715388, 15601.14193719345, 15644.765328520081, 4888.706677599338, 4961.280614310923, 5266.92099618506, 5273.815416460425, 5349.170878513817, 5189.792408303663, 5227.79088836446, 5245.921311180336, 5252.973735131319, 5528.032594295983, 5476.67139971601, 5496.945030549703, 5501.119820828668, 5512.944870551303, 5514.80698175564, 5208.270842082093, 5401.3248343957, 5410.48600382963, 5480.232767412565, 5499.477549632798, 5217.817376391846, 5219.42586315505, 5222.895542089175, 5246.632735708502, 5258.710770907599, 11574.421278936019, 11678.824817627743, 12312.630621081382, 12360.25838449696, 12416.379181041002, 1906.5805522784965, 1926.6532024235632, 1930.0, 2019.0409555461185, 2036.431947400508, 8999.19007289347, 9034.32242581809, 9348.672796452092, 9432.292578056673, 9497.335186536946, 1777.919993600278, 1823.188681036939, 1837.7151541511087, 1856.9814301856943, 1863.7297591849242, 69247.3075269251, 70633.64683176551, 71317.28682713158, 71406.64296678535, 71444.6427767863, 9792.265580081379, 9803.754906127262, 10002.099811017044, 10038.64864729731, 10127.7468063299, 13875.098118622258, 13896.861031389557, 13901.235432051335, 13988.300584970913, 14016.789748153786, 6887.827804304832, 6960.338767817049, 7055.647217639097, 7119.00333953247, 7123.358897699232, 6549.574277671936, 6571.408573228432, 6606.6036037837885, 6699.698513566901, 6726.260111387744, 4257.6168144867115, 4308.89227769302, 4323.200207961537, 4386.0, 4415.889602759957, 1747.6329970706295, 1802.8016918138994, 1821.3716267887557, 1830.9359172428901, 1854.8145185481344, 861.5950503263456, 869.2350731356366, 932.8647346134773, 936.0047846889979, 974.605284859633, 16284.430044948607, 16720.0, 17022.148892555324, 17038.914805425895, 17156.828431715774, 846.4032856835915, 850.7958090058341, 859.4370687199894, 865.16079402979, 878.8769572259889, 9423.38747981379, 9537.761555961157, 9749.07383798538, 9769.655282732094, 9778.168855647207, 404102.0, 408027.0, 412910.0, 414255.0, 414352.0, 49874.501254987714, 68850.31149688539, 71639.6418017917, 79170.0, 79296.0, 897.7531178925848, 902.0843843498853, 957.095544710256, 977.6040703515088, 979.8285300072458, 15869.682606347578, 15891.205439728199, 16000.839991599934, 16110.919445403168, 16252.0, 36280.81859590685, 37924.0, 38154.42768358421, 38305.80847095747, 39458.60541394549, 45166.0, 46606.06787864291, 47426.288605670255, 52800.20799688085, 53928.46071539234, 7518.248175182438, 7604.923950760643, 7665.425093117927, 7806.804829879298, 8114.918850811417, 9844.852327215242, 12163.75672486563, 12228.144029917821, 12258.448369823202, 12419.75160496803, 9230.584623691815, 9574.329796914428, 9661.178799802095, 10219.386836789816, 10581.0, 4953.876153096201, 8999.830022097085, 9267.490288034223, 9760.755981100529, 9983.650572229937, 7563.016807814949, 9697.32118751709, 9744.902550974399, 10037.44794036335, 10257.435841028815, 7197.748078817216, 7240.710371585288, 7265.164506081868, 7620.618969051636, 7781.5331080135375, 9023.729288121367, 10058.798824023625, 10183.796324073624, 10199.796004080024, 10257.33327333721], "value": 7991.7852675645545, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.4283672276006, 1402.5231421316753, 1504.7441934871072, 1680.563053606062, 1690.822463641317, 6683.69923353449, 7363.5213711108745, 7447.4786764926475, 7886.093099293583, 7916.604169791509, 7520.661570229339, 7638.274363935418, 7726.536407815535, 7729.690812367498, 7753.340966017895, 2131.3605918224507, 2163.4158777130165, 2167.0, 2167.4039639099215, 2168.945776355588, 2133.040131940625, 2174.652055671093, 2181.923632672857, 2189.069645400706, 2197.890105494727, 2155.2348916134783, 2168.078566609193, 2170.370592528165, 2179.2372669565684, 2180.2587120379067, 2017.213286818142, 2029.9492512687227, 2033.2680235115272, 2033.5424529480897, 2035.9694604580943, 2046.8669536480081, 2073.807560652631, 2079.6984437256665, 2081.6149012432747, 2139.2619546256515, 7694.807629809244, 7732.45872788905, 7732.961335193288, 7737.264959828807, 7737.994060772064, 4388.210122178007, 4536.841210557614, 4548.317752337143, 4555.498895121534, 4559.886002849922, 2763.309172706823, 2823.322402623376, 2888.277930517371, 2902.7968042237053, 2921.941561168786, 909.9772505687345, 931.0875342164717, 944.0889541592328, 948.8102379524123, 959.8800149981253, 10344.482775861177, 10400.583976640924, 10408.635697750618, 10411.323263987817, 10421.114205292559, 3958.5447673517915, 4062.7968601569805, 4065.593440655911, 4123.546409894909, 4130.215259100762, 8953.0, 8973.237274831581, 8985.056569060154, 9012.504312262758, 9027.864582031143, 4456.665750068758, 4543.772811359485, 4557.08858228349, 4571.1543364477675, 4578.450585929643, 3555.6088830228655, 4082.3672330788777, 4113.506379234511, 4184.0, 4223.936640950388, 3655.4151335786146, 3679.576848662438, 3724.5902950675404, 3775.2826962876966, 3811.9237615248094, 1164.8019836627793, 1177.7232350397649, 1188.8989435898045, 1200.9279443233434, 1209.0448545649015, 710.3535782437957, 762.5615271219071, 826.5247482697353, 845.1675100026468, 847.8516259654535, 5270.525652691276, 5283.0, 5294.682319060792, 5308.0710875596615, 5359.705216213068, 410.1202919737147, 411.1612310885819, 416.0763105904886, 416.1552049339845, 421.1198594936597, 3438.381091403571, 3573.8391772370305, 3577.499150118985, 3602.8919132426067, 3638.9636103639154, 9358.906410935939, 9730.610775568897, 9808.068233517804, 9830.852537211947, 9841.803163936682, 9437.811243775086, 9596.376235544667, 9640.855387169198, 9646.614135434504, 9655.275854310954, 7305.488615796843, 7404.74083407089, 7435.925640743631, 7438.0, 7458.2541745826065, 5061.645684802176, 5089.211172268304, 5131.179011358165, 5179.533841954242, 5233.293505376725, 9050.366474346733, 9071.773205669648, 9074.818503629758, 9144.177024067865, 9204.079592041011, 8252.133525979925, 8512.0, 8583.313334933066, 8815.823683526165, 8820.603072861864, 5975.462208401264, 6692.498062645223, 6838.589684618939, 6859.416949559144, 6966.3730264276455, 7678.232176782277, 7694.961525192338, 7730.072391313079, 7772.961135194288, 7783.610819459118, 6659.733610655519, 6700.329967003261, 6738.898916516354, 6786.253512113565, 6994.860102798018, 6643.60138391698, 6681.532292739462, 6684.532082754355, 6757.155355580552, 6813.420859226823, 5829.15477255804, 6408.0, 6465.127207826883, 6476.935230647821, 6486.675666216576, 4447.73313601185, 4452.532484089124, 4561.771911404483, 4566.360709500739, 4583.610393116623, 4182.2681030820095, 4254.340577210537, 4261.815786979065, 4311.353297005474, 4381.802818873222], "value": 4016.907776788187, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.65280073507745, 279.6699894124933, 282.1015067011568, 285.67718478119724, 287.17151019309284, 4905.484924082969, 4949.975250123744, 4957.256411538271, 4971.204607262839, 4978.701277923323, 4850.830220942268, 4868.853934381966, 4876.146674331995, 4908.141075311824, 4908.950910490894, 3561.501389805423, 3694.4458331250257, 3799.3731034379293, 3806.467094606757, 3813.7711737295713, 3788.3181027415194, 3807.95281297644, 3810.73324867258, 3814.809259537026, 3822.5153650127363, 3781.413880848459, 3788.867389641363, 3790.9431358529646, 3797.7531460454984, 3799.4680744695765, 3536.752427330088, 3759.2669429461266, 3782.602826703198, 3791.50710407648, 3809.638084381993, 3222.726068284199, 3226.935461290761, 3229.5963004624423, 3232.9838350808095, 3236.72487838534, 4639.260277395976, 4641.907161856744, 4647.744374059425, 4648.0, 4670.206064968964, 4279.058607106432, 4286.292761694348, 4286.699931004831, 4287.8284868605215, 4299.247631664446, 5005.724685142316, 5016.849494515171, 5066.164082926312, 5080.0, 5082.161443361841, 3530.117470632342, 3532.258225772591, 3536.408616122755, 3537.0626783902285, 3547.5033495310417, 5309.327561818053, 5351.812686555952, 5352.384475785296, 5352.437994010612, 5364.927014597096, 3489.668481494254, 3551.94672079919, 3564.287142571496, 3575.910602234965, 3578.1054736315923, 3561.1453251220037, 3568.286342731464, 3583.9820800895827, 3600.5139306193328, 3602.7838329700303, 4143.129942712004, 4148.79256037197, 4162.334026555797, 4191.224623444611, 4198.160367926427, 5009.472111006178, 5094.286799848024, 5124.052859913284, 5134.358205224347, 5138.691678499302, 1248.182440501473, 1258.5091814192472, 1264.20986883198, 1264.2793607643555, 1265.4432049898016, 788.113372455987, 789.4079440419686, 791.9049714034353, 813.507827764206, 818.4557269415772, 4486.170058539181, 4557.612602928722, 4569.1547063793305, 4582.5417458253905, 4615.792289346988, 5227.895442091137, 5232.502912223333, 5245.554127899171, 5247.553957913544, 5298.860744939857, 4457.732536047847, 4608.677392582554, 4613.792379342871, 4614.700044497097, 4621.382516119332, 2794.986025069902, 2803.4393121375806, 2817.3520090378915, 2826.7314605112483, 2830.7735381169455, 5021.59827213822, 5027.698338099725, 5032.622553308516, 5037.463573610011, 5039.79840806371, 5168.113638521912, 5411.540019098342, 5419.566434685215, 5425.965263026365, 5428.2900886221505, 5015.498450155028, 5040.59675225981, 5040.697558146523, 5041.470645582161, 5051.848444546669, 5276.604254680991, 5285.524302812765, 5292.391374991926, 5305.363356397257, 5312.362516498045, 4943.431505376784, 5204.0, 5205.0, 5210.635255532228, 5233.7383130842545, 5033.874153146055, 5054.9494505055945, 5070.4929507049, 5077.365329333833, 5088.651507350629, 3591.3356029133647, 3650.4889315496384, 3657.1771351445714, 3662.5788034376387, 3663.9450408243365, 5151.845444636667, 5261.868453288698, 5288.65623734456, 5332.613520484624, 5353.304070470969, 5111.948880511147, 5135.589152867687, 5137.434882162885, 5149.716765577929, 5170.1727723564045, 5114.923276150935, 5128.974205158908, 5134.639320580124, 5170.2597623259735, 5178.689278643294, 4944.728039957693, 5023.02051100032, 5079.492050794891, 5083.542481176712, 5084.9745751271, 4953.826616068421, 5107.897842043212, 5147.510986456281, 5188.351456067991, 5203.947960520346, 4960.280759289955, 5061.772220250024, 5078.568321692697, 5106.336176297058, 5113.821016264413], "value": 3819.66574950021, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.9156501219851, 717.9482058783881, 720.4956530428694, 722.7181399254291, 748.5695724958149, 12797.168184068028, 13132.540361087364, 13435.126716763416, 13482.258475783829, 13526.932365338173, 12599.937000314985, 12673.176243544187, 12786.744265114716, 12788.808167877489, 12856.67858303543, 614.5790133758379, 763.9083310002808, 773.5706682791049, 778.5367706214821, 780.9219078092202, 774.1059076766315, 776.8795836645329, 780.2197802197802, 780.3445106110865, 782.495290537603, 823.127484866041, 828.1345993436843, 828.3373301358919, 832.6169961817571, 833.6207025803275, 819.5779173725506, 820.6430202861744, 821.5276216175723, 824.295227580416, 826.0376661189707, 599.1791245992974, 602.3223873142714, 603.6408337039454, 604.9727762250709, 606.5693357716027, 12293.446794894251, 12384.0, 12400.62798116058, 12447.502099915993, 12555.811662825065, 12827.230366178059, 13155.408006639724, 13393.19640821544, 13461.730765384638, 13508.864911350956, 10256.743581410525, 10284.485775711184, 10288.79422411555, 10381.532831022621, 10509.159267258601, 3383.4924761285756, 3413.2832105257926, 3424.7945123292684, 3455.8617655293756, 3531.788092714445, 55993.76024959038, 56196.157057644166, 57189.714051429895, 59189.40810591882, 60333.396666033215, 10442.843357349646, 10538.104261137889, 10542.42016689074, 10545.525451354708, 10551.1417578573, 19290.903545482182, 19292.710609340873, 19321.0, 19333.90333048326, 19350.225990960203, 6723.394894459522, 6732.764353247613, 6750.223724271772, 6797.966010169917, 6816.352446517573, 3200.3279311344877, 3236.3203727217547, 3271.3457308538386, 3276.737860971117, 3394.321135772855, 2673.492036513095, 2737.8494182819736, 2751.3534319434916, 2763.737444942727, 2789.1353680359152, 482.27176962786444, 482.4524165072598, 483.7702091506506, 488.0531768369352, 496.82362761219247, 534.5723421262974, 556.1740814889886, 586.2320360327984, 609.9542534309855, 618.3754408047814, 7897.210278972172, 8004.959975200087, 8021.959890200512, 8279.95860020696, 8285.751427457186, 496.6721963504142, 575.7754475754459, 578.4319057106578, 597.6175247841385, 599.6881621556853, 4032.495938007749, 4059.4722686050623, 4075.612816782401, 4149.854755083557, 4214.7471151731, 77138.0, 77898.0, 78492.60753696195, 79129.60435197788, 89307.0, 70462.64768676124, 73993.63003185057, 81261.59369203234, 82236.17763822405, 83477.58261208655, 47807.0, 50862.23706644403, 74602.6269868658, 75659.62170189223, 77605.22394776093, 8501.489910605384, 8729.956350218208, 8780.209781119729, 8850.557472126497, 8959.955200223958, 43475.34786978135, 44367.556324436344, 44650.77674611606, 45330.0, 45767.77116114398, 59520.702396489476, 63531.682341588, 64302.0, 64692.0, 65013.67493162504, 11607.0, 11769.058475322125, 11785.88214117848, 12124.272543647057, 12518.561850335194, 12390.380480975735, 12796.36018199105, 12951.28767917736, 12978.935105324414, 13458.932705336802, 11805.586804461802, 12059.397030148282, 12124.575639852563, 12226.141388046955, 12330.19853709506, 11842.171048026556, 12014.279143251084, 12307.815382769444, 12640.367981601066, 12766.74466510646, 12055.879441205476, 12377.257364558156, 12379.071569632493, 12398.442070106687, 12401.565945191875, 9787.119159275699, 9965.402075875181, 10057.295989280972, 10151.54318055704, 10272.794544109225, 9724.367916085432, 9787.070228328297, 9800.607975680892, 9922.751931201778, 9977.900220997697], "value": 6504.844775949776, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 112.0, 114.0, 115.0, 114.0, 113.0, 115.0, 116.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 136.0, 157.0, 190.0, 133.0, 164.0, 165.0, 133.0, 204.0, 131.0], "value": 156.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 176.0, 162.0, 169.0, 163.0, 163.0, 162.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 160.0, 77.0, 76.0, 76.0, 76.0, 175.0, 77.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 149.0, 87.0, 88.0, 86.0, 133.0, 87.0, 91.0, 128.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 119.0, 120.0, 119.0, 119.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 149.0, 147.0, 149.0, 148.0, 150.0, 150.0, 148.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 63.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 64.0, 66.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 88.0, 87.0, 86.0, 89.0, 85.0, 85.0, 109.0, 87.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 141.0, 140.0, 133.0, 133.0, 132.0, 142.0, 139.0, 143.0, 137.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 182.0, 167.0, 174.0, 170.0, 168.0, 168.0, 171.0, 167.0, 168.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 68.0, 70.0, 68.0, 69.0, 73.0, 68.0, 66.0, 67.0], "value": 68.8, "unit": "score"}]}]} 04:29:29 INFO - Return code: 0 04:29:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:29:29 ERROR - # TBPL SUCCESS # 04:29:29 INFO - Running post-action listener: _resource_record_post_action 04:29:29 INFO - ##### 04:29:29 INFO - ##### Finished run-tests step (success) 04:29:29 INFO - ##### 04:29:29 INFO - Running post-run listener: _resource_record_post_run 04:29:29 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407162880; Read time: 12; Write time: 382608 04:29:29 INFO - TinderboxPrint: CPU usage
13.4% 04:29:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:29:29 INFO - TinderboxPrint: I/O write bytes / time
407,162,880 / 382,608 04:29:29 INFO - TinderboxPrint: CPU idle
8,282.5 (86.6%) 04:29:29 INFO - TinderboxPrint: CPU user
1,229.0 (12.8%) 04:29:29 INFO - TinderboxPrint: Swap in / out
0 / 0 04:29:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110903296; Read time: 0; Write time: 115820 04:29:29 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296259584; Read time: 12; Write time: 266788 04:29:29 INFO - Running post-run listener: _upload_blobber_files 04:29:29 INFO - Blob upload gear active. 04:29:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:29:29 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:29:29 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:29:29 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:29:30 INFO - (blobuploader) - INFO - Open directory for files ... 04:29:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:29:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:29:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:33 INFO - (blobuploader) - INFO - Done attempting. 04:29:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:29:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:29:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:34 INFO - (blobuploader) - INFO - Done attempting. 04:29:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:29:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:29:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:35 INFO - (blobuploader) - INFO - Done attempting. 04:29:35 INFO - (blobuploader) - INFO - Iteration through files over. 04:29:35 INFO - Return code: 0 04:29:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:29:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:29:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ad36276654b8d7e1acdb0ee419b07830e8e1af3c1a95a133bee76794613559b529c2dfe46befdfaec9a885b2e7f8c50e8440064cf2323aec0c7236378694994", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33caab20f7b7f31828ed54928aea9a7a285054e91f4cf840bd53dddf4b2d42df85499e6183ab0d30c6efc9330e9254682bc700df20bc1f257e88f7e2aab619e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53bf8aa363d15141ea071f37c77001fc79e64e7c54c05230b7de846dd7fdcf58f70422b17d3336c03f57b8fc9ceb847c52e61a4a714767488b40ee095c580fe9"} 04:29:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:29:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:29:35 INFO - Contents: 04:29:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ad36276654b8d7e1acdb0ee419b07830e8e1af3c1a95a133bee76794613559b529c2dfe46befdfaec9a885b2e7f8c50e8440064cf2323aec0c7236378694994", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33caab20f7b7f31828ed54928aea9a7a285054e91f4cf840bd53dddf4b2d42df85499e6183ab0d30c6efc9330e9254682bc700df20bc1f257e88f7e2aab619e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53bf8aa363d15141ea071f37c77001fc79e64e7c54c05230b7de846dd7fdcf58f70422b17d3336c03f57b8fc9ceb847c52e61a4a714767488b40ee095c580fe9"} 04:29:35 INFO - Running post-run listener: copy_logs_to_upload_dir 04:29:35 INFO - Copying logs to upload dir... 04:29:35 INFO - mkdir: /builds/slave/test/build/upload/logs 04:29:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.662157 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-09 04:29:35.136193) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 04:29:35.139994) ========= 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=eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568 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/4ad36276654b8d7e1acdb0ee419b07830e8e1af3c1a95a133bee76794613559b529c2dfe46befdfaec9a885b2e7f8c50e8440064cf2323aec0c7236378694994", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33caab20f7b7f31828ed54928aea9a7a285054e91f4cf840bd53dddf4b2d42df85499e6183ab0d30c6efc9330e9254682bc700df20bc1f257e88f7e2aab619e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53bf8aa363d15141ea071f37c77001fc79e64e7c54c05230b7de846dd7fdcf58f70422b17d3336c03f57b8fc9ceb847c52e61a4a714767488b40ee095c580fe9"} build_url:https://queue.taskcluster.net/v1/task/V0Pmgq4qSimolC9I12MQ3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011581 build_url: 'https://queue.taskcluster.net/v1/task/V0Pmgq4qSimolC9I12MQ3w/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/4ad36276654b8d7e1acdb0ee419b07830e8e1af3c1a95a133bee76794613559b529c2dfe46befdfaec9a885b2e7f8c50e8440064cf2323aec0c7236378694994", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33caab20f7b7f31828ed54928aea9a7a285054e91f4cf840bd53dddf4b2d42df85499e6183ab0d30c6efc9330e9254682bc700df20bc1f257e88f7e2aab619e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53bf8aa363d15141ea071f37c77001fc79e64e7c54c05230b7de846dd7fdcf58f70422b17d3336c03f57b8fc9ceb847c52e61a4a714767488b40ee095c580fe9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 04:29:35.166367) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:29:35.166726) ========= 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=eca2ab57546de7b41f256b19000001ef-1465470520.875405-1472799568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:29:35.253767) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 04:29:35.254079) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 04:29:35.254367) ========= ========= Total master_lag: 0.19 =========