builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1469618598.77 results: success (0) buildid: 20160726081123 builduid: d55b11d35c3148cb8ff39a91e15f3ac4 revision: ebd239b4cbfb8eff833560f72b163275ac4026d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:18.769408) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:18.770375) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:18.771120) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:18.787728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:18.788062) ========= 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=33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 04:23:19-- 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% 66.6M=0s 2016-07-27 04:23:19 (66.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082168 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:18.887747) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:18.888476) ========= 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=33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020003 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:18.943189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:18.944002) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ebd239b4cbfb8eff833560f72b163275ac4026d3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ebd239b4cbfb8eff833560f72b163275ac4026d3 --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=33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 04:23:19,409 truncating revision to first 12 chars 2016-07-27 04:23:19,409 Setting DEBUG logging. 2016-07-27 04:23:19,409 attempt 1/10 2016-07-27 04:23:19,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ebd239b4cbfb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 04:23:19,716 unpacking tar archive at: mozilla-aurora-ebd239b4cbfb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631278 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:19.593098) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:19.593872) ========= script_repo_revision: ebd239b4cbfb8eff833560f72b163275ac4026d3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:19.595043) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:19.595538) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:19.607877) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-27 04:23:19.608604) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:23:20 INFO - MultiFileLogger online at 20160727 04:23:20 in /builds/slave/test 04:23:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:23:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:20 INFO - {'append_to_log': False, 04:23:20 INFO - 'base_work_dir': '/builds/slave/test', 04:23:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:23:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:20 INFO - 'branch': 'Mozilla-Aurora', 04:23:20 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:20 INFO - 'config_files': ('talos/linux_config.py',), 04:23:20 INFO - 'default_actions': ('clobber', 04:23:20 INFO - 'read-buildbot-config', 04:23:20 INFO - 'download-and-extract', 04:23:20 INFO - 'populate-webroot', 04:23:20 INFO - 'create-virtualenv', 04:23:20 INFO - 'install', 04:23:20 INFO - 'run-tests'), 04:23:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:20 INFO - 'download_minidump_stackwalk': True, 04:23:20 INFO - 'download_symbols': 'ondemand', 04:23:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:20 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:20 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:20 INFO - 'installer_path': 'installer.exe', 04:23:20 INFO - 'log_level': 'info', 04:23:20 INFO - 'log_name': 'talos', 04:23:20 INFO - 'log_to_console': True, 04:23:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:23:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:23:20 INFO - 'opt_config_files': (), 04:23:20 INFO - 'pip_index': False, 04:23:20 INFO - 'sps_profile': False, 04:23:20 INFO - 'sps_profile_interval': 0, 04:23:20 INFO - 'suite': 'dromaeojs-e10s', 04:23:20 INFO - 'system_bits': '32', 04:23:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:20 INFO - 'title': 'talos-linux64-ix-063', 04:23:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:20 INFO - 'use_talos_json': True, 04:23:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:20 INFO - 'work_dir': 'build'} 04:23:20 INFO - ##### 04:23:20 INFO - ##### Running clobber step. 04:23:20 INFO - ##### 04:23:20 INFO - Running pre-action listener: _resource_record_pre_action 04:23:20 INFO - Running main action method: clobber 04:23:20 INFO - rmtree: /builds/slave/test/build 04:23:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:20 INFO - Running post-action listener: _resource_record_post_action 04:23:20 INFO - ##### 04:23:20 INFO - ##### Finished clobber step (success) 04:23:20 INFO - ##### 04:23:20 INFO - ##### 04:23:20 INFO - ##### Running read-buildbot-config step. 04:23:20 INFO - ##### 04:23:20 INFO - Running pre-action listener: _resource_record_pre_action 04:23:20 INFO - Running main action method: read_buildbot_config 04:23:20 INFO - Using buildbot properties: 04:23:20 INFO - { 04:23:20 INFO - "project": "", 04:23:20 INFO - "product": "firefox", 04:23:20 INFO - "script_repo_revision": "production", 04:23:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:23:20 INFO - "repository": "", 04:23:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:23:20 INFO - "buildid": "20160726081123", 04:23:20 INFO - "pgo_build": "True", 04:23:20 INFO - "basedir": "/builds/slave/test", 04:23:20 INFO - "buildnumber": 410, 04:23:20 INFO - "slavename": "talos-linux64-ix-063", 04:23:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:23:20 INFO - "platform": "ubuntu64_hw", 04:23:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:23:20 INFO - "branch": "mozilla-aurora", 04:23:20 INFO - "repo_path": "releases/mozilla-aurora", 04:23:20 INFO - "revision": "ebd239b4cbfb8eff833560f72b163275ac4026d3", 04:23:20 INFO - "stage_platform": "linux64-pgo", 04:23:20 INFO - "builduid": "d55b11d35c3148cb8ff39a91e15f3ac4", 04:23:20 INFO - "slavebuilddir": "test" 04:23:20 INFO - } 04:23:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 04:23:20 INFO - Running post-action listener: _resource_record_post_action 04:23:20 INFO - ##### 04:23:20 INFO - ##### Finished read-buildbot-config step (success) 04:23:20 INFO - ##### 04:23:20 INFO - ##### 04:23:20 INFO - ##### Running download-and-extract step. 04:23:20 INFO - ##### 04:23:20 INFO - Running pre-action listener: _resource_record_pre_action 04:23:20 INFO - Running main action method: download_and_extract 04:23:20 INFO - mkdir: /builds/slave/test/build/tests 04:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:20 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:23:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:23:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:23:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:23:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:23:21 INFO - Downloaded 1361 bytes. 04:23:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:23:21 INFO - Using the following test package requirements: 04:23:21 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:23:21 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:23:21 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:23:21 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:21 INFO - u'jsshell-linux-x86_64.zip'], 04:23:21 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:23:21 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:23:21 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:23:21 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:23:21 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:23:21 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:23:21 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:21 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:23:25 INFO - Downloaded 24494733 bytes. 04:23:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:23:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:23:26 INFO - Return code: 0 04:23:26 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:26 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:23:27 INFO - Downloaded 24494733 bytes. 04:23:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:23:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:23:29 INFO - Return code: 0 04:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:29 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:23:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:23:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:23:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:23:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:23:29 INFO - Downloaded 10833369 bytes. 04:23:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:23:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:23:30 INFO - Return code: 0 04:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:30 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:23:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:23:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:23:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:23:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:23:31 INFO - Downloaded 63637001 bytes. 04:23:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:23:31 INFO - mkdir: /builds/slave/test/properties 04:23:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:23:31 INFO - Writing to file /builds/slave/test/properties/build_url 04:23:31 INFO - Contents: 04:23:31 INFO - build_url:https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:23:32 INFO - Running post-action listener: _resource_record_post_action 04:23:32 INFO - Running post-action listener: set_extra_try_arguments 04:23:32 INFO - ##### 04:23:32 INFO - ##### Finished download-and-extract step (success) 04:23:32 INFO - ##### 04:23:32 INFO - ##### 04:23:32 INFO - ##### Running populate-webroot step. 04:23:32 INFO - ##### 04:23:32 INFO - Running pre-action listener: _resource_record_pre_action 04:23:32 INFO - Running main action method: populate_webroot 04:23:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:23:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:23:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:23:32 INFO - '--tppagecycles', 04:23:32 INFO - '7'], 04:23:32 INFO - 'tests': ['tsvgm']}}, 04:23:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:23:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:23:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:23:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:23:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:23:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:23:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:32 INFO - 'talos_options': ['--disable-e10s'], 04:23:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:32 INFO - 'talos_options': ['--disable-e10s'], 04:23:32 INFO - 'tests': ['damp', 'tps']}, 04:23:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:32 INFO - 'tests': ['damp', 'tps']}, 04:23:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:23:32 INFO - 'tests': ['dromaeo_dom']}, 04:23:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:23:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:23:32 INFO - 'tests': ['a11yr', 04:23:32 INFO - 'ts_paint', 04:23:32 INFO - 'tpaint', 04:23:32 INFO - 'sessionrestore', 04:23:32 INFO - 'sessionrestore_no_auto_restore', 04:23:32 INFO - 'tabpaint']}, 04:23:32 INFO - 'other-e10s': {'tests': ['a11yr', 04:23:32 INFO - 'ts_paint', 04:23:32 INFO - 'tpaint', 04:23:32 INFO - 'sessionrestore', 04:23:32 INFO - 'sessionrestore_no_auto_restore', 04:23:32 INFO - 'tabpaint']}, 04:23:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:23:32 INFO - 'ts_paint', 04:23:32 INFO - 'tpaint', 04:23:32 INFO - 'sessionrestore', 04:23:32 INFO - 'sessionrestore_no_auto_restore', 04:23:32 INFO - 'tabpaint']}, 04:23:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:23:32 INFO - 'ts_paint', 04:23:32 INFO - 'tpaint', 04:23:32 INFO - 'sessionrestore', 04:23:32 INFO - 'sessionrestore_no_auto_restore', 04:23:32 INFO - 'tabpaint']}, 04:23:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:23:32 INFO - 'tests': ['a11yr', 04:23:32 INFO - 'ts_paint', 04:23:32 INFO - 'tpaint', 04:23:32 INFO - 'sessionrestore', 04:23:32 INFO - 'sessionrestore_no_auto_restore', 04:23:32 INFO - 'tabpaint']}, 04:23:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:23:32 INFO - 'tests': ['a11yr', 04:23:32 INFO - 'ts_paint', 04:23:32 INFO - 'tpaint', 04:23:32 INFO - 'sessionrestore', 04:23:32 INFO - 'sessionrestore_no_auto_restore', 04:23:32 INFO - 'tabpaint']}, 04:23:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:23:32 INFO - 'tests': ['tsvgx', 04:23:32 INFO - 'tsvgr_opacity', 04:23:32 INFO - 'tart', 04:23:32 INFO - 'tscrollx', 04:23:32 INFO - 'cart']}, 04:23:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:23:32 INFO - 'tsvgr_opacity', 04:23:32 INFO - 'tart', 04:23:32 INFO - 'tscrollx', 04:23:32 INFO - 'cart']}, 04:23:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:32 INFO - 'talos_options': ['--disable-e10s'], 04:23:32 INFO - 'tests': ['tp5o']}, 04:23:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:32 INFO - 'tests': ['tp5o']}, 04:23:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:32 INFO - 'talos_options': ['--disable-e10s', 04:23:32 INFO - '--xperf_path', 04:23:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:32 INFO - 'tests': ['tp5n']}, 04:23:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:32 INFO - 'talos_options': ['--xperf_path', 04:23:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:32 INFO - 'tests': ['tp5n']}}, 04:23:32 INFO - 'talos.zip': {'path': '', 04:23:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:23:32 INFO - Running post-action listener: _resource_record_post_action 04:23:32 INFO - ##### 04:23:32 INFO - ##### Finished populate-webroot step (success) 04:23:32 INFO - ##### 04:23:32 INFO - ##### 04:23:32 INFO - ##### Running create-virtualenv step. 04:23:32 INFO - ##### 04:23:32 INFO - Running pre-action listener: _resource_record_pre_action 04:23:32 INFO - Running main action method: create_virtualenv 04:23:32 INFO - Creating virtualenv /builds/slave/test/build/venv 04:23:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:23:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:23:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:23:32 INFO - Using real prefix '/usr' 04:23:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:23:33 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:35 INFO - Installing pip.................done. 04:23:35 INFO - Return code: 0 04:23:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:35 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 0x7ff0d38c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13041c0>, '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 0x13050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305550>, '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': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:23:35 INFO - Using env: {'DISPLAY': ':0', 04:23:35 INFO - 'HOME': '/home/cltbld', 04:23:35 INFO - 'LANG': 'en_US.UTF-8', 04:23:35 INFO - 'LANGUAGE': 'en_US:en', 04:23:35 INFO - 'LOGNAME': 'cltbld', 04:23:35 INFO - 'MAIL': '/var/mail/cltbld', 04:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:35 INFO - 'MOZ_NO_REMOTE': '1', 04:23:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:35 INFO - 'NO_EM_RESTART': '1', 04:23:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:35 INFO - 'PWD': '/builds/slave/test', 04:23:35 INFO - 'SHELL': '/bin/bash', 04:23:35 INFO - 'SHLVL': '1', 04:23:35 INFO - 'TERM': 'linux', 04:23:35 INFO - 'TMOUT': '86400', 04:23:35 INFO - 'USER': 'cltbld', 04:23:35 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 04:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:35 INFO - '_': '/tools/buildbot/bin/python'} 04:23:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:23:35 INFO - Cleaning up... 04:23:35 INFO - Return code: 0 04:23:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:35 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 0x7ff0d38c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13041c0>, '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 0x13050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305550>, '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': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:23:35 INFO - Using env: {'DISPLAY': ':0', 04:23:35 INFO - 'HOME': '/home/cltbld', 04:23:35 INFO - 'LANG': 'en_US.UTF-8', 04:23:35 INFO - 'LANGUAGE': 'en_US:en', 04:23:35 INFO - 'LOGNAME': 'cltbld', 04:23:35 INFO - 'MAIL': '/var/mail/cltbld', 04:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:35 INFO - 'MOZ_NO_REMOTE': '1', 04:23:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:35 INFO - 'NO_EM_RESTART': '1', 04:23:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:35 INFO - 'PWD': '/builds/slave/test', 04:23:35 INFO - 'SHELL': '/bin/bash', 04:23:35 INFO - 'SHLVL': '1', 04:23:35 INFO - 'TERM': 'linux', 04:23:35 INFO - 'TMOUT': '86400', 04:23:35 INFO - 'USER': 'cltbld', 04:23:35 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 04:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:35 INFO - '_': '/tools/buildbot/bin/python'} 04:23:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:35 INFO - Downloading/unpacking psutil>=3.1.1 04:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:37 INFO - Installing collected packages: psutil 04:23:37 INFO - Running setup.py install for psutil 04:23:37 INFO - building 'psutil._psutil_linux' extension 04:23:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:23:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:23:37 INFO - building 'psutil._psutil_posix' extension 04:23:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:23:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:23:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:38 INFO - Successfully installed psutil 04:23:38 INFO - Cleaning up... 04:23:38 INFO - Return code: 0 04:23:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:38 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 0x7ff0d38c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13041c0>, '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 0x13050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305550>, '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': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:23:38 INFO - Using env: {'DISPLAY': ':0', 04:23:38 INFO - 'HOME': '/home/cltbld', 04:23:38 INFO - 'LANG': 'en_US.UTF-8', 04:23:38 INFO - 'LANGUAGE': 'en_US:en', 04:23:38 INFO - 'LOGNAME': 'cltbld', 04:23:38 INFO - 'MAIL': '/var/mail/cltbld', 04:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:38 INFO - 'MOZ_NO_REMOTE': '1', 04:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:38 INFO - 'NO_EM_RESTART': '1', 04:23:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:38 INFO - 'PWD': '/builds/slave/test', 04:23:38 INFO - 'SHELL': '/bin/bash', 04:23:38 INFO - 'SHLVL': '1', 04:23:38 INFO - 'TERM': 'linux', 04:23:38 INFO - 'TMOUT': '86400', 04:23:38 INFO - 'USER': 'cltbld', 04:23:38 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 04:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:38 INFO - '_': '/tools/buildbot/bin/python'} 04:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:23:40 INFO - Installing collected packages: mozsystemmonitor 04:23:40 INFO - Running setup.py install for mozsystemmonitor 04:23:40 INFO - Successfully installed mozsystemmonitor 04:23:40 INFO - Cleaning up... 04:23:40 INFO - Return code: 0 04:23:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:40 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 0x7ff0d38c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13041c0>, '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 0x13050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305550>, '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': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:23:40 INFO - Using env: {'DISPLAY': ':0', 04:23:40 INFO - 'HOME': '/home/cltbld', 04:23:40 INFO - 'LANG': 'en_US.UTF-8', 04:23:40 INFO - 'LANGUAGE': 'en_US:en', 04:23:40 INFO - 'LOGNAME': 'cltbld', 04:23:40 INFO - 'MAIL': '/var/mail/cltbld', 04:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:40 INFO - 'MOZ_NO_REMOTE': '1', 04:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:40 INFO - 'NO_EM_RESTART': '1', 04:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:40 INFO - 'PWD': '/builds/slave/test', 04:23:40 INFO - 'SHELL': '/bin/bash', 04:23:40 INFO - 'SHLVL': '1', 04:23:40 INFO - 'TERM': 'linux', 04:23:40 INFO - 'TMOUT': '86400', 04:23:40 INFO - 'USER': 'cltbld', 04:23:40 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 04:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:40 INFO - '_': '/tools/buildbot/bin/python'} 04:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:40 INFO - Downloading/unpacking jsonschema==2.5.1 04:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:23:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:42 INFO - Downloading functools32-3.2.3-2.tar.gz 04:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:23:42 INFO - warning: no files found matching '*.txt' 04:23:42 INFO - no previously-included directories found matching 'build' 04:23:42 INFO - no previously-included directories found matching 'dist' 04:23:42 INFO - no previously-included directories found matching '.git*' 04:23:42 INFO - Installing collected packages: jsonschema, functools32 04:23:42 INFO - Running setup.py install for functools32 04:23:43 INFO - warning: no files found matching '*.txt' 04:23:43 INFO - no previously-included directories found matching 'build' 04:23:43 INFO - no previously-included directories found matching 'dist' 04:23:43 INFO - no previously-included directories found matching '.git*' 04:23:43 INFO - Successfully installed jsonschema functools32 04:23:43 INFO - Cleaning up... 04:23:43 INFO - Return code: 0 04:23:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff0d38c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13041c0>, '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 0x13050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305550>, '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': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:23:43 INFO - Using env: {'DISPLAY': ':0', 04:23:43 INFO - 'HOME': '/home/cltbld', 04:23:43 INFO - 'LANG': 'en_US.UTF-8', 04:23:43 INFO - 'LANGUAGE': 'en_US:en', 04:23:43 INFO - 'LOGNAME': 'cltbld', 04:23:43 INFO - 'MAIL': '/var/mail/cltbld', 04:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:43 INFO - 'MOZ_NO_REMOTE': '1', 04:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:43 INFO - 'NO_EM_RESTART': '1', 04:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:43 INFO - 'PWD': '/builds/slave/test', 04:23:43 INFO - 'SHELL': '/bin/bash', 04:23:43 INFO - 'SHLVL': '1', 04:23:43 INFO - 'TERM': 'linux', 04:23:43 INFO - 'TMOUT': '86400', 04:23:43 INFO - 'USER': 'cltbld', 04:23:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 04:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:43 INFO - '_': '/tools/buildbot/bin/python'} 04:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:43 INFO - Downloading/unpacking blobuploader==1.2.4 04:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:45 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:45 INFO - Downloading docopt-0.6.1.tar.gz 04:23:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:46 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:46 INFO - Running setup.py install for blobuploader 04:23:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:46 INFO - Running setup.py install for requests 04:23:46 INFO - Running setup.py install for docopt 04:23:46 INFO - Successfully installed blobuploader requests docopt 04:23:46 INFO - Cleaning up... 04:23:46 INFO - Return code: 0 04:23:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:46 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 0x7ff0d38c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13041c0>, '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 0x13050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305550>, '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': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:23:46 INFO - Using env: {'DISPLAY': ':0', 04:23:46 INFO - 'HOME': '/home/cltbld', 04:23:46 INFO - 'LANG': 'en_US.UTF-8', 04:23:46 INFO - 'LANGUAGE': 'en_US:en', 04:23:46 INFO - 'LOGNAME': 'cltbld', 04:23:46 INFO - 'MAIL': '/var/mail/cltbld', 04:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:46 INFO - 'MOZ_NO_REMOTE': '1', 04:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:46 INFO - 'NO_EM_RESTART': '1', 04:23:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:46 INFO - 'PWD': '/builds/slave/test', 04:23:46 INFO - 'SHELL': '/bin/bash', 04:23:46 INFO - 'SHLVL': '1', 04:23:46 INFO - 'TERM': 'linux', 04:23:46 INFO - 'TMOUT': '86400', 04:23:46 INFO - 'USER': 'cltbld', 04:23:46 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 04:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:46 INFO - '_': '/tools/buildbot/bin/python'} 04:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:46 INFO - Running setup.py (path:/tmp/pip-Ah6CiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:46 INFO - Running setup.py (path:/tmp/pip-XXGRsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:47 INFO - Running setup.py (path:/tmp/pip-mXJ9U_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:47 INFO - Running setup.py (path:/tmp/pip-Tz4sPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:47 INFO - Running setup.py (path:/tmp/pip-lmgZcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:47 INFO - Running setup.py (path:/tmp/pip-SvXbOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:47 INFO - Running setup.py (path:/tmp/pip-DmM7Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:47 INFO - Running setup.py (path:/tmp/pip-0ZqEBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:47 INFO - Running setup.py (path:/tmp/pip-OBAdkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:47 INFO - Running setup.py (path:/tmp/pip-b5ej66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:47 INFO - Running setup.py (path:/tmp/pip-4IuW8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:47 INFO - Running setup.py (path:/tmp/pip-7lO_FK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:47 INFO - Running setup.py (path:/tmp/pip-eJeG8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:47 INFO - Running setup.py (path:/tmp/pip-lxWAqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:47 INFO - Running setup.py (path:/tmp/pip-8H_BZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:47 INFO - Running setup.py (path:/tmp/pip-K9v4nM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:48 INFO - Running setup.py (path:/tmp/pip-9uZP9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:23:48 INFO - Running setup.py install for manifestparser 04:23:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:23:48 INFO - Running setup.py install for mozcrash 04:23:48 INFO - Running setup.py install for mozdebug 04:23:48 INFO - Running setup.py install for mozdevice 04:23:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:23:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:23:48 INFO - Running setup.py install for mozfile 04:23:48 INFO - Running setup.py install for mozhttpd 04:23:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:23:48 INFO - Running setup.py install for mozinfo 04:23:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:23:48 INFO - Running setup.py install for mozInstall 04:23:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:23:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:23:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:23:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:23:48 INFO - Running setup.py install for mozleak 04:23:48 INFO - Running setup.py install for mozlog 04:23:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:23:49 INFO - Running setup.py install for moznetwork 04:23:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:23:49 INFO - Running setup.py install for mozprocess 04:23:49 INFO - Running setup.py install for mozprofile 04:23:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:23:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:23:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:23:49 INFO - Running setup.py install for mozrunner 04:23:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:23:49 INFO - Running setup.py install for mozscreenshot 04:23:49 INFO - Running setup.py install for moztest 04:23:49 INFO - Running setup.py install for mozversion 04:23:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:23:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:23:49 INFO - Cleaning up... 04:23:49 INFO - Return code: 0 04:23:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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')]} 04:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:49 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 0x7ff0d38c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13041c0>, '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 0x13050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305550>, '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': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:23:49 INFO - Using env: {'DISPLAY': ':0', 04:23:49 INFO - 'HOME': '/home/cltbld', 04:23:49 INFO - 'LANG': 'en_US.UTF-8', 04:23:49 INFO - 'LANGUAGE': 'en_US:en', 04:23:49 INFO - 'LOGNAME': 'cltbld', 04:23:49 INFO - 'MAIL': '/var/mail/cltbld', 04:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:49 INFO - 'MOZ_NO_REMOTE': '1', 04:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:49 INFO - 'NO_EM_RESTART': '1', 04:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:49 INFO - 'PWD': '/builds/slave/test', 04:23:49 INFO - 'SHELL': '/bin/bash', 04:23:49 INFO - 'SHLVL': '1', 04:23:49 INFO - 'TERM': 'linux', 04:23:49 INFO - 'TMOUT': '86400', 04:23:49 INFO - 'USER': 'cltbld', 04:23:49 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 04:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:49 INFO - '_': '/tools/buildbot/bin/python'} 04:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:50 INFO - Running setup.py (path:/tmp/pip-Is5z__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:50 INFO - Running setup.py (path:/tmp/pip-nu0rmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:50 INFO - Running setup.py (path:/tmp/pip-SyQdjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:50 INFO - Running setup.py (path:/tmp/pip-SC1KXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:50 INFO - Running setup.py (path:/tmp/pip-pwVrdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:50 INFO - Running setup.py (path:/tmp/pip-eytftD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:50 INFO - Running setup.py (path:/tmp/pip-eFNCNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:50 INFO - Running setup.py (path:/tmp/pip-E0hLlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:50 INFO - Running setup.py (path:/tmp/pip-DoXSUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:50 INFO - Running setup.py (path:/tmp/pip-qms_Zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:50 INFO - Running setup.py (path:/tmp/pip-1S98LP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:50 INFO - Running setup.py (path:/tmp/pip-UNh85e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:50 INFO - Running setup.py (path:/tmp/pip-Kteu4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:51 INFO - Running setup.py (path:/tmp/pip-3bdwVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:51 INFO - Running setup.py (path:/tmp/pip-WBYyrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:51 INFO - Running setup.py (path:/tmp/pip-Yj8taJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:51 INFO - Running setup.py (path:/tmp/pip-kXEuiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:23:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:53 INFO - Downloading blessings-1.6.tar.gz 04:23:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:23:53 INFO - Installing collected packages: blessings 04:23:53 INFO - Running setup.py install for blessings 04:23:53 INFO - Successfully installed blessings 04:23:53 INFO - Cleaning up... 04:23:53 INFO - Return code: 0 04:23:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:23:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:53 INFO - Reading from file tmpfile_stdout 04:23:53 INFO - Current package versions: 04:23:53 INFO - argparse == 1.2.1 04:23:53 INFO - blessings == 1.6 04:23:53 INFO - blobuploader == 1.2.4 04:23:53 INFO - docopt == 0.6.1 04:23:53 INFO - functools32 == 3.2.3-2 04:23:53 INFO - jsonschema == 2.5.1 04:23:53 INFO - manifestparser == 1.1 04:23:53 INFO - mozInstall == 1.12 04:23:53 INFO - mozcrash == 0.17 04:23:53 INFO - mozdebug == 0.1 04:23:53 INFO - mozdevice == 0.48 04:23:53 INFO - mozfile == 1.2 04:23:53 INFO - mozhttpd == 0.7 04:23:53 INFO - mozinfo == 0.9 04:23:53 INFO - mozleak == 0.1 04:23:53 INFO - mozlog == 3.2 04:23:53 INFO - moznetwork == 0.27 04:23:53 INFO - mozprocess == 0.23 04:23:53 INFO - mozprofile == 0.28 04:23:53 INFO - mozrunner == 6.12 04:23:53 INFO - mozscreenshot == 0.1 04:23:53 INFO - mozsystemmonitor == 0.3 04:23:53 INFO - moztest == 0.7 04:23:53 INFO - mozversion == 1.4 04:23:53 INFO - psutil == 3.1.1 04:23:53 INFO - requests == 1.2.3 04:23:53 INFO - wsgiref == 0.1.2 04:23:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:53 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 0x7ff0d38c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13041c0>, '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 0x13050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305550>, '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': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:23:53 INFO - Using env: {'DISPLAY': ':0', 04:23:53 INFO - 'HOME': '/home/cltbld', 04:23:53 INFO - 'LANG': 'en_US.UTF-8', 04:23:53 INFO - 'LANGUAGE': 'en_US:en', 04:23:53 INFO - 'LOGNAME': 'cltbld', 04:23:53 INFO - 'MAIL': '/var/mail/cltbld', 04:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:53 INFO - 'MOZ_NO_REMOTE': '1', 04:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:53 INFO - 'NO_EM_RESTART': '1', 04:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:53 INFO - 'PWD': '/builds/slave/test', 04:23:53 INFO - 'SHELL': '/bin/bash', 04:23:53 INFO - 'SHLVL': '1', 04:23:53 INFO - 'TERM': 'linux', 04:23:53 INFO - 'TMOUT': '86400', 04:23:53 INFO - 'USER': 'cltbld', 04:23:53 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 04:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:53 INFO - '_': '/tools/buildbot/bin/python'} 04:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:23:54 INFO - Cleaning up... 04:23:54 INFO - Return code: 0 04:23:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:54 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 0x7ff0d38c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13041c0>, '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 0x13050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305550>, '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': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:23:54 INFO - Using env: {'DISPLAY': ':0', 04:23:54 INFO - 'HOME': '/home/cltbld', 04:23:54 INFO - 'LANG': 'en_US.UTF-8', 04:23:54 INFO - 'LANGUAGE': 'en_US:en', 04:23:54 INFO - 'LOGNAME': 'cltbld', 04:23:54 INFO - 'MAIL': '/var/mail/cltbld', 04:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:54 INFO - 'MOZ_NO_REMOTE': '1', 04:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:54 INFO - 'NO_EM_RESTART': '1', 04:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:54 INFO - 'PWD': '/builds/slave/test', 04:23:54 INFO - 'SHELL': '/bin/bash', 04:23:54 INFO - 'SHLVL': '1', 04:23:54 INFO - 'TERM': 'linux', 04:23:54 INFO - 'TMOUT': '86400', 04:23:54 INFO - 'USER': 'cltbld', 04:23:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 04:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:54 INFO - '_': '/tools/buildbot/bin/python'} 04:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:23:54 INFO - Cleaning up... 04:23:54 INFO - Return code: 0 04:23:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:54 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 0x7ff0d38c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13041c0>, '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 0x13050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305550>, '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': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:23:54 INFO - Using env: {'DISPLAY': ':0', 04:23:54 INFO - 'HOME': '/home/cltbld', 04:23:54 INFO - 'LANG': 'en_US.UTF-8', 04:23:54 INFO - 'LANGUAGE': 'en_US:en', 04:23:54 INFO - 'LOGNAME': 'cltbld', 04:23:54 INFO - 'MAIL': '/var/mail/cltbld', 04:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:54 INFO - 'MOZ_NO_REMOTE': '1', 04:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:54 INFO - 'NO_EM_RESTART': '1', 04:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:54 INFO - 'PWD': '/builds/slave/test', 04:23:54 INFO - 'SHELL': '/bin/bash', 04:23:54 INFO - 'SHLVL': '1', 04:23:54 INFO - 'TERM': 'linux', 04:23:54 INFO - 'TMOUT': '86400', 04:23:54 INFO - 'USER': 'cltbld', 04:23:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 04:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:54 INFO - '_': '/tools/buildbot/bin/python'} 04:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:54 INFO - Downloading/unpacking flake8 04:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:23:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:23:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:57 INFO - no previously-included directories found matching 'docs/_build' 04:23:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:23:57 INFO - Running setup.py install for pep8 04:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:57 INFO - no previously-included directories found matching 'docs/_build' 04:23:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:23:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:23:57 INFO - Cleaning up... 04:23:57 INFO - Return code: 0 04:23:57 INFO - Running post-action listener: _resource_record_post_action 04:23:57 INFO - Running post-action listener: _start_resource_monitoring 04:23:57 INFO - Starting resource monitoring. 04:23:57 INFO - ##### 04:23:57 INFO - ##### Finished create-virtualenv step (success) 04:23:57 INFO - ##### 04:23:57 INFO - ##### 04:23:57 INFO - ##### Running install step. 04:23:57 INFO - ##### 04:23:57 INFO - Running pre-action listener: _resource_record_pre_action 04:23:57 INFO - Running main action method: install 04:23:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:57 INFO - Reading from file tmpfile_stdout 04:23:57 INFO - Detecting whether we're running mozinstall >=1.0... 04:23:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:23:57 INFO - Reading from file tmpfile_stdout 04:23:57 INFO - Output received: 04:23:57 INFO - Usage: mozinstall [options] installer 04:23:57 INFO - Options: 04:23:57 INFO - -h, --help show this help message and exit 04:23:57 INFO - -d DEST, --destination=DEST 04:23:57 INFO - Directory to install application into. [default: 04:23:57 INFO - "/builds/slave/test"] 04:23:57 INFO - --app=APP Application being installed. [default: firefox] 04:23:57 INFO - mkdir: /builds/slave/test/build/application 04:23:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:24:21 INFO - Reading from file tmpfile_stdout 04:24:24 INFO - Output received: 04:24:24 INFO - /builds/slave/test/build/application/firefox/firefox 04:24:24 INFO - Running post-action listener: _resource_record_post_action 04:24:24 INFO - ##### 04:24:24 INFO - ##### Finished install step (success) 04:24:24 INFO - ##### 04:24:24 INFO - ##### 04:24:24 INFO - ##### Running run-tests step. 04:24:24 INFO - ##### 04:24:24 INFO - Running pre-action listener: _resource_record_pre_action 04:24:24 INFO - Running main action method: run_tests 04:24:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:24:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:24:24 INFO - Python 2.7.3 04:24:24 INFO - Return code: 0 04:24:24 INFO - grabbing minidump binary from tooltool 04:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:24 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 0x13041c0>, '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 0x13050c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1305550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:24:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:24:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:24:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:24:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:24:24 INFO - Return code: 0 04:24:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:24:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:24:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:24:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:24:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:24:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:24:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:24:25 INFO - Return code: 0 04:24:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:24:25 INFO - Using env: {'DISPLAY': ':0', 04:24:25 INFO - 'HOME': '/home/cltbld', 04:24:25 INFO - 'LANG': 'en_US.UTF-8', 04:24:25 INFO - 'LANGUAGE': 'en_US:en', 04:24:25 INFO - 'LOGNAME': 'cltbld', 04:24:25 INFO - 'MAIL': '/var/mail/cltbld', 04:24:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:24:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:25 INFO - 'MOZ_NO_REMOTE': '1', 04:24:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:24:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:25 INFO - 'NO_EM_RESTART': '1', 04:24:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:25 INFO - 'PWD': '/builds/slave/test', 04:24:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:24:25 INFO - 'SHELL': '/bin/bash', 04:24:25 INFO - 'SHLVL': '1', 04:24:25 INFO - 'TERM': 'linux', 04:24:25 INFO - 'TMOUT': '86400', 04:24:25 INFO - 'USER': 'cltbld', 04:24:25 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454', 04:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:25 INFO - '_': '/tools/buildbot/bin/python'} 04:24:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:24:25 INFO - mozversion application_buildid: 20160726081123 04:24:25 INFO - mozversion application_changeset: ebd239b4cbfb8eff833560f72b163275ac4026d3 04:24:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:24:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:24:25 INFO - mozversion application_name: Firefox 04:24:25 INFO - mozversion application_remotingname: firefox-dev 04:24:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:24:25 INFO - mozversion application_vendor: Mozilla 04:24:25 INFO - mozversion application_version: 49.0a2 04:24:25 INFO - mozversion platform_buildid: 20160726081123 04:24:25 INFO - mozversion platform_changeset: ebd239b4cbfb8eff833560f72b163275ac4026d3 04:24:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:24:25 INFO - mozversion platform_version: 49.0a2 04:24:25 INFO - using testdate: 1469618665 04:24:25 INFO - actual date: 1469618665 04:24:25 INFO - starting webserver on 'localhost:39676' 04:24:25 INFO - SUITE-START | Running 2 tests 04:24:25 INFO - TEST-START | dromaeo_css 04:24:25 INFO - operating with platform_type : linux_ 04:24:25 INFO - Initialising browser for dromaeo_css test... 04:24:25 INFO - TEST-INFO | started process 17511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu8odn7/profile http://localhost:39676/getInfo.html) 04:24:32 INFO - PROCESS | 17511 | __metrics Screen width/height:1600/1200 04:24:32 INFO - PROCESS | 17511 | colorDepth:24 04:24:32 INFO - PROCESS | 17511 | Browser inner width/height: 1024/697 04:24:32 INFO - PROCESS | 17511 | __metrics 04:24:34 ERROR - PROCESS | 17511 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:24:35 INFO - TEST-INFO | 17511: exit 0 04:24:35 INFO - Browser initialized. 04:24:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:24:35 INFO - TEST-INFO | started process 17643 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu8odn7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:47 INFO - PROCESS | 17643 | RSS: Main: 156102656 04:24:47 INFO - PROCESS | 17643 | 04:25:36 INFO - PROCESS | 17643 | 1469618736713 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:27:45 INFO - PROCESS | 17643 | Cycle 1(1): loaded http://localhost:39676/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39676/tests/dromaeo/cssquery-ext.html) 04:27:46 INFO - PROCESS | 17643 | RSS: Main: 159383552 04:27:46 INFO - PROCESS | 17643 | 04:30:48 INFO - PROCESS | 17643 | Cycle 1(1): loaded http://localhost:39676/tests/dromaeo/cssquery-ext.html (next: http://localhost:39676/tests/dromaeo/cssquery-jquery.html) 04:30:48 INFO - PROCESS | 17643 | RSS: Main: 157593600 04:30:48 INFO - PROCESS | 17643 | 04:33:50 INFO - PROCESS | 17643 | Cycle 1(1): loaded http://localhost:39676/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39676/tests/dromaeo/cssquery-mootools.html) 04:33:51 INFO - PROCESS | 17643 | RSS: Main: 157544448 04:33:51 INFO - PROCESS | 17643 | 04:36:52 INFO - PROCESS | 17643 | Cycle 1(1): loaded http://localhost:39676/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39676/tests/dromaeo/cssquery-prototype.html) 04:36:53 INFO - PROCESS | 17643 | RSS: Main: 156803072 04:36:53 INFO - PROCESS | 17643 | 04:39:55 INFO - PROCESS | 17643 | Cycle 1(1): loaded http://localhost:39676/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39676/tests/dromaeo/cssquery-yui.html) 04:39:56 INFO - PROCESS | 17643 | RSS: Main: 159047680 04:39:56 INFO - PROCESS | 17643 | 04:42:58 INFO - PROCESS | 17643 | Cycle 1(1): loaded http://localhost:39676/tests/dromaeo/cssquery-yui.html (next: http://localhost:39676/tests/dromaeo/cssquery-dojo.html) 04:42:58 INFO - PROCESS | 17643 | RSS: Main: 159354880 04:42:58 INFO - PROCESS | 17643 | 04:42:58 INFO - PROCESS | 17643 | __start_tp_report 04:42:58 INFO - PROCESS | 17643 | _x_x_mozilla_page_load 04:42:58 INFO - PROCESS | 17643 | _x_x_mozilla_page_load_details 04:42:58 INFO - PROCESS | 17643 | |i|pagename|runs| 04:42:58 INFO - PROCESS | 17643 | |0;dojo.html;3420.1107711994878;3459.3254315408476;3464.0127563644337;3491.8428670709814;3507.2810073934847;5757.913631295534;5758;5781.190633311329;5831.854203644905;5887.0286402743495;5741.368449470555;5742.368339482654;5800.071988481844;5815.127730840376;5818.505427038707;5209.088409528336;5257.737113144328;5288.0745869472885;5299.099153143975;5327.200919862013;5058.772355244005;5125.769340379692;5132.024915266106;5341.732913354336;5352.330958630171;5240.502152295526;5275.920861187085;5279.3928698199625;5318.601104917147;5333.173358129496;5277.445868183843;5354.839354819343;5362.410134885159;5365.865853353658;5387.4612538746205;5095.388553373619;5149.356330458692;5211.557017653504;5272.578193744491;5352.946470535284;5552.91670624941;5611.270534830446;5637.126245431924;5650.51970582501;5675.829725108253;6089.482393996515;6146.416090471398;6172.938270617326;6186.226721659793;6202.689865506707;5904.734286957054;6127.34224287047;6150.261968563756;6228.844278893019;6244.438000579969;5884.70576471179;5885.440883116097;5891.23413956183;5900.291964964189;5908.497777688859;6406.935930640634;6413.422791948747;6437.9678101610125;6456.838579035468;6457.870842583216;5941.940580594225;6002.069679199731;6017.458428741435;6035.336113027563;6179.81460556184;6129.233845769279;6143.662098584621;6153.046277826855;6165.260168779775;6177.567570270128;6070.332263451017;6097.878042439126;6110.938890611126;6146.200993870858;6148.661823599656;5977.163197152402;6126.36500017443;6137;6182.196314479089;6257.8748425031245;4753.619710423158;4760.357351757538;4772.451168115711;4786.329913811999;4790.784414701347;4143;4222.303319952235;4255.106427650228;4258.659307255412;4263.936040959388;5739;5797.4782269595935;5955.76176952917;5986.2517185351835;6016;6108.852642408393;6141.946315431794;6147.508199344042;6151.7539298428455;6165.876682466325;5983.371745966698;5988.071848863346;5994.07091900756;6000.969995149996;6018.8194354169445;5240.240165176028;5268.315119034501;5271.762770675252;5287.735613219324;5324.707141107277;6406.423421892052;6484.124643173205;6499.610023398611;6515.153030106056;6522.64125473094;6053.788117415869;6239.06414037898;6249.50003999688;6255.74977000924;6258.718357674006;6251.499880009497;6282.2147231596055;6305.369463053658;6459.580127291711;6464.870702586016;6088.208532890696;6088.665123418255;6089.208402907594;6090.756369745161;6094.695265236809;6047.5464340173785;6136.079588061648;6189.876202475835;6195.504359651127;6197.81406557804;6020.54845886569;6077.817665470043;6108.389161083856;6128.988716861668;6141.723622437091;6057.7879774207695;6071.7571297147615;6073.119397687399;6076.544259180668;6094.847628809315;5762.625429347079;5920.911186332122;5966.3735307793795;5968.045112781934;5969.522438204846;6076.878462430638;6093.238345206849;6100.0849872519475;6130.356312587114;6143.170671959407;5977.880442391215;5996.4603185713495;5996.730147143302;6001.129836173817;6006.489448396936 04:42:58 INFO - PROCESS | 17643 | |1;ext.html;592.6266452135154;644.7453255963894;652.0187118386827;652.5301782716442;666.3170250493243;47396.763016184916;48272.275915861246;48714.02571948563;48948.51051489484;52353;50278.24582631263;51124.74437627816;51137.23294150591;51183.48816511834;51474.22788658173;9142.222911052568;9262.166405023547;9264.49045302508;9290.489023103726;9302.813943721121;9114.407563508385;9159.175674189322;9164.908350916505;9171.862422063641;9173.541322933826;9187.95406022969;9206.125418085272;9223.677171299007;9225.308101892351;9232.8615070774;9134.634614615408;9150.222231110363;9155.908440915573;9218.400803947721;9226.215771659417;9180.44917304964;9203.769905752342;9232.6306947722;9254.12085851843;9274;46181;46237.768811156064;46455.767721161516;46748.29877551839;46773.532264677255;3788.393856982897;3869.1351257070355;3917.9216415671813;3959.227950549644;3961.3067713150085;35794;36323.81838090819;36577.81711091428;36614.45078323827;36632;4708.152532544141;4788.353572267734;4795.784189711437;4796.328514008042;4869.780859861315;394032;395889;397136;397913;399651;67568.66215668891;67979;68452.31547684559;68460;68502;40158.79920600378;40956.59043409587;41119.7944010278;42840.57159428428;42912;18446.631067378577;18469.7229541557;18759.718604220947;18760.24959001652;18861.245550178115;14647.853521464649;14660.193689346976;14670.706585868436;14686.192259425834;14698.33857476416;21925.561488770134;22427.88786056092;22529.549409012056;22547.661785073236;22629.321120366414;7559.522619595048;7587.127480339721;7612.467127301146;7699.653515591812;7959.44283900133;1053.1574740207957;1090.2531765740493;1136.9829452558054;1167.165476684158;1238.1518659718122;34071.488927666105;35312.47031294533;36271.09831213496;36335.81832090876;37728.24543509114;1165.5920427850353;1198.8141838015122;1210.3040751567883;1212.478634187308;1299.3503248375812;17895.28418863257;18056.90971545134;18073.63852722938;18223.362182323555;18269.725954110698;932019;976328;990349;994700;997744;62435.06347404793;62715;62862.057069144;63168.68415657892;63284.683576581825;1429.0711037825704;1436.3967133803828;1480.415235981781;1480.5706345159783;1544.2201688147413;33525;33591.66408335885;33850.661493385735;34359.31281374308;34486;55812.72093639506;61663;63344.36655633384;63366.36633633605;70093;521610;528215;528849;531451;534702;49331.26003110028;49655.503444965085;50008.49974500625;50222.49777502178;51093.48906510887;54432.45567544274;55019.174712378546;55108.72445637746;56185.71907140438;57163.14255286091;45439.091218176116;45589.54410455853;46718;46772;46833.765831170625;43481.78259108684;45519.08961820811;46131.76934115308;46477.767611161726;46581.30128048014;46799;46934;47711.52288477071;47871.28193077037;48086.27870582014;39149.2170156601;39594;39923.203455845134;40352;41158.588414115475;31265.218369540944;31493.998484667627;31638.841805790824;31689.524657130623;31970 04:42:58 INFO - PROCESS | 17643 | |2;jquery.html;414.53986075456237;418.7654913248581;419.25372836351295;426.79727129613417;439.0494579235954;18476.353327633537;19419.22323107076;19918.302859399922;20855;21061.57876842462;19326.806731932676;19499.317523886668;19561.119749611265;20052.498687532818;20217;5760.7695692172265;5977.432143946318;6009.429104235091;6016.789412370568;6017.879642407149;4247.341662042389;5820.854478638025;5932;6393.520485963548;6671.399574038335;6547.47620190386;6594.439472644807;6608.867822643544;6635.137432133816;6650.900236496456;6413.551051426402;6705.966470167642;6709.060731497594;6709.09427227323;6725.09211256479;5707.857303567444;5922.911156332659;5951.434613711691;5954;5970.253718285215;22900.770992290032;23083.884580577156;23135.0745970161;23372;23493.647595286086;2541.07250853439;2560.7311232320526;2601.9869900650565;2610.25607701806;2910.970890291091;15001.474948376754;15380;15404.460843870524;15542.222888855513;15720.29258683362;2091.581683663258;2102.6320393931155;2107.7997590229056;2134.669126285413;2150.0969592770916;77140.22859771442;78875.11115996061;79078.60460697717;79453;79959.20040799634;10811.513481893333;10971.244600863824;11256.831147532794;11344.659660210207;11409.942950285196;15645.687086258438;15680.529584112495;15729.764053539206;15812.841871581137;15853.603659908595;8736.69421570242;9017.188453039127;9074.274058075338;9143.679971201109;9192.17270445663;8798.29613630908;8852.911470885338;8886.377953543319;8941.910580894239;9023.368364214442;6895.241523432418;7067.469939754436;7115.217326094125;7118.679659415338;7149.14210294768;1799.4961410804995;1917.5302050997595;1999.2302963359211;2041.3671761753903;2046.92835750748;997.8503224516236;1021.5964693945998;1052.021619893491;1063.2344711807486;1119.3507765495992;17145.571360715832;19778.70331945022;19847.801521984595;19916;20137.09383077765;1109.4951796932376;1116.983245251322;1139.5270962550615;1141.5148561861342;1180.976380472403;11243.437828108561;11361.261518001469;11425.657230283105;11560.132990025782;11653.067754579613;516724;532852;534287;535097;544096;77646;78691;79153;80297.59851200823;80317.59841200756;1085.8642669666292;1123.6909849791373;1145.7880292145812;1146.1804809561038;1152.5965911930757;17664.823351766318;17722.291108356036;17846.91076544609;17934.66911947507;17976.820231797516;41760;42605.36091958685;42785.358219626105;43499.13001740011;43824;60637.393626063174;61127.694361529684;61913.38086619076;62246.377536224056;63028;8704.129587041245;8817.911820881709;8894.866577001221;8997.145271199226;9054.502002389669;9710.465924373944;11539.36533490666;12407.441665125272;12947.611571652866;13063.216207027608;11151.386673732699;11190.216684831983;11468.713282168013;11596.768064638829;11725.179237453296;4791.856244312677;9623.663171788954;10403.855575886797;10591.4704264788;10835.837462438227;11617.941910290732;11664.183507154417;11719;11787.941060294643;11947.984421323938;8689.261412779984;8983.550822458981;9024.232940199894;9068.546572671472;9126.863097053681;8827.426217295855;11193.440327983732;11394.658160255205;11398.94300528492;11709.707257318636 04:42:58 INFO - PROCESS | 17643 | |3;mootools.html;1605.9357625694972;1655.5778276539484;1856.3131641292723;1931.3723040011982;1961.6763234066389;8378.539180345078;8951.462912225255;9116.270698344133;9958.253131015175;9993.200543956475;9046.27629789617;9112.498812565307;9405.106514881092;9454.669086581971;9564.09141131593;2470.617054356573;2514.3085651445817;2521.205820166651;2540.390306326487;2543.8473691578474;2364.113457453455;2386.343755467243;2388.9283321500384;2396.772306630867;2399.832011759169;2343.285297984114;2381.630847218684;2397.736249012607;2405.7714517120935;2417.528581926525;2318.547883162784;2324.5815753164507;2328.4528135888136;2356.622940329556;2392.569337519246;2329.9883500582387;2345.542619189259;2365.3849999000213;2367.3134790910617;2369.715634123916;9411.811763764756;9428.669996550156;9483.525823708856;9495.287853411022;9509.239260859114;5825.38833422493;5873.2658417697785;5947.910781338283;5954.166416701665;5964.582479226456;3727.030971947286;3770.340190466685;3771.283456143324;3807.8667246646232;3872;1109.5396506045652;1154.261272785418;1168.456667649547;1168.8363629091934;1175.3594291111278;13656.453741850313;13786.793198101936;13874.93062534681;13916.652083697887;13924.721505569933;5199.298094757235;5227.843164704989;5339.866503337447;5381.67709937405;5401.270828438189;11647.41762911868;11651.708707282216;11661.18371713989;11703.941480292544;11706.88293117058;5822.70886455684;5882.3529411764675;5904.291485021825;5916.497097746654;5935.109733539917;4840.177169881129;5310.150375939831;5420.891582168335;5431.2396264522995;5484.478974497496;4477.619402350771;4508.256137737302;4565.954340456553;4590.517995610413;4604.7927843247135;1395.539471974246;1459.7153555056875;1465.3332733606183;1469.897107202507;1482.13295222294;918.8437965545874;994.9403884862598;1007.66243308491;1081.4484612847348;1095.3318475729798;6531.575447595986;6582.736690532421;6689.531732778659;6705.832354191087;6725.6973436195485;487.50518224002667;492.8570714492757;493.1960903726902;505.9215821547666;520.9244659524423;4466.486354069259;4534.2971839364955;4599.563041511051;4604.815807367735;4608.216603177468;11852.822207666892;11968.341741204144;12232.877671223352;12294.262344259194;12548.68628284282;12237.082218833622;12295;12421.068419868547;12432.37838108091;12446.81329780054;8863.290936725047;9037.77405564853;9051.637934482678;9062.003179650234;9085.591148398338;6547.410733034049;6594.637294948632;6722.092517510074;6734.326567343226;6889;11141.498632561392;11153.888461115284;11197.328160310408;11396.544138234378;11417.828732568853;11462.312261264351;11508.367039812556;11541.192116551762;11652;11694.122940779645;8510.957445212734;8811.823763524822;8822.955885220534;8834.293256539333;8843.115688431362;9206.493642849708;9238.260939124988;9310.813783724423;9328.06719328089;9419.293552983416;8068.475549089525;8079.596020198849;8156.673733050611;8165.346772258324;8211.096779354148;8028.1169071403265;8163.551004694798;8186.345092392713;8190.754277371689;8303.709370172015;7809.531428114331;7829.373650107864;7863.960680196562;7889.408294377829;7937.682492700227;5625.746841392065;5697.116946873241;5818.127280907897;5825.097109947965;5868.471837534642;5611.046122159161;5708.857278568069;5750.194972703908;5774;5892 04:42:58 INFO - PROCESS | 17643 | |4;prototype.html;348.1678787697403;352.77246176216323;357.6888107346608;370.30198076625555;372.37069352793793;5572.832815015546;5657.2928383952;5733.684647344395;5798.362180160179;5825.300963884334;5505.724713764306;5585.385607583163;5628.521575666063;5635.055905712533;5711.457411545907;4408.691391602589;4435.356873253377;4436.223660859345;4466.325128076971;4490.50604433512;4210;4458.554144585548;4484.753338566377;4493.393391892102;4524.773761311938;4387.552107804417;4399.406080179167;4411.492678341983;4421.270490369101;4438.178936896668;4388.5830846069575;4418.64650827933;4421.010545254616;4434.778261086933;4452;3779.7732136071922;3853.441251018615;3898.7465814722236;3929.7445666031904;3934.429507721364;5435.809746658888;5477.698726570037;5483.862903427446;5495.148252020943;5516.862078448071;5082.847514574569;5091.949080509185;5094.955534115497;5101.362329708786;5107.948920510785;5708.286464191976;5882.47057764799;5900.321463031763;5950.821475355746;5977.521798256173;4231.238377092122;4232.259354612961;4246;4249.490061192646;4259.893502662459;6095.268567771852;6129.448349648553;6137.846553836145;6167;6217.906731399033;4251.447311849502;4310.870673879788;4313.352997050405;4322.827086916551;4329.415528903621;4352.564743525622;4369.519352871182;4370.759608221515;4374.62815660666;4407.669424793089;4925.236588328815;5033.1695270280725;5041.697498150123;5043.5965122790085;5072.289879416885;5708.20085188074;5756.65460072397;5988.9101663475085;6028.547858910511;6066.81492216581;1506.8869834762436;1508.9094654320777;1525.83978682239;1530.9387624495118;1533.4862820954881;972.5137431284357;988.3180605382263;991.9156871665989;993.9155171810332;997.546116516983;5126.769295381717;5150.97424512875;5186.559142472856;5234.97382513085;5282.517216908047;5399.460053994648;5435.537979271806;5441.782328706887;5541.251930989265;5546.918350921612;5002.59979201663;5165.631107756448;5198.6880787152895;5199.948000520022;5206.817761378409;2859.4416043256474;2886.4515742008953;2891.4097246514334;2912.402957393729;2926.956095658567;5593;5597.992361374992;5624;5670.497318210678;5769.538436925036;5187.818426355135;5474.863128421821;5485.753141108659;5491.176323551499;5611.242482264924;5603.375021243875;5607.52336051432;5624.578156638268;5628.073401831025;5634.464725850956;5124.590032797441;5376.843978544632;5402.864928376822;5406.702631355313;5441.972790136024;5314.574834013347;5382.892342153214;5394.1099718546;5410.242566040836;5462.180672899097;5469.374700143873;5622.6064175508955;5626.409227031267;5643.266375371176;5658.943410566007;3789.791561464146;3958.525921299188;3983.8605648802154;3991.4611527444586;4017.4978127734034;5413.188021796762;5428.348598168245;5492.670439773627;5919.881602367843;6084.178635884099;5915.231019967377;6006.369331220334;6013.488853447506;6038.909416358846;6056.969715151572;5878.882422351615;5904.763809447574;5930.881382372242;5936.5844390892225;5938.198343223609;5555.638883472561;5837.898356591539;5882.823515294548;5899.557533185114;5918.112283157561;6015.669138197266;6018.578699491169;6058;6059.878802424015;6070.1501789750355;5719.227904233042;5873.324567674772;5892.998190307572;5914.497267732291;5925.614835035709 04:42:58 INFO - PROCESS | 17643 | |5;yui.html;819.2585709932513;836.3058661311112;852.4757274276319;886.2644005475456;954.7279025477739;15077.396904123836;16262.593435164112;16515.83484165158;16675.91662041688;16765;15879.52361429156;16052.277647505862;16124.83875161248;16126.113063781488;16162.515124546253;855.149126619015;890.123228619809;892.5046599137476;894.4275663575316;896.274018045382;894.789724414762;894.9597268122917;896.7892545251893;897.6947837735169;902.5306840442998;934.5187228577288;943.6980166346772;947.8578213268031;949.2785483032876;952.8427809411439;948.7865230323191;949.2927768812244;950.0736781637883;950.3300173377787;951.6098399656108;696.6133795743411;696.7213114754088;698.6227437183915;698.671624336561;700.0933790741003;15123.546293611209;15146.469873554483;15154.469593564283;15184.620384490365;15430.53708388739;14681.412743490248;14732.55802325932;14887.47893823711;15306.464273750476;15612.375504979787;13097.86902130976;13188.47246110164;13213.669658258525;13253.204807711569;13322;4003.6596889264447;4087.8364865405347;4155.439015732868;4170.395292682544;4220.07158425146;77999;79627.20372796255;80233.59883200606;82427.17572824255;82509.58745206296;11915.404229788475;12257.2248879882;12352.567660131852;12503.187292825936;12684.302363370103;21422.78577214239;21621.24325648595;21625.56748865014;21756;21781.673274900888;8868.8669669955;9178.403403778733;9271.721848344561;9325.766855828522;9649.758756031015;5001.674891132065;5270.393904700932;5399.865003374868;5445.346558412936;5483.561315094783;3943.802809859553;4039.636432721069;4070.9389359159636;4110.260153172458;4123.175364927027;727.9308465695856;752.7704050264613;756.9659365328573;770.4221833624781;785.8428314337156;745.9776206713807;757.4508481350977;793.9483933544301;823.5100115431309;828.8632375657949;10254.692359229235;10305.587776488857;10872.075873550837;10977.506012229469;11061;748.1022772672815;770.3298130626391;782.5617654113714;787.6849260295813;794.5391672829745;5030.471800460972;5098.821541246113;5099.133147364957;5146.279520867081;5189.481051894856;99962;101711;103925;113053;116550.41724791322;92781;93394.53302733578;94791;95439.52280238693;97394.02605973992;57448;81900.18099819045;87297;87870;91248;10411.843822342822;10623.628173014216;10775.676729698122;11077.667669969915;11466.426678665866;51291.23063153981;51567;52450.737746311024;53925.46074539361;56742.716286418305;70472.53346133066;76891.61554192193;78276.60861695655;78616;79535;13679.974001949695;13913.930430347784;14285.142891426547;14315.99788014829;14466.493672721404;15804.92097539551;15858.20708964524;16056.919715401815;16259.349626014828;16688.666226675155;14162.221077840817;14260.286985650884;14281.105281705853;14352.712945740817;14664.853351466349;14730.484433044792;15191.908765173845;15388.692226155637;15408.15255160977;16008.8399116012;14896.851031489547;15100.093994360373;15210.695786084438;15650.37398504047;15651.452199172974;11387.715307117058;11409.828852567383;11450.37022963745;11895.940520297343;12500.24998500093;12417.75164496687;12673.17624354414;12836.294003829878;12997.480100795863;13066 04:42:58 INFO - PROCESS | 17643 | __end_tp_report 04:42:58 INFO - PROCESS | 17643 | __start_cc_report 04:42:58 INFO - PROCESS | 17643 | _x_x_mozilla_cycle_collect,339 04:42:58 INFO - PROCESS | 17643 | __end_cc_report 04:42:58 INFO - PROCESS | 17643 | __startTimestamp1469619778912__endTimestamp 04:42:58 INFO - PROCESS | 17643 | 04:42:58 INFO - PROCESS | 17643 | ------- Summary: start ------- 04:42:58 INFO - PROCESS | 17643 | Number of tests: 6 04:42:58 INFO - PROCESS | 17643 | 04:42:58 INFO - PROCESS | 17643 | [#0] dojo.html Cycles:165 Average:5753.89 Median:5996.73 stddev:639.47 (10.7%) stddev-sans-first:614.67 04:42:58 INFO - PROCESS | 17643 | Values: 3420.1 3459.3 3464.0 3491.8 3507.3 5757.9 5758.0 5781.2 5831.9 5887.0 5741.4 5742.4 5800.1 5815.1 5818.5 5209.1 5257.7 5288.1 5299.1 5327.2 5058.8 5125.8 5132.0 5341.7 5352.3 5240.5 5275.9 5279.4 5318.6 5333.2 5277.4 5354.8 5362.4 5365.9 5387.5 5095.4 5149.4 5211.6 5272.6 5352.9 5552.9 5611.3 5637.1 5650.5 5675.8 6089.5 6146.4 6172.9 6186.2 6202.7 5904.7 6127.3 6150.3 6228.8 6244.4 5884.7 5885.4 5891.2 5900.3 5908.5 6406.9 6413.4 6438.0 6456.8 6457.9 5941.9 6002.1 6017.5 6035.3 6179.8 6129.2 6143.7 6153.0 6165.3 6177.6 6070.3 6097.9 6110.9 6146.2 6148.7 5977.2 6126.4 6137.0 6182.2 6257.9 4753.6 4760.4 4772.5 4786.3 4790.8 4143.0 4222.3 4255.1 4258.7 4263.9 5739.0 5797.5 5955.8 5986.3 6016.0 6108.9 6141.9 6147.5 6151.8 6165.9 5983.4 5988.1 5994.1 6001.0 6018.8 5240.2 5268.3 5271.8 5287.7 5324.7 6406.4 6484.1 6499.6 6515.2 6522.6 6053.8 6239.1 6249.5 6255.7 6258.7 6251.5 6282.2 6305.4 6459.6 6464.9 6088.2 6088.7 6089.2 6090.8 6094.7 6047.5 6136.1 6189.9 6195.5 6197.8 6020.5 6077.8 6108.4 6129.0 6141.7 6057.8 6071.8 6073.1 6076.5 6094.8 5762.6 5920.9 5966.4 5968.0 5969.5 6076.9 6093.2 6100.1 6130.4 6143.2 5977.9 5996.5 5996.7 6001.1 6006.5 04:42:58 INFO - PROCESS | 17643 | 04:42:58 INFO - PROCESS | 17643 | [#1] ext.html Cycles:180 Average:79166.96 Median:46883.88 stddev:183930.51 (392.3%) stddev-sans-first:184351.87 04:42:58 INFO - PROCESS | 17643 | Values: 592.6 644.7 652.0 652.5 666.3 47396.8 48272.3 48714.0 48948.5 52353.0 50278.2 51124.7 51137.2 51183.5 51474.2 9142.2 9262.2 9264.5 9290.5 9302.8 9114.4 9159.2 9164.9 9171.9 9173.5 9188.0 9206.1 9223.7 9225.3 9232.9 9134.6 9150.2 9155.9 9218.4 9226.2 9180.4 9203.8 9232.6 9254.1 9274.0 46181.0 46237.8 46455.8 46748.3 46773.5 3788.4 3869.1 3917.9 3959.2 3961.3 35794.0 36323.8 36577.8 36614.5 36632.0 4708.2 4788.4 4795.8 4796.3 4869.8 394032.0 395889.0 397136.0 397913.0 399651.0 67568.7 67979.0 68452.3 68460.0 68502.0 40158.8 40956.6 41119.8 42840.6 42912.0 18446.6 18469.7 18759.7 18760.2 18861.2 14647.9 14660.2 14670.7 14686.2 14698.3 21925.6 22427.9 22529.5 22547.7 22629.3 7559.5 7587.1 7612.5 7699.7 7959.4 1053.2 1090.3 1137.0 1167.2 1238.2 34071.5 35312.5 36271.1 36335.8 37728.2 1165.6 1198.8 1210.3 1212.5 1299.4 17895.3 18056.9 18073.6 18223.4 18269.7 932019.0 976328.0 990349.0 994700.0 997744.0 62435.1 62715.0 62862.1 63168.7 63284.7 1429.1 1436.4 1480.4 1480.6 1544.2 33525.0 33591.7 33850.7 34359.3 34486.0 55812.7 61663.0 63344.4 63366.4 70093.0 521610.0 528215.0 528849.0 531451.0 534702.0 49331.3 49655.5 50008.5 50222.5 51093.5 54432.5 55019.2 55108.7 56185.7 57163.1 45439.1 45589.5 46718.0 46772.0 46833.8 43481.8 45519.1 46131.8 46477.8 46581.3 46799.0 46934.0 47711.5 47871.3 48086.3 39149.2 39594.0 39923.2 40352.0 41158.6 31265.2 31494.0 31638.8 31689.5 31970.0 04:42:58 INFO - PROCESS | 17643 | 04:42:58 INFO - PROCESS | 17643 | [#2] jquery.html Cycles:180 Average:30243.96 Median:2550.90 stddev:87317.92 (3423.0%) stddev-sans-first:87534.14 04:42:58 INFO - PROCESS | 17643 | Values: 414.5 418.8 419.3 426.8 439.0 18476.4 19419.2 19918.3 20855.0 21061.6 19326.8 19499.3 19561.1 20052.5 20217.0 5760.8 5977.4 6009.4 6016.8 6017.9 4247.3 5820.9 5932.0 6393.5 6671.4 6547.5 6594.4 6608.9 6635.1 6650.9 6413.6 6706.0 6709.1 6709.1 6725.1 5707.9 5922.9 5951.4 5954.0 5970.3 22900.8 23083.9 23135.1 23372.0 23493.6 2541.1 2560.7 2602.0 2610.3 2911.0 15001.5 15380.0 15404.5 15542.2 15720.3 2091.6 2102.6 2107.8 2134.7 2150.1 77140.2 78875.1 79078.6 79453.0 79959.2 10811.5 10971.2 11256.8 11344.7 11409.9 15645.7 15680.5 15729.8 15812.8 15853.6 8736.7 9017.2 9074.3 9143.7 9192.2 8798.3 8852.9 8886.4 8941.9 9023.4 6895.2 7067.5 7115.2 7118.7 7149.1 1799.5 1917.5 1999.2 2041.4 2046.9 997.9 1021.6 1052.0 1063.2 1119.4 17145.6 19778.7 19847.8 19916.0 20137.1 1109.5 1117.0 1139.5 1141.5 1181.0 11243.4 11361.3 11425.7 11560.1 11653.1 516724.0 532852.0 534287.0 535097.0 544096.0 77646.0 78691.0 79153.0 80297.6 80317.6 1085.9 1123.7 1145.8 1146.2 1152.6 17664.8 17722.3 17846.9 17934.7 17976.8 41760.0 42605.4 42785.4 43499.1 43824.0 60637.4 61127.7 61913.4 62246.4 63028.0 8704.1 8817.9 8894.9 8997.1 9054.5 9710.5 11539.4 12407.4 12947.6 13063.2 11151.4 11190.2 11468.7 11596.8 11725.2 4791.9 9623.7 10403.9 10591.5 10835.8 11617.9 11664.2 11719.0 11787.9 11948.0 8689.3 8983.6 9024.2 9068.5 9126.9 8827.4 11193.4 11394.7 11398.9 11709.7 04:42:58 INFO - PROCESS | 17643 | 04:42:58 INFO - PROCESS | 17643 | [#3] mootools.html Cycles:180 Average:6397.44 Median:493.03 stddev:3710.67 (752.6%) stddev-sans-first:3703.61 04:42:58 INFO - PROCESS | 17643 | Values: 1605.9 1655.6 1856.3 1931.4 1961.7 8378.5 8951.5 9116.3 9958.3 9993.2 9046.3 9112.5 9405.1 9454.7 9564.1 2470.6 2514.3 2521.2 2540.4 2543.8 2364.1 2386.3 2388.9 2396.8 2399.8 2343.3 2381.6 2397.7 2405.8 2417.5 2318.5 2324.6 2328.5 2356.6 2392.6 2330.0 2345.5 2365.4 2367.3 2369.7 9411.8 9428.7 9483.5 9495.3 9509.2 5825.4 5873.3 5947.9 5954.2 5964.6 3727.0 3770.3 3771.3 3807.9 3872.0 1109.5 1154.3 1168.5 1168.8 1175.4 13656.5 13786.8 13874.9 13916.7 13924.7 5199.3 5227.8 5339.9 5381.7 5401.3 11647.4 11651.7 11661.2 11703.9 11706.9 5822.7 5882.4 5904.3 5916.5 5935.1 4840.2 5310.2 5420.9 5431.2 5484.5 4477.6 4508.3 4566.0 4590.5 4604.8 1395.5 1459.7 1465.3 1469.9 1482.1 918.8 994.9 1007.7 1081.4 1095.3 6531.6 6582.7 6689.5 6705.8 6725.7 487.5 492.9 493.2 505.9 520.9 4466.5 4534.3 4599.6 4604.8 4608.2 11852.8 11968.3 12232.9 12294.3 12548.7 12237.1 12295.0 12421.1 12432.4 12446.8 8863.3 9037.8 9051.6 9062.0 9085.6 6547.4 6594.6 6722.1 6734.3 6889.0 11141.5 11153.9 11197.3 11396.5 11417.8 11462.3 11508.4 11541.2 11652.0 11694.1 8511.0 8811.8 8823.0 8834.3 8843.1 9206.5 9238.3 9310.8 9328.1 9419.3 8068.5 8079.6 8156.7 8165.3 8211.1 8028.1 8163.6 8186.3 8190.8 8303.7 7809.5 7829.4 7864.0 7889.4 7937.7 5625.7 5697.1 5818.1 5825.1 5868.5 5611.0 5708.9 5750.2 5774.0 5892.0 04:42:58 INFO - PROCESS | 17643 | 04:42:58 INFO - PROCESS | 17643 | [#4] prototype.html Cycles:180 Average:4814.47 Median:5420.77 stddev:1389.01 (25.6%) stddev-sans-first:1351.85 04:42:58 INFO - PROCESS | 17643 | Values: 348.2 352.8 357.7 370.3 372.4 5572.8 5657.3 5733.7 5798.4 5825.3 5505.7 5585.4 5628.5 5635.1 5711.5 4408.7 4435.4 4436.2 4466.3 4490.5 4210.0 4458.6 4484.8 4493.4 4524.8 4387.6 4399.4 4411.5 4421.3 4438.2 4388.6 4418.6 4421.0 4434.8 4452.0 3779.8 3853.4 3898.7 3929.7 3934.4 5435.8 5477.7 5483.9 5495.1 5516.9 5082.8 5091.9 5095.0 5101.4 5107.9 5708.3 5882.5 5900.3 5950.8 5977.5 4231.2 4232.3 4246.0 4249.5 4259.9 6095.3 6129.4 6137.8 6167.0 6217.9 4251.4 4310.9 4313.4 4322.8 4329.4 4352.6 4369.5 4370.8 4374.6 4407.7 4925.2 5033.2 5041.7 5043.6 5072.3 5708.2 5756.7 5988.9 6028.5 6066.8 1506.9 1508.9 1525.8 1530.9 1533.5 972.5 988.3 991.9 993.9 997.5 5126.8 5151.0 5186.6 5235.0 5282.5 5399.5 5435.5 5441.8 5541.3 5546.9 5002.6 5165.6 5198.7 5199.9 5206.8 2859.4 2886.5 2891.4 2912.4 2927.0 5593.0 5598.0 5624.0 5670.5 5769.5 5187.8 5474.9 5485.8 5491.2 5611.2 5603.4 5607.5 5624.6 5628.1 5634.5 5124.6 5376.8 5402.9 5406.7 5442.0 5314.6 5382.9 5394.1 5410.2 5462.2 5469.4 5622.6 5626.4 5643.3 5658.9 3789.8 3958.5 3983.9 3991.5 4017.5 5413.2 5428.3 5492.7 5919.9 6084.2 5915.2 6006.4 6013.5 6038.9 6057.0 5878.9 5904.8 5930.9 5936.6 5938.2 5555.6 5837.9 5882.8 5899.6 5918.1 6015.7 6018.6 6058.0 6059.9 6070.2 5719.2 5873.3 5893.0 5914.5 5925.6 04:42:58 INFO - PROCESS | 17643 | 04:42:58 INFO - PROCESS | 17643 | [#5] yui.html Cycles:180 Average:21112.34 Median:4139.31 stddev:28961.13 (699.7%) stddev-sans-first:29002.29 04:42:58 INFO - PROCESS | 17643 | Values: 819.3 836.3 852.5 886.3 954.7 15077.4 16262.6 16515.8 16675.9 16765.0 15879.5 16052.3 16124.8 16126.1 16162.5 855.1 890.1 892.5 894.4 896.3 894.8 895.0 896.8 897.7 902.5 934.5 943.7 947.9 949.3 952.8 948.8 949.3 950.1 950.3 951.6 696.6 696.7 698.6 698.7 700.1 15123.5 15146.5 15154.5 15184.6 15430.5 14681.4 14732.6 14887.5 15306.5 15612.4 13097.9 13188.5 13213.7 13253.2 13322.0 4003.7 4087.8 4155.4 4170.4 4220.1 77999.0 79627.2 80233.6 82427.2 82509.6 11915.4 12257.2 12352.6 12503.2 12684.3 21422.8 21621.2 21625.6 21756.0 21781.7 8868.9 9178.4 9271.7 9325.8 9649.8 5001.7 5270.4 5399.9 5445.3 5483.6 3943.8 4039.6 4070.9 4110.3 4123.2 727.9 752.8 757.0 770.4 785.8 746.0 757.5 793.9 823.5 828.9 10254.7 10305.6 10872.1 10977.5 11061.0 748.1 770.3 782.6 787.7 794.5 5030.5 5098.8 5099.1 5146.3 5189.5 99962.0 101711.0 103925.0 113053.0 116550.4 92781.0 93394.5 94791.0 95439.5 97394.0 57448.0 81900.2 87297.0 87870.0 91248.0 10411.8 10623.6 10775.7 11077.7 11466.4 51291.2 51567.0 52450.7 53925.5 56742.7 70472.5 76891.6 78276.6 78616.0 79535.0 13680.0 13913.9 14285.1 14316.0 14466.5 15804.9 15858.2 16056.9 16259.3 16688.7 14162.2 14260.3 14281.1 14352.7 14664.9 14730.5 15191.9 15388.7 15408.2 16008.8 14896.9 15100.1 15210.7 15650.4 15651.5 11387.7 11409.8 11450.4 11895.9 12500.2 12417.8 12673.2 12836.3 12997.5 13066.0 04:42:58 INFO - PROCESS | 17643 | -------- Summary: end -------- 04:42:58 INFO - PROCESS | 17643 | 04:42:59 INFO - TEST-INFO | 17643: exit 0 04:42:59 INFO - TEST-OK | dromaeo_css | took 1114172ms 04:42:59 INFO - TEST-START | kraken 04:42:59 INFO - operating with platform_type : linux_ 04:42:59 INFO - Initialising browser for kraken test... 04:42:59 INFO - TEST-INFO | started process 17891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjHd8rP/profile http://localhost:39676/getInfo.html) 04:43:06 INFO - PROCESS | 17891 | __metrics Screen width/height:1600/1200 04:43:06 INFO - PROCESS | 17891 | colorDepth:24 04:43:06 INFO - PROCESS | 17891 | Browser inner width/height: 1024/697 04:43:06 INFO - PROCESS | 17891 | __metrics 04:43:07 ERROR - PROCESS | 17891 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:43:08 INFO - TEST-INFO | 17891: exit 0 04:43:08 INFO - Browser initialized. 04:43:08 INFO - Running cycle 1/1 for kraken test... 04:43:08 INFO - TEST-INFO | started process 18022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjHd8rP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:20 INFO - PROCESS | 18022 | RSS: Main: 156037120 04:43:20 INFO - PROCESS | 18022 | 04:43:22 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39676/tests/kraken/driver.html?testName=audio-beat-detection) 04:43:23 INFO - PROCESS | 18022 | RSS: Main: 160837632 04:43:23 INFO - PROCESS | 18022 | 04:43:26 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39676/tests/kraken/driver.html?testName=audio-dft) 04:43:27 INFO - PROCESS | 18022 | RSS: Main: 160165888 04:43:27 INFO - PROCESS | 18022 | 04:43:29 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39676/tests/kraken/driver.html?testName=audio-fft) 04:43:30 INFO - PROCESS | 18022 | RSS: Main: 160534528 04:43:30 INFO - PROCESS | 18022 | 04:43:32 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39676/tests/kraken/driver.html?testName=audio-oscillator) 04:43:33 INFO - PROCESS | 18022 | RSS: Main: 160563200 04:43:33 INFO - PROCESS | 18022 | 04:43:35 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39676/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:36 INFO - PROCESS | 18022 | RSS: Main: 160260096 04:43:36 INFO - PROCESS | 18022 | 04:43:39 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39676/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:39 INFO - PROCESS | 18022 | RSS: Main: 160632832 04:43:39 INFO - PROCESS | 18022 | 04:43:43 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39676/tests/kraken/driver.html?testName=imaging-desaturate) 04:43:43 INFO - PROCESS | 18022 | RSS: Main: 160952320 04:43:43 INFO - PROCESS | 18022 | 04:43:46 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39676/tests/kraken/driver.html?testName=json-parse-financial) 04:43:47 INFO - PROCESS | 18022 | RSS: Main: 160903168 04:43:47 INFO - PROCESS | 18022 | 04:43:48 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39676/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:43:49 INFO - PROCESS | 18022 | RSS: Main: 160686080 04:43:49 INFO - PROCESS | 18022 | 04:43:51 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:43:51 INFO - PROCESS | 18022 | RSS: Main: 160743424 04:43:51 INFO - PROCESS | 18022 | 04:43:53 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:43:54 INFO - PROCESS | 18022 | RSS: Main: 161046528 04:43:54 INFO - PROCESS | 18022 | 04:43:57 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:43:57 INFO - PROCESS | 18022 | RSS: Main: 161300480 04:43:57 INFO - PROCESS | 18022 | 04:44:00 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:44:00 INFO - PROCESS | 18022 | RSS: Main: 161107968 04:44:00 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39676/tests/kraken/driver.html?testName=ai-astar) 04:44:02 INFO - PROCESS | 18022 | RSS: Main: 161497088 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | __start_tp_report 04:44:02 INFO - PROCESS | 18022 | _x_x_mozilla_page_load 04:44:02 INFO - PROCESS | 18022 | _x_x_mozilla_page_load_details 04:44:02 INFO - PROCESS | 18022 | |i|pagename|runs| 04:44:02 INFO - PROCESS | 18022 | |0;ai-astar;112;105;110;110;112;110;110;110;112;111 04:44:02 INFO - PROCESS | 18022 | |1;audio-beat-detection;147;132;157;180;125;153;157;135;180;126 04:44:02 INFO - PROCESS | 18022 | |2;audio-dft;163;165;163;162;163;162;162;160;161;162 04:44:02 INFO - PROCESS | 18022 | |3;audio-fft;76;76;75;167;75;76;74;76;169;77 04:44:02 INFO - PROCESS | 18022 | |4;audio-oscillator;85;85;156;84;84;85;141;86;85;143 04:44:02 INFO - PROCESS | 18022 | |5;imaging-gaussian-blur;120;120;117;117;118;117;118;117;118;118 04:44:02 INFO - PROCESS | 18022 | |6;imaging-darkroom;147;147;147;148;147;148;147;148;147;147 04:44:02 INFO - PROCESS | 18022 | |7;imaging-desaturate;96;96;96;96;100;96;96;96;95;95 04:44:02 INFO - PROCESS | 18022 | |8;json-parse-financial;52;51;50;51;52;51;56;52;50;52 04:44:02 INFO - PROCESS | 18022 | |9;json-stringify-tinderbox;61;61;61;61;62;62;60;61;61;61 04:44:02 INFO - PROCESS | 18022 | |10;stanford-crypto-aes;77;81;76;78;76;78;79;78;113;78 04:44:02 INFO - PROCESS | 18022 | |11;stanford-crypto-ccm;130;128;126;120;121;117;126;119;128;121 04:44:02 INFO - PROCESS | 18022 | |12;stanford-crypto-pbkdf2;161;153;160;155;156;149;153;152;169;157 04:44:02 INFO - PROCESS | 18022 | |13;stanford-crypto-sha256-iterative;61;64;61;61;62;64;63;69;64;63 04:44:02 INFO - PROCESS | 18022 | __end_tp_report 04:44:02 INFO - PROCESS | 18022 | __start_cc_report 04:44:02 INFO - PROCESS | 18022 | _x_x_mozilla_cycle_collect,867 04:44:02 INFO - PROCESS | 18022 | __end_cc_report 04:44:02 INFO - PROCESS | 18022 | __startTimestamp1469619842831__endTimestamp 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | ------- Summary: start ------- 04:44:02 INFO - PROCESS | 18022 | Number of tests: 14 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:2.04 (1.8%) stddev-sans-first:2.06 04:44:02 INFO - PROCESS | 18022 | Values: 112.0 105.0 110.0 110.0 112.0 110.0 110.0 110.0 112.0 111.0 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:155.00 stddev:20.16 (13.0%) stddev-sans-first:21.37 04:44:02 INFO - PROCESS | 18022 | Values: 147.0 132.0 157.0 180.0 125.0 153.0 157.0 135.0 180.0 126.0 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.34 (0.8%) stddev-sans-first:1.39 04:44:02 INFO - PROCESS | 18022 | Values: 163.0 165.0 163.0 162.0 163.0 162.0 162.0 160.0 161.0 162.0 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.00 stddev:38.96 (51.3%) stddev-sans-first:40.77 04:44:02 INFO - PROCESS | 18022 | Values: 76.0 76.0 75.0 167.0 75.0 76.0 74.0 76.0 169.0 77.0 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:85.00 stddev:30.11 (35.4%) stddev-sans-first:31.19 04:44:02 INFO - PROCESS | 18022 | Values: 85.0 85.0 156.0 84.0 84.0 85.0 141.0 86.0 85.0 143.0 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.15 (1.0%) stddev-sans-first:0.97 04:44:02 INFO - PROCESS | 18022 | Values: 120.0 120.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 04:44:02 INFO - PROCESS | 18022 | Values: 147.0 147.0 147.0 148.0 147.0 148.0 147.0 148.0 147.0 147.0 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.40 (1.5%) stddev-sans-first:1.48 04:44:02 INFO - PROCESS | 18022 | Values: 96.0 96.0 96.0 96.0 100.0 96.0 96.0 96.0 95.0 95.0 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:1.70 (3.3%) stddev-sans-first:1.80 04:44:02 INFO - PROCESS | 18022 | Values: 52.0 51.0 50.0 51.0 52.0 51.0 56.0 52.0 50.0 52.0 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 04:44:02 INFO - PROCESS | 18022 | Values: 61.0 61.0 61.0 61.0 62.0 62.0 60.0 61.0 61.0 61.0 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:78.00 stddev:11.20 (14.4%) stddev-sans-first:11.76 04:44:02 INFO - PROCESS | 18022 | Values: 77.0 81.0 76.0 78.0 76.0 78.0 79.0 78.0 113.0 78.0 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:126.00 stddev:4.50 (3.6%) stddev-sans-first:4.14 04:44:02 INFO - PROCESS | 18022 | Values: 130.0 128.0 126.0 120.0 121.0 117.0 126.0 119.0 128.0 121.0 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:156.50 stddev:5.70 (3.6%) stddev-sans-first:5.81 04:44:02 INFO - PROCESS | 18022 | Values: 161.0 153.0 160.0 155.0 156.0 149.0 153.0 152.0 169.0 157.0 04:44:02 INFO - PROCESS | 18022 | 04:44:02 INFO - PROCESS | 18022 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:2.39 (3.8%) stddev-sans-first:2.40 04:44:02 INFO - PROCESS | 18022 | Values: 61.0 64.0 61.0 61.0 62.0 64.0 63.0 69.0 64.0 63.0 04:44:02 INFO - PROCESS | 18022 | -------- Summary: end -------- 04:44:02 INFO - PROCESS | 18022 | 04:44:03 INFO - TEST-INFO | 18022: exit 0 04:44:03 INFO - TEST-OK | kraken | took 64195ms 04:44:03 INFO - SUITE-END | took 1178s 04:44:03 INFO - Completed test suite (00:19:38) 04:44:03 INFO - javascript benchmark 04:44:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7793.6440573002355, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3420.1107711994878, 3459.3254315408476, 3464.0127563644337, 3491.8428670709814, 3507.2810073934847, 5757.913631295534, 5758.0, 5781.190633311329, 5831.854203644905, 5887.0286402743495, 5741.368449470555, 5742.368339482654, 5800.071988481844, 5815.127730840376, 5818.505427038707, 5209.088409528336, 5257.737113144328, 5288.0745869472885, 5299.099153143975, 5327.200919862013, 5058.772355244005, 5125.769340379692, 5132.024915266106, 5341.732913354336, 5352.330958630171, 5240.502152295526, 5275.920861187085, 5279.3928698199625, 5318.601104917147, 5333.173358129496, 5277.445868183843, 5354.839354819343, 5362.410134885159, 5365.865853353658, 5387.4612538746205, 5095.388553373619, 5149.356330458692, 5211.557017653504, 5272.578193744491, 5352.946470535284, 5552.91670624941, 5611.270534830446, 5637.126245431924, 5650.51970582501, 5675.829725108253, 6089.482393996515, 6146.416090471398, 6172.938270617326, 6186.226721659793, 6202.689865506707, 5904.734286957054, 6127.34224287047, 6150.261968563756, 6228.844278893019, 6244.438000579969, 5884.70576471179, 5885.440883116097, 5891.23413956183, 5900.291964964189, 5908.497777688859, 6406.935930640634, 6413.422791948747, 6437.9678101610125, 6456.838579035468, 6457.870842583216, 5941.940580594225, 6002.069679199731, 6017.458428741435, 6035.336113027563, 6179.81460556184, 6129.233845769279, 6143.662098584621, 6153.046277826855, 6165.260168779775, 6177.567570270128, 6070.332263451017, 6097.878042439126, 6110.938890611126, 6146.200993870858, 6148.661823599656, 5977.163197152402, 6126.36500017443, 6137.0, 6182.196314479089, 6257.8748425031245, 4753.619710423158, 4760.357351757538, 4772.451168115711, 4786.329913811999, 4790.784414701347, 4143.0, 4222.303319952235, 4255.106427650228, 4258.659307255412, 4263.936040959388, 5739.0, 5797.4782269595935, 5955.76176952917, 5986.2517185351835, 6016.0, 6108.852642408393, 6141.946315431794, 6147.508199344042, 6151.7539298428455, 6165.876682466325, 5983.371745966698, 5988.071848863346, 5994.07091900756, 6000.969995149996, 6018.8194354169445, 5240.240165176028, 5268.315119034501, 5271.762770675252, 5287.735613219324, 5324.707141107277, 6406.423421892052, 6484.124643173205, 6499.610023398611, 6515.153030106056, 6522.64125473094, 6053.788117415869, 6239.06414037898, 6249.50003999688, 6255.74977000924, 6258.718357674006, 6251.499880009497, 6282.2147231596055, 6305.369463053658, 6459.580127291711, 6464.870702586016, 6088.208532890696, 6088.665123418255, 6089.208402907594, 6090.756369745161, 6094.695265236809, 6047.5464340173785, 6136.079588061648, 6189.876202475835, 6195.504359651127, 6197.81406557804, 6020.54845886569, 6077.817665470043, 6108.389161083856, 6128.988716861668, 6141.723622437091, 6057.7879774207695, 6071.7571297147615, 6073.119397687399, 6076.544259180668, 6094.847628809315, 5762.625429347079, 5920.911186332122, 5966.3735307793795, 5968.045112781934, 5969.522438204846, 6076.878462430638, 6093.238345206849, 6100.0849872519475, 6130.356312587114, 6143.170671959407, 5977.880442391215, 5996.4603185713495, 5996.730147143302, 6001.129836173817, 6006.489448396936], "value": 5712.3303862173125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.6266452135154, 644.7453255963894, 652.0187118386827, 652.5301782716442, 666.3170250493243, 47396.763016184916, 48272.275915861246, 48714.02571948563, 48948.51051489484, 52353.0, 50278.24582631263, 51124.74437627816, 51137.23294150591, 51183.48816511834, 51474.22788658173, 9142.222911052568, 9262.166405023547, 9264.49045302508, 9290.489023103726, 9302.813943721121, 9114.407563508385, 9159.175674189322, 9164.908350916505, 9171.862422063641, 9173.541322933826, 9187.95406022969, 9206.125418085272, 9223.677171299007, 9225.308101892351, 9232.8615070774, 9134.634614615408, 9150.222231110363, 9155.908440915573, 9218.400803947721, 9226.215771659417, 9180.44917304964, 9203.769905752342, 9232.6306947722, 9254.12085851843, 9274.0, 46181.0, 46237.768811156064, 46455.767721161516, 46748.29877551839, 46773.532264677255, 3788.393856982897, 3869.1351257070355, 3917.9216415671813, 3959.227950549644, 3961.3067713150085, 35794.0, 36323.81838090819, 36577.81711091428, 36614.45078323827, 36632.0, 4708.152532544141, 4788.353572267734, 4795.784189711437, 4796.328514008042, 4869.780859861315, 394032.0, 395889.0, 397136.0, 397913.0, 399651.0, 67568.66215668891, 67979.0, 68452.31547684559, 68460.0, 68502.0, 40158.79920600378, 40956.59043409587, 41119.7944010278, 42840.57159428428, 42912.0, 18446.631067378577, 18469.7229541557, 18759.718604220947, 18760.24959001652, 18861.245550178115, 14647.853521464649, 14660.193689346976, 14670.706585868436, 14686.192259425834, 14698.33857476416, 21925.561488770134, 22427.88786056092, 22529.549409012056, 22547.661785073236, 22629.321120366414, 7559.522619595048, 7587.127480339721, 7612.467127301146, 7699.653515591812, 7959.44283900133, 1053.1574740207957, 1090.2531765740493, 1136.9829452558054, 1167.165476684158, 1238.1518659718122, 34071.488927666105, 35312.47031294533, 36271.09831213496, 36335.81832090876, 37728.24543509114, 1165.5920427850353, 1198.8141838015122, 1210.3040751567883, 1212.478634187308, 1299.3503248375812, 17895.28418863257, 18056.90971545134, 18073.63852722938, 18223.362182323555, 18269.725954110698, 932019.0, 976328.0, 990349.0, 994700.0, 997744.0, 62435.06347404793, 62715.0, 62862.057069144, 63168.68415657892, 63284.683576581825, 1429.0711037825704, 1436.3967133803828, 1480.415235981781, 1480.5706345159783, 1544.2201688147413, 33525.0, 33591.66408335885, 33850.661493385735, 34359.31281374308, 34486.0, 55812.72093639506, 61663.0, 63344.36655633384, 63366.36633633605, 70093.0, 521610.0, 528215.0, 528849.0, 531451.0, 534702.0, 49331.26003110028, 49655.503444965085, 50008.49974500625, 50222.49777502178, 51093.48906510887, 54432.45567544274, 55019.174712378546, 55108.72445637746, 56185.71907140438, 57163.14255286091, 45439.091218176116, 45589.54410455853, 46718.0, 46772.0, 46833.765831170625, 43481.78259108684, 45519.08961820811, 46131.76934115308, 46477.767611161726, 46581.30128048014, 46799.0, 46934.0, 47711.52288477071, 47871.28193077037, 48086.27870582014, 39149.2170156601, 39594.0, 39923.203455845134, 40352.0, 41158.588414115475, 31265.218369540944, 31493.998484667627, 31638.841805790824, 31689.524657130623, 31970.0], "value": 22626.527705518998, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.53986075456237, 418.7654913248581, 419.25372836351295, 426.79727129613417, 439.0494579235954, 18476.353327633537, 19419.22323107076, 19918.302859399922, 20855.0, 21061.57876842462, 19326.806731932676, 19499.317523886668, 19561.119749611265, 20052.498687532818, 20217.0, 5760.7695692172265, 5977.432143946318, 6009.429104235091, 6016.789412370568, 6017.879642407149, 4247.341662042389, 5820.854478638025, 5932.0, 6393.520485963548, 6671.399574038335, 6547.47620190386, 6594.439472644807, 6608.867822643544, 6635.137432133816, 6650.900236496456, 6413.551051426402, 6705.966470167642, 6709.060731497594, 6709.09427227323, 6725.09211256479, 5707.857303567444, 5922.911156332659, 5951.434613711691, 5954.0, 5970.253718285215, 22900.770992290032, 23083.884580577156, 23135.0745970161, 23372.0, 23493.647595286086, 2541.07250853439, 2560.7311232320526, 2601.9869900650565, 2610.25607701806, 2910.970890291091, 15001.474948376754, 15380.0, 15404.460843870524, 15542.222888855513, 15720.29258683362, 2091.581683663258, 2102.6320393931155, 2107.7997590229056, 2134.669126285413, 2150.0969592770916, 77140.22859771442, 78875.11115996061, 79078.60460697717, 79453.0, 79959.20040799634, 10811.513481893333, 10971.244600863824, 11256.831147532794, 11344.659660210207, 11409.942950285196, 15645.687086258438, 15680.529584112495, 15729.764053539206, 15812.841871581137, 15853.603659908595, 8736.69421570242, 9017.188453039127, 9074.274058075338, 9143.679971201109, 9192.17270445663, 8798.29613630908, 8852.911470885338, 8886.377953543319, 8941.910580894239, 9023.368364214442, 6895.241523432418, 7067.469939754436, 7115.217326094125, 7118.679659415338, 7149.14210294768, 1799.4961410804995, 1917.5302050997595, 1999.2302963359211, 2041.3671761753903, 2046.92835750748, 997.8503224516236, 1021.5964693945998, 1052.021619893491, 1063.2344711807486, 1119.3507765495992, 17145.571360715832, 19778.70331945022, 19847.801521984595, 19916.0, 20137.09383077765, 1109.4951796932376, 1116.983245251322, 1139.5270962550615, 1141.5148561861342, 1180.976380472403, 11243.437828108561, 11361.261518001469, 11425.657230283105, 11560.132990025782, 11653.067754579613, 516724.0, 532852.0, 534287.0, 535097.0, 544096.0, 77646.0, 78691.0, 79153.0, 80297.59851200823, 80317.59841200756, 1085.8642669666292, 1123.6909849791373, 1145.7880292145812, 1146.1804809561038, 1152.5965911930757, 17664.823351766318, 17722.291108356036, 17846.91076544609, 17934.66911947507, 17976.820231797516, 41760.0, 42605.36091958685, 42785.358219626105, 43499.13001740011, 43824.0, 60637.393626063174, 61127.694361529684, 61913.38086619076, 62246.377536224056, 63028.0, 8704.129587041245, 8817.911820881709, 8894.866577001221, 8997.145271199226, 9054.502002389669, 9710.465924373944, 11539.36533490666, 12407.441665125272, 12947.611571652866, 13063.216207027608, 11151.386673732699, 11190.216684831983, 11468.713282168013, 11596.768064638829, 11725.179237453296, 4791.856244312677, 9623.663171788954, 10403.855575886797, 10591.4704264788, 10835.837462438227, 11617.941910290732, 11664.183507154417, 11719.0, 11787.941060294643, 11947.984421323938, 8689.261412779984, 8983.550822458981, 9024.232940199894, 9068.546572671472, 9126.863097053681, 8827.426217295855, 11193.440327983732, 11394.658160255205, 11398.94300528492, 11709.707257318636], "value": 9719.439149014754, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1605.9357625694972, 1655.5778276539484, 1856.3131641292723, 1931.3723040011982, 1961.6763234066389, 8378.539180345078, 8951.462912225255, 9116.270698344133, 9958.253131015175, 9993.200543956475, 9046.27629789617, 9112.498812565307, 9405.106514881092, 9454.669086581971, 9564.09141131593, 2470.617054356573, 2514.3085651445817, 2521.205820166651, 2540.390306326487, 2543.8473691578474, 2364.113457453455, 2386.343755467243, 2388.9283321500384, 2396.772306630867, 2399.832011759169, 2343.285297984114, 2381.630847218684, 2397.736249012607, 2405.7714517120935, 2417.528581926525, 2318.547883162784, 2324.5815753164507, 2328.4528135888136, 2356.622940329556, 2392.569337519246, 2329.9883500582387, 2345.542619189259, 2365.3849999000213, 2367.3134790910617, 2369.715634123916, 9411.811763764756, 9428.669996550156, 9483.525823708856, 9495.287853411022, 9509.239260859114, 5825.38833422493, 5873.2658417697785, 5947.910781338283, 5954.166416701665, 5964.582479226456, 3727.030971947286, 3770.340190466685, 3771.283456143324, 3807.8667246646232, 3872.0, 1109.5396506045652, 1154.261272785418, 1168.456667649547, 1168.8363629091934, 1175.3594291111278, 13656.453741850313, 13786.793198101936, 13874.93062534681, 13916.652083697887, 13924.721505569933, 5199.298094757235, 5227.843164704989, 5339.866503337447, 5381.67709937405, 5401.270828438189, 11647.41762911868, 11651.708707282216, 11661.18371713989, 11703.941480292544, 11706.88293117058, 5822.70886455684, 5882.3529411764675, 5904.291485021825, 5916.497097746654, 5935.109733539917, 4840.177169881129, 5310.150375939831, 5420.891582168335, 5431.2396264522995, 5484.478974497496, 4477.619402350771, 4508.256137737302, 4565.954340456553, 4590.517995610413, 4604.7927843247135, 1395.539471974246, 1459.7153555056875, 1465.3332733606183, 1469.897107202507, 1482.13295222294, 918.8437965545874, 994.9403884862598, 1007.66243308491, 1081.4484612847348, 1095.3318475729798, 6531.575447595986, 6582.736690532421, 6689.531732778659, 6705.832354191087, 6725.6973436195485, 487.50518224002667, 492.8570714492757, 493.1960903726902, 505.9215821547666, 520.9244659524423, 4466.486354069259, 4534.2971839364955, 4599.563041511051, 4604.815807367735, 4608.216603177468, 11852.822207666892, 11968.341741204144, 12232.877671223352, 12294.262344259194, 12548.68628284282, 12237.082218833622, 12295.0, 12421.068419868547, 12432.37838108091, 12446.81329780054, 8863.290936725047, 9037.77405564853, 9051.637934482678, 9062.003179650234, 9085.591148398338, 6547.410733034049, 6594.637294948632, 6722.092517510074, 6734.326567343226, 6889.0, 11141.498632561392, 11153.888461115284, 11197.328160310408, 11396.544138234378, 11417.828732568853, 11462.312261264351, 11508.367039812556, 11541.192116551762, 11652.0, 11694.122940779645, 8510.957445212734, 8811.823763524822, 8822.955885220534, 8834.293256539333, 8843.115688431362, 9206.493642849708, 9238.260939124988, 9310.813783724423, 9328.06719328089, 9419.293552983416, 8068.475549089525, 8079.596020198849, 8156.673733050611, 8165.346772258324, 8211.096779354148, 8028.1169071403265, 8163.551004694798, 8186.345092392713, 8190.754277371689, 8303.709370172015, 7809.531428114331, 7829.373650107864, 7863.960680196562, 7889.408294377829, 7937.682492700227, 5625.746841392065, 5697.116946873241, 5818.127280907897, 5825.097109947965, 5868.471837534642, 5611.046122159161, 5708.857278568069, 5750.194972703908, 5774.0, 5892.0], "value": 4994.111917448292, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.1678787697403, 352.77246176216323, 357.6888107346608, 370.30198076625555, 372.37069352793793, 5572.832815015546, 5657.2928383952, 5733.684647344395, 5798.362180160179, 5825.300963884334, 5505.724713764306, 5585.385607583163, 5628.521575666063, 5635.055905712533, 5711.457411545907, 4408.691391602589, 4435.356873253377, 4436.223660859345, 4466.325128076971, 4490.50604433512, 4210.0, 4458.554144585548, 4484.753338566377, 4493.393391892102, 4524.773761311938, 4387.552107804417, 4399.406080179167, 4411.492678341983, 4421.270490369101, 4438.178936896668, 4388.5830846069575, 4418.64650827933, 4421.010545254616, 4434.778261086933, 4452.0, 3779.7732136071922, 3853.441251018615, 3898.7465814722236, 3929.7445666031904, 3934.429507721364, 5435.809746658888, 5477.698726570037, 5483.862903427446, 5495.148252020943, 5516.862078448071, 5082.847514574569, 5091.949080509185, 5094.955534115497, 5101.362329708786, 5107.948920510785, 5708.286464191976, 5882.47057764799, 5900.321463031763, 5950.821475355746, 5977.521798256173, 4231.238377092122, 4232.259354612961, 4246.0, 4249.490061192646, 4259.893502662459, 6095.268567771852, 6129.448349648553, 6137.846553836145, 6167.0, 6217.906731399033, 4251.447311849502, 4310.870673879788, 4313.352997050405, 4322.827086916551, 4329.415528903621, 4352.564743525622, 4369.519352871182, 4370.759608221515, 4374.62815660666, 4407.669424793089, 4925.236588328815, 5033.1695270280725, 5041.697498150123, 5043.5965122790085, 5072.289879416885, 5708.20085188074, 5756.65460072397, 5988.9101663475085, 6028.547858910511, 6066.81492216581, 1506.8869834762436, 1508.9094654320777, 1525.83978682239, 1530.9387624495118, 1533.4862820954881, 972.5137431284357, 988.3180605382263, 991.9156871665989, 993.9155171810332, 997.546116516983, 5126.769295381717, 5150.97424512875, 5186.559142472856, 5234.97382513085, 5282.517216908047, 5399.460053994648, 5435.537979271806, 5441.782328706887, 5541.251930989265, 5546.918350921612, 5002.59979201663, 5165.631107756448, 5198.6880787152895, 5199.948000520022, 5206.817761378409, 2859.4416043256474, 2886.4515742008953, 2891.4097246514334, 2912.402957393729, 2926.956095658567, 5593.0, 5597.992361374992, 5624.0, 5670.497318210678, 5769.538436925036, 5187.818426355135, 5474.863128421821, 5485.753141108659, 5491.176323551499, 5611.242482264924, 5603.375021243875, 5607.52336051432, 5624.578156638268, 5628.073401831025, 5634.464725850956, 5124.590032797441, 5376.843978544632, 5402.864928376822, 5406.702631355313, 5441.972790136024, 5314.574834013347, 5382.892342153214, 5394.1099718546, 5410.242566040836, 5462.180672899097, 5469.374700143873, 5622.6064175508955, 5626.409227031267, 5643.266375371176, 5658.943410566007, 3789.791561464146, 3958.525921299188, 3983.8605648802154, 3991.4611527444586, 4017.4978127734034, 5413.188021796762, 5428.348598168245, 5492.670439773627, 5919.881602367843, 6084.178635884099, 5915.231019967377, 6006.369331220334, 6013.488853447506, 6038.909416358846, 6056.969715151572, 5878.882422351615, 5904.763809447574, 5930.881382372242, 5936.5844390892225, 5938.198343223609, 5555.638883472561, 5837.898356591539, 5882.823515294548, 5899.557533185114, 5918.112283157561, 6015.669138197266, 6018.578699491169, 6058.0, 6059.878802424015, 6070.1501789750355, 5719.227904233042, 5873.324567674772, 5892.998190307572, 5914.497267732291, 5925.614835035709], "value": 4377.838063697384, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.2585709932513, 836.3058661311112, 852.4757274276319, 886.2644005475456, 954.7279025477739, 15077.396904123836, 16262.593435164112, 16515.83484165158, 16675.91662041688, 16765.0, 15879.52361429156, 16052.277647505862, 16124.83875161248, 16126.113063781488, 16162.515124546253, 855.149126619015, 890.123228619809, 892.5046599137476, 894.4275663575316, 896.274018045382, 894.789724414762, 894.9597268122917, 896.7892545251893, 897.6947837735169, 902.5306840442998, 934.5187228577288, 943.6980166346772, 947.8578213268031, 949.2785483032876, 952.8427809411439, 948.7865230323191, 949.2927768812244, 950.0736781637883, 950.3300173377787, 951.6098399656108, 696.6133795743411, 696.7213114754088, 698.6227437183915, 698.671624336561, 700.0933790741003, 15123.546293611209, 15146.469873554483, 15154.469593564283, 15184.620384490365, 15430.53708388739, 14681.412743490248, 14732.55802325932, 14887.47893823711, 15306.464273750476, 15612.375504979787, 13097.86902130976, 13188.47246110164, 13213.669658258525, 13253.204807711569, 13322.0, 4003.6596889264447, 4087.8364865405347, 4155.439015732868, 4170.395292682544, 4220.07158425146, 77999.0, 79627.20372796255, 80233.59883200606, 82427.17572824255, 82509.58745206296, 11915.404229788475, 12257.2248879882, 12352.567660131852, 12503.187292825936, 12684.302363370103, 21422.78577214239, 21621.24325648595, 21625.56748865014, 21756.0, 21781.673274900888, 8868.8669669955, 9178.403403778733, 9271.721848344561, 9325.766855828522, 9649.758756031015, 5001.674891132065, 5270.393904700932, 5399.865003374868, 5445.346558412936, 5483.561315094783, 3943.802809859553, 4039.636432721069, 4070.9389359159636, 4110.260153172458, 4123.175364927027, 727.9308465695856, 752.7704050264613, 756.9659365328573, 770.4221833624781, 785.8428314337156, 745.9776206713807, 757.4508481350977, 793.9483933544301, 823.5100115431309, 828.8632375657949, 10254.692359229235, 10305.587776488857, 10872.075873550837, 10977.506012229469, 11061.0, 748.1022772672815, 770.3298130626391, 782.5617654113714, 787.6849260295813, 794.5391672829745, 5030.471800460972, 5098.821541246113, 5099.133147364957, 5146.279520867081, 5189.481051894856, 99962.0, 101711.0, 103925.0, 113053.0, 116550.41724791322, 92781.0, 93394.53302733578, 94791.0, 95439.52280238693, 97394.02605973992, 57448.0, 81900.18099819045, 87297.0, 87870.0, 91248.0, 10411.843822342822, 10623.628173014216, 10775.676729698122, 11077.667669969915, 11466.426678665866, 51291.23063153981, 51567.0, 52450.737746311024, 53925.46074539361, 56742.716286418305, 70472.53346133066, 76891.61554192193, 78276.60861695655, 78616.0, 79535.0, 13679.974001949695, 13913.930430347784, 14285.142891426547, 14315.99788014829, 14466.493672721404, 15804.92097539551, 15858.20708964524, 16056.919715401815, 16259.349626014828, 16688.666226675155, 14162.221077840817, 14260.286985650884, 14281.105281705853, 14352.712945740817, 14664.853351466349, 14730.484433044792, 15191.908765173845, 15388.692226155637, 15408.15255160977, 16008.8399116012, 14896.851031489547, 15100.093994360373, 15210.695786084438, 15650.37398504047, 15651.452199172974, 11387.715307117058, 11409.828852567383, 11450.37022963745, 11895.940520297343, 12500.24998500093, 12417.75164496687, 12673.17624354414, 12836.294003829878, 12997.480100795863, 13066.0], "value": 8158.457592198082, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 110.0, 110.0, 112.0, 110.0, 110.0, 110.0, 112.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 132.0, 157.0, 180.0, 125.0, 153.0, 157.0, 135.0, 180.0, 126.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 162.0, 163.0, 162.0, 162.0, 160.0, 161.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 167.0, 75.0, 76.0, 74.0, 76.0, 169.0, 77.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 156.0, 84.0, 84.0, 85.0, 141.0, 86.0, 85.0, 143.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 100.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 50.0, 51.0, 52.0, 51.0, 56.0, 52.0, 50.0, 52.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 60.0, 61.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 76.0, 78.0, 76.0, 78.0, 79.0, 78.0, 113.0, 78.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 128.0, 126.0, 120.0, 121.0, 117.0, 126.0, 119.0, 128.0, 121.0], "value": 123.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 153.0, 160.0, 155.0, 156.0, 149.0, 153.0, 152.0, 169.0, 157.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 61.0, 61.0, 62.0, 64.0, 63.0, 69.0, 64.0, 63.0], "value": 63.2, "unit": "score"}]}]} 04:44:04 INFO - Return code: 0 04:44:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:44:04 ERROR - # TBPL SUCCESS # 04:44:04 INFO - Running post-action listener: _resource_record_post_action 04:44:04 INFO - ##### 04:44:04 INFO - ##### Finished run-tests step (success) 04:44:04 INFO - ##### 04:44:04 INFO - Running post-run listener: _resource_record_post_run 04:44:04 INFO - Total resource usage - Wall time: 1206s; CPU: 14.0%; Read bytes: 266240; Write bytes: 508055552; Read time: 304; Write time: 3868372 04:44:04 INFO - TinderboxPrint: CPU usage
13.9% 04:44:04 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 304 04:44:04 INFO - TinderboxPrint: I/O write bytes / time
508,055,552 / 3,868,372 04:44:04 INFO - TinderboxPrint: CPU idle
8,281.0 (86.1%) 04:44:04 INFO - TinderboxPrint: CPU user
1,220.1 (12.7%) 04:44:04 INFO - TinderboxPrint: Swap in / out
0 / 0 04:44:04 INFO - install - Wall time: 27s; CPU: 27.0%; Read bytes: 0; Write bytes: 253059072; Read time: 0; Write time: 2620460 04:44:04 INFO - run-tests - Wall time: 1180s; CPU: 14.0%; Read bytes: 266240; Write bytes: 236826624; Read time: 304; Write time: 894872 04:44:04 INFO - Running post-run listener: _upload_blobber_files 04:44:04 INFO - Blob upload gear active. 04:44:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:44:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:44:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:44:05 INFO - (blobuploader) - INFO - Open directory for files ... 04:44:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:44:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:44:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:12 INFO - (blobuploader) - INFO - Done attempting. 04:44:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:44:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:44:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:13 INFO - (blobuploader) - INFO - Done attempting. 04:44:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:44:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:44:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:14 INFO - (blobuploader) - INFO - Done attempting. 04:44:14 INFO - (blobuploader) - INFO - Iteration through files over. 04:44:14 INFO - Return code: 0 04:44:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:44:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:44:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6a556023a5f33c8c2f291c53d8f39e46633cf366889440256ccfbd03260e59c18e06c3695e540219fb5955357b1acd2af3fa8d54f3ab8ac3e414ab13fe62aa5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/326014bafc0e171597062262729be433a246e02f85d32a0e0260211af2f487593a886ff5b093640e003b2496716d001080aac46705d52ac6169f0b80516c2bae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c11e42087a3395de086f34cfcca11498aca45c9adcd171cf7ccaeb9e3b8690d5228073382b0e35506309cdfc9e6ffcc5bb77e74d0e12ace7f2864d67ef9f79d9"} 04:44:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:44:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:44:14 INFO - Contents: 04:44:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6a556023a5f33c8c2f291c53d8f39e46633cf366889440256ccfbd03260e59c18e06c3695e540219fb5955357b1acd2af3fa8d54f3ab8ac3e414ab13fe62aa5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/326014bafc0e171597062262729be433a246e02f85d32a0e0260211af2f487593a886ff5b093640e003b2496716d001080aac46705d52ac6169f0b80516c2bae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c11e42087a3395de086f34cfcca11498aca45c9adcd171cf7ccaeb9e3b8690d5228073382b0e35506309cdfc9e6ffcc5bb77e74d0e12ace7f2864d67ef9f79d9"} 04:44:14 INFO - Running post-run listener: copy_logs_to_upload_dir 04:44:14 INFO - Copying logs to upload dir... 04:44:14 INFO - mkdir: /builds/slave/test/build/upload/logs 04:44:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.549667 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-27 04:44:14.191902) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:44:14.195324) ========= 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=33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6a556023a5f33c8c2f291c53d8f39e46633cf366889440256ccfbd03260e59c18e06c3695e540219fb5955357b1acd2af3fa8d54f3ab8ac3e414ab13fe62aa5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/326014bafc0e171597062262729be433a246e02f85d32a0e0260211af2f487593a886ff5b093640e003b2496716d001080aac46705d52ac6169f0b80516c2bae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c11e42087a3395de086f34cfcca11498aca45c9adcd171cf7ccaeb9e3b8690d5228073382b0e35506309cdfc9e6ffcc5bb77e74d0e12ace7f2864d67ef9f79d9"} build_url:https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6a556023a5f33c8c2f291c53d8f39e46633cf366889440256ccfbd03260e59c18e06c3695e540219fb5955357b1acd2af3fa8d54f3ab8ac3e414ab13fe62aa5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/326014bafc0e171597062262729be433a246e02f85d32a0e0260211af2f487593a886ff5b093640e003b2496716d001080aac46705d52ac6169f0b80516c2bae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c11e42087a3395de086f34cfcca11498aca45c9adcd171cf7ccaeb9e3b8690d5228073382b0e35506309cdfc9e6ffcc5bb77e74d0e12ace7f2864d67ef9f79d9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:44:14.224151) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:44:14.224469) ========= 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=33d5923976266a1c518c4bf7000001ab-1469618598.424555-1369134454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:44:14.309287) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:44:14.309986) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:44:14.310640) ========= ========= Total master_lag: 0.20 =========