builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1466693971.24 results: success (0) buildid: 20160623061726 builduid: a472c0227e7a42109d1c12e5bb327535 revision: d1102663db10b3d4b9358f3cf4e16b7c56902352 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 07:59:31.243095) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 07:59:31.243625) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 07:59:31.243920) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 07:59:31.258992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:59:31.259470) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 07:59:31-- 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% 225M=0s 2016-06-23 07:59:31 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090426 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:59:31.364917) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:59:31.365483) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015910 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:59:31.416488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:59:31.416860) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d1102663db10b3d4b9358f3cf4e16b7c56902352 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev d1102663db10b3d4b9358f3cf4e16b7c56902352 --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=78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 07:59:32,003 truncating revision to first 12 chars 2016-06-23 07:59:32,003 Setting DEBUG logging. 2016-06-23 07:59:32,003 attempt 1/10 2016-06-23 07:59:32,003 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d1102663db10?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 07:59:32,320 unpacking tar archive at: autoland-d1102663db10/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668432 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:59:32.100383) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 07:59:32.100899) ========= script_repo_revision: d1102663db10b3d4b9358f3cf4e16b7c56902352 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 07:59:32.101596) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 07:59:32.102025) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 07:59:32.113631) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-23 07:59:32.114225) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:59:32 INFO - MultiFileLogger online at 20160623 07:59:32 in /builds/slave/test 07:59:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 07:59:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:59:32 INFO - {'append_to_log': False, 07:59:32 INFO - 'base_work_dir': '/builds/slave/test', 07:59:32 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 07:59:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:59:32 INFO - 'branch': 'Autoland-Non-PGO', 07:59:32 INFO - 'buildbot_json_path': 'buildprops.json', 07:59:32 INFO - 'config_files': ('talos/linux_config.py',), 07:59:32 INFO - 'default_actions': ('clobber', 07:59:32 INFO - 'read-buildbot-config', 07:59:32 INFO - 'download-and-extract', 07:59:32 INFO - 'populate-webroot', 07:59:32 INFO - 'create-virtualenv', 07:59:32 INFO - 'install', 07:59:32 INFO - 'run-tests'), 07:59:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:59:32 INFO - 'download_minidump_stackwalk': True, 07:59:32 INFO - 'download_symbols': 'ondemand', 07:59:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:59:32 INFO - 'tooltool.py': '/tools/tooltool.py', 07:59:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:59:32 INFO - '/tools/misc-python/virtualenv.py')}, 07:59:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:59:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:59:32 INFO - 'installer_path': 'installer.exe', 07:59:32 INFO - 'log_level': 'info', 07:59:32 INFO - 'log_name': 'talos', 07:59:32 INFO - 'log_to_console': True, 07:59:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:59:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:59:32 INFO - 'opt_config_files': (), 07:59:32 INFO - 'pip_index': False, 07:59:32 INFO - 'sps_profile': False, 07:59:32 INFO - 'sps_profile_interval': 0, 07:59:32 INFO - 'suite': 'dromaeojs-e10s', 07:59:32 INFO - 'system_bits': '32', 07:59:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:59:32 INFO - 'title': 'talos-linux64-ix-019', 07:59:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:59:32 INFO - 'use_talos_json': True, 07:59:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:59:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:59:32 INFO - 'work_dir': 'build'} 07:59:32 INFO - ##### 07:59:32 INFO - ##### Running clobber step. 07:59:32 INFO - ##### 07:59:32 INFO - Running pre-action listener: _resource_record_pre_action 07:59:32 INFO - Running main action method: clobber 07:59:32 INFO - rmtree: /builds/slave/test/build 07:59:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:59:33 INFO - Running post-action listener: _resource_record_post_action 07:59:33 INFO - ##### 07:59:33 INFO - ##### Finished clobber step (success) 07:59:33 INFO - ##### 07:59:33 INFO - ##### 07:59:33 INFO - ##### Running read-buildbot-config step. 07:59:33 INFO - ##### 07:59:33 INFO - Running pre-action listener: _resource_record_pre_action 07:59:33 INFO - Running main action method: read_buildbot_config 07:59:33 INFO - Using buildbot properties: 07:59:33 INFO - { 07:59:33 INFO - "project": "", 07:59:33 INFO - "product": "firefox", 07:59:33 INFO - "script_repo_revision": "production", 07:59:33 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 07:59:33 INFO - "repository": "", 07:59:33 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 07:59:33 INFO - "buildid": "20160623061726", 07:59:33 INFO - "pgo_build": "False", 07:59:33 INFO - "basedir": "/builds/slave/test", 07:59:33 INFO - "buildnumber": 6, 07:59:33 INFO - "slavename": "talos-linux64-ix-019", 07:59:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:59:33 INFO - "platform": "ubuntu64_hw", 07:59:33 INFO - "scheduler": "tests-autoland-linux64-talos", 07:59:33 INFO - "branch": "autoland", 07:59:33 INFO - "repo_path": "integration/autoland", 07:59:33 INFO - "revision": "d1102663db10b3d4b9358f3cf4e16b7c56902352", 07:59:33 INFO - "stage_platform": "linux64", 07:59:33 INFO - "builduid": "a472c0227e7a42109d1c12e5bb327535", 07:59:33 INFO - "slavebuilddir": "test" 07:59:33 INFO - } 07:59:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:59:33 INFO - Running post-action listener: _resource_record_post_action 07:59:33 INFO - ##### 07:59:33 INFO - ##### Finished read-buildbot-config step (success) 07:59:33 INFO - ##### 07:59:33 INFO - ##### 07:59:33 INFO - ##### Running download-and-extract step. 07:59:33 INFO - ##### 07:59:33 INFO - Running pre-action listener: _resource_record_pre_action 07:59:33 INFO - Running main action method: download_and_extract 07:59:33 INFO - mkdir: /builds/slave/test/build/tests 07:59:33 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')]} 07:59:33 INFO - https://queue.taskcluster.net/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/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 07:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/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 07:59:33 INFO - Downloaded 1361 bytes. 07:59:33 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:59:33 INFO - Using the following test package requirements: 07:59:33 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:59:33 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:59:33 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:59:33 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:33 INFO - u'jsshell-linux-x86_64.zip'], 07:59:33 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:59:33 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:59:33 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:59:33 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:59:33 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:59:33 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:59:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:59:33 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')]} 07:59:33 INFO - https://queue.taskcluster.net/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/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 07:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/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 07:59:34 INFO - Downloaded 22703288 bytes. 07:59:34 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'] 07:59:34 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 07:59:36 INFO - Return code: 0 07:59:36 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 07:59:36 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')]} 07:59:36 INFO - https://queue.taskcluster.net/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:59:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:59:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:59:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/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 07:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/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 07:59:37 INFO - Downloaded 22703288 bytes. 07:59:37 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'] 07:59:37 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 07:59:38 INFO - Return code: 0 07:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:38 INFO - https://queue.taskcluster.net/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:59:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:59:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:59:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/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 07:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/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 07:59:39 INFO - Downloaded 14405384 bytes. 07:59:39 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'] 07:59:39 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 07:59:39 INFO - Return code: 0 07:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:39 INFO - https://queue.taskcluster.net/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:59:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:59:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:59:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/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 07:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONF30rRJRdabacYZdKXjcQ/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 07:59:41 INFO - Downloaded 56276505 bytes. 07:59:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:59:41 INFO - mkdir: /builds/slave/test/properties 07:59:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:59:41 INFO - Writing to file /builds/slave/test/properties/build_url 07:59:41 INFO - Contents: 07:59:41 INFO - build_url:https://queue.taskcluster.net/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:59:42 INFO - Running post-action listener: _resource_record_post_action 07:59:42 INFO - Running post-action listener: set_extra_try_arguments 07:59:42 INFO - ##### 07:59:42 INFO - ##### Finished download-and-extract step (success) 07:59:42 INFO - ##### 07:59:42 INFO - ##### 07:59:42 INFO - ##### Running populate-webroot step. 07:59:42 INFO - ##### 07:59:42 INFO - Running pre-action listener: _resource_record_pre_action 07:59:42 INFO - Running main action method: populate_webroot 07:59:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:59:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:59:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:59:42 INFO - '--tppagecycles', 07:59:42 INFO - '7'], 07:59:42 INFO - 'tests': ['tsvgm']}}, 07:59:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:59:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:59:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:59:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:59:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['damp', 'tps']}, 07:59:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'tests': ['damp', 'tps']}, 07:59:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['dromaeo_dom']}, 07:59:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:59:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['basic_compositor_video']}, 07:59:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:59:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['a11yr', 07:59:42 INFO - 'ts_paint', 07:59:42 INFO - 'tpaint', 07:59:42 INFO - 'sessionrestore', 07:59:42 INFO - 'sessionrestore_no_auto_restore', 07:59:42 INFO - 'tabpaint']}, 07:59:42 INFO - 'other-e10s': {'tests': ['a11yr', 07:59:42 INFO - 'ts_paint', 07:59:42 INFO - 'tpaint', 07:59:42 INFO - 'sessionrestore', 07:59:42 INFO - 'sessionrestore_no_auto_restore', 07:59:42 INFO - 'tabpaint']}, 07:59:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:59:42 INFO - 'ts_paint', 07:59:42 INFO - 'tpaint', 07:59:42 INFO - 'sessionrestore', 07:59:42 INFO - 'sessionrestore_no_auto_restore', 07:59:42 INFO - 'tabpaint']}, 07:59:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:59:42 INFO - 'ts_paint', 07:59:42 INFO - 'tpaint', 07:59:42 INFO - 'sessionrestore', 07:59:42 INFO - 'sessionrestore_no_auto_restore', 07:59:42 INFO - 'tabpaint']}, 07:59:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['a11yr', 07:59:42 INFO - 'ts_paint', 07:59:42 INFO - 'tpaint', 07:59:42 INFO - 'sessionrestore', 07:59:42 INFO - 'sessionrestore_no_auto_restore', 07:59:42 INFO - 'tabpaint']}, 07:59:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['a11yr', 07:59:42 INFO - 'ts_paint', 07:59:42 INFO - 'tpaint', 07:59:42 INFO - 'sessionrestore', 07:59:42 INFO - 'sessionrestore_no_auto_restore', 07:59:42 INFO - 'tabpaint']}, 07:59:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['tsvgx', 07:59:42 INFO - 'tsvgr_opacity', 07:59:42 INFO - 'tart', 07:59:42 INFO - 'tscrollx', 07:59:42 INFO - 'cart']}, 07:59:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:59:42 INFO - 'tsvgr_opacity', 07:59:42 INFO - 'tart', 07:59:42 INFO - 'tscrollx', 07:59:42 INFO - 'cart']}, 07:59:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['tp5o']}, 07:59:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'tests': ['tp5o']}, 07:59:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'talos_options': ['--disable-e10s', 07:59:42 INFO - '--xperf_path', 07:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:42 INFO - 'tests': ['tp5n']}, 07:59:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'talos_options': ['--xperf_path', 07:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:42 INFO - 'tests': ['tp5n']}}, 07:59:42 INFO - 'talos.zip': {'path': '', 07:59:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:59:42 INFO - Running post-action listener: _resource_record_post_action 07:59:42 INFO - ##### 07:59:42 INFO - ##### Finished populate-webroot step (success) 07:59:42 INFO - ##### 07:59:42 INFO - ##### 07:59:42 INFO - ##### Running create-virtualenv step. 07:59:42 INFO - ##### 07:59:42 INFO - Running pre-action listener: _resource_record_pre_action 07:59:42 INFO - Running main action method: create_virtualenv 07:59:42 INFO - Creating virtualenv /builds/slave/test/build/venv 07:59:42 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 07:59:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:59:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:59:42 INFO - Using real prefix '/usr' 07:59:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:59:42 INFO - Installing distribute.............................................................................................................................................................................................done. 07:59:44 INFO - Installing pip.................done. 07:59:44 INFO - Return code: 0 07:59:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:44 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 0x7f29b5bc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18392e0>, '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 0x17a5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a55d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', '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 07:59:44 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 07:59:44 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 07:59:44 INFO - Using env: {'DISPLAY': ':0', 07:59:44 INFO - 'HOME': '/home/cltbld', 07:59:44 INFO - 'LANG': 'en_US.UTF-8', 07:59:44 INFO - 'LANGUAGE': 'en_US:en', 07:59:44 INFO - 'LOGNAME': 'cltbld', 07:59:44 INFO - 'MAIL': '/var/mail/cltbld', 07:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:44 INFO - 'MOZ_NO_REMOTE': '1', 07:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:44 INFO - 'NO_EM_RESTART': '1', 07:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:44 INFO - 'PWD': '/builds/slave/test', 07:59:44 INFO - 'SHELL': '/bin/bash', 07:59:44 INFO - 'SHLVL': '1', 07:59:44 INFO - 'TERM': 'linux', 07:59:44 INFO - 'TMOUT': '86400', 07:59:44 INFO - 'USER': 'cltbld', 07:59:44 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', 07:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:44 INFO - '_': '/tools/buildbot/bin/python'} 07:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:45 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 07:59:45 INFO - Cleaning up... 07:59:45 INFO - Return code: 0 07:59:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07: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')]} 07:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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', '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 0x7f29b5bc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18392e0>, '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 0x17a5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a55d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', '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 07: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07: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 psutil>=3.1.1 07:59:45 INFO - Using env: {'DISPLAY': ':0', 07:59:45 INFO - 'HOME': '/home/cltbld', 07:59:45 INFO - 'LANG': 'en_US.UTF-8', 07:59:45 INFO - 'LANGUAGE': 'en_US:en', 07:59:45 INFO - 'LOGNAME': 'cltbld', 07:59:45 INFO - 'MAIL': '/var/mail/cltbld', 07:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:45 INFO - 'MOZ_NO_REMOTE': '1', 07:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:45 INFO - 'NO_EM_RESTART': '1', 07:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:45 INFO - 'PWD': '/builds/slave/test', 07:59:45 INFO - 'SHELL': '/bin/bash', 07:59:45 INFO - 'SHLVL': '1', 07:59:45 INFO - 'TERM': 'linux', 07:59:45 INFO - 'TMOUT': '86400', 07:59:45 INFO - 'USER': 'cltbld', 07:59:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', 07:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:45 INFO - '_': '/tools/buildbot/bin/python'} 07:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:45 INFO - Downloading/unpacking psutil>=3.1.1 07:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:59:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:47 INFO - Installing collected packages: psutil 07:59:47 INFO - Running setup.py install for psutil 07:59:47 INFO - building 'psutil._psutil_linux' extension 07:59:47 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 07:59:47 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 07:59:47 INFO - building 'psutil._psutil_posix' extension 07:59:47 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 07:59:47 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 07:59:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:47 INFO - Successfully installed psutil 07:59:47 INFO - Cleaning up... 07:59:47 INFO - Return code: 0 07:59:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:59:47 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')]} 07:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:47 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')]} 07:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:47 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 0x7f29b5bc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18392e0>, '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 0x17a5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a55d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', '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 07:59:47 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 07:59:47 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 07:59:47 INFO - Using env: {'DISPLAY': ':0', 07:59:47 INFO - 'HOME': '/home/cltbld', 07:59:47 INFO - 'LANG': 'en_US.UTF-8', 07:59:47 INFO - 'LANGUAGE': 'en_US:en', 07:59:47 INFO - 'LOGNAME': 'cltbld', 07:59:47 INFO - 'MAIL': '/var/mail/cltbld', 07:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:47 INFO - 'MOZ_NO_REMOTE': '1', 07:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:47 INFO - 'NO_EM_RESTART': '1', 07:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:47 INFO - 'PWD': '/builds/slave/test', 07:59:47 INFO - 'SHELL': '/bin/bash', 07:59:47 INFO - 'SHLVL': '1', 07:59:47 INFO - 'TERM': 'linux', 07:59:47 INFO - 'TMOUT': '86400', 07:59:47 INFO - 'USER': 'cltbld', 07:59:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', 07:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:47 INFO - '_': '/tools/buildbot/bin/python'} 07:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 07: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 07: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 07: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 07: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 07: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 07: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 07:59:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:59:50 INFO - Installing collected packages: mozsystemmonitor 07:59:50 INFO - Running setup.py install for mozsystemmonitor 07:59:50 INFO - Successfully installed mozsystemmonitor 07:59:50 INFO - Cleaning up... 07:59:50 INFO - Return code: 0 07:59:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:50 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 0x7f29b5bc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18392e0>, '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 0x17a5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a55d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', '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 07:59:50 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 07:59:50 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 07:59:50 INFO - Using env: {'DISPLAY': ':0', 07:59:50 INFO - 'HOME': '/home/cltbld', 07:59:50 INFO - 'LANG': 'en_US.UTF-8', 07:59:50 INFO - 'LANGUAGE': 'en_US:en', 07:59:50 INFO - 'LOGNAME': 'cltbld', 07:59:50 INFO - 'MAIL': '/var/mail/cltbld', 07:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:50 INFO - 'MOZ_NO_REMOTE': '1', 07:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:50 INFO - 'NO_EM_RESTART': '1', 07:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:50 INFO - 'PWD': '/builds/slave/test', 07:59:50 INFO - 'SHELL': '/bin/bash', 07:59:50 INFO - 'SHLVL': '1', 07:59:50 INFO - 'TERM': 'linux', 07:59:50 INFO - 'TMOUT': '86400', 07:59:50 INFO - 'USER': 'cltbld', 07:59:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', 07:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:50 INFO - '_': '/tools/buildbot/bin/python'} 07:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:50 INFO - Downloading/unpacking jsonschema==2.5.1 07: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 07: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 07: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 07: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 07: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 07: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 07:59:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:59:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:59:52 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 07:59:52 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 07:59:52 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 07:59:52 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 07:59:52 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 07:59:52 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 07:59:52 INFO - Downloading functools32-3.2.3-2.tar.gz 07:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:59:52 INFO - warning: no files found matching '*.txt' 07:59:52 INFO - no previously-included directories found matching 'build' 07:59:52 INFO - no previously-included directories found matching 'dist' 07:59:52 INFO - no previously-included directories found matching '.git*' 07:59:52 INFO - Installing collected packages: jsonschema, functools32 07:59:52 INFO - Running setup.py install for functools32 07:59:52 INFO - warning: no files found matching '*.txt' 07:59:52 INFO - no previously-included directories found matching 'build' 07:59:52 INFO - no previously-included directories found matching 'dist' 07:59:52 INFO - no previously-included directories found matching '.git*' 07:59:52 INFO - Successfully installed jsonschema functools32 07:59:52 INFO - Cleaning up... 07:59:52 INFO - Return code: 0 07:59:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:59:52 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')]} 07:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:52 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')]} 07:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:52 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 0x7f29b5bc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18392e0>, '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 0x17a5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a55d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', '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 07:59:52 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 07:59:52 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 07:59:52 INFO - Using env: {'DISPLAY': ':0', 07:59:52 INFO - 'HOME': '/home/cltbld', 07:59:52 INFO - 'LANG': 'en_US.UTF-8', 07:59:52 INFO - 'LANGUAGE': 'en_US:en', 07:59:52 INFO - 'LOGNAME': 'cltbld', 07:59:52 INFO - 'MAIL': '/var/mail/cltbld', 07:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:52 INFO - 'MOZ_NO_REMOTE': '1', 07:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:52 INFO - 'NO_EM_RESTART': '1', 07:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:52 INFO - 'PWD': '/builds/slave/test', 07:59:52 INFO - 'SHELL': '/bin/bash', 07:59:52 INFO - 'SHLVL': '1', 07:59:52 INFO - 'TERM': 'linux', 07:59:52 INFO - 'TMOUT': '86400', 07:59:52 INFO - 'USER': 'cltbld', 07:59:52 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', 07:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:52 INFO - '_': '/tools/buildbot/bin/python'} 07:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:53 INFO - Downloading/unpacking blobuploader==1.2.4 07:59:53 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 07:59:53 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 07:59:53 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 07:59:53 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 07:59:53 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 07:59:53 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 07:59:54 INFO - Downloading blobuploader-1.2.4.tar.gz 07:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:59:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:59:55 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 07:59:55 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 07:59:55 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 07:59:55 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 07:59:55 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 07:59:55 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 07:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:59:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:59:55 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 07:59:55 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 07:59:55 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 07:59:55 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 07:59:55 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 07:59:55 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 07:59:55 INFO - Downloading docopt-0.6.1.tar.gz 07:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:59:55 INFO - Installing collected packages: blobuploader, requests, docopt 07:59:55 INFO - Running setup.py install for blobuploader 07:59:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:59:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:59:55 INFO - Running setup.py install for requests 07:59:56 INFO - Running setup.py install for docopt 07:59:56 INFO - Successfully installed blobuploader requests docopt 07:59:56 INFO - Cleaning up... 07:59:56 INFO - Return code: 0 07:59:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:56 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 0x7f29b5bc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18392e0>, '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 0x17a5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a55d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', '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 07:59:56 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 07:59:56 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 07:59:56 INFO - Using env: {'DISPLAY': ':0', 07:59:56 INFO - 'HOME': '/home/cltbld', 07:59:56 INFO - 'LANG': 'en_US.UTF-8', 07:59:56 INFO - 'LANGUAGE': 'en_US:en', 07:59:56 INFO - 'LOGNAME': 'cltbld', 07:59:56 INFO - 'MAIL': '/var/mail/cltbld', 07:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:56 INFO - 'MOZ_NO_REMOTE': '1', 07:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:56 INFO - 'NO_EM_RESTART': '1', 07:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:56 INFO - 'PWD': '/builds/slave/test', 07:59:56 INFO - 'SHELL': '/bin/bash', 07:59:56 INFO - 'SHLVL': '1', 07:59:56 INFO - 'TERM': 'linux', 07:59:56 INFO - 'TMOUT': '86400', 07:59:56 INFO - 'USER': 'cltbld', 07:59:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', 07:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:56 INFO - '_': '/tools/buildbot/bin/python'} 07:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:56 INFO - Running setup.py (path:/tmp/pip-Qg6hac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:56 INFO - Running setup.py (path:/tmp/pip-mzJOyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:56 INFO - Running setup.py (path:/tmp/pip-a0jayM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:59:56 INFO - Running setup.py (path:/tmp/pip-H1KnCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:59:56 INFO - Running setup.py (path:/tmp/pip-QPSVIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:59:56 INFO - Running setup.py (path:/tmp/pip-YWZ8w7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:59:57 INFO - Running setup.py (path:/tmp/pip-XFLpCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:59:57 INFO - Running setup.py (path:/tmp/pip-nlhNp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:59:57 INFO - Running setup.py (path:/tmp/pip-UsAszt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:59:57 INFO - Running setup.py (path:/tmp/pip-d6KNro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:59:57 INFO - Running setup.py (path:/tmp/pip-zPKXhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:59:57 INFO - Running setup.py (path:/tmp/pip-Kv2MRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:59:57 INFO - Running setup.py (path:/tmp/pip-4uXpuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:59:57 INFO - Running setup.py (path:/tmp/pip-gJUs_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:57 INFO - Running setup.py (path:/tmp/pip-FGKzw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:59:57 INFO - Running setup.py (path:/tmp/pip-gmu71I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:59:57 INFO - Running setup.py (path:/tmp/pip-udZG7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:59:57 INFO - Running setup.py install for manifestparser 07:59:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:59:57 INFO - Running setup.py install for mozcrash 07:59:58 INFO - Running setup.py install for mozdebug 07:59:58 INFO - Running setup.py install for mozdevice 07:59:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:59:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:59:58 INFO - Running setup.py install for mozfile 07:59:58 INFO - Running setup.py install for mozhttpd 07:59:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:59:58 INFO - Running setup.py install for mozinfo 07:59:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:59:58 INFO - Running setup.py install for mozInstall 07:59:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:59:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:59:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:59:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:59:58 INFO - Running setup.py install for mozleak 07:59:58 INFO - Running setup.py install for mozlog 07:59:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:59:58 INFO - Running setup.py install for moznetwork 07:59:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:59:58 INFO - Running setup.py install for mozprocess 07:59:59 INFO - Running setup.py install for mozprofile 07:59:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:59:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:59:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:59:59 INFO - Running setup.py install for mozrunner 07:59:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:59:59 INFO - Running setup.py install for mozscreenshot 07:59:59 INFO - Running setup.py install for moztest 07:59:59 INFO - Running setup.py install for mozversion 07:59:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:59:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:59:59 INFO - Cleaning up... 07:59:59 INFO - Return code: 0 07:59:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07: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')]} 07:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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/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 0x7f29b5bc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18392e0>, '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 0x17a5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a55d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', '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 07:59:59 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 07:59:59 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 07:59:59 INFO - Using env: {'DISPLAY': ':0', 07:59:59 INFO - 'HOME': '/home/cltbld', 07:59:59 INFO - 'LANG': 'en_US.UTF-8', 07:59:59 INFO - 'LANGUAGE': 'en_US:en', 07:59:59 INFO - 'LOGNAME': 'cltbld', 07:59:59 INFO - 'MAIL': '/var/mail/cltbld', 07:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:59 INFO - 'MOZ_NO_REMOTE': '1', 07:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:59 INFO - 'NO_EM_RESTART': '1', 07:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:59 INFO - 'PWD': '/builds/slave/test', 07:59:59 INFO - 'SHELL': '/bin/bash', 07:59:59 INFO - 'SHLVL': '1', 07:59:59 INFO - 'TERM': 'linux', 07:59:59 INFO - 'TMOUT': '86400', 07:59:59 INFO - 'USER': 'cltbld', 07:59:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', 07:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:59 INFO - '_': '/tools/buildbot/bin/python'} 07:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:59 INFO - Running setup.py (path:/tmp/pip-Zv79nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:59 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)) 07:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:59 INFO - Running setup.py (path:/tmp/pip-4qngzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:59 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)) 07:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:59 INFO - Running setup.py (path:/tmp/pip-VjeDL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00:00 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)) 08:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:00 INFO - Running setup.py (path:/tmp/pip-DCyTMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00:00 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)) 08:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:00 INFO - Running setup.py (path:/tmp/pip-09NJpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00:00 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)) 08:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:00 INFO - Running setup.py (path:/tmp/pip-RM5wnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00:00 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)) 08:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:00 INFO - Running setup.py (path:/tmp/pip-ZVennO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00:00 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)) 08:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:00 INFO - Running setup.py (path:/tmp/pip-Fgw6NW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00:00 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)) 08:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:00 INFO - Running setup.py (path:/tmp/pip-ahcXXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:00 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)) 08:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:00 INFO - Running setup.py (path:/tmp/pip-TtN4yM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00:00 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)) 08:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:00 INFO - Running setup.py (path:/tmp/pip-tAp5hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00:00 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)) 08:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:00 INFO - Running setup.py (path:/tmp/pip-k_op0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00:00 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)) 08:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:00 INFO - Running setup.py (path:/tmp/pip-xhlgTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00:00 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)) 08:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:00 INFO - Running setup.py (path:/tmp/pip-MnZLAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00:00 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)) 08:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:00 INFO - Running setup.py (path:/tmp/pip-G1ZME2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:00 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)) 08:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:00 INFO - Running setup.py (path:/tmp/pip-eOa6GC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00:01 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)) 08:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:01 INFO - Running setup.py (path:/tmp/pip-RR4YoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00:01 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)) 08:00:01 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)) 08:00:01 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)) 08:00:01 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)) 08:00:01 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)) 08:00:01 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)) 08:00:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08: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 08: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 08: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 08: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 08: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 08: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 08:00:02 INFO - Downloading blessings-1.6.tar.gz 08:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:00:03 INFO - Installing collected packages: blessings 08:00:03 INFO - Running setup.py install for blessings 08:00:03 INFO - Successfully installed blessings 08:00:03 INFO - Cleaning up... 08:00:03 INFO - Return code: 0 08:00:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:00:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:03 INFO - Reading from file tmpfile_stdout 08:00:03 INFO - Current package versions: 08:00:03 INFO - argparse == 1.2.1 08:00:03 INFO - blessings == 1.6 08:00:03 INFO - blobuploader == 1.2.4 08:00:03 INFO - docopt == 0.6.1 08:00:03 INFO - functools32 == 3.2.3-2 08:00:03 INFO - jsonschema == 2.5.1 08:00:03 INFO - manifestparser == 1.1 08:00:03 INFO - mozInstall == 1.12 08:00:03 INFO - mozcrash == 0.17 08:00:03 INFO - mozdebug == 0.1 08:00:03 INFO - mozdevice == 0.48 08:00:03 INFO - mozfile == 1.2 08:00:03 INFO - mozhttpd == 0.7 08:00:03 INFO - mozinfo == 0.9 08:00:03 INFO - mozleak == 0.1 08:00:03 INFO - mozlog == 3.2 08:00:03 INFO - moznetwork == 0.27 08:00:03 INFO - mozprocess == 0.22 08:00:03 INFO - mozprofile == 0.28 08:00:03 INFO - mozrunner == 6.11 08:00:03 INFO - mozscreenshot == 0.1 08:00:03 INFO - mozsystemmonitor == 0.3 08:00:03 INFO - moztest == 0.7 08:00:03 INFO - mozversion == 1.4 08:00:03 INFO - psutil == 3.1.1 08:00:03 INFO - requests == 1.2.3 08:00:03 INFO - wsgiref == 0.1.2 08:00:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:03 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 0x7f29b5bc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18392e0>, '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 0x17a5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a55d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', '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 08:00:03 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 08:00:03 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 08:00:03 INFO - Using env: {'DISPLAY': ':0', 08:00:03 INFO - 'HOME': '/home/cltbld', 08:00:03 INFO - 'LANG': 'en_US.UTF-8', 08:00:03 INFO - 'LANGUAGE': 'en_US:en', 08:00:03 INFO - 'LOGNAME': 'cltbld', 08:00:03 INFO - 'MAIL': '/var/mail/cltbld', 08:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:03 INFO - 'MOZ_NO_REMOTE': '1', 08:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:03 INFO - 'NO_EM_RESTART': '1', 08:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:03 INFO - 'PWD': '/builds/slave/test', 08:00:03 INFO - 'SHELL': '/bin/bash', 08:00:03 INFO - 'SHLVL': '1', 08:00:03 INFO - 'TERM': 'linux', 08:00:03 INFO - 'TMOUT': '86400', 08:00:03 INFO - 'USER': 'cltbld', 08:00:03 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', 08:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:03 INFO - '_': '/tools/buildbot/bin/python'} 08:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:03 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)) 08:00:03 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)) 08:00:03 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)) 08:00:03 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)) 08:00:03 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)) 08:00:03 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)) 08:00:03 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)) 08:00:03 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)) 08:00:03 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)) 08:00:03 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)) 08:00:03 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)) 08:00:03 INFO - Cleaning up... 08:00:03 INFO - Return code: 0 08:00:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29b5bc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18392e0>, '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 0x17a5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a55d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', '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 08:00:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:00:03 INFO - Using env: {'DISPLAY': ':0', 08:00:03 INFO - 'HOME': '/home/cltbld', 08:00:03 INFO - 'LANG': 'en_US.UTF-8', 08:00:03 INFO - 'LANGUAGE': 'en_US:en', 08:00:03 INFO - 'LOGNAME': 'cltbld', 08:00:03 INFO - 'MAIL': '/var/mail/cltbld', 08:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:03 INFO - 'MOZ_NO_REMOTE': '1', 08:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:03 INFO - 'NO_EM_RESTART': '1', 08:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:03 INFO - 'PWD': '/builds/slave/test', 08:00:03 INFO - 'SHELL': '/bin/bash', 08:00:03 INFO - 'SHLVL': '1', 08:00:03 INFO - 'TERM': 'linux', 08:00:03 INFO - 'TMOUT': '86400', 08:00:03 INFO - 'USER': 'cltbld', 08:00:03 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', 08:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:03 INFO - '_': '/tools/buildbot/bin/python'} 08:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:00:03 INFO - Cleaning up... 08:00:03 INFO - Return code: 0 08:00:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29b5bc3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18392e0>, '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 0x17a5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a55d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', '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 08:00:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:00:03 INFO - Using env: {'DISPLAY': ':0', 08:00:03 INFO - 'HOME': '/home/cltbld', 08:00:03 INFO - 'LANG': 'en_US.UTF-8', 08:00:03 INFO - 'LANGUAGE': 'en_US:en', 08:00:03 INFO - 'LOGNAME': 'cltbld', 08:00:03 INFO - 'MAIL': '/var/mail/cltbld', 08:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:03 INFO - 'MOZ_NO_REMOTE': '1', 08:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:03 INFO - 'NO_EM_RESTART': '1', 08:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:03 INFO - 'PWD': '/builds/slave/test', 08:00:03 INFO - 'SHELL': '/bin/bash', 08:00:03 INFO - 'SHLVL': '1', 08:00:03 INFO - 'TERM': 'linux', 08:00:03 INFO - 'TMOUT': '86400', 08:00:03 INFO - 'USER': 'cltbld', 08:00:03 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', 08:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:03 INFO - '_': '/tools/buildbot/bin/python'} 08:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:04 INFO - Downloading/unpacking flake8 08:00:04 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 08:00:04 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 08:00:04 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 08:00:04 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 08:00:04 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 08:00:04 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 08:00:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:00:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:00:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:06 INFO - no previously-included directories found matching 'docs/_build' 08:00:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:00:06 INFO - Running setup.py install for pep8 08:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:06 INFO - no previously-included directories found matching 'docs/_build' 08:00:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:00:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:00:06 INFO - Cleaning up... 08:00:07 INFO - Return code: 0 08:00:07 INFO - Running post-action listener: _resource_record_post_action 08:00:07 INFO - Running post-action listener: _start_resource_monitoring 08:00:07 INFO - Starting resource monitoring. 08:00:07 INFO - ##### 08:00:07 INFO - ##### Finished create-virtualenv step (success) 08:00:07 INFO - ##### 08:00:07 INFO - ##### 08:00:07 INFO - ##### Running install step. 08:00:07 INFO - ##### 08:00:07 INFO - Running pre-action listener: _resource_record_pre_action 08:00:07 INFO - Running main action method: install 08:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:07 INFO - Reading from file tmpfile_stdout 08:00:07 INFO - Detecting whether we're running mozinstall >=1.0... 08:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:00:07 INFO - Reading from file tmpfile_stdout 08:00:07 INFO - Output received: 08:00:07 INFO - Usage: mozinstall [options] installer 08:00:07 INFO - Options: 08:00:07 INFO - -h, --help show this help message and exit 08:00:07 INFO - -d DEST, --destination=DEST 08:00:07 INFO - Directory to install application into. [default: 08:00:07 INFO - "/builds/slave/test"] 08:00:07 INFO - --app=APP Application being installed. [default: firefox] 08:00:07 INFO - mkdir: /builds/slave/test/build/application 08:00:07 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'] 08:00:07 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 08:00:23 INFO - Reading from file tmpfile_stdout 08:00:23 INFO - Output received: 08:00:23 INFO - /builds/slave/test/build/application/firefox/firefox 08:00:23 INFO - Running post-action listener: _resource_record_post_action 08:00:23 INFO - ##### 08:00:23 INFO - ##### Finished install step (success) 08:00:23 INFO - ##### 08:00:23 INFO - ##### 08:00:23 INFO - ##### Running run-tests step. 08:00:23 INFO - ##### 08:00:23 INFO - Running pre-action listener: _resource_record_pre_action 08:00:23 INFO - Running main action method: run_tests 08:00:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:00:23 INFO - Python 2.7.3 08:00:23 INFO - Return code: 0 08:00:23 INFO - grabbing minidump binary from tooltool 08:00:23 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')]} 08:00:23 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 0x18392e0>, '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 0x17a5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a55d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:00:23 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 08:00:23 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 08:00:23 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 08:00:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:00:23 INFO - Return code: 0 08:00:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:00:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:00:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:00:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:00:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:00:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:00:24 INFO - Return code: 0 08:00:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:00:24 INFO - Using env: {'DISPLAY': ':0', 08:00:24 INFO - 'HOME': '/home/cltbld', 08:00:24 INFO - 'LANG': 'en_US.UTF-8', 08:00:24 INFO - 'LANGUAGE': 'en_US:en', 08:00:24 INFO - 'LOGNAME': 'cltbld', 08:00:24 INFO - 'MAIL': '/var/mail/cltbld', 08:00:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:00:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:24 INFO - 'MOZ_NO_REMOTE': '1', 08:00:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:24 INFO - 'NO_EM_RESTART': '1', 08:00:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:24 INFO - 'PWD': '/builds/slave/test', 08:00:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:00:24 INFO - 'SHELL': '/bin/bash', 08:00:24 INFO - 'SHLVL': '1', 08:00:24 INFO - 'TERM': 'linux', 08:00:24 INFO - 'TMOUT': '86400', 08:00:24 INFO - 'USER': 'cltbld', 08:00:24 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314', 08:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:24 INFO - '_': '/tools/buildbot/bin/python'} 08:00:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:00:24 INFO - mozversion application_buildid: 20160623061726 08:00:24 INFO - mozversion application_changeset: d1102663db10b3d4b9358f3cf4e16b7c56902352 08:00:24 INFO - mozversion application_display_name: Nightly 08:00:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:00:24 INFO - mozversion application_name: Firefox 08:00:24 INFO - mozversion application_remotingname: firefox 08:00:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 08:00:24 INFO - mozversion application_vendor: Mozilla 08:00:24 INFO - mozversion application_version: 50.0a1 08:00:24 INFO - mozversion platform_buildid: 20160623061726 08:00:24 INFO - mozversion platform_changeset: d1102663db10b3d4b9358f3cf4e16b7c56902352 08:00:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 08:00:24 INFO - mozversion platform_version: 50.0a1 08:00:24 INFO - using testdate: 1466694024 08:00:24 INFO - actual date: 1466694024 08:00:24 INFO - starting webserver on 'localhost:42571' 08:00:24 INFO - SUITE-START | Running 2 tests 08:00:24 INFO - TEST-START | dromaeo_css 08:00:24 INFO - operating with platform_type : linux_ 08:00:24 INFO - Initialising browser for dromaeo_css test... 08:00:24 INFO - TEST-INFO | started process 5076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXAdtcL/profile http://localhost:42571/getInfo.html) 08:00:29 INFO - PROCESS | 5076 | __metrics Screen width/height:1600/1200 08:00:29 INFO - PROCESS | 5076 | colorDepth:24 08:00:29 INFO - PROCESS | 5076 | Browser inner width/height: 1024/697 08:00:29 INFO - PROCESS | 5076 | __metrics 08:00:30 ERROR - PROCESS | 5076 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:00:31 INFO - TEST-INFO | 5076: exit 0 08:00:31 INFO - Browser initialized. 08:00:31 INFO - Running cycle 1/1 for dromaeo_css test... 08:00:31 INFO - TEST-INFO | started process 5196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXAdtcL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:00:43 INFO - PROCESS | 5196 | RSS: Main: 186163200 08:00:43 INFO - PROCESS | 5196 | 08:01:33 INFO - PROCESS | 5196 | 1466694093497 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] 08:03:45 INFO - PROCESS | 5196 | Cycle 1(1): loaded http://localhost:42571/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42571/tests/dromaeo/cssquery-ext.html) 08:03:46 INFO - PROCESS | 5196 | RSS: Main: 189558784 08:03:46 INFO - PROCESS | 5196 | 08:06:48 INFO - PROCESS | 5196 | Cycle 1(1): loaded http://localhost:42571/tests/dromaeo/cssquery-ext.html (next: http://localhost:42571/tests/dromaeo/cssquery-jquery.html) 08:06:49 INFO - PROCESS | 5196 | RSS: Main: 188473344 08:06:49 INFO - PROCESS | 5196 | 08:09:51 INFO - PROCESS | 5196 | Cycle 1(1): loaded http://localhost:42571/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42571/tests/dromaeo/cssquery-mootools.html) 08:09:52 INFO - PROCESS | 5196 | RSS: Main: 189427712 08:09:52 INFO - PROCESS | 5196 | 08:12:54 INFO - PROCESS | 5196 | Cycle 1(1): loaded http://localhost:42571/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42571/tests/dromaeo/cssquery-prototype.html) 08:12:54 INFO - PROCESS | 5196 | RSS: Main: 187764736 08:12:54 INFO - PROCESS | 5196 | 08:15:57 INFO - PROCESS | 5196 | Cycle 1(1): loaded http://localhost:42571/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42571/tests/dromaeo/cssquery-yui.html) 08:15:58 INFO - PROCESS | 5196 | RSS: Main: 189333504 08:15:58 INFO - PROCESS | 5196 | 08:19:00 INFO - PROCESS | 5196 | Cycle 1(1): loaded http://localhost:42571/tests/dromaeo/cssquery-yui.html (next: http://localhost:42571/tests/dromaeo/cssquery-dojo.html) 08:19:00 INFO - PROCESS | 5196 | RSS: Main: 189947904 08:19:00 INFO - PROCESS | 5196 | 08:19:00 INFO - PROCESS | 5196 | __start_tp_report 08:19:00 INFO - PROCESS | 5196 | _x_x_mozilla_page_load 08:19:00 INFO - PROCESS | 5196 | _x_x_mozilla_page_load_details 08:19:00 INFO - PROCESS | 5196 | |i|pagename|runs| 08:19:00 INFO - PROCESS | 5196 | |0;dojo.html;2611;2660.973390266097;2664.6535950326456;2675.772559332457;2697.8111532192743;4752.643551733621;4755.857324280269;4815.25363568647;4815.66290359675;4864.829730959417;4766.3088852116425;4804.447488538819;4806.086843499733;4876.87807804805;4949.554540091391;4313.82744690212;4439.933400998988;4481.058977614704;4513;4518.819247230107;563.7994277613474;4395.208862404766;4470.441194850644;4478.193925093482;4523.3441151033085;4453.332000199964;4458.7324760514475;4462.4645042594775;4470.147543760007;4510.075434535912;4428.512863585003;4477.462704475452;4491.101779644085;4509.1883460977015;4519.570640789153;4416.050549131952;4480.529544397824;4481.170983368054;4523.072770082125;4530.682852200347;4884.389451318585;4908.877278068041;4927.482614325516;4928.556429921325;4961.5038496150455;5134.845954621367;5276.947230527684;5288.497592728685;5296.735163241861;5299.178627312773;5358.544523715489;5367.2485851980755;5372.677639341652;5379.542738867201;5409.377921539034;4986.601071914238;5001.9249711254;5005.749712514396;5013.924791128136;5049.2426136079885;5240.816571419982;5307.761150748225;5361.51746342831;5375.81184658535;5462.481064298885;5129.461406552333;5146.768395422215;5153.098207813618;5158.277841102249;5160.974195129075;5232.2674825524455;5252.1596544552685;5259.263703081571;5260.552853007461;5295.099833028395;5100.897982040338;5148.974255128775;5188.429272779991;5207.921881171786;5209.4009188943;5066.6453348266;5114.360704911886;5118.744062796845;5156.432792392834;5160.200168973815;4443.711158774734;4449.087936972913;4454.398656181439;4462.620677242406;4496.505384407713;3812.675922546559;3866.38137897935;3866.729328947003;3890.5525864525375;3904.0630248740667;4508.57168568992;4526.977365113154;4529.705569137996;4563.9087218255445;4575.908481830411;5138.537531622172;5267.78928842842;5288.709120998382;5321.148616221386;5327.680339179584;4485.147821913891;4519.457665080211;4537.115262523842;4542.091581683677;4543.5910768031035;4621.4223222097235;4677.929831052537;4698.154332220233;4714.717116972993;4741.786619602126;4745.38310019709;4868.2940973557925;4920.040592084509;4929.901401971941;4956.925646115311;5256.211568264791;5277.472252774692;5279.6040296978645;5321.281626980308;5343.385510666323;4921.8523444296725;4930.457649658463;4937.456879743154;4953.752312384294;4991.875203119951;5011.123053465702;5147.665401749025;5162.845114646567;5207.71357575337;5222.503862133091;5218.425973142876;5234.712090834888;5270.393904701008;5284.867878302919;5324.440933702061;5142.871428214325;5156.845294641167;5160.948390516047;5172.224166375074;5176.197689358156;4982.850514484571;5020.723860187579;5089.6691715038405;5095.0574143783515;5132.050570644443;4907.288443175791;4988.5260900214425;5003.224500202475;5027.64806463544;5060.822871199491;5182.663126896739;5191.844244672666;5197.506236907488;5198.16829307309;5246.31797866275;4914.189158788903;5013.448520662651;5034.798608055637;5075.187969924795;5100.413452452867 08:19:00 INFO - PROCESS | 5196 | |1;ext.html;546.7458017733078;582.737768004398;586.7242396073843;595.294575927526;601.9217501724775;34874.82562587187;39557.60442395579;39669.40495892564;39794.801025994864;40007.399889001616;40108.197836043335;40721.59278407215;40743.79628101863;40789;40802;7683.57740324282;7888.7633370998965;7920.089189743167;7960.920390796105;7961.800954976114;7679.462437629368;7863.331616812549;7869.409794265453;7919.881201781978;7924.881126783102;7857.332126769232;7915.327197188246;7938.483998540105;7942;7961.7213397531095;7903.960480197619;7919.881201781978;7923.801904952365;7968.880466793003;7971.44199906001;7736.6518506667335;7799;7806.453548251625;7822.647980840876;7873.645685944089;37254.8137259312;37333.25333493315;37368.43947340765;37475;37548.81225593882;3137.62348518177;3379.104537297618;3541.8229088545468;3732.197577520846;3798.487204227449;29728.55407168894;29848.25379365533;29914;30230.244243894078;30477.238069048228;3202.471592187286;3289.6052473703307;3338.699517043478;3370.932581348384;3383.932321353559;261263;261621;261819;262793;263281;30221.848890755846;31644.367112658078;52092.479075208765;52207.216891746655;52472;31300.37399252048;31400;31408.685913140576;31473.685263147076;31732.524012139835;13210.27343496117;13374;13397.598072057854;13434.664133396744;13461.596152115451;11096.55613775456;11221.887781122248;11257.099432045417;11280.266782659264;11329.603463878724;7729.8454030919065;7744.225577442211;7778.144404115543;7818.726344578026;7850.803729906684;3087.367089746597;3099.8760049597763;3107.6892310769194;3127.0931429885077;3134.623845138598;872.2455076358904;888.1606881497053;967.1827305926481;978.3836183204536;986.4278718343344;26930.54555387267;27328.180154595393;27435.588466173023;27928.30179245535;28058.15825525197;1001.2740762946805;1002.7643503776607;1002.7844013537125;1038.2991480750613;1069.0699091790193;14285.428582856777;14959.024585248764;15067.698646027236;15069;15142.091474511564;338862;339168;341203;341486;342118;46728;47417.76291118522;47538.76230618825;47546;47698.28452573214;1142;1168.1239070696977;1181.2381014245934;1186.7626474705094;1188.2514016169757;25651.486970260863;26748;26971;27564;27622.723772762016;35643.10892227715;35906;35971;42200;42255;271840;273079;274140;277512;278038;24135.275941721775;24430.26709198727;24448.633270501312;24500.509989799746;24582.139625113035;39667.801660991514;39976.40035399413;40106;40547.39178912378;41052;35710.4643430354;35729;35907;35915.28169436649;36285.27429451449;35082;35234.647653523134;35409.46885796663;35723.10692232715;35760.642393576774;30975.690243098183;34661;36528.63471365252;37093;39823.80088099541;32341.191470213435;33435;33476.83261583676;33910.491342629386;34226.65773342235;25543.23370298894;25685.486290273715;25815;26027.609585856608;26161 08:19:00 INFO - PROCESS | 5196 | |2;jquery.html;366.15783697495755;374.8331992263443;375.2420111375022;381.5135701979977;383.388495349917;15888.761668574965;16533.421330253444;16863.57841053973;17140.14299285037;17205.655886882254;15908.204589770523;16320.918395408007;16836;16940.576485587866;16958.236879340428;5007.549320561139;5133.768980395891;5138.2806407103035;5167.147420675584;5178.378594568657;4980.900381992358;5050.166722490803;5056.620753443488;5129.153689641204;5129.948700513003;5091.745412729349;5107.412647545542;5120.411152717429;5124.8975020499565;5127.359080114986;4965.875853103701;5052.913623570931;5054.79780808769;5080.59355251579;5138.845834624967;4468.910621787546;4517.141743068806;4545.931811022837;4550.522195169493;4573.5426457354;13759.587212383645;13843.792343114861;13845.16928984254;18094.728579071325;20118.79881201184;1707.4962885948676;1827.6436094961489;1901.6386886491523;2013.7180794688754;2027.6654352031896;9086.909130908738;9090;9107.316951228684;9194.12655797698;9348.252139828797;1668.5661727950699;1709.9145042747814;1715.7083295839736;1727.2227497626118;1797.21821007862;47905.520944790456;58777;59476.10785838173;65386.673066634365;70269.64865175693;9122.087791220958;9183.448993060438;9812.65655702047;9861.75345616351;9920.900790992142;13156.079074464888;13184.143030702973;13221.669458263428;13227.074104812764;13312.534061308;7070.010198572204;7115.146182458035;7185.748498802517;7217.061781968416;7340.339369456668;6782.864342713118;6821.283765204582;6859.965700171567;7008.579485230801;7118.928810711826;4165.208610364081;4233.343831706091;4296.334068219431;4309.784510774512;4495.483019452805;1824.9908750456163;1828.9359872404402;1881.6788368529556;1902.2961504243242;1915.8467322614158;743.8437928035173;834.2116699718707;838.2078935406105;879.2174964281794;927.1099744245465;16719.247633856263;16817.32730690783;17219.65560688779;17263.74104388435;17467.388641397745;812.7805492516987;846.4836449765638;869.5956380283072;872.965081396737;922.8154369126202;9372.5313734313;9420.199283061016;9590.328676992543;9679.661211857692;9739.26955478342;400417;400989;403120;414719;419628;65354.67322663356;74020.62989685124;78192.21807781963;79484.60257698674;81738;881.3610132653903;887.7603047177226;902.264654306738;908.1009800297658;918.6095909238547;15572;15810.446634367741;15836.683266334378;15999.760003599722;16191.514254572381;35720.64279357173;36385.818070909474;36912.81543592265;37094.44358334681;37519.24961500809;51451.48548514467;52381.47618523766;52629;53091.20363194632;53629.927401452536;7316.561006339637;7818.413618978713;7835.5690437026515;7844.764657060297;7846.764597062097;10001;11657.591984280509;11777.764444711229;11810.881891180978;11992.220505667105;10112.140468060297;10216.948915255376;10329.535170917177;10428.53071611764;10476.947615261875;9764.462954537568;10189.235807314333;10215.795684086424;10352.53413596405;10441;10115.544800484144;10662.73343166396;10670.46647667629;10785.352878827296;10914.945425272823;7202.369748065564;7276.781696549112;7333.266673332624;7384.852302954018;7707.614619269127;9560.187384072153;10016.849747253651;10155;10341.121004714683;10416.427096509764 08:19:00 INFO - PROCESS | 5196 | |3;mootools.html;1346.5489061164512;1375.0786972728272;1404.8595140485952;1555.4322672224641;1604.0856711674344;6756.695948682309;7372.373348265397;7407.296306850854;7924.762257132288;7933.325667318278;7540.736074237403;7764.922350776491;7809.453338266324;7815.804604884866;7868.724594639189;2175.369142948547;2193.352960876537;2201.306588424649;2221.7000704904794;2223.2329846203033;2097.5070858348354;2118.8304935605115;2150.6989021536997;2150.8171805396482;2165.4586353411646;2113.3448630924386;2125.4898824282136;2126.3089495913814;2126.6597344424895;2163.9567208655817;2133.658614621661;2138.860974036683;2142.4429648291402;2145.560160167162;2151.8386121040908;2081.3131666550003;2132.1791110422446;2141.860779049357;2144.7426308842882;2160.503084290622;7916.881246781303;7964.601769911481;7979.042514898191;7979.122296547375;7989.2809647132035;4454.175977444183;4576.359309696645;4577.244754615484;4580.404547408815;4591.081783643284;2869.856507174654;2906.433245517104;2945.955810662842;2971.970280297191;2990.0880231529377;899.0425197165064;913.2055510921006;932.7714709896051;935.1770442010986;960.0831206198064;10548.78902421955;10549.52527136273;10554.525046372932;10572.524236409303;10573.577056917715;4234.1108367242605;4259.680523960716;4353.651707863363;4361.12777444506;4371.409859668904;9068.50123243228;9072.228860546795;9114.726558203265;9117.863232051392;9159.129882661136;4781.043791241766;4794.089123066676;4806.423229212517;4806.591439727592;4814.614830813526;3633.65480279373;4068.898277543085;4201.810918508674;4234.87295381139;4384.649228061748;3648.7081033517784;3681.650243226889;3722.441633754904;3757.643023912724;3762.3227818992846;1173.0849937048945;1199.6341115959717;1213.7633161533415;1218.4577862851124;1232.8335674683983;785.3717026378874;791.6041979010495;795.8368534450424;798.9840203195904;808.4785313472895;4936.925946110811;5005.949940500621;5063.0380227756605;5125;5141.408737995103;844.2275318083884;893.620211410148;914.6981496106268;917.0508523677961;918.2883265469181;3533.717302615785;3614.855405783792;3619.149499867529;3647.179384638488;3675.7978311192605;9242;9485.66800161991;9608;9628.18160456369;9635;9458.763530911783;9483.762905927408;9496.952515237517;9529.618815247451;9558.95220523893;6975.895361569581;7328.853422931618;7340.0457940467395;7348.2284360142485;7353.117625884928;5030.522100400456;5166.741662916915;5222.869428264324;5260.237265596544;5376.8118115865755;8952.776180595276;8961.686340978034;9001.099890010946;9035.322350823846;9066.50134242623;8378.958105209678;8728.170823771732;8749.606267717842;9018.954905225432;9056.683016094405;6033.155358249761;6528.151340325728;6560.245571759118;6717.865642687217;6764.458843292623;7594.468387212842;7622.466427350032;7632.389408847168;7681.807954801175;7710.691572337268;6623.403893649402;6778.288279730557;6835.453163746988;6867.965660171667;6914.827129321807;6619.735210591715;6706.262311145672;6735.595864248161;6747.763828265987;6780.559263648044;5779.2775903012125;5801.680907550125;5842.474177324061;5846.152307915413;5872.882542349214;4437.112577484451;4519.276915693474;4542.0915816836105;4602.677812553223;4605.4933957264;4446.155230506193;4449.199144153954;4508.797104130387;4542.954570454253;4573.656975726767 08:19:00 INFO - PROCESS | 5196 | |4;prototype.html;283.75738743374416;296.9806962547434;298.5715498259997;301.82192506421205;304.42007974807984;5047.444781074084;5091.236314552819;5151.974240128803;5165.354330708667;5167.509086636764;5051.77267022984;5057.0897238497055;5094.847154585359;5097.541221290083;5121.692698438096;3945.329294020009;3985.4619626350363;3986.063275130342;3997.7601343919314;3999.2401443725744;3686.889393318205;3938;3997.160596274786;4003.2593970115477;4013.799310034501;3848.7113466489986;3861.440091186776;3865.323568375523;3872.1413721413737;3884.126071633874;3880.417937309398;3884.864029758945;3888.630580094901;3894.805259737002;3896.9025774355728;3147.8740850365957;3234.7897386669792;3318.950215746766;3322.7009569138895;3332.716719078857;4959.528844759742;4964.429090654585;4968.633625752911;4977.178765503688;4979.900401991976;4379.627731642814;4401.2517871961845;4404;4409.250427427345;4415.381846541487;5064.3163172971545;5301.840944771625;5336.252924590561;5348.8127915523155;5372.006178856885;3695.1131728384994;3698.3527882620433;3718.163413232001;3727;3727.7390582659223;5565.1374037024325;5586.944130558683;5592.384837667853;5637.633553818989;5658.490735833753;3525.629808870032;3763.4569826371057;3764.680002199844;3765.4540091686554;3777.9244415111543;3782.543720667508;3815.1988082502985;3816.5115604914104;3854.284843244729;3860.2665493556133;4426.933595996063;4463.705525397599;4474.328850672425;4478.149151661174;4505.008898042425;5258.973705131526;5260.7759370974445;5347.491988261109;5402.459754024566;5416.431274716177;1321.4317843327462;1327.7917095443102;1345.5290648273026;1351.7228968061524;1352.709167528986;816.9673213071529;836.2056046755606;852.3011130872749;858;862.7153039496951;4056.9391459128137;4114.670826333886;4133.966508372907;4148.62662360389;4196.216607941613;4817.662763606584;4887.266909963463;4891.26631005352;4966.255061740768;4972.210004398414;4159.9792001039805;4205.201011807747;4215.515215750228;4282.550332215073;4287.785610719451;2462.963055554168;2668;2676.4780867730606;2817.8591070446396;2842.1899758568707;5132.358455193101;5134.845954621367;5154.639175257696;5159.303494028258;5173.508516690908;5634.802781902696;5645.379008309083;5670.262865827499;5704.401037890962;5713;4945.604351651859;5121.923171152361;5155.149400348901;5160.5550445875215;5163.974180129076;5452.236686863763;5516.972415137899;5545.916811247754;5548.944510554843;5549.861253468695;5294.338207724035;5451;5459.617826752089;5467.507924286674;5477.917831232615;5033.723145226902;5039.949600503948;5086.64393492452;5101.69389836611;5122.667026643257;3804.212020350431;3847.980285224362;3853.1715681128694;3858.4212368145004;3867.651911327994;5212.576152089145;5527.944720552904;5545.861353466195;5558.861028474321;5569;5273.34083239595;5273.393559740679;5300.787968481218;5324.893502130013;5326.760295786777;5358.866028349323;5387.92241551699;5391.75737091824;5392.649477783932;5400.729963501888;5057.494250574913;5265;5287.391949925808;5294.602904782234;5320.627556071038;5300.946990530046;5353.518183363516;5371.8450533135565;5374.381946076095;5389.51494365509;5193.792248310026;5220.9477905220465;5260.105782017143;5275.287836142225;5309.920351194658 08:19:00 INFO - PROCESS | 5196 | |5;yui.html;651.7132461716848;712.9448416343811;721.9855602887942;728.4245446097583;772.501736380035;12300.323482208474;12923.935380323086;13038.739225215513;13072.803907941377;13175.868241317585;11367.602133925315;11557.826632600518;11586.942065289682;11595.594154204604;11601.187916845824;620.2278163686217;788.6451097006342;794.1224946434194;801.3789313282194;803.3131672420085;773.7291947818275;797.1709422200933;799.3565180030073;801.2588355770889;801.7674874286479;831.9833603327929;832.2301870769544;833.5457175839182;836.5942517878824;837.3845223760532;820.2330820682681;822.0998007182126;822.62159406673;824.11819353292;825.6408462318881;604.4227762486859;605.0289285696482;606.7178761875749;607.2803727582784;607.8510764862593;13323.933380333134;13403.664908377272;13477.932610336886;13479.865201347959;13508;13178.341082945813;13446.529371471952;13522;13655.522056728067;13964.511242106477;10800.945995269973;10840.78318433627;10842.674719758419;10899.509522071527;10922.071623911977;3398.2693720850134;3431.55389799327;3434.4161492546327;3456.412409890325;3523.823808809575;51118.48881511212;52886.47113528892;52896;56984;57136;10409.68770936858;10495.842562361571;10548.63079792219;10562.524686388977;10618.469076546142;18486.445406637824;18605.7209141863;18623.348182813537;18670;18857.151428185764;7033.050538177383;7124.43004559634;7175.425965922818;7279.3621435176665;7314.780556583205;3656.341858465502;3691.7415780895617;3712.9628703713156;3718;3830.9233815324096;2927.7657787376957;2996.2509372656837;3009.5184770437063;3009.774266929989;3026.576279320897;508.54739282039014;524.3052954834859;526.5708447615182;528.2129626855957;530.212634238156;576.9125744102994;599.1778722218313;625.6965371794676;635.7107516080173;649.574528683713;7446.180920098785;7862.371010319275;7905.090914544786;7993.240642138988;8034.517928924166;587.3304432946444;594.4590422715395;612.9203203583505;621.7699451203084;632.451944590845;3640.8543658253375;3701.4262789267705;3742.55089389275;3831.482749828793;3870.3613903705573;60056.39943600595;84277.57861210777;89048.5547572258;90590.54704726434;92508;82682.58658706788;83253;83305;83306.58346708228;83307.5834620823;45035.999999999345;45544.86137846514;65708.34291657117;73463.63268183624;73790.26209737833;6952.200496942916;7217.422606191387;7363.631818408951;7439.851202976019;7524.623768811428;42148;43025.7848710767;44143.11713765771;44442.333365000195;44773;60326.69836650789;63118.684406577675;63127.6843615779;63134.368656314684;63156.68421657862;9509.524523773922;9595.760105997406;9600.279979001463;9777.071178238057;9802.411855288705;11405.600803971822;11535.307881527135;11551.711207219887;11563.595274165364;11702.122340824642;10099.394036357842;10189;10279;10475.94762026185;10498.527566259689;10416.166706663296;10483.947580262049;10837.349759014485;11001.944990274997;11106.833397498882;10056.798864022532;10334.960611896598;10460.581576736846;10486.318389304672;10616.469176541297;8417.957910210409;9001.234895033733;9016;9040.141186587263;9156.22172115351;8665.090165532529;8948.668679659517;8958.148975847284;8967.372283940062;9076.591553380245 08:19:00 INFO - PROCESS | 5196 | __end_tp_report 08:19:00 INFO - PROCESS | 5196 | __start_cc_report 08:19:00 INFO - PROCESS | 5196 | _x_x_mozilla_cycle_collect,400 08:19:00 INFO - PROCESS | 5196 | __end_cc_report 08:19:00 INFO - PROCESS | 5196 | __startTimestamp1466695140938__endTimestamp 08:19:00 INFO - PROCESS | 5196 | 08:19:00 INFO - PROCESS | 5196 | ------- Summary: start ------- 08:19:00 INFO - PROCESS | 5196 | Number of tests: 6 08:19:00 INFO - PROCESS | 5196 | 08:19:00 INFO - PROCESS | 5196 | [#0] dojo.html Cycles:165 Average:4814.03 Median:4988.53 stddev:620.85 (12.4%) stddev-sans-first:598.22 08:19:00 INFO - PROCESS | 5196 | Values: 2611.0 2661.0 2664.7 2675.8 2697.8 4752.6 4755.9 4815.3 4815.7 4864.8 4766.3 4804.4 4806.1 4876.9 4949.6 4313.8 4439.9 4481.1 4513.0 4518.8 563.8 4395.2 4470.4 4478.2 4523.3 4453.3 4458.7 4462.5 4470.1 4510.1 4428.5 4477.5 4491.1 4509.2 4519.6 4416.1 4480.5 4481.2 4523.1 4530.7 4884.4 4908.9 4927.5 4928.6 4961.5 5134.8 5276.9 5288.5 5296.7 5299.2 5358.5 5367.2 5372.7 5379.5 5409.4 4986.6 5001.9 5005.7 5013.9 5049.2 5240.8 5307.8 5361.5 5375.8 5462.5 5129.5 5146.8 5153.1 5158.3 5161.0 5232.3 5252.2 5259.3 5260.6 5295.1 5100.9 5149.0 5188.4 5207.9 5209.4 5066.6 5114.4 5118.7 5156.4 5160.2 4443.7 4449.1 4454.4 4462.6 4496.5 3812.7 3866.4 3866.7 3890.6 3904.1 4508.6 4527.0 4529.7 4563.9 4575.9 5138.5 5267.8 5288.7 5321.1 5327.7 4485.1 4519.5 4537.1 4542.1 4543.6 4621.4 4677.9 4698.2 4714.7 4741.8 4745.4 4868.3 4920.0 4929.9 4956.9 5256.2 5277.5 5279.6 5321.3 5343.4 4921.9 4930.5 4937.5 4953.8 4991.9 5011.1 5147.7 5162.8 5207.7 5222.5 5218.4 5234.7 5270.4 5284.9 5324.4 5142.9 5156.8 5160.9 5172.2 5176.2 4982.9 5020.7 5089.7 5095.1 5132.1 4907.3 4988.5 5003.2 5027.6 5060.8 5182.7 5191.8 5197.5 5198.2 5246.3 4914.2 5013.4 5034.8 5075.2 5100.4 08:19:00 INFO - PROCESS | 5196 | 08:19:00 INFO - PROCESS | 5196 | [#1] ext.html Cycles:180 Average:43651.74 Median:34767.91 stddev:77345.75 (222.5%) stddev-sans-first:77495.01 08:19:00 INFO - PROCESS | 5196 | Values: 546.7 582.7 586.7 595.3 601.9 34874.8 39557.6 39669.4 39794.8 40007.4 40108.2 40721.6 40743.8 40789.0 40802.0 7683.6 7888.8 7920.1 7960.9 7961.8 7679.5 7863.3 7869.4 7919.9 7924.9 7857.3 7915.3 7938.5 7942.0 7961.7 7904.0 7919.9 7923.8 7968.9 7971.4 7736.7 7799.0 7806.5 7822.6 7873.6 37254.8 37333.3 37368.4 37475.0 37548.8 3137.6 3379.1 3541.8 3732.2 3798.5 29728.6 29848.3 29914.0 30230.2 30477.2 3202.5 3289.6 3338.7 3370.9 3383.9 261263.0 261621.0 261819.0 262793.0 263281.0 30221.8 31644.4 52092.5 52207.2 52472.0 31300.4 31400.0 31408.7 31473.7 31732.5 13210.3 13374.0 13397.6 13434.7 13461.6 11096.6 11221.9 11257.1 11280.3 11329.6 7729.8 7744.2 7778.1 7818.7 7850.8 3087.4 3099.9 3107.7 3127.1 3134.6 872.2 888.2 967.2 978.4 986.4 26930.5 27328.2 27435.6 27928.3 28058.2 1001.3 1002.8 1002.8 1038.3 1069.1 14285.4 14959.0 15067.7 15069.0 15142.1 338862.0 339168.0 341203.0 341486.0 342118.0 46728.0 47417.8 47538.8 47546.0 47698.3 1142.0 1168.1 1181.2 1186.8 1188.3 25651.5 26748.0 26971.0 27564.0 27622.7 35643.1 35906.0 35971.0 42200.0 42255.0 271840.0 273079.0 274140.0 277512.0 278038.0 24135.3 24430.3 24448.6 24500.5 24582.1 39667.8 39976.4 40106.0 40547.4 41052.0 35710.5 35729.0 35907.0 35915.3 36285.3 35082.0 35234.6 35409.5 35723.1 35760.6 30975.7 34661.0 36528.6 37093.0 39823.8 32341.2 33435.0 33476.8 33910.5 34226.7 25543.2 25685.5 25815.0 26027.6 26161.0 08:19:00 INFO - PROCESS | 5196 | 08:19:00 INFO - PROCESS | 5196 | [#2] jquery.html Cycles:180 Average:24349.68 Median:4548.23 stddev:67127.85 (1475.9%) stddev-sans-first:67292.00 08:19:00 INFO - PROCESS | 5196 | Values: 366.2 374.8 375.2 381.5 383.4 15888.8 16533.4 16863.6 17140.1 17205.7 15908.2 16320.9 16836.0 16940.6 16958.2 5007.5 5133.8 5138.3 5167.1 5178.4 4980.9 5050.2 5056.6 5129.2 5129.9 5091.7 5107.4 5120.4 5124.9 5127.4 4965.9 5052.9 5054.8 5080.6 5138.8 4468.9 4517.1 4545.9 4550.5 4573.5 13759.6 13843.8 13845.2 18094.7 20118.8 1707.5 1827.6 1901.6 2013.7 2027.7 9086.9 9090.0 9107.3 9194.1 9348.3 1668.6 1709.9 1715.7 1727.2 1797.2 47905.5 58777.0 59476.1 65386.7 70269.6 9122.1 9183.4 9812.7 9861.8 9920.9 13156.1 13184.1 13221.7 13227.1 13312.5 7070.0 7115.1 7185.7 7217.1 7340.3 6782.9 6821.3 6860.0 7008.6 7118.9 4165.2 4233.3 4296.3 4309.8 4495.5 1825.0 1828.9 1881.7 1902.3 1915.8 743.8 834.2 838.2 879.2 927.1 16719.2 16817.3 17219.7 17263.7 17467.4 812.8 846.5 869.6 873.0 922.8 9372.5 9420.2 9590.3 9679.7 9739.3 400417.0 400989.0 403120.0 414719.0 419628.0 65354.7 74020.6 78192.2 79484.6 81738.0 881.4 887.8 902.3 908.1 918.6 15572.0 15810.4 15836.7 15999.8 16191.5 35720.6 36385.8 36912.8 37094.4 37519.2 51451.5 52381.5 52629.0 53091.2 53629.9 7316.6 7818.4 7835.6 7844.8 7846.8 10001.0 11657.6 11777.8 11810.9 11992.2 10112.1 10216.9 10329.5 10428.5 10476.9 9764.5 10189.2 10215.8 10352.5 10441.0 10115.5 10662.7 10670.5 10785.4 10914.9 7202.4 7276.8 7333.3 7384.9 7707.6 9560.2 10016.8 10155.0 10341.1 10416.4 08:19:00 INFO - PROCESS | 5196 | 08:19:00 INFO - PROCESS | 5196 | [#3] mootools.html Cycles:180 Average:5107.36 Median:5154.08 stddev:2852.91 (55.4%) stddev-sans-first:2846.91 08:19:00 INFO - PROCESS | 5196 | Values: 1346.5 1375.1 1404.9 1555.4 1604.1 6756.7 7372.4 7407.3 7924.8 7933.3 7540.7 7764.9 7809.5 7815.8 7868.7 2175.4 2193.4 2201.3 2221.7 2223.2 2097.5 2118.8 2150.7 2150.8 2165.5 2113.3 2125.5 2126.3 2126.7 2164.0 2133.7 2138.9 2142.4 2145.6 2151.8 2081.3 2132.2 2141.9 2144.7 2160.5 7916.9 7964.6 7979.0 7979.1 7989.3 4454.2 4576.4 4577.2 4580.4 4591.1 2869.9 2906.4 2946.0 2972.0 2990.1 899.0 913.2 932.8 935.2 960.1 10548.8 10549.5 10554.5 10572.5 10573.6 4234.1 4259.7 4353.7 4361.1 4371.4 9068.5 9072.2 9114.7 9117.9 9159.1 4781.0 4794.1 4806.4 4806.6 4814.6 3633.7 4068.9 4201.8 4234.9 4384.6 3648.7 3681.7 3722.4 3757.6 3762.3 1173.1 1199.6 1213.8 1218.5 1232.8 785.4 791.6 795.8 799.0 808.5 4936.9 5005.9 5063.0 5125.0 5141.4 844.2 893.6 914.7 917.1 918.3 3533.7 3614.9 3619.1 3647.2 3675.8 9242.0 9485.7 9608.0 9628.2 9635.0 9458.8 9483.8 9497.0 9529.6 9559.0 6975.9 7328.9 7340.0 7348.2 7353.1 5030.5 5166.7 5222.9 5260.2 5376.8 8952.8 8961.7 9001.1 9035.3 9066.5 8379.0 8728.2 8749.6 9019.0 9056.7 6033.2 6528.2 6560.2 6717.9 6764.5 7594.5 7622.5 7632.4 7681.8 7710.7 6623.4 6778.3 6835.5 6868.0 6914.8 6619.7 6706.3 6735.6 6747.8 6780.6 5779.3 5801.7 5842.5 5846.2 5872.9 4437.1 4519.3 4542.1 4602.7 4605.5 4446.2 4449.2 4508.8 4543.0 4573.7 08:19:00 INFO - PROCESS | 5196 | 08:19:00 INFO - PROCESS | 5196 | [#4] prototype.html Cycles:180 Average:4354.27 Median:5006.81 stddev:1307.17 (26.1%) stddev-sans-first:1274.63 08:19:00 INFO - PROCESS | 5196 | Values: 283.8 297.0 298.6 301.8 304.4 5047.4 5091.2 5152.0 5165.4 5167.5 5051.8 5057.1 5094.8 5097.5 5121.7 3945.3 3985.5 3986.1 3997.8 3999.2 3686.9 3938.0 3997.2 4003.3 4013.8 3848.7 3861.4 3865.3 3872.1 3884.1 3880.4 3884.9 3888.6 3894.8 3896.9 3147.9 3234.8 3319.0 3322.7 3332.7 4959.5 4964.4 4968.6 4977.2 4979.9 4379.6 4401.3 4404.0 4409.3 4415.4 5064.3 5301.8 5336.3 5348.8 5372.0 3695.1 3698.4 3718.2 3727.0 3727.7 5565.1 5586.9 5592.4 5637.6 5658.5 3525.6 3763.5 3764.7 3765.5 3777.9 3782.5 3815.2 3816.5 3854.3 3860.3 4426.9 4463.7 4474.3 4478.1 4505.0 5259.0 5260.8 5347.5 5402.5 5416.4 1321.4 1327.8 1345.5 1351.7 1352.7 817.0 836.2 852.3 858.0 862.7 4056.9 4114.7 4134.0 4148.6 4196.2 4817.7 4887.3 4891.3 4966.3 4972.2 4160.0 4205.2 4215.5 4282.6 4287.8 2463.0 2668.0 2676.5 2817.9 2842.2 5132.4 5134.8 5154.6 5159.3 5173.5 5634.8 5645.4 5670.3 5704.4 5713.0 4945.6 5121.9 5155.1 5160.6 5164.0 5452.2 5517.0 5545.9 5548.9 5549.9 5294.3 5451.0 5459.6 5467.5 5477.9 5033.7 5039.9 5086.6 5101.7 5122.7 3804.2 3848.0 3853.2 3858.4 3867.7 5212.6 5527.9 5545.9 5558.9 5569.0 5273.3 5273.4 5300.8 5324.9 5326.8 5358.9 5387.9 5391.8 5392.6 5400.7 5057.5 5265.0 5287.4 5294.6 5320.6 5300.9 5353.5 5371.8 5374.4 5389.5 5193.8 5220.9 5260.1 5275.3 5309.9 08:19:00 INFO - PROCESS | 5196 | 08:19:00 INFO - PROCESS | 5196 | [#5] yui.html Cycles:180 Average:16450.07 Median:57060.00 stddev:23072.46 (40.4%) stddev-sans-first:23106.69 08:19:00 INFO - PROCESS | 5196 | Values: 651.7 712.9 722.0 728.4 772.5 12300.3 12923.9 13038.7 13072.8 13175.9 11367.6 11557.8 11586.9 11595.6 11601.2 620.2 788.6 794.1 801.4 803.3 773.7 797.2 799.4 801.3 801.8 832.0 832.2 833.5 836.6 837.4 820.2 822.1 822.6 824.1 825.6 604.4 605.0 606.7 607.3 607.9 13323.9 13403.7 13477.9 13479.9 13508.0 13178.3 13446.5 13522.0 13655.5 13964.5 10800.9 10840.8 10842.7 10899.5 10922.1 3398.3 3431.6 3434.4 3456.4 3523.8 51118.5 52886.5 52896.0 56984.0 57136.0 10409.7 10495.8 10548.6 10562.5 10618.5 18486.4 18605.7 18623.3 18670.0 18857.2 7033.1 7124.4 7175.4 7279.4 7314.8 3656.3 3691.7 3713.0 3718.0 3830.9 2927.8 2996.3 3009.5 3009.8 3026.6 508.5 524.3 526.6 528.2 530.2 576.9 599.2 625.7 635.7 649.6 7446.2 7862.4 7905.1 7993.2 8034.5 587.3 594.5 612.9 621.8 632.5 3640.9 3701.4 3742.6 3831.5 3870.4 60056.4 84277.6 89048.6 90590.5 92508.0 82682.6 83253.0 83305.0 83306.6 83307.6 45036.0 45544.9 65708.3 73463.6 73790.3 6952.2 7217.4 7363.6 7439.9 7524.6 42148.0 43025.8 44143.1 44442.3 44773.0 60326.7 63118.7 63127.7 63134.4 63156.7 9509.5 9595.8 9600.3 9777.1 9802.4 11405.6 11535.3 11551.7 11563.6 11702.1 10099.4 10189.0 10279.0 10475.9 10498.5 10416.2 10483.9 10837.3 11001.9 11106.8 10056.8 10335.0 10460.6 10486.3 10616.5 8418.0 9001.2 9016.0 9040.1 9156.2 8665.1 8948.7 8958.1 8967.4 9076.6 08:19:00 INFO - PROCESS | 5196 | -------- Summary: end -------- 08:19:00 INFO - PROCESS | 5196 | 08:19:01 INFO - TEST-INFO | 5196: exit 0 08:19:01 INFO - TEST-OK | dromaeo_css | took 1116989ms 08:19:01 INFO - TEST-START | kraken 08:19:01 INFO - operating with platform_type : linux_ 08:19:01 INFO - Initialising browser for kraken test... 08:19:01 INFO - TEST-INFO | started process 5431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplAdTuu/profile http://localhost:42571/getInfo.html) 08:19:07 INFO - PROCESS | 5431 | __metrics Screen width/height:1600/1200 08:19:07 INFO - PROCESS | 5431 | colorDepth:24 08:19:07 INFO - PROCESS | 5431 | Browser inner width/height: 1024/697 08:19:07 INFO - PROCESS | 5431 | __metrics 08:19:07 ERROR - PROCESS | 5431 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:19:08 INFO - TEST-INFO | 5431: exit 0 08:19:08 INFO - Browser initialized. 08:19:08 INFO - Running cycle 1/1 for kraken test... 08:19:08 INFO - TEST-INFO | started process 5549 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplAdTuu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:20 INFO - PROCESS | 5549 | RSS: Main: 186204160 08:19:20 INFO - PROCESS | 5549 | 08:19:23 INFO - PROCESS | 5549 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42571/tests/kraken/driver.html?testName=audio-beat-detection) 08:19:24 INFO - PROCESS | 5549 | RSS: Main: 190816256 08:19:24 INFO - PROCESS | 5549 | 08:19:27 INFO - PROCESS | 5549 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42571/tests/kraken/driver.html?testName=audio-dft) 08:19:28 INFO - PROCESS | 5549 | RSS: Main: 190435328 08:19:28 INFO - PROCESS | 5549 | 08:19:31 INFO - PROCESS | 5549 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42571/tests/kraken/driver.html?testName=audio-fft) 08:19:31 INFO - PROCESS | 5549 | RSS: Main: 186568704 08:19:31 INFO - PROCESS | 5549 | 08:19:33 INFO - PROCESS | 5549 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42571/tests/kraken/driver.html?testName=audio-oscillator) 08:19:34 INFO - PROCESS | 5549 | RSS: Main: 187170816 08:19:34 INFO - PROCESS | 5549 | 08:19:36 INFO - PROCESS | 5549 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42571/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:19:37 INFO - PROCESS | 5549 | RSS: Main: 187416576 08:19:37 INFO - PROCESS | 5549 | 08:19:40 INFO - PROCESS | 5549 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42571/tests/kraken/driver.html?testName=imaging-darkroom) 08:19:41 INFO - PROCESS | 5549 | RSS: Main: 187756544 08:19:41 INFO - PROCESS | 5549 | 08:19:44 INFO - PROCESS | 5549 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42571/tests/kraken/driver.html?testName=imaging-desaturate) 08:19:45 INFO - PROCESS | 5549 | RSS: Main: 185073664 08:19:45 INFO - PROCESS | 5549 | 08:19:48 INFO - PROCESS | 5549 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42571/tests/kraken/driver.html?testName=json-parse-financial) 08:19:48 INFO - PROCESS | 5549 | RSS: Main: 185950208 08:19:48 INFO - PROCESS | 5549 | 08:19:50 INFO - PROCESS | 5549 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42571/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:19:51 INFO - PROCESS | 5549 | RSS: Main: 186535936 08:19:51 INFO - PROCESS | 5549 | 08:19:53 INFO - PROCESS | 5549 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:19:53 INFO - PROCESS | 5549 | RSS: Main: 186818560 08:19:53 INFO - PROCESS | 5549 | 08:19:56 INFO - PROCESS | 5549 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:19:56 INFO - PROCESS | 5549 | RSS: Main: 187166720 08:19:56 INFO - PROCESS | 5549 | 08:19:59 INFO - PROCESS | 5549 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:20:00 INFO - PROCESS | 5549 | RSS: Main: 187674624 08:20:00 INFO - PROCESS | 5549 | 08:20:03 INFO - PROCESS | 5549 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:20:03 INFO - PROCESS | 5549 | RSS: Main: 187068416 08:20:03 INFO - PROCESS | 5549 | 08:20:05 INFO - PROCESS | 5549 | Cycle 1(1): loaded http://localhost:42571/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42571/tests/kraken/driver.html?testName=ai-astar) 08:20:06 INFO - PROCESS | 5549 | RSS: Main: 188379136 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | __start_tp_report 08:20:06 INFO - PROCESS | 5549 | _x_x_mozilla_page_load 08:20:06 INFO - PROCESS | 5549 | _x_x_mozilla_page_load_details 08:20:06 INFO - PROCESS | 5549 | |i|pagename|runs| 08:20:06 INFO - PROCESS | 5549 | |0;ai-astar;105;116;107;116;116;115;115;114;115;114 08:20:06 INFO - PROCESS | 5549 | |1;audio-beat-detection;176;142;167;196;137;160;155;139;186;133 08:20:06 INFO - PROCESS | 5549 | |2;audio-dft;163;168;173;164;165;164;165;165;164;163 08:20:06 INFO - PROCESS | 5549 | |3;audio-fft;77;76;76;169;78;76;77;78;164;79 08:20:06 INFO - PROCESS | 5549 | |4;audio-oscillator;88;86;155;88;88;86;142;87;87;127 08:20:06 INFO - PROCESS | 5549 | |5;imaging-gaussian-blur;119;119;118;118;118;118;118;121;117;118 08:20:06 INFO - PROCESS | 5549 | |6;imaging-darkroom;148;148;148;150;149;148;150;149;150;149 08:20:06 INFO - PROCESS | 5549 | |7;imaging-desaturate;95;96;96;96;96;96;95;96;96;97 08:20:06 INFO - PROCESS | 5549 | |8;json-parse-financial;67;67;67;66;68;68;68;67;66;69 08:20:06 INFO - PROCESS | 5549 | |9;json-stringify-tinderbox;64;64;65;66;66;65;66;64;65;65 08:20:06 INFO - PROCESS | 5549 | |10;stanford-crypto-aes;82;82;84;88;90;85;90;85;101;89 08:20:06 INFO - PROCESS | 5549 | |11;stanford-crypto-ccm;147;150;137;132;132;150;139;143;136;131 08:20:06 INFO - PROCESS | 5549 | |12;stanford-crypto-pbkdf2;174;176;178;176;169;173;178;175;176;169 08:20:06 INFO - PROCESS | 5549 | |13;stanford-crypto-sha256-iterative;67;72;71;73;69;68;68;69;68;68 08:20:06 INFO - PROCESS | 5549 | __end_tp_report 08:20:06 INFO - PROCESS | 5549 | __start_cc_report 08:20:06 INFO - PROCESS | 5549 | _x_x_mozilla_cycle_collect,975 08:20:06 INFO - PROCESS | 5549 | __end_cc_report 08:20:06 INFO - PROCESS | 5549 | __startTimestamp1466695206009__endTimestamp 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | ------- Summary: start ------- 08:20:06 INFO - PROCESS | 5549 | Number of tests: 14 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | [#0] ai-astar Cycles:10 Average:113.30 Median:115.00 stddev:3.95 (3.4%) stddev-sans-first:2.82 08:20:06 INFO - PROCESS | 5549 | Values: 105.0 116.0 107.0 116.0 116.0 115.0 115.0 114.0 115.0 114.0 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | [#1] audio-beat-detection Cycles:10 Average:159.10 Median:163.50 stddev:21.90 (13.4%) stddev-sans-first:22.36 08:20:06 INFO - PROCESS | 5549 | Values: 176.0 142.0 167.0 196.0 137.0 160.0 155.0 139.0 186.0 133.0 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:3.03 (1.8%) stddev-sans-first:3.08 08:20:06 INFO - PROCESS | 5549 | Values: 163.0 168.0 173.0 164.0 165.0 164.0 165.0 165.0 164.0 163.0 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | [#3] audio-fft Cycles:10 Average:95.00 Median:77.00 stddev:37.72 (49.0%) stddev-sans-first:39.44 08:20:06 INFO - PROCESS | 5549 | Values: 77.0 76.0 76.0 169.0 78.0 76.0 77.0 78.0 164.0 79.0 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:87.00 stddev:27.01 (31.0%) stddev-sans-first:28.06 08:20:06 INFO - PROCESS | 5549 | Values: 88.0 86.0 155.0 88.0 88.0 86.0 142.0 87.0 87.0 127.0 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:1.07 (0.9%) stddev-sans-first:1.12 08:20:06 INFO - PROCESS | 5549 | Values: 119.0 119.0 118.0 118.0 118.0 118.0 118.0 121.0 117.0 118.0 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 08:20:06 INFO - PROCESS | 5549 | Values: 148.0 148.0 148.0 150.0 149.0 148.0 150.0 149.0 150.0 149.0 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 08:20:06 INFO - PROCESS | 5549 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 97.0 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:67.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 08:20:06 INFO - PROCESS | 5549 | Values: 67.0 67.0 67.0 66.0 68.0 68.0 68.0 67.0 66.0 69.0 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 08:20:06 INFO - PROCESS | 5549 | Values: 64.0 64.0 65.0 66.0 66.0 65.0 66.0 64.0 65.0 65.0 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:86.50 stddev:5.60 (6.5%) stddev-sans-first:5.56 08:20:06 INFO - PROCESS | 5549 | Values: 82.0 82.0 84.0 88.0 90.0 85.0 90.0 85.0 101.0 89.0 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:141.00 stddev:7.39 (5.2%) stddev-sans-first:7.36 08:20:06 INFO - PROCESS | 5549 | Values: 147.0 150.0 137.0 132.0 132.0 150.0 139.0 143.0 136.0 131.0 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:176.00 stddev:3.24 (1.8%) stddev-sans-first:3.43 08:20:06 INFO - PROCESS | 5549 | Values: 174.0 176.0 178.0 176.0 169.0 173.0 178.0 175.0 176.0 169.0 08:20:06 INFO - PROCESS | 5549 | 08:20:06 INFO - PROCESS | 5549 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:2.00 (2.9%) stddev-sans-first:1.94 08:20:06 INFO - PROCESS | 5549 | Values: 67.0 72.0 71.0 73.0 69.0 68.0 68.0 69.0 68.0 68.0 08:20:06 INFO - PROCESS | 5549 | -------- Summary: end -------- 08:20:06 INFO - PROCESS | 5549 | 08:20:07 INFO - TEST-INFO | 5549: exit 0 08:20:07 INFO - TEST-OK | kraken | took 65409ms 08:20:07 INFO - SUITE-END | took 1182s 08:20:07 INFO - Completed test suite (00:19:42) 08:20:07 INFO - javascript benchmark 08:20:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6325.0697359042915, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2611.0, 2660.973390266097, 2664.6535950326456, 2675.772559332457, 2697.8111532192743, 4752.643551733621, 4755.857324280269, 4815.25363568647, 4815.66290359675, 4864.829730959417, 4766.3088852116425, 4804.447488538819, 4806.086843499733, 4876.87807804805, 4949.554540091391, 4313.82744690212, 4439.933400998988, 4481.058977614704, 4513.0, 4518.819247230107, 563.7994277613474, 4395.208862404766, 4470.441194850644, 4478.193925093482, 4523.3441151033085, 4453.332000199964, 4458.7324760514475, 4462.4645042594775, 4470.147543760007, 4510.075434535912, 4428.512863585003, 4477.462704475452, 4491.101779644085, 4509.1883460977015, 4519.570640789153, 4416.050549131952, 4480.529544397824, 4481.170983368054, 4523.072770082125, 4530.682852200347, 4884.389451318585, 4908.877278068041, 4927.482614325516, 4928.556429921325, 4961.5038496150455, 5134.845954621367, 5276.947230527684, 5288.497592728685, 5296.735163241861, 5299.178627312773, 5358.544523715489, 5367.2485851980755, 5372.677639341652, 5379.542738867201, 5409.377921539034, 4986.601071914238, 5001.9249711254, 5005.749712514396, 5013.924791128136, 5049.2426136079885, 5240.816571419982, 5307.761150748225, 5361.51746342831, 5375.81184658535, 5462.481064298885, 5129.461406552333, 5146.768395422215, 5153.098207813618, 5158.277841102249, 5160.974195129075, 5232.2674825524455, 5252.1596544552685, 5259.263703081571, 5260.552853007461, 5295.099833028395, 5100.897982040338, 5148.974255128775, 5188.429272779991, 5207.921881171786, 5209.4009188943, 5066.6453348266, 5114.360704911886, 5118.744062796845, 5156.432792392834, 5160.200168973815, 4443.711158774734, 4449.087936972913, 4454.398656181439, 4462.620677242406, 4496.505384407713, 3812.675922546559, 3866.38137897935, 3866.729328947003, 3890.5525864525375, 3904.0630248740667, 4508.57168568992, 4526.977365113154, 4529.705569137996, 4563.9087218255445, 4575.908481830411, 5138.537531622172, 5267.78928842842, 5288.709120998382, 5321.148616221386, 5327.680339179584, 4485.147821913891, 4519.457665080211, 4537.115262523842, 4542.091581683677, 4543.5910768031035, 4621.4223222097235, 4677.929831052537, 4698.154332220233, 4714.717116972993, 4741.786619602126, 4745.38310019709, 4868.2940973557925, 4920.040592084509, 4929.901401971941, 4956.925646115311, 5256.211568264791, 5277.472252774692, 5279.6040296978645, 5321.281626980308, 5343.385510666323, 4921.8523444296725, 4930.457649658463, 4937.456879743154, 4953.752312384294, 4991.875203119951, 5011.123053465702, 5147.665401749025, 5162.845114646567, 5207.71357575337, 5222.503862133091, 5218.425973142876, 5234.712090834888, 5270.393904701008, 5284.867878302919, 5324.440933702061, 5142.871428214325, 5156.845294641167, 5160.948390516047, 5172.224166375074, 5176.197689358156, 4982.850514484571, 5020.723860187579, 5089.6691715038405, 5095.0574143783515, 5132.050570644443, 4907.288443175791, 4988.5260900214425, 5003.224500202475, 5027.64806463544, 5060.822871199491, 5182.663126896739, 5191.844244672666, 5197.506236907488, 5198.16829307309, 5246.31797866275, 4914.189158788903, 5013.448520662651, 5034.798608055637, 5075.187969924795, 5100.413452452867], "value": 4774.786208386668, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.7458017733078, 582.737768004398, 586.7242396073843, 595.294575927526, 601.9217501724775, 34874.82562587187, 39557.60442395579, 39669.40495892564, 39794.801025994864, 40007.399889001616, 40108.197836043335, 40721.59278407215, 40743.79628101863, 40789.0, 40802.0, 7683.57740324282, 7888.7633370998965, 7920.089189743167, 7960.920390796105, 7961.800954976114, 7679.462437629368, 7863.331616812549, 7869.409794265453, 7919.881201781978, 7924.881126783102, 7857.332126769232, 7915.327197188246, 7938.483998540105, 7942.0, 7961.7213397531095, 7903.960480197619, 7919.881201781978, 7923.801904952365, 7968.880466793003, 7971.44199906001, 7736.6518506667335, 7799.0, 7806.453548251625, 7822.647980840876, 7873.645685944089, 37254.8137259312, 37333.25333493315, 37368.43947340765, 37475.0, 37548.81225593882, 3137.62348518177, 3379.104537297618, 3541.8229088545468, 3732.197577520846, 3798.487204227449, 29728.55407168894, 29848.25379365533, 29914.0, 30230.244243894078, 30477.238069048228, 3202.471592187286, 3289.6052473703307, 3338.699517043478, 3370.932581348384, 3383.932321353559, 261263.0, 261621.0, 261819.0, 262793.0, 263281.0, 30221.848890755846, 31644.367112658078, 52092.479075208765, 52207.216891746655, 52472.0, 31300.37399252048, 31400.0, 31408.685913140576, 31473.685263147076, 31732.524012139835, 13210.27343496117, 13374.0, 13397.598072057854, 13434.664133396744, 13461.596152115451, 11096.55613775456, 11221.887781122248, 11257.099432045417, 11280.266782659264, 11329.603463878724, 7729.8454030919065, 7744.225577442211, 7778.144404115543, 7818.726344578026, 7850.803729906684, 3087.367089746597, 3099.8760049597763, 3107.6892310769194, 3127.0931429885077, 3134.623845138598, 872.2455076358904, 888.1606881497053, 967.1827305926481, 978.3836183204536, 986.4278718343344, 26930.54555387267, 27328.180154595393, 27435.588466173023, 27928.30179245535, 28058.15825525197, 1001.2740762946805, 1002.7643503776607, 1002.7844013537125, 1038.2991480750613, 1069.0699091790193, 14285.428582856777, 14959.024585248764, 15067.698646027236, 15069.0, 15142.091474511564, 338862.0, 339168.0, 341203.0, 341486.0, 342118.0, 46728.0, 47417.76291118522, 47538.76230618825, 47546.0, 47698.28452573214, 1142.0, 1168.1239070696977, 1181.2381014245934, 1186.7626474705094, 1188.2514016169757, 25651.486970260863, 26748.0, 26971.0, 27564.0, 27622.723772762016, 35643.10892227715, 35906.0, 35971.0, 42200.0, 42255.0, 271840.0, 273079.0, 274140.0, 277512.0, 278038.0, 24135.275941721775, 24430.26709198727, 24448.633270501312, 24500.509989799746, 24582.139625113035, 39667.801660991514, 39976.40035399413, 40106.0, 40547.39178912378, 41052.0, 35710.4643430354, 35729.0, 35907.0, 35915.28169436649, 36285.27429451449, 35082.0, 35234.647653523134, 35409.46885796663, 35723.10692232715, 35760.642393576774, 30975.690243098183, 34661.0, 36528.63471365252, 37093.0, 39823.80088099541, 32341.191470213435, 33435.0, 33476.83261583676, 33910.491342629386, 34226.65773342235, 25543.23370298894, 25685.486290273715, 25815.0, 26027.609585856608, 26161.0], "value": 16257.963571502489, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.15783697495755, 374.8331992263443, 375.2420111375022, 381.5135701979977, 383.388495349917, 15888.761668574965, 16533.421330253444, 16863.57841053973, 17140.14299285037, 17205.655886882254, 15908.204589770523, 16320.918395408007, 16836.0, 16940.576485587866, 16958.236879340428, 5007.549320561139, 5133.768980395891, 5138.2806407103035, 5167.147420675584, 5178.378594568657, 4980.900381992358, 5050.166722490803, 5056.620753443488, 5129.153689641204, 5129.948700513003, 5091.745412729349, 5107.412647545542, 5120.411152717429, 5124.8975020499565, 5127.359080114986, 4965.875853103701, 5052.913623570931, 5054.79780808769, 5080.59355251579, 5138.845834624967, 4468.910621787546, 4517.141743068806, 4545.931811022837, 4550.522195169493, 4573.5426457354, 13759.587212383645, 13843.792343114861, 13845.16928984254, 18094.728579071325, 20118.79881201184, 1707.4962885948676, 1827.6436094961489, 1901.6386886491523, 2013.7180794688754, 2027.6654352031896, 9086.909130908738, 9090.0, 9107.316951228684, 9194.12655797698, 9348.252139828797, 1668.5661727950699, 1709.9145042747814, 1715.7083295839736, 1727.2227497626118, 1797.21821007862, 47905.520944790456, 58777.0, 59476.10785838173, 65386.673066634365, 70269.64865175693, 9122.087791220958, 9183.448993060438, 9812.65655702047, 9861.75345616351, 9920.900790992142, 13156.079074464888, 13184.143030702973, 13221.669458263428, 13227.074104812764, 13312.534061308, 7070.010198572204, 7115.146182458035, 7185.748498802517, 7217.061781968416, 7340.339369456668, 6782.864342713118, 6821.283765204582, 6859.965700171567, 7008.579485230801, 7118.928810711826, 4165.208610364081, 4233.343831706091, 4296.334068219431, 4309.784510774512, 4495.483019452805, 1824.9908750456163, 1828.9359872404402, 1881.6788368529556, 1902.2961504243242, 1915.8467322614158, 743.8437928035173, 834.2116699718707, 838.2078935406105, 879.2174964281794, 927.1099744245465, 16719.247633856263, 16817.32730690783, 17219.65560688779, 17263.74104388435, 17467.388641397745, 812.7805492516987, 846.4836449765638, 869.5956380283072, 872.965081396737, 922.8154369126202, 9372.5313734313, 9420.199283061016, 9590.328676992543, 9679.661211857692, 9739.26955478342, 400417.0, 400989.0, 403120.0, 414719.0, 419628.0, 65354.67322663356, 74020.62989685124, 78192.21807781963, 79484.60257698674, 81738.0, 881.3610132653903, 887.7603047177226, 902.264654306738, 908.1009800297658, 918.6095909238547, 15572.0, 15810.446634367741, 15836.683266334378, 15999.760003599722, 16191.514254572381, 35720.64279357173, 36385.818070909474, 36912.81543592265, 37094.44358334681, 37519.24961500809, 51451.48548514467, 52381.47618523766, 52629.0, 53091.20363194632, 53629.927401452536, 7316.561006339637, 7818.413618978713, 7835.5690437026515, 7844.764657060297, 7846.764597062097, 10001.0, 11657.591984280509, 11777.764444711229, 11810.881891180978, 11992.220505667105, 10112.140468060297, 10216.948915255376, 10329.535170917177, 10428.53071611764, 10476.947615261875, 9764.462954537568, 10189.235807314333, 10215.795684086424, 10352.53413596405, 10441.0, 10115.544800484144, 10662.73343166396, 10670.46647667629, 10785.352878827296, 10914.945425272823, 7202.369748065564, 7276.781696549112, 7333.266673332624, 7384.852302954018, 7707.614619269127, 9560.187384072153, 10016.849747253651, 10155.0, 10341.121004714683, 10416.427096509764], "value": 8017.209234848773, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.5489061164512, 1375.0786972728272, 1404.8595140485952, 1555.4322672224641, 1604.0856711674344, 6756.695948682309, 7372.373348265397, 7407.296306850854, 7924.762257132288, 7933.325667318278, 7540.736074237403, 7764.922350776491, 7809.453338266324, 7815.804604884866, 7868.724594639189, 2175.369142948547, 2193.352960876537, 2201.306588424649, 2221.7000704904794, 2223.2329846203033, 2097.5070858348354, 2118.8304935605115, 2150.6989021536997, 2150.8171805396482, 2165.4586353411646, 2113.3448630924386, 2125.4898824282136, 2126.3089495913814, 2126.6597344424895, 2163.9567208655817, 2133.658614621661, 2138.860974036683, 2142.4429648291402, 2145.560160167162, 2151.8386121040908, 2081.3131666550003, 2132.1791110422446, 2141.860779049357, 2144.7426308842882, 2160.503084290622, 7916.881246781303, 7964.601769911481, 7979.042514898191, 7979.122296547375, 7989.2809647132035, 4454.175977444183, 4576.359309696645, 4577.244754615484, 4580.404547408815, 4591.081783643284, 2869.856507174654, 2906.433245517104, 2945.955810662842, 2971.970280297191, 2990.0880231529377, 899.0425197165064, 913.2055510921006, 932.7714709896051, 935.1770442010986, 960.0831206198064, 10548.78902421955, 10549.52527136273, 10554.525046372932, 10572.524236409303, 10573.577056917715, 4234.1108367242605, 4259.680523960716, 4353.651707863363, 4361.12777444506, 4371.409859668904, 9068.50123243228, 9072.228860546795, 9114.726558203265, 9117.863232051392, 9159.129882661136, 4781.043791241766, 4794.089123066676, 4806.423229212517, 4806.591439727592, 4814.614830813526, 3633.65480279373, 4068.898277543085, 4201.810918508674, 4234.87295381139, 4384.649228061748, 3648.7081033517784, 3681.650243226889, 3722.441633754904, 3757.643023912724, 3762.3227818992846, 1173.0849937048945, 1199.6341115959717, 1213.7633161533415, 1218.4577862851124, 1232.8335674683983, 785.3717026378874, 791.6041979010495, 795.8368534450424, 798.9840203195904, 808.4785313472895, 4936.925946110811, 5005.949940500621, 5063.0380227756605, 5125.0, 5141.408737995103, 844.2275318083884, 893.620211410148, 914.6981496106268, 917.0508523677961, 918.2883265469181, 3533.717302615785, 3614.855405783792, 3619.149499867529, 3647.179384638488, 3675.7978311192605, 9242.0, 9485.66800161991, 9608.0, 9628.18160456369, 9635.0, 9458.763530911783, 9483.762905927408, 9496.952515237517, 9529.618815247451, 9558.95220523893, 6975.895361569581, 7328.853422931618, 7340.0457940467395, 7348.2284360142485, 7353.117625884928, 5030.522100400456, 5166.741662916915, 5222.869428264324, 5260.237265596544, 5376.8118115865755, 8952.776180595276, 8961.686340978034, 9001.099890010946, 9035.322350823846, 9066.50134242623, 8378.958105209678, 8728.170823771732, 8749.606267717842, 9018.954905225432, 9056.683016094405, 6033.155358249761, 6528.151340325728, 6560.245571759118, 6717.865642687217, 6764.458843292623, 7594.468387212842, 7622.466427350032, 7632.389408847168, 7681.807954801175, 7710.691572337268, 6623.403893649402, 6778.288279730557, 6835.453163746988, 6867.965660171667, 6914.827129321807, 6619.735210591715, 6706.262311145672, 6735.595864248161, 6747.763828265987, 6780.559263648044, 5779.2775903012125, 5801.680907550125, 5842.474177324061, 5846.152307915413, 5872.882542349214, 4437.112577484451, 4519.276915693474, 4542.0915816836105, 4602.677812553223, 4605.4933957264, 4446.155230506193, 4449.199144153954, 4508.797104130387, 4542.954570454253, 4573.656975726767], "value": 4119.145522728165, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.75738743374416, 296.9806962547434, 298.5715498259997, 301.82192506421205, 304.42007974807984, 5047.444781074084, 5091.236314552819, 5151.974240128803, 5165.354330708667, 5167.509086636764, 5051.77267022984, 5057.0897238497055, 5094.847154585359, 5097.541221290083, 5121.692698438096, 3945.329294020009, 3985.4619626350363, 3986.063275130342, 3997.7601343919314, 3999.2401443725744, 3686.889393318205, 3938.0, 3997.160596274786, 4003.2593970115477, 4013.799310034501, 3848.7113466489986, 3861.440091186776, 3865.323568375523, 3872.1413721413737, 3884.126071633874, 3880.417937309398, 3884.864029758945, 3888.630580094901, 3894.805259737002, 3896.9025774355728, 3147.8740850365957, 3234.7897386669792, 3318.950215746766, 3322.7009569138895, 3332.716719078857, 4959.528844759742, 4964.429090654585, 4968.633625752911, 4977.178765503688, 4979.900401991976, 4379.627731642814, 4401.2517871961845, 4404.0, 4409.250427427345, 4415.381846541487, 5064.3163172971545, 5301.840944771625, 5336.252924590561, 5348.8127915523155, 5372.006178856885, 3695.1131728384994, 3698.3527882620433, 3718.163413232001, 3727.0, 3727.7390582659223, 5565.1374037024325, 5586.944130558683, 5592.384837667853, 5637.633553818989, 5658.490735833753, 3525.629808870032, 3763.4569826371057, 3764.680002199844, 3765.4540091686554, 3777.9244415111543, 3782.543720667508, 3815.1988082502985, 3816.5115604914104, 3854.284843244729, 3860.2665493556133, 4426.933595996063, 4463.705525397599, 4474.328850672425, 4478.149151661174, 4505.008898042425, 5258.973705131526, 5260.7759370974445, 5347.491988261109, 5402.459754024566, 5416.431274716177, 1321.4317843327462, 1327.7917095443102, 1345.5290648273026, 1351.7228968061524, 1352.709167528986, 816.9673213071529, 836.2056046755606, 852.3011130872749, 858.0, 862.7153039496951, 4056.9391459128137, 4114.670826333886, 4133.966508372907, 4148.62662360389, 4196.216607941613, 4817.662763606584, 4887.266909963463, 4891.26631005352, 4966.255061740768, 4972.210004398414, 4159.9792001039805, 4205.201011807747, 4215.515215750228, 4282.550332215073, 4287.785610719451, 2462.963055554168, 2668.0, 2676.4780867730606, 2817.8591070446396, 2842.1899758568707, 5132.358455193101, 5134.845954621367, 5154.639175257696, 5159.303494028258, 5173.508516690908, 5634.802781902696, 5645.379008309083, 5670.262865827499, 5704.401037890962, 5713.0, 4945.604351651859, 5121.923171152361, 5155.149400348901, 5160.5550445875215, 5163.974180129076, 5452.236686863763, 5516.972415137899, 5545.916811247754, 5548.944510554843, 5549.861253468695, 5294.338207724035, 5451.0, 5459.617826752089, 5467.507924286674, 5477.917831232615, 5033.723145226902, 5039.949600503948, 5086.64393492452, 5101.69389836611, 5122.667026643257, 3804.212020350431, 3847.980285224362, 3853.1715681128694, 3858.4212368145004, 3867.651911327994, 5212.576152089145, 5527.944720552904, 5545.861353466195, 5558.861028474321, 5569.0, 5273.34083239595, 5273.393559740679, 5300.787968481218, 5324.893502130013, 5326.760295786777, 5358.866028349323, 5387.92241551699, 5391.75737091824, 5392.649477783932, 5400.729963501888, 5057.494250574913, 5265.0, 5287.391949925808, 5294.602904782234, 5320.627556071038, 5300.946990530046, 5353.518183363516, 5371.8450533135565, 5374.381946076095, 5389.51494365509, 5193.792248310026, 5220.9477905220465, 5260.105782017143, 5275.287836142225, 5309.920351194658], "value": 3933.42810207035, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.7132461716848, 712.9448416343811, 721.9855602887942, 728.4245446097583, 772.501736380035, 12300.323482208474, 12923.935380323086, 13038.739225215513, 13072.803907941377, 13175.868241317585, 11367.602133925315, 11557.826632600518, 11586.942065289682, 11595.594154204604, 11601.187916845824, 620.2278163686217, 788.6451097006342, 794.1224946434194, 801.3789313282194, 803.3131672420085, 773.7291947818275, 797.1709422200933, 799.3565180030073, 801.2588355770889, 801.7674874286479, 831.9833603327929, 832.2301870769544, 833.5457175839182, 836.5942517878824, 837.3845223760532, 820.2330820682681, 822.0998007182126, 822.62159406673, 824.11819353292, 825.6408462318881, 604.4227762486859, 605.0289285696482, 606.7178761875749, 607.2803727582784, 607.8510764862593, 13323.933380333134, 13403.664908377272, 13477.932610336886, 13479.865201347959, 13508.0, 13178.341082945813, 13446.529371471952, 13522.0, 13655.522056728067, 13964.511242106477, 10800.945995269973, 10840.78318433627, 10842.674719758419, 10899.509522071527, 10922.071623911977, 3398.2693720850134, 3431.55389799327, 3434.4161492546327, 3456.412409890325, 3523.823808809575, 51118.48881511212, 52886.47113528892, 52896.0, 56984.0, 57136.0, 10409.68770936858, 10495.842562361571, 10548.63079792219, 10562.524686388977, 10618.469076546142, 18486.445406637824, 18605.7209141863, 18623.348182813537, 18670.0, 18857.151428185764, 7033.050538177383, 7124.43004559634, 7175.425965922818, 7279.3621435176665, 7314.780556583205, 3656.341858465502, 3691.7415780895617, 3712.9628703713156, 3718.0, 3830.9233815324096, 2927.7657787376957, 2996.2509372656837, 3009.5184770437063, 3009.774266929989, 3026.576279320897, 508.54739282039014, 524.3052954834859, 526.5708447615182, 528.2129626855957, 530.212634238156, 576.9125744102994, 599.1778722218313, 625.6965371794676, 635.7107516080173, 649.574528683713, 7446.180920098785, 7862.371010319275, 7905.090914544786, 7993.240642138988, 8034.517928924166, 587.3304432946444, 594.4590422715395, 612.9203203583505, 621.7699451203084, 632.451944590845, 3640.8543658253375, 3701.4262789267705, 3742.55089389275, 3831.482749828793, 3870.3613903705573, 60056.39943600595, 84277.57861210777, 89048.5547572258, 90590.54704726434, 92508.0, 82682.58658706788, 83253.0, 83305.0, 83306.58346708228, 83307.5834620823, 45035.999999999345, 45544.86137846514, 65708.34291657117, 73463.63268183624, 73790.26209737833, 6952.200496942916, 7217.422606191387, 7363.631818408951, 7439.851202976019, 7524.623768811428, 42148.0, 43025.7848710767, 44143.11713765771, 44442.333365000195, 44773.0, 60326.69836650789, 63118.684406577675, 63127.6843615779, 63134.368656314684, 63156.68421657862, 9509.524523773922, 9595.760105997406, 9600.279979001463, 9777.071178238057, 9802.411855288705, 11405.600803971822, 11535.307881527135, 11551.711207219887, 11563.595274165364, 11702.122340824642, 10099.394036357842, 10189.0, 10279.0, 10475.94762026185, 10498.527566259689, 10416.166706663296, 10483.947580262049, 10837.349759014485, 11001.944990274997, 11106.833397498882, 10056.798864022532, 10334.960611896598, 10460.581576736846, 10486.318389304672, 10616.469176541297, 8417.957910210409, 9001.234895033733, 9016.0, 9040.141186587263, 9156.22172115351, 8665.090165532529, 8948.668679659517, 8958.148975847284, 8967.372283940062, 9076.591553380245], "value": 6349.304663430608, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1602.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 107.0, 116.0, 116.0, 115.0, 115.0, 114.0, 115.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 142.0, 167.0, 196.0, 137.0, 160.0, 155.0, 139.0, 186.0, 133.0], "value": 159.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 173.0, 164.0, 165.0, 164.0, 165.0, 165.0, 164.0, 163.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 169.0, 78.0, 76.0, 77.0, 78.0, 164.0, 79.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 155.0, 88.0, 88.0, 86.0, 142.0, 87.0, 87.0, 127.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 121.0, 117.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 150.0, 149.0, 148.0, 150.0, 149.0, 150.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 68.0, 68.0, 68.0, 67.0, 66.0, 69.0], "value": 67.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 66.0, 66.0, 65.0, 66.0, 64.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 84.0, 88.0, 90.0, 85.0, 90.0, 85.0, 101.0, 89.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 137.0, 132.0, 132.0, 150.0, 139.0, 143.0, 136.0, 131.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 178.0, 176.0, 169.0, 173.0, 178.0, 175.0, 176.0, 169.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 71.0, 73.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0], "value": 69.3, "unit": "score"}]}]} 08:20:07 INFO - Return code: 0 08:20:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:20:07 ERROR - # TBPL SUCCESS # 08:20:07 INFO - Running post-action listener: _resource_record_post_action 08:20:07 INFO - ##### 08:20:07 INFO - ##### Finished run-tests step (success) 08:20:07 INFO - ##### 08:20:07 INFO - Running post-run listener: _resource_record_post_run 08:20:07 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544468992; Read time: 140; Write time: 515992 08:20:07 INFO - TinderboxPrint: CPU usage
13.5% 08:20:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 140 08:20:07 INFO - TinderboxPrint: I/O write bytes / time
544,468,992 / 515,992 08:20:07 INFO - TinderboxPrint: CPU idle
8,279.2 (86.5%) 08:20:07 INFO - TinderboxPrint: CPU user
1,236.3 (12.9%) 08:20:07 INFO - TinderboxPrint: Swap in / out
0 / 0 08:20:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246337536; Read time: 0; Write time: 289136 08:20:07 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291368960; Read time: 140; Write time: 224148 08:20:07 INFO - Running post-run listener: _upload_blobber_files 08:20:07 INFO - Blob upload gear active. 08:20:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:20:07 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 08:20:07 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:20:07 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:20:08 INFO - (blobuploader) - INFO - Open directory for files ... 08:20:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:20:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:20:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:09 INFO - (blobuploader) - INFO - Done attempting. 08:20:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:20:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:20:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:09 INFO - (blobuploader) - INFO - Done attempting. 08:20:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:20:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:20:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:13 INFO - (blobuploader) - INFO - Done attempting. 08:20:13 INFO - (blobuploader) - INFO - Iteration through files over. 08:20:13 INFO - Return code: 0 08:20:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:20:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:20:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06e004ff14a2051909c6b681132a89d4e29013135ddcfdee0d45631f24d15976ec392666c344a6c2ae8558e3e1ee56d3d4b04cb1326842306f94f98f065ecd35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a2e10fc6daa1e66531bc39088156d47c99695882fb89cf74e2d2c786f75473a44e9c90134665b3fc4cd8d8e1994b68525ffbe6342352a9636bc37167656e9494", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f7c9c3aaf1d33f3fe59a21edff315f947a785708cc06ae101b74041fd0339bd41e117f561c0857b27ad117ac374f2dd01b9a598b896d213a4596b3d64b2d8126"} 08:20:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:20:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:20:13 INFO - Contents: 08:20:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06e004ff14a2051909c6b681132a89d4e29013135ddcfdee0d45631f24d15976ec392666c344a6c2ae8558e3e1ee56d3d4b04cb1326842306f94f98f065ecd35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a2e10fc6daa1e66531bc39088156d47c99695882fb89cf74e2d2c786f75473a44e9c90134665b3fc4cd8d8e1994b68525ffbe6342352a9636bc37167656e9494", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f7c9c3aaf1d33f3fe59a21edff315f947a785708cc06ae101b74041fd0339bd41e117f561c0857b27ad117ac374f2dd01b9a598b896d213a4596b3d64b2d8126"} 08:20:13 INFO - Running post-run listener: copy_logs_to_upload_dir 08:20:13 INFO - Copying logs to upload dir... 08:20:13 INFO - mkdir: /builds/slave/test/build/upload/logs 08:20:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.095498 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-23 08:20:13.229848) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 08:20:13.233713) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06e004ff14a2051909c6b681132a89d4e29013135ddcfdee0d45631f24d15976ec392666c344a6c2ae8558e3e1ee56d3d4b04cb1326842306f94f98f065ecd35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a2e10fc6daa1e66531bc39088156d47c99695882fb89cf74e2d2c786f75473a44e9c90134665b3fc4cd8d8e1994b68525ffbe6342352a9636bc37167656e9494", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f7c9c3aaf1d33f3fe59a21edff315f947a785708cc06ae101b74041fd0339bd41e117f561c0857b27ad117ac374f2dd01b9a598b896d213a4596b3d64b2d8126"} build_url:https://queue.taskcluster.net/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/ONF30rRJRdabacYZdKXjcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06e004ff14a2051909c6b681132a89d4e29013135ddcfdee0d45631f24d15976ec392666c344a6c2ae8558e3e1ee56d3d4b04cb1326842306f94f98f065ecd35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a2e10fc6daa1e66531bc39088156d47c99695882fb89cf74e2d2c786f75473a44e9c90134665b3fc4cd8d8e1994b68525ffbe6342352a9636bc37167656e9494", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f7c9c3aaf1d33f3fe59a21edff315f947a785708cc06ae101b74041fd0339bd41e117f561c0857b27ad117ac374f2dd01b9a598b896d213a4596b3d64b2d8126"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 08:20:13.259235) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:20:13.259575) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1466693971.79110-1970056314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:20:13.346297) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 08:20:13.346745) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 08:20:13.347146) ========= ========= Total master_lag: 0.18 =========