builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1466442219.13 results: success (0) buildid: 20160620073144 builduid: fdb69f75815a4a1abb7f6bdaf185ed75 revision: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 10:03:39.129742) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 10:03:39.130802) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 10:03:39.131546) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 10:03:39.148186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 10:03:39.148501) ========= 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=745a4373a2a16df560f216e000000264-1466441849.842299-1066716371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-20 10:03:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.3M=0s 2016-06-20 10:03:39 (67.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089171 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 10:03:39.256850) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 10:03:39.257167) ========= 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=745a4373a2a16df560f216e000000264-1466441849.842299-1066716371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019367 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 10:03:39.310705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 10:03:39.311109) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3c5025f98e561a20e24d97c91a9e4e0ec28015ea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3c5025f98e561a20e24d97c91a9e4e0ec28015ea --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=745a4373a2a16df560f216e000000264-1466441849.842299-1066716371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-20 10:03:39,404 truncating revision to first 12 chars 2016-06-20 10:03:39,404 Setting DEBUG logging. 2016-06-20 10:03:39,405 attempt 1/10 2016-06-20 10:03:39,405 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3c5025f98e56?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 10:03:39,717 unpacking tar archive at: mozilla-central-3c5025f98e56/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643598 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 10:03:39.970441) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 10:03:39.970992) ========= script_repo_revision: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 10:03:39.971669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 10:03:39.972197) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 10:03:39.991977) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-20 10:03:39.992670) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1466441849.842299-1066716371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:03:40 INFO - MultiFileLogger online at 20160620 10:03:40 in /builds/slave/test 10:03:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:03:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:03:40 INFO - {'append_to_log': False, 10:03:40 INFO - 'base_work_dir': '/builds/slave/test', 10:03:40 INFO - 'blob_upload_branch': 'Firefox', 10:03:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:03:40 INFO - 'branch': 'Firefox', 10:03:40 INFO - 'buildbot_json_path': 'buildprops.json', 10:03:40 INFO - 'config_files': ('talos/linux_config.py',), 10:03:40 INFO - 'default_actions': ('clobber', 10:03:40 INFO - 'read-buildbot-config', 10:03:40 INFO - 'download-and-extract', 10:03:40 INFO - 'populate-webroot', 10:03:40 INFO - 'create-virtualenv', 10:03:40 INFO - 'install', 10:03:40 INFO - 'run-tests'), 10:03:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:03:40 INFO - 'download_minidump_stackwalk': True, 10:03:40 INFO - 'download_symbols': 'ondemand', 10:03:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:03:40 INFO - 'tooltool.py': '/tools/tooltool.py', 10:03:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:03:40 INFO - '/tools/misc-python/virtualenv.py')}, 10:03:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:03:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:03:40 INFO - 'installer_path': 'installer.exe', 10:03:40 INFO - 'log_level': 'info', 10:03:40 INFO - 'log_name': 'talos', 10:03:40 INFO - 'log_to_console': True, 10:03:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:03:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:03:40 INFO - 'opt_config_files': (), 10:03:40 INFO - 'pip_index': False, 10:03:40 INFO - 'sps_profile': False, 10:03:40 INFO - 'sps_profile_interval': 0, 10:03:40 INFO - 'suite': 'dromaeojs', 10:03:40 INFO - 'system_bits': '32', 10:03:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:03:40 INFO - 'title': 'talos-linux64-ix-032', 10:03:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:03:40 INFO - 'use_talos_json': True, 10:03:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:03:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:03:40 INFO - 'work_dir': 'build'} 10:03:40 INFO - ##### 10:03:40 INFO - ##### Running clobber step. 10:03:40 INFO - ##### 10:03:40 INFO - Running pre-action listener: _resource_record_pre_action 10:03:40 INFO - Running main action method: clobber 10:03:40 INFO - rmtree: /builds/slave/test/build 10:03:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:03:40 INFO - Running post-action listener: _resource_record_post_action 10:03:40 INFO - ##### 10:03:40 INFO - ##### Finished clobber step (success) 10:03:40 INFO - ##### 10:03:40 INFO - ##### 10:03:40 INFO - ##### Running read-buildbot-config step. 10:03:40 INFO - ##### 10:03:40 INFO - Running pre-action listener: _resource_record_pre_action 10:03:40 INFO - Running main action method: read_buildbot_config 10:03:40 INFO - Using buildbot properties: 10:03:40 INFO - { 10:03:40 INFO - "project": "", 10:03:40 INFO - "product": "firefox", 10:03:40 INFO - "script_repo_revision": "production", 10:03:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:03:40 INFO - "repository": "", 10:03:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:03:40 INFO - "buildid": "20160620073144", 10:03:40 INFO - "pgo_build": "True", 10:03:40 INFO - "basedir": "/builds/slave/test", 10:03:40 INFO - "buildnumber": 787, 10:03:40 INFO - "slavename": "talos-linux64-ix-032", 10:03:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:03:40 INFO - "platform": "ubuntu64_hw", 10:03:40 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:03:40 INFO - "branch": "mozilla-central", 10:03:40 INFO - "repo_path": "mozilla-central", 10:03:40 INFO - "revision": "3c5025f98e561a20e24d97c91a9e4e0ec28015ea", 10:03:40 INFO - "stage_platform": "linux64-pgo", 10:03:40 INFO - "builduid": "fdb69f75815a4a1abb7f6bdaf185ed75", 10:03:40 INFO - "slavebuilddir": "test" 10:03:40 INFO - } 10:03:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:03:40 INFO - Running post-action listener: _resource_record_post_action 10:03:40 INFO - ##### 10:03:40 INFO - ##### Finished read-buildbot-config step (success) 10:03:40 INFO - ##### 10:03:40 INFO - ##### 10:03:40 INFO - ##### Running download-and-extract step. 10:03:40 INFO - ##### 10:03:40 INFO - Running pre-action listener: _resource_record_pre_action 10:03:40 INFO - Running main action method: download_and_extract 10:03:40 INFO - mkdir: /builds/slave/test/build/tests 10:03: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')]} 10:03:40 INFO - https://queue.taskcluster.net/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:03:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:03:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:03:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:03:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:03:44 INFO - Downloaded 1361 bytes. 10:03:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:03:44 INFO - Using the following test package requirements: 10:03:44 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:03:44 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:03:44 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:03:44 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:44 INFO - u'jsshell-linux-x86_64.zip'], 10:03:44 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:03:44 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:03:44 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:03:44 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:03:44 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:03:44 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:03:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:03:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:44 INFO - https://queue.taskcluster.net/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:03:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:03:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:03:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:03:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:03:49 INFO - Downloaded 24221165 bytes. 10:03:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:03:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:03:50 INFO - Return code: 0 10:03:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:03:50 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')]} 10:03:50 INFO - https://queue.taskcluster.net/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:03:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:03:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:03:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:03:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:03:51 INFO - Downloaded 24221165 bytes. 10:03:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:03:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:03:53 INFO - Return code: 0 10:03: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')]} 10:03:53 INFO - https://queue.taskcluster.net/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:03:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:03:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:03:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:03:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:03:54 INFO - Downloaded 14405384 bytes. 10:03:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:03:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:03:54 INFO - Return code: 0 10:03: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')]} 10:03:54 INFO - https://queue.taskcluster.net/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:03:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:03:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:03:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:03:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:03:56 INFO - Downloaded 60125831 bytes. 10:03:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:03:56 INFO - mkdir: /builds/slave/test/properties 10:03:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:03:56 INFO - Writing to file /builds/slave/test/properties/build_url 10:03:56 INFO - Contents: 10:03:56 INFO - build_url:https://queue.taskcluster.net/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:03:57 INFO - Running post-action listener: _resource_record_post_action 10:03:57 INFO - Running post-action listener: set_extra_try_arguments 10:03:57 INFO - ##### 10:03:57 INFO - ##### Finished download-and-extract step (success) 10:03:57 INFO - ##### 10:03:57 INFO - ##### 10:03:57 INFO - ##### Running populate-webroot step. 10:03:57 INFO - ##### 10:03:57 INFO - Running pre-action listener: _resource_record_pre_action 10:03:57 INFO - Running main action method: populate_webroot 10:03:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:03:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:03:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:03:57 INFO - '--tppagecycles', 10:03:57 INFO - '7'], 10:03:57 INFO - 'tests': ['tsvgm']}}, 10:03:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:03:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:03:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:03:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:03:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:03:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:03:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:57 INFO - 'talos_options': ['--disable-e10s'], 10:03:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:57 INFO - 'talos_options': ['--disable-e10s'], 10:03:57 INFO - 'tests': ['damp', 'tps']}, 10:03:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:57 INFO - 'tests': ['damp', 'tps']}, 10:03:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:03:57 INFO - 'tests': ['dromaeo_dom']}, 10:03:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:03:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:03:57 INFO - 'tests': ['basic_compositor_video']}, 10:03:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:03:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:03:57 INFO - 'tests': ['a11yr', 10:03:57 INFO - 'ts_paint', 10:03:57 INFO - 'tpaint', 10:03:57 INFO - 'sessionrestore', 10:03:57 INFO - 'sessionrestore_no_auto_restore', 10:03:57 INFO - 'tabpaint']}, 10:03:57 INFO - 'other-e10s': {'tests': ['a11yr', 10:03:57 INFO - 'ts_paint', 10:03:57 INFO - 'tpaint', 10:03:57 INFO - 'sessionrestore', 10:03:57 INFO - 'sessionrestore_no_auto_restore', 10:03:57 INFO - 'tabpaint']}, 10:03:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:03:57 INFO - 'ts_paint', 10:03:57 INFO - 'tpaint', 10:03:57 INFO - 'sessionrestore', 10:03:57 INFO - 'sessionrestore_no_auto_restore', 10:03:57 INFO - 'tabpaint']}, 10:03:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:03:57 INFO - 'ts_paint', 10:03:57 INFO - 'tpaint', 10:03:57 INFO - 'sessionrestore', 10:03:57 INFO - 'sessionrestore_no_auto_restore', 10:03:57 INFO - 'tabpaint']}, 10:03:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:03:57 INFO - 'tests': ['a11yr', 10:03:57 INFO - 'ts_paint', 10:03:57 INFO - 'tpaint', 10:03:57 INFO - 'sessionrestore', 10:03:57 INFO - 'sessionrestore_no_auto_restore', 10:03:57 INFO - 'tabpaint']}, 10:03:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:03:57 INFO - 'tests': ['a11yr', 10:03:57 INFO - 'ts_paint', 10:03:57 INFO - 'tpaint', 10:03:57 INFO - 'sessionrestore', 10:03:57 INFO - 'sessionrestore_no_auto_restore', 10:03:57 INFO - 'tabpaint']}, 10:03:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:03:57 INFO - 'tests': ['tsvgx', 10:03:57 INFO - 'tsvgr_opacity', 10:03:57 INFO - 'tart', 10:03:57 INFO - 'tscrollx', 10:03:57 INFO - 'cart']}, 10:03:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:03:57 INFO - 'tsvgr_opacity', 10:03:57 INFO - 'tart', 10:03:57 INFO - 'tscrollx', 10:03:57 INFO - 'cart']}, 10:03:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:57 INFO - 'talos_options': ['--disable-e10s'], 10:03:57 INFO - 'tests': ['tp5o']}, 10:03:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:57 INFO - 'tests': ['tp5o']}, 10:03:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:57 INFO - 'talos_options': ['--disable-e10s', 10:03:57 INFO - '--xperf_path', 10:03:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:57 INFO - 'tests': ['tp5n']}, 10:03:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:57 INFO - 'talos_options': ['--xperf_path', 10:03:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:57 INFO - 'tests': ['tp5n']}}, 10:03:57 INFO - 'talos.zip': {'path': '', 10:03:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:03:57 INFO - Running post-action listener: _resource_record_post_action 10:03:57 INFO - ##### 10:03:57 INFO - ##### Finished populate-webroot step (success) 10:03:57 INFO - ##### 10:03:57 INFO - ##### 10:03:57 INFO - ##### Running create-virtualenv step. 10:03:57 INFO - ##### 10:03:57 INFO - Running pre-action listener: _resource_record_pre_action 10:03:57 INFO - Running main action method: create_virtualenv 10:03:57 INFO - Creating virtualenv /builds/slave/test/build/venv 10:03:57 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 10:03:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:03:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:03:57 INFO - Using real prefix '/usr' 10:03:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:03:58 INFO - Installing distribute.............................................................................................................................................................................................done. 10:04:00 INFO - Installing pip.................done. 10:04:00 INFO - Return code: 0 10:04:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:00 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 0x7fd29061ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2270350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff1c0>, '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 0x23000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300550>, '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': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', '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 10:04:00 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 10:04:00 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 10:04:00 INFO - Using env: {'DISPLAY': ':0', 10:04:00 INFO - 'HOME': '/home/cltbld', 10:04:00 INFO - 'LANG': 'en_US.UTF-8', 10:04:00 INFO - 'LANGUAGE': 'en_US:en', 10:04:00 INFO - 'LOGNAME': 'cltbld', 10:04:00 INFO - 'MAIL': '/var/mail/cltbld', 10:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:00 INFO - 'MOZ_NO_REMOTE': '1', 10:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:00 INFO - 'NO_EM_RESTART': '1', 10:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:00 INFO - 'PWD': '/builds/slave/test', 10:04:00 INFO - 'SHELL': '/bin/bash', 10:04:00 INFO - 'SHLVL': '1', 10:04:00 INFO - 'TERM': 'linux', 10:04:00 INFO - 'TMOUT': '86400', 10:04:00 INFO - 'USER': 'cltbld', 10:04:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', 10:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:00 INFO - '_': '/tools/buildbot/bin/python'} 10:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:00 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 10:04:00 INFO - Cleaning up... 10:04:00 INFO - Return code: 0 10:04:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:00 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 0x7fd29061ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2270350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff1c0>, '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 0x23000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300550>, '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': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', '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 10:04:00 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 10:04:00 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 10:04:00 INFO - Using env: {'DISPLAY': ':0', 10:04:00 INFO - 'HOME': '/home/cltbld', 10:04:00 INFO - 'LANG': 'en_US.UTF-8', 10:04:00 INFO - 'LANGUAGE': 'en_US:en', 10:04:00 INFO - 'LOGNAME': 'cltbld', 10:04:00 INFO - 'MAIL': '/var/mail/cltbld', 10:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:00 INFO - 'MOZ_NO_REMOTE': '1', 10:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:00 INFO - 'NO_EM_RESTART': '1', 10:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:00 INFO - 'PWD': '/builds/slave/test', 10:04:00 INFO - 'SHELL': '/bin/bash', 10:04:00 INFO - 'SHLVL': '1', 10:04:00 INFO - 'TERM': 'linux', 10:04:00 INFO - 'TMOUT': '86400', 10:04:00 INFO - 'USER': 'cltbld', 10:04:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', 10:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:00 INFO - '_': '/tools/buildbot/bin/python'} 10:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:00 INFO - Downloading/unpacking psutil>=3.1.1 10:04:00 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 10:04:00 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 10:04:00 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 10:04:00 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 10:04:00 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 10:04:00 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 10:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:04:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:02 INFO - Installing collected packages: psutil 10:04:02 INFO - Running setup.py install for psutil 10:04:02 INFO - building 'psutil._psutil_linux' extension 10:04:02 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 10:04:02 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 10:04:02 INFO - building 'psutil._psutil_posix' extension 10:04:02 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 10:04:02 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 10:04:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:03 INFO - Successfully installed psutil 10:04:03 INFO - Cleaning up... 10:04:03 INFO - Return code: 0 10:04:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd29061ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2270350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff1c0>, '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 0x23000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300550>, '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': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', '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 10:04:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:04:03 INFO - Using env: {'DISPLAY': ':0', 10:04:03 INFO - 'HOME': '/home/cltbld', 10:04:03 INFO - 'LANG': 'en_US.UTF-8', 10:04:03 INFO - 'LANGUAGE': 'en_US:en', 10:04:03 INFO - 'LOGNAME': 'cltbld', 10:04:03 INFO - 'MAIL': '/var/mail/cltbld', 10:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:03 INFO - 'MOZ_NO_REMOTE': '1', 10:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:03 INFO - 'NO_EM_RESTART': '1', 10:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:03 INFO - 'PWD': '/builds/slave/test', 10:04:03 INFO - 'SHELL': '/bin/bash', 10:04:03 INFO - 'SHLVL': '1', 10:04:03 INFO - 'TERM': 'linux', 10:04:03 INFO - 'TMOUT': '86400', 10:04:03 INFO - 'USER': 'cltbld', 10:04:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', 10:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:03 INFO - '_': '/tools/buildbot/bin/python'} 10:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:04:05 INFO - Installing collected packages: mozsystemmonitor 10:04:05 INFO - Running setup.py install for mozsystemmonitor 10:04:05 INFO - Successfully installed mozsystemmonitor 10:04:05 INFO - Cleaning up... 10:04:05 INFO - Return code: 0 10:04:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:04:05 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')]} 10:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:05 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')]} 10:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:05 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 0x7fd29061ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2270350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff1c0>, '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 0x23000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300550>, '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': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', '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 10:04:05 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 10:04:05 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 10:04:05 INFO - Using env: {'DISPLAY': ':0', 10:04:05 INFO - 'HOME': '/home/cltbld', 10:04:05 INFO - 'LANG': 'en_US.UTF-8', 10:04:05 INFO - 'LANGUAGE': 'en_US:en', 10:04:05 INFO - 'LOGNAME': 'cltbld', 10:04:05 INFO - 'MAIL': '/var/mail/cltbld', 10:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:05 INFO - 'MOZ_NO_REMOTE': '1', 10:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:05 INFO - 'NO_EM_RESTART': '1', 10:04:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:05 INFO - 'PWD': '/builds/slave/test', 10:04:05 INFO - 'SHELL': '/bin/bash', 10:04:05 INFO - 'SHLVL': '1', 10:04:05 INFO - 'TERM': 'linux', 10:04:05 INFO - 'TMOUT': '86400', 10:04:05 INFO - 'USER': 'cltbld', 10:04:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', 10:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:05 INFO - '_': '/tools/buildbot/bin/python'} 10:04:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:05 INFO - Downloading/unpacking jsonschema==2.5.1 10:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:04:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:07 INFO - Downloading functools32-3.2.3-2.tar.gz 10:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:04:07 INFO - warning: no files found matching '*.txt' 10:04:07 INFO - no previously-included directories found matching 'build' 10:04:07 INFO - no previously-included directories found matching 'dist' 10:04:07 INFO - no previously-included directories found matching '.git*' 10:04:07 INFO - Installing collected packages: jsonschema, functools32 10:04:07 INFO - Running setup.py install for functools32 10:04:07 INFO - warning: no files found matching '*.txt' 10:04:07 INFO - no previously-included directories found matching 'build' 10:04:07 INFO - no previously-included directories found matching 'dist' 10:04:07 INFO - no previously-included directories found matching '.git*' 10:04:07 INFO - Successfully installed jsonschema functools32 10:04:07 INFO - Cleaning up... 10:04:07 INFO - Return code: 0 10:04:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd29061ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2270350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff1c0>, '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 0x23000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300550>, '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': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', '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 10:04:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:04:07 INFO - Using env: {'DISPLAY': ':0', 10:04:07 INFO - 'HOME': '/home/cltbld', 10:04:07 INFO - 'LANG': 'en_US.UTF-8', 10:04:07 INFO - 'LANGUAGE': 'en_US:en', 10:04:07 INFO - 'LOGNAME': 'cltbld', 10:04:07 INFO - 'MAIL': '/var/mail/cltbld', 10:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:07 INFO - 'MOZ_NO_REMOTE': '1', 10:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:07 INFO - 'NO_EM_RESTART': '1', 10:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:07 INFO - 'PWD': '/builds/slave/test', 10:04:07 INFO - 'SHELL': '/bin/bash', 10:04:07 INFO - 'SHLVL': '1', 10:04:07 INFO - 'TERM': 'linux', 10:04:07 INFO - 'TMOUT': '86400', 10:04:07 INFO - 'USER': 'cltbld', 10:04:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', 10:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:07 INFO - '_': '/tools/buildbot/bin/python'} 10:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:08 INFO - Downloading/unpacking blobuploader==1.2.4 10:04:08 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 10:04:08 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 10:04:08 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 10:04:08 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 10:04:08 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 10:04:08 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 10:04:10 INFO - Downloading blobuploader-1.2.4.tar.gz 10:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:04:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:04:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:10 INFO - Downloading docopt-0.6.1.tar.gz 10:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:04:10 INFO - Installing collected packages: blobuploader, requests, docopt 10:04:10 INFO - Running setup.py install for blobuploader 10:04:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:04:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:04:10 INFO - Running setup.py install for requests 10:04:11 INFO - Running setup.py install for docopt 10:04:11 INFO - Successfully installed blobuploader requests docopt 10:04:11 INFO - Cleaning up... 10:04:11 INFO - Return code: 0 10:04:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:11 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 0x7fd29061ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2270350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff1c0>, '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 0x23000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300550>, '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': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', '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 10:04:11 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 10:04:11 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 10:04:11 INFO - Using env: {'DISPLAY': ':0', 10:04:11 INFO - 'HOME': '/home/cltbld', 10:04:11 INFO - 'LANG': 'en_US.UTF-8', 10:04:11 INFO - 'LANGUAGE': 'en_US:en', 10:04:11 INFO - 'LOGNAME': 'cltbld', 10:04:11 INFO - 'MAIL': '/var/mail/cltbld', 10:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:11 INFO - 'MOZ_NO_REMOTE': '1', 10:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:11 INFO - 'NO_EM_RESTART': '1', 10:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:11 INFO - 'PWD': '/builds/slave/test', 10:04:11 INFO - 'SHELL': '/bin/bash', 10:04:11 INFO - 'SHLVL': '1', 10:04:11 INFO - 'TERM': 'linux', 10:04:11 INFO - 'TMOUT': '86400', 10:04:11 INFO - 'USER': 'cltbld', 10:04:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', 10:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:11 INFO - '_': '/tools/buildbot/bin/python'} 10:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:11 INFO - Running setup.py (path:/tmp/pip-lK8hIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:11 INFO - Running setup.py (path:/tmp/pip-JHhy64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:11 INFO - Running setup.py (path:/tmp/pip-VeMYNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:11 INFO - Running setup.py (path:/tmp/pip-SyJjNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:11 INFO - Running setup.py (path:/tmp/pip-584Beb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:12 INFO - Running setup.py (path:/tmp/pip-08u6uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:12 INFO - Running setup.py (path:/tmp/pip-Vha98O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:12 INFO - Running setup.py (path:/tmp/pip-o9ePg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:12 INFO - Running setup.py (path:/tmp/pip-dZQ85b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:12 INFO - Running setup.py (path:/tmp/pip-8ctBoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:12 INFO - Running setup.py (path:/tmp/pip-WOh3CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:12 INFO - Running setup.py (path:/tmp/pip-lLMOhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:04:12 INFO - Running setup.py (path:/tmp/pip-iqjeFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:04:12 INFO - Running setup.py (path:/tmp/pip-hoqMbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:12 INFO - Running setup.py (path:/tmp/pip-C91_hE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:12 INFO - Running setup.py (path:/tmp/pip-ujB_g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:12 INFO - Running setup.py (path:/tmp/pip-3mNF7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:04:12 INFO - Running setup.py install for manifestparser 10:04:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:04:13 INFO - Running setup.py install for mozcrash 10:04:13 INFO - Running setup.py install for mozdebug 10:04:13 INFO - Running setup.py install for mozdevice 10:04:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:04:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:04:13 INFO - Running setup.py install for mozfile 10:04:13 INFO - Running setup.py install for mozhttpd 10:04:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:04:13 INFO - Running setup.py install for mozinfo 10:04:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:04:13 INFO - Running setup.py install for mozInstall 10:04:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:04:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:04:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:04:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:04:13 INFO - Running setup.py install for mozleak 10:04:13 INFO - Running setup.py install for mozlog 10:04:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:04:13 INFO - Running setup.py install for moznetwork 10:04:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:04:14 INFO - Running setup.py install for mozprocess 10:04:14 INFO - Running setup.py install for mozprofile 10:04:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:04:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:04:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:04:14 INFO - Running setup.py install for mozrunner 10:04:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:04:14 INFO - Running setup.py install for mozscreenshot 10:04:14 INFO - Running setup.py install for moztest 10:04:14 INFO - Running setup.py install for mozversion 10:04:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:04:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:04:14 INFO - Cleaning up... 10:04:14 INFO - Return code: 0 10:04:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:14 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 0x7fd29061ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2270350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff1c0>, '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 0x23000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300550>, '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': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', '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 10:04:14 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 10:04:14 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 10:04:14 INFO - Using env: {'DISPLAY': ':0', 10:04:14 INFO - 'HOME': '/home/cltbld', 10:04:14 INFO - 'LANG': 'en_US.UTF-8', 10:04:14 INFO - 'LANGUAGE': 'en_US:en', 10:04:14 INFO - 'LOGNAME': 'cltbld', 10:04:14 INFO - 'MAIL': '/var/mail/cltbld', 10:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:14 INFO - 'MOZ_NO_REMOTE': '1', 10:04:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:14 INFO - 'NO_EM_RESTART': '1', 10:04:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:14 INFO - 'PWD': '/builds/slave/test', 10:04:14 INFO - 'SHELL': '/bin/bash', 10:04:14 INFO - 'SHLVL': '1', 10:04:14 INFO - 'TERM': 'linux', 10:04:14 INFO - 'TMOUT': '86400', 10:04:14 INFO - 'USER': 'cltbld', 10:04:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', 10:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:14 INFO - '_': '/tools/buildbot/bin/python'} 10:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:14 INFO - Running setup.py (path:/tmp/pip-kzO9Mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:14 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)) 10:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:14 INFO - Running setup.py (path:/tmp/pip-Led_Pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:15 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)) 10:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:15 INFO - Running setup.py (path:/tmp/pip-l_bRGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:15 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)) 10:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:15 INFO - Running setup.py (path:/tmp/pip-mUqn47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:15 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)) 10:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:15 INFO - Running setup.py (path:/tmp/pip-ORuQu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:15 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)) 10:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:15 INFO - Running setup.py (path:/tmp/pip-TPpgn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:15 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)) 10:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:15 INFO - Running setup.py (path:/tmp/pip-AbIrkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:15 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)) 10:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:15 INFO - Running setup.py (path:/tmp/pip-VM1x6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:15 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)) 10:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:15 INFO - Running setup.py (path:/tmp/pip-d_1z8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:15 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)) 10:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:15 INFO - Running setup.py (path:/tmp/pip-j4f8nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:15 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)) 10:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:15 INFO - Running setup.py (path:/tmp/pip-NUzPvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:15 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)) 10:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:15 INFO - Running setup.py (path:/tmp/pip-Aw4e_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:04:15 INFO - Running setup.py (path:/tmp/pip-MtERGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:04:15 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)) 10:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:04:15 INFO - Running setup.py (path:/tmp/pip-9rqAaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:15 INFO - Running setup.py (path:/tmp/pip-MyoRjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:15 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)) 10:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:15 INFO - Running setup.py (path:/tmp/pip-vMr75W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:16 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)) 10:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:16 INFO - Running setup.py (path:/tmp/pip-THUgDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:16 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)) 10:04:16 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)) 10:04:16 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)) 10:04:16 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)) 10:04:16 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)) 10:04:16 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)) 10:04:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:18 INFO - Downloading blessings-1.6.tar.gz 10:04:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:04:18 INFO - Installing collected packages: blessings 10:04:18 INFO - Running setup.py install for blessings 10:04:18 INFO - Successfully installed blessings 10:04:18 INFO - Cleaning up... 10:04:18 INFO - Return code: 0 10:04:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:04:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:04:18 INFO - Reading from file tmpfile_stdout 10:04:18 INFO - Current package versions: 10:04:18 INFO - argparse == 1.2.1 10:04:18 INFO - blessings == 1.6 10:04:18 INFO - blobuploader == 1.2.4 10:04:18 INFO - docopt == 0.6.1 10:04:18 INFO - functools32 == 3.2.3-2 10:04:18 INFO - jsonschema == 2.5.1 10:04:18 INFO - manifestparser == 1.1 10:04:18 INFO - mozInstall == 1.12 10:04:18 INFO - mozcrash == 0.17 10:04:18 INFO - mozdebug == 0.1 10:04:18 INFO - mozdevice == 0.48 10:04:18 INFO - mozfile == 1.2 10:04:18 INFO - mozhttpd == 0.7 10:04:18 INFO - mozinfo == 0.9 10:04:18 INFO - mozleak == 0.1 10:04:18 INFO - mozlog == 3.2 10:04:18 INFO - moznetwork == 0.27 10:04:18 INFO - mozprocess == 0.22 10:04:18 INFO - mozprofile == 0.28 10:04:18 INFO - mozrunner == 6.11 10:04:18 INFO - mozscreenshot == 0.1 10:04:18 INFO - mozsystemmonitor == 0.3 10:04:18 INFO - moztest == 0.7 10:04:18 INFO - mozversion == 1.4 10:04:18 INFO - psutil == 3.1.1 10:04:18 INFO - requests == 1.2.3 10:04:18 INFO - wsgiref == 0.1.2 10:04:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:18 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 0x7fd29061ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2270350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff1c0>, '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 0x23000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300550>, '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': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', '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 10:04:18 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 10:04:18 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 10:04:18 INFO - Using env: {'DISPLAY': ':0', 10:04:18 INFO - 'HOME': '/home/cltbld', 10:04:18 INFO - 'LANG': 'en_US.UTF-8', 10:04:18 INFO - 'LANGUAGE': 'en_US:en', 10:04:18 INFO - 'LOGNAME': 'cltbld', 10:04:18 INFO - 'MAIL': '/var/mail/cltbld', 10:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:18 INFO - 'MOZ_NO_REMOTE': '1', 10:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:18 INFO - 'NO_EM_RESTART': '1', 10:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:18 INFO - 'PWD': '/builds/slave/test', 10:04:18 INFO - 'SHELL': '/bin/bash', 10:04:18 INFO - 'SHLVL': '1', 10:04:18 INFO - 'TERM': 'linux', 10:04:18 INFO - 'TMOUT': '86400', 10:04:18 INFO - 'USER': 'cltbld', 10:04:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', 10:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:18 INFO - '_': '/tools/buildbot/bin/python'} 10:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:18 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)) 10:04:18 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)) 10:04:18 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)) 10:04:18 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)) 10:04:18 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)) 10:04:18 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)) 10:04:18 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)) 10:04:18 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)) 10:04:18 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)) 10:04:18 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)) 10:04:18 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)) 10:04:18 INFO - Cleaning up... 10:04:18 INFO - Return code: 0 10:04:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:18 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 0x7fd29061ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2270350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff1c0>, '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 0x23000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300550>, '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': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', '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 10:04:18 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 10:04:18 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 10:04:18 INFO - Using env: {'DISPLAY': ':0', 10:04:18 INFO - 'HOME': '/home/cltbld', 10:04:18 INFO - 'LANG': 'en_US.UTF-8', 10:04:18 INFO - 'LANGUAGE': 'en_US:en', 10:04:18 INFO - 'LOGNAME': 'cltbld', 10:04:18 INFO - 'MAIL': '/var/mail/cltbld', 10:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:18 INFO - 'MOZ_NO_REMOTE': '1', 10:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:18 INFO - 'NO_EM_RESTART': '1', 10:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:18 INFO - 'PWD': '/builds/slave/test', 10:04:18 INFO - 'SHELL': '/bin/bash', 10:04:18 INFO - 'SHLVL': '1', 10:04:18 INFO - 'TERM': 'linux', 10:04:18 INFO - 'TMOUT': '86400', 10:04:18 INFO - 'USER': 'cltbld', 10:04:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', 10:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:18 INFO - '_': '/tools/buildbot/bin/python'} 10:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:04:18 INFO - Cleaning up... 10:04:18 INFO - Return code: 0 10:04:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:18 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 0x7fd29061ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2270350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ff1c0>, '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 0x23000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300550>, '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': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', '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 10:04:18 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 10:04:18 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 10:04:18 INFO - Using env: {'DISPLAY': ':0', 10:04:18 INFO - 'HOME': '/home/cltbld', 10:04:18 INFO - 'LANG': 'en_US.UTF-8', 10:04:18 INFO - 'LANGUAGE': 'en_US:en', 10:04:18 INFO - 'LOGNAME': 'cltbld', 10:04:18 INFO - 'MAIL': '/var/mail/cltbld', 10:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:18 INFO - 'MOZ_NO_REMOTE': '1', 10:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:18 INFO - 'NO_EM_RESTART': '1', 10:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:18 INFO - 'PWD': '/builds/slave/test', 10:04:18 INFO - 'SHELL': '/bin/bash', 10:04:18 INFO - 'SHLVL': '1', 10:04:18 INFO - 'TERM': 'linux', 10:04:18 INFO - 'TMOUT': '86400', 10:04:18 INFO - 'USER': 'cltbld', 10:04:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', 10:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:18 INFO - '_': '/tools/buildbot/bin/python'} 10:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:19 INFO - Downloading/unpacking flake8 10:04:19 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 10:04:19 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 10:04:19 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 10:04:19 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 10:04:19 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 10:04:19 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 10:04:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:04:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:04:21 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 10:04:21 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 10:04:21 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 10:04:21 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 10:04:21 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 10:04:21 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 10:04:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:04:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:04:21 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 10:04:21 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 10:04:21 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 10:04:21 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 10:04:21 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 10:04:21 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 10:04:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:04:21 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 10:04:21 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 10:04:21 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 10:04:21 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 10:04:21 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 10:04:21 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 10:04:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:04:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:04:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:04:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:04:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:04:21 INFO - no previously-included directories found matching 'docs/_build' 10:04:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:04:21 INFO - Running setup.py install for pep8 10:04:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:04:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:04:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:04:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:04:21 INFO - no previously-included directories found matching 'docs/_build' 10:04:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:04:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:04:21 INFO - Cleaning up... 10:04:22 INFO - Return code: 0 10:04:22 INFO - Running post-action listener: _resource_record_post_action 10:04:22 INFO - Running post-action listener: _start_resource_monitoring 10:04:22 INFO - Starting resource monitoring. 10:04:22 INFO - ##### 10:04:22 INFO - ##### Finished create-virtualenv step (success) 10:04:22 INFO - ##### 10:04:22 INFO - ##### 10:04:22 INFO - ##### Running install step. 10:04:22 INFO - ##### 10:04:22 INFO - Running pre-action listener: _resource_record_pre_action 10:04:22 INFO - Running main action method: install 10:04:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:04:22 INFO - Reading from file tmpfile_stdout 10:04:22 INFO - Detecting whether we're running mozinstall >=1.0... 10:04:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:04:22 INFO - Reading from file tmpfile_stdout 10:04:22 INFO - Output received: 10:04:22 INFO - Usage: mozinstall [options] installer 10:04:22 INFO - Options: 10:04:22 INFO - -h, --help show this help message and exit 10:04:22 INFO - -d DEST, --destination=DEST 10:04:22 INFO - Directory to install application into. [default: 10:04:22 INFO - "/builds/slave/test"] 10:04:22 INFO - --app=APP Application being installed. [default: firefox] 10:04:22 INFO - mkdir: /builds/slave/test/build/application 10:04:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:04:39 INFO - Reading from file tmpfile_stdout 10:04:39 INFO - Output received: 10:04:39 INFO - /builds/slave/test/build/application/firefox/firefox 10:04:39 INFO - Running post-action listener: _resource_record_post_action 10:04:39 INFO - ##### 10:04:39 INFO - ##### Finished install step (success) 10:04:39 INFO - ##### 10:04:39 INFO - ##### 10:04:39 INFO - ##### Running run-tests step. 10:04:39 INFO - ##### 10:04:39 INFO - Running pre-action listener: _resource_record_pre_action 10:04:39 INFO - Running main action method: run_tests 10:04:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:04:39 INFO - Python 2.7.3 10:04:39 INFO - Return code: 0 10:04:39 INFO - grabbing minidump binary from tooltool 10:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:39 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 0x22ff1c0>, '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 0x23000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2300550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:04:39 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 10:04:39 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 10:04:39 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 10:04:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:04:39 INFO - Return code: 0 10:04:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:04:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:04:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:04:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:04:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:04:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:04:40 INFO - Return code: 0 10:04:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:04:40 INFO - Using env: {'DISPLAY': ':0', 10:04:40 INFO - 'HOME': '/home/cltbld', 10:04:40 INFO - 'LANG': 'en_US.UTF-8', 10:04:40 INFO - 'LANGUAGE': 'en_US:en', 10:04:40 INFO - 'LOGNAME': 'cltbld', 10:04:40 INFO - 'MAIL': '/var/mail/cltbld', 10:04:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:04:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:40 INFO - 'MOZ_NO_REMOTE': '1', 10:04:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:40 INFO - 'NO_EM_RESTART': '1', 10:04:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:40 INFO - 'PWD': '/builds/slave/test', 10:04:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:04:40 INFO - 'SHELL': '/bin/bash', 10:04:40 INFO - 'SHLVL': '1', 10:04:40 INFO - 'TERM': 'linux', 10:04:40 INFO - 'TMOUT': '86400', 10:04:40 INFO - 'USER': 'cltbld', 10:04:40 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466441849.842299-1066716371', 10:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:40 INFO - '_': '/tools/buildbot/bin/python'} 10:04:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:04:40 INFO - mozversion application_buildid: 20160620073144 10:04:40 INFO - mozversion application_changeset: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea 10:04:40 INFO - mozversion application_display_name: Nightly 10:04:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:04:40 INFO - mozversion application_name: Firefox 10:04:40 INFO - mozversion application_remotingname: firefox 10:04:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:04:40 INFO - mozversion application_vendor: Mozilla 10:04:40 INFO - mozversion application_version: 50.0a1 10:04:40 INFO - mozversion platform_buildid: 20160620073144 10:04:40 INFO - mozversion platform_changeset: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea 10:04:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:04:40 INFO - mozversion platform_version: 50.0a1 10:04:40 INFO - using testdate: 1466442280 10:04:40 INFO - actual date: 1466442280 10:04:40 INFO - starting webserver on 'localhost:54138' 10:04:40 INFO - SUITE-START | Running 2 tests 10:04:40 INFO - TEST-START | dromaeo_css 10:04:40 INFO - operating with platform_type : linux_ 10:04:40 INFO - Initialising browser for dromaeo_css test... 10:04:40 INFO - TEST-INFO | started process 17669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpglXH3I/profile http://localhost:54138/getInfo.html) 10:04:45 INFO - PROCESS | 17669 | __metrics Screen width/height:1600/1200 10:04:45 INFO - PROCESS | 17669 | colorDepth:24 10:04:45 INFO - PROCESS | 17669 | Browser inner width/height: 1024/697 10:04:45 INFO - PROCESS | 17669 | __metrics 10:04:46 INFO - PROCESS | 17669 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:04:47 INFO - PROCESS | 17669 | console.error: PushService: 10:04:47 INFO - PROCESS | 17669 | stateChangeProcessEnqueue: Error transitioning state 10:04:47 INFO - PROCESS | 17669 | UnknownError 10:04:47 INFO - TEST-INFO | 17669: exit 0 10:04:47 INFO - Browser initialized. 10:04:47 INFO - Running cycle 1/1 for dromaeo_css test... 10:04:47 INFO - TEST-INFO | started process 17753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpglXH3I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:04:59 INFO - PROCESS | 17753 | RSS: Main: 173600768 10:04:59 INFO - PROCESS | 17753 | 10:05:50 INFO - PROCESS | 17753 | 1466442350660 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] 10:07:59 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:54138/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54138/tests/dromaeo/cssquery-ext.html) 10:08:00 INFO - PROCESS | 17753 | RSS: Main: 289009664 10:08:00 INFO - PROCESS | 17753 | 10:11:03 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:54138/tests/dromaeo/cssquery-ext.html (next: http://localhost:54138/tests/dromaeo/cssquery-jquery.html) 10:11:04 INFO - PROCESS | 17753 | RSS: Main: 258052096 10:11:04 INFO - PROCESS | 17753 | 10:14:06 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:54138/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54138/tests/dromaeo/cssquery-mootools.html) 10:14:06 INFO - PROCESS | 17753 | RSS: Main: 252424192 10:14:06 INFO - PROCESS | 17753 | 10:17:08 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:54138/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54138/tests/dromaeo/cssquery-prototype.html) 10:17:09 INFO - PROCESS | 17753 | RSS: Main: 255725568 10:17:09 INFO - PROCESS | 17753 | 10:20:11 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:54138/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54138/tests/dromaeo/cssquery-yui.html) 10:20:12 INFO - PROCESS | 17753 | RSS: Main: 232308736 10:20:12 INFO - PROCESS | 17753 | 10:23:15 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:54138/tests/dromaeo/cssquery-yui.html (next: http://localhost:54138/tests/dromaeo/cssquery-dojo.html) 10:23:15 INFO - PROCESS | 17753 | RSS: Main: 313679872 10:23:15 INFO - PROCESS | 17753 | 10:23:15 INFO - PROCESS | 17753 | __start_tp_report 10:23:15 INFO - PROCESS | 17753 | _x_x_mozilla_page_load 10:23:15 INFO - PROCESS | 17753 | _x_x_mozilla_page_load_details 10:23:15 INFO - PROCESS | 17753 | |i|pagename|runs| 10:23:15 INFO - PROCESS | 17753 | |0;dojo.html;3096.5819614352063;3101.2556986323275;3125.390548842976;3134.1224457152007;3141.9842900785507;5304.151335786275;5324.547413469855;5333.733313334337;5387;5413.188021796727;5393.2719082923795;5413.621046526745;5443.455654434554;5459.645123066998;5505.284313039299;4895.8776030599165;4899.6325275604295;4905.362302900618;5002.099622068026;5035.420926593452;4981.103401387749;5035.269885866547;5139.537441630253;5141.331626888499;5150.768215430296;4856.635752318591;4887.95112048882;4963.726995015273;4968.2795994580765;5025.597952163818;4901.460839307673;4915.262710593403;4940.752962351868;4962.429320628138;4977.203647416396;4862.562369386772;4865.19724245499;4951.702897826142;4963.429205641325;4993.550580447741;5301.840944771625;5496.945030549723;5560.972195138998;5565.165225216209;5573.219749235111;5722.885542289131;5767.36558978512;5776.277965254343;5809.941900580982;5872.911906321408;5870.677112758796;5887.8528036799;5906.438888305604;5922.733476993546;5927.496162826165;5338.145896656516;5399.973000134974;5494.09347457669;5522.751476183581;5523.005858945428;5908.231929849092;6038.30559485656;6043.123747056652;6045.939540604626;6050.273967123885;5744.942550574524;5790.276215473066;5793.507551858055;5795.246617939641;5801.071828507503;5627.6904770237215;5815.389384114692;5829.650220986669;5860;5874.971879920997;5764.337101233412;5802.448767367094;5803.738831752581;5889.587728858939;5892.29292484896;5793.478586927196;5829.067349224104;5834.679092649945;5841.737121829443;5842.386549412336;4409.647228221735;4424.115176964556;4461.442319710036;4476.37330773692;4508.842190523382;3893.3381325174787;3899.1032062625754;3907.1013666856784;3920.745151565139;3963.603639636013;5434.864128396822;5439.048166570913;5441.347038355343;5446.645968012067;5450.182472629058;5795.39148389413;5798.043322851767;5805.651660900359;5806.68063256525;5829.970850145722;5332.813351532678;5425.593080518976;5428.185772134132;5464.590155738256;5491.505764481216;5028.798848046037;5030.522100400456;5034.119029169954;5037.773300201499;5078.263651770547;5971.611845230046;5978.432048955342;5981.312149102909;5985.760569577168;5990.28116625999;5672.546196304368;5758.71206439668;5790.363060063305;5805.970970145291;5853.970730146322;5961.701914904151;5969;5969.283685957713;5976.641401515923;5991.310999235144;5616.1014237721765;5693.487586117104;5731.312242530923;5745.454181852884;5754.51086657622;5702.087665973424;5710.885782284414;5753.338366087954;5803.767849285981;5812.476877081083;5614.578906581941;5647.1529270609735;5648.661080335193;5651.180578816131;5662.85842853932;5557.166425036277;5574.08027675429;5650.830475085754;5651.265335506358;5668;5473.781048758005;5556.138798486241;5573.637713548606;5575.581831362583;5634.915476267777;5691.060974939089;5769.07694768835;5773.278340207474;5774.249347584787;5781.739821708117;5458;5476.288082549243;5504.834854954358;5581.190727344593;5585.776568937197 10:23:15 INFO - PROCESS | 17753 | |1;ext.html;565.5758181363977;604.9727762250699;606.4178388746806;614.7571709174877;623.2240860129139;30070.398592028145;32964.67035329646;33010.33979320412;33031.834840825795;33042.33915321695;32877.50683739746;33480.83259583699;43179.25028246898;44009.55990440094;44071;8895.110488951103;8977.37158398909;9015.549222538879;9023.593938272761;9029.232515236214;8867.556622168899;8947.910520894806;8963.686270980517;8966.282697384193;8971.10288971101;8184.427090103695;10643.201759868001;10894.67315980522;10902.890971090306;11318.717032074182;10909.399983000932;10913;10917.672469825839;10917.945410272898;10918.454077296103;8061.314788243007;10345.275830691855;10624.203184761096;10694.518746656342;10697.465126743631;41096;41442.79278603618;41518.37722434166;41522;41536.58463415357;3418.077119177833;3577.499150118985;3593.5148754918014;3691.8154092295276;3896.844126234947;31723;32359.838200808845;32993.835030824695;33074.17314567131;33715.32569348624;3979.880603581897;4023.1752490739623;4033.657139143176;4065.4918135233097;4131.318332475138;323129;325783;326606;327047;330086;57675.711621441624;57932.131018034765;58298.41701583015;58323;58352.41647583555;59836.40163598395;60473.69763151244;60639.09041364383;60770.69614651898;60835.69582152061;16849.91575042117;17192.914035429993;17199.484015479557;17214.225359858585;17221.827781722273;12423.689407764878;12444.688882778002;12466.626001219978;12467.376631168587;12472.937635311766;15113.244337783068;15939.44211952576;16188.514344569681;16494.83505164957;16787.160641967854;5675.612322761779;5871.55963302754;5888.499477544371;5997.190379298826;6072.453479186806;920.4247345409119;1028.93311934724;1043.5199808088212;1100.5377741348652;1137.3573930729112;31842.522362164586;32171.51742723861;32178.35643287168;32241.355172896412;32608.673913260565;1093.8796732359433;1107.6787731557758;1115.3308015190821;1124.1568823382463;1190.9761804763857;16391.262393192334;16776.496705098867;16934.83065169357;16954.406595769335;16986.660266794595;501219;504564;507951;511860;512724;55806.44193558012;56576.151357729665;56742.71628641913;56765;56839.43160568424;1241.6647505173553;1279.1877158004734;1283.332667013148;1376.5595009596832;1378.293863405502;24134.87932560326;31559.842200789768;33874.49188262129;34022.82988585041;34138.82930585331;55016.72491637516;55076.72461637666;55245.44754552564;55746;55762;443798;445467;445997;448531;449204;24653.876730616234;26407.33981650474;27109.322266943484;27198;27749.583756244076;40268.79865600653;41333;45956.7702161487;46213.76893115513;51651.2252316208;39089;41254.587454125074;42039.7898010508;42492.57507424886;42566.36150457684;39789.40315895322;39922.20155596814;40877;43535.346969794846;44783.55216447794;38685.6131438682;40544.594554054085;41219;41410.1717965633;41733.37399939064;35758.4636230462;36884;36925.44611830771;37005.25989480249;37654.2469150621;28140.59297035181;28143.697683787705;28199.15402537927;28245.762837968185;28278.293042674097 10:23:15 INFO - PROCESS | 17753 | |2;jquery.html;380.27557502956876;381.6755757606035;393.9015246188453;395.24508189358323;398.7308566717465;18274.45176644701;19579.118939647713;19839;20128.194872205113;20245.493862653442;18919.621607567842;19492.415227543162;19739.802601973977;19955;19966.90016549915;5320.334958130234;5531.640443371168;5643.971780141093;5772.30732312121;5809.157672137538;5533.501984821385;5560.888782224353;5564.638298510604;5601.8599535011745;5603.551715862721;5574.275344205268;5580.441955804407;5655.519280861132;6249.87500249997;6259.780907668232;6215.50275977923;6272.027835685499;6283;6286.622802631857;6303.2436107667145;5471.644343117685;5536.141898005815;5552.139418390156;5554.111342185231;5558.555315574744;12837.1014029018;12945.935270323682;12969.546065887744;13216.471341146438;13312.267825269606;2191;2243.540074284784;2249.224017713886;2427.9802482957202;2720.1295585412677;9248.491332976684;9573.234141268682;9714.757131071708;9976.90023099767;10059.597616095347;1927.759030121235;1966.1447270437407;1967.2327792160925;1969.5076230942263;1977.1201815192246;74403.62798186029;82326.58836705778;82432.58783706103;83023;84466.31067378618;10238.53926573306;10612.0449159576;10766.56933722658;10849.566017359375;10887.223757941674;14890.032147910351;15221.391144354324;15235.771463428058;15237.6190595236;15271.465498707492;7603.125640551297;8117.878231826528;8145.877811832827;8167.75496735087;8168.101508834024;7638.121616014118;7682.692692292358;7767.456278060595;7898;7947.5231486111015;4587.770611469413;4684.812607495662;4690.296455531629;4694.0611877624615;4744.335792988984;1795.8204179582199;1798.2447372103748;1813.8730288879915;1820.7541981832549;1853.731208974691;893.9821203576022;975.4586204656483;992.2211064314479;1020.0870221152176;1025.031345378625;18417.90791046063;18546.350877719484;19630.607387852448;19670.606587868162;19911.800881991283;966.8114717629994;984.8965858584888;999.0908273471107;1009.6062535611118;1056.9588954879437;10773.35359878394;11121.72195695098;11319.320840749582;11330.943345283385;11372.886271137348;467355.65288694034;474416;479633;481359;483594;96730.51634741922;97532;98646.50676746714;100299.49850250702;100847.49576252072;1004.2869562610482;1013.1945103642622;1026.7227848480868;1032.9793404131876;1041.099448976645;13947.93026034904;17850.821491784915;18789.718154227972;18840.52898677544;18914.810851891303;39837;45000.32499512444;45295.320570190815;45521.544784551734;45718;55107.72446137744;62838.37161628325;63510.682446587474;63620.363796363294;64487.032694510555;8289.212524810133;8538.573071346533;8582.09887961755;8791.296696264411;8887.111288871061;13155.60533184006;13779.586612401645;13888.375023123781;13907.721845563234;14228.075175113585;12000.15998880105;12155.513779448724;12322.507099715911;12339.62981110568;12363.258204507758;12029.578964736193;12236.204646697935;12303.323317217639;12417.19288246261;12508.499660013862;12160.939195304321;12215.144939854124;12275.570355037531;12655.367231638196;12674.429650665927;7208.495405321577;7496.887546686695;8489.915100848912;8650.870236946577;8701.695440659547;11258.324500529994;11673.649790506299;11874.940625296818;11884.524619015143;11999.340036297739 10:23:15 INFO - PROCESS | 17753 | |3;mootools.html;1295.3911661519082;1478.3051965576176;1484.7475929092054;1621.6675581505792;1745.5287072490437;8141.959290203548;8484.024337201232;8485.575721213945;8495.405321627488;8689.26141277992;8184.140665230155;8425.536595487245;8617.65529378824;8621.224089831929;8624.180702833237;1906.6472702550004;2193.649016157415;2242.4281808138985;2255.402318385621;2290.599145149592;2209.1494774511766;2214.0479593774753;2214.82281417487;2215.268961242794;2217.977820221793;2231.8884055797225;2239.0819763896807;2264.6036943534896;2266.3880752196897;2266.660000999855;1857.7213417987343;2108.34641261208;2173.2936795541355;2178.0198910490344;2183.5087105401317;2178.1396348442436;2184.7378314602192;2203.7135172427643;2204.823614110883;2205.658122990923;8707.825843483095;8766.561671916379;8776.517291548962;8778.253848422892;8782.297416206688;4991.650584459089;5090.745462726849;5096.133657278272;5097.388313402415;5109.897802043938;3228.499582564706;3256.902292931216;3277.1807048237943;3349.834406485872;3356.5300857879915;1032.8812186598486;1039.371180435833;1049.7270709615555;1052.2949623752104;1062.718379629399;11722.706932326675;11931.1051671125;11999.52001919922;12016.459259333351;12046.096542759327;4342.457192850894;4450.777461126931;4523.615492683093;4538.636909047268;4554.111948170142;10153.238507111997;10161;10164.847527287096;10168.949155254177;10175.643852465128;5159.793608255628;5161.2516185152945;5170.97414512925;5187.481251874782;5191.532762051358;4242.384854196186;4586.220342541776;4721.055788842245;4723.574878260973;4791.664583479123;3884.6503814656817;3908.296506628777;3989.7007724420782;4015.4980627421573;4016.357382818735;1222.8593711723265;1224.589762429596;1225.0995518294046;1238.6717519857245;1259.2822091407809;975.5805003848271;1006.6979906028163;1026.440589878518;1034.3070143004054;1043.0925095167254;6163.660998645028;6202.28673702521;6210.658413787285;6285.779997700059;6314.62112273265;431.30129190710625;435.68195217490774;444.0608113839207;446.0610415076218;452.61753818023715;4219.873403797891;4222.852200172979;4270.188664153801;4284.528701842794;4301.225779359683;10634.627788027381;10963.397013164353;11013.449327533592;11053.557857685764;11059.612913547988;10913.890861091446;10934.07060399859;10944.124470042378;10953.83569246462;10959.50682219302;7823.491473054233;8135.552544610104;8137.552434616153;8341.66633334672;8345.374096942754;5887.352391236875;6267.1539342188225;6312.779052733133;6395.136656551306;6466.902996454963;9968.55141518619;10250.948745256524;10299.948500257451;10337.224708146769;10455.059044686015;10267;10296.382217067;10379.06588407047;10385.428801415994;10387.428691421743;7196.640167991684;7765.456418050682;7812.88280675779;8038.879416808635;8080.313173380094;8733.781655458664;8763.649454022023;8777.385583009129;8807.559622019002;8816.382853200214;7373.078365204349;7531.246875312425;7589.468737188344;7628.8855667163925;7929.405294603043;7613.581253030915;7619.580923049286;7644.617769111411;7722.6138693063995;7801.921980780119;7127.786166415016;7213.314735100157;7216.170140433917;7233.493655444068;7234.204237533761;5059.418166910852;5083.974580127076;5182.689038657692;5224.451432599522;5259.47405259471;5351.063563876384;5420.322459692538;5433.945660543344;5480.72596370172;5488.917666235089 10:23:15 INFO - PROCESS | 17753 | |4;prototype.html;317.9349180246175;318.3791606367584;325.72150811056537;333.59801439265686;335.5235565496997;5380.300560927074;5391.676499410039;5424.8607792363655;5467.824417750188;5489.560835133189;5417.943501017303;5426;5442.210879422481;5442.265294185284;5449.291592093023;4123.195976784528;4226.175895700339;4260.5100413452465;4276.893077673052;4287.699861009731;4169.708120431571;4186.451013125148;4207.579242075783;4221.810018549173;4239.660827133837;4195.601417865298;4201.91596168078;4207.737678696379;4212.599803018724;4246.787660616972;3978.3833505806647;4046.5751096134777;4169.478815148106;4180.519240287375;4195.916081678364;3672.5042119313816;3688.170161713593;3695.909706636549;3696.5564132304294;3701.9444708329397;5234.738263086831;5247.763850626731;5261.263423120766;5263.44733802949;5270.945810837809;4501.707389019703;4619.953800461986;4756.66703330767;4757.643176761757;4769.259220384534;5579.246801681762;5622.718864056781;5623.156526521055;5650.63270887391;5658.179563963202;4011.959880401217;4025.1547175093265;4040.7777572233517;4094.3653733671326;4104.733192342488;5801.187833703285;5810.1865738796605;5814.825555233308;5829.795957141479;5860.82783443313;4138.937915931264;4142.881422016099;4144.3990621359735;4173.874783756492;4180.456540649696;4175.62419382257;4215.515215750228;4217.472815898012;4225.19721252961;4239.59723826236;4605.572272595507;4748.620110391161;4759.547842954914;4765.404324459442;4775.188218002948;5574.1917421973585;5641.802536911188;5646.802361917313;5657.858553536194;5669.43305669438;1442.7619442792031;1458.5405597236836;1459.5110637936198;1461.8318893327191;1462.1081140504284;907.5326207003399;947.2374738335706;953.7091187187974;954.8901876284316;962.855571664256;5295.973520132452;5377.569794416438;5383.542398896059;5395.919061214085;5448.346198456211;5490.533304669148;5642.746076426571;5673.404292549306;5682.232898558725;5719.942800572025;5109.259157422153;5311.990721762852;5335.66608347913;5353.0899747043095;5394.541463975606;2968.1837494689134;2996.2509372656837;3033.453978283886;3047.9390412191633;3068.5704001439817;5723.54211663066;5853.560982926298;5909.2908850938165;5995.52035837132;6004.189434426384;5840.707964601753;5852.297724273029;5927.614705044159;5944.405559444108;5966.224390829165;5868.151532267237;5868.618539794899;5900.881982360329;5910.202122713465;5918.852028699317;5468.753906074316;5761.539076873756;5796.304443466811;5816.302043754777;5816.94183058164;5748.878968601082;5762.444140082071;5773.942260577341;5775.325155704799;5776.624519406225;5718.771249149988;5918.970405147947;5958.76164953397;5977.282726072899;5982.4316689914385;4084.2852500812833;4100.54893961658;4104.774237416971;4107.445494858156;4111.362738775495;5826.504747096545;5864.853378665567;5870.853228669317;5943.821685349447;5947.9702601486715;5522.889542209053;5704.543636508986;5742.903840098417;5758.654480731169;5786.334571524329;5681.346645135863;5695.2311437957005;5702.173184888251;5722.856928576819;5751.827445176651;5577.107662773937;5594;5607.635503692247;5628.690422026828;5644.6613203207935;5471.808486703106;5725.513331366714;5727.599068065196;5736.340320863154;5743.282089738783;5532.170174473861;5561.360443548881;5562.916556251578;5565.860853478695;5574.91637625444 10:23:15 INFO - PROCESS | 17753 | |5;yui.html;750.9586972716498;777.6617171530385;786.1234723283541;815.5595978171788;856.7001549457689;15697.764533531992;16015.19924003801;16375.59061023475;16708.248128834202;16727.916360418196;14770.926145369258;15106.924465377657;15114.697706045872;15131.092134471912;15138.924305378458;655.9442447391978;767.7811823630267;793.9444238903279;799.7480793550013;803.7106641609016;803.5660743198665;807.5598798654718;808.0182578167526;810;813.1218284252992;852.1691350932853;853.8633818588996;854.0136142755127;854.7777577829747;854.918782715641;683.1904193530683;823.4400607586839;838.6645341863242;839.4543546694637;839.6767244610808;616.7779599344277;617.3332800575367;618.5113760129492;618.9102580125857;619.3991827926903;14565.344559494848;14569.49006784768;14581.927090364587;14602.926985365006;14645.70708585833;13822.723545529034;13941.372638231203;14034;14073.085249458753;14177.43290268388;13080.411381487856;13156.671083222996;13177.538786142439;13316.334183290894;13851.58445246634;4476.529964353761;4495.797689103965;4544.182047231497;4652.441706995149;4690.882727931795;76463;76840;77582.22417775806;79035.99999999942;79110.60444697739;11374.715632109264;11476.770464590662;11634.883651163549;11664.766704665859;11803.88196118045;21691.349259522238;21694.674579881314;21696.89151554232;21718.348449546538;21723.239686610894;8574.871376929352;8701.17338852808;8720.563971801512;9186.86219706705;9190.724278271662;4666.4633567139535;4756.833510827105;4801.375821143229;4810.63920205986;4986.376702912136;3198.1365031441846;3267.2975310307925;3295.868165273362;3298.86804527821;3312.089175476763;576.6482445708115;578.9015867302569;593.4273426143792;596.4929809661753;603.9758409663652;681.3186813186813;696.8223103108675;710.5701050864257;718.8023293594199;730.5324592260957;9394.295427842939;9512.619495220251;9552.42685438876;9623.182029527428;9629.470379129216;607.8449995251183;676.4081428749844;686.8935315026179;691.7959202035412;703.5286358140058;4634.536546345338;4704.976475117603;4742.668013239109;4813.542713442217;4863.282516220059;113753;116231;116348;116510;119091;99716.50141749244;100495;101316;101373.49313253534;101941;87790.1220987782;87868;88037.55981220053;89672.10327896768;91523;8756.912430875864;8821.338399619926;8859;9015;9272.119148680864;51462.48537514727;51520.74239628778;51926.74036629793;53128;53892.19161712656;45362.319565205886;54735.726321368136;59492;64877.35122648713;74758.62620686862;11356.488957996744;11426.828597570877;11687.707807304885;11693.181477296508;11895.286282823059;11815.940920295343;12409.642167988053;12656.873431265569;12868.742625147257;13053.216806991612;11106;11266.267692599955;11384.316940983568;11950.760984780429;12203.69490762738;11015.669529913795;11609.47757350938;11740.58907938218;12078.094142939139;12551.874481255436;11927.761444770882;12114.878851211375;12125.939370303093;12446.43991020388;12614.873851261369;9995.250356223167;10009.499525023866;10198;10219.846702299621;10719.517621706886;10061.409776596342;10063.49682515886;10091.243156763125;10100.747481313027;10102.393856368348 10:23:15 INFO - PROCESS | 17753 | __end_tp_report 10:23:15 INFO - PROCESS | 17753 | __start_cc_report 10:23:15 INFO - PROCESS | 17753 | _x_x_mozilla_cycle_collect,876 10:23:15 INFO - PROCESS | 17753 | __end_cc_report 10:23:15 INFO - PROCESS | 17753 | __startTimestamp1466443395787__endTimestamp 10:23:15 INFO - PROCESS | 17753 | 10:23:15 INFO - PROCESS | 17753 | ------- Summary: start ------- 10:23:15 INFO - PROCESS | 17753 | Number of tests: 6 10:23:15 INFO - PROCESS | 17753 | 10:23:15 INFO - PROCESS | 17753 | [#0] dojo.html Cycles:165 Average:5395.95 Median:5574.08 stddev:614.82 (11.0%) stddev-sans-first:589.65 10:23:15 INFO - PROCESS | 17753 | Values: 3096.6 3101.3 3125.4 3134.1 3142.0 5304.2 5324.5 5333.7 5387.0 5413.2 5393.3 5413.6 5443.5 5459.6 5505.3 4895.9 4899.6 4905.4 5002.1 5035.4 4981.1 5035.3 5139.5 5141.3 5150.8 4856.6 4888.0 4963.7 4968.3 5025.6 4901.5 4915.3 4940.8 4962.4 4977.2 4862.6 4865.2 4951.7 4963.4 4993.6 5301.8 5496.9 5561.0 5565.2 5573.2 5722.9 5767.4 5776.3 5809.9 5872.9 5870.7 5887.9 5906.4 5922.7 5927.5 5338.1 5400.0 5494.1 5522.8 5523.0 5908.2 6038.3 6043.1 6045.9 6050.3 5744.9 5790.3 5793.5 5795.2 5801.1 5627.7 5815.4 5829.7 5860.0 5875.0 5764.3 5802.4 5803.7 5889.6 5892.3 5793.5 5829.1 5834.7 5841.7 5842.4 4409.6 4424.1 4461.4 4476.4 4508.8 3893.3 3899.1 3907.1 3920.7 3963.6 5434.9 5439.0 5441.3 5446.6 5450.2 5795.4 5798.0 5805.7 5806.7 5830.0 5332.8 5425.6 5428.2 5464.6 5491.5 5028.8 5030.5 5034.1 5037.8 5078.3 5971.6 5978.4 5981.3 5985.8 5990.3 5672.5 5758.7 5790.4 5806.0 5854.0 5961.7 5969.0 5969.3 5976.6 5991.3 5616.1 5693.5 5731.3 5745.5 5754.5 5702.1 5710.9 5753.3 5803.8 5812.5 5614.6 5647.2 5648.7 5651.2 5662.9 5557.2 5574.1 5650.8 5651.3 5668.0 5473.8 5556.1 5573.6 5575.6 5634.9 5691.1 5769.1 5773.3 5774.2 5781.7 5458.0 5476.3 5504.8 5581.2 5585.8 10:23:15 INFO - PROCESS | 17753 | 10:23:15 INFO - PROCESS | 17753 | [#1] ext.html Cycles:180 Average:58652.04 Median:36965.35 stddev:114866.86 (310.7%) stddev-sans-first:115106.30 10:23:15 INFO - PROCESS | 17753 | Values: 565.6 605.0 606.4 614.8 623.2 30070.4 32964.7 33010.3 33031.8 33042.3 32877.5 33480.8 43179.3 44009.6 44071.0 8895.1 8977.4 9015.5 9023.6 9029.2 8867.6 8947.9 8963.7 8966.3 8971.1 8184.4 10643.2 10894.7 10902.9 11318.7 10909.4 10913.0 10917.7 10917.9 10918.5 8061.3 10345.3 10624.2 10694.5 10697.5 41096.0 41442.8 41518.4 41522.0 41536.6 3418.1 3577.5 3593.5 3691.8 3896.8 31723.0 32359.8 32993.8 33074.2 33715.3 3979.9 4023.2 4033.7 4065.5 4131.3 323129.0 325783.0 326606.0 327047.0 330086.0 57675.7 57932.1 58298.4 58323.0 58352.4 59836.4 60473.7 60639.1 60770.7 60835.7 16849.9 17192.9 17199.5 17214.2 17221.8 12423.7 12444.7 12466.6 12467.4 12472.9 15113.2 15939.4 16188.5 16494.8 16787.2 5675.6 5871.6 5888.5 5997.2 6072.5 920.4 1028.9 1043.5 1100.5 1137.4 31842.5 32171.5 32178.4 32241.4 32608.7 1093.9 1107.7 1115.3 1124.2 1191.0 16391.3 16776.5 16934.8 16954.4 16986.7 501219.0 504564.0 507951.0 511860.0 512724.0 55806.4 56576.2 56742.7 56765.0 56839.4 1241.7 1279.2 1283.3 1376.6 1378.3 24134.9 31559.8 33874.5 34022.8 34138.8 55016.7 55076.7 55245.4 55746.0 55762.0 443798.0 445467.0 445997.0 448531.0 449204.0 24653.9 26407.3 27109.3 27198.0 27749.6 40268.8 41333.0 45956.8 46213.8 51651.2 39089.0 41254.6 42039.8 42492.6 42566.4 39789.4 39922.2 40877.0 43535.3 44783.6 38685.6 40544.6 41219.0 41410.2 41733.4 35758.5 36884.0 36925.4 37005.3 37654.2 28140.6 28143.7 28199.2 28245.8 28278.3 10:23:15 INFO - PROCESS | 17753 | 10:23:15 INFO - PROCESS | 17753 | [#2] jquery.html Cycles:180 Average:28822.98 Median:2574.05 stddev:79023.74 (3070.0%) stddev-sans-first:79216.56 10:23:15 INFO - PROCESS | 17753 | Values: 380.3 381.7 393.9 395.2 398.7 18274.5 19579.1 19839.0 20128.2 20245.5 18919.6 19492.4 19739.8 19955.0 19966.9 5320.3 5531.6 5644.0 5772.3 5809.2 5533.5 5560.9 5564.6 5601.9 5603.6 5574.3 5580.4 5655.5 6249.9 6259.8 6215.5 6272.0 6283.0 6286.6 6303.2 5471.6 5536.1 5552.1 5554.1 5558.6 12837.1 12945.9 12969.5 13216.5 13312.3 2191.0 2243.5 2249.2 2428.0 2720.1 9248.5 9573.2 9714.8 9976.9 10059.6 1927.8 1966.1 1967.2 1969.5 1977.1 74403.6 82326.6 82432.6 83023.0 84466.3 10238.5 10612.0 10766.6 10849.6 10887.2 14890.0 15221.4 15235.8 15237.6 15271.5 7603.1 8117.9 8145.9 8167.8 8168.1 7638.1 7682.7 7767.5 7898.0 7947.5 4587.8 4684.8 4690.3 4694.1 4744.3 1795.8 1798.2 1813.9 1820.8 1853.7 894.0 975.5 992.2 1020.1 1025.0 18417.9 18546.4 19630.6 19670.6 19911.8 966.8 984.9 999.1 1009.6 1057.0 10773.4 11121.7 11319.3 11330.9 11372.9 467355.7 474416.0 479633.0 481359.0 483594.0 96730.5 97532.0 98646.5 100299.5 100847.5 1004.3 1013.2 1026.7 1033.0 1041.1 13947.9 17850.8 18789.7 18840.5 18914.8 39837.0 45000.3 45295.3 45521.5 45718.0 55107.7 62838.4 63510.7 63620.4 64487.0 8289.2 8538.6 8582.1 8791.3 8887.1 13155.6 13779.6 13888.4 13907.7 14228.1 12000.2 12155.5 12322.5 12339.6 12363.3 12029.6 12236.2 12303.3 12417.2 12508.5 12160.9 12215.1 12275.6 12655.4 12674.4 7208.5 7496.9 8489.9 8650.9 8701.7 11258.3 11673.6 11874.9 11884.5 11999.3 10:23:15 INFO - PROCESS | 17753 | 10:23:15 INFO - PROCESS | 17753 | [#3] mootools.html Cycles:180 Average:5769.30 Median:2389.07 stddev:3327.93 (139.3%) stddev-sans-first:3320.28 10:23:15 INFO - PROCESS | 17753 | Values: 1295.4 1478.3 1484.7 1621.7 1745.5 8142.0 8484.0 8485.6 8495.4 8689.3 8184.1 8425.5 8617.7 8621.2 8624.2 1906.6 2193.6 2242.4 2255.4 2290.6 2209.1 2214.0 2214.8 2215.3 2218.0 2231.9 2239.1 2264.6 2266.4 2266.7 1857.7 2108.3 2173.3 2178.0 2183.5 2178.1 2184.7 2203.7 2204.8 2205.7 8707.8 8766.6 8776.5 8778.3 8782.3 4991.7 5090.7 5096.1 5097.4 5109.9 3228.5 3256.9 3277.2 3349.8 3356.5 1032.9 1039.4 1049.7 1052.3 1062.7 11722.7 11931.1 11999.5 12016.5 12046.1 4342.5 4450.8 4523.6 4538.6 4554.1 10153.2 10161.0 10164.8 10168.9 10175.6 5159.8 5161.3 5171.0 5187.5 5191.5 4242.4 4586.2 4721.1 4723.6 4791.7 3884.7 3908.3 3989.7 4015.5 4016.4 1222.9 1224.6 1225.1 1238.7 1259.3 975.6 1006.7 1026.4 1034.3 1043.1 6163.7 6202.3 6210.7 6285.8 6314.6 431.3 435.7 444.1 446.1 452.6 4219.9 4222.9 4270.2 4284.5 4301.2 10634.6 10963.4 11013.4 11053.6 11059.6 10913.9 10934.1 10944.1 10953.8 10959.5 7823.5 8135.6 8137.6 8341.7 8345.4 5887.4 6267.2 6312.8 6395.1 6466.9 9968.6 10250.9 10299.9 10337.2 10455.1 10267.0 10296.4 10379.1 10385.4 10387.4 7196.6 7765.5 7812.9 8038.9 8080.3 8733.8 8763.6 8777.4 8807.6 8816.4 7373.1 7531.2 7589.5 7628.9 7929.4 7613.6 7619.6 7644.6 7722.6 7801.9 7127.8 7213.3 7216.2 7233.5 7234.2 5059.4 5084.0 5182.7 5224.5 5259.5 5351.1 5420.3 5433.9 5480.7 5488.9 10:23:15 INFO - PROCESS | 17753 | 10:23:15 INFO - PROCESS | 17753 | [#4] prototype.html Cycles:180 Average:4748.47 Median:5445.31 stddev:1398.45 (25.7%) stddev-sans-first:1362.26 10:23:15 INFO - PROCESS | 17753 | Values: 317.9 318.4 325.7 333.6 335.5 5380.3 5391.7 5424.9 5467.8 5489.6 5417.9 5426.0 5442.2 5442.3 5449.3 4123.2 4226.2 4260.5 4276.9 4287.7 4169.7 4186.5 4207.6 4221.8 4239.7 4195.6 4201.9 4207.7 4212.6 4246.8 3978.4 4046.6 4169.5 4180.5 4195.9 3672.5 3688.2 3695.9 3696.6 3701.9 5234.7 5247.8 5261.3 5263.4 5270.9 4501.7 4620.0 4756.7 4757.6 4769.3 5579.2 5622.7 5623.2 5650.6 5658.2 4012.0 4025.2 4040.8 4094.4 4104.7 5801.2 5810.2 5814.8 5829.8 5860.8 4138.9 4142.9 4144.4 4173.9 4180.5 4175.6 4215.5 4217.5 4225.2 4239.6 4605.6 4748.6 4759.5 4765.4 4775.2 5574.2 5641.8 5646.8 5657.9 5669.4 1442.8 1458.5 1459.5 1461.8 1462.1 907.5 947.2 953.7 954.9 962.9 5296.0 5377.6 5383.5 5395.9 5448.3 5490.5 5642.7 5673.4 5682.2 5719.9 5109.3 5312.0 5335.7 5353.1 5394.5 2968.2 2996.3 3033.5 3047.9 3068.6 5723.5 5853.6 5909.3 5995.5 6004.2 5840.7 5852.3 5927.6 5944.4 5966.2 5868.2 5868.6 5900.9 5910.2 5918.9 5468.8 5761.5 5796.3 5816.3 5816.9 5748.9 5762.4 5773.9 5775.3 5776.6 5718.8 5919.0 5958.8 5977.3 5982.4 4084.3 4100.5 4104.8 4107.4 4111.4 5826.5 5864.9 5870.9 5943.8 5948.0 5522.9 5704.5 5742.9 5758.7 5786.3 5681.3 5695.2 5702.2 5722.9 5751.8 5577.1 5594.0 5607.6 5628.7 5644.7 5471.8 5725.5 5727.6 5736.3 5743.3 5532.2 5561.4 5562.9 5565.9 5574.9 10:23:15 INFO - PROCESS | 17753 | 10:23:15 INFO - PROCESS | 17753 | [#5] yui.html Cycles:180 Average:20401.07 Median:4697.93 stddev:29943.25 (637.4%) stddev-sans-first:29990.90 10:23:15 INFO - PROCESS | 17753 | Values: 751.0 777.7 786.1 815.6 856.7 15697.8 16015.2 16375.6 16708.2 16727.9 14770.9 15106.9 15114.7 15131.1 15138.9 655.9 767.8 793.9 799.7 803.7 803.6 807.6 808.0 810.0 813.1 852.2 853.9 854.0 854.8 854.9 683.2 823.4 838.7 839.5 839.7 616.8 617.3 618.5 618.9 619.4 14565.3 14569.5 14581.9 14602.9 14645.7 13822.7 13941.4 14034.0 14073.1 14177.4 13080.4 13156.7 13177.5 13316.3 13851.6 4476.5 4495.8 4544.2 4652.4 4690.9 76463.0 76840.0 77582.2 79036.0 79110.6 11374.7 11476.8 11634.9 11664.8 11803.9 21691.3 21694.7 21696.9 21718.3 21723.2 8574.9 8701.2 8720.6 9186.9 9190.7 4666.5 4756.8 4801.4 4810.6 4986.4 3198.1 3267.3 3295.9 3298.9 3312.1 576.6 578.9 593.4 596.5 604.0 681.3 696.8 710.6 718.8 730.5 9394.3 9512.6 9552.4 9623.2 9629.5 607.8 676.4 686.9 691.8 703.5 4634.5 4705.0 4742.7 4813.5 4863.3 113753.0 116231.0 116348.0 116510.0 119091.0 99716.5 100495.0 101316.0 101373.5 101941.0 87790.1 87868.0 88037.6 89672.1 91523.0 8756.9 8821.3 8859.0 9015.0 9272.1 51462.5 51520.7 51926.7 53128.0 53892.2 45362.3 54735.7 59492.0 64877.4 74758.6 11356.5 11426.8 11687.7 11693.2 11895.3 11815.9 12409.6 12656.9 12868.7 13053.2 11106.0 11266.3 11384.3 11950.8 12203.7 11015.7 11609.5 11740.6 12078.1 12551.9 11927.8 12114.9 12125.9 12446.4 12614.9 9995.3 10009.5 10198.0 10219.8 10719.5 10061.4 10063.5 10091.2 10100.7 10102.4 10:23:15 INFO - PROCESS | 17753 | -------- Summary: end -------- 10:23:15 INFO - PROCESS | 17753 | 10:23:16 INFO - TEST-INFO | 17753: exit 0 10:23:16 INFO - TEST-OK | dromaeo_css | took 1115910ms 10:23:16 INFO - TEST-START | kraken 10:23:16 INFO - operating with platform_type : linux_ 10:23:16 INFO - Initialising browser for kraken test... 10:23:16 INFO - TEST-INFO | started process 17943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc1rrmt/profile http://localhost:54138/getInfo.html) 10:23:20 INFO - PROCESS | 17943 | __metrics Screen width/height:1600/1200 10:23:20 INFO - PROCESS | 17943 | colorDepth:24 10:23:20 INFO - PROCESS | 17943 | Browser inner width/height: 1024/697 10:23:20 INFO - PROCESS | 17943 | __metrics 10:23:22 INFO - PROCESS | 17943 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:23:22 INFO - PROCESS | 17943 | console.error: PushService: 10:23:22 INFO - PROCESS | 17943 | stateChangeProcessEnqueue: Error transitioning state 10:23:22 INFO - PROCESS | 17943 | UnknownError 10:23:23 INFO - TEST-INFO | 17943: exit 0 10:23:23 INFO - Browser initialized. 10:23:23 INFO - Running cycle 1/1 for kraken test... 10:23:23 INFO - TEST-INFO | started process 18026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc1rrmt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:23:35 INFO - PROCESS | 18026 | RSS: Main: 173752320 10:23:35 INFO - PROCESS | 18026 | 10:23:37 INFO - PROCESS | 18026 | Cycle 1(1): loaded http://localhost:54138/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54138/tests/kraken/driver.html?testName=audio-beat-detection) 10:23:38 INFO - PROCESS | 18026 | RSS: Main: 233238528 10:23:38 INFO - PROCESS | 18026 | 10:23:41 INFO - PROCESS | 18026 | Cycle 1(1): loaded http://localhost:54138/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54138/tests/kraken/driver.html?testName=audio-dft) 10:23:41 INFO - PROCESS | 18026 | RSS: Main: 217067520 10:23:41 INFO - PROCESS | 18026 | 10:23:45 INFO - PROCESS | 18026 | Cycle 1(1): loaded http://localhost:54138/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54138/tests/kraken/driver.html?testName=audio-fft) 10:23:45 INFO - PROCESS | 18026 | RSS: Main: 286658560 10:23:45 INFO - PROCESS | 18026 | 10:23:47 INFO - PROCESS | 18026 | Cycle 1(1): loaded http://localhost:54138/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54138/tests/kraken/driver.html?testName=audio-oscillator) 10:23:48 INFO - PROCESS | 18026 | RSS: Main: 197574656 10:23:48 INFO - PROCESS | 18026 | 10:23:50 INFO - PROCESS | 18026 | Cycle 1(1): loaded http://localhost:54138/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54138/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:23:51 INFO - PROCESS | 18026 | RSS: Main: 201998336 10:23:51 INFO - PROCESS | 18026 | 10:23:54 INFO - PROCESS | 18026 | Cycle 1(1): loaded http://localhost:54138/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54138/tests/kraken/driver.html?testName=imaging-darkroom) 10:23:54 INFO - PROCESS | 18026 | RSS: Main: 235827200 10:23:54 INFO - PROCESS | 18026 | 10:23:58 INFO - PROCESS | 18026 | Cycle 1(1): loaded http://localhost:54138/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54138/tests/kraken/driver.html?testName=imaging-desaturate) 10:23:58 INFO - PROCESS | 18026 | RSS: Main: 233041920 10:23:58 INFO - PROCESS | 18026 | 10:24:01 INFO - PROCESS | 18026 | Cycle 1(1): loaded http://localhost:54138/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54138/tests/kraken/driver.html?testName=json-parse-financial) 10:24:02 INFO - PROCESS | 18026 | RSS: Main: 235827200 10:24:02 INFO - PROCESS | 18026 | 10:24:03 INFO - PROCESS | 18026 | Cycle 1(1): loaded http://localhost:54138/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54138/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:24:04 INFO - PROCESS | 18026 | RSS: Main: 224493568 10:24:04 INFO - PROCESS | 18026 | 10:24:06 INFO - PROCESS | 18026 | Cycle 1(1): loaded http://localhost:54138/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54138/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:24:06 INFO - PROCESS | 18026 | RSS: Main: 228298752 10:24:06 INFO - PROCESS | 18026 | 10:24:08 INFO - PROCESS | 18026 | Cycle 1(1): loaded http://localhost:54138/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54138/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:24:09 INFO - PROCESS | 18026 | RSS: Main: 238469120 10:24:09 INFO - PROCESS | 18026 | 10:24:12 INFO - PROCESS | 18026 | Cycle 1(1): loaded http://localhost:54138/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:24:12 INFO - PROCESS | 18026 | RSS: Main: 239030272 10:24:12 INFO - PROCESS | 18026 | 10:24:15 INFO - PROCESS | 18026 | Cycle 1(1): loaded http://localhost:54138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:24:15 INFO - PROCESS | 18026 | RSS: Main: 238485504 10:24:15 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | Cycle 1(1): loaded http://localhost:54138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54138/tests/kraken/driver.html?testName=ai-astar) 10:24:17 INFO - PROCESS | 18026 | RSS: Main: 281595904 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | __start_tp_report 10:24:17 INFO - PROCESS | 18026 | _x_x_mozilla_page_load 10:24:17 INFO - PROCESS | 18026 | _x_x_mozilla_page_load_details 10:24:17 INFO - PROCESS | 18026 | |i|pagename|runs| 10:24:17 INFO - PROCESS | 18026 | |0;ai-astar;110;105;111;110;111;112;110;111;110;112 10:24:17 INFO - PROCESS | 18026 | |1;audio-beat-detection;156;126;129;176;127;128;161;126;157;128 10:24:17 INFO - PROCESS | 18026 | |2;audio-dft;161;161;160;162;160;161;160;162;161;166 10:24:17 INFO - PROCESS | 18026 | |3;audio-fft;73;74;75;116;75;75;74;73;99;75 10:24:17 INFO - PROCESS | 18026 | |4;audio-oscillator;85;85;117;84;85;84;118;84;86;129 10:24:17 INFO - PROCESS | 18026 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;116;117;117 10:24:17 INFO - PROCESS | 18026 | |6;imaging-darkroom;146;145;146;146;147;146;146;146;146;146 10:24:17 INFO - PROCESS | 18026 | |7;imaging-desaturate;94;94;94;94;94;94;94;95;94;96 10:24:17 INFO - PROCESS | 18026 | |8;json-parse-financial;51;51;52;53;53;53;51;53;52;52 10:24:17 INFO - PROCESS | 18026 | |9;json-stringify-tinderbox;61;62;61;61;63;62;62;62;62;61 10:24:17 INFO - PROCESS | 18026 | |10;stanford-crypto-aes;82;83;79;80;80;84;83;80;114;85 10:24:17 INFO - PROCESS | 18026 | |11;stanford-crypto-ccm;130;132;120;122;129;120;117;124;134;122 10:24:17 INFO - PROCESS | 18026 | |12;stanford-crypto-pbkdf2;159;159;158;168;162;162;163;165;166;161 10:24:17 INFO - PROCESS | 18026 | |13;stanford-crypto-sha256-iterative;63;62;62;62;65;62;66;63;62;61 10:24:17 INFO - PROCESS | 18026 | __end_tp_report 10:24:17 INFO - PROCESS | 18026 | __start_cc_report 10:24:17 INFO - PROCESS | 18026 | _x_x_mozilla_cycle_collect,1611 10:24:17 INFO - PROCESS | 18026 | __end_cc_report 10:24:17 INFO - PROCESS | 18026 | __startTimestamp1466443457854__endTimestamp 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | ------- Summary: start ------- 10:24:17 INFO - PROCESS | 18026 | Number of tests: 14 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.99 (1.8%) stddev-sans-first:2.11 10:24:17 INFO - PROCESS | 18026 | Values: 110.0 105.0 111.0 110.0 111.0 112.0 110.0 111.0 110.0 112.0 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:142.50 stddev:18.95 (13.3%) stddev-sans-first:19.35 10:24:17 INFO - PROCESS | 18026 | Values: 156.0 126.0 129.0 176.0 127.0 128.0 161.0 126.0 157.0 128.0 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.78 (1.1%) stddev-sans-first:1.88 10:24:17 INFO - PROCESS | 18026 | Values: 161.0 161.0 160.0 162.0 160.0 161.0 160.0 162.0 161.0 166.0 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:14.60 (19.5%) stddev-sans-first:15.21 10:24:17 INFO - PROCESS | 18026 | Values: 73.0 74.0 75.0 116.0 75.0 75.0 74.0 73.0 99.0 75.0 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:84.50 stddev:17.98 (21.3%) stddev-sans-first:18.64 10:24:17 INFO - PROCESS | 18026 | Values: 85.0 85.0 117.0 84.0 85.0 84.0 118.0 84.0 86.0 129.0 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:24:17 INFO - PROCESS | 18026 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 10:24:17 INFO - PROCESS | 18026 | Values: 146.0 145.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 10:24:17 INFO - PROCESS | 18026 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 96.0 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.50 stddev:0.88 (1.7%) stddev-sans-first:0.83 10:24:17 INFO - PROCESS | 18026 | Values: 51.0 51.0 52.0 53.0 53.0 53.0 51.0 53.0 52.0 52.0 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 10:24:17 INFO - PROCESS | 18026 | Values: 61.0 62.0 61.0 61.0 63.0 62.0 62.0 62.0 62.0 61.0 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:82.50 stddev:10.38 (12.6%) stddev-sans-first:10.95 10:24:17 INFO - PROCESS | 18026 | Values: 82.0 83.0 79.0 80.0 80.0 84.0 83.0 80.0 114.0 85.0 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:126.50 stddev:5.81 (4.6%) stddev-sans-first:5.88 10:24:17 INFO - PROCESS | 18026 | Values: 130.0 132.0 120.0 122.0 129.0 120.0 117.0 124.0 134.0 122.0 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.50 stddev:3.27 (2.0%) stddev-sans-first:3.24 10:24:17 INFO - PROCESS | 18026 | Values: 159.0 159.0 158.0 168.0 162.0 162.0 163.0 165.0 166.0 161.0 10:24:17 INFO - PROCESS | 18026 | 10:24:17 INFO - PROCESS | 18026 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.50 stddev:1.55 (2.5%) stddev-sans-first:1.64 10:24:17 INFO - PROCESS | 18026 | Values: 63.0 62.0 62.0 62.0 65.0 62.0 66.0 63.0 62.0 61.0 10:24:17 INFO - PROCESS | 18026 | -------- Summary: end -------- 10:24:17 INFO - PROCESS | 18026 | 10:24:18 INFO - TEST-INFO | 18026: exit 0 10:24:18 INFO - TEST-OK | kraken | took 62395ms 10:24:18 INFO - SUITE-END | took 1178s 10:24:19 INFO - Completed test suite (00:19:38) 10:24:19 INFO - javascript benchmark 10:24:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.5819614352063, 3101.2556986323275, 3125.390548842976, 3134.1224457152007, 3141.9842900785507, 5304.151335786275, 5324.547413469855, 5333.733313334337, 5387.0, 5413.188021796727, 5393.2719082923795, 5413.621046526745, 5443.455654434554, 5459.645123066998, 5505.284313039299, 4895.8776030599165, 4899.6325275604295, 4905.362302900618, 5002.099622068026, 5035.420926593452, 4981.103401387749, 5035.269885866547, 5139.537441630253, 5141.331626888499, 5150.768215430296, 4856.635752318591, 4887.95112048882, 4963.726995015273, 4968.2795994580765, 5025.597952163818, 4901.460839307673, 4915.262710593403, 4940.752962351868, 4962.429320628138, 4977.203647416396, 4862.562369386772, 4865.19724245499, 4951.702897826142, 4963.429205641325, 4993.550580447741, 5301.840944771625, 5496.945030549723, 5560.972195138998, 5565.165225216209, 5573.219749235111, 5722.885542289131, 5767.36558978512, 5776.277965254343, 5809.941900580982, 5872.911906321408, 5870.677112758796, 5887.8528036799, 5906.438888305604, 5922.733476993546, 5927.496162826165, 5338.145896656516, 5399.973000134974, 5494.09347457669, 5522.751476183581, 5523.005858945428, 5908.231929849092, 6038.30559485656, 6043.123747056652, 6045.939540604626, 6050.273967123885, 5744.942550574524, 5790.276215473066, 5793.507551858055, 5795.246617939641, 5801.071828507503, 5627.6904770237215, 5815.389384114692, 5829.650220986669, 5860.0, 5874.971879920997, 5764.337101233412, 5802.448767367094, 5803.738831752581, 5889.587728858939, 5892.29292484896, 5793.478586927196, 5829.067349224104, 5834.679092649945, 5841.737121829443, 5842.386549412336, 4409.647228221735, 4424.115176964556, 4461.442319710036, 4476.37330773692, 4508.842190523382, 3893.3381325174787, 3899.1032062625754, 3907.1013666856784, 3920.745151565139, 3963.603639636013, 5434.864128396822, 5439.048166570913, 5441.347038355343, 5446.645968012067, 5450.182472629058, 5795.39148389413, 5798.043322851767, 5805.651660900359, 5806.68063256525, 5829.970850145722, 5332.813351532678, 5425.593080518976, 5428.185772134132, 5464.590155738256, 5491.505764481216, 5028.798848046037, 5030.522100400456, 5034.119029169954, 5037.773300201499, 5078.263651770547, 5971.611845230046, 5978.432048955342, 5981.312149102909, 5985.760569577168, 5990.28116625999, 5672.546196304368, 5758.71206439668, 5790.363060063305, 5805.970970145291, 5853.970730146322, 5961.701914904151, 5969.0, 5969.283685957713, 5976.641401515923, 5991.310999235144, 5616.1014237721765, 5693.487586117104, 5731.312242530923, 5745.454181852884, 5754.51086657622, 5702.087665973424, 5710.885782284414, 5753.338366087954, 5803.767849285981, 5812.476877081083, 5614.578906581941, 5647.1529270609735, 5648.661080335193, 5651.180578816131, 5662.85842853932, 5557.166425036277, 5574.08027675429, 5650.830475085754, 5651.265335506358, 5668.0, 5473.781048758005, 5556.138798486241, 5573.637713548606, 5575.581831362583, 5634.915476267777, 5691.060974939089, 5769.07694768835, 5773.278340207474, 5774.249347584787, 5781.739821708117, 5458.0, 5476.288082549243, 5504.834854954358, 5581.190727344593, 5585.776568937197], "value": 5353.994688260765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.5758181363977, 604.9727762250699, 606.4178388746806, 614.7571709174877, 623.2240860129139, 30070.398592028145, 32964.67035329646, 33010.33979320412, 33031.834840825795, 33042.33915321695, 32877.50683739746, 33480.83259583699, 43179.25028246898, 44009.55990440094, 44071.0, 8895.110488951103, 8977.37158398909, 9015.549222538879, 9023.593938272761, 9029.232515236214, 8867.556622168899, 8947.910520894806, 8963.686270980517, 8966.282697384193, 8971.10288971101, 8184.427090103695, 10643.201759868001, 10894.67315980522, 10902.890971090306, 11318.717032074182, 10909.399983000932, 10913.0, 10917.672469825839, 10917.945410272898, 10918.454077296103, 8061.314788243007, 10345.275830691855, 10624.203184761096, 10694.518746656342, 10697.465126743631, 41096.0, 41442.79278603618, 41518.37722434166, 41522.0, 41536.58463415357, 3418.077119177833, 3577.499150118985, 3593.5148754918014, 3691.8154092295276, 3896.844126234947, 31723.0, 32359.838200808845, 32993.835030824695, 33074.17314567131, 33715.32569348624, 3979.880603581897, 4023.1752490739623, 4033.657139143176, 4065.4918135233097, 4131.318332475138, 323129.0, 325783.0, 326606.0, 327047.0, 330086.0, 57675.711621441624, 57932.131018034765, 58298.41701583015, 58323.0, 58352.41647583555, 59836.40163598395, 60473.69763151244, 60639.09041364383, 60770.69614651898, 60835.69582152061, 16849.91575042117, 17192.914035429993, 17199.484015479557, 17214.225359858585, 17221.827781722273, 12423.689407764878, 12444.688882778002, 12466.626001219978, 12467.376631168587, 12472.937635311766, 15113.244337783068, 15939.44211952576, 16188.514344569681, 16494.83505164957, 16787.160641967854, 5675.612322761779, 5871.55963302754, 5888.499477544371, 5997.190379298826, 6072.453479186806, 920.4247345409119, 1028.93311934724, 1043.5199808088212, 1100.5377741348652, 1137.3573930729112, 31842.522362164586, 32171.51742723861, 32178.35643287168, 32241.355172896412, 32608.673913260565, 1093.8796732359433, 1107.6787731557758, 1115.3308015190821, 1124.1568823382463, 1190.9761804763857, 16391.262393192334, 16776.496705098867, 16934.83065169357, 16954.406595769335, 16986.660266794595, 501219.0, 504564.0, 507951.0, 511860.0, 512724.0, 55806.44193558012, 56576.151357729665, 56742.71628641913, 56765.0, 56839.43160568424, 1241.6647505173553, 1279.1877158004734, 1283.332667013148, 1376.5595009596832, 1378.293863405502, 24134.87932560326, 31559.842200789768, 33874.49188262129, 34022.82988585041, 34138.82930585331, 55016.72491637516, 55076.72461637666, 55245.44754552564, 55746.0, 55762.0, 443798.0, 445467.0, 445997.0, 448531.0, 449204.0, 24653.876730616234, 26407.33981650474, 27109.322266943484, 27198.0, 27749.583756244076, 40268.79865600653, 41333.0, 45956.7702161487, 46213.76893115513, 51651.2252316208, 39089.0, 41254.587454125074, 42039.7898010508, 42492.57507424886, 42566.36150457684, 39789.40315895322, 39922.20155596814, 40877.0, 43535.346969794846, 44783.55216447794, 38685.6131438682, 40544.594554054085, 41219.0, 41410.1717965633, 41733.37399939064, 35758.4636230462, 36884.0, 36925.44611830771, 37005.25989480249, 37654.2469150621, 28140.59297035181, 28143.697683787705, 28199.15402537927, 28245.762837968185, 28278.293042674097], "value": 19874.170530538326, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.27557502956876, 381.6755757606035, 393.9015246188453, 395.24508189358323, 398.7308566717465, 18274.45176644701, 19579.118939647713, 19839.0, 20128.194872205113, 20245.493862653442, 18919.621607567842, 19492.415227543162, 19739.802601973977, 19955.0, 19966.90016549915, 5320.334958130234, 5531.640443371168, 5643.971780141093, 5772.30732312121, 5809.157672137538, 5533.501984821385, 5560.888782224353, 5564.638298510604, 5601.8599535011745, 5603.551715862721, 5574.275344205268, 5580.441955804407, 5655.519280861132, 6249.87500249997, 6259.780907668232, 6215.50275977923, 6272.027835685499, 6283.0, 6286.622802631857, 6303.2436107667145, 5471.644343117685, 5536.141898005815, 5552.139418390156, 5554.111342185231, 5558.555315574744, 12837.1014029018, 12945.935270323682, 12969.546065887744, 13216.471341146438, 13312.267825269606, 2191.0, 2243.540074284784, 2249.224017713886, 2427.9802482957202, 2720.1295585412677, 9248.491332976684, 9573.234141268682, 9714.757131071708, 9976.90023099767, 10059.597616095347, 1927.759030121235, 1966.1447270437407, 1967.2327792160925, 1969.5076230942263, 1977.1201815192246, 74403.62798186029, 82326.58836705778, 82432.58783706103, 83023.0, 84466.31067378618, 10238.53926573306, 10612.0449159576, 10766.56933722658, 10849.566017359375, 10887.223757941674, 14890.032147910351, 15221.391144354324, 15235.771463428058, 15237.6190595236, 15271.465498707492, 7603.125640551297, 8117.878231826528, 8145.877811832827, 8167.75496735087, 8168.101508834024, 7638.121616014118, 7682.692692292358, 7767.456278060595, 7898.0, 7947.5231486111015, 4587.770611469413, 4684.812607495662, 4690.296455531629, 4694.0611877624615, 4744.335792988984, 1795.8204179582199, 1798.2447372103748, 1813.8730288879915, 1820.7541981832549, 1853.731208974691, 893.9821203576022, 975.4586204656483, 992.2211064314479, 1020.0870221152176, 1025.031345378625, 18417.90791046063, 18546.350877719484, 19630.607387852448, 19670.606587868162, 19911.800881991283, 966.8114717629994, 984.8965858584888, 999.0908273471107, 1009.6062535611118, 1056.9588954879437, 10773.35359878394, 11121.72195695098, 11319.320840749582, 11330.943345283385, 11372.886271137348, 467355.65288694034, 474416.0, 479633.0, 481359.0, 483594.0, 96730.51634741922, 97532.0, 98646.50676746714, 100299.49850250702, 100847.49576252072, 1004.2869562610482, 1013.1945103642622, 1026.7227848480868, 1032.9793404131876, 1041.099448976645, 13947.93026034904, 17850.821491784915, 18789.718154227972, 18840.52898677544, 18914.810851891303, 39837.0, 45000.32499512444, 45295.320570190815, 45521.544784551734, 45718.0, 55107.72446137744, 62838.37161628325, 63510.682446587474, 63620.363796363294, 64487.032694510555, 8289.212524810133, 8538.573071346533, 8582.09887961755, 8791.296696264411, 8887.111288871061, 13155.60533184006, 13779.586612401645, 13888.375023123781, 13907.721845563234, 14228.075175113585, 12000.15998880105, 12155.513779448724, 12322.507099715911, 12339.62981110568, 12363.258204507758, 12029.578964736193, 12236.204646697935, 12303.323317217639, 12417.19288246261, 12508.499660013862, 12160.939195304321, 12215.144939854124, 12275.570355037531, 12655.367231638196, 12674.429650665927, 7208.495405321577, 7496.887546686695, 8489.915100848912, 8650.870236946577, 8701.695440659547, 11258.324500529994, 11673.649790506299, 11874.940625296818, 11884.524619015143, 11999.340036297739], "value": 9153.807189955409, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.3911661519082, 1478.3051965576176, 1484.7475929092054, 1621.6675581505792, 1745.5287072490437, 8141.959290203548, 8484.024337201232, 8485.575721213945, 8495.405321627488, 8689.26141277992, 8184.140665230155, 8425.536595487245, 8617.65529378824, 8621.224089831929, 8624.180702833237, 1906.6472702550004, 2193.649016157415, 2242.4281808138985, 2255.402318385621, 2290.599145149592, 2209.1494774511766, 2214.0479593774753, 2214.82281417487, 2215.268961242794, 2217.977820221793, 2231.8884055797225, 2239.0819763896807, 2264.6036943534896, 2266.3880752196897, 2266.660000999855, 1857.7213417987343, 2108.34641261208, 2173.2936795541355, 2178.0198910490344, 2183.5087105401317, 2178.1396348442436, 2184.7378314602192, 2203.7135172427643, 2204.823614110883, 2205.658122990923, 8707.825843483095, 8766.561671916379, 8776.517291548962, 8778.253848422892, 8782.297416206688, 4991.650584459089, 5090.745462726849, 5096.133657278272, 5097.388313402415, 5109.897802043938, 3228.499582564706, 3256.902292931216, 3277.1807048237943, 3349.834406485872, 3356.5300857879915, 1032.8812186598486, 1039.371180435833, 1049.7270709615555, 1052.2949623752104, 1062.718379629399, 11722.706932326675, 11931.1051671125, 11999.52001919922, 12016.459259333351, 12046.096542759327, 4342.457192850894, 4450.777461126931, 4523.615492683093, 4538.636909047268, 4554.111948170142, 10153.238507111997, 10161.0, 10164.847527287096, 10168.949155254177, 10175.643852465128, 5159.793608255628, 5161.2516185152945, 5170.97414512925, 5187.481251874782, 5191.532762051358, 4242.384854196186, 4586.220342541776, 4721.055788842245, 4723.574878260973, 4791.664583479123, 3884.6503814656817, 3908.296506628777, 3989.7007724420782, 4015.4980627421573, 4016.357382818735, 1222.8593711723265, 1224.589762429596, 1225.0995518294046, 1238.6717519857245, 1259.2822091407809, 975.5805003848271, 1006.6979906028163, 1026.440589878518, 1034.3070143004054, 1043.0925095167254, 6163.660998645028, 6202.28673702521, 6210.658413787285, 6285.779997700059, 6314.62112273265, 431.30129190710625, 435.68195217490774, 444.0608113839207, 446.0610415076218, 452.61753818023715, 4219.873403797891, 4222.852200172979, 4270.188664153801, 4284.528701842794, 4301.225779359683, 10634.627788027381, 10963.397013164353, 11013.449327533592, 11053.557857685764, 11059.612913547988, 10913.890861091446, 10934.07060399859, 10944.124470042378, 10953.83569246462, 10959.50682219302, 7823.491473054233, 8135.552544610104, 8137.552434616153, 8341.66633334672, 8345.374096942754, 5887.352391236875, 6267.1539342188225, 6312.779052733133, 6395.136656551306, 6466.902996454963, 9968.55141518619, 10250.948745256524, 10299.948500257451, 10337.224708146769, 10455.059044686015, 10267.0, 10296.382217067, 10379.06588407047, 10385.428801415994, 10387.428691421743, 7196.640167991684, 7765.456418050682, 7812.88280675779, 8038.879416808635, 8080.313173380094, 8733.781655458664, 8763.649454022023, 8777.385583009129, 8807.559622019002, 8816.382853200214, 7373.078365204349, 7531.246875312425, 7589.468737188344, 7628.8855667163925, 7929.405294603043, 7613.581253030915, 7619.580923049286, 7644.617769111411, 7722.6138693063995, 7801.921980780119, 7127.786166415016, 7213.314735100157, 7216.170140433917, 7233.493655444068, 7234.204237533761, 5059.418166910852, 5083.974580127076, 5182.689038657692, 5224.451432599522, 5259.47405259471, 5351.063563876384, 5420.322459692538, 5433.945660543344, 5480.72596370172, 5488.917666235089], "value": 4503.226601144226, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.9349180246175, 318.3791606367584, 325.72150811056537, 333.59801439265686, 335.5235565496997, 5380.300560927074, 5391.676499410039, 5424.8607792363655, 5467.824417750188, 5489.560835133189, 5417.943501017303, 5426.0, 5442.210879422481, 5442.265294185284, 5449.291592093023, 4123.195976784528, 4226.175895700339, 4260.5100413452465, 4276.893077673052, 4287.699861009731, 4169.708120431571, 4186.451013125148, 4207.579242075783, 4221.810018549173, 4239.660827133837, 4195.601417865298, 4201.91596168078, 4207.737678696379, 4212.599803018724, 4246.787660616972, 3978.3833505806647, 4046.5751096134777, 4169.478815148106, 4180.519240287375, 4195.916081678364, 3672.5042119313816, 3688.170161713593, 3695.909706636549, 3696.5564132304294, 3701.9444708329397, 5234.738263086831, 5247.763850626731, 5261.263423120766, 5263.44733802949, 5270.945810837809, 4501.707389019703, 4619.953800461986, 4756.66703330767, 4757.643176761757, 4769.259220384534, 5579.246801681762, 5622.718864056781, 5623.156526521055, 5650.63270887391, 5658.179563963202, 4011.959880401217, 4025.1547175093265, 4040.7777572233517, 4094.3653733671326, 4104.733192342488, 5801.187833703285, 5810.1865738796605, 5814.825555233308, 5829.795957141479, 5860.82783443313, 4138.937915931264, 4142.881422016099, 4144.3990621359735, 4173.874783756492, 4180.456540649696, 4175.62419382257, 4215.515215750228, 4217.472815898012, 4225.19721252961, 4239.59723826236, 4605.572272595507, 4748.620110391161, 4759.547842954914, 4765.404324459442, 4775.188218002948, 5574.1917421973585, 5641.802536911188, 5646.802361917313, 5657.858553536194, 5669.43305669438, 1442.7619442792031, 1458.5405597236836, 1459.5110637936198, 1461.8318893327191, 1462.1081140504284, 907.5326207003399, 947.2374738335706, 953.7091187187974, 954.8901876284316, 962.855571664256, 5295.973520132452, 5377.569794416438, 5383.542398896059, 5395.919061214085, 5448.346198456211, 5490.533304669148, 5642.746076426571, 5673.404292549306, 5682.232898558725, 5719.942800572025, 5109.259157422153, 5311.990721762852, 5335.66608347913, 5353.0899747043095, 5394.541463975606, 2968.1837494689134, 2996.2509372656837, 3033.453978283886, 3047.9390412191633, 3068.5704001439817, 5723.54211663066, 5853.560982926298, 5909.2908850938165, 5995.52035837132, 6004.189434426384, 5840.707964601753, 5852.297724273029, 5927.614705044159, 5944.405559444108, 5966.224390829165, 5868.151532267237, 5868.618539794899, 5900.881982360329, 5910.202122713465, 5918.852028699317, 5468.753906074316, 5761.539076873756, 5796.304443466811, 5816.302043754777, 5816.94183058164, 5748.878968601082, 5762.444140082071, 5773.942260577341, 5775.325155704799, 5776.624519406225, 5718.771249149988, 5918.970405147947, 5958.76164953397, 5977.282726072899, 5982.4316689914385, 4084.2852500812833, 4100.54893961658, 4104.774237416971, 4107.445494858156, 4111.362738775495, 5826.504747096545, 5864.853378665567, 5870.853228669317, 5943.821685349447, 5947.9702601486715, 5522.889542209053, 5704.543636508986, 5742.903840098417, 5758.654480731169, 5786.334571524329, 5681.346645135863, 5695.2311437957005, 5702.173184888251, 5722.856928576819, 5751.827445176651, 5577.107662773937, 5594.0, 5607.635503692247, 5628.690422026828, 5644.6613203207935, 5471.808486703106, 5725.513331366714, 5727.599068065196, 5736.340320863154, 5743.282089738783, 5532.170174473861, 5561.360443548881, 5562.916556251578, 5565.860853478695, 5574.91637625444], "value": 4298.443901769691, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.9586972716498, 777.6617171530385, 786.1234723283541, 815.5595978171788, 856.7001549457689, 15697.764533531992, 16015.19924003801, 16375.59061023475, 16708.248128834202, 16727.916360418196, 14770.926145369258, 15106.924465377657, 15114.697706045872, 15131.092134471912, 15138.924305378458, 655.9442447391978, 767.7811823630267, 793.9444238903279, 799.7480793550013, 803.7106641609016, 803.5660743198665, 807.5598798654718, 808.0182578167526, 810.0, 813.1218284252992, 852.1691350932853, 853.8633818588996, 854.0136142755127, 854.7777577829747, 854.918782715641, 683.1904193530683, 823.4400607586839, 838.6645341863242, 839.4543546694637, 839.6767244610808, 616.7779599344277, 617.3332800575367, 618.5113760129492, 618.9102580125857, 619.3991827926903, 14565.344559494848, 14569.49006784768, 14581.927090364587, 14602.926985365006, 14645.70708585833, 13822.723545529034, 13941.372638231203, 14034.0, 14073.085249458753, 14177.43290268388, 13080.411381487856, 13156.671083222996, 13177.538786142439, 13316.334183290894, 13851.58445246634, 4476.529964353761, 4495.797689103965, 4544.182047231497, 4652.441706995149, 4690.882727931795, 76463.0, 76840.0, 77582.22417775806, 79035.99999999942, 79110.60444697739, 11374.715632109264, 11476.770464590662, 11634.883651163549, 11664.766704665859, 11803.88196118045, 21691.349259522238, 21694.674579881314, 21696.89151554232, 21718.348449546538, 21723.239686610894, 8574.871376929352, 8701.17338852808, 8720.563971801512, 9186.86219706705, 9190.724278271662, 4666.4633567139535, 4756.833510827105, 4801.375821143229, 4810.63920205986, 4986.376702912136, 3198.1365031441846, 3267.2975310307925, 3295.868165273362, 3298.86804527821, 3312.089175476763, 576.6482445708115, 578.9015867302569, 593.4273426143792, 596.4929809661753, 603.9758409663652, 681.3186813186813, 696.8223103108675, 710.5701050864257, 718.8023293594199, 730.5324592260957, 9394.295427842939, 9512.619495220251, 9552.42685438876, 9623.182029527428, 9629.470379129216, 607.8449995251183, 676.4081428749844, 686.8935315026179, 691.7959202035412, 703.5286358140058, 4634.536546345338, 4704.976475117603, 4742.668013239109, 4813.542713442217, 4863.282516220059, 113753.0, 116231.0, 116348.0, 116510.0, 119091.0, 99716.50141749244, 100495.0, 101316.0, 101373.49313253534, 101941.0, 87790.1220987782, 87868.0, 88037.55981220053, 89672.10327896768, 91523.0, 8756.912430875864, 8821.338399619926, 8859.0, 9015.0, 9272.119148680864, 51462.48537514727, 51520.74239628778, 51926.74036629793, 53128.0, 53892.19161712656, 45362.319565205886, 54735.726321368136, 59492.0, 64877.35122648713, 74758.62620686862, 11356.488957996744, 11426.828597570877, 11687.707807304885, 11693.181477296508, 11895.286282823059, 11815.940920295343, 12409.642167988053, 12656.873431265569, 12868.742625147257, 13053.216806991612, 11106.0, 11266.267692599955, 11384.316940983568, 11950.760984780429, 12203.69490762738, 11015.669529913795, 11609.47757350938, 11740.58907938218, 12078.094142939139, 12551.874481255436, 11927.761444770882, 12114.878851211375, 12125.939370303093, 12446.43991020388, 12614.873851261369, 9995.250356223167, 10009.499525023866, 10198.0, 10219.846702299621, 10719.517621706886, 10061.409776596342, 10063.49682515886, 10091.243156763125, 10100.747481313027, 10102.393856368348], "value": 7365.9626033115865, "unit": "score"}], "name": "dromaeo_css", "value": 7196.362037431897, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 111.0, 110.0, 111.0, 112.0, 110.0, 111.0, 110.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 129.0, 176.0, 127.0, 128.0, 161.0, 126.0, 157.0, 128.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 160.0, 161.0, 160.0, 162.0, 161.0, 166.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 116.0, 75.0, 75.0, 74.0, 73.0, 99.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 117.0, 84.0, 85.0, 84.0, 118.0, 84.0, 86.0, 129.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 96.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 53.0, 53.0, 53.0, 51.0, 53.0, 52.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 63.0, 62.0, 62.0, 62.0, 62.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 79.0, 80.0, 80.0, 84.0, 83.0, 80.0, 114.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 132.0, 120.0, 122.0, 129.0, 120.0, 117.0, 124.0, 134.0, 122.0], "value": 125.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 158.0, 168.0, 162.0, 162.0, 163.0, 165.0, 166.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 65.0, 62.0, 66.0, 63.0, 62.0, 61.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1495.5, "alertThreshold": 2.0}]} 10:24:19 INFO - Return code: 0 10:24:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:24:19 INFO - # TBPL SUCCESS # 10:24:19 INFO - Running post-action listener: _resource_record_post_action 10:24:19 INFO - ##### 10:24:19 INFO - ##### Finished run-tests step (success) 10:24:19 INFO - ##### 10:24:19 INFO - Running post-run listener: _resource_record_post_run 10:24:19 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 551219200; Read time: 0; Write time: 1331716 10:24:19 INFO - TinderboxPrint: CPU usage
13.2% 10:24:19 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:24:19 INFO - TinderboxPrint: I/O write bytes / time
551,219,200 / 1,331,716 10:24:19 INFO - TinderboxPrint: CPU idle
8,285.0 (86.7%) 10:24:19 INFO - TinderboxPrint: CPU user
1,207.8 (12.6%) 10:24:19 INFO - TinderboxPrint: Swap in / out
0 / 0 10:24:19 INFO - install - Wall time: 17s; CPU: 19.0%; Read bytes: 0; Write bytes: 256020480; Read time: 0; Write time: 875612 10:24:19 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 294612992; Read time: 0; Write time: 456072 10:24:19 INFO - Running post-run listener: _upload_blobber_files 10:24:19 INFO - Blob upload gear active. 10:24:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:24:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:24:20 INFO - (blobuploader) - INFO - Open directory for files ... 10:24:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:24:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:24:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:23 INFO - (blobuploader) - INFO - Done attempting. 10:24:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:24:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:24:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:24 INFO - (blobuploader) - INFO - Done attempting. 10:24:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:24:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:24:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:25 INFO - (blobuploader) - INFO - Done attempting. 10:24:25 INFO - (blobuploader) - INFO - Iteration through files over. 10:24:25 INFO - Return code: 0 10:24:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:24:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:24:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78480dfbaf8326f2b49c3f667f383d1cf473bedaf4aa7b219cec5ff11f755f18a73ce624c7f79417361d8d040d4053e6c3bed0fdf25587841bd53a209fee57a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9422798b8ecbe3b9304f013461419424273e7677c51034b872c645849b2b7b6a3bf528687a72ea11723f7652c4bd7a969e536f27552bb06e14641b3e24e11504", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1171d06681c8ff0f0645a1fba75ecac52a3bacd9e2894ecaf4aa92ac41c359c74e28e6b99f0a775d31eaa5721521ee1a4779904b9d87159289e5ac09df5a6384"} 10:24:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:24:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:24:25 INFO - Contents: 10:24:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78480dfbaf8326f2b49c3f667f383d1cf473bedaf4aa7b219cec5ff11f755f18a73ce624c7f79417361d8d040d4053e6c3bed0fdf25587841bd53a209fee57a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9422798b8ecbe3b9304f013461419424273e7677c51034b872c645849b2b7b6a3bf528687a72ea11723f7652c4bd7a969e536f27552bb06e14641b3e24e11504", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1171d06681c8ff0f0645a1fba75ecac52a3bacd9e2894ecaf4aa92ac41c359c74e28e6b99f0a775d31eaa5721521ee1a4779904b9d87159289e5ac09df5a6384"} 10:24:25 INFO - Running post-run listener: copy_logs_to_upload_dir 10:24:25 INFO - Copying logs to upload dir... 10:24:25 INFO - mkdir: /builds/slave/test/build/upload/logs 10:24:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.487048 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-20 10:24:25.496928) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 10:24:25.500945) ========= 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=745a4373a2a16df560f216e000000264-1466441849.842299-1066716371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78480dfbaf8326f2b49c3f667f383d1cf473bedaf4aa7b219cec5ff11f755f18a73ce624c7f79417361d8d040d4053e6c3bed0fdf25587841bd53a209fee57a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9422798b8ecbe3b9304f013461419424273e7677c51034b872c645849b2b7b6a3bf528687a72ea11723f7652c4bd7a969e536f27552bb06e14641b3e24e11504", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1171d06681c8ff0f0645a1fba75ecac52a3bacd9e2894ecaf4aa92ac41c359c74e28e6b99f0a775d31eaa5721521ee1a4779904b9d87159289e5ac09df5a6384"} build_url:https://queue.taskcluster.net/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011221 build_url: 'https://queue.taskcluster.net/v1/task/VWDyxN4qSkqQf8mZce8IsA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78480dfbaf8326f2b49c3f667f383d1cf473bedaf4aa7b219cec5ff11f755f18a73ce624c7f79417361d8d040d4053e6c3bed0fdf25587841bd53a209fee57a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9422798b8ecbe3b9304f013461419424273e7677c51034b872c645849b2b7b6a3bf528687a72ea11723f7652c4bd7a969e536f27552bb06e14641b3e24e11504", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1171d06681c8ff0f0645a1fba75ecac52a3bacd9e2894ecaf4aa92ac41c359c74e28e6b99f0a775d31eaa5721521ee1a4779904b9d87159289e5ac09df5a6384"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 10:24:25.526419) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 10:24:25.526973) ========= 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=745a4373a2a16df560f216e000000264-1466441849.842299-1066716371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 10:24:25.609310) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 10:24:25.609631) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 10:24:25.609925) ========= ========= Total master_lag: 0.18 =========