builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1466773167.41 results: success (0) buildid: 20160624030212 builduid: e1e27e42a3aa4aa488423fb62e197b16 revision: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 05:59:27.409867) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 05:59:27.410685) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 05:59:27.411169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 05:59:27.426642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:59:27.426969) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 05:59:27-- 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% 220M=0s 2016-06-24 05:59:27 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118403 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:59:27.562801) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:59:27.563186) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019525 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:59:27.612941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:59:27.613335) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 939ecc4e9d055c263633cbe276bfb634a68fe4c5 --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 939ecc4e9d055c263633cbe276bfb634a68fe4c5 --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=a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 05:59:28,025 truncating revision to first 12 chars 2016-06-24 05:59:28,025 Setting DEBUG logging. 2016-06-24 05:59:28,025 attempt 1/10 2016-06-24 05:59:28,025 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/939ecc4e9d05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 05:59:28,317 unpacking tar archive at: mozilla-central-939ecc4e9d05/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633883 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:59:28.264321) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 05:59:28.264895) ========= script_repo_revision: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 05:59:28.265715) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 05:59:28.266294) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 05:59:28.277956) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-24 05:59:28.278306) ========= /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=a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:59:28 INFO - MultiFileLogger online at 20160624 05:59:28 in /builds/slave/test 05:59:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:59:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:59:28 INFO - {'append_to_log': False, 05:59:28 INFO - 'base_work_dir': '/builds/slave/test', 05:59:28 INFO - 'blob_upload_branch': 'Firefox', 05:59:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:59:28 INFO - 'branch': 'Firefox', 05:59:28 INFO - 'buildbot_json_path': 'buildprops.json', 05:59:28 INFO - 'config_files': ('talos/linux_config.py',), 05:59:28 INFO - 'default_actions': ('clobber', 05:59:28 INFO - 'read-buildbot-config', 05:59:28 INFO - 'download-and-extract', 05:59:28 INFO - 'populate-webroot', 05:59:28 INFO - 'create-virtualenv', 05:59:28 INFO - 'install', 05:59:28 INFO - 'run-tests'), 05:59:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:59:28 INFO - 'download_minidump_stackwalk': True, 05:59:28 INFO - 'download_symbols': 'ondemand', 05:59:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:59:28 INFO - 'tooltool.py': '/tools/tooltool.py', 05:59:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:59:28 INFO - '/tools/misc-python/virtualenv.py')}, 05:59:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:59:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:59:28 INFO - 'installer_path': 'installer.exe', 05:59:28 INFO - 'log_level': 'info', 05:59:28 INFO - 'log_name': 'talos', 05:59:28 INFO - 'log_to_console': True, 05:59:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:59:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:59:28 INFO - 'opt_config_files': (), 05:59:28 INFO - 'pip_index': False, 05:59:28 INFO - 'sps_profile': False, 05:59:28 INFO - 'sps_profile_interval': 0, 05:59:28 INFO - 'suite': 'dromaeojs', 05:59:28 INFO - 'system_bits': '32', 05:59:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:59:28 INFO - 'title': 'talos-linux64-ix-002', 05:59:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:59:28 INFO - 'use_talos_json': True, 05:59:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:59:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:59:28 INFO - 'work_dir': 'build'} 05:59:28 INFO - ##### 05:59:28 INFO - ##### Running clobber step. 05:59:28 INFO - ##### 05:59:28 INFO - Running pre-action listener: _resource_record_pre_action 05:59:28 INFO - Running main action method: clobber 05:59:28 INFO - rmtree: /builds/slave/test/build 05:59:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:59:29 INFO - Running post-action listener: _resource_record_post_action 05:59:29 INFO - ##### 05:59:29 INFO - ##### Finished clobber step (success) 05:59:29 INFO - ##### 05:59:29 INFO - ##### 05:59:29 INFO - ##### Running read-buildbot-config step. 05:59:29 INFO - ##### 05:59:29 INFO - Running pre-action listener: _resource_record_pre_action 05:59:29 INFO - Running main action method: read_buildbot_config 05:59:29 INFO - Using buildbot properties: 05:59:29 INFO - { 05:59:29 INFO - "project": "", 05:59:29 INFO - "product": "firefox", 05:59:29 INFO - "script_repo_revision": "production", 05:59:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:59:29 INFO - "repository": "", 05:59:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:59:29 INFO - "buildid": "20160624030212", 05:59:29 INFO - "stage_platform": "linux64-pgo", 05:59:29 INFO - "basedir": "/builds/slave/test", 05:59:29 INFO - "nightly_build": "True", 05:59:29 INFO - "buildnumber": 789, 05:59:29 INFO - "slavename": "talos-linux64-ix-002", 05:59:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:59:29 INFO - "platform": "ubuntu64_hw", 05:59:29 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:59:29 INFO - "branch": "mozilla-central", 05:59:29 INFO - "repo_path": "mozilla-central", 05:59:29 INFO - "revision": "939ecc4e9d055c263633cbe276bfb634a68fe4c5", 05:59:29 INFO - "pgo_build": "True", 05:59:29 INFO - "builduid": "e1e27e42a3aa4aa488423fb62e197b16", 05:59:29 INFO - "slavebuilddir": "test" 05:59:29 INFO - } 05:59:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:59:29 INFO - Running post-action listener: _resource_record_post_action 05:59:29 INFO - ##### 05:59:29 INFO - ##### Finished read-buildbot-config step (success) 05:59:29 INFO - ##### 05:59:29 INFO - ##### 05:59:29 INFO - ##### Running download-and-extract step. 05:59:29 INFO - ##### 05:59:29 INFO - Running pre-action listener: _resource_record_pre_action 05:59:29 INFO - Running main action method: download_and_extract 05:59:29 INFO - mkdir: /builds/slave/test/build/tests 05:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:29 INFO - https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:59:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:59:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:59:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:59:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:59:29 INFO - Downloaded 1361 bytes. 05:59:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:59:29 INFO - Using the following test package requirements: 05:59:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:59:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:59:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:59:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:29 INFO - u'jsshell-linux-x86_64.zip'], 05:59:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:59:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:59:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:59:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:59:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:59:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:59:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:29 INFO - https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:59:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:59:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:59:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:59:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:59:30 INFO - Downloaded 24277161 bytes. 05:59:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:59:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:59:32 INFO - Return code: 0 05:59:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:32 INFO - https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:59:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:59:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:59:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:59:33 INFO - Downloaded 24277161 bytes. 05:59:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:59:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:59:34 INFO - Return code: 0 05:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:34 INFO - https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:59:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:59:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:59:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:59:35 INFO - Downloaded 14405518 bytes. 05:59:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:59:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:59:35 INFO - Return code: 0 05:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:35 INFO - https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:59:37 INFO - Downloaded 60154910 bytes. 05:59:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:59:37 INFO - mkdir: /builds/slave/test/properties 05:59:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:59:37 INFO - Writing to file /builds/slave/test/properties/build_url 05:59:37 INFO - Contents: 05:59:37 INFO - build_url:https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:59:38 INFO - Running post-action listener: _resource_record_post_action 05:59:38 INFO - Running post-action listener: set_extra_try_arguments 05:59:38 INFO - ##### 05:59:38 INFO - ##### Finished download-and-extract step (success) 05:59:38 INFO - ##### 05:59:38 INFO - ##### 05:59:38 INFO - ##### Running populate-webroot step. 05:59:38 INFO - ##### 05:59:38 INFO - Running pre-action listener: _resource_record_pre_action 05:59:38 INFO - Running main action method: populate_webroot 05:59:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:59:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:59:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:59:38 INFO - '--tppagecycles', 05:59:38 INFO - '7'], 05:59:38 INFO - 'tests': ['tsvgm']}}, 05:59:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:59:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:59:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:59:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:59:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:59:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:59:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'talos_options': ['--disable-e10s'], 05:59:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'talos_options': ['--disable-e10s'], 05:59:38 INFO - 'tests': ['damp', 'tps']}, 05:59:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'tests': ['damp', 'tps']}, 05:59:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:59:38 INFO - 'tests': ['dromaeo_dom']}, 05:59:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:59:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:59:38 INFO - 'tests': ['basic_compositor_video']}, 05:59:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:59:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:59:38 INFO - 'tests': ['a11yr', 05:59:38 INFO - 'ts_paint', 05:59:38 INFO - 'tpaint', 05:59:38 INFO - 'sessionrestore', 05:59:38 INFO - 'sessionrestore_no_auto_restore', 05:59:38 INFO - 'tabpaint']}, 05:59:38 INFO - 'other-e10s': {'tests': ['a11yr', 05:59:38 INFO - 'ts_paint', 05:59:38 INFO - 'tpaint', 05:59:38 INFO - 'sessionrestore', 05:59:38 INFO - 'sessionrestore_no_auto_restore', 05:59:38 INFO - 'tabpaint']}, 05:59:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:59:38 INFO - 'ts_paint', 05:59:38 INFO - 'tpaint', 05:59:38 INFO - 'sessionrestore', 05:59:38 INFO - 'sessionrestore_no_auto_restore', 05:59:38 INFO - 'tabpaint']}, 05:59:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:59:38 INFO - 'ts_paint', 05:59:38 INFO - 'tpaint', 05:59:38 INFO - 'sessionrestore', 05:59:38 INFO - 'sessionrestore_no_auto_restore', 05:59:38 INFO - 'tabpaint']}, 05:59:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:59:38 INFO - 'tests': ['a11yr', 05:59:38 INFO - 'ts_paint', 05:59:38 INFO - 'tpaint', 05:59:38 INFO - 'sessionrestore', 05:59:38 INFO - 'sessionrestore_no_auto_restore', 05:59:38 INFO - 'tabpaint']}, 05:59:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:59:38 INFO - 'tests': ['a11yr', 05:59:38 INFO - 'ts_paint', 05:59:38 INFO - 'tpaint', 05:59:38 INFO - 'sessionrestore', 05:59:38 INFO - 'sessionrestore_no_auto_restore', 05:59:38 INFO - 'tabpaint']}, 05:59:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:59:38 INFO - 'tests': ['tsvgx', 05:59:38 INFO - 'tsvgr_opacity', 05:59:38 INFO - 'tart', 05:59:38 INFO - 'tscrollx', 05:59:38 INFO - 'cart']}, 05:59:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:59:38 INFO - 'tsvgr_opacity', 05:59:38 INFO - 'tart', 05:59:38 INFO - 'tscrollx', 05:59:38 INFO - 'cart']}, 05:59:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'talos_options': ['--disable-e10s'], 05:59:38 INFO - 'tests': ['tp5o']}, 05:59:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'tests': ['tp5o']}, 05:59:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'talos_options': ['--disable-e10s', 05:59:38 INFO - '--xperf_path', 05:59:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:38 INFO - 'tests': ['tp5n']}, 05:59:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:38 INFO - 'talos_options': ['--xperf_path', 05:59:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:38 INFO - 'tests': ['tp5n']}}, 05:59:38 INFO - 'talos.zip': {'path': '', 05:59:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:59:38 INFO - Running post-action listener: _resource_record_post_action 05:59:38 INFO - ##### 05:59:38 INFO - ##### Finished populate-webroot step (success) 05:59:38 INFO - ##### 05:59:38 INFO - ##### 05:59:38 INFO - ##### Running create-virtualenv step. 05:59:38 INFO - ##### 05:59:38 INFO - Running pre-action listener: _resource_record_pre_action 05:59:38 INFO - Running main action method: create_virtualenv 05:59:38 INFO - Creating virtualenv /builds/slave/test/build/venv 05:59:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:59:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:59:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:59:38 INFO - Using real prefix '/usr' 05:59:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:59:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:59:40 INFO - Installing pip.................done. 05:59:40 INFO - Return code: 0 05:59:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:59: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')]} 05:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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')]} 05:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee786b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd010>, '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 0x22bdef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22be3a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:59:40 INFO - Using env: {'DISPLAY': ':0', 05:59:40 INFO - 'HOME': '/home/cltbld', 05:59:40 INFO - 'LANG': 'en_US.UTF-8', 05:59:40 INFO - 'LANGUAGE': 'en_US:en', 05:59:40 INFO - 'LOGNAME': 'cltbld', 05:59:40 INFO - 'MAIL': '/var/mail/cltbld', 05:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:40 INFO - 'MOZ_NO_REMOTE': '1', 05:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:40 INFO - 'NO_EM_RESTART': '1', 05:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:40 INFO - 'PWD': '/builds/slave/test', 05:59:40 INFO - 'SHELL': '/bin/bash', 05:59:40 INFO - 'SHLVL': '1', 05:59:40 INFO - 'TERM': 'linux', 05:59:40 INFO - 'TMOUT': '86400', 05:59:40 INFO - 'USER': 'cltbld', 05:59:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 05:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:40 INFO - '_': '/tools/buildbot/bin/python'} 05:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:59:40 INFO - Cleaning up... 05:59:40 INFO - Return code: 0 05:59:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:59: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')]} 05:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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')]} 05:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fee786b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd010>, '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 0x22bdef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22be3a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:59:40 INFO - Using env: {'DISPLAY': ':0', 05:59:40 INFO - 'HOME': '/home/cltbld', 05:59:40 INFO - 'LANG': 'en_US.UTF-8', 05:59:40 INFO - 'LANGUAGE': 'en_US:en', 05:59:40 INFO - 'LOGNAME': 'cltbld', 05:59:40 INFO - 'MAIL': '/var/mail/cltbld', 05:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:40 INFO - 'MOZ_NO_REMOTE': '1', 05:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:40 INFO - 'NO_EM_RESTART': '1', 05:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:40 INFO - 'PWD': '/builds/slave/test', 05:59:40 INFO - 'SHELL': '/bin/bash', 05:59:40 INFO - 'SHLVL': '1', 05:59:40 INFO - 'TERM': 'linux', 05:59:40 INFO - 'TMOUT': '86400', 05:59:40 INFO - 'USER': 'cltbld', 05:59:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 05:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:40 INFO - '_': '/tools/buildbot/bin/python'} 05:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:41 INFO - Downloading/unpacking psutil>=3.1.1 05:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:59:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:43 INFO - Installing collected packages: psutil 05:59:43 INFO - Running setup.py install for psutil 05:59:43 INFO - building 'psutil._psutil_linux' extension 05:59:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:59:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:59:43 INFO - building 'psutil._psutil_posix' extension 05:59:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:59:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:59:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:43 INFO - Successfully installed psutil 05:59:43 INFO - Cleaning up... 05:59:43 INFO - Return code: 0 05:59:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee786b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd010>, '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 0x22bdef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22be3a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:59:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:59:43 INFO - Using env: {'DISPLAY': ':0', 05:59:43 INFO - 'HOME': '/home/cltbld', 05:59:43 INFO - 'LANG': 'en_US.UTF-8', 05:59:43 INFO - 'LANGUAGE': 'en_US:en', 05:59:43 INFO - 'LOGNAME': 'cltbld', 05:59:43 INFO - 'MAIL': '/var/mail/cltbld', 05:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:43 INFO - 'MOZ_NO_REMOTE': '1', 05:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:43 INFO - 'NO_EM_RESTART': '1', 05:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:43 INFO - 'PWD': '/builds/slave/test', 05:59:43 INFO - 'SHELL': '/bin/bash', 05:59:43 INFO - 'SHLVL': '1', 05:59:43 INFO - 'TERM': 'linux', 05:59:43 INFO - 'TMOUT': '86400', 05:59:43 INFO - 'USER': 'cltbld', 05:59:43 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 05:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:43 INFO - '_': '/tools/buildbot/bin/python'} 05:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:59:45 INFO - Installing collected packages: mozsystemmonitor 05:59:45 INFO - Running setup.py install for mozsystemmonitor 05:59:45 INFO - Successfully installed mozsystemmonitor 05:59:45 INFO - Cleaning up... 05:59:45 INFO - Return code: 0 05:59:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:45 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 0x7fee786b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd010>, '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 0x22bdef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22be3a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:59:45 INFO - Using env: {'DISPLAY': ':0', 05:59:45 INFO - 'HOME': '/home/cltbld', 05:59:45 INFO - 'LANG': 'en_US.UTF-8', 05:59:45 INFO - 'LANGUAGE': 'en_US:en', 05:59:45 INFO - 'LOGNAME': 'cltbld', 05:59:45 INFO - 'MAIL': '/var/mail/cltbld', 05:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:45 INFO - 'MOZ_NO_REMOTE': '1', 05:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:45 INFO - 'NO_EM_RESTART': '1', 05:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:45 INFO - 'PWD': '/builds/slave/test', 05:59:45 INFO - 'SHELL': '/bin/bash', 05:59:45 INFO - 'SHLVL': '1', 05:59:45 INFO - 'TERM': 'linux', 05:59:45 INFO - 'TMOUT': '86400', 05:59:45 INFO - 'USER': 'cltbld', 05:59:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 05:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:45 INFO - '_': '/tools/buildbot/bin/python'} 05:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:46 INFO - Downloading/unpacking jsonschema==2.5.1 05:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:59:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:59:48 INFO - warning: no files found matching '*.txt' 05:59:48 INFO - no previously-included directories found matching 'build' 05:59:48 INFO - no previously-included directories found matching 'dist' 05:59:48 INFO - no previously-included directories found matching '.git*' 05:59:48 INFO - Installing collected packages: jsonschema, functools32 05:59:48 INFO - Running setup.py install for functools32 05:59:48 INFO - warning: no files found matching '*.txt' 05:59:48 INFO - no previously-included directories found matching 'build' 05:59:48 INFO - no previously-included directories found matching 'dist' 05:59:48 INFO - no previously-included directories found matching '.git*' 05:59:48 INFO - Successfully installed jsonschema functools32 05:59:48 INFO - Cleaning up... 05:59:48 INFO - Return code: 0 05:59:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:48 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 0x7fee786b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd010>, '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 0x22bdef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22be3a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:59:48 INFO - Using env: {'DISPLAY': ':0', 05:59:48 INFO - 'HOME': '/home/cltbld', 05:59:48 INFO - 'LANG': 'en_US.UTF-8', 05:59:48 INFO - 'LANGUAGE': 'en_US:en', 05:59:48 INFO - 'LOGNAME': 'cltbld', 05:59:48 INFO - 'MAIL': '/var/mail/cltbld', 05:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:48 INFO - 'MOZ_NO_REMOTE': '1', 05:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:48 INFO - 'NO_EM_RESTART': '1', 05:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:48 INFO - 'PWD': '/builds/slave/test', 05:59:48 INFO - 'SHELL': '/bin/bash', 05:59:48 INFO - 'SHLVL': '1', 05:59:48 INFO - 'TERM': 'linux', 05:59:48 INFO - 'TMOUT': '86400', 05:59:48 INFO - 'USER': 'cltbld', 05:59:48 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 05:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:48 INFO - '_': '/tools/buildbot/bin/python'} 05:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:50 INFO - Downloading blobuploader-1.2.4.tar.gz 05:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:59:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:59:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:51 INFO - Downloading docopt-0.6.1.tar.gz 05:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:59:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:59:51 INFO - Running setup.py install for blobuploader 05:59:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:59:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:59:51 INFO - Running setup.py install for requests 05:59:51 INFO - Running setup.py install for docopt 05:59:51 INFO - Successfully installed blobuploader requests docopt 05:59:51 INFO - Cleaning up... 05:59:51 INFO - Return code: 0 05:59:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:51 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 0x7fee786b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd010>, '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 0x22bdef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22be3a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:59:51 INFO - Using env: {'DISPLAY': ':0', 05:59:51 INFO - 'HOME': '/home/cltbld', 05:59:51 INFO - 'LANG': 'en_US.UTF-8', 05:59:51 INFO - 'LANGUAGE': 'en_US:en', 05:59:51 INFO - 'LOGNAME': 'cltbld', 05:59:51 INFO - 'MAIL': '/var/mail/cltbld', 05:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:51 INFO - 'MOZ_NO_REMOTE': '1', 05:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:51 INFO - 'NO_EM_RESTART': '1', 05:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:51 INFO - 'PWD': '/builds/slave/test', 05:59:51 INFO - 'SHELL': '/bin/bash', 05:59:51 INFO - 'SHLVL': '1', 05:59:51 INFO - 'TERM': 'linux', 05:59:51 INFO - 'TMOUT': '86400', 05:59:51 INFO - 'USER': 'cltbld', 05:59:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 05:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:51 INFO - '_': '/tools/buildbot/bin/python'} 05:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:52 INFO - Running setup.py (path:/tmp/pip-O6H9iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:52 INFO - Running setup.py (path:/tmp/pip-aimrbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:52 INFO - Running setup.py (path:/tmp/pip-bjSoZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:52 INFO - Running setup.py (path:/tmp/pip-XkZ8bQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:52 INFO - Running setup.py (path:/tmp/pip-1OAuYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:52 INFO - Running setup.py (path:/tmp/pip-ex8DDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:52 INFO - Running setup.py (path:/tmp/pip-Iie39n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:52 INFO - Running setup.py (path:/tmp/pip-pF4NYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:52 INFO - Running setup.py (path:/tmp/pip-rrgFLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:52 INFO - Running setup.py (path:/tmp/pip-zCE0fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:52 INFO - Running setup.py (path:/tmp/pip-2P1TjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:52 INFO - Running setup.py (path:/tmp/pip-kAQEDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:53 INFO - Running setup.py (path:/tmp/pip-sxPGr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:53 INFO - Running setup.py (path:/tmp/pip-R2TN1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:53 INFO - Running setup.py (path:/tmp/pip-kGMxyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:53 INFO - Running setup.py (path:/tmp/pip-RdmyrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:53 INFO - Running setup.py (path:/tmp/pip-OlbxrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:59:53 INFO - Running setup.py install for manifestparser 05:59:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:59:53 INFO - Running setup.py install for mozcrash 05:59:53 INFO - Running setup.py install for mozdebug 05:59:53 INFO - Running setup.py install for mozdevice 05:59:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:59:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:59:53 INFO - Running setup.py install for mozfile 05:59:53 INFO - Running setup.py install for mozhttpd 05:59:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:59:54 INFO - Running setup.py install for mozinfo 05:59:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:59:54 INFO - Running setup.py install for mozInstall 05:59:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:59:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:59:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:59:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:59:54 INFO - Running setup.py install for mozleak 05:59:54 INFO - Running setup.py install for mozlog 05:59:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:59:54 INFO - Running setup.py install for moznetwork 05:59:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:59:54 INFO - Running setup.py install for mozprocess 05:59:54 INFO - Running setup.py install for mozprofile 05:59:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:59:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:59:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:59:54 INFO - Running setup.py install for mozrunner 05:59:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:59:54 INFO - Running setup.py install for mozscreenshot 05:59:54 INFO - Running setup.py install for moztest 05:59:55 INFO - Running setup.py install for mozversion 05:59:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:59:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:59:55 INFO - Cleaning up... 05:59:55 INFO - Return code: 0 05:59:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:55 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 0x7fee786b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd010>, '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 0x22bdef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22be3a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:59:55 INFO - Using env: {'DISPLAY': ':0', 05:59:55 INFO - 'HOME': '/home/cltbld', 05:59:55 INFO - 'LANG': 'en_US.UTF-8', 05:59:55 INFO - 'LANGUAGE': 'en_US:en', 05:59:55 INFO - 'LOGNAME': 'cltbld', 05:59:55 INFO - 'MAIL': '/var/mail/cltbld', 05:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:55 INFO - 'MOZ_NO_REMOTE': '1', 05:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:55 INFO - 'NO_EM_RESTART': '1', 05:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:55 INFO - 'PWD': '/builds/slave/test', 05:59:55 INFO - 'SHELL': '/bin/bash', 05:59:55 INFO - 'SHLVL': '1', 05:59:55 INFO - 'TERM': 'linux', 05:59:55 INFO - 'TMOUT': '86400', 05:59:55 INFO - 'USER': 'cltbld', 05:59:55 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 05:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:55 INFO - '_': '/tools/buildbot/bin/python'} 05:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:55 INFO - Running setup.py (path:/tmp/pip-TELg8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:55 INFO - Running setup.py (path:/tmp/pip-canOvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:55 INFO - Running setup.py (path:/tmp/pip-h3A0eU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:55 INFO - Running setup.py (path:/tmp/pip-h6AODq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:55 INFO - Running setup.py (path:/tmp/pip-xdgq3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:55 INFO - Running setup.py (path:/tmp/pip-OsB09K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:55 INFO - Running setup.py (path:/tmp/pip-qZsajY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:55 INFO - Running setup.py (path:/tmp/pip-Yv1I7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:55 INFO - Running setup.py (path:/tmp/pip-KKpjJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:56 INFO - Running setup.py (path:/tmp/pip-41QFVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:56 INFO - Running setup.py (path:/tmp/pip-KXiehh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:56 INFO - Running setup.py (path:/tmp/pip-3XFTGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:56 INFO - Running setup.py (path:/tmp/pip-tDd3UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:56 INFO - Running setup.py (path:/tmp/pip-lyV6yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:56 INFO - Running setup.py (path:/tmp/pip-Cz9LQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:56 INFO - Running setup.py (path:/tmp/pip-PkCmLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:56 INFO - Running setup.py (path:/tmp/pip-w_CJQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:59:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:58 INFO - Downloading blessings-1.6.tar.gz 05:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:59:58 INFO - Installing collected packages: blessings 05:59:58 INFO - Running setup.py install for blessings 05:59:58 INFO - Successfully installed blessings 05:59:58 INFO - Cleaning up... 05:59:58 INFO - Return code: 0 05:59:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:59:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:58 INFO - Reading from file tmpfile_stdout 05:59:58 INFO - Current package versions: 05:59:58 INFO - argparse == 1.2.1 05:59:58 INFO - blessings == 1.6 05:59:58 INFO - blobuploader == 1.2.4 05:59:58 INFO - docopt == 0.6.1 05:59:58 INFO - functools32 == 3.2.3-2 05:59:58 INFO - jsonschema == 2.5.1 05:59:58 INFO - manifestparser == 1.1 05:59:58 INFO - mozInstall == 1.12 05:59:58 INFO - mozcrash == 0.17 05:59:58 INFO - mozdebug == 0.1 05:59:58 INFO - mozdevice == 0.48 05:59:58 INFO - mozfile == 1.2 05:59:58 INFO - mozhttpd == 0.7 05:59:58 INFO - mozinfo == 0.9 05:59:58 INFO - mozleak == 0.1 05:59:58 INFO - mozlog == 3.2 05:59:58 INFO - moznetwork == 0.27 05:59:58 INFO - mozprocess == 0.22 05:59:58 INFO - mozprofile == 0.28 05:59:59 INFO - mozrunner == 6.11 05:59:59 INFO - mozscreenshot == 0.1 05:59:59 INFO - mozsystemmonitor == 0.3 05:59:59 INFO - moztest == 0.7 05:59:59 INFO - mozversion == 1.4 05:59:59 INFO - psutil == 3.1.1 05:59:59 INFO - requests == 1.2.3 05:59:59 INFO - wsgiref == 0.1.2 05:59:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:59 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 0x7fee786b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd010>, '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 0x22bdef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22be3a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:59:59 INFO - Using env: {'DISPLAY': ':0', 05:59:59 INFO - 'HOME': '/home/cltbld', 05:59:59 INFO - 'LANG': 'en_US.UTF-8', 05:59:59 INFO - 'LANGUAGE': 'en_US:en', 05:59:59 INFO - 'LOGNAME': 'cltbld', 05:59:59 INFO - 'MAIL': '/var/mail/cltbld', 05:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:59 INFO - 'MOZ_NO_REMOTE': '1', 05:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:59 INFO - 'NO_EM_RESTART': '1', 05:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:59 INFO - 'PWD': '/builds/slave/test', 05:59:59 INFO - 'SHELL': '/bin/bash', 05:59:59 INFO - 'SHLVL': '1', 05:59:59 INFO - 'TERM': 'linux', 05:59:59 INFO - 'TMOUT': '86400', 05:59:59 INFO - 'USER': 'cltbld', 05:59:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 05:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:59 INFO - '_': '/tools/buildbot/bin/python'} 05:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:59:59 INFO - Cleaning up... 05:59:59 INFO - Return code: 0 05:59:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee786b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd010>, '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 0x22bdef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22be3a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:59:59 INFO - Using env: {'DISPLAY': ':0', 05:59:59 INFO - 'HOME': '/home/cltbld', 05:59:59 INFO - 'LANG': 'en_US.UTF-8', 05:59:59 INFO - 'LANGUAGE': 'en_US:en', 05:59:59 INFO - 'LOGNAME': 'cltbld', 05:59:59 INFO - 'MAIL': '/var/mail/cltbld', 05:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:59 INFO - 'MOZ_NO_REMOTE': '1', 05:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:59 INFO - 'NO_EM_RESTART': '1', 05:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:59 INFO - 'PWD': '/builds/slave/test', 05:59:59 INFO - 'SHELL': '/bin/bash', 05:59:59 INFO - 'SHLVL': '1', 05:59:59 INFO - 'TERM': 'linux', 05:59:59 INFO - 'TMOUT': '86400', 05:59:59 INFO - 'USER': 'cltbld', 05:59:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 05:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:59 INFO - '_': '/tools/buildbot/bin/python'} 05:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:59:59 INFO - Cleaning up... 05:59:59 INFO - Return code: 0 05:59:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee786b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222df60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd010>, '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 0x22bdef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22be3a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:59:59 INFO - Using env: {'DISPLAY': ':0', 05:59:59 INFO - 'HOME': '/home/cltbld', 05:59:59 INFO - 'LANG': 'en_US.UTF-8', 05:59:59 INFO - 'LANGUAGE': 'en_US:en', 05:59:59 INFO - 'LOGNAME': 'cltbld', 05:59:59 INFO - 'MAIL': '/var/mail/cltbld', 05:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:59 INFO - 'MOZ_NO_REMOTE': '1', 05:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:59 INFO - 'NO_EM_RESTART': '1', 05:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:59 INFO - 'PWD': '/builds/slave/test', 05:59:59 INFO - 'SHELL': '/bin/bash', 05:59:59 INFO - 'SHLVL': '1', 05:59:59 INFO - 'TERM': 'linux', 05:59:59 INFO - 'TMOUT': '86400', 05:59:59 INFO - 'USER': 'cltbld', 05:59:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 05:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:59 INFO - '_': '/tools/buildbot/bin/python'} 05:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:59 INFO - Downloading/unpacking flake8 05:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:00:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:00:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:00:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:00:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:00:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:00:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:00:02 INFO - no previously-included directories found matching 'docs/_build' 06:00:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:00:02 INFO - Running setup.py install for pep8 06:00:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:00:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:00:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:00:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:00:02 INFO - no previously-included directories found matching 'docs/_build' 06:00:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:00:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:00:02 INFO - Cleaning up... 06:00:02 INFO - Return code: 0 06:00:02 INFO - Running post-action listener: _resource_record_post_action 06:00:02 INFO - Running post-action listener: _start_resource_monitoring 06:00:02 INFO - Starting resource monitoring. 06:00:02 INFO - ##### 06:00:02 INFO - ##### Finished create-virtualenv step (success) 06:00:02 INFO - ##### 06:00:02 INFO - ##### 06:00:02 INFO - ##### Running install step. 06:00:02 INFO - ##### 06:00:02 INFO - Running pre-action listener: _resource_record_pre_action 06:00:02 INFO - Running main action method: install 06:00:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:00:03 INFO - Reading from file tmpfile_stdout 06:00:03 INFO - Detecting whether we're running mozinstall >=1.0... 06:00:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:00:03 INFO - Reading from file tmpfile_stdout 06:00:03 INFO - Output received: 06:00:03 INFO - Usage: mozinstall [options] installer 06:00:03 INFO - Options: 06:00:03 INFO - -h, --help show this help message and exit 06:00:03 INFO - -d DEST, --destination=DEST 06:00:03 INFO - Directory to install application into. [default: 06:00:03 INFO - "/builds/slave/test"] 06:00:03 INFO - --app=APP Application being installed. [default: firefox] 06:00:03 INFO - mkdir: /builds/slave/test/build/application 06:00:03 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'] 06:00:03 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 06:00:20 INFO - Reading from file tmpfile_stdout 06:00:20 INFO - Output received: 06:00:20 INFO - /builds/slave/test/build/application/firefox/firefox 06:00:20 INFO - Running post-action listener: _resource_record_post_action 06:00:20 INFO - ##### 06:00:20 INFO - ##### Finished install step (success) 06:00:20 INFO - ##### 06:00:20 INFO - ##### 06:00:20 INFO - ##### Running run-tests step. 06:00:20 INFO - ##### 06:00:20 INFO - Running pre-action listener: _resource_record_pre_action 06:00:20 INFO - Running main action method: run_tests 06:00:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:00:20 INFO - Python 2.7.3 06:00:20 INFO - Return code: 0 06:00:20 INFO - grabbing minidump binary from tooltool 06:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:20 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 0x22bd010>, '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 0x22bdef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22be3a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:00:20 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 06:00:20 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 06:00:20 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 06:00:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:00:20 INFO - Return code: 0 06:00:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:00:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:00:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:00:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:00:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:00:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:00:21 INFO - Return code: 0 06:00:21 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/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 06:00:21 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/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 06:00:21 INFO - Using env: {'DISPLAY': ':0', 06:00:21 INFO - 'HOME': '/home/cltbld', 06:00:21 INFO - 'LANG': 'en_US.UTF-8', 06:00:21 INFO - 'LANGUAGE': 'en_US:en', 06:00:21 INFO - 'LOGNAME': 'cltbld', 06:00:21 INFO - 'MAIL': '/var/mail/cltbld', 06:00:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:00:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:21 INFO - 'MOZ_NO_REMOTE': '1', 06:00:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:21 INFO - 'NO_EM_RESTART': '1', 06:00:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:21 INFO - 'PWD': '/builds/slave/test', 06:00:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:00:21 INFO - 'SHELL': '/bin/bash', 06:00:21 INFO - 'SHLVL': '1', 06:00:21 INFO - 'TERM': 'linux', 06:00:21 INFO - 'TMOUT': '86400', 06:00:21 INFO - 'USER': 'cltbld', 06:00:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516', 06:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:21 INFO - '_': '/tools/buildbot/bin/python'} 06:00:21 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/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 06:00:21 INFO - mozversion application_buildid: 20160624030212 06:00:21 INFO - mozversion application_changeset: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 06:00:21 INFO - mozversion application_display_name: Nightly 06:00:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:00:21 INFO - mozversion application_name: Firefox 06:00:21 INFO - mozversion application_remotingname: firefox 06:00:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:00:21 INFO - mozversion application_vendor: Mozilla 06:00:21 INFO - mozversion application_version: 50.0a1 06:00:21 INFO - mozversion platform_buildid: 20160624030212 06:00:21 INFO - mozversion platform_changeset: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 06:00:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:00:21 INFO - mozversion platform_version: 50.0a1 06:00:21 INFO - using testdate: 1466773221 06:00:21 INFO - actual date: 1466773221 06:00:21 INFO - starting webserver on 'localhost:49158' 06:00:21 INFO - SUITE-START | Running 2 tests 06:00:21 INFO - TEST-START | dromaeo_css 06:00:21 INFO - operating with platform_type : linux_ 06:00:21 INFO - Initialising browser for dromaeo_css test... 06:00:21 INFO - TEST-INFO | started process 16336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ6VD5b/profile http://localhost:49158/getInfo.html) 06:00:25 INFO - PROCESS | 16336 | __metrics Screen width/height:1600/1200 06:00:25 INFO - PROCESS | 16336 | colorDepth:24 06:00:25 INFO - PROCESS | 16336 | Browser inner width/height: 1024/697 06:00:25 INFO - PROCESS | 16336 | __metrics 06:00:26 INFO - PROCESS | 16336 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:00:27 INFO - TEST-INFO | 16336: exit 0 06:00:27 INFO - Browser initialized. 06:00:27 INFO - Running cycle 1/1 for dromaeo_css test... 06:00:27 INFO - TEST-INFO | started process 16420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ6VD5b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:39 INFO - PROCESS | 16420 | RSS: Main: 173948928 06:00:39 INFO - PROCESS | 16420 | 06:01:31 INFO - PROCESS | 16420 | 1466773291096 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] 06:03:39 INFO - PROCESS | 16420 | Cycle 1(1): loaded http://localhost:49158/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49158/tests/dromaeo/cssquery-ext.html) 06:03:40 INFO - PROCESS | 16420 | RSS: Main: 266473472 06:03:40 INFO - PROCESS | 16420 | 06:06:42 INFO - PROCESS | 16420 | Cycle 1(1): loaded http://localhost:49158/tests/dromaeo/cssquery-ext.html (next: http://localhost:49158/tests/dromaeo/cssquery-jquery.html) 06:06:43 INFO - PROCESS | 16420 | RSS: Main: 260952064 06:06:43 INFO - PROCESS | 16420 | 06:09:45 INFO - PROCESS | 16420 | Cycle 1(1): loaded http://localhost:49158/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49158/tests/dromaeo/cssquery-mootools.html) 06:09:45 INFO - PROCESS | 16420 | RSS: Main: 266354688 06:09:45 INFO - PROCESS | 16420 | 06:12:47 INFO - PROCESS | 16420 | Cycle 1(1): loaded http://localhost:49158/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49158/tests/dromaeo/cssquery-prototype.html) 06:12:48 INFO - PROCESS | 16420 | RSS: Main: 253751296 06:12:48 INFO - PROCESS | 16420 | 06:15:51 INFO - PROCESS | 16420 | Cycle 1(1): loaded http://localhost:49158/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49158/tests/dromaeo/cssquery-yui.html) 06:15:51 INFO - PROCESS | 16420 | RSS: Main: 245329920 06:15:51 INFO - PROCESS | 16420 | 06:18:54 INFO - PROCESS | 16420 | Cycle 1(1): loaded http://localhost:49158/tests/dromaeo/cssquery-yui.html (next: http://localhost:49158/tests/dromaeo/cssquery-dojo.html) 06:18:54 INFO - PROCESS | 16420 | RSS: Main: 360898560 06:18:54 INFO - PROCESS | 16420 | 06:18:54 INFO - PROCESS | 16420 | __start_tp_report 06:18:54 INFO - PROCESS | 16420 | _x_x_mozilla_page_load 06:18:54 INFO - PROCESS | 16420 | _x_x_mozilla_page_load_details 06:18:54 INFO - PROCESS | 16420 | |i|pagename|runs| 06:18:54 INFO - PROCESS | 16420 | |0;dojo.html;3114.4238315911557;3131.0293808919237;3142.7642926780495;3165.034664427352;3192.329610781736;5292.576593872491;5407.729613519328;5446.2647542581735;5523.861903452421;5524.08852539331;5366.221897824813;5400.29796126503;5440.782368705257;5448.7548060337285;5451.48210919963;4847.103285892122;4851.22380419133;4927.77824997876;4944.134776414131;5130.769115389798;5034.345535080434;5081.923771143436;5088.745562721868;5094.31226784383;5106.540411362977;4840.201366774478;4912.36139301892;4930.408350997904;4996.825111121093;5001.874953126165;4953.331300274453;4985.476524964899;4986.127427700138;4995.900081998339;5035.521625445614;4856.951430485685;4876.097921884463;4882.170031094723;4898.828541001083;4934.062528119682;5293.338332708411;5365;5376.166694162411;5401.378841433247;5448.564114870801;5823.621464604787;5853.414658534155;5853.443922827325;5853.882922341572;5856.912146317809;5844.26946631671;5872.265966754156;5906.586538942276;5922.3485416604135;5926.644401335933;5249.973750131263;5341.412444631087;5381.838544843661;5389.461053894618;5455.972720136374;5922.7927022554;5933.970330148321;5940.762369505172;5947.881042379128;5949.167116603679;5458.208559758813;5700.116481945305;5705.62913410627;5709.74306156224;5711.3146422428745;5765.1640512125505;5819.301683797887;5828.912566311508;5851;5916.852078698067;5797.072468405035;5834.212381328466;5837.620554663933;5850.3272123705465;5864.266966629171;5600.159976003632;5775.393583673654;5792.478676919098;5854.7072646367515;5860.296764388216;4423.380726698265;4424.380586717862;4439.933400998988;4470.821167153277;4472.955270447319;3935.626115519078;3937.8031098444962;3947.1513624570857;3960.980195099006;3996.1008773025837;5297.125974214288;5357.464253574612;5359.598030147755;5482.259894914216;5544.390117087117;5717.342505611825;5758.913616295759;5794.768209271666;5797.188393624896;5849.912251316234;5394.811181608625;5401.216823560561;5401.918971215435;5417.756200970965;5445.646033007842;4985.277134815431;5005.124103281911;5020.234058842779;5046;5087.821926232564;6073;6081.239845019284;6082.2093127893095;6092.878142437126;6127.234095738033;5839.416058394127;5853.2976042875125;5853.473187413153;5854.356020837789;5860.326062502867;5900.911486327623;5916.733746981482;5954.880902381841;5992.2809262886985;6045.758169673164;5752.568557358299;5754.482096611325;5809.593328466966;5821.09772985188;5822.097574875901;5855.824325270249;5897.67562784051;5907.793227237026;5914.34942156371;5915.733791979285;5559.11054231321;5663.490285874291;5667.971660141673;5719.399463056319;5751;5698.088305871041;5698.458646428583;5706.942930570641;5713.914291285717;5728.54171666274;5492;5600.4959553640365;5610.326760788568;5611.5230205433;5619.719014049199;5708.457696518824;5746.741396637078;5756.683382414008;5820.796272130455;5829.47534721877;5650;5652.434756524479;5675.063614503726;5680.460356266148;5692.5730570208225 06:18:54 INFO - PROCESS | 16420 | |1;ext.html;630.8517498387879;636.176151883311;636.303247943502;641.9005054216598;650.6291413894081;30958;33901.83049084757;33929.32141357174;33935.15162120945;41868.79065604675;44761;44945.10109797802;45085.09829803402;45186;45222.547774522245;8802.955985220065;8960.462372257685;8963.910360896405;8965.686200982967;8972.147645973655;8850.645974161058;8931.77670558238;8945.73162805117;8949.507777072258;8951.73144805657;8911.68809091682;8953.59708813105;8962.73111806647;8962.775930601754;8966.372353935227;8851.203391694746;8914.554272286392;8921.197092261727;8927.419717718327;8934.910650893473;8785.516796576187;8841.248493877963;8847.159519845605;8850.911490885073;8853.911460885372;42542.78728606368;42919.14161716779;42932.570674293485;42980;42987.35518967218;3384.7461440392067;3443.466262729256;3509.8771542995873;3588.0132963435003;3661.2494438640015;32627.836860815543;33045;33156.33687326264;33309.6669033309;33935.49096763526;4130.091379896448;4153.439285696422;4168.749875007509;4184.769837658928;4230.830766769325;328833;329936.35031824926;330571;330648;331938;60188.69905650444;60813.391866081656;60897.39102609006;60901.39098609046;60908;55711;60903.39096609066;61301.38698613046;61825.38174618286;66116.33883661198;16780.496585102468;16796.076215808247;16871;16918.577035573962;16938.91530542364;10497.842532362021;12373.072019598387;12441.502339906483;12465.813012804816;12466.937665311616;18662.720059199124;18842.52893677669;18993.33523326677;19464.416067517715;19691.803081968996;7143.857122857514;7191.532550384209;7278.708851645981;7408.925910740932;7481.625918704043;949.5252373813094;1010.9848352274722;1031.03083101884;1061.193492945367;1124.960626378073;31135.59889804964;31501.684983149877;31550.36899262002;31835.638056142292;32003.839980800414;1071.1537885070863;1113.7438389170375;1140.9218288717082;1170.5551890281638;1179.4692388425242;16603.012466238477;16624.750628740578;16876.57808554796;16933.576660583585;17028.57428564271;501978;502829;505303;505648;508307;57594.7120264396;57969.13046304309;58049.41950580524;58055;58085.419145808846;1245.9688507787196;1310.4758096761373;1330.5210124355224;1351.331091109907;1387.1815628779068;31270;31438.528422074145;32152.35695286128;32576;33153.50269746004;49636.751816240685;49679.503204967485;50165;50170.749146254035;50214.74892625513;404571;409026;411407;411579;412940;24757.50484990326;44278.11443771171;44939.775301124595;45628.08743825038;46085.30872036989;46203.76898115488;46646.76676616595;46753.2987005202;50274.24588631246;51283.48716512787;42628.573714262464;42998.495052673;43154.136917260854;44004.33993490036;44069.559304406546;41746.791266043474;42364.576354237295;42876.35685464658;43312.78343608262;43512.564874352116;41695.58304416917;42051.57948420599;42815.78592107019;42895.7855210722;42925;36700.81649591735;38280.617193827704;38509.22981540298;38522;38875.416868746426;28256.43487130287;28691.569626455203;28714.712852871206;28944.42111157807;28967.5654865173 06:18:54 INFO - PROCESS | 16420 | |2;jquery.html;378.62137862137854;383.1016266854228;396.0968990701201;398.1916709080567;399.44876071021986;17049;19506.512337191576;19548.31580894669;19599.608007839834;19647.44583204183;17363.392281270157;18171.818281817177;18179.81820181798;19726.802731972675;20480;6153.815385538441;6249.968750156243;6435.549511534195;6498.350164983487;6582.17722784652;6314.494840412756;6326.49388048955;6344.080108384282;6383.2340119185765;6385.744570217185;6232.906506402385;6278.811635650915;6317.084022816689;6428.0357946308195;6432.42108210261;6425.293217746044;6430.839229019265;6444;6452.064450654652;6733.528652994292;6866.8626627467675;6911.7926462206215;6991.580505169655;6993.0908981832545;6999.475039372017;25031.749682503123;25794.742052579422;26330.6050409244;26381.472370552674;26544.336391590365;2379.8691071991034;2736.3569561153113;3238.6437491875877;3367.6295607483157;3393.3213357328386;14723.263836808117;14851.405943762236;15964.680706385807;16125.43560975372;16143.273552690158;2027.888466134362;2038.714579958807;2061.690746388039;2144.7962443567994;2168.24111560954;91994;94579.52710236405;97302;97900;99568.50215748875;17012.744808827876;17467.30130794754;17633.823661763476;17958.730619040725;18022.459326220236;31528.684713153034;31994;32295.838520807247;32364.190895227337;32379.352412951608;9469.857952130724;9520.952395237979;9656.517174141265;9781.16860066888;9975.800483990424;7948.443608947434;7977.7207797726805;8065.6370463329295;8140.715074972348;8291.917080829235;8957.4177678452;8973.28213742899;9070.909290907006;9088.636454541876;9206.98723140454;3452.3256220732924;3501.397097005484;3516.4725291206523;3520.2607452434763;3644.653757892996;860.2988564320059;970.7136394763562;990.1286867556504;1040.484959944832;1046.1682962045193;18629.81370186308;19079.427617171506;19448.319308824124;19456.319028834205;19649.214031438867;975.4196253229317;997.9351342162736;999.860019597257;1004.5077911823154;1004.7086344960026;10212.08091271789;10459.529321180566;10772.676819695422;10968.725781855517;11001.504932278067;505054;505601;513623;513851;516427;55685.721571391885;63995.68002160053;96561;97913.51043244738;100671.49664251631;972.2513664478312;985.8521221816785;988.5353883674661;1005.6027868991854;1007.9899201008043;17278.30886764515;17285.357891000334;17770.289188432318;17775.377861774778;17916.731249031014;39494.80252598719;39610.603893961845;40522.797386012884;40816.30612479484;42713.145737084466;56935.71532142479;59783.70108149605;60342.39657603368;60418.39581604128;61036;8670.566471676517;8742.256908162877;8823.294136469196;8920.687775927812;8941.061188575366;12336.198147120409;12698.873011270138;12731.363431828557;12877.678058048623;12997.285149316878;11184;11237.381943992832;11545.191836571696;11684.532618695497;11782.410879455821;11036.5033573491;11374.829377559508;11425;11509.884901150881;11896.22674526153;11501.252418592765;11943;11976.401179940794;12008.819867701817;12061.51753929868;8523.531205783742;8538.829223415622;8594.527300998256;8699.478031317887;8978.10218978097;10499.947500262755;10834.729131771768;11102.333859968428;11200.775984480428;11248.831267531157 06:18:54 INFO - PROCESS | 16420 | |3;mootools.html;1353.1880871477108;1492.7835463857737;1521.0569446942893;1641.2040160522145;1787.1064467766116;8562.229399354057;8854.291656667467;8939.41893776904;9175.449473031622;9191.816163676722;8890.688825891095;9092.499912504825;9099.363044586882;9107.59015844287;9120.133587309196;2105.1789801977243;2296.081567373056;2333.230034088755;2341.929742107731;2362.397588614901;2363.1728894886824;2372.466195106105;2375.1805627058725;2380.547695937766;2386.8090552755825;2363.5981883079917;2374.252110585169;2400.579898517761;2409.771071748181;2411.252511721372;2020.2222144474335;2224.24375712257;2303.3205204464725;2311.295055008222;2332.1720789119872;2385.487120269133;2386.4153282445736;2403.218953840009;2405.5549723301247;2409.3856066703056;9151.908480915172;9187.586558604879;9240.306976976686;9266.490343031131;9268.073192680746;5124.590032797368;5276.736163191825;5277.12927366984;5278.340207474066;5287.867803304948;3324.5896724874515;3447.913802154941;3529.6470352964757;3530.9293814123575;3583.6416358363954;1131.4682099413344;1144.8626164860186;1147.4205526209294;1200.8619008813923;1204.753025629744;12951.222926624432;12954.935225323814;12956.870431295754;12971.351432428435;12990.480380784757;4753.9762301188275;4825.894948810202;4869.220924652039;4873.610111191097;4890.804367825318;10839.078678312275;10892.727681807859;10911.890881091247;10919.563217471212;10926.344419334866;5223.347081614798;5306.628536002443;5307.41618421981;5309.044372013074;5309.283246761715;4285.550017248206;4712.24604063355;4816.109019831342;4830.468648448667;4918.8770280743265;3989.6808255340084;4022;4086.2644723949975;4124.731892427043;4139.254934111828;1190.6190019193948;1241.540629966918;1242.3601845049807;1247.5820600098887;1263.0274688489994;927.4759760735163;933.3466573398513;944.1172503708917;950.805084957582;971.8056388722284;5831.416858314219;5925.081612350093;6008.609440386361;6025.15647809307;6111.449969502766;426.52402801735604;429.07962420607623;437.51872939766;437.8401883312568;442.75427137938107;4023.597640235953;4055.8377664893073;4084.5098588169017;4097.508299004138;4102.897427564275;11238.606648767254;11533.538658453735;11605.187636865337;11626.360550169822;11686.298822070534;11436.656900293005;11474.254173478697;11499.482523286471;11515.078793696484;11525.596604118815;8023.197680232047;8441.95779021101;8534.87197692035;8540.530270835165;8558.657653693783;6180.737633280787;6369.617822930639;6375.808725738235;6390.9041364378645;6413.775517856852;10126.544305506122;10831.404272765074;10886.836697449702;10950.835737463785;10976.560937562728;10761.30051546647;10801.945990270313;11085.94457027742;11108.055815255793;11117.666470005914;8042.87935680977;8145.063317718538;8214.58927053633;8231.053428855519;8235.752927412188;8422.24199822019;8473.110323415953;8511.659533618586;8529.488230706178;8551.016633087274;7438.107427108782;7573.318401343906;7775.688972441039;7894.6842126314305;7963.362930965393;7444.702211911463;7451.2921272479025;7461.888071679038;7481;7827.6868925244635;6959.095317608679;6987.7204911802955;7002.859942801014;7004.334588214111;7005.6146911918295;4963.602911767122;4999.300097986357;5128.640995130305;5130.51260130287;5135.6918584885025;5005.549500544968;5094.617903657167;5146.228065790161;5163.173892177234;5207.973960130326 06:18:54 INFO - PROCESS | 16420 | |4;prototype.html;330.62143845297135;331.7180396662837;335.93113411750585;338.1394351375748;342.50166008457694;5219.973900130503;5249.317588713462;5258.237555554442;5282.392524859638;5300.469953004697;5168.586513078954;5208.921866172011;5218.32161818964;5229.875576750997;5240.794617238038;3963.84144634215;3968.7420317679403;4131.607497287753;4173.457450531442;4191.497020357546;4064.8577299794515;4070.3487442009286;4086.6117718816663;4098.774567398792;4149.128682976579;3884.39791832265;4079.2657321682086;4087.12126892718;4087.652549533293;4101.89248902796;3965.960340396588;4067.1052368479036;4133.338665813486;4141.565135660742;4162.023039056454;3634.94625536571;3661.5423072115987;3668.486411902309;3675.44868269759;3678.834452449646;5080.390353157608;5089.185730283137;5112.667676601009;5129.1280482317725;5159.174532074888;4557.860534866283;4706.3411122442885;4732.384789977281;4738.914877453909;4750.643701722384;5415.783368665248;5428.647137936022;5441.156620723794;5445;5447.618666693333;4029.2747305485;4043.2722110020186;4043.636072753466;4064.943114790176;4081.346984482498;5463.48096930791;5505.339359276913;5594.188842617838;5628.380878103405;5684.8294551163535;4119.629233369011;4138.420621113047;4145.098431098183;4179.477565304337;4183.3515805050265;4219.9578004220175;4222.3244280914905;4245.389085712265;4259.595338442843;4264.275073237557;4616.376789133491;4666.5533684557895;4733.964395310049;4739.2891066339635;4756.096341695136;5336.17289320156;5419.458054194628;5445.891082178334;5449.6730196188355;5466.6993315367245;1429.621150395146;1446.6455718349073;1447.5802017415042;1459.5767227503904;1462.8683418492174;950.353759443585;956.4118067388506;1009.2329829329616;1018.3889666200369;1028.5165971993151;5253.264542963988;5255.5532779713385;5284.894302113936;5288.444713305124;5306.442823503477;5544.722763861791;5570.888582228414;5596.4403559644525;5606.24315717373;5623.650323922229;5006.849794506171;5204;5232.973835130876;5243.161094224905;5293.602979776532;2932.941341173165;2962.762978961678;2962.762978961678;2965.3624470738896;2979.16781179573;5625.521830644359;5749.7700091996685;5787.276590426197;5797;5821.825345239649;5826.126081087871;5831.941680583224;5845.649261044351;5847.275053859122;5850.64896106235;5818.534517238526;5820.679862607597;5842.152887831241;5896.882062358729;5927.347991720907;5508.457631863084;5600.4959553640365;5605.859853503695;5648.152777083306;5736.168255602831;5540.307461567304;5583.972080139573;5588.189712491747;5601.439856014366;5636.2954630671165;5665.320161580472;5820.8649313383485;5828.184054232326;5856.180134781219;5870.383609720918;4020.7483809067016;4039.6970227232487;4047.190561887693;4056.249593825152;4063.2889244382704;5652.943470565242;5679.744411501575;5694.17434471991;5710.200571920018;5711.200431939615;5456.399796022355;5569.19246709233;5590.301212348457;5590.608657393944;5593.384727680033;5484.8354549363585;5512.586556008235;5513.09034009384;5514.448555144453;5547;5197.350331208599;5286.947130528645;5422.728863556886;5441.183822426509;5442.782288708566;5533.197686335539;5536.7231638417115;5537.667739935617;5555;5559.777608895599;5389.784408623611;5396.892062158813;5400.540954018952;5412.810551630674;5443.59173062014 06:18:54 INFO - PROCESS | 16420 | |5;yui.html;700.2682197104026;701.6772284749015;766.758471081609;820.5774026376415;848.2026894718964;15263;16798;16798.244079016444;16895.57761055971;16928.068956207404;13849.723005539909;13917;15537.300821463034;15596.532104036869;15614.141222232773;679.0628932073731;793.0443815202667;798.6725442568548;811.6428771340621;816.4978538198994;803.1406395157184;807.0315621254489;807.289585165054;807.4186585658316;807.8667019941703;869.0961400143843;869.4044579463057;869.4044579463057;870.0125357718971;873.8208667223204;708.8475977664775;829.0714399872181;848.8302339532119;858.7037472072125;860.7073594977707;622.862970146567;623.2676604989119;623.3921926121994;623.5728525959732;623.6133597169738;15368.154751488664;15378.769318460232;15387.461438849587;15424.151671658054;15431.074135551902;14390.856091439056;14622.634434139125;14628.561143165722;14812.407503699838;14839.92580037093;13020.934895325463;13099.41052652633;13099.672508187276;13352.065355425124;13409.854423292323;4556.200300881133;4627.768611569408;4644.187267228222;4657.347971284023;4677.158111539921;63489.68255158695;65369.346306536805;66115.33884661188;74938;76594.61702691506;11142.164337674707;11739.178257522062;11931.582394616147;12011.219270747373;12268.32524211177;20965.790342096385;20991.16035358599;21050.894745526482;21059.789402105784;21129.68305475419;8865.634114952038;9054.954725226464;9077.909220907839;9101.681441149529;9199.862002069975;4857;4874.512548745168;4968.503149685075;4973.204287314013;5021;3716.758410703296;3814.0464883779055;3818.6563209311294;3830.616938306147;4015.759054456742;729.4784229276094;733.1934871641258;736.2343163110305;743.7619961612232;765.7281665008953;627.1752645271454;629.3140476880222;704.0073496370094;705.6013352455846;733.2264460993596;9274.721758347261;9523.809523809485;9831;9924.950375248078;10010.899891000996;626.5707990026846;636.0745115856417;725.793148952546;741.4698490579261;767.5739964319745;4454.665900057508;4643;4752.7623618818925;4753.310769938409;4835.516448355136;104150.47924760479;109619.45190273998;112385;114416;114740.42629786965;92320;99853;102987;103437;104536;83478.58260708657;85736.14263857531;85779.5711021441;86832;87944;8861.64553417856;8885.955570222108;8907.643694252158;8976;9057.049009854134;49668;50373;50724;51155.74422128015;51276.826338632905;66498;66802;74626.43362646452;77071;77668.2233177661;11749.76500470003;11857.881421185677;11994.520219191134;12180.75638487243;12407.75184496287;13958.790618140532;14212;14332.528543595212;14483;14577.489787857374;11129;13464.865351346361;13652.453901844212;13922.443102275796;14056.437742490185;14066;14084.718305634035;14258;15064.698706026038;15268.465603703817;14104.153750774987;14118.576442706324;14446.349914253673;15030.624234394227;15042.02226855251;10988.230823842254;11191.32852028881;11476.475175461384;11484.483198255932;11731.23746956445;10713.196510261605;11539.5961141363;11544.81249378275;11564.94217528907;11668.299902005907 06:18:54 INFO - PROCESS | 16420 | __end_tp_report 06:18:54 INFO - PROCESS | 16420 | __start_cc_report 06:18:54 INFO - PROCESS | 16420 | _x_x_mozilla_cycle_collect,859 06:18:54 INFO - PROCESS | 16420 | __end_cc_report 06:18:54 INFO - PROCESS | 16420 | __startTimestamp1466774334631__endTimestamp 06:18:54 INFO - PROCESS | 16420 | 06:18:54 INFO - PROCESS | 16420 | ------- Summary: start ------- 06:18:54 INFO - PROCESS | 16420 | Number of tests: 6 06:18:54 INFO - PROCESS | 16420 | 06:18:54 INFO - PROCESS | 16420 | [#0] dojo.html Cycles:165 Average:5406.61 Median:5619.72 stddev:618.04 (11.0%) stddev-sans-first:593.20 06:18:54 INFO - PROCESS | 16420 | Values: 3114.4 3131.0 3142.8 3165.0 3192.3 5292.6 5407.7 5446.3 5523.9 5524.1 5366.2 5400.3 5440.8 5448.8 5451.5 4847.1 4851.2 4927.8 4944.1 5130.8 5034.3 5081.9 5088.7 5094.3 5106.5 4840.2 4912.4 4930.4 4996.8 5001.9 4953.3 4985.5 4986.1 4995.9 5035.5 4857.0 4876.1 4882.2 4898.8 4934.1 5293.3 5365.0 5376.2 5401.4 5448.6 5823.6 5853.4 5853.4 5853.9 5856.9 5844.3 5872.3 5906.6 5922.3 5926.6 5250.0 5341.4 5381.8 5389.5 5456.0 5922.8 5934.0 5940.8 5947.9 5949.2 5458.2 5700.1 5705.6 5709.7 5711.3 5765.2 5819.3 5828.9 5851.0 5916.9 5797.1 5834.2 5837.6 5850.3 5864.3 5600.2 5775.4 5792.5 5854.7 5860.3 4423.4 4424.4 4439.9 4470.8 4473.0 3935.6 3937.8 3947.2 3961.0 3996.1 5297.1 5357.5 5359.6 5482.3 5544.4 5717.3 5758.9 5794.8 5797.2 5849.9 5394.8 5401.2 5401.9 5417.8 5445.6 4985.3 5005.1 5020.2 5046.0 5087.8 6073.0 6081.2 6082.2 6092.9 6127.2 5839.4 5853.3 5853.5 5854.4 5860.3 5900.9 5916.7 5954.9 5992.3 6045.8 5752.6 5754.5 5809.6 5821.1 5822.1 5855.8 5897.7 5907.8 5914.3 5915.7 5559.1 5663.5 5668.0 5719.4 5751.0 5698.1 5698.5 5706.9 5713.9 5728.5 5492.0 5600.5 5610.3 5611.5 5619.7 5708.5 5746.7 5756.7 5820.8 5829.5 5650.0 5652.4 5675.1 5680.5 5692.6 06:18:54 INFO - PROCESS | 16420 | 06:18:54 INFO - PROCESS | 16420 | [#1] ext.html Cycles:180 Average:58558.88 Median:42722.18 stddev:111310.38 (260.5%) stddev-sans-first:111537.66 06:18:54 INFO - PROCESS | 16420 | Values: 630.9 636.2 636.3 641.9 650.6 30958.0 33901.8 33929.3 33935.2 41868.8 44761.0 44945.1 45085.1 45186.0 45222.5 8803.0 8960.5 8963.9 8965.7 8972.1 8850.6 8931.8 8945.7 8949.5 8951.7 8911.7 8953.6 8962.7 8962.8 8966.4 8851.2 8914.6 8921.2 8927.4 8934.9 8785.5 8841.2 8847.2 8850.9 8853.9 42542.8 42919.1 42932.6 42980.0 42987.4 3384.7 3443.5 3509.9 3588.0 3661.2 32627.8 33045.0 33156.3 33309.7 33935.5 4130.1 4153.4 4168.7 4184.8 4230.8 328833.0 329936.4 330571.0 330648.0 331938.0 60188.7 60813.4 60897.4 60901.4 60908.0 55711.0 60903.4 61301.4 61825.4 66116.3 16780.5 16796.1 16871.0 16918.6 16938.9 10497.8 12373.1 12441.5 12465.8 12466.9 18662.7 18842.5 18993.3 19464.4 19691.8 7143.9 7191.5 7278.7 7408.9 7481.6 949.5 1011.0 1031.0 1061.2 1125.0 31135.6 31501.7 31550.4 31835.6 32003.8 1071.2 1113.7 1140.9 1170.6 1179.5 16603.0 16624.8 16876.6 16933.6 17028.6 501978.0 502829.0 505303.0 505648.0 508307.0 57594.7 57969.1 58049.4 58055.0 58085.4 1246.0 1310.5 1330.5 1351.3 1387.2 31270.0 31438.5 32152.4 32576.0 33153.5 49636.8 49679.5 50165.0 50170.7 50214.7 404571.0 409026.0 411407.0 411579.0 412940.0 24757.5 44278.1 44939.8 45628.1 46085.3 46203.8 46646.8 46753.3 50274.2 51283.5 42628.6 42998.5 43154.1 44004.3 44069.6 41746.8 42364.6 42876.4 43312.8 43512.6 41695.6 42051.6 42815.8 42895.8 42925.0 36700.8 38280.6 38509.2 38522.0 38875.4 28256.4 28691.6 28714.7 28944.4 28967.6 06:18:54 INFO - PROCESS | 16420 | 06:18:54 INFO - PROCESS | 16420 | [#2] jquery.html Cycles:180 Average:30959.94 Median:3582.46 stddev:84129.72 (2348.4%) stddev-sans-first:84334.39 06:18:54 INFO - PROCESS | 16420 | Values: 378.6 383.1 396.1 398.2 399.4 17049.0 19506.5 19548.3 19599.6 19647.4 17363.4 18171.8 18179.8 19726.8 20480.0 6153.8 6250.0 6435.5 6498.4 6582.2 6314.5 6326.5 6344.1 6383.2 6385.7 6232.9 6278.8 6317.1 6428.0 6432.4 6425.3 6430.8 6444.0 6452.1 6733.5 6866.9 6911.8 6991.6 6993.1 6999.5 25031.7 25794.7 26330.6 26381.5 26544.3 2379.9 2736.4 3238.6 3367.6 3393.3 14723.3 14851.4 15964.7 16125.4 16143.3 2027.9 2038.7 2061.7 2144.8 2168.2 91994.0 94579.5 97302.0 97900.0 99568.5 17012.7 17467.3 17633.8 17958.7 18022.5 31528.7 31994.0 32295.8 32364.2 32379.4 9469.9 9521.0 9656.5 9781.2 9975.8 7948.4 7977.7 8065.6 8140.7 8291.9 8957.4 8973.3 9070.9 9088.6 9207.0 3452.3 3501.4 3516.5 3520.3 3644.7 860.3 970.7 990.1 1040.5 1046.2 18629.8 19079.4 19448.3 19456.3 19649.2 975.4 997.9 999.9 1004.5 1004.7 10212.1 10459.5 10772.7 10968.7 11001.5 505054.0 505601.0 513623.0 513851.0 516427.0 55685.7 63995.7 96561.0 97913.5 100671.5 972.3 985.9 988.5 1005.6 1008.0 17278.3 17285.4 17770.3 17775.4 17916.7 39494.8 39610.6 40522.8 40816.3 42713.1 56935.7 59783.7 60342.4 60418.4 61036.0 8670.6 8742.3 8823.3 8920.7 8941.1 12336.2 12698.9 12731.4 12877.7 12997.3 11184.0 11237.4 11545.2 11684.5 11782.4 11036.5 11374.8 11425.0 11509.9 11896.2 11501.3 11943.0 11976.4 12008.8 12061.5 8523.5 8538.8 8594.5 8699.5 8978.1 10499.9 10834.7 11102.3 11200.8 11248.8 06:18:54 INFO - PROCESS | 16420 | 06:18:54 INFO - PROCESS | 16420 | [#3] mootools.html Cycles:180 Average:5957.64 Median:2577.50 stddev:3512.08 (136.3%) stddev-sans-first:3504.88 06:18:54 INFO - PROCESS | 16420 | Values: 1353.2 1492.8 1521.1 1641.2 1787.1 8562.2 8854.3 8939.4 9175.4 9191.8 8890.7 9092.5 9099.4 9107.6 9120.1 2105.2 2296.1 2333.2 2341.9 2362.4 2363.2 2372.5 2375.2 2380.5 2386.8 2363.6 2374.3 2400.6 2409.8 2411.3 2020.2 2224.2 2303.3 2311.3 2332.2 2385.5 2386.4 2403.2 2405.6 2409.4 9151.9 9187.6 9240.3 9266.5 9268.1 5124.6 5276.7 5277.1 5278.3 5287.9 3324.6 3447.9 3529.6 3530.9 3583.6 1131.5 1144.9 1147.4 1200.9 1204.8 12951.2 12954.9 12956.9 12971.4 12990.5 4754.0 4825.9 4869.2 4873.6 4890.8 10839.1 10892.7 10911.9 10919.6 10926.3 5223.3 5306.6 5307.4 5309.0 5309.3 4285.6 4712.2 4816.1 4830.5 4918.9 3989.7 4022.0 4086.3 4124.7 4139.3 1190.6 1241.5 1242.4 1247.6 1263.0 927.5 933.3 944.1 950.8 971.8 5831.4 5925.1 6008.6 6025.2 6111.4 426.5 429.1 437.5 437.8 442.8 4023.6 4055.8 4084.5 4097.5 4102.9 11238.6 11533.5 11605.2 11626.4 11686.3 11436.7 11474.3 11499.5 11515.1 11525.6 8023.2 8442.0 8534.9 8540.5 8558.7 6180.7 6369.6 6375.8 6390.9 6413.8 10126.5 10831.4 10886.8 10950.8 10976.6 10761.3 10801.9 11085.9 11108.1 11117.7 8042.9 8145.1 8214.6 8231.1 8235.8 8422.2 8473.1 8511.7 8529.5 8551.0 7438.1 7573.3 7775.7 7894.7 7963.4 7444.7 7451.3 7461.9 7481.0 7827.7 6959.1 6987.7 7002.9 7004.3 7005.6 4963.6 4999.3 5128.6 5130.5 5135.7 5005.5 5094.6 5146.2 5163.2 5208.0 06:18:54 INFO - PROCESS | 16420 | 06:18:54 INFO - PROCESS | 16420 | [#4] prototype.html Cycles:180 Average:4645.96 Median:5254.41 stddev:1346.90 (25.6%) stddev-sans-first:1311.15 06:18:54 INFO - PROCESS | 16420 | Values: 330.6 331.7 335.9 338.1 342.5 5220.0 5249.3 5258.2 5282.4 5300.5 5168.6 5208.9 5218.3 5229.9 5240.8 3963.8 3968.7 4131.6 4173.5 4191.5 4064.9 4070.3 4086.6 4098.8 4149.1 3884.4 4079.3 4087.1 4087.7 4101.9 3966.0 4067.1 4133.3 4141.6 4162.0 3634.9 3661.5 3668.5 3675.4 3678.8 5080.4 5089.2 5112.7 5129.1 5159.2 4557.9 4706.3 4732.4 4738.9 4750.6 5415.8 5428.6 5441.2 5445.0 5447.6 4029.3 4043.3 4043.6 4064.9 4081.3 5463.5 5505.3 5594.2 5628.4 5684.8 4119.6 4138.4 4145.1 4179.5 4183.4 4220.0 4222.3 4245.4 4259.6 4264.3 4616.4 4666.6 4734.0 4739.3 4756.1 5336.2 5419.5 5445.9 5449.7 5466.7 1429.6 1446.6 1447.6 1459.6 1462.9 950.4 956.4 1009.2 1018.4 1028.5 5253.3 5255.6 5284.9 5288.4 5306.4 5544.7 5570.9 5596.4 5606.2 5623.7 5006.8 5204.0 5233.0 5243.2 5293.6 2932.9 2962.8 2962.8 2965.4 2979.2 5625.5 5749.8 5787.3 5797.0 5821.8 5826.1 5831.9 5845.6 5847.3 5850.6 5818.5 5820.7 5842.2 5896.9 5927.3 5508.5 5600.5 5605.9 5648.2 5736.2 5540.3 5584.0 5588.2 5601.4 5636.3 5665.3 5820.9 5828.2 5856.2 5870.4 4020.7 4039.7 4047.2 4056.2 4063.3 5652.9 5679.7 5694.2 5710.2 5711.2 5456.4 5569.2 5590.3 5590.6 5593.4 5484.8 5512.6 5513.1 5514.4 5547.0 5197.4 5286.9 5422.7 5441.2 5442.8 5533.2 5536.7 5537.7 5555.0 5559.8 5389.8 5396.9 5400.5 5412.8 5443.6 06:18:54 INFO - PROCESS | 16420 | 06:18:54 INFO - PROCESS | 16420 | [#5] yui.html Cycles:180 Average:20603.88 Median:4714.96 stddev:29209.26 (619.5%) stddev-sans-first:29252.96 06:18:54 INFO - PROCESS | 16420 | Values: 700.3 701.7 766.8 820.6 848.2 15263.0 16798.0 16798.2 16895.6 16928.1 13849.7 13917.0 15537.3 15596.5 15614.1 679.1 793.0 798.7 811.6 816.5 803.1 807.0 807.3 807.4 807.9 869.1 869.4 869.4 870.0 873.8 708.8 829.1 848.8 858.7 860.7 622.9 623.3 623.4 623.6 623.6 15368.2 15378.8 15387.5 15424.2 15431.1 14390.9 14622.6 14628.6 14812.4 14839.9 13020.9 13099.4 13099.7 13352.1 13409.9 4556.2 4627.8 4644.2 4657.3 4677.2 63489.7 65369.3 66115.3 74938.0 76594.6 11142.2 11739.2 11931.6 12011.2 12268.3 20965.8 20991.2 21050.9 21059.8 21129.7 8865.6 9055.0 9077.9 9101.7 9199.9 4857.0 4874.5 4968.5 4973.2 5021.0 3716.8 3814.0 3818.7 3830.6 4015.8 729.5 733.2 736.2 743.8 765.7 627.2 629.3 704.0 705.6 733.2 9274.7 9523.8 9831.0 9925.0 10010.9 626.6 636.1 725.8 741.5 767.6 4454.7 4643.0 4752.8 4753.3 4835.5 104150.5 109619.5 112385.0 114416.0 114740.4 92320.0 99853.0 102987.0 103437.0 104536.0 83478.6 85736.1 85779.6 86832.0 87944.0 8861.6 8886.0 8907.6 8976.0 9057.0 49668.0 50373.0 50724.0 51155.7 51276.8 66498.0 66802.0 74626.4 77071.0 77668.2 11749.8 11857.9 11994.5 12180.8 12407.8 13958.8 14212.0 14332.5 14483.0 14577.5 11129.0 13464.9 13652.5 13922.4 14056.4 14066.0 14084.7 14258.0 15064.7 15268.5 14104.2 14118.6 14446.3 15030.6 15042.0 10988.2 11191.3 11476.5 11484.5 11731.2 10713.2 11539.6 11544.8 11564.9 11668.3 06:18:54 INFO - PROCESS | 16420 | -------- Summary: end -------- 06:18:54 INFO - PROCESS | 16420 | 06:18:55 INFO - TEST-INFO | 16420: exit 0 06:18:55 INFO - TEST-OK | dromaeo_css | took 1113953ms 06:18:55 INFO - TEST-START | kraken 06:18:55 INFO - operating with platform_type : linux_ 06:18:55 INFO - Initialising browser for kraken test... 06:18:55 INFO - TEST-INFO | started process 16612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfCuhmT/profile http://localhost:49158/getInfo.html) 06:18:59 INFO - PROCESS | 16612 | __metrics Screen width/height:1600/1200 06:18:59 INFO - PROCESS | 16612 | colorDepth:24 06:18:59 INFO - PROCESS | 16612 | Browser inner width/height: 1024/697 06:18:59 INFO - PROCESS | 16612 | __metrics 06:19:00 INFO - PROCESS | 16612 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:19:01 INFO - TEST-INFO | 16612: exit 0 06:19:01 INFO - Browser initialized. 06:19:01 INFO - Running cycle 1/1 for kraken test... 06:19:01 INFO - TEST-INFO | started process 16691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfCuhmT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:13 INFO - PROCESS | 16691 | RSS: Main: 174063616 06:19:13 INFO - PROCESS | 16691 | 06:19:16 INFO - PROCESS | 16691 | Cycle 1(1): loaded http://localhost:49158/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49158/tests/kraken/driver.html?testName=audio-beat-detection) 06:19:16 INFO - PROCESS | 16691 | RSS: Main: 231948288 06:19:16 INFO - PROCESS | 16691 | 06:19:19 INFO - PROCESS | 16691 | Cycle 1(1): loaded http://localhost:49158/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49158/tests/kraken/driver.html?testName=audio-dft) 06:19:20 INFO - PROCESS | 16691 | RSS: Main: 217190400 06:19:20 INFO - PROCESS | 16691 | 06:19:23 INFO - PROCESS | 16691 | Cycle 1(1): loaded http://localhost:49158/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49158/tests/kraken/driver.html?testName=audio-fft) 06:19:23 INFO - PROCESS | 16691 | RSS: Main: 286728192 06:19:23 INFO - PROCESS | 16691 | 06:19:26 INFO - PROCESS | 16691 | Cycle 1(1): loaded http://localhost:49158/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49158/tests/kraken/driver.html?testName=audio-oscillator) 06:19:26 INFO - PROCESS | 16691 | RSS: Main: 196771840 06:19:26 INFO - PROCESS | 16691 | 06:19:28 INFO - PROCESS | 16691 | Cycle 1(1): loaded http://localhost:49158/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49158/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:19:29 INFO - PROCESS | 16691 | RSS: Main: 200953856 06:19:29 INFO - PROCESS | 16691 | 06:19:32 INFO - PROCESS | 16691 | Cycle 1(1): loaded http://localhost:49158/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49158/tests/kraken/driver.html?testName=imaging-darkroom) 06:19:33 INFO - PROCESS | 16691 | RSS: Main: 237027328 06:19:33 INFO - PROCESS | 16691 | 06:19:36 INFO - PROCESS | 16691 | Cycle 1(1): loaded http://localhost:49158/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49158/tests/kraken/driver.html?testName=imaging-desaturate) 06:19:37 INFO - PROCESS | 16691 | RSS: Main: 237424640 06:19:37 INFO - PROCESS | 16691 | 06:19:39 INFO - PROCESS | 16691 | Cycle 1(1): loaded http://localhost:49158/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49158/tests/kraken/driver.html?testName=json-parse-financial) 06:19:40 INFO - PROCESS | 16691 | RSS: Main: 237490176 06:19:40 INFO - PROCESS | 16691 | 06:19:42 INFO - PROCESS | 16691 | Cycle 1(1): loaded http://localhost:49158/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49158/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:19:42 INFO - PROCESS | 16691 | RSS: Main: 226050048 06:19:42 INFO - PROCESS | 16691 | 06:19:44 INFO - PROCESS | 16691 | Cycle 1(1): loaded http://localhost:49158/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49158/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:19:45 INFO - PROCESS | 16691 | RSS: Main: 231264256 06:19:45 INFO - PROCESS | 16691 | 06:19:47 INFO - PROCESS | 16691 | Cycle 1(1): loaded http://localhost:49158/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49158/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:19:47 INFO - PROCESS | 16691 | RSS: Main: 236191744 06:19:47 INFO - PROCESS | 16691 | 06:19:50 INFO - PROCESS | 16691 | Cycle 1(1): loaded http://localhost:49158/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:19:50 INFO - PROCESS | 16691 | RSS: Main: 237748224 06:19:50 INFO - PROCESS | 16691 | 06:19:53 INFO - PROCESS | 16691 | Cycle 1(1): loaded http://localhost:49158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:19:54 INFO - PROCESS | 16691 | RSS: Main: 238419968 06:19:54 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | Cycle 1(1): loaded http://localhost:49158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49158/tests/kraken/driver.html?testName=ai-astar) 06:19:55 INFO - PROCESS | 16691 | RSS: Main: 281554944 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | __start_tp_report 06:19:55 INFO - PROCESS | 16691 | _x_x_mozilla_page_load 06:19:55 INFO - PROCESS | 16691 | _x_x_mozilla_page_load_details 06:19:55 INFO - PROCESS | 16691 | |i|pagename|runs| 06:19:55 INFO - PROCESS | 16691 | |0;ai-astar;101;111;112;110;111;111;110;111;108;110 06:19:55 INFO - PROCESS | 16691 | |1;audio-beat-detection;153;126;134;196;128;136;128;151;166;125 06:19:55 INFO - PROCESS | 16691 | |2;audio-dft;161;161;162;163;162;161;163;162;162;161 06:19:55 INFO - PROCESS | 16691 | |3;audio-fft;75;75;75;122;75;75;82;76;105;76 06:19:55 INFO - PROCESS | 16691 | |4;audio-oscillator;85;84;113;86;85;85;121;85;86;121 06:19:55 INFO - PROCESS | 16691 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;118;117;119 06:19:55 INFO - PROCESS | 16691 | |6;imaging-darkroom;145;147;146;146;145;146;146;146;145;145 06:19:55 INFO - PROCESS | 16691 | |7;imaging-desaturate;94;95;94;94;94;95;95;96;94;95 06:19:55 INFO - PROCESS | 16691 | |8;json-parse-financial;56;53;53;53;54;53;54;56;51;52 06:19:55 INFO - PROCESS | 16691 | |9;json-stringify-tinderbox;61;63;61;62;62;61;62;61;61;62 06:19:55 INFO - PROCESS | 16691 | |10;stanford-crypto-aes;81;79;78;81;77;80;80;80;97;85 06:19:55 INFO - PROCESS | 16691 | |11;stanford-crypto-ccm;125;129;118;126;120;121;118;121;126;122 06:19:55 INFO - PROCESS | 16691 | |12;stanford-crypto-pbkdf2;155;155;160;159;159;156;154;155;157;156 06:19:55 INFO - PROCESS | 16691 | |13;stanford-crypto-sha256-iterative;61;60;62;62;63;61;64;65;59;62 06:19:55 INFO - PROCESS | 16691 | __end_tp_report 06:19:55 INFO - PROCESS | 16691 | __start_cc_report 06:19:55 INFO - PROCESS | 16691 | _x_x_mozilla_cycle_collect,1609 06:19:55 INFO - PROCESS | 16691 | __end_cc_report 06:19:55 INFO - PROCESS | 16691 | __startTimestamp1466774395970__endTimestamp 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | ------- Summary: start ------- 06:19:55 INFO - PROCESS | 16691 | Number of tests: 14 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.17 (2.9%) stddev-sans-first:1.13 06:19:55 INFO - PROCESS | 16691 | Values: 101.0 111.0 112.0 110.0 111.0 111.0 110.0 111.0 108.0 110.0 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:143.50 stddev:22.80 (15.9%) stddev-sans-first:23.96 06:19:55 INFO - PROCESS | 16691 | Values: 153.0 126.0 134.0 196.0 128.0 136.0 128.0 151.0 166.0 125.0 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 06:19:55 INFO - PROCESS | 16691 | Values: 161.0 161.0 162.0 163.0 162.0 161.0 163.0 162.0 162.0 161.0 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | [#3] audio-fft Cycles:10 Average:83.60 Median:75.00 stddev:16.40 (21.9%) stddev-sans-first:17.10 06:19:55 INFO - PROCESS | 16691 | Values: 75.0 75.0 75.0 122.0 75.0 75.0 82.0 76.0 105.0 76.0 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:85.00 stddev:16.19 (19.0%) stddev-sans-first:16.75 06:19:55 INFO - PROCESS | 16691 | Values: 85.0 84.0 113.0 86.0 85.0 85.0 121.0 85.0 86.0 121.0 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 06:19:55 INFO - PROCESS | 16691 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 119.0 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 06:19:55 INFO - PROCESS | 16691 | Values: 145.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 06:19:55 INFO - PROCESS | 16691 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 95.0 96.0 94.0 95.0 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:1.58 (3.0%) stddev-sans-first:1.39 06:19:55 INFO - PROCESS | 16691 | Values: 56.0 53.0 53.0 53.0 54.0 53.0 54.0 56.0 51.0 52.0 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 06:19:55 INFO - PROCESS | 16691 | Values: 61.0 63.0 61.0 62.0 62.0 61.0 62.0 61.0 61.0 62.0 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:80.50 stddev:5.75 (7.1%) stddev-sans-first:6.09 06:19:55 INFO - PROCESS | 16691 | Values: 81.0 79.0 78.0 81.0 77.0 80.0 80.0 80.0 97.0 85.0 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:123.50 stddev:3.72 (3.0%) stddev-sans-first:3.84 06:19:55 INFO - PROCESS | 16691 | Values: 125.0 129.0 118.0 126.0 120.0 121.0 118.0 121.0 126.0 122.0 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:156.50 stddev:2.07 (1.3%) stddev-sans-first:2.11 06:19:55 INFO - PROCESS | 16691 | Values: 155.0 155.0 160.0 159.0 159.0 156.0 154.0 155.0 157.0 156.0 06:19:55 INFO - PROCESS | 16691 | 06:19:55 INFO - PROCESS | 16691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.79 (2.9%) stddev-sans-first:1.87 06:19:55 INFO - PROCESS | 16691 | Values: 61.0 60.0 62.0 62.0 63.0 61.0 64.0 65.0 59.0 62.0 06:19:55 INFO - PROCESS | 16691 | -------- Summary: end -------- 06:19:55 INFO - PROCESS | 16691 | 06:19:56 INFO - TEST-INFO | 16691: exit 0 06:19:56 INFO - TEST-OK | kraken | took 61583ms 06:19:56 INFO - SUITE-END | took 1175s 06:19:57 INFO - Completed test suite (00:19:35) 06:19:57 INFO - javascript benchmark 06:19:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.4238315911557, 3131.0293808919237, 3142.7642926780495, 3165.034664427352, 3192.329610781736, 5292.576593872491, 5407.729613519328, 5446.2647542581735, 5523.861903452421, 5524.08852539331, 5366.221897824813, 5400.29796126503, 5440.782368705257, 5448.7548060337285, 5451.48210919963, 4847.103285892122, 4851.22380419133, 4927.77824997876, 4944.134776414131, 5130.769115389798, 5034.345535080434, 5081.923771143436, 5088.745562721868, 5094.31226784383, 5106.540411362977, 4840.201366774478, 4912.36139301892, 4930.408350997904, 4996.825111121093, 5001.874953126165, 4953.331300274453, 4985.476524964899, 4986.127427700138, 4995.900081998339, 5035.521625445614, 4856.951430485685, 4876.097921884463, 4882.170031094723, 4898.828541001083, 4934.062528119682, 5293.338332708411, 5365.0, 5376.166694162411, 5401.378841433247, 5448.564114870801, 5823.621464604787, 5853.414658534155, 5853.443922827325, 5853.882922341572, 5856.912146317809, 5844.26946631671, 5872.265966754156, 5906.586538942276, 5922.3485416604135, 5926.644401335933, 5249.973750131263, 5341.412444631087, 5381.838544843661, 5389.461053894618, 5455.972720136374, 5922.7927022554, 5933.970330148321, 5940.762369505172, 5947.881042379128, 5949.167116603679, 5458.208559758813, 5700.116481945305, 5705.62913410627, 5709.74306156224, 5711.3146422428745, 5765.1640512125505, 5819.301683797887, 5828.912566311508, 5851.0, 5916.852078698067, 5797.072468405035, 5834.212381328466, 5837.620554663933, 5850.3272123705465, 5864.266966629171, 5600.159976003632, 5775.393583673654, 5792.478676919098, 5854.7072646367515, 5860.296764388216, 4423.380726698265, 4424.380586717862, 4439.933400998988, 4470.821167153277, 4472.955270447319, 3935.626115519078, 3937.8031098444962, 3947.1513624570857, 3960.980195099006, 3996.1008773025837, 5297.125974214288, 5357.464253574612, 5359.598030147755, 5482.259894914216, 5544.390117087117, 5717.342505611825, 5758.913616295759, 5794.768209271666, 5797.188393624896, 5849.912251316234, 5394.811181608625, 5401.216823560561, 5401.918971215435, 5417.756200970965, 5445.646033007842, 4985.277134815431, 5005.124103281911, 5020.234058842779, 5046.0, 5087.821926232564, 6073.0, 6081.239845019284, 6082.2093127893095, 6092.878142437126, 6127.234095738033, 5839.416058394127, 5853.2976042875125, 5853.473187413153, 5854.356020837789, 5860.326062502867, 5900.911486327623, 5916.733746981482, 5954.880902381841, 5992.2809262886985, 6045.758169673164, 5752.568557358299, 5754.482096611325, 5809.593328466966, 5821.09772985188, 5822.097574875901, 5855.824325270249, 5897.67562784051, 5907.793227237026, 5914.34942156371, 5915.733791979285, 5559.11054231321, 5663.490285874291, 5667.971660141673, 5719.399463056319, 5751.0, 5698.088305871041, 5698.458646428583, 5706.942930570641, 5713.914291285717, 5728.54171666274, 5492.0, 5600.4959553640365, 5610.326760788568, 5611.5230205433, 5619.719014049199, 5708.457696518824, 5746.741396637078, 5756.683382414008, 5820.796272130455, 5829.47534721877, 5650.0, 5652.434756524479, 5675.063614503726, 5680.460356266148, 5692.5730570208225], "value": 5364.663833780395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.8517498387879, 636.176151883311, 636.303247943502, 641.9005054216598, 650.6291413894081, 30958.0, 33901.83049084757, 33929.32141357174, 33935.15162120945, 41868.79065604675, 44761.0, 44945.10109797802, 45085.09829803402, 45186.0, 45222.547774522245, 8802.955985220065, 8960.462372257685, 8963.910360896405, 8965.686200982967, 8972.147645973655, 8850.645974161058, 8931.77670558238, 8945.73162805117, 8949.507777072258, 8951.73144805657, 8911.68809091682, 8953.59708813105, 8962.73111806647, 8962.775930601754, 8966.372353935227, 8851.203391694746, 8914.554272286392, 8921.197092261727, 8927.419717718327, 8934.910650893473, 8785.516796576187, 8841.248493877963, 8847.159519845605, 8850.911490885073, 8853.911460885372, 42542.78728606368, 42919.14161716779, 42932.570674293485, 42980.0, 42987.35518967218, 3384.7461440392067, 3443.466262729256, 3509.8771542995873, 3588.0132963435003, 3661.2494438640015, 32627.836860815543, 33045.0, 33156.33687326264, 33309.6669033309, 33935.49096763526, 4130.091379896448, 4153.439285696422, 4168.749875007509, 4184.769837658928, 4230.830766769325, 328833.0, 329936.35031824926, 330571.0, 330648.0, 331938.0, 60188.69905650444, 60813.391866081656, 60897.39102609006, 60901.39098609046, 60908.0, 55711.0, 60903.39096609066, 61301.38698613046, 61825.38174618286, 66116.33883661198, 16780.496585102468, 16796.076215808247, 16871.0, 16918.577035573962, 16938.91530542364, 10497.842532362021, 12373.072019598387, 12441.502339906483, 12465.813012804816, 12466.937665311616, 18662.720059199124, 18842.52893677669, 18993.33523326677, 19464.416067517715, 19691.803081968996, 7143.857122857514, 7191.532550384209, 7278.708851645981, 7408.925910740932, 7481.625918704043, 949.5252373813094, 1010.9848352274722, 1031.03083101884, 1061.193492945367, 1124.960626378073, 31135.59889804964, 31501.684983149877, 31550.36899262002, 31835.638056142292, 32003.839980800414, 1071.1537885070863, 1113.7438389170375, 1140.9218288717082, 1170.5551890281638, 1179.4692388425242, 16603.012466238477, 16624.750628740578, 16876.57808554796, 16933.576660583585, 17028.57428564271, 501978.0, 502829.0, 505303.0, 505648.0, 508307.0, 57594.7120264396, 57969.13046304309, 58049.41950580524, 58055.0, 58085.419145808846, 1245.9688507787196, 1310.4758096761373, 1330.5210124355224, 1351.331091109907, 1387.1815628779068, 31270.0, 31438.528422074145, 32152.35695286128, 32576.0, 33153.50269746004, 49636.751816240685, 49679.503204967485, 50165.0, 50170.749146254035, 50214.74892625513, 404571.0, 409026.0, 411407.0, 411579.0, 412940.0, 24757.50484990326, 44278.11443771171, 44939.775301124595, 45628.08743825038, 46085.30872036989, 46203.76898115488, 46646.76676616595, 46753.2987005202, 50274.24588631246, 51283.48716512787, 42628.573714262464, 42998.495052673, 43154.136917260854, 44004.33993490036, 44069.559304406546, 41746.791266043474, 42364.576354237295, 42876.35685464658, 43312.78343608262, 43512.564874352116, 41695.58304416917, 42051.57948420599, 42815.78592107019, 42895.7855210722, 42925.0, 36700.81649591735, 38280.617193827704, 38509.22981540298, 38522.0, 38875.416868746426, 28256.43487130287, 28691.569626455203, 28714.712852871206, 28944.42111157807, 28967.5654865173], "value": 20277.09526348572, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.62137862137854, 383.1016266854228, 396.0968990701201, 398.1916709080567, 399.44876071021986, 17049.0, 19506.512337191576, 19548.31580894669, 19599.608007839834, 19647.44583204183, 17363.392281270157, 18171.818281817177, 18179.81820181798, 19726.802731972675, 20480.0, 6153.815385538441, 6249.968750156243, 6435.549511534195, 6498.350164983487, 6582.17722784652, 6314.494840412756, 6326.49388048955, 6344.080108384282, 6383.2340119185765, 6385.744570217185, 6232.906506402385, 6278.811635650915, 6317.084022816689, 6428.0357946308195, 6432.42108210261, 6425.293217746044, 6430.839229019265, 6444.0, 6452.064450654652, 6733.528652994292, 6866.8626627467675, 6911.7926462206215, 6991.580505169655, 6993.0908981832545, 6999.475039372017, 25031.749682503123, 25794.742052579422, 26330.6050409244, 26381.472370552674, 26544.336391590365, 2379.8691071991034, 2736.3569561153113, 3238.6437491875877, 3367.6295607483157, 3393.3213357328386, 14723.263836808117, 14851.405943762236, 15964.680706385807, 16125.43560975372, 16143.273552690158, 2027.888466134362, 2038.714579958807, 2061.690746388039, 2144.7962443567994, 2168.24111560954, 91994.0, 94579.52710236405, 97302.0, 97900.0, 99568.50215748875, 17012.744808827876, 17467.30130794754, 17633.823661763476, 17958.730619040725, 18022.459326220236, 31528.684713153034, 31994.0, 32295.838520807247, 32364.190895227337, 32379.352412951608, 9469.857952130724, 9520.952395237979, 9656.517174141265, 9781.16860066888, 9975.800483990424, 7948.443608947434, 7977.7207797726805, 8065.6370463329295, 8140.715074972348, 8291.917080829235, 8957.4177678452, 8973.28213742899, 9070.909290907006, 9088.636454541876, 9206.98723140454, 3452.3256220732924, 3501.397097005484, 3516.4725291206523, 3520.2607452434763, 3644.653757892996, 860.2988564320059, 970.7136394763562, 990.1286867556504, 1040.484959944832, 1046.1682962045193, 18629.81370186308, 19079.427617171506, 19448.319308824124, 19456.319028834205, 19649.214031438867, 975.4196253229317, 997.9351342162736, 999.860019597257, 1004.5077911823154, 1004.7086344960026, 10212.08091271789, 10459.529321180566, 10772.676819695422, 10968.725781855517, 11001.504932278067, 505054.0, 505601.0, 513623.0, 513851.0, 516427.0, 55685.721571391885, 63995.68002160053, 96561.0, 97913.51043244738, 100671.49664251631, 972.2513664478312, 985.8521221816785, 988.5353883674661, 1005.6027868991854, 1007.9899201008043, 17278.30886764515, 17285.357891000334, 17770.289188432318, 17775.377861774778, 17916.731249031014, 39494.80252598719, 39610.603893961845, 40522.797386012884, 40816.30612479484, 42713.145737084466, 56935.71532142479, 59783.70108149605, 60342.39657603368, 60418.39581604128, 61036.0, 8670.566471676517, 8742.256908162877, 8823.294136469196, 8920.687775927812, 8941.061188575366, 12336.198147120409, 12698.873011270138, 12731.363431828557, 12877.678058048623, 12997.285149316878, 11184.0, 11237.381943992832, 11545.191836571696, 11684.532618695497, 11782.410879455821, 11036.5033573491, 11374.829377559508, 11425.0, 11509.884901150881, 11896.22674526153, 11501.252418592765, 11943.0, 11976.401179940794, 12008.819867701817, 12061.51753929868, 8523.531205783742, 8538.829223415622, 8594.527300998256, 8699.478031317887, 8978.10218978097, 10499.947500262755, 10834.729131771768, 11102.333859968428, 11200.775984480428, 11248.831267531157], "value": 10348.90300695956, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.1880871477108, 1492.7835463857737, 1521.0569446942893, 1641.2040160522145, 1787.1064467766116, 8562.229399354057, 8854.291656667467, 8939.41893776904, 9175.449473031622, 9191.816163676722, 8890.688825891095, 9092.499912504825, 9099.363044586882, 9107.59015844287, 9120.133587309196, 2105.1789801977243, 2296.081567373056, 2333.230034088755, 2341.929742107731, 2362.397588614901, 2363.1728894886824, 2372.466195106105, 2375.1805627058725, 2380.547695937766, 2386.8090552755825, 2363.5981883079917, 2374.252110585169, 2400.579898517761, 2409.771071748181, 2411.252511721372, 2020.2222144474335, 2224.24375712257, 2303.3205204464725, 2311.295055008222, 2332.1720789119872, 2385.487120269133, 2386.4153282445736, 2403.218953840009, 2405.5549723301247, 2409.3856066703056, 9151.908480915172, 9187.586558604879, 9240.306976976686, 9266.490343031131, 9268.073192680746, 5124.590032797368, 5276.736163191825, 5277.12927366984, 5278.340207474066, 5287.867803304948, 3324.5896724874515, 3447.913802154941, 3529.6470352964757, 3530.9293814123575, 3583.6416358363954, 1131.4682099413344, 1144.8626164860186, 1147.4205526209294, 1200.8619008813923, 1204.753025629744, 12951.222926624432, 12954.935225323814, 12956.870431295754, 12971.351432428435, 12990.480380784757, 4753.9762301188275, 4825.894948810202, 4869.220924652039, 4873.610111191097, 4890.804367825318, 10839.078678312275, 10892.727681807859, 10911.890881091247, 10919.563217471212, 10926.344419334866, 5223.347081614798, 5306.628536002443, 5307.41618421981, 5309.044372013074, 5309.283246761715, 4285.550017248206, 4712.24604063355, 4816.109019831342, 4830.468648448667, 4918.8770280743265, 3989.6808255340084, 4022.0, 4086.2644723949975, 4124.731892427043, 4139.254934111828, 1190.6190019193948, 1241.540629966918, 1242.3601845049807, 1247.5820600098887, 1263.0274688489994, 927.4759760735163, 933.3466573398513, 944.1172503708917, 950.805084957582, 971.8056388722284, 5831.416858314219, 5925.081612350093, 6008.609440386361, 6025.15647809307, 6111.449969502766, 426.52402801735604, 429.07962420607623, 437.51872939766, 437.8401883312568, 442.75427137938107, 4023.597640235953, 4055.8377664893073, 4084.5098588169017, 4097.508299004138, 4102.897427564275, 11238.606648767254, 11533.538658453735, 11605.187636865337, 11626.360550169822, 11686.298822070534, 11436.656900293005, 11474.254173478697, 11499.482523286471, 11515.078793696484, 11525.596604118815, 8023.197680232047, 8441.95779021101, 8534.87197692035, 8540.530270835165, 8558.657653693783, 6180.737633280787, 6369.617822930639, 6375.808725738235, 6390.9041364378645, 6413.775517856852, 10126.544305506122, 10831.404272765074, 10886.836697449702, 10950.835737463785, 10976.560937562728, 10761.30051546647, 10801.945990270313, 11085.94457027742, 11108.055815255793, 11117.666470005914, 8042.87935680977, 8145.063317718538, 8214.58927053633, 8231.053428855519, 8235.752927412188, 8422.24199822019, 8473.110323415953, 8511.659533618586, 8529.488230706178, 8551.016633087274, 7438.107427108782, 7573.318401343906, 7775.688972441039, 7894.6842126314305, 7963.362930965393, 7444.702211911463, 7451.2921272479025, 7461.888071679038, 7481.0, 7827.6868925244635, 6959.095317608679, 6987.7204911802955, 7002.859942801014, 7004.334588214111, 7005.6146911918295, 4963.602911767122, 4999.300097986357, 5128.640995130305, 5130.51260130287, 5135.6918584885025, 5005.549500544968, 5094.617903657167, 5146.228065790161, 5163.173892177234, 5207.973960130326], "value": 4630.858982612895, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.62143845297135, 331.7180396662837, 335.93113411750585, 338.1394351375748, 342.50166008457694, 5219.973900130503, 5249.317588713462, 5258.237555554442, 5282.392524859638, 5300.469953004697, 5168.586513078954, 5208.921866172011, 5218.32161818964, 5229.875576750997, 5240.794617238038, 3963.84144634215, 3968.7420317679403, 4131.607497287753, 4173.457450531442, 4191.497020357546, 4064.8577299794515, 4070.3487442009286, 4086.6117718816663, 4098.774567398792, 4149.128682976579, 3884.39791832265, 4079.2657321682086, 4087.12126892718, 4087.652549533293, 4101.89248902796, 3965.960340396588, 4067.1052368479036, 4133.338665813486, 4141.565135660742, 4162.023039056454, 3634.94625536571, 3661.5423072115987, 3668.486411902309, 3675.44868269759, 3678.834452449646, 5080.390353157608, 5089.185730283137, 5112.667676601009, 5129.1280482317725, 5159.174532074888, 4557.860534866283, 4706.3411122442885, 4732.384789977281, 4738.914877453909, 4750.643701722384, 5415.783368665248, 5428.647137936022, 5441.156620723794, 5445.0, 5447.618666693333, 4029.2747305485, 4043.2722110020186, 4043.636072753466, 4064.943114790176, 4081.346984482498, 5463.48096930791, 5505.339359276913, 5594.188842617838, 5628.380878103405, 5684.8294551163535, 4119.629233369011, 4138.420621113047, 4145.098431098183, 4179.477565304337, 4183.3515805050265, 4219.9578004220175, 4222.3244280914905, 4245.389085712265, 4259.595338442843, 4264.275073237557, 4616.376789133491, 4666.5533684557895, 4733.964395310049, 4739.2891066339635, 4756.096341695136, 5336.17289320156, 5419.458054194628, 5445.891082178334, 5449.6730196188355, 5466.6993315367245, 1429.621150395146, 1446.6455718349073, 1447.5802017415042, 1459.5767227503904, 1462.8683418492174, 950.353759443585, 956.4118067388506, 1009.2329829329616, 1018.3889666200369, 1028.5165971993151, 5253.264542963988, 5255.5532779713385, 5284.894302113936, 5288.444713305124, 5306.442823503477, 5544.722763861791, 5570.888582228414, 5596.4403559644525, 5606.24315717373, 5623.650323922229, 5006.849794506171, 5204.0, 5232.973835130876, 5243.161094224905, 5293.602979776532, 2932.941341173165, 2962.762978961678, 2962.762978961678, 2965.3624470738896, 2979.16781179573, 5625.521830644359, 5749.7700091996685, 5787.276590426197, 5797.0, 5821.825345239649, 5826.126081087871, 5831.941680583224, 5845.649261044351, 5847.275053859122, 5850.64896106235, 5818.534517238526, 5820.679862607597, 5842.152887831241, 5896.882062358729, 5927.347991720907, 5508.457631863084, 5600.4959553640365, 5605.859853503695, 5648.152777083306, 5736.168255602831, 5540.307461567304, 5583.972080139573, 5588.189712491747, 5601.439856014366, 5636.2954630671165, 5665.320161580472, 5820.8649313383485, 5828.184054232326, 5856.180134781219, 5870.383609720918, 4020.7483809067016, 4039.6970227232487, 4047.190561887693, 4056.249593825152, 4063.2889244382704, 5652.943470565242, 5679.744411501575, 5694.17434471991, 5710.200571920018, 5711.200431939615, 5456.399796022355, 5569.19246709233, 5590.301212348457, 5590.608657393944, 5593.384727680033, 5484.8354549363585, 5512.586556008235, 5513.09034009384, 5514.448555144453, 5547.0, 5197.350331208599, 5286.947130528645, 5422.728863556886, 5441.183822426509, 5442.782288708566, 5533.197686335539, 5536.7231638417115, 5537.667739935617, 5555.0, 5559.777608895599, 5389.784408623611, 5396.892062158813, 5400.540954018952, 5412.810551630674, 5443.59173062014], "value": 4222.321260216998, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.2682197104026, 701.6772284749015, 766.758471081609, 820.5774026376415, 848.2026894718964, 15263.0, 16798.0, 16798.244079016444, 16895.57761055971, 16928.068956207404, 13849.723005539909, 13917.0, 15537.300821463034, 15596.532104036869, 15614.141222232773, 679.0628932073731, 793.0443815202667, 798.6725442568548, 811.6428771340621, 816.4978538198994, 803.1406395157184, 807.0315621254489, 807.289585165054, 807.4186585658316, 807.8667019941703, 869.0961400143843, 869.4044579463057, 869.4044579463057, 870.0125357718971, 873.8208667223204, 708.8475977664775, 829.0714399872181, 848.8302339532119, 858.7037472072125, 860.7073594977707, 622.862970146567, 623.2676604989119, 623.3921926121994, 623.5728525959732, 623.6133597169738, 15368.154751488664, 15378.769318460232, 15387.461438849587, 15424.151671658054, 15431.074135551902, 14390.856091439056, 14622.634434139125, 14628.561143165722, 14812.407503699838, 14839.92580037093, 13020.934895325463, 13099.41052652633, 13099.672508187276, 13352.065355425124, 13409.854423292323, 4556.200300881133, 4627.768611569408, 4644.187267228222, 4657.347971284023, 4677.158111539921, 63489.68255158695, 65369.346306536805, 66115.33884661188, 74938.0, 76594.61702691506, 11142.164337674707, 11739.178257522062, 11931.582394616147, 12011.219270747373, 12268.32524211177, 20965.790342096385, 20991.16035358599, 21050.894745526482, 21059.789402105784, 21129.68305475419, 8865.634114952038, 9054.954725226464, 9077.909220907839, 9101.681441149529, 9199.862002069975, 4857.0, 4874.512548745168, 4968.503149685075, 4973.204287314013, 5021.0, 3716.758410703296, 3814.0464883779055, 3818.6563209311294, 3830.616938306147, 4015.759054456742, 729.4784229276094, 733.1934871641258, 736.2343163110305, 743.7619961612232, 765.7281665008953, 627.1752645271454, 629.3140476880222, 704.0073496370094, 705.6013352455846, 733.2264460993596, 9274.721758347261, 9523.809523809485, 9831.0, 9924.950375248078, 10010.899891000996, 626.5707990026846, 636.0745115856417, 725.793148952546, 741.4698490579261, 767.5739964319745, 4454.665900057508, 4643.0, 4752.7623618818925, 4753.310769938409, 4835.516448355136, 104150.47924760479, 109619.45190273998, 112385.0, 114416.0, 114740.42629786965, 92320.0, 99853.0, 102987.0, 103437.0, 104536.0, 83478.58260708657, 85736.14263857531, 85779.5711021441, 86832.0, 87944.0, 8861.64553417856, 8885.955570222108, 8907.643694252158, 8976.0, 9057.049009854134, 49668.0, 50373.0, 50724.0, 51155.74422128015, 51276.826338632905, 66498.0, 66802.0, 74626.43362646452, 77071.0, 77668.2233177661, 11749.76500470003, 11857.881421185677, 11994.520219191134, 12180.75638487243, 12407.75184496287, 13958.790618140532, 14212.0, 14332.528543595212, 14483.0, 14577.489787857374, 11129.0, 13464.865351346361, 13652.453901844212, 13922.443102275796, 14056.437742490185, 14066.0, 14084.718305634035, 14258.0, 15064.698706026038, 15268.465603703817, 14104.153750774987, 14118.576442706324, 14446.349914253673, 15030.624234394227, 15042.02226855251, 10988.230823842254, 11191.32852028881, 11476.475175461384, 11484.483198255932, 11731.23746956445, 10713.196510261605, 11539.5961141363, 11544.81249378275, 11564.94217528907, 11668.299902005907], "value": 7664.403308667693, "unit": "score"}], "name": "dromaeo_css", "value": 7433.559234488758, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 112.0, 110.0, 111.0, 111.0, 110.0, 111.0, 108.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 134.0, 196.0, 128.0, 136.0, 128.0, 151.0, 166.0, 125.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 163.0, 162.0, 161.0, 163.0, 162.0, 162.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 122.0, 75.0, 75.0, 82.0, 76.0, 105.0, 76.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 113.0, 86.0, 85.0, 85.0, 121.0, 85.0, 86.0, 121.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 53.0, 54.0, 53.0, 54.0, 56.0, 51.0, 52.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 61.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 78.0, 81.0, 77.0, 80.0, 80.0, 80.0, 97.0, 85.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 129.0, 118.0, 126.0, 120.0, 121.0, 118.0, 121.0, 126.0, 122.0], "value": 122.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 160.0, 159.0, 159.0, 156.0, 154.0, 155.0, 157.0, 156.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 62.0, 62.0, 63.0, 61.0, 64.0, 65.0, 59.0, 62.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1490.0, "alertThreshold": 2.0}]} 06:19:57 INFO - Return code: 0 06:19:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:19:57 INFO - # TBPL SUCCESS # 06:19:57 INFO - Running post-action listener: _resource_record_post_action 06:19:57 INFO - ##### 06:19:57 INFO - ##### Finished run-tests step (success) 06:19:57 INFO - ##### 06:19:57 INFO - Running post-run listener: _resource_record_post_run 06:19:57 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 556249088; Read time: 16; Write time: 465076 06:19:57 INFO - TinderboxPrint: CPU usage
13.1% 06:19:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:19:57 INFO - TinderboxPrint: I/O write bytes / time
556,249,088 / 465,076 06:19:57 INFO - TinderboxPrint: CPU idle
8,277.1 (86.9%) 06:19:57 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 06:19:57 INFO - TinderboxPrint: Swap in / out
0 / 0 06:19:57 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 263593984; Read time: 0; Write time: 290072 06:19:57 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288669696; Read time: 16; Write time: 174224 06:19:57 INFO - Running post-run listener: _upload_blobber_files 06:19:57 INFO - Blob upload gear active. 06:19:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:19:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:19:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:19:58 INFO - (blobuploader) - INFO - Open directory for files ... 06:19:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:19:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:19:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:59 INFO - (blobuploader) - INFO - Done attempting. 06:19:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:19:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:20:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:02 INFO - (blobuploader) - INFO - Done attempting. 06:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:20:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:03 INFO - (blobuploader) - INFO - Done attempting. 06:20:03 INFO - (blobuploader) - INFO - Iteration through files over. 06:20:03 INFO - Return code: 0 06:20:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:20:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:20:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0834aeeccf8b901411e287e6825317b406e82fbb885ff6d4f6dcb9c094d5f639d0754d44c3867dbace3f5bb1ccfe1c6cc6ea36db442e385a16493691d18f093a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/082c9cab555645a6b774a5e4ec2fefe6191c20329b73af7fe367ad2d7dcf162278607d591007fad88274150d8a233de945e5b07be9c21ab405cb66f5cbdc51a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05ad44f3a55e863d05a8f957daee13718a147880ba5c0cf8d872f9710adce7df975220b801037b7cc1abe36a284f25a5b9739f3b803f18dd072bc6ba5b22aeb8"} 06:20:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:20:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:20:03 INFO - Contents: 06:20:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0834aeeccf8b901411e287e6825317b406e82fbb885ff6d4f6dcb9c094d5f639d0754d44c3867dbace3f5bb1ccfe1c6cc6ea36db442e385a16493691d18f093a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/082c9cab555645a6b774a5e4ec2fefe6191c20329b73af7fe367ad2d7dcf162278607d591007fad88274150d8a233de945e5b07be9c21ab405cb66f5cbdc51a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05ad44f3a55e863d05a8f957daee13718a147880ba5c0cf8d872f9710adce7df975220b801037b7cc1abe36a284f25a5b9739f3b803f18dd072bc6ba5b22aeb8"} 06:20:03 INFO - Running post-run listener: copy_logs_to_upload_dir 06:20:03 INFO - Copying logs to upload dir... 06:20:03 INFO - mkdir: /builds/slave/test/build/upload/logs 06:20:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.861488 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-24 06:20:03.159614) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 06:20:03.163614) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516 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/0834aeeccf8b901411e287e6825317b406e82fbb885ff6d4f6dcb9c094d5f639d0754d44c3867dbace3f5bb1ccfe1c6cc6ea36db442e385a16493691d18f093a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/082c9cab555645a6b774a5e4ec2fefe6191c20329b73af7fe367ad2d7dcf162278607d591007fad88274150d8a233de945e5b07be9c21ab405cb66f5cbdc51a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05ad44f3a55e863d05a8f957daee13718a147880ba5c0cf8d872f9710adce7df975220b801037b7cc1abe36a284f25a5b9739f3b803f18dd072bc6ba5b22aeb8"} build_url:https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/F_B7hMk2SZec74LZUB6NmQ/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/0834aeeccf8b901411e287e6825317b406e82fbb885ff6d4f6dcb9c094d5f639d0754d44c3867dbace3f5bb1ccfe1c6cc6ea36db442e385a16493691d18f093a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/082c9cab555645a6b774a5e4ec2fefe6191c20329b73af7fe367ad2d7dcf162278607d591007fad88274150d8a233de945e5b07be9c21ab405cb66f5cbdc51a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05ad44f3a55e863d05a8f957daee13718a147880ba5c0cf8d872f9710adce7df975220b801037b7cc1abe36a284f25a5b9739f3b803f18dd072bc6ba5b22aeb8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 06:20:03.189912) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 06:20:03.190269) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466773167.8167-1495616516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 06:20:03.273252) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 06:20:03.273614) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 06:20:03.274000) ========= ========= Total master_lag: 0.18 =========