builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1466253685.62 results: success (0) buildid: 20160618030212 builduid: f232ce6a95344dd2b6d98f8f02a4e347 revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.623383) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.623837) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.624110) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.691934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.692224) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-18 05:41:26-- 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% 224M=0s 2016-06-18 05:41:26 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105534 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.813857) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.814194) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020254 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.863918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.864219) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3ce53bd1e25b93140484d3933c9339a829e0c1eb --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 3ce53bd1e25b93140484d3933c9339a829e0c1eb --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=337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-18 05:41:26,387 truncating revision to first 12 chars 2016-06-18 05:41:26,387 Setting DEBUG logging. 2016-06-18 05:41:26,387 attempt 1/10 2016-06-18 05:41:26,387 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3ce53bd1e25b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-18 05:41:26,696 unpacking tar archive at: mozilla-central-3ce53bd1e25b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:26.535431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:26.535795) ========= script_repo_revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:26.536190) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:26.536453) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:26.549949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-18 05:41:26.550225) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:41:27 INFO - MultiFileLogger online at 20160618 05:41:27 in /builds/slave/test 05:41:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:41:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:41:27 INFO - {'append_to_log': False, 05:41:27 INFO - 'base_work_dir': '/builds/slave/test', 05:41:27 INFO - 'blob_upload_branch': 'Firefox', 05:41:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:41:27 INFO - 'branch': 'Firefox', 05:41:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:41:27 INFO - 'config_files': ('talos/linux_config.py',), 05:41:27 INFO - 'default_actions': ('clobber', 05:41:27 INFO - 'read-buildbot-config', 05:41:27 INFO - 'download-and-extract', 05:41:27 INFO - 'populate-webroot', 05:41:27 INFO - 'create-virtualenv', 05:41:27 INFO - 'install', 05:41:27 INFO - 'run-tests'), 05:41:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:41:27 INFO - 'download_minidump_stackwalk': True, 05:41:27 INFO - 'download_symbols': 'ondemand', 05:41:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:41:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:41:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:41:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:41:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:41:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:41:27 INFO - 'installer_path': 'installer.exe', 05:41:27 INFO - 'log_level': 'info', 05:41:27 INFO - 'log_name': 'talos', 05:41:27 INFO - 'log_to_console': True, 05:41:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:41:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:41:27 INFO - 'opt_config_files': (), 05:41:27 INFO - 'pip_index': False, 05:41:27 INFO - 'sps_profile': False, 05:41:27 INFO - 'sps_profile_interval': 0, 05:41:27 INFO - 'suite': 'dromaeojs', 05:41:27 INFO - 'system_bits': '32', 05:41:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:41:27 INFO - 'title': 'talos-linux64-ix-060', 05:41:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:41:27 INFO - 'use_talos_json': True, 05:41:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:41:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:41:27 INFO - 'work_dir': 'build'} 05:41:27 INFO - ##### 05:41:27 INFO - ##### Running clobber step. 05:41:27 INFO - ##### 05:41:27 INFO - Running pre-action listener: _resource_record_pre_action 05:41:27 INFO - Running main action method: clobber 05:41:27 INFO - rmtree: /builds/slave/test/build 05:41:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:41:28 INFO - Running post-action listener: _resource_record_post_action 05:41:28 INFO - ##### 05:41:28 INFO - ##### Finished clobber step (success) 05:41:28 INFO - ##### 05:41:28 INFO - ##### 05:41:28 INFO - ##### Running read-buildbot-config step. 05:41:28 INFO - ##### 05:41:28 INFO - Running pre-action listener: _resource_record_pre_action 05:41:28 INFO - Running main action method: read_buildbot_config 05:41:28 INFO - Using buildbot properties: 05:41:28 INFO - { 05:41:28 INFO - "project": "", 05:41:28 INFO - "product": "firefox", 05:41:28 INFO - "script_repo_revision": "production", 05:41:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:41:28 INFO - "repository": "", 05:41:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:41:28 INFO - "buildid": "20160618030212", 05:41:28 INFO - "stage_platform": "linux64-pgo", 05:41:28 INFO - "basedir": "/builds/slave/test", 05:41:28 INFO - "nightly_build": "True", 05:41:28 INFO - "buildnumber": 348, 05:41:28 INFO - "slavename": "talos-linux64-ix-060", 05:41:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:41:28 INFO - "platform": "ubuntu64_hw", 05:41:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:41:28 INFO - "branch": "mozilla-central", 05:41:28 INFO - "repo_path": "mozilla-central", 05:41:28 INFO - "revision": "3ce53bd1e25b93140484d3933c9339a829e0c1eb", 05:41:28 INFO - "pgo_build": "True", 05:41:28 INFO - "builduid": "f232ce6a95344dd2b6d98f8f02a4e347", 05:41:28 INFO - "slavebuilddir": "test" 05:41:28 INFO - } 05:41:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:41:28 INFO - Running post-action listener: _resource_record_post_action 05:41:28 INFO - ##### 05:41:28 INFO - ##### Finished read-buildbot-config step (success) 05:41:28 INFO - ##### 05:41:28 INFO - ##### 05:41:28 INFO - ##### Running download-and-extract step. 05:41:28 INFO - ##### 05:41:28 INFO - Running pre-action listener: _resource_record_pre_action 05:41:28 INFO - Running main action method: download_and_extract 05:41:28 INFO - mkdir: /builds/slave/test/build/tests 05:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:28 INFO - https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:41:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/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 05:41:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/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 05:41:28 INFO - Downloaded 1361 bytes. 05:41:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:28 INFO - Using the following test package requirements: 05:41:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:41:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:41:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:41:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'jsshell-linux-x86_64.zip'], 05:41:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:41:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:41:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:41:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:41:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:41:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:41:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:28 INFO - https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:41:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/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 05:41:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/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 05:41:29 INFO - Downloaded 24220863 bytes. 05:41:29 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'] 05:41:29 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 05:41:31 INFO - Return code: 0 05:41:31 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 05:41:31 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')]} 05:41:31 INFO - https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:41:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/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 05:41:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/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 05:41:48 INFO - Downloaded 24220863 bytes. 05:41:48 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'] 05:41:48 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 05:41:49 INFO - Return code: 0 05:41:49 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')]} 05:41:49 INFO - https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:41:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/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 05:41:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/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 05:41:50 INFO - Downloaded 14405384 bytes. 05:41:50 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'] 05:41:50 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 05:41:51 INFO - Return code: 0 05:41:51 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')]} 05:41:51 INFO - https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:41:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/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 05:41:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/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 05:41:52 INFO - Downloaded 60115312 bytes. 05:41:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:52 INFO - mkdir: /builds/slave/test/properties 05:41:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:41:52 INFO - Writing to file /builds/slave/test/properties/build_url 05:41:52 INFO - Contents: 05:41:52 INFO - build_url:https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:53 INFO - Running post-action listener: _resource_record_post_action 05:41:53 INFO - Running post-action listener: set_extra_try_arguments 05:41:53 INFO - ##### 05:41:53 INFO - ##### Finished download-and-extract step (success) 05:41:53 INFO - ##### 05:41:53 INFO - ##### 05:41:53 INFO - ##### Running populate-webroot step. 05:41:53 INFO - ##### 05:41:53 INFO - Running pre-action listener: _resource_record_pre_action 05:41:53 INFO - Running main action method: populate_webroot 05:41:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:41:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:41:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:41:53 INFO - '--tppagecycles', 05:41:53 INFO - '7'], 05:41:53 INFO - 'tests': ['tsvgm']}}, 05:41:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:41:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:41:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:41:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:41:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:41:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:41:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:53 INFO - 'talos_options': ['--disable-e10s'], 05:41:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:53 INFO - 'talos_options': ['--disable-e10s'], 05:41:53 INFO - 'tests': ['damp', 'tps']}, 05:41:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:53 INFO - 'tests': ['damp', 'tps']}, 05:41:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:41:53 INFO - 'tests': ['dromaeo_dom']}, 05:41:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:41:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:41:53 INFO - 'tests': ['basic_compositor_video']}, 05:41:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:41:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:41:53 INFO - 'tests': ['a11yr', 05:41:53 INFO - 'ts_paint', 05:41:53 INFO - 'tpaint', 05:41:53 INFO - 'sessionrestore', 05:41:53 INFO - 'sessionrestore_no_auto_restore', 05:41:53 INFO - 'tabpaint']}, 05:41:53 INFO - 'other-e10s': {'tests': ['a11yr', 05:41:53 INFO - 'ts_paint', 05:41:53 INFO - 'tpaint', 05:41:53 INFO - 'sessionrestore', 05:41:53 INFO - 'sessionrestore_no_auto_restore', 05:41:53 INFO - 'tabpaint']}, 05:41:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:41:53 INFO - 'ts_paint', 05:41:53 INFO - 'tpaint', 05:41:53 INFO - 'sessionrestore', 05:41:53 INFO - 'sessionrestore_no_auto_restore', 05:41:53 INFO - 'tabpaint']}, 05:41:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:41:53 INFO - 'ts_paint', 05:41:53 INFO - 'tpaint', 05:41:53 INFO - 'sessionrestore', 05:41:53 INFO - 'sessionrestore_no_auto_restore', 05:41:53 INFO - 'tabpaint']}, 05:41:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:41:53 INFO - 'tests': ['a11yr', 05:41:53 INFO - 'ts_paint', 05:41:53 INFO - 'tpaint', 05:41:53 INFO - 'sessionrestore', 05:41:53 INFO - 'sessionrestore_no_auto_restore', 05:41:53 INFO - 'tabpaint']}, 05:41:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:41:53 INFO - 'tests': ['a11yr', 05:41:53 INFO - 'ts_paint', 05:41:53 INFO - 'tpaint', 05:41:53 INFO - 'sessionrestore', 05:41:53 INFO - 'sessionrestore_no_auto_restore', 05:41:53 INFO - 'tabpaint']}, 05:41:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:41:53 INFO - 'tests': ['tsvgx', 05:41:53 INFO - 'tsvgr_opacity', 05:41:53 INFO - 'tart', 05:41:53 INFO - 'tscrollx', 05:41:53 INFO - 'cart']}, 05:41:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:41:53 INFO - 'tsvgr_opacity', 05:41:53 INFO - 'tart', 05:41:53 INFO - 'tscrollx', 05:41:53 INFO - 'cart']}, 05:41:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:53 INFO - 'talos_options': ['--disable-e10s'], 05:41:53 INFO - 'tests': ['tp5o']}, 05:41:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:53 INFO - 'tests': ['tp5o']}, 05:41:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:53 INFO - 'talos_options': ['--disable-e10s', 05:41:53 INFO - '--xperf_path', 05:41:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:53 INFO - 'tests': ['tp5n']}, 05:41:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:53 INFO - 'talos_options': ['--xperf_path', 05:41:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:53 INFO - 'tests': ['tp5n']}}, 05:41:53 INFO - 'talos.zip': {'path': '', 05:41:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:41:53 INFO - Running post-action listener: _resource_record_post_action 05:41:53 INFO - ##### 05:41:53 INFO - ##### Finished populate-webroot step (success) 05:41:53 INFO - ##### 05:41:53 INFO - ##### 05:41:53 INFO - ##### Running create-virtualenv step. 05:41:53 INFO - ##### 05:41:53 INFO - Running pre-action listener: _resource_record_pre_action 05:41:53 INFO - Running main action method: create_virtualenv 05:41:53 INFO - Creating virtualenv /builds/slave/test/build/venv 05:41:53 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 05:41:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:41:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:41:53 INFO - Using real prefix '/usr' 05:41:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:41:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:41:55 INFO - Installing pip.................done. 05:41:55 INFO - Return code: 0 05:41:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:41:55 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')]} 05:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:55 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')]} 05:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:55 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 0x7f05b956df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ae190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140110>, '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 0x20ac230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ac6c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', '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 05:41:55 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 05:41:55 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 05:41:55 INFO - Using env: {'DISPLAY': ':0', 05:41:55 INFO - 'HOME': '/home/cltbld', 05:41:55 INFO - 'LANG': 'en_US.UTF-8', 05:41:55 INFO - 'LANGUAGE': 'en_US:en', 05:41:55 INFO - 'LOGNAME': 'cltbld', 05:41:55 INFO - 'MAIL': '/var/mail/cltbld', 05:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:55 INFO - 'MOZ_NO_REMOTE': '1', 05:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:55 INFO - 'NO_EM_RESTART': '1', 05:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:55 INFO - 'PWD': '/builds/slave/test', 05:41:55 INFO - 'SHELL': '/bin/bash', 05:41:55 INFO - 'SHLVL': '1', 05:41:55 INFO - 'TERM': 'linux', 05:41:55 INFO - 'TMOUT': '86400', 05:41:55 INFO - 'USER': 'cltbld', 05:41:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', 05:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:55 INFO - '_': '/tools/buildbot/bin/python'} 05:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:41:56 INFO - Cleaning up... 05:41:56 INFO - Return code: 0 05:41:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05b956df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ae190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140110>, '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 0x20ac230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ac6c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', '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 05:41:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:41:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:41:56 INFO - Using env: {'DISPLAY': ':0', 05:41:56 INFO - 'HOME': '/home/cltbld', 05:41:56 INFO - 'LANG': 'en_US.UTF-8', 05:41:56 INFO - 'LANGUAGE': 'en_US:en', 05:41:56 INFO - 'LOGNAME': 'cltbld', 05:41:56 INFO - 'MAIL': '/var/mail/cltbld', 05:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:56 INFO - 'MOZ_NO_REMOTE': '1', 05:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:56 INFO - 'NO_EM_RESTART': '1', 05:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:56 INFO - 'PWD': '/builds/slave/test', 05:41:56 INFO - 'SHELL': '/bin/bash', 05:41:56 INFO - 'SHLVL': '1', 05:41:56 INFO - 'TERM': 'linux', 05:41:56 INFO - 'TMOUT': '86400', 05:41:56 INFO - 'USER': 'cltbld', 05:41:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', 05:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:56 INFO - '_': '/tools/buildbot/bin/python'} 05:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:56 INFO - Downloading/unpacking psutil>=3.1.1 05:41:56 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 05:41:56 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 05:41:56 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 05:41:56 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 05:41:56 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 05:41:56 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 05:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:41:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:58 INFO - Installing collected packages: psutil 05:41:58 INFO - Running setup.py install for psutil 05:41:58 INFO - building 'psutil._psutil_linux' extension 05:41:58 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 05:41:58 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 05:41:58 INFO - building 'psutil._psutil_posix' extension 05:41:58 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 05:41:58 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 05:41:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:58 INFO - Successfully installed psutil 05:41:58 INFO - Cleaning up... 05:41:58 INFO - Return code: 0 05:41:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:41: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')]} 05:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41: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')]} 05:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:58 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 0x7f05b956df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ae190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140110>, '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 0x20ac230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ac6c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', '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 05:41:58 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 05:41:58 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 05:41:58 INFO - Using env: {'DISPLAY': ':0', 05:41:58 INFO - 'HOME': '/home/cltbld', 05:41:58 INFO - 'LANG': 'en_US.UTF-8', 05:41:58 INFO - 'LANGUAGE': 'en_US:en', 05:41:58 INFO - 'LOGNAME': 'cltbld', 05:41:58 INFO - 'MAIL': '/var/mail/cltbld', 05:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:58 INFO - 'MOZ_NO_REMOTE': '1', 05:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:58 INFO - 'NO_EM_RESTART': '1', 05:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:58 INFO - 'PWD': '/builds/slave/test', 05:41:58 INFO - 'SHELL': '/bin/bash', 05:41:58 INFO - 'SHLVL': '1', 05:41:58 INFO - 'TERM': 'linux', 05:41:58 INFO - 'TMOUT': '86400', 05:41:58 INFO - 'USER': 'cltbld', 05:41:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', 05:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:58 INFO - '_': '/tools/buildbot/bin/python'} 05:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 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 05:42:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:42:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:42:00 INFO - Installing collected packages: mozsystemmonitor 05:42:00 INFO - Running setup.py install for mozsystemmonitor 05:42:01 INFO - Successfully installed mozsystemmonitor 05:42:01 INFO - Cleaning up... 05:42:01 INFO - Return code: 0 05:42:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05b956df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ae190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140110>, '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 0x20ac230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ac6c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', '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 05:42:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:42:01 INFO - Using env: {'DISPLAY': ':0', 05:42:01 INFO - 'HOME': '/home/cltbld', 05:42:01 INFO - 'LANG': 'en_US.UTF-8', 05:42:01 INFO - 'LANGUAGE': 'en_US:en', 05:42:01 INFO - 'LOGNAME': 'cltbld', 05:42:01 INFO - 'MAIL': '/var/mail/cltbld', 05:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:01 INFO - 'MOZ_NO_REMOTE': '1', 05:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:01 INFO - 'NO_EM_RESTART': '1', 05:42:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:01 INFO - 'PWD': '/builds/slave/test', 05:42:01 INFO - 'SHELL': '/bin/bash', 05:42:01 INFO - 'SHLVL': '1', 05:42:01 INFO - 'TERM': 'linux', 05:42:01 INFO - 'TMOUT': '86400', 05:42:01 INFO - 'USER': 'cltbld', 05:42:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', 05:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:01 INFO - '_': '/tools/buildbot/bin/python'} 05:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:01 INFO - Downloading/unpacking jsonschema==2.5.1 05:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:42:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:42:03 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 05:42:03 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 05:42:03 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 05:42:03 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 05:42:03 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 05:42:03 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 05:42:03 INFO - Downloading functools32-3.2.3-2.tar.gz 05:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:42:03 INFO - warning: no files found matching '*.txt' 05:42:03 INFO - no previously-included directories found matching 'build' 05:42:03 INFO - no previously-included directories found matching 'dist' 05:42:03 INFO - no previously-included directories found matching '.git*' 05:42:03 INFO - Installing collected packages: jsonschema, functools32 05:42:03 INFO - Running setup.py install for functools32 05:42:03 INFO - warning: no files found matching '*.txt' 05:42:03 INFO - no previously-included directories found matching 'build' 05:42:03 INFO - no previously-included directories found matching 'dist' 05:42:03 INFO - no previously-included directories found matching '.git*' 05:42:03 INFO - Successfully installed jsonschema functools32 05:42:03 INFO - Cleaning up... 05:42:03 INFO - Return code: 0 05:42:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f05b956df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ae190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140110>, '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 0x20ac230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ac6c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', '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 05:42:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:42:03 INFO - Using env: {'DISPLAY': ':0', 05:42:03 INFO - 'HOME': '/home/cltbld', 05:42:03 INFO - 'LANG': 'en_US.UTF-8', 05:42:03 INFO - 'LANGUAGE': 'en_US:en', 05:42:03 INFO - 'LOGNAME': 'cltbld', 05:42:03 INFO - 'MAIL': '/var/mail/cltbld', 05:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:03 INFO - 'MOZ_NO_REMOTE': '1', 05:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:03 INFO - 'NO_EM_RESTART': '1', 05:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:03 INFO - 'PWD': '/builds/slave/test', 05:42:03 INFO - 'SHELL': '/bin/bash', 05:42:03 INFO - 'SHLVL': '1', 05:42:03 INFO - 'TERM': 'linux', 05:42:03 INFO - 'TMOUT': '86400', 05:42:03 INFO - 'USER': 'cltbld', 05:42:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', 05:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:03 INFO - '_': '/tools/buildbot/bin/python'} 05:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:42:03 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 05:42:03 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 05:42:03 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 05:42:03 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 05:42:03 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 05:42:03 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 05:42:05 INFO - Downloading blobuploader-1.2.4.tar.gz 05:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:42:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:42:05 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 05:42:05 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 05:42:05 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 05:42:05 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 05:42:05 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 05:42:05 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 05:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:42:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:06 INFO - Downloading docopt-0.6.1.tar.gz 05:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:42:06 INFO - Installing collected packages: blobuploader, requests, docopt 05:42:06 INFO - Running setup.py install for blobuploader 05:42:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:42:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:42:06 INFO - Running setup.py install for requests 05:42:06 INFO - Running setup.py install for docopt 05:42:07 INFO - Successfully installed blobuploader requests docopt 05:42:07 INFO - Cleaning up... 05:42:07 INFO - Return code: 0 05:42:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42: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')]} 05:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42: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')]} 05:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05b956df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ae190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140110>, '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 0x20ac230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ac6c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', '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 05:42:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:42:07 INFO - Using env: {'DISPLAY': ':0', 05:42:07 INFO - 'HOME': '/home/cltbld', 05:42:07 INFO - 'LANG': 'en_US.UTF-8', 05:42:07 INFO - 'LANGUAGE': 'en_US:en', 05:42:07 INFO - 'LOGNAME': 'cltbld', 05:42:07 INFO - 'MAIL': '/var/mail/cltbld', 05:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:07 INFO - 'MOZ_NO_REMOTE': '1', 05:42:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:07 INFO - 'NO_EM_RESTART': '1', 05:42:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:07 INFO - 'PWD': '/builds/slave/test', 05:42:07 INFO - 'SHELL': '/bin/bash', 05:42:07 INFO - 'SHLVL': '1', 05:42:07 INFO - 'TERM': 'linux', 05:42:07 INFO - 'TMOUT': '86400', 05:42:07 INFO - 'USER': 'cltbld', 05:42:07 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', 05:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:07 INFO - '_': '/tools/buildbot/bin/python'} 05:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:42:07 INFO - Running setup.py (path:/tmp/pip-GAa9qL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:42:07 INFO - Running setup.py (path:/tmp/pip-tUS0QV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:42:07 INFO - Running setup.py (path:/tmp/pip-MkheYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:42:07 INFO - Running setup.py (path:/tmp/pip-fLPJPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:42:07 INFO - Running setup.py (path:/tmp/pip-jxqd4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:42:07 INFO - Running setup.py (path:/tmp/pip-KMJSeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:42:07 INFO - Running setup.py (path:/tmp/pip-sodfiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:42:07 INFO - Running setup.py (path:/tmp/pip-KVrO1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:42:07 INFO - Running setup.py (path:/tmp/pip-pZ0L0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:42:08 INFO - Running setup.py (path:/tmp/pip-S9b2hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:42:08 INFO - Running setup.py (path:/tmp/pip-XF3dCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:42:08 INFO - Running setup.py (path:/tmp/pip-mwBwhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:42:08 INFO - Running setup.py (path:/tmp/pip-niJBeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:42:08 INFO - Running setup.py (path:/tmp/pip-n9qWYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:08 INFO - Running setup.py (path:/tmp/pip-dzuZ7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:42:08 INFO - Running setup.py (path:/tmp/pip-CtIHrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:42:08 INFO - Running setup.py (path:/tmp/pip-CXGZM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:42:08 INFO - Running setup.py install for manifestparser 05:42:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:42:08 INFO - Running setup.py install for mozcrash 05:42:08 INFO - Running setup.py install for mozdebug 05:42:08 INFO - Running setup.py install for mozdevice 05:42:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:42:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:42:09 INFO - Running setup.py install for mozfile 05:42:09 INFO - Running setup.py install for mozhttpd 05:42:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:42:09 INFO - Running setup.py install for mozinfo 05:42:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:42:09 INFO - Running setup.py install for mozInstall 05:42:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:42:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:42:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:42:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:42:09 INFO - Running setup.py install for mozleak 05:42:09 INFO - Running setup.py install for mozlog 05:42:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:42:09 INFO - Running setup.py install for moznetwork 05:42:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:42:09 INFO - Running setup.py install for mozprocess 05:42:09 INFO - Running setup.py install for mozprofile 05:42:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:42:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:42:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:42:09 INFO - Running setup.py install for mozrunner 05:42:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:42:10 INFO - Running setup.py install for mozscreenshot 05:42:10 INFO - Running setup.py install for moztest 05:42:10 INFO - Running setup.py install for mozversion 05:42:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:42:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:42:10 INFO - Cleaning up... 05:42:10 INFO - Return code: 0 05:42:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42: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')]} 05:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42: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')]} 05:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:10 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 0x7f05b956df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ae190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140110>, '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 0x20ac230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ac6c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', '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 05:42:10 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 05:42:10 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 05:42:10 INFO - Using env: {'DISPLAY': ':0', 05:42:10 INFO - 'HOME': '/home/cltbld', 05:42:10 INFO - 'LANG': 'en_US.UTF-8', 05:42:10 INFO - 'LANGUAGE': 'en_US:en', 05:42:10 INFO - 'LOGNAME': 'cltbld', 05:42:10 INFO - 'MAIL': '/var/mail/cltbld', 05:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:10 INFO - 'MOZ_NO_REMOTE': '1', 05:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:10 INFO - 'NO_EM_RESTART': '1', 05:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:10 INFO - 'PWD': '/builds/slave/test', 05:42:10 INFO - 'SHELL': '/bin/bash', 05:42:10 INFO - 'SHLVL': '1', 05:42:10 INFO - 'TERM': 'linux', 05:42:10 INFO - 'TMOUT': '86400', 05:42:10 INFO - 'USER': 'cltbld', 05:42:10 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', 05:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:10 INFO - '_': '/tools/buildbot/bin/python'} 05:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:42:10 INFO - Running setup.py (path:/tmp/pip-aFtIau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:42:10 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)) 05:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:42:10 INFO - Running setup.py (path:/tmp/pip-_F9n4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:42:10 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)) 05:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:42:10 INFO - Running setup.py (path:/tmp/pip-H2L0dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:42:10 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)) 05:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:42:10 INFO - Running setup.py (path:/tmp/pip-dfTpsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:42:10 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)) 05:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:42:10 INFO - Running setup.py (path:/tmp/pip-hLpKMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:42:10 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)) 05:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:42:10 INFO - Running setup.py (path:/tmp/pip-qqliL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:42:11 INFO - Running setup.py (path:/tmp/pip-ZEbdRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:42:11 INFO - Running setup.py (path:/tmp/pip-yIgE2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:42:11 INFO - Running setup.py (path:/tmp/pip-ttCzU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:42:11 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)) 05:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:42:11 INFO - Running setup.py (path:/tmp/pip-Vb25fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:42:11 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)) 05:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:42:11 INFO - Running setup.py (path:/tmp/pip-xQcWNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:42:11 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)) 05:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:42:11 INFO - Running setup.py (path:/tmp/pip-zTsANM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:42:11 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)) 05:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:42:11 INFO - Running setup.py (path:/tmp/pip-t6TKju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:42:11 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)) 05:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:42:11 INFO - Running setup.py (path:/tmp/pip-hCHjVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:42:11 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)) 05:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:11 INFO - Running setup.py (path:/tmp/pip-Ig1fYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:11 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)) 05:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:42:11 INFO - Running setup.py (path:/tmp/pip-Mvoeh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:42:11 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)) 05:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:42:11 INFO - Running setup.py (path:/tmp/pip-rD2_Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:11 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)) 05:42:11 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)) 05:42:11 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)) 05:42:11 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)) 05:42:11 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)) 05:42:11 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)) 05:42:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:42:11 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 05:42:11 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 05:42:11 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 05:42:11 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 05:42:11 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 05:42:11 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 05:42:13 INFO - Downloading blessings-1.6.tar.gz 05:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:42:13 INFO - Installing collected packages: blessings 05:42:13 INFO - Running setup.py install for blessings 05:42:13 INFO - Successfully installed blessings 05:42:13 INFO - Cleaning up... 05:42:13 INFO - Return code: 0 05:42:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:42:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:14 INFO - Reading from file tmpfile_stdout 05:42:14 INFO - Current package versions: 05:42:14 INFO - argparse == 1.2.1 05:42:14 INFO - blessings == 1.6 05:42:14 INFO - blobuploader == 1.2.4 05:42:14 INFO - docopt == 0.6.1 05:42:14 INFO - functools32 == 3.2.3-2 05:42:14 INFO - jsonschema == 2.5.1 05:42:14 INFO - manifestparser == 1.1 05:42:14 INFO - mozInstall == 1.12 05:42:14 INFO - mozcrash == 0.17 05:42:14 INFO - mozdebug == 0.1 05:42:14 INFO - mozdevice == 0.48 05:42:14 INFO - mozfile == 1.2 05:42:14 INFO - mozhttpd == 0.7 05:42:14 INFO - mozinfo == 0.9 05:42:14 INFO - mozleak == 0.1 05:42:14 INFO - mozlog == 3.2 05:42:14 INFO - moznetwork == 0.27 05:42:14 INFO - mozprocess == 0.22 05:42:14 INFO - mozprofile == 0.28 05:42:14 INFO - mozrunner == 6.11 05:42:14 INFO - mozscreenshot == 0.1 05:42:14 INFO - mozsystemmonitor == 0.3 05:42:14 INFO - moztest == 0.7 05:42:14 INFO - mozversion == 1.4 05:42:14 INFO - psutil == 3.1.1 05:42:14 INFO - requests == 1.2.3 05:42:14 INFO - wsgiref == 0.1.2 05:42:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42:14 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')]} 05:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:14 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')]} 05:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:14 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 0x7f05b956df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ae190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140110>, '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 0x20ac230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ac6c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', '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 05:42:14 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 05:42:14 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 05:42:14 INFO - Using env: {'DISPLAY': ':0', 05:42:14 INFO - 'HOME': '/home/cltbld', 05:42:14 INFO - 'LANG': 'en_US.UTF-8', 05:42:14 INFO - 'LANGUAGE': 'en_US:en', 05:42:14 INFO - 'LOGNAME': 'cltbld', 05:42:14 INFO - 'MAIL': '/var/mail/cltbld', 05:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:14 INFO - 'MOZ_NO_REMOTE': '1', 05:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:14 INFO - 'NO_EM_RESTART': '1', 05:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:14 INFO - 'PWD': '/builds/slave/test', 05:42:14 INFO - 'SHELL': '/bin/bash', 05:42:14 INFO - 'SHLVL': '1', 05:42:14 INFO - 'TERM': 'linux', 05:42:14 INFO - 'TMOUT': '86400', 05:42:14 INFO - 'USER': 'cltbld', 05:42:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', 05:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:14 INFO - '_': '/tools/buildbot/bin/python'} 05:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:14 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)) 05:42:14 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)) 05:42:14 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)) 05:42:14 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)) 05:42:14 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)) 05:42:14 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)) 05:42:14 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)) 05:42:14 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)) 05:42:14 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)) 05:42:14 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)) 05:42:14 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)) 05:42:14 INFO - Cleaning up... 05:42:14 INFO - Return code: 0 05:42:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:42:14 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')]} 05:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:14 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')]} 05:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:14 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 0x7f05b956df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ae190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140110>, '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 0x20ac230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ac6c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', '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 05:42:14 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 05:42:14 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 05:42:14 INFO - Using env: {'DISPLAY': ':0', 05:42:14 INFO - 'HOME': '/home/cltbld', 05:42:14 INFO - 'LANG': 'en_US.UTF-8', 05:42:14 INFO - 'LANGUAGE': 'en_US:en', 05:42:14 INFO - 'LOGNAME': 'cltbld', 05:42:14 INFO - 'MAIL': '/var/mail/cltbld', 05:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:14 INFO - 'MOZ_NO_REMOTE': '1', 05:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:14 INFO - 'NO_EM_RESTART': '1', 05:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:14 INFO - 'PWD': '/builds/slave/test', 05:42:14 INFO - 'SHELL': '/bin/bash', 05:42:14 INFO - 'SHLVL': '1', 05:42:14 INFO - 'TERM': 'linux', 05:42:14 INFO - 'TMOUT': '86400', 05:42:14 INFO - 'USER': 'cltbld', 05:42:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', 05:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:14 INFO - '_': '/tools/buildbot/bin/python'} 05:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:42:14 INFO - Cleaning up... 05:42:14 INFO - Return code: 0 05:42:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:42:14 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')]} 05:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:14 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')]} 05:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:14 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 0x7f05b956df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ae190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140110>, '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 0x20ac230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ac6c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', '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 05:42:14 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 05:42:14 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 05:42:14 INFO - Using env: {'DISPLAY': ':0', 05:42:14 INFO - 'HOME': '/home/cltbld', 05:42:14 INFO - 'LANG': 'en_US.UTF-8', 05:42:14 INFO - 'LANGUAGE': 'en_US:en', 05:42:14 INFO - 'LOGNAME': 'cltbld', 05:42:14 INFO - 'MAIL': '/var/mail/cltbld', 05:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:14 INFO - 'MOZ_NO_REMOTE': '1', 05:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:14 INFO - 'NO_EM_RESTART': '1', 05:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:14 INFO - 'PWD': '/builds/slave/test', 05:42:14 INFO - 'SHELL': '/bin/bash', 05:42:14 INFO - 'SHLVL': '1', 05:42:14 INFO - 'TERM': 'linux', 05:42:14 INFO - 'TMOUT': '86400', 05:42:14 INFO - 'USER': 'cltbld', 05:42:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', 05:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:14 INFO - '_': '/tools/buildbot/bin/python'} 05:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:14 INFO - Downloading/unpacking flake8 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:42:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:42:16 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 05:42:16 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 05:42:16 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 05:42:16 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 05:42:16 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 05:42:16 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 05:42:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:42:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:42:16 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 05:42:16 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 05:42:16 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 05:42:16 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 05:42:16 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 05:42:16 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 05:42:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42: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 05:42:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:42:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:42:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:42:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:42:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:42:17 INFO - no previously-included directories found matching 'docs/_build' 05:42:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:42:17 INFO - Running setup.py install for pep8 05:42:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:42:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:42:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:42:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:42:17 INFO - no previously-included directories found matching 'docs/_build' 05:42:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:42:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:42:17 INFO - Cleaning up... 05:42:17 INFO - Return code: 0 05:42:17 INFO - Running post-action listener: _resource_record_post_action 05:42:17 INFO - Running post-action listener: _start_resource_monitoring 05:42:17 INFO - Starting resource monitoring. 05:42:17 INFO - ##### 05:42:17 INFO - ##### Finished create-virtualenv step (success) 05:42:17 INFO - ##### 05:42:17 INFO - ##### 05:42:17 INFO - ##### Running install step. 05:42:17 INFO - ##### 05:42:17 INFO - Running pre-action listener: _resource_record_pre_action 05:42:17 INFO - Running main action method: install 05:42:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:17 INFO - Reading from file tmpfile_stdout 05:42:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:42:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:42:18 INFO - Reading from file tmpfile_stdout 05:42:18 INFO - Output received: 05:42:18 INFO - Usage: mozinstall [options] installer 05:42:18 INFO - Options: 05:42:18 INFO - -h, --help show this help message and exit 05:42:18 INFO - -d DEST, --destination=DEST 05:42:18 INFO - Directory to install application into. [default: 05:42:18 INFO - "/builds/slave/test"] 05:42:18 INFO - --app=APP Application being installed. [default: firefox] 05:42:18 INFO - mkdir: /builds/slave/test/build/application 05:42:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:42:35 INFO - Reading from file tmpfile_stdout 05:42:35 INFO - Output received: 05:42:35 INFO - /builds/slave/test/build/application/firefox/firefox 05:42:35 INFO - Running post-action listener: _resource_record_post_action 05:42:35 INFO - ##### 05:42:35 INFO - ##### Finished install step (success) 05:42:35 INFO - ##### 05:42:35 INFO - ##### 05:42:35 INFO - ##### Running run-tests step. 05:42:35 INFO - ##### 05:42:35 INFO - Running pre-action listener: _resource_record_pre_action 05:42:35 INFO - Running main action method: run_tests 05:42:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:42:35 INFO - Python 2.7.3 05:42:35 INFO - Return code: 0 05:42:35 INFO - grabbing minidump binary from tooltool 05:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:35 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2140110>, '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 0x20ac230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ac6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:42:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:42:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:42:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:42:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:42:35 INFO - Return code: 0 05:42:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:42:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:42:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:42:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:42:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:42:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:42:36 INFO - Return code: 0 05:42:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:42:36 INFO - Using env: {'DISPLAY': ':0', 05:42:36 INFO - 'HOME': '/home/cltbld', 05:42:36 INFO - 'LANG': 'en_US.UTF-8', 05:42:36 INFO - 'LANGUAGE': 'en_US:en', 05:42:36 INFO - 'LOGNAME': 'cltbld', 05:42:36 INFO - 'MAIL': '/var/mail/cltbld', 05:42:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:42:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:36 INFO - 'MOZ_NO_REMOTE': '1', 05:42:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:36 INFO - 'NO_EM_RESTART': '1', 05:42:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:36 INFO - 'PWD': '/builds/slave/test', 05:42:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:42:36 INFO - 'SHELL': '/bin/bash', 05:42:36 INFO - 'SHLVL': '1', 05:42:36 INFO - 'TERM': 'linux', 05:42:36 INFO - 'TMOUT': '86400', 05:42:36 INFO - 'USER': 'cltbld', 05:42:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404', 05:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:36 INFO - '_': '/tools/buildbot/bin/python'} 05:42:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:42:36 INFO - mozversion application_buildid: 20160618030212 05:42:36 INFO - mozversion application_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 05:42:36 INFO - mozversion application_display_name: Nightly 05:42:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:42:36 INFO - mozversion application_name: Firefox 05:42:36 INFO - mozversion application_remotingname: firefox 05:42:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:42:36 INFO - mozversion application_vendor: Mozilla 05:42:36 INFO - mozversion application_version: 50.0a1 05:42:36 INFO - mozversion platform_buildid: 20160618030212 05:42:36 INFO - mozversion platform_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 05:42:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:42:36 INFO - mozversion platform_version: 50.0a1 05:42:36 INFO - using testdate: 1466253756 05:42:36 INFO - actual date: 1466253756 05:42:36 INFO - starting webserver on 'localhost:55742' 05:42:36 INFO - SUITE-START | Running 2 tests 05:42:36 INFO - TEST-START | dromaeo_css 05:42:36 INFO - operating with platform_type : linux_ 05:42:36 INFO - Initialising browser for dromaeo_css test... 05:42:36 INFO - TEST-INFO | started process 11813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbUvnxP/profile http://localhost:55742/getInfo.html) 05:42:40 INFO - PROCESS | 11813 | __metrics Screen width/height:1600/1200 05:42:40 INFO - PROCESS | 11813 | colorDepth:24 05:42:40 INFO - PROCESS | 11813 | Browser inner width/height: 1024/697 05:42:40 INFO - PROCESS | 11813 | __metrics 05:42:41 INFO - PROCESS | 11813 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:42:42 INFO - TEST-INFO | 11813: exit 0 05:42:42 INFO - Browser initialized. 05:42:42 INFO - Running cycle 1/1 for dromaeo_css test... 05:42:42 INFO - TEST-INFO | started process 11895 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbUvnxP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:54 INFO - PROCESS | 11895 | RSS: Main: 174120960 05:42:54 INFO - PROCESS | 11895 | 05:43:45 INFO - PROCESS | 11895 | 1466253825513 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] 05:45:53 INFO - PROCESS | 11895 | Cycle 1(1): loaded http://localhost:55742/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55742/tests/dromaeo/cssquery-ext.html) 05:45:54 INFO - PROCESS | 11895 | RSS: Main: 265678848 05:45:54 INFO - PROCESS | 11895 | 05:48:57 INFO - PROCESS | 11895 | Cycle 1(1): loaded http://localhost:55742/tests/dromaeo/cssquery-ext.html (next: http://localhost:55742/tests/dromaeo/cssquery-jquery.html) 05:48:57 INFO - PROCESS | 11895 | RSS: Main: 256864256 05:48:57 INFO - PROCESS | 11895 | 05:51:59 INFO - PROCESS | 11895 | Cycle 1(1): loaded http://localhost:55742/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55742/tests/dromaeo/cssquery-mootools.html) 05:52:00 INFO - PROCESS | 11895 | RSS: Main: 267845632 05:52:00 INFO - PROCESS | 11895 | 05:55:02 INFO - PROCESS | 11895 | Cycle 1(1): loaded http://localhost:55742/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55742/tests/dromaeo/cssquery-prototype.html) 05:55:03 INFO - PROCESS | 11895 | RSS: Main: 264142848 05:55:03 INFO - PROCESS | 11895 | 05:58:05 INFO - PROCESS | 11895 | Cycle 1(1): loaded http://localhost:55742/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55742/tests/dromaeo/cssquery-yui.html) 05:58:06 INFO - PROCESS | 11895 | RSS: Main: 249876480 05:58:06 INFO - PROCESS | 11895 | 06:01:08 INFO - PROCESS | 11895 | Cycle 1(1): loaded http://localhost:55742/tests/dromaeo/cssquery-yui.html (next: http://localhost:55742/tests/dromaeo/cssquery-dojo.html) 06:01:09 INFO - PROCESS | 11895 | RSS: Main: 290725888 06:01:09 INFO - PROCESS | 11895 | 06:01:09 INFO - PROCESS | 11895 | __start_tp_report 06:01:09 INFO - PROCESS | 11895 | _x_x_mozilla_page_load 06:01:09 INFO - PROCESS | 11895 | _x_x_mozilla_page_load_details 06:01:09 INFO - PROCESS | 11895 | |i|pagename|runs| 06:01:09 INFO - PROCESS | 11895 | |0;dojo.html;3091.799033062851;3110.3623757129785;3122.9375412491745;3131.4363414585396;3144.905652830416;5242.68543887367;5306.681599104051;5315.123004704229;5386.461353864612;5419.729013549321;5368.275282836816;5388.299521062267;5397.62216644835;5432;5511.862203444916;4870.756462176886;4945.530174633404;4950.6287028472825;4956.653034287601;5003.649744517885;4959.132151873426;4992.251162325644;4998.850034498971;5030.899382012358;5037.1940489521685;4772.594329481998;4820.325154478376;4836;4907.975460122694;4909.901801963959;4893.584045356149;4901.779419926076;4904;4910.1898186799135;4914.533119353691;4860.1251774680895;4861.2222044473065;4866.7566621668775;4870.659053866196;4872.634552408548;5288.312519372495;5304.840854774363;5380.542653874425;5389.78440862365;5395.433479484637;5812.244408226903;5823;5829.125631155318;5902.409759024106;5904.675242861641;5882.117682347639;5929.495992840613;5948.494377977877;5954.196183515213;5955.464008239236;5231.241469986869;5349.384820745586;5411.945880541223;5423.132298832168;5424.566034717213;5928.686372490888;5985.461308482258;6000.369961154103;6001.129836173817;6003.759849605967;5463.672179669233;5735.856603584861;5736.770529178786;5738.110592858114;5742.368339482654;5633.126865335879;5703.572232082611;5709.74306156224;5732.71336433185;5733.971330143406;5719.771209151588;5728.484436400744;5737.08206686928;5738.713064346766;5739.7704091836695;5559.610827242135;5674.858128546737;5688.260526131577;5744.655320680772;5745.597808153389;4445.777711114431;4457.24226881431;4463.665225108065;4497.955020449819;4498.572635599613;3966.5438474575794;3970.1265721541213;3987.342088555356;3997.5802540733384;4016.0763024504527;5221.973890130525;5285.471452854684;5356.0894647909945;5446.264754258124;5505.614606977553;5793.971030144822;5810.360860305363;5820.679862607512;5849.941500585025;5850.678212698257;5434.402215756264;5439.972800135974;5457.290552228185;5457.399686034533;5457.454254574511;4843.104025755247;4909.116359055404;4965.255211718271;5029.421616514074;5083.288339632454;5949.10763385487;5950.940490595039;5959.0763431668165;5960.761569537257;5995.400459953969;5798.5651076168615;5799.449052340021;5801.129830525455;5806.390329015392;5809.564282678901;5809.8547536311935;5856.560757943086;5895.056790913433;5917.201177840936;5933.821985340447;5680.062789639664;5680.886382272414;5682.573806964411;5683.204351390891;5693.430656934273;5734.971325143348;5744.655320680772;5798.913016304675;5804.738786754522;5809.0415081512765;5519.917201242065;5628.380878103323;5673.234113394639;5693.772249109989;5748.655080695172;5683.5737319700365;5687.573431992534;5690.544756419394;5690.77236910519;5711.286089238845;5382.246485491956;5606.383297837153;5633.746481408264;5633.802816901552;5641.492265696107;5617.045102332695;5683.204351390726;5694.202811606461;5740.6268592541355;5752.252207213036;5580.302462192226;5580.665160090408;5580.832575022756;5584.022796010763;5586.078297081099 06:01:09 INFO - PROCESS | 11895 | |1;ext.html;606.6380974711772;616.7224748863013;634.2737565487515;635.4916067146282;658.2561705273041;30365.544516832237;33143;41311.79344103279;42261.7886910565;42267.154656906845;44159.55840441595;44550.33174502377;44645;44766;44771.328430073576;8708.04211536732;8901.599428025755;8907.421017633866;8910.55447227636;8911.331650126234;8804.383693141483;8878;8889.866652000224;8894.86657700135;8896.59965301563;8876.8668469973;8896.332775041865;8902.198802107809;8904.065073167321;8938.374313798036;8836.0722124177;8877.644894204224;8878.112188781135;8878.511681857528;8881.955590222007;8706;8715.389922705413;8732.95204575455;8742.825143497159;8760.342974276891;41543;41730;41807.581924180675;41817.581824181674;41831.95420114491;3514.5958214805114;3518.2787528556582;3539.752217344787;3632.5822530409077;3635.309291234657;31756.841215793775;32166.517502237486;32472.350552989043;32677.346453071044;32823;4428.933565996513;4431.962527786598;4499.797509112098;4526.932096018562;4557.5442455754155;349350;349779;353142;461377;463475;58274;58302.7084864573;58347.70826145927;58900;58949;52614.47385526172;53736.46263537393;53754;58595.41404585985;61534.38465615376;16302.10338431374;16559.91720041392;16562.17189140538;16933.068681222652;16976.236069376908;12432.937835310766;12499.875001250053;12548.749025019448;12568.245905245714;12799.040071994452;16591;17756.644867102586;18088.547786305186;18672.159752811156;18769;6721.495887808336;6773.221079575814;6917.757878474229;7113.75101871432;7206.819829504199;932.6922115701802;1033.6433930294036;1049.8477720730605;1069.5133714160038;1125.319181894958;30550;31735;32244;32558.348833023207;34671.30657386838;1070.571771291474;1098.0392156862745;1123.230587047875;1161.0943464098018;1162.9244099133698;15907.443239486562;16590.253438595293;16743.497695069167;16779.161041948097;16866.915665421595;524747;528958;529629;529944;531801;54758;56205.43794562084;56287;56299.71850140723;56402;1329.4416345135066;1340.1891855427325;1352.905296629246;1355.8034085057611;1380.5996261084174;29231.707682922897;30053.398932021675;30256.54615180818;30445.84777076189;30702.539461908535;49207.753961229966;49366.75316623394;49419.75290123526;49633.75183124061;49700.50299496959;423930;426231;428570;430114;432099;23921.760782391953;25897.741022589533;26855.597166042135;27084;27138.1858544244;41677.37483937804;45680.77159614181;45694.31458528058;46147.307790382496;46882.76558617185;38752.80623596864;38819.2236155281;38864.61135388723;38895.41656875206;39306.2138757229;38558.61441385662;38906;38910;39051.80474097725;39460;37391.81304093462;38188;38461.615383845805;38712.2257554853;39199.41200881932;33275;34662;35207.647923521465;35555.82222088873;35570.11074723153;26659.20022399331;27495.725042750117;27654.585181221897;27723.861380692968;27819.304517387227 06:01:09 INFO - PROCESS | 11895 | |2;jquery.html;356.95538057742783;377.3584905660378;378.8371000469797;381.728972429575;393.3234836081938;14391.640208994768;17572.736408953875;17973.28106875725;18050.63898722025;19030.714539281922;17183.140842957833;17270.704697147732;17955.371561995333;17955.91022044888;18016.279348826065;5098.362704661918;5272.367315922094;5313.9637770634745;5313.9734301328435;5316.0962636351915;3664.3037822813712;3837.712171587128;3843.5195600549932;5166.07010738067;5308.9116731070035;4136.214119317335;6426.839329016765;6431.967840160816;6527.47780177587;6542.542022058457;6197.752089916398;6392.105105285264;6432.131662225586;6490.610563366189;6526.510511711617;5659.60382773206;5670.8015219467125;5684.204211410406;5694.6867922264255;5697.430256974311;13522.18866867991;13526.797098043537;13539.526116585872;13549.390277437538;18519.2592296308;2480.4295012147127;2519.7858182054547;2639.1818536253822;2678.7723043541323;2836.405690756989;9852.935339181578;9883.308168428213;9981.401115933068;10181.694549163536;10344.586216551405;1775.3519965212604;1924.8363889069446;1934.2571576474397;1961.7547806524185;1999.7600287965392;78653.60673196655;78894;80805.59597202035;81172.59413702953;82195.58902205511;9695.70912872615;10066.69799906004;10945.179111566664;11008.504617292241;11095.778084438427;14375.78436323456;14772.187529685756;14998.850011499746;15009;15032.624184395478;7848;7983.281504664608;8019.759407217793;8040.437169398086;8074.515529068275;7736.2650548197835;7927.643256053491;7964.283214510722;8100.513969161869;8189.058258300252;4615;4654.394928659321;4704.69419487739;4754.881127971828;4804.06320767454;1914.15777058094;1928.7299778031088;1940.427573865713;1970.2020681623965;1997.7602687677572;865.2688478235881;957.8850537935492;986.7286496213455;1011.4790882695418;1079.3901445683164;18302.725459118123;18466.446006619823;18467.630647386977;18510.16704248312;18932.43202703921;914.533587870191;941.8963913969458;951.3673407184145;962.0956301077105;1010.3836659637615;10328.431936243578;10514.106300964351;10565.154787617126;10689;10716.464176791129;454174;458282;462672;472687;473505;86125.56937215274;88244.55877720698;88703;89024;89790.55104724565;929.2798081486902;941.0730430525927;944.9716508504619;961.6441916490943;964.6912987843963;16188.757168642243;16405.91797041007;16678.999260044435;16722.076961149625;17324.740128897825;31780.04659860208;40540.79729601451;42790.5720942799;42794.35808462938;43270.78364608157;53113;53816.730916345165;58651.01466375235;58982.70508647601;58993.705031474565;8721.302295816446;8811.911880881109;8851.247643950337;8870.935487741512;9147.679831205876;9935.254855885982;13835.515756948458;13895.791563126359;14013.579592612237;14277.714445711235;7319.670614822452;11855.051595872137;12154.635360939186;12182.512699491921;12225.388730563258;11928.224665396721;12123.696907577381;12314.322712250912;12485.500579976699;12500.124991250525;12258;12287.1399002069;12292.078094143153;12484.750304994031;12580.30808305552;7544.773656790305;7876.763697089096;7955.4828936118965;8129.79675508117;8218.630161642861;11995.820062698893;12199.634010979686;12200.877991219973;12246.387680615755;12270.570530031406 06:01:09 INFO - PROCESS | 11895 | |3;mootools.html;1293.695981444361;1448.3989144505028;1473.8378778334384;1568.5451219146448;1693.872959528035;8152.510849349043;8473.44922580032;8491;8529.829403411928;8789.648414063446;8494;8763.167499087593;9035.457872527637;9046.86429703555;9059.320550958688;1979.9703004454946;2043.8875861827594;2245.5059886824956;2254.120892851789;2310.09906136606;2307.1463558483383;2329.8485598436046;2337.5857606148293;2338.5089131282452;2340.180936672168;2286.965695514569;2304.354780661409;2309.607366747657;2347.061175529793;2353.0234952494693;1926.3257859749117;2174.14121422039;2244.2257421189665;2250.707408036961;2251.268337790225;2228.832837537191;2245.2253972379503;2248.730152381708;2249.707538020063;2251.9887400563057;8946.910530894738;8997.415168014059;9050.230730387924;9056;9056.411333263317;5151.665141765773;5270.314859068335;5283.524482796567;5286.180642000496;5287.4448182941005;3161.4783560712453;3301.323228738103;3446.4657978013197;3456.3087382523345;3460.463628137643;1149.672343382132;1166.8891455311732;1169.2777232775386;1175.8295047218191;1179.445660539545;12317.69205769854;12481.251124932442;12483.50065997368;12524.74950500994;12549.560765373168;4478.753668548261;4594.47163576193;4647.024124933801;4669.603083737852;4679.859604211879;10421.166306695446;10426.270161088803;10436.5825366986;10440.112590429746;10453.163746900229;5295.338082739658;5295.523402893758;5296.073187192226;5301.469853014668;5304.787808487617;4023.5372932112596;4210.45264115663;4329.437173167468;4721.504242054535;4895.8041678332465;3961.4255932890146;3969.8412063517135;4044.595540445932;4074;4094.406311084876;1203.4825025239231;1213.5995121609847;1216.969575760613;1220.7558488302375;1231.2181764579557;907.7065182115459;949.2168960607527;952.1002652493328;962.2638681408728;976.6581696406344;5916.940830591639;5946.583739138306;6097.847553811191;6188.783392581328;6220.911340515392;427.9208346455916;433.55127443096245;441.98232070717455;445.2830942183083;451.0617914737338;4071.307877660805;4117.794110294473;4131.9173616528105;4140.503139623264;4157.168566286755;10630.734231644115;10881;11138.777224455465;11228.606998755167;11245.044171245372;11292.54829806815;11320.886791131983;11615.76768464626;11619.709507262218;11620.302781833117;8137.430379873471;8272.958635206785;8550.615222314886;8609.913900861036;8634.481931084156;5978.671173085522;6057.697115144137;6179.81460556184;6233.937660623335;6268.279147897868;10107.191424686154;10174.745631359276;10389.064984151462;10399.740006499898;10433.852276249454;10338.431386273827;10627.628033018807;10672.679819605424;10679.94660026726;10703.250772445854;7116.430685545248;7787.727429540166;8035.517868927883;8104.635291411782;8113.8377232456205;8792.868106978272;8810.030896601496;8847.159519845605;8851.070637582961;8891.377603567948;7592.316691497792;7856.685732570633;7938.64276107565;7942.841143177219;8126.146754590683;7812;7869.803254918673;7950.40371972116;7993.560354180576;8153.918460815553;7221.963890180516;7280.490365674352;7281.599512026889;7316.304951029643;7353.191148973716;5217.556507696737;5248.08158572256;5281.392639846466;5303.602229832855;5360.892782144413;4987.326710893983;5108.28484012246;5182.689038657692;5256.526912577733;5258.2375555544995 06:01:09 INFO - PROCESS | 11895 | |4;prototype.html;297.0094734061902;302.83646830711416;312.5312031952072;313.47962382445144;314.69631805307876;5189.740512974355;5199.4800519948085;5359.812406565771;5405.729713514318;5462.180672899062;5289.153735402337;5346.465353464651;5347.59893008024;5353.625246232766;5363.927214557085;4173.457450531427;4182.539920608739;4184;4190.371444283367;4190.769507677077;3863.632954869283;3939.72421930465;4083.3466645336603;4202.873913782591;4212.094399704063;4025.134596061846;4051.392291156321;4064.227796718614;4075.6331930126285;4082.6733861291173;4022.6178513041214;4031.354983202703;4039.515258169009;4044.352903535435;4074.490688663917;3510.4558793387064;3553.626869178725;3556.808469162808;3566.6789988900864;3566.698155173369;5110.872228194287;5144.045262800112;5154.561862241677;5156.767945442464;5165.690058596496;4615.607673347769;4621.2837010263465;4649.8372556960685;4666.976665116653;4686.297055441677;5226.216067589892;5454.809081682161;5471.781128754845;5475.7262136893;5503.394626591072;3883.49514563105;3901.1612503311926;3924.156306394139;3929.351656976595;3942.448057271984;5666.150077488369;5670.801521946753;5672.326663634238;5677.6309539880185;5682;3991.7426010806503;3999.24014437256;4016.979915100406;4026.939595906064;4031.3952907064177;3791.50235656914;3997.140614767839;3997.900052498711;4005.839766409311;4015.257177422186;4605.723656580616;4617.907641847211;4638.141943740419;4651.697639653412;4660.39414876064;5506;5533.584981126432;5596;5604.97197514018;5632.295963004624;1271.8346614939999;1278.9232646041266;1363.8772510473907;1365.208179256029;1368.2269517722455;845.8223773007614;861.0786458489481;869.913008699125;874.5758307220992;881.0836430763064;4662.95337046632;4671.462781780071;4672.252439609646;4746.311784791186;4749.3588365570895;4940.654154209243;4984.42679091909;5006.945763084515;5008.69947803133;5034.974825125851;4596.781852809008;4644.674872758942;4663.556962088596;4666.929996050062;4739.573438390561;2801.817881837674;2949.6460424749166;3028.8338989489207;3045.83247921362;3056.541518772202;5768.105943578668;5786.797462088891;5800.636850340166;5879.706014699248;5893.970530147408;5578.804741834017;5808;5822.155787410802;5843.181954526284;5847.690162385834;5819.243498345188;5840.8247752567495;5856.238688970407;5871.706414679335;5873.559483038789;5645.68948707825;5672.5745569081655;5678.432156784289;5689.34572524165;5697.943020569741;5326.4407237241085;5627.746751396279;5674.404187560247;5681.659100453986;5682.14767784819;5738.713064346849;5808.854778630568;5816.651000939957;5820.177214051267;5846.824595262149;3776.37689781194;3876.7480113792512;3897.103666156743;3951.7431366961055;3956.4263181837896;5461.754221059982;5515.283013208257;5522.447755224445;5558.694271815089;5604.663720176803;5427.457254274541;5432.511074003359;5485.314335708036;5493;5497.587680923867;5219.182899226964;5419.2413062170535;5444.700541470257;5502.752376143163;5523.1991361253195;5377.542908852792;5407.351117865881;5409;5452.400235974119;5455.509004189642;5500.559955203654;5503.504684578407;5525.226468294361;5537.2524709163745;5541.861453463534;5143.305653736697;5392.299001129828;5422.671445495721;5463.754131064191;5471.632091977006 06:01:09 INFO - PROCESS | 11895 | |5;yui.html;697.7139372857126;733.7065173930431;749.0973377080618;763.2062654838968;784.5253621558956;14391.136531808073;15038.774418383706;15178;16153.515394538168;16173;15989;16163.434279800209;16167.514974550753;16180.27188776505;16192.919035404806;646.0374042676425;740.7518481308769;746.7162478258268;761.0410882288302;767.5279702982654;758.0524344569288;766.5362455714269;766.7546385156752;766.789132988427;766.8082979255187;803.0564087197549;808.0707186735243;808.6159074439653;808.7088648086684;808.8301456694102;662.5395350231591;779.6101949025488;800.7277525641281;801.3469022746443;805.7099444200084;592.8428966323928;593.1429084972217;593.9287285525721;593.9524838012949;594.0317282829004;15192.848071519255;15210.08739475635;15210.771838422323;15225;15240.390384384722;13460.596182114454;13813.378397972116;14048.71902561943;14071.577852664437;14122.22327771972;11939.94030029853;12268.38658067102;13096.279704616243;13418.329083545783;13614.795778063337;3808.333541630231;3850.5571859236265;3886.9222615547533;3920.6473766550494;3999.8200080996135;78030.60984695097;78198.21801781966;78211.60894195492;78774.21225787725;78936;11536.192466527431;11578.884211157949;11687.532498700128;11707.648770536898;11755.118366122404;19081.904590477236;20561;20613.793862061488;20663.276785312442;20664.896675516826;7958.6418611162635;8135.837283254302;8326.750197494084;8337.916070910744;8398.202170793766;4456.665750068693;4549.158405694957;4587.220172570671;4596.931046034312;4642.141203877293;3588.551431071116;3741.3639681254253;3744.43833424983;3745.0637340664834;3745.4194599836524;534.9518543331119;631.3150231998242;635.8473966248159;642.2421542579707;653.3238098568054;618.8700372921737;666.6000399760202;723.4574069447914;723.9493235473466;747.970081196746;9909.405435673883;9930.900690992998;10216.540255688511;10526.105281051043;10537.367757934548;686.7459040155074;690.848013437043;704.1057856522189;716.7563028570207;724.3589423360364;4902.289168070681;5033.295338652591;5076.82231121909;5187.688738675692;5210.270562121306;126944.36527817302;127777;127827;129215.35392323167;129584.35207823901;113417.62785418921;113911;114613.1117543832;116518.41740791242;117076;95753.5212323934;97721;99757.99999999854;99955.50022249988;100086.49956750315;9692.17308304159;9718.562664680248;9762.853557196506;9843.090553044693;10210.846837297595;48515;48596.2710559349;49282;50144;50468;55930.161047585134;67354;72918.27081729328;74539.62730186315;76276;12760.170588912062;12778.488860445477;12804;12809.743805124031;13484.12353197039;14216.644583885485;14300.570982870531;14324.85675143277;14633;15197.468088616846;14157.575272741835;14533.78199327032;14648.633784155481;14804.456763522041;14856.40574377056;13170.143940643828;13356;13394.129381590166;13487.25820079905;14050.086744361584;13394.866051339752;13472.932635336761;13562.321883905963;14744.115353078849;15001.399944002118;10432.582696692047;10889.564417423215;10920.56317747313;10995.61515346991;11583.942080289544;11971.341576213392;11975.940120299343;12033.157678962389;12149.81775273354;12206.816897746363 06:01:09 INFO - PROCESS | 11895 | __end_tp_report 06:01:09 INFO - PROCESS | 11895 | __start_cc_report 06:01:09 INFO - PROCESS | 11895 | _x_x_mozilla_cycle_collect,900 06:01:09 INFO - PROCESS | 11895 | __end_cc_report 06:01:09 INFO - PROCESS | 11895 | __startTimestamp1466254869051__endTimestamp 06:01:09 INFO - PROCESS | 11895 | 06:01:09 INFO - PROCESS | 11895 | ------- Summary: start ------- 06:01:09 INFO - PROCESS | 11895 | Number of tests: 6 06:01:09 INFO - PROCESS | 11895 | 06:01:09 INFO - PROCESS | 11895 | [#0] dojo.html Cycles:165 Average:5367.17 Median:5584.02 stddev:607.65 (10.9%) stddev-sans-first:582.71 06:01:09 INFO - PROCESS | 11895 | Values: 3091.8 3110.4 3122.9 3131.4 3144.9 5242.7 5306.7 5315.1 5386.5 5419.7 5368.3 5388.3 5397.6 5432.0 5511.9 4870.8 4945.5 4950.6 4956.7 5003.6 4959.1 4992.3 4998.9 5030.9 5037.2 4772.6 4820.3 4836.0 4908.0 4909.9 4893.6 4901.8 4904.0 4910.2 4914.5 4860.1 4861.2 4866.8 4870.7 4872.6 5288.3 5304.8 5380.5 5389.8 5395.4 5812.2 5823.0 5829.1 5902.4 5904.7 5882.1 5929.5 5948.5 5954.2 5955.5 5231.2 5349.4 5411.9 5423.1 5424.6 5928.7 5985.5 6000.4 6001.1 6003.8 5463.7 5735.9 5736.8 5738.1 5742.4 5633.1 5703.6 5709.7 5732.7 5734.0 5719.8 5728.5 5737.1 5738.7 5739.8 5559.6 5674.9 5688.3 5744.7 5745.6 4445.8 4457.2 4463.7 4498.0 4498.6 3966.5 3970.1 3987.3 3997.6 4016.1 5222.0 5285.5 5356.1 5446.3 5505.6 5794.0 5810.4 5820.7 5849.9 5850.7 5434.4 5440.0 5457.3 5457.4 5457.5 4843.1 4909.1 4965.3 5029.4 5083.3 5949.1 5950.9 5959.1 5960.8 5995.4 5798.6 5799.4 5801.1 5806.4 5809.6 5809.9 5856.6 5895.1 5917.2 5933.8 5680.1 5680.9 5682.6 5683.2 5693.4 5735.0 5744.7 5798.9 5804.7 5809.0 5519.9 5628.4 5673.2 5693.8 5748.7 5683.6 5687.6 5690.5 5690.8 5711.3 5382.2 5606.4 5633.7 5633.8 5641.5 5617.0 5683.2 5694.2 5740.6 5752.3 5580.3 5580.7 5580.8 5584.0 5586.1 06:01:09 INFO - PROCESS | 11895 | 06:01:09 INFO - PROCESS | 11895 | [#1] ext.html Cycles:180 Average:60248.70 Median:41610.19 stddev:120865.29 (290.5%) stddev-sans-first:121121.39 06:01:09 INFO - PROCESS | 11895 | Values: 606.6 616.7 634.3 635.5 658.3 30365.5 33143.0 41311.8 42261.8 42267.2 44159.6 44550.3 44645.0 44766.0 44771.3 8708.0 8901.6 8907.4 8910.6 8911.3 8804.4 8878.0 8889.9 8894.9 8896.6 8876.9 8896.3 8902.2 8904.1 8938.4 8836.1 8877.6 8878.1 8878.5 8882.0 8706.0 8715.4 8733.0 8742.8 8760.3 41543.0 41730.0 41807.6 41817.6 41832.0 3514.6 3518.3 3539.8 3632.6 3635.3 31756.8 32166.5 32472.4 32677.3 32823.0 4428.9 4432.0 4499.8 4526.9 4557.5 349350.0 349779.0 353142.0 461377.0 463475.0 58274.0 58302.7 58347.7 58900.0 58949.0 52614.5 53736.5 53754.0 58595.4 61534.4 16302.1 16559.9 16562.2 16933.1 16976.2 12432.9 12499.9 12548.7 12568.2 12799.0 16591.0 17756.6 18088.5 18672.2 18769.0 6721.5 6773.2 6917.8 7113.8 7206.8 932.7 1033.6 1049.8 1069.5 1125.3 30550.0 31735.0 32244.0 32558.3 34671.3 1070.6 1098.0 1123.2 1161.1 1162.9 15907.4 16590.3 16743.5 16779.2 16866.9 524747.0 528958.0 529629.0 529944.0 531801.0 54758.0 56205.4 56287.0 56299.7 56402.0 1329.4 1340.2 1352.9 1355.8 1380.6 29231.7 30053.4 30256.5 30445.8 30702.5 49207.8 49366.8 49419.8 49633.8 49700.5 423930.0 426231.0 428570.0 430114.0 432099.0 23921.8 25897.7 26855.6 27084.0 27138.2 41677.4 45680.8 45694.3 46147.3 46882.8 38752.8 38819.2 38864.6 38895.4 39306.2 38558.6 38906.0 38910.0 39051.8 39460.0 37391.8 38188.0 38461.6 38712.2 39199.4 33275.0 34662.0 35207.6 35555.8 35570.1 26659.2 27495.7 27654.6 27723.9 27819.3 06:01:09 INFO - PROCESS | 11895 | 06:01:09 INFO - PROCESS | 11895 | [#2] jquery.html Cycles:180 Average:27692.47 Median:20467.06 stddev:76652.41 (374.5%) stddev-sans-first:76839.96 06:01:09 INFO - PROCESS | 11895 | Values: 357.0 377.4 378.8 381.7 393.3 14391.6 17572.7 17973.3 18050.6 19030.7 17183.1 17270.7 17955.4 17955.9 18016.3 5098.4 5272.4 5314.0 5314.0 5316.1 3664.3 3837.7 3843.5 5166.1 5308.9 4136.2 6426.8 6432.0 6527.5 6542.5 6197.8 6392.1 6432.1 6490.6 6526.5 5659.6 5670.8 5684.2 5694.7 5697.4 13522.2 13526.8 13539.5 13549.4 18519.3 2480.4 2519.8 2639.2 2678.8 2836.4 9852.9 9883.3 9981.4 10181.7 10344.6 1775.4 1924.8 1934.3 1961.8 1999.8 78653.6 78894.0 80805.6 81172.6 82195.6 9695.7 10066.7 10945.2 11008.5 11095.8 14375.8 14772.2 14998.9 15009.0 15032.6 7848.0 7983.3 8019.8 8040.4 8074.5 7736.3 7927.6 7964.3 8100.5 8189.1 4615.0 4654.4 4704.7 4754.9 4804.1 1914.2 1928.7 1940.4 1970.2 1997.8 865.3 957.9 986.7 1011.5 1079.4 18302.7 18466.4 18467.6 18510.2 18932.4 914.5 941.9 951.4 962.1 1010.4 10328.4 10514.1 10565.2 10689.0 10716.5 454174.0 458282.0 462672.0 472687.0 473505.0 86125.6 88244.6 88703.0 89024.0 89790.6 929.3 941.1 945.0 961.6 964.7 16188.8 16405.9 16679.0 16722.1 17324.7 31780.0 40540.8 42790.6 42794.4 43270.8 53113.0 53816.7 58651.0 58982.7 58993.7 8721.3 8811.9 8851.2 8870.9 9147.7 9935.3 13835.5 13895.8 14013.6 14277.7 7319.7 11855.1 12154.6 12182.5 12225.4 11928.2 12123.7 12314.3 12485.5 12500.1 12258.0 12287.1 12292.1 12484.8 12580.3 7544.8 7876.8 7955.5 8129.8 8218.6 11995.8 12199.6 12200.9 12246.4 12270.6 06:01:09 INFO - PROCESS | 11895 | 06:01:09 INFO - PROCESS | 11895 | [#3] mootools.html Cycles:180 Average:5868.11 Median:443.63 stddev:3430.00 (773.2%) stddev-sans-first:3422.39 06:01:09 INFO - PROCESS | 11895 | Values: 1293.7 1448.4 1473.8 1568.5 1693.9 8152.5 8473.4 8491.0 8529.8 8789.6 8494.0 8763.2 9035.5 9046.9 9059.3 1980.0 2043.9 2245.5 2254.1 2310.1 2307.1 2329.8 2337.6 2338.5 2340.2 2287.0 2304.4 2309.6 2347.1 2353.0 1926.3 2174.1 2244.2 2250.7 2251.3 2228.8 2245.2 2248.7 2249.7 2252.0 8946.9 8997.4 9050.2 9056.0 9056.4 5151.7 5270.3 5283.5 5286.2 5287.4 3161.5 3301.3 3446.5 3456.3 3460.5 1149.7 1166.9 1169.3 1175.8 1179.4 12317.7 12481.3 12483.5 12524.7 12549.6 4478.8 4594.5 4647.0 4669.6 4679.9 10421.2 10426.3 10436.6 10440.1 10453.2 5295.3 5295.5 5296.1 5301.5 5304.8 4023.5 4210.5 4329.4 4721.5 4895.8 3961.4 3969.8 4044.6 4074.0 4094.4 1203.5 1213.6 1217.0 1220.8 1231.2 907.7 949.2 952.1 962.3 976.7 5916.9 5946.6 6097.8 6188.8 6220.9 427.9 433.6 442.0 445.3 451.1 4071.3 4117.8 4131.9 4140.5 4157.2 10630.7 10881.0 11138.8 11228.6 11245.0 11292.5 11320.9 11615.8 11619.7 11620.3 8137.4 8273.0 8550.6 8609.9 8634.5 5978.7 6057.7 6179.8 6233.9 6268.3 10107.2 10174.7 10389.1 10399.7 10433.9 10338.4 10627.6 10672.7 10679.9 10703.3 7116.4 7787.7 8035.5 8104.6 8113.8 8792.9 8810.0 8847.2 8851.1 8891.4 7592.3 7856.7 7938.6 7942.8 8126.1 7812.0 7869.8 7950.4 7993.6 8153.9 7222.0 7280.5 7281.6 7316.3 7353.2 5217.6 5248.1 5281.4 5303.6 5360.9 4987.3 5108.3 5182.7 5256.5 5258.2 06:01:09 INFO - PROCESS | 11895 | 06:01:09 INFO - PROCESS | 11895 | [#4] prototype.html Cycles:180 Average:4571.34 Median:5177.72 stddev:1363.12 (26.3%) stddev-sans-first:1328.65 06:01:09 INFO - PROCESS | 11895 | Values: 297.0 302.8 312.5 313.5 314.7 5189.7 5199.5 5359.8 5405.7 5462.2 5289.2 5346.5 5347.6 5353.6 5363.9 4173.5 4182.5 4184.0 4190.4 4190.8 3863.6 3939.7 4083.3 4202.9 4212.1 4025.1 4051.4 4064.2 4075.6 4082.7 4022.6 4031.4 4039.5 4044.4 4074.5 3510.5 3553.6 3556.8 3566.7 3566.7 5110.9 5144.0 5154.6 5156.8 5165.7 4615.6 4621.3 4649.8 4667.0 4686.3 5226.2 5454.8 5471.8 5475.7 5503.4 3883.5 3901.2 3924.2 3929.4 3942.4 5666.2 5670.8 5672.3 5677.6 5682.0 3991.7 3999.2 4017.0 4026.9 4031.4 3791.5 3997.1 3997.9 4005.8 4015.3 4605.7 4617.9 4638.1 4651.7 4660.4 5506.0 5533.6 5596.0 5605.0 5632.3 1271.8 1278.9 1363.9 1365.2 1368.2 845.8 861.1 869.9 874.6 881.1 4663.0 4671.5 4672.3 4746.3 4749.4 4940.7 4984.4 5006.9 5008.7 5035.0 4596.8 4644.7 4663.6 4666.9 4739.6 2801.8 2949.6 3028.8 3045.8 3056.5 5768.1 5786.8 5800.6 5879.7 5894.0 5578.8 5808.0 5822.2 5843.2 5847.7 5819.2 5840.8 5856.2 5871.7 5873.6 5645.7 5672.6 5678.4 5689.3 5697.9 5326.4 5627.7 5674.4 5681.7 5682.1 5738.7 5808.9 5816.7 5820.2 5846.8 3776.4 3876.7 3897.1 3951.7 3956.4 5461.8 5515.3 5522.4 5558.7 5604.7 5427.5 5432.5 5485.3 5493.0 5497.6 5219.2 5419.2 5444.7 5502.8 5523.2 5377.5 5407.4 5409.0 5452.4 5455.5 5500.6 5503.5 5525.2 5537.3 5541.9 5143.3 5392.3 5422.7 5463.8 5471.6 06:01:09 INFO - PROCESS | 11895 | 06:01:09 INFO - PROCESS | 11895 | [#5] yui.html Cycles:180 Average:21926.65 Median:3829.45 stddev:32930.31 (859.9%) stddev-sans-first:32984.11 06:01:09 INFO - PROCESS | 11895 | Values: 697.7 733.7 749.1 763.2 784.5 14391.1 15038.8 15178.0 16153.5 16173.0 15989.0 16163.4 16167.5 16180.3 16192.9 646.0 740.8 746.7 761.0 767.5 758.1 766.5 766.8 766.8 766.8 803.1 808.1 808.6 808.7 808.8 662.5 779.6 800.7 801.3 805.7 592.8 593.1 593.9 594.0 594.0 15192.8 15210.1 15210.8 15225.0 15240.4 13460.6 13813.4 14048.7 14071.6 14122.2 11939.9 12268.4 13096.3 13418.3 13614.8 3808.3 3850.6 3886.9 3920.6 3999.8 78030.6 78198.2 78211.6 78774.2 78936.0 11536.2 11578.9 11687.5 11707.6 11755.1 19081.9 20561.0 20613.8 20663.3 20664.9 7958.6 8135.8 8326.8 8337.9 8398.2 4456.7 4549.2 4587.2 4596.9 4642.1 3588.6 3741.4 3744.4 3745.1 3745.4 535.0 631.3 635.8 642.2 653.3 618.9 666.6 723.5 723.9 748.0 9909.4 9930.9 10216.5 10526.1 10537.4 686.7 690.8 704.1 716.8 724.4 4902.3 5033.3 5076.8 5187.7 5210.3 126944.4 127777.0 127827.0 129215.4 129584.4 113417.6 113911.0 114613.1 116518.4 117076.0 95753.5 97721.0 99758.0 99955.5 100086.5 9692.2 9718.6 9762.9 9843.1 10210.8 48515.0 48596.3 49282.0 50144.0 50468.0 55930.2 67354.0 72918.3 74539.6 76276.0 12760.2 12778.5 12804.0 12809.7 13484.1 14216.6 14300.6 14324.9 14633.0 15197.5 14157.6 14533.8 14648.6 14804.5 14856.4 13170.1 13356.0 13394.1 13487.3 14050.1 13394.9 13472.9 13562.3 14744.1 15001.4 10432.6 10889.6 10920.6 10995.6 11583.9 11971.3 11975.9 12033.2 12149.8 12206.8 06:01:09 INFO - PROCESS | 11895 | -------- Summary: end -------- 06:01:09 INFO - PROCESS | 11895 | 06:01:09 INFO - TEST-INFO | 11895: exit 0 06:01:09 INFO - TEST-OK | dromaeo_css | took 1113486ms 06:01:09 INFO - TEST-START | kraken 06:01:09 INFO - operating with platform_type : linux_ 06:01:09 INFO - Initialising browser for kraken test... 06:01:09 INFO - TEST-INFO | started process 12076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN5yaOD/profile http://localhost:55742/getInfo.html) 06:01:13 INFO - PROCESS | 12076 | __metrics Screen width/height:1600/1200 06:01:13 INFO - PROCESS | 12076 | colorDepth:24 06:01:13 INFO - PROCESS | 12076 | Browser inner width/height: 1024/697 06:01:13 INFO - PROCESS | 12076 | __metrics 06:01:14 INFO - PROCESS | 12076 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:01:15 INFO - TEST-INFO | 12076: exit 0 06:01:15 INFO - Browser initialized. 06:01:15 INFO - Running cycle 1/1 for kraken test... 06:01:15 INFO - TEST-INFO | started process 12159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN5yaOD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:27 INFO - PROCESS | 12159 | RSS: Main: 173400064 06:01:27 INFO - PROCESS | 12159 | 06:01:30 INFO - PROCESS | 12159 | Cycle 1(1): loaded http://localhost:55742/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55742/tests/kraken/driver.html?testName=audio-beat-detection) 06:01:30 INFO - PROCESS | 12159 | RSS: Main: 233000960 06:01:30 INFO - PROCESS | 12159 | 06:01:33 INFO - PROCESS | 12159 | Cycle 1(1): loaded http://localhost:55742/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55742/tests/kraken/driver.html?testName=audio-dft) 06:01:34 INFO - PROCESS | 12159 | RSS: Main: 220688384 06:01:34 INFO - PROCESS | 12159 | 06:01:37 INFO - PROCESS | 12159 | Cycle 1(1): loaded http://localhost:55742/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55742/tests/kraken/driver.html?testName=audio-fft) 06:01:38 INFO - PROCESS | 12159 | RSS: Main: 287019008 06:01:38 INFO - PROCESS | 12159 | 06:01:40 INFO - PROCESS | 12159 | Cycle 1(1): loaded http://localhost:55742/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55742/tests/kraken/driver.html?testName=audio-oscillator) 06:01:40 INFO - PROCESS | 12159 | RSS: Main: 198766592 06:01:40 INFO - PROCESS | 12159 | 06:01:43 INFO - PROCESS | 12159 | Cycle 1(1): loaded http://localhost:55742/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55742/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:01:43 INFO - PROCESS | 12159 | RSS: Main: 202989568 06:01:43 INFO - PROCESS | 12159 | 06:01:46 INFO - PROCESS | 12159 | Cycle 1(1): loaded http://localhost:55742/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55742/tests/kraken/driver.html?testName=imaging-darkroom) 06:01:47 INFO - PROCESS | 12159 | RSS: Main: 238301184 06:01:47 INFO - PROCESS | 12159 | 06:01:50 INFO - PROCESS | 12159 | Cycle 1(1): loaded http://localhost:55742/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55742/tests/kraken/driver.html?testName=imaging-desaturate) 06:01:51 INFO - PROCESS | 12159 | RSS: Main: 238870528 06:01:51 INFO - PROCESS | 12159 | 06:01:54 INFO - PROCESS | 12159 | Cycle 1(1): loaded http://localhost:55742/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55742/tests/kraken/driver.html?testName=json-parse-financial) 06:01:54 INFO - PROCESS | 12159 | RSS: Main: 238411776 06:01:54 INFO - PROCESS | 12159 | 06:01:56 INFO - PROCESS | 12159 | Cycle 1(1): loaded http://localhost:55742/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55742/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:01:56 INFO - PROCESS | 12159 | RSS: Main: 226770944 06:01:56 INFO - PROCESS | 12159 | 06:01:58 INFO - PROCESS | 12159 | Cycle 1(1): loaded http://localhost:55742/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55742/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:01:59 INFO - PROCESS | 12159 | RSS: Main: 229662720 06:01:59 INFO - PROCESS | 12159 | 06:02:01 INFO - PROCESS | 12159 | Cycle 1(1): loaded http://localhost:55742/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55742/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:02:01 INFO - PROCESS | 12159 | RSS: Main: 238370816 06:02:01 INFO - PROCESS | 12159 | 06:02:04 INFO - PROCESS | 12159 | Cycle 1(1): loaded http://localhost:55742/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:02:05 INFO - PROCESS | 12159 | RSS: Main: 242356224 06:02:05 INFO - PROCESS | 12159 | 06:02:07 INFO - PROCESS | 12159 | Cycle 1(1): loaded http://localhost:55742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:02:08 INFO - PROCESS | 12159 | RSS: Main: 243077120 06:02:08 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | Cycle 1(1): loaded http://localhost:55742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55742/tests/kraken/driver.html?testName=ai-astar) 06:02:10 INFO - PROCESS | 12159 | RSS: Main: 285298688 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | __start_tp_report 06:02:10 INFO - PROCESS | 12159 | _x_x_mozilla_page_load 06:02:10 INFO - PROCESS | 12159 | _x_x_mozilla_page_load_details 06:02:10 INFO - PROCESS | 12159 | |i|pagename|runs| 06:02:10 INFO - PROCESS | 12159 | |0;ai-astar;109;104;107;108;111;109;112;109;109;112 06:02:10 INFO - PROCESS | 12159 | |1;audio-beat-detection;152;131;134;184;132;125;166;125;168;126 06:02:10 INFO - PROCESS | 12159 | |2;audio-dft;163;161;161;160;160;162;160;161;162;160 06:02:10 INFO - PROCESS | 12159 | |3;audio-fft;75;75;83;126;74;75;73;74;107;74 06:02:10 INFO - PROCESS | 12159 | |4;audio-oscillator;85;86;115;85;86;85;131;85;85;134 06:02:10 INFO - PROCESS | 12159 | |5;imaging-gaussian-blur;117;118;117;117;117;118;117;118;118;118 06:02:10 INFO - PROCESS | 12159 | |6;imaging-darkroom;146;147;147;145;146;145;146;146;146;148 06:02:10 INFO - PROCESS | 12159 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;97;96 06:02:10 INFO - PROCESS | 12159 | |8;json-parse-financial;53;57;53;54;61;53;53;55;52;55 06:02:10 INFO - PROCESS | 12159 | |9;json-stringify-tinderbox;62;63;62;63;63;63;63;62;63;63 06:02:10 INFO - PROCESS | 12159 | |10;stanford-crypto-aes;80;93;78;81;85;81;81;82;121;80 06:02:10 INFO - PROCESS | 12159 | |11;stanford-crypto-ccm;124;125;129;134;133;129;131;130;138;131 06:02:10 INFO - PROCESS | 12159 | |12;stanford-crypto-pbkdf2;160;159;167;159;163;166;161;162;160;159 06:02:10 INFO - PROCESS | 12159 | |13;stanford-crypto-sha256-iterative;64;66;67;62;63;63;64;61;63;65 06:02:10 INFO - PROCESS | 12159 | __end_tp_report 06:02:10 INFO - PROCESS | 12159 | __start_cc_report 06:02:10 INFO - PROCESS | 12159 | _x_x_mozilla_cycle_collect,1634 06:02:10 INFO - PROCESS | 12159 | __end_cc_report 06:02:10 INFO - PROCESS | 12159 | __startTimestamp1466254930416__endTimestamp 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | ------- Summary: start ------- 06:02:10 INFO - PROCESS | 12159 | Number of tests: 14 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.00 stddev:2.40 (2.2%) stddev-sans-first:2.55 06:02:10 INFO - PROCESS | 12159 | Values: 109.0 104.0 107.0 108.0 111.0 109.0 112.0 109.0 109.0 112.0 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:143.00 stddev:21.56 (15.1%) stddev-sans-first:22.68 06:02:10 INFO - PROCESS | 12159 | Values: 152.0 131.0 134.0 184.0 132.0 125.0 166.0 125.0 168.0 126.0 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:0.83 06:02:10 INFO - PROCESS | 12159 | Values: 163.0 161.0 161.0 160.0 160.0 162.0 160.0 161.0 162.0 160.0 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | [#3] audio-fft Cycles:10 Average:83.60 Median:74.50 stddev:18.12 (24.3%) stddev-sans-first:18.95 06:02:10 INFO - PROCESS | 12159 | Values: 75.0 75.0 83.0 126.0 74.0 75.0 73.0 74.0 107.0 74.0 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:85.00 stddev:20.56 (24.2%) stddev-sans-first:21.29 06:02:10 INFO - PROCESS | 12159 | Values: 85.0 86.0 115.0 85.0 86.0 85.0 131.0 85.0 85.0 134.0 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:02:10 INFO - PROCESS | 12159 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 06:02:10 INFO - PROCESS | 12159 | Values: 146.0 147.0 147.0 145.0 146.0 145.0 146.0 146.0 146.0 148.0 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 06:02:10 INFO - PROCESS | 12159 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:2.67 (4.9%) stddev-sans-first:2.77 06:02:10 INFO - PROCESS | 12159 | Values: 53.0 57.0 53.0 54.0 61.0 53.0 53.0 55.0 52.0 55.0 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 06:02:10 INFO - PROCESS | 12159 | Values: 62.0 63.0 62.0 63.0 63.0 63.0 63.0 62.0 63.0 63.0 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:81.00 stddev:12.92 (15.9%) stddev-sans-first:13.50 06:02:10 INFO - PROCESS | 12159 | Values: 80.0 93.0 78.0 81.0 85.0 81.0 81.0 82.0 121.0 80.0 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:131.00 stddev:4.12 (3.1%) stddev-sans-first:3.66 06:02:10 INFO - PROCESS | 12159 | Values: 124.0 125.0 129.0 134.0 133.0 129.0 131.0 130.0 138.0 131.0 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:161.50 stddev:2.91 (1.8%) stddev-sans-first:3.03 06:02:10 INFO - PROCESS | 12159 | Values: 160.0 159.0 167.0 159.0 163.0 166.0 161.0 162.0 160.0 159.0 06:02:10 INFO - PROCESS | 12159 | 06:02:10 INFO - PROCESS | 12159 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.81 (2.8%) stddev-sans-first:1.92 06:02:10 INFO - PROCESS | 12159 | Values: 64.0 66.0 67.0 62.0 63.0 63.0 64.0 61.0 63.0 65.0 06:02:10 INFO - PROCESS | 12159 | -------- Summary: end -------- 06:02:10 INFO - PROCESS | 12159 | 06:02:11 INFO - TEST-INFO | 12159: exit 0 06:02:11 INFO - TEST-OK | kraken | took 61652ms 06:02:11 INFO - SUITE-END | took 1175s 06:02:11 INFO - Completed test suite (00:19:35) 06:02:11 INFO - javascript benchmark 06:02:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3091.799033062851, 3110.3623757129785, 3122.9375412491745, 3131.4363414585396, 3144.905652830416, 5242.68543887367, 5306.681599104051, 5315.123004704229, 5386.461353864612, 5419.729013549321, 5368.275282836816, 5388.299521062267, 5397.62216644835, 5432.0, 5511.862203444916, 4870.756462176886, 4945.530174633404, 4950.6287028472825, 4956.653034287601, 5003.649744517885, 4959.132151873426, 4992.251162325644, 4998.850034498971, 5030.899382012358, 5037.1940489521685, 4772.594329481998, 4820.325154478376, 4836.0, 4907.975460122694, 4909.901801963959, 4893.584045356149, 4901.779419926076, 4904.0, 4910.1898186799135, 4914.533119353691, 4860.1251774680895, 4861.2222044473065, 4866.7566621668775, 4870.659053866196, 4872.634552408548, 5288.312519372495, 5304.840854774363, 5380.542653874425, 5389.78440862365, 5395.433479484637, 5812.244408226903, 5823.0, 5829.125631155318, 5902.409759024106, 5904.675242861641, 5882.117682347639, 5929.495992840613, 5948.494377977877, 5954.196183515213, 5955.464008239236, 5231.241469986869, 5349.384820745586, 5411.945880541223, 5423.132298832168, 5424.566034717213, 5928.686372490888, 5985.461308482258, 6000.369961154103, 6001.129836173817, 6003.759849605967, 5463.672179669233, 5735.856603584861, 5736.770529178786, 5738.110592858114, 5742.368339482654, 5633.126865335879, 5703.572232082611, 5709.74306156224, 5732.71336433185, 5733.971330143406, 5719.771209151588, 5728.484436400744, 5737.08206686928, 5738.713064346766, 5739.7704091836695, 5559.610827242135, 5674.858128546737, 5688.260526131577, 5744.655320680772, 5745.597808153389, 4445.777711114431, 4457.24226881431, 4463.665225108065, 4497.955020449819, 4498.572635599613, 3966.5438474575794, 3970.1265721541213, 3987.342088555356, 3997.5802540733384, 4016.0763024504527, 5221.973890130525, 5285.471452854684, 5356.0894647909945, 5446.264754258124, 5505.614606977553, 5793.971030144822, 5810.360860305363, 5820.679862607512, 5849.941500585025, 5850.678212698257, 5434.402215756264, 5439.972800135974, 5457.290552228185, 5457.399686034533, 5457.454254574511, 4843.104025755247, 4909.116359055404, 4965.255211718271, 5029.421616514074, 5083.288339632454, 5949.10763385487, 5950.940490595039, 5959.0763431668165, 5960.761569537257, 5995.400459953969, 5798.5651076168615, 5799.449052340021, 5801.129830525455, 5806.390329015392, 5809.564282678901, 5809.8547536311935, 5856.560757943086, 5895.056790913433, 5917.201177840936, 5933.821985340447, 5680.062789639664, 5680.886382272414, 5682.573806964411, 5683.204351390891, 5693.430656934273, 5734.971325143348, 5744.655320680772, 5798.913016304675, 5804.738786754522, 5809.0415081512765, 5519.917201242065, 5628.380878103323, 5673.234113394639, 5693.772249109989, 5748.655080695172, 5683.5737319700365, 5687.573431992534, 5690.544756419394, 5690.77236910519, 5711.286089238845, 5382.246485491956, 5606.383297837153, 5633.746481408264, 5633.802816901552, 5641.492265696107, 5617.045102332695, 5683.204351390726, 5694.202811606461, 5740.6268592541355, 5752.252207213036, 5580.302462192226, 5580.665160090408, 5580.832575022756, 5584.022796010763, 5586.078297081099], "value": 5326.333234987457, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.6380974711772, 616.7224748863013, 634.2737565487515, 635.4916067146282, 658.2561705273041, 30365.544516832237, 33143.0, 41311.79344103279, 42261.7886910565, 42267.154656906845, 44159.55840441595, 44550.33174502377, 44645.0, 44766.0, 44771.328430073576, 8708.04211536732, 8901.599428025755, 8907.421017633866, 8910.55447227636, 8911.331650126234, 8804.383693141483, 8878.0, 8889.866652000224, 8894.86657700135, 8896.59965301563, 8876.8668469973, 8896.332775041865, 8902.198802107809, 8904.065073167321, 8938.374313798036, 8836.0722124177, 8877.644894204224, 8878.112188781135, 8878.511681857528, 8881.955590222007, 8706.0, 8715.389922705413, 8732.95204575455, 8742.825143497159, 8760.342974276891, 41543.0, 41730.0, 41807.581924180675, 41817.581824181674, 41831.95420114491, 3514.5958214805114, 3518.2787528556582, 3539.752217344787, 3632.5822530409077, 3635.309291234657, 31756.841215793775, 32166.517502237486, 32472.350552989043, 32677.346453071044, 32823.0, 4428.933565996513, 4431.962527786598, 4499.797509112098, 4526.932096018562, 4557.5442455754155, 349350.0, 349779.0, 353142.0, 461377.0, 463475.0, 58274.0, 58302.7084864573, 58347.70826145927, 58900.0, 58949.0, 52614.47385526172, 53736.46263537393, 53754.0, 58595.41404585985, 61534.38465615376, 16302.10338431374, 16559.91720041392, 16562.17189140538, 16933.068681222652, 16976.236069376908, 12432.937835310766, 12499.875001250053, 12548.749025019448, 12568.245905245714, 12799.040071994452, 16591.0, 17756.644867102586, 18088.547786305186, 18672.159752811156, 18769.0, 6721.495887808336, 6773.221079575814, 6917.757878474229, 7113.75101871432, 7206.819829504199, 932.6922115701802, 1033.6433930294036, 1049.8477720730605, 1069.5133714160038, 1125.319181894958, 30550.0, 31735.0, 32244.0, 32558.348833023207, 34671.30657386838, 1070.571771291474, 1098.0392156862745, 1123.230587047875, 1161.0943464098018, 1162.9244099133698, 15907.443239486562, 16590.253438595293, 16743.497695069167, 16779.161041948097, 16866.915665421595, 524747.0, 528958.0, 529629.0, 529944.0, 531801.0, 54758.0, 56205.43794562084, 56287.0, 56299.71850140723, 56402.0, 1329.4416345135066, 1340.1891855427325, 1352.905296629246, 1355.8034085057611, 1380.5996261084174, 29231.707682922897, 30053.398932021675, 30256.54615180818, 30445.84777076189, 30702.539461908535, 49207.753961229966, 49366.75316623394, 49419.75290123526, 49633.75183124061, 49700.50299496959, 423930.0, 426231.0, 428570.0, 430114.0, 432099.0, 23921.760782391953, 25897.741022589533, 26855.597166042135, 27084.0, 27138.1858544244, 41677.37483937804, 45680.77159614181, 45694.31458528058, 46147.307790382496, 46882.76558617185, 38752.80623596864, 38819.2236155281, 38864.61135388723, 38895.41656875206, 39306.2138757229, 38558.61441385662, 38906.0, 38910.0, 39051.80474097725, 39460.0, 37391.81304093462, 38188.0, 38461.615383845805, 38712.2257554853, 39199.41200881932, 33275.0, 34662.0, 35207.647923521465, 35555.82222088873, 35570.11074723153, 26659.20022399331, 27495.725042750117, 27654.585181221897, 27723.861380692968, 27819.304517387227], "value": 19767.911696258874, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.95538057742783, 377.3584905660378, 378.8371000469797, 381.728972429575, 393.3234836081938, 14391.640208994768, 17572.736408953875, 17973.28106875725, 18050.63898722025, 19030.714539281922, 17183.140842957833, 17270.704697147732, 17955.371561995333, 17955.91022044888, 18016.279348826065, 5098.362704661918, 5272.367315922094, 5313.9637770634745, 5313.9734301328435, 5316.0962636351915, 3664.3037822813712, 3837.712171587128, 3843.5195600549932, 5166.07010738067, 5308.9116731070035, 4136.214119317335, 6426.839329016765, 6431.967840160816, 6527.47780177587, 6542.542022058457, 6197.752089916398, 6392.105105285264, 6432.131662225586, 6490.610563366189, 6526.510511711617, 5659.60382773206, 5670.8015219467125, 5684.204211410406, 5694.6867922264255, 5697.430256974311, 13522.18866867991, 13526.797098043537, 13539.526116585872, 13549.390277437538, 18519.2592296308, 2480.4295012147127, 2519.7858182054547, 2639.1818536253822, 2678.7723043541323, 2836.405690756989, 9852.935339181578, 9883.308168428213, 9981.401115933068, 10181.694549163536, 10344.586216551405, 1775.3519965212604, 1924.8363889069446, 1934.2571576474397, 1961.7547806524185, 1999.7600287965392, 78653.60673196655, 78894.0, 80805.59597202035, 81172.59413702953, 82195.58902205511, 9695.70912872615, 10066.69799906004, 10945.179111566664, 11008.504617292241, 11095.778084438427, 14375.78436323456, 14772.187529685756, 14998.850011499746, 15009.0, 15032.624184395478, 7848.0, 7983.281504664608, 8019.759407217793, 8040.437169398086, 8074.515529068275, 7736.2650548197835, 7927.643256053491, 7964.283214510722, 8100.513969161869, 8189.058258300252, 4615.0, 4654.394928659321, 4704.69419487739, 4754.881127971828, 4804.06320767454, 1914.15777058094, 1928.7299778031088, 1940.427573865713, 1970.2020681623965, 1997.7602687677572, 865.2688478235881, 957.8850537935492, 986.7286496213455, 1011.4790882695418, 1079.3901445683164, 18302.725459118123, 18466.446006619823, 18467.630647386977, 18510.16704248312, 18932.43202703921, 914.533587870191, 941.8963913969458, 951.3673407184145, 962.0956301077105, 1010.3836659637615, 10328.431936243578, 10514.106300964351, 10565.154787617126, 10689.0, 10716.464176791129, 454174.0, 458282.0, 462672.0, 472687.0, 473505.0, 86125.56937215274, 88244.55877720698, 88703.0, 89024.0, 89790.55104724565, 929.2798081486902, 941.0730430525927, 944.9716508504619, 961.6441916490943, 964.6912987843963, 16188.757168642243, 16405.91797041007, 16678.999260044435, 16722.076961149625, 17324.740128897825, 31780.04659860208, 40540.79729601451, 42790.5720942799, 42794.35808462938, 43270.78364608157, 53113.0, 53816.730916345165, 58651.01466375235, 58982.70508647601, 58993.705031474565, 8721.302295816446, 8811.911880881109, 8851.247643950337, 8870.935487741512, 9147.679831205876, 9935.254855885982, 13835.515756948458, 13895.791563126359, 14013.579592612237, 14277.714445711235, 7319.670614822452, 11855.051595872137, 12154.635360939186, 12182.512699491921, 12225.388730563258, 11928.224665396721, 12123.696907577381, 12314.322712250912, 12485.500579976699, 12500.124991250525, 12258.0, 12287.1399002069, 12292.078094143153, 12484.750304994031, 12580.30808305552, 7544.773656790305, 7876.763697089096, 7955.4828936118965, 8129.79675508117, 8218.630161642861, 11995.820062698893, 12199.634010979686, 12200.877991219973, 12246.387680615755, 12270.570530031406], "value": 8924.794547720272, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1293.695981444361, 1448.3989144505028, 1473.8378778334384, 1568.5451219146448, 1693.872959528035, 8152.510849349043, 8473.44922580032, 8491.0, 8529.829403411928, 8789.648414063446, 8494.0, 8763.167499087593, 9035.457872527637, 9046.86429703555, 9059.320550958688, 1979.9703004454946, 2043.8875861827594, 2245.5059886824956, 2254.120892851789, 2310.09906136606, 2307.1463558483383, 2329.8485598436046, 2337.5857606148293, 2338.5089131282452, 2340.180936672168, 2286.965695514569, 2304.354780661409, 2309.607366747657, 2347.061175529793, 2353.0234952494693, 1926.3257859749117, 2174.14121422039, 2244.2257421189665, 2250.707408036961, 2251.268337790225, 2228.832837537191, 2245.2253972379503, 2248.730152381708, 2249.707538020063, 2251.9887400563057, 8946.910530894738, 8997.415168014059, 9050.230730387924, 9056.0, 9056.411333263317, 5151.665141765773, 5270.314859068335, 5283.524482796567, 5286.180642000496, 5287.4448182941005, 3161.4783560712453, 3301.323228738103, 3446.4657978013197, 3456.3087382523345, 3460.463628137643, 1149.672343382132, 1166.8891455311732, 1169.2777232775386, 1175.8295047218191, 1179.445660539545, 12317.69205769854, 12481.251124932442, 12483.50065997368, 12524.74950500994, 12549.560765373168, 4478.753668548261, 4594.47163576193, 4647.024124933801, 4669.603083737852, 4679.859604211879, 10421.166306695446, 10426.270161088803, 10436.5825366986, 10440.112590429746, 10453.163746900229, 5295.338082739658, 5295.523402893758, 5296.073187192226, 5301.469853014668, 5304.787808487617, 4023.5372932112596, 4210.45264115663, 4329.437173167468, 4721.504242054535, 4895.8041678332465, 3961.4255932890146, 3969.8412063517135, 4044.595540445932, 4074.0, 4094.406311084876, 1203.4825025239231, 1213.5995121609847, 1216.969575760613, 1220.7558488302375, 1231.2181764579557, 907.7065182115459, 949.2168960607527, 952.1002652493328, 962.2638681408728, 976.6581696406344, 5916.940830591639, 5946.583739138306, 6097.847553811191, 6188.783392581328, 6220.911340515392, 427.9208346455916, 433.55127443096245, 441.98232070717455, 445.2830942183083, 451.0617914737338, 4071.307877660805, 4117.794110294473, 4131.9173616528105, 4140.503139623264, 4157.168566286755, 10630.734231644115, 10881.0, 11138.777224455465, 11228.606998755167, 11245.044171245372, 11292.54829806815, 11320.886791131983, 11615.76768464626, 11619.709507262218, 11620.302781833117, 8137.430379873471, 8272.958635206785, 8550.615222314886, 8609.913900861036, 8634.481931084156, 5978.671173085522, 6057.697115144137, 6179.81460556184, 6233.937660623335, 6268.279147897868, 10107.191424686154, 10174.745631359276, 10389.064984151462, 10399.740006499898, 10433.852276249454, 10338.431386273827, 10627.628033018807, 10672.679819605424, 10679.94660026726, 10703.250772445854, 7116.430685545248, 7787.727429540166, 8035.517868927883, 8104.635291411782, 8113.8377232456205, 8792.868106978272, 8810.030896601496, 8847.159519845605, 8851.070637582961, 8891.377603567948, 7592.316691497792, 7856.685732570633, 7938.64276107565, 7942.841143177219, 8126.146754590683, 7812.0, 7869.803254918673, 7950.40371972116, 7993.560354180576, 8153.918460815553, 7221.963890180516, 7280.490365674352, 7281.599512026889, 7316.304951029643, 7353.191148973716, 5217.556507696737, 5248.08158572256, 5281.392639846466, 5303.602229832855, 5360.892782144413, 4987.326710893983, 5108.28484012246, 5182.689038657692, 5256.526912577733, 5258.2375555544995], "value": 4562.899858414349, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.0094734061902, 302.83646830711416, 312.5312031952072, 313.47962382445144, 314.69631805307876, 5189.740512974355, 5199.4800519948085, 5359.812406565771, 5405.729713514318, 5462.180672899062, 5289.153735402337, 5346.465353464651, 5347.59893008024, 5353.625246232766, 5363.927214557085, 4173.457450531427, 4182.539920608739, 4184.0, 4190.371444283367, 4190.769507677077, 3863.632954869283, 3939.72421930465, 4083.3466645336603, 4202.873913782591, 4212.094399704063, 4025.134596061846, 4051.392291156321, 4064.227796718614, 4075.6331930126285, 4082.6733861291173, 4022.6178513041214, 4031.354983202703, 4039.515258169009, 4044.352903535435, 4074.490688663917, 3510.4558793387064, 3553.626869178725, 3556.808469162808, 3566.6789988900864, 3566.698155173369, 5110.872228194287, 5144.045262800112, 5154.561862241677, 5156.767945442464, 5165.690058596496, 4615.607673347769, 4621.2837010263465, 4649.8372556960685, 4666.976665116653, 4686.297055441677, 5226.216067589892, 5454.809081682161, 5471.781128754845, 5475.7262136893, 5503.394626591072, 3883.49514563105, 3901.1612503311926, 3924.156306394139, 3929.351656976595, 3942.448057271984, 5666.150077488369, 5670.801521946753, 5672.326663634238, 5677.6309539880185, 5682.0, 3991.7426010806503, 3999.24014437256, 4016.979915100406, 4026.939595906064, 4031.3952907064177, 3791.50235656914, 3997.140614767839, 3997.900052498711, 4005.839766409311, 4015.257177422186, 4605.723656580616, 4617.907641847211, 4638.141943740419, 4651.697639653412, 4660.39414876064, 5506.0, 5533.584981126432, 5596.0, 5604.97197514018, 5632.295963004624, 1271.8346614939999, 1278.9232646041266, 1363.8772510473907, 1365.208179256029, 1368.2269517722455, 845.8223773007614, 861.0786458489481, 869.913008699125, 874.5758307220992, 881.0836430763064, 4662.95337046632, 4671.462781780071, 4672.252439609646, 4746.311784791186, 4749.3588365570895, 4940.654154209243, 4984.42679091909, 5006.945763084515, 5008.69947803133, 5034.974825125851, 4596.781852809008, 4644.674872758942, 4663.556962088596, 4666.929996050062, 4739.573438390561, 2801.817881837674, 2949.6460424749166, 3028.8338989489207, 3045.83247921362, 3056.541518772202, 5768.105943578668, 5786.797462088891, 5800.636850340166, 5879.706014699248, 5893.970530147408, 5578.804741834017, 5808.0, 5822.155787410802, 5843.181954526284, 5847.690162385834, 5819.243498345188, 5840.8247752567495, 5856.238688970407, 5871.706414679335, 5873.559483038789, 5645.68948707825, 5672.5745569081655, 5678.432156784289, 5689.34572524165, 5697.943020569741, 5326.4407237241085, 5627.746751396279, 5674.404187560247, 5681.659100453986, 5682.14767784819, 5738.713064346849, 5808.854778630568, 5816.651000939957, 5820.177214051267, 5846.824595262149, 3776.37689781194, 3876.7480113792512, 3897.103666156743, 3951.7431366961055, 3956.4263181837896, 5461.754221059982, 5515.283013208257, 5522.447755224445, 5558.694271815089, 5604.663720176803, 5427.457254274541, 5432.511074003359, 5485.314335708036, 5493.0, 5497.587680923867, 5219.182899226964, 5419.2413062170535, 5444.700541470257, 5502.752376143163, 5523.1991361253195, 5377.542908852792, 5407.351117865881, 5409.0, 5452.400235974119, 5455.509004189642, 5500.559955203654, 5503.504684578407, 5525.226468294361, 5537.2524709163745, 5541.861453463534, 5143.305653736697, 5392.299001129828, 5422.671445495721, 5463.754131064191, 5471.632091977006], "value": 4126.274811963183, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.7139372857126, 733.7065173930431, 749.0973377080618, 763.2062654838968, 784.5253621558956, 14391.136531808073, 15038.774418383706, 15178.0, 16153.515394538168, 16173.0, 15989.0, 16163.434279800209, 16167.514974550753, 16180.27188776505, 16192.919035404806, 646.0374042676425, 740.7518481308769, 746.7162478258268, 761.0410882288302, 767.5279702982654, 758.0524344569288, 766.5362455714269, 766.7546385156752, 766.789132988427, 766.8082979255187, 803.0564087197549, 808.0707186735243, 808.6159074439653, 808.7088648086684, 808.8301456694102, 662.5395350231591, 779.6101949025488, 800.7277525641281, 801.3469022746443, 805.7099444200084, 592.8428966323928, 593.1429084972217, 593.9287285525721, 593.9524838012949, 594.0317282829004, 15192.848071519255, 15210.08739475635, 15210.771838422323, 15225.0, 15240.390384384722, 13460.596182114454, 13813.378397972116, 14048.71902561943, 14071.577852664437, 14122.22327771972, 11939.94030029853, 12268.38658067102, 13096.279704616243, 13418.329083545783, 13614.795778063337, 3808.333541630231, 3850.5571859236265, 3886.9222615547533, 3920.6473766550494, 3999.8200080996135, 78030.60984695097, 78198.21801781966, 78211.60894195492, 78774.21225787725, 78936.0, 11536.192466527431, 11578.884211157949, 11687.532498700128, 11707.648770536898, 11755.118366122404, 19081.904590477236, 20561.0, 20613.793862061488, 20663.276785312442, 20664.896675516826, 7958.6418611162635, 8135.837283254302, 8326.750197494084, 8337.916070910744, 8398.202170793766, 4456.665750068693, 4549.158405694957, 4587.220172570671, 4596.931046034312, 4642.141203877293, 3588.551431071116, 3741.3639681254253, 3744.43833424983, 3745.0637340664834, 3745.4194599836524, 534.9518543331119, 631.3150231998242, 635.8473966248159, 642.2421542579707, 653.3238098568054, 618.8700372921737, 666.6000399760202, 723.4574069447914, 723.9493235473466, 747.970081196746, 9909.405435673883, 9930.900690992998, 10216.540255688511, 10526.105281051043, 10537.367757934548, 686.7459040155074, 690.848013437043, 704.1057856522189, 716.7563028570207, 724.3589423360364, 4902.289168070681, 5033.295338652591, 5076.82231121909, 5187.688738675692, 5210.270562121306, 126944.36527817302, 127777.0, 127827.0, 129215.35392323167, 129584.35207823901, 113417.62785418921, 113911.0, 114613.1117543832, 116518.41740791242, 117076.0, 95753.5212323934, 97721.0, 99757.99999999854, 99955.50022249988, 100086.49956750315, 9692.17308304159, 9718.562664680248, 9762.853557196506, 9843.090553044693, 10210.846837297595, 48515.0, 48596.2710559349, 49282.0, 50144.0, 50468.0, 55930.161047585134, 67354.0, 72918.27081729328, 74539.62730186315, 76276.0, 12760.170588912062, 12778.488860445477, 12804.0, 12809.743805124031, 13484.12353197039, 14216.644583885485, 14300.570982870531, 14324.85675143277, 14633.0, 15197.468088616846, 14157.575272741835, 14533.78199327032, 14648.633784155481, 14804.456763522041, 14856.40574377056, 13170.143940643828, 13356.0, 13394.129381590166, 13487.25820079905, 14050.086744361584, 13394.866051339752, 13472.932635336761, 13562.321883905963, 14744.115353078849, 15001.399944002118, 10432.582696692047, 10889.564417423215, 10920.56317747313, 10995.61515346991, 11583.942080289544, 11971.341576213392, 11975.940120299343, 12033.157678962389, 12149.81775273354, 12206.816897746363], "value": 7621.530681332918, "unit": "score"}], "name": "dromaeo_css", "value": 7161.088738809778, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 107.0, 108.0, 111.0, 109.0, 112.0, 109.0, 109.0, 112.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 131.0, 134.0, 184.0, 132.0, 125.0, 166.0, 125.0, 168.0, 126.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 160.0, 160.0, 162.0, 160.0, 161.0, 162.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 83.0, 126.0, 74.0, 75.0, 73.0, 74.0, 107.0, 74.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 115.0, 85.0, 86.0, 85.0, 131.0, 85.0, 85.0, 134.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 148.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 53.0, 54.0, 61.0, 53.0, 53.0, 55.0, 52.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 93.0, 78.0, 81.0, 85.0, 81.0, 81.0, 82.0, 121.0, 80.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 129.0, 134.0, 133.0, 129.0, 131.0, 130.0, 138.0, 131.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 167.0, 159.0, 163.0, 166.0, 161.0, 162.0, 160.0, 159.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 67.0, 62.0, 63.0, 63.0, 64.0, 61.0, 63.0, 65.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1514.6, "alertThreshold": 2.0}]} 06:02:11 INFO - Return code: 0 06:02:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:02:11 INFO - # TBPL SUCCESS # 06:02:11 INFO - Running post-action listener: _resource_record_post_action 06:02:11 INFO - ##### 06:02:11 INFO - ##### Finished run-tests step (success) 06:02:11 INFO - ##### 06:02:11 INFO - Running post-run listener: _resource_record_post_run 06:02:11 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 550694912; Read time: 0; Write time: 423096 06:02:11 INFO - TinderboxPrint: CPU usage
13.2% 06:02:11 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:02:11 INFO - TinderboxPrint: I/O write bytes / time
550,694,912 / 423,096 06:02:11 INFO - TinderboxPrint: CPU idle
8,262.5 (86.8%) 06:02:11 INFO - TinderboxPrint: CPU user
1,210.8 (12.7%) 06:02:11 INFO - TinderboxPrint: Swap in / out
0 / 0 06:02:11 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256372736; Read time: 0; Write time: 245936 06:02:11 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 294322176; Read time: 0; Write time: 177160 06:02:12 INFO - Running post-run listener: _upload_blobber_files 06:02:12 INFO - Blob upload gear active. 06:02:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:02:12 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 06:02:12 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:02:12 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:02:12 INFO - (blobuploader) - INFO - Open directory for files ... 06:02:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:02:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:02:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:13 INFO - (blobuploader) - INFO - Done attempting. 06:02:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:02:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:02:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:14 INFO - (blobuploader) - INFO - Done attempting. 06:02:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:02:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:02:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:17 INFO - (blobuploader) - INFO - Done attempting. 06:02:17 INFO - (blobuploader) - INFO - Iteration through files over. 06:02:17 INFO - Return code: 0 06:02:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:02:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:02:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6892b88ce0733ab60e24f952ed4bb912eb1b71a84caa8c32ab9ab8105ae0193ba0adebc4eccd8160543a45dd64984274dd161af5e5960ddfd06fa314a52e26b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af42c5b4804f52f2a5cd39e284873086e0385c80831b5b40857034967a3b206a34265768c2cfdb6c3677308981e30a57b449888fd8f6731f73b73492a7d73de8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58dc465d79ddd53a82a7f52180d8fe196ddbf2604311b683ae2d93b32037d26a8ccbebaee14df58553185f7e11bc973af970be79c08e6bba3af8dfcfb38d511d"} 06:02:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:02:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:02:17 INFO - Contents: 06:02:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6892b88ce0733ab60e24f952ed4bb912eb1b71a84caa8c32ab9ab8105ae0193ba0adebc4eccd8160543a45dd64984274dd161af5e5960ddfd06fa314a52e26b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af42c5b4804f52f2a5cd39e284873086e0385c80831b5b40857034967a3b206a34265768c2cfdb6c3677308981e30a57b449888fd8f6731f73b73492a7d73de8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58dc465d79ddd53a82a7f52180d8fe196ddbf2604311b683ae2d93b32037d26a8ccbebaee14df58553185f7e11bc973af970be79c08e6bba3af8dfcfb38d511d"} 06:02:17 INFO - Running post-run listener: copy_logs_to_upload_dir 06:02:17 INFO - Copying logs to upload dir... 06:02:17 INFO - mkdir: /builds/slave/test/build/upload/logs 06:02:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.510347 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-18 06:02:17.076109) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 06:02:17.079999) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6892b88ce0733ab60e24f952ed4bb912eb1b71a84caa8c32ab9ab8105ae0193ba0adebc4eccd8160543a45dd64984274dd161af5e5960ddfd06fa314a52e26b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af42c5b4804f52f2a5cd39e284873086e0385c80831b5b40857034967a3b206a34265768c2cfdb6c3677308981e30a57b449888fd8f6731f73b73492a7d73de8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58dc465d79ddd53a82a7f52180d8fe196ddbf2604311b683ae2d93b32037d26a8ccbebaee14df58553185f7e11bc973af970be79c08e6bba3af8dfcfb38d511d"} build_url:https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6892b88ce0733ab60e24f952ed4bb912eb1b71a84caa8c32ab9ab8105ae0193ba0adebc4eccd8160543a45dd64984274dd161af5e5960ddfd06fa314a52e26b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af42c5b4804f52f2a5cd39e284873086e0385c80831b5b40857034967a3b206a34265768c2cfdb6c3677308981e30a57b449888fd8f6731f73b73492a7d73de8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58dc465d79ddd53a82a7f52180d8fe196ddbf2604311b683ae2d93b32037d26a8ccbebaee14df58553185f7e11bc973af970be79c08e6bba3af8dfcfb38d511d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 06:02:17.106734) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 06:02:17.107165) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466252458.342537-968824404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 06:02:17.189470) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 06:02:17.189794) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 06:02:17.190107) ========= ========= Total master_lag: 0.17 =========