builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1468477366.56 results: success (0) buildid: 20160713152443 builduid: fb5f9fc9a81843ef95c1b9ce84958adb revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:46.559600) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:46.560075) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:46.560363) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:46.574599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:46.574883) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 23:22:46-- 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% 45.8M=0s 2016-07-13 23:22:46 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138147 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:46.726982) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:46.727304) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020131 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:46.776958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:46.777317) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 709652b674013b136627e45fd90b4e9063906a19 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 709652b674013b136627e45fd90b4e9063906a19 --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=14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 23:22:47,060 truncating revision to first 12 chars 2016-07-13 23:22:47,060 Setting DEBUG logging. 2016-07-13 23:22:47,060 attempt 1/10 2016-07-13 23:22:47,060 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/709652b67401?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 23:22:47,374 unpacking tar archive at: mozilla-aurora-709652b67401/testing/mozharness/ program finished with exit code 0 elapsedTime=0.665352 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:47.456657) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:47.457015) ========= script_repo_revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:47.457455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:47.457734) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:47.467063) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-13 23:22:47.467389) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:22:47 INFO - MultiFileLogger online at 20160713 23:22:47 in /builds/slave/test 23:22:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 23:22:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:22:47 INFO - {'append_to_log': False, 23:22:47 INFO - 'base_work_dir': '/builds/slave/test', 23:22:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:22:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:22:47 INFO - 'branch': 'Mozilla-Aurora', 23:22:47 INFO - 'buildbot_json_path': 'buildprops.json', 23:22:47 INFO - 'config_files': ('talos/linux_config.py',), 23:22:47 INFO - 'default_actions': ('clobber', 23:22:47 INFO - 'read-buildbot-config', 23:22:47 INFO - 'download-and-extract', 23:22:47 INFO - 'populate-webroot', 23:22:47 INFO - 'create-virtualenv', 23:22:47 INFO - 'install', 23:22:47 INFO - 'run-tests'), 23:22:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:22:47 INFO - 'download_minidump_stackwalk': True, 23:22:47 INFO - 'download_symbols': 'ondemand', 23:22:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:22:47 INFO - 'tooltool.py': '/tools/tooltool.py', 23:22:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:22:47 INFO - '/tools/misc-python/virtualenv.py')}, 23:22:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:22:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:22:47 INFO - 'installer_path': 'installer.exe', 23:22:47 INFO - 'log_level': 'info', 23:22:47 INFO - 'log_name': 'talos', 23:22:47 INFO - 'log_to_console': True, 23:22:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:22:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:22:47 INFO - 'opt_config_files': (), 23:22:47 INFO - 'pip_index': False, 23:22:47 INFO - 'sps_profile': False, 23:22:47 INFO - 'sps_profile_interval': 0, 23:22:47 INFO - 'suite': 'dromaeojs-e10s', 23:22:47 INFO - 'system_bits': '32', 23:22:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:22:47 INFO - 'title': 'talos-linux64-ix-036', 23:22:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:22:47 INFO - 'use_talos_json': True, 23:22:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:22:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:22:47 INFO - 'work_dir': 'build'} 23:22:47 INFO - ##### 23:22:47 INFO - ##### Running clobber step. 23:22:47 INFO - ##### 23:22:47 INFO - Running pre-action listener: _resource_record_pre_action 23:22:47 INFO - Running main action method: clobber 23:22:47 INFO - rmtree: /builds/slave/test/build 23:22:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:22:48 INFO - Running post-action listener: _resource_record_post_action 23:22:48 INFO - ##### 23:22:48 INFO - ##### Finished clobber step (success) 23:22:48 INFO - ##### 23:22:48 INFO - ##### 23:22:48 INFO - ##### Running read-buildbot-config step. 23:22:48 INFO - ##### 23:22:48 INFO - Running pre-action listener: _resource_record_pre_action 23:22:48 INFO - Running main action method: read_buildbot_config 23:22:48 INFO - Using buildbot properties: 23:22:48 INFO - { 23:22:48 INFO - "project": "", 23:22:48 INFO - "product": "firefox", 23:22:48 INFO - "script_repo_revision": "production", 23:22:48 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 23:22:48 INFO - "repository": "", 23:22:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 23:22:48 INFO - "buildid": "20160713152443", 23:22:48 INFO - "pgo_build": "True", 23:22:48 INFO - "basedir": "/builds/slave/test", 23:22:48 INFO - "buildnumber": 416, 23:22:48 INFO - "slavename": "talos-linux64-ix-036", 23:22:48 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:22:48 INFO - "platform": "ubuntu64_hw", 23:22:48 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:22:48 INFO - "branch": "mozilla-aurora", 23:22:48 INFO - "repo_path": "releases/mozilla-aurora", 23:22:48 INFO - "revision": "709652b674013b136627e45fd90b4e9063906a19", 23:22:48 INFO - "stage_platform": "linux64-pgo", 23:22:48 INFO - "builduid": "fb5f9fc9a81843ef95c1b9ce84958adb", 23:22:48 INFO - "slavebuilddir": "test" 23:22:48 INFO - } 23:22:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 23:22:48 INFO - Running post-action listener: _resource_record_post_action 23:22:48 INFO - ##### 23:22:48 INFO - ##### Finished read-buildbot-config step (success) 23:22:48 INFO - ##### 23:22:48 INFO - ##### 23:22:48 INFO - ##### Running download-and-extract step. 23:22:48 INFO - ##### 23:22:48 INFO - Running pre-action listener: _resource_record_pre_action 23:22:48 INFO - Running main action method: download_and_extract 23:22:48 INFO - mkdir: /builds/slave/test/build/tests 23:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:48 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:22:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:22:49 INFO - Downloaded 1361 bytes. 23:22:49 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:49 INFO - Using the following test package requirements: 23:22:49 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:22:49 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:49 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:22:49 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:49 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:22:49 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:49 INFO - u'jsshell-linux-x86_64.zip'], 23:22:49 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:49 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:22:49 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:22:49 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:49 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:22:49 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:49 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:22:49 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:49 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:22:49 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:49 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:22:49 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:49 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:22:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:22:50 INFO - Downloaded 24491003 bytes. 23:22:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:22:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:22:51 INFO - Return code: 0 23:22:51 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:51 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:22:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:22:52 INFO - Downloaded 24491003 bytes. 23:22:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:22:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:22:54 INFO - Return code: 0 23:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:54 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:22:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:22:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:22:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:22:55 INFO - Downloaded 10833369 bytes. 23:22:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:22:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:22:55 INFO - Return code: 0 23:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:55 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:22:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:22:57 INFO - Downloaded 63642548 bytes. 23:22:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:57 INFO - mkdir: /builds/slave/test/properties 23:22:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:22:57 INFO - Writing to file /builds/slave/test/properties/build_url 23:22:57 INFO - Contents: 23:22:57 INFO - build_url:https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:57 INFO - Running post-action listener: _resource_record_post_action 23:22:57 INFO - Running post-action listener: set_extra_try_arguments 23:22:57 INFO - ##### 23:22:57 INFO - ##### Finished download-and-extract step (success) 23:22:57 INFO - ##### 23:22:57 INFO - ##### 23:22:57 INFO - ##### Running populate-webroot step. 23:22:57 INFO - ##### 23:22:57 INFO - Running pre-action listener: _resource_record_pre_action 23:22:57 INFO - Running main action method: populate_webroot 23:22:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:22:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:22:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:22:57 INFO - '--tppagecycles', 23:22:57 INFO - '7'], 23:22:57 INFO - 'tests': ['tsvgm']}}, 23:22:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:22:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:22:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:22:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:22:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:22:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:22:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:57 INFO - 'talos_options': ['--disable-e10s'], 23:22:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:22:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:22:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:57 INFO - 'talos_options': ['--disable-e10s'], 23:22:57 INFO - 'tests': ['damp', 'tps']}, 23:22:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:57 INFO - 'tests': ['damp', 'tps']}, 23:22:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:22:57 INFO - 'tests': ['dromaeo_dom']}, 23:22:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:22:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:22:57 INFO - 'tests': ['a11yr', 23:22:57 INFO - 'ts_paint', 23:22:57 INFO - 'tpaint', 23:22:57 INFO - 'sessionrestore', 23:22:57 INFO - 'sessionrestore_no_auto_restore', 23:22:57 INFO - 'tabpaint']}, 23:22:57 INFO - 'other-e10s': {'tests': ['a11yr', 23:22:57 INFO - 'ts_paint', 23:22:57 INFO - 'tpaint', 23:22:57 INFO - 'sessionrestore', 23:22:57 INFO - 'sessionrestore_no_auto_restore', 23:22:57 INFO - 'tabpaint']}, 23:22:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:22:57 INFO - 'ts_paint', 23:22:57 INFO - 'tpaint', 23:22:57 INFO - 'sessionrestore', 23:22:57 INFO - 'sessionrestore_no_auto_restore', 23:22:57 INFO - 'tabpaint']}, 23:22:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:22:57 INFO - 'ts_paint', 23:22:57 INFO - 'tpaint', 23:22:57 INFO - 'sessionrestore', 23:22:57 INFO - 'sessionrestore_no_auto_restore', 23:22:57 INFO - 'tabpaint']}, 23:22:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:22:57 INFO - 'tests': ['a11yr', 23:22:57 INFO - 'ts_paint', 23:22:57 INFO - 'tpaint', 23:22:57 INFO - 'sessionrestore', 23:22:57 INFO - 'sessionrestore_no_auto_restore', 23:22:57 INFO - 'tabpaint']}, 23:22:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:22:57 INFO - 'tests': ['a11yr', 23:22:57 INFO - 'ts_paint', 23:22:57 INFO - 'tpaint', 23:22:57 INFO - 'sessionrestore', 23:22:57 INFO - 'sessionrestore_no_auto_restore', 23:22:57 INFO - 'tabpaint']}, 23:22:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:22:57 INFO - 'tests': ['tsvgx', 23:22:57 INFO - 'tsvgr_opacity', 23:22:57 INFO - 'tart', 23:22:57 INFO - 'tscrollx', 23:22:57 INFO - 'cart']}, 23:22:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:22:57 INFO - 'tsvgr_opacity', 23:22:57 INFO - 'tart', 23:22:57 INFO - 'tscrollx', 23:22:57 INFO - 'cart']}, 23:22:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:57 INFO - 'talos_options': ['--disable-e10s'], 23:22:57 INFO - 'tests': ['tp5o']}, 23:22:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:57 INFO - 'tests': ['tp5o']}, 23:22:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:57 INFO - 'talos_options': ['--disable-e10s', 23:22:57 INFO - '--xperf_path', 23:22:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:22:57 INFO - 'tests': ['tp5n']}, 23:22:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:57 INFO - 'talos_options': ['--xperf_path', 23:22:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:22:57 INFO - 'tests': ['tp5n']}}, 23:22:57 INFO - 'talos.zip': {'path': '', 23:22:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:22:57 INFO - Running post-action listener: _resource_record_post_action 23:22:57 INFO - ##### 23:22:57 INFO - ##### Finished populate-webroot step (success) 23:22:57 INFO - ##### 23:22:57 INFO - ##### 23:22:57 INFO - ##### Running create-virtualenv step. 23:22:57 INFO - ##### 23:22:57 INFO - Running pre-action listener: _resource_record_pre_action 23:22:57 INFO - Running main action method: create_virtualenv 23:22:57 INFO - Creating virtualenv /builds/slave/test/build/venv 23:22:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:22:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:22:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:22:57 INFO - Using real prefix '/usr' 23:22:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:22:58 INFO - Installing distribute.............................................................................................................................................................................................done. 23:23:00 INFO - Installing pip.................done. 23:23:00 INFO - Return code: 0 23:23:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38c39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c1c0>, '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 0x199d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199d550>, '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': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', '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 23:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:23:00 INFO - Using env: {'DISPLAY': ':0', 23:23:00 INFO - 'HOME': '/home/cltbld', 23:23:00 INFO - 'LANG': 'en_US.UTF-8', 23:23:00 INFO - 'LANGUAGE': 'en_US:en', 23:23:00 INFO - 'LOGNAME': 'cltbld', 23:23:00 INFO - 'MAIL': '/var/mail/cltbld', 23:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:00 INFO - 'MOZ_NO_REMOTE': '1', 23:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:00 INFO - 'NO_EM_RESTART': '1', 23:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:00 INFO - 'PWD': '/builds/slave/test', 23:23:00 INFO - 'SHELL': '/bin/bash', 23:23:00 INFO - 'SHLVL': '1', 23:23:00 INFO - 'TERM': 'linux', 23:23:00 INFO - 'TMOUT': '86400', 23:23:00 INFO - 'USER': 'cltbld', 23:23:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', 23:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:00 INFO - '_': '/tools/buildbot/bin/python'} 23:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:23:00 INFO - Cleaning up... 23:23:00 INFO - Return code: 0 23:23:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38c39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c1c0>, '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 0x199d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199d550>, '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': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', '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 23:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:23:00 INFO - Using env: {'DISPLAY': ':0', 23:23:00 INFO - 'HOME': '/home/cltbld', 23:23:00 INFO - 'LANG': 'en_US.UTF-8', 23:23:00 INFO - 'LANGUAGE': 'en_US:en', 23:23:00 INFO - 'LOGNAME': 'cltbld', 23:23:00 INFO - 'MAIL': '/var/mail/cltbld', 23:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:00 INFO - 'MOZ_NO_REMOTE': '1', 23:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:00 INFO - 'NO_EM_RESTART': '1', 23:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:00 INFO - 'PWD': '/builds/slave/test', 23:23:00 INFO - 'SHELL': '/bin/bash', 23:23:00 INFO - 'SHLVL': '1', 23:23:00 INFO - 'TERM': 'linux', 23:23:00 INFO - 'TMOUT': '86400', 23:23:00 INFO - 'USER': 'cltbld', 23:23:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', 23:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:00 INFO - '_': '/tools/buildbot/bin/python'} 23:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:00 INFO - Downloading/unpacking psutil>=3.1.1 23:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:23:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:23:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:23:02 INFO - Installing collected packages: psutil 23:23:02 INFO - Running setup.py install for psutil 23:23:02 INFO - building 'psutil._psutil_linux' extension 23:23:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:23:03 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 23:23:03 INFO - building 'psutil._psutil_posix' extension 23:23:03 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 23:23:03 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 23:23:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:23:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:23:03 INFO - Successfully installed psutil 23:23:03 INFO - Cleaning up... 23:23:03 INFO - Return code: 0 23:23:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:23: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')]} 23:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23: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')]} 23:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38c39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c1c0>, '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 0x199d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199d550>, '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': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', '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 23:23:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:23:03 INFO - Using env: {'DISPLAY': ':0', 23:23:03 INFO - 'HOME': '/home/cltbld', 23:23:03 INFO - 'LANG': 'en_US.UTF-8', 23:23:03 INFO - 'LANGUAGE': 'en_US:en', 23:23:03 INFO - 'LOGNAME': 'cltbld', 23:23:03 INFO - 'MAIL': '/var/mail/cltbld', 23:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:03 INFO - 'MOZ_NO_REMOTE': '1', 23:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:03 INFO - 'NO_EM_RESTART': '1', 23:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:03 INFO - 'PWD': '/builds/slave/test', 23:23:03 INFO - 'SHELL': '/bin/bash', 23:23:03 INFO - 'SHLVL': '1', 23:23:03 INFO - 'TERM': 'linux', 23:23:03 INFO - 'TMOUT': '86400', 23:23:03 INFO - 'USER': 'cltbld', 23:23:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', 23:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:03 INFO - '_': '/tools/buildbot/bin/python'} 23:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:23:05 INFO - Installing collected packages: mozsystemmonitor 23:23:05 INFO - Running setup.py install for mozsystemmonitor 23:23:05 INFO - Successfully installed mozsystemmonitor 23:23:05 INFO - Cleaning up... 23:23:05 INFO - Return code: 0 23:23:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38c39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c1c0>, '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 0x199d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199d550>, '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': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', '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 23:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:23:05 INFO - Using env: {'DISPLAY': ':0', 23:23:05 INFO - 'HOME': '/home/cltbld', 23:23:05 INFO - 'LANG': 'en_US.UTF-8', 23:23:05 INFO - 'LANGUAGE': 'en_US:en', 23:23:05 INFO - 'LOGNAME': 'cltbld', 23:23:05 INFO - 'MAIL': '/var/mail/cltbld', 23:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:05 INFO - 'MOZ_NO_REMOTE': '1', 23:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:05 INFO - 'NO_EM_RESTART': '1', 23:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:05 INFO - 'PWD': '/builds/slave/test', 23:23:05 INFO - 'SHELL': '/bin/bash', 23:23:05 INFO - 'SHLVL': '1', 23:23:05 INFO - 'TERM': 'linux', 23:23:05 INFO - 'TMOUT': '86400', 23:23:05 INFO - 'USER': 'cltbld', 23:23:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', 23:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:05 INFO - '_': '/tools/buildbot/bin/python'} 23:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:05 INFO - Downloading/unpacking jsonschema==2.5.1 23:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:23:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:08 INFO - Downloading functools32-3.2.3-2.tar.gz 23:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:23:08 INFO - warning: no files found matching '*.txt' 23:23:08 INFO - no previously-included directories found matching 'build' 23:23:08 INFO - no previously-included directories found matching 'dist' 23:23:08 INFO - no previously-included directories found matching '.git*' 23:23:08 INFO - Installing collected packages: jsonschema, functools32 23:23:08 INFO - Running setup.py install for functools32 23:23:08 INFO - warning: no files found matching '*.txt' 23:23:08 INFO - no previously-included directories found matching 'build' 23:23:08 INFO - no previously-included directories found matching 'dist' 23:23:08 INFO - no previously-included directories found matching '.git*' 23:23:08 INFO - Successfully installed jsonschema functools32 23:23:08 INFO - Cleaning up... 23:23:08 INFO - Return code: 0 23:23:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:23:08 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')]} 23:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:08 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')]} 23:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:08 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 0x7fc38c39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c1c0>, '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 0x199d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199d550>, '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': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', '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 23:23:08 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 23:23:08 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 23:23:08 INFO - Using env: {'DISPLAY': ':0', 23:23:08 INFO - 'HOME': '/home/cltbld', 23:23:08 INFO - 'LANG': 'en_US.UTF-8', 23:23:08 INFO - 'LANGUAGE': 'en_US:en', 23:23:08 INFO - 'LOGNAME': 'cltbld', 23:23:08 INFO - 'MAIL': '/var/mail/cltbld', 23:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:08 INFO - 'MOZ_NO_REMOTE': '1', 23:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:08 INFO - 'NO_EM_RESTART': '1', 23:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:08 INFO - 'PWD': '/builds/slave/test', 23:23:08 INFO - 'SHELL': '/bin/bash', 23:23:08 INFO - 'SHLVL': '1', 23:23:08 INFO - 'TERM': 'linux', 23:23:08 INFO - 'TMOUT': '86400', 23:23:08 INFO - 'USER': 'cltbld', 23:23:08 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', 23:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:08 INFO - '_': '/tools/buildbot/bin/python'} 23:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:08 INFO - Downloading/unpacking blobuploader==1.2.4 23:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:10 INFO - Downloading blobuploader-1.2.4.tar.gz 23:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:23:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:23:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:11 INFO - Downloading docopt-0.6.1.tar.gz 23:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:23:11 INFO - Installing collected packages: blobuploader, requests, docopt 23:23:11 INFO - Running setup.py install for blobuploader 23:23:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:23:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:23:11 INFO - Running setup.py install for requests 23:23:11 INFO - Running setup.py install for docopt 23:23:11 INFO - Successfully installed blobuploader requests docopt 23:23:11 INFO - Cleaning up... 23:23:11 INFO - Return code: 0 23:23:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38c39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c1c0>, '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 0x199d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199d550>, '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': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', '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 23:23:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:23:11 INFO - Using env: {'DISPLAY': ':0', 23:23:11 INFO - 'HOME': '/home/cltbld', 23:23:11 INFO - 'LANG': 'en_US.UTF-8', 23:23:11 INFO - 'LANGUAGE': 'en_US:en', 23:23:11 INFO - 'LOGNAME': 'cltbld', 23:23:11 INFO - 'MAIL': '/var/mail/cltbld', 23:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:11 INFO - 'MOZ_NO_REMOTE': '1', 23:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:11 INFO - 'NO_EM_RESTART': '1', 23:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:11 INFO - 'PWD': '/builds/slave/test', 23:23:11 INFO - 'SHELL': '/bin/bash', 23:23:11 INFO - 'SHLVL': '1', 23:23:11 INFO - 'TERM': 'linux', 23:23:11 INFO - 'TMOUT': '86400', 23:23:11 INFO - 'USER': 'cltbld', 23:23:11 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', 23:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:11 INFO - '_': '/tools/buildbot/bin/python'} 23:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:23:12 INFO - Running setup.py (path:/tmp/pip-xr204q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:23:12 INFO - Running setup.py (path:/tmp/pip-ZBbUpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:23:12 INFO - Running setup.py (path:/tmp/pip-55keIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:23:12 INFO - Running setup.py (path:/tmp/pip-75aTpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:23:12 INFO - Running setup.py (path:/tmp/pip-dKAYwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:23:12 INFO - Running setup.py (path:/tmp/pip-jkh9Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:23:12 INFO - Running setup.py (path:/tmp/pip-AUsToW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:23:12 INFO - Running setup.py (path:/tmp/pip-xCJkDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:23:12 INFO - Running setup.py (path:/tmp/pip-yF2KH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:23:12 INFO - Running setup.py (path:/tmp/pip-C1Vgj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:23:12 INFO - Running setup.py (path:/tmp/pip-me_cEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:23:12 INFO - Running setup.py (path:/tmp/pip-xM_F1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:23:12 INFO - Running setup.py (path:/tmp/pip-B9fWvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:23:13 INFO - Running setup.py (path:/tmp/pip-3jgKVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:13 INFO - Running setup.py (path:/tmp/pip-1BnF6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:23:13 INFO - Running setup.py (path:/tmp/pip-4greBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:23:13 INFO - Running setup.py (path:/tmp/pip-qEZWTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:23:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:23:13 INFO - Running setup.py install for manifestparser 23:23:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:23:13 INFO - Running setup.py install for mozcrash 23:23:13 INFO - Running setup.py install for mozdebug 23:23:13 INFO - Running setup.py install for mozdevice 23:23:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:23:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:23:13 INFO - Running setup.py install for mozfile 23:23:13 INFO - Running setup.py install for mozhttpd 23:23:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:23:13 INFO - Running setup.py install for mozinfo 23:23:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:23:14 INFO - Running setup.py install for mozInstall 23:23:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:23:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:23:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:23:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:23:14 INFO - Running setup.py install for mozleak 23:23:14 INFO - Running setup.py install for mozlog 23:23:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:23:14 INFO - Running setup.py install for moznetwork 23:23:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:23:14 INFO - Running setup.py install for mozprocess 23:23:14 INFO - Running setup.py install for mozprofile 23:23:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:23:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:23:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:23:14 INFO - Running setup.py install for mozrunner 23:23:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:23:14 INFO - Running setup.py install for mozscreenshot 23:23:14 INFO - Running setup.py install for moztest 23:23:14 INFO - Running setup.py install for mozversion 23:23:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:23:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:23:15 INFO - Cleaning up... 23:23:15 INFO - Return code: 0 23:23:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:15 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')]} 23:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:15 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')]} 23:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:15 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 0x7fc38c39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c1c0>, '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 0x199d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199d550>, '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': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', '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 23:23:15 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 23:23:15 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 23:23:15 INFO - Using env: {'DISPLAY': ':0', 23:23:15 INFO - 'HOME': '/home/cltbld', 23:23:15 INFO - 'LANG': 'en_US.UTF-8', 23:23:15 INFO - 'LANGUAGE': 'en_US:en', 23:23:15 INFO - 'LOGNAME': 'cltbld', 23:23:15 INFO - 'MAIL': '/var/mail/cltbld', 23:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:15 INFO - 'MOZ_NO_REMOTE': '1', 23:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:15 INFO - 'NO_EM_RESTART': '1', 23:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:15 INFO - 'PWD': '/builds/slave/test', 23:23:15 INFO - 'SHELL': '/bin/bash', 23:23:15 INFO - 'SHLVL': '1', 23:23:15 INFO - 'TERM': 'linux', 23:23:15 INFO - 'TMOUT': '86400', 23:23:15 INFO - 'USER': 'cltbld', 23:23:15 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', 23:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:15 INFO - '_': '/tools/buildbot/bin/python'} 23:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:23:15 INFO - Running setup.py (path:/tmp/pip-tlujOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:23:15 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)) 23:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:23:15 INFO - Running setup.py (path:/tmp/pip-yAlF_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:23:15 INFO - Running setup.py (path:/tmp/pip-2ygAb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:23:15 INFO - Running setup.py (path:/tmp/pip-1eOi7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:23:15 INFO - Running setup.py (path:/tmp/pip-BRpeu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:23:15 INFO - Running setup.py (path:/tmp/pip-i9o4Yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:23:15 INFO - Running setup.py (path:/tmp/pip-jLGmCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:23:15 INFO - Running setup.py (path:/tmp/pip-RQeT1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:23:15 INFO - Running setup.py (path:/tmp/pip-NAwfXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:23:15 INFO - Running setup.py (path:/tmp/pip-RpYwA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:23:16 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)) 23:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:23:16 INFO - Running setup.py (path:/tmp/pip-3riq3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:23:16 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)) 23:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:23:16 INFO - Running setup.py (path:/tmp/pip-SQ987r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:23:16 INFO - Running setup.py (path:/tmp/pip-X6ylzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:23:16 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)) 23:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:23:16 INFO - Running setup.py (path:/tmp/pip-OgGhWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:16 INFO - Running setup.py (path:/tmp/pip-3Jcb8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:16 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)) 23:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:23:16 INFO - Running setup.py (path:/tmp/pip-edXoEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:23:16 INFO - Running setup.py (path:/tmp/pip-fYEmvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:23:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:18 INFO - Downloading blessings-1.6.tar.gz 23:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:23:18 INFO - Installing collected packages: blessings 23:23:18 INFO - Running setup.py install for blessings 23:23:18 INFO - Successfully installed blessings 23:23:18 INFO - Cleaning up... 23:23:18 INFO - Return code: 0 23:23:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:23:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:23:18 INFO - Reading from file tmpfile_stdout 23:23:18 INFO - Current package versions: 23:23:18 INFO - argparse == 1.2.1 23:23:18 INFO - blessings == 1.6 23:23:18 INFO - blobuploader == 1.2.4 23:23:18 INFO - docopt == 0.6.1 23:23:18 INFO - functools32 == 3.2.3-2 23:23:18 INFO - jsonschema == 2.5.1 23:23:18 INFO - manifestparser == 1.1 23:23:18 INFO - mozInstall == 1.12 23:23:18 INFO - mozcrash == 0.17 23:23:18 INFO - mozdebug == 0.1 23:23:18 INFO - mozdevice == 0.48 23:23:18 INFO - mozfile == 1.2 23:23:18 INFO - mozhttpd == 0.7 23:23:18 INFO - mozinfo == 0.9 23:23:18 INFO - mozleak == 0.1 23:23:18 INFO - mozlog == 3.2 23:23:18 INFO - moznetwork == 0.27 23:23:18 INFO - mozprocess == 0.23 23:23:18 INFO - mozprofile == 0.28 23:23:18 INFO - mozrunner == 6.12 23:23:18 INFO - mozscreenshot == 0.1 23:23:18 INFO - mozsystemmonitor == 0.3 23:23:18 INFO - moztest == 0.7 23:23:18 INFO - mozversion == 1.4 23:23:18 INFO - psutil == 3.1.1 23:23:18 INFO - requests == 1.2.3 23:23:18 INFO - wsgiref == 0.1.2 23:23:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc38c39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c1c0>, '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 0x199d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199d550>, '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': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', '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 23:23:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:23:18 INFO - Using env: {'DISPLAY': ':0', 23:23:18 INFO - 'HOME': '/home/cltbld', 23:23:18 INFO - 'LANG': 'en_US.UTF-8', 23:23:18 INFO - 'LANGUAGE': 'en_US:en', 23:23:18 INFO - 'LOGNAME': 'cltbld', 23:23:18 INFO - 'MAIL': '/var/mail/cltbld', 23:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:18 INFO - 'MOZ_NO_REMOTE': '1', 23:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:18 INFO - 'NO_EM_RESTART': '1', 23:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:18 INFO - 'PWD': '/builds/slave/test', 23:23:18 INFO - 'SHELL': '/bin/bash', 23:23:18 INFO - 'SHLVL': '1', 23:23:18 INFO - 'TERM': 'linux', 23:23:18 INFO - 'TMOUT': '86400', 23:23:18 INFO - 'USER': 'cltbld', 23:23:18 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', 23:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:18 INFO - '_': '/tools/buildbot/bin/python'} 23:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:19 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)) 23:23:19 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)) 23:23:19 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)) 23:23:19 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)) 23:23:19 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)) 23:23:19 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)) 23:23:19 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)) 23:23:19 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)) 23:23:19 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)) 23:23:19 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)) 23:23:19 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)) 23:23:19 INFO - Cleaning up... 23:23:19 INFO - Return code: 0 23:23:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:23:19 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')]} 23:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:19 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')]} 23:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:19 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 0x7fc38c39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c1c0>, '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 0x199d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199d550>, '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': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', '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 23:23:19 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 23:23:19 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 23:23:19 INFO - Using env: {'DISPLAY': ':0', 23:23:19 INFO - 'HOME': '/home/cltbld', 23:23:19 INFO - 'LANG': 'en_US.UTF-8', 23:23:19 INFO - 'LANGUAGE': 'en_US:en', 23:23:19 INFO - 'LOGNAME': 'cltbld', 23:23:19 INFO - 'MAIL': '/var/mail/cltbld', 23:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:19 INFO - 'MOZ_NO_REMOTE': '1', 23:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:19 INFO - 'NO_EM_RESTART': '1', 23:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:19 INFO - 'PWD': '/builds/slave/test', 23:23:19 INFO - 'SHELL': '/bin/bash', 23:23:19 INFO - 'SHLVL': '1', 23:23:19 INFO - 'TERM': 'linux', 23:23:19 INFO - 'TMOUT': '86400', 23:23:19 INFO - 'USER': 'cltbld', 23:23:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', 23:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:19 INFO - '_': '/tools/buildbot/bin/python'} 23:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:23:19 INFO - Cleaning up... 23:23:19 INFO - Return code: 0 23:23:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:23:19 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')]} 23:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:19 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')]} 23:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:19 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 0x7fc38c39cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c1c0>, '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 0x199d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199d550>, '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': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', '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 23:23:19 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 23:23:19 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 23:23:19 INFO - Using env: {'DISPLAY': ':0', 23:23:19 INFO - 'HOME': '/home/cltbld', 23:23:19 INFO - 'LANG': 'en_US.UTF-8', 23:23:19 INFO - 'LANGUAGE': 'en_US:en', 23:23:19 INFO - 'LOGNAME': 'cltbld', 23:23:19 INFO - 'MAIL': '/var/mail/cltbld', 23:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:19 INFO - 'MOZ_NO_REMOTE': '1', 23:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:19 INFO - 'NO_EM_RESTART': '1', 23:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:19 INFO - 'PWD': '/builds/slave/test', 23:23:19 INFO - 'SHELL': '/bin/bash', 23:23:19 INFO - 'SHLVL': '1', 23:23:19 INFO - 'TERM': 'linux', 23:23:19 INFO - 'TMOUT': '86400', 23:23:19 INFO - 'USER': 'cltbld', 23:23:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', 23:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:19 INFO - '_': '/tools/buildbot/bin/python'} 23:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:19 INFO - Downloading/unpacking flake8 23:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:23:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:23:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:23:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:23:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:23:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:23:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:23:22 INFO - no previously-included directories found matching 'docs/_build' 23:23:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:23:22 INFO - Running setup.py install for pep8 23:23:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:23:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:23:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:23:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:23:22 INFO - no previously-included directories found matching 'docs/_build' 23:23:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:23:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:23:22 INFO - Cleaning up... 23:23:22 INFO - Return code: 0 23:23:22 INFO - Running post-action listener: _resource_record_post_action 23:23:22 INFO - Running post-action listener: _start_resource_monitoring 23:23:22 INFO - Starting resource monitoring. 23:23:22 INFO - ##### 23:23:22 INFO - ##### Finished create-virtualenv step (success) 23:23:22 INFO - ##### 23:23:22 INFO - ##### 23:23:22 INFO - ##### Running install step. 23:23:22 INFO - ##### 23:23:22 INFO - Running pre-action listener: _resource_record_pre_action 23:23:22 INFO - Running main action method: install 23:23:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:23:22 INFO - Reading from file tmpfile_stdout 23:23:22 INFO - Detecting whether we're running mozinstall >=1.0... 23:23:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:23:22 INFO - Reading from file tmpfile_stdout 23:23:22 INFO - Output received: 23:23:22 INFO - Usage: mozinstall [options] installer 23:23:22 INFO - Options: 23:23:22 INFO - -h, --help show this help message and exit 23:23:22 INFO - -d DEST, --destination=DEST 23:23:22 INFO - Directory to install application into. [default: 23:23:22 INFO - "/builds/slave/test"] 23:23:22 INFO - --app=APP Application being installed. [default: firefox] 23:23:22 INFO - mkdir: /builds/slave/test/build/application 23:23:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:23:38 INFO - Reading from file tmpfile_stdout 23:23:38 INFO - Output received: 23:23:38 INFO - /builds/slave/test/build/application/firefox/firefox 23:23:38 INFO - Running post-action listener: _resource_record_post_action 23:23:38 INFO - ##### 23:23:38 INFO - ##### Finished install step (success) 23:23:38 INFO - ##### 23:23:38 INFO - ##### 23:23:38 INFO - ##### Running run-tests step. 23:23:38 INFO - ##### 23:23:38 INFO - Running pre-action listener: _resource_record_pre_action 23:23:38 INFO - Running main action method: run_tests 23:23:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:23:38 INFO - Python 2.7.3 23:23:38 INFO - Return code: 0 23:23:38 INFO - grabbing minidump binary from tooltool 23:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:38 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 0x199c1c0>, '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 0x199d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:23:38 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 23:23:38 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 23:23:38 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 23:23:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:23:38 INFO - Return code: 0 23:23:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:23:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:23:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:23:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:23:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:23:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:23:39 INFO - Return code: 0 23:23:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 23:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 23:23:39 INFO - Using env: {'DISPLAY': ':0', 23:23:39 INFO - 'HOME': '/home/cltbld', 23:23:39 INFO - 'LANG': 'en_US.UTF-8', 23:23:39 INFO - 'LANGUAGE': 'en_US:en', 23:23:39 INFO - 'LOGNAME': 'cltbld', 23:23:39 INFO - 'MAIL': '/var/mail/cltbld', 23:23:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:23:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:39 INFO - 'MOZ_NO_REMOTE': '1', 23:23:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:23:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:39 INFO - 'NO_EM_RESTART': '1', 23:23:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:39 INFO - 'PWD': '/builds/slave/test', 23:23:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:23:39 INFO - 'SHELL': '/bin/bash', 23:23:39 INFO - 'SHLVL': '1', 23:23:39 INFO - 'TERM': 'linux', 23:23:39 INFO - 'TMOUT': '86400', 23:23:39 INFO - 'USER': 'cltbld', 23:23:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868', 23:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:39 INFO - '_': '/tools/buildbot/bin/python'} 23:23:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 23:23:39 INFO - mozversion application_buildid: 20160713152443 23:23:39 INFO - mozversion application_changeset: 709652b674013b136627e45fd90b4e9063906a19 23:23:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:23:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:23:39 INFO - mozversion application_name: Firefox 23:23:39 INFO - mozversion application_remotingname: firefox-dev 23:23:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:23:39 INFO - mozversion application_vendor: Mozilla 23:23:39 INFO - mozversion application_version: 49.0a2 23:23:39 INFO - mozversion platform_buildid: 20160713152443 23:23:39 INFO - mozversion platform_changeset: 709652b674013b136627e45fd90b4e9063906a19 23:23:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:23:39 INFO - mozversion platform_version: 49.0a2 23:23:39 INFO - using testdate: 1468477419 23:23:39 INFO - actual date: 1468477419 23:23:39 INFO - starting webserver on 'localhost:59051' 23:23:39 INFO - SUITE-START | Running 2 tests 23:23:39 INFO - TEST-START | dromaeo_css 23:23:39 INFO - operating with platform_type : linux_ 23:23:39 INFO - Initialising browser for dromaeo_css test... 23:23:39 INFO - TEST-INFO | started process 6792 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDcTzdr/profile http://localhost:59051/getInfo.html) 23:23:44 INFO - PROCESS | 6792 | __metrics Screen width/height:1600/1200 23:23:44 INFO - PROCESS | 6792 | colorDepth:24 23:23:44 INFO - PROCESS | 6792 | Browser inner width/height: 1024/697 23:23:44 INFO - PROCESS | 6792 | __metrics 23:23:45 ERROR - PROCESS | 6792 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 23:23:46 INFO - TEST-INFO | 6792: exit 0 23:23:46 INFO - Browser initialized. 23:23:46 INFO - Running cycle 1/1 for dromaeo_css test... 23:23:46 INFO - TEST-INFO | started process 6920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDcTzdr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:23:57 INFO - PROCESS | 6920 | RSS: Main: 155840512 23:23:57 INFO - PROCESS | 6920 | 23:24:47 INFO - PROCESS | 6920 | 1468477487575 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] 23:26:55 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:59051/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59051/tests/dromaeo/cssquery-ext.html) 23:26:56 INFO - PROCESS | 6920 | RSS: Main: 159899648 23:26:56 INFO - PROCESS | 6920 | 23:29:58 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:59051/tests/dromaeo/cssquery-ext.html (next: http://localhost:59051/tests/dromaeo/cssquery-jquery.html) 23:29:59 INFO - PROCESS | 6920 | RSS: Main: 157618176 23:29:59 INFO - PROCESS | 6920 | 23:33:01 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:59051/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59051/tests/dromaeo/cssquery-mootools.html) 23:33:01 INFO - PROCESS | 6920 | RSS: Main: 157007872 23:33:01 INFO - PROCESS | 6920 | 23:36:03 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:59051/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59051/tests/dromaeo/cssquery-prototype.html) 23:36:03 INFO - PROCESS | 6920 | RSS: Main: 157044736 23:36:03 INFO - PROCESS | 6920 | 23:39:06 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:59051/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59051/tests/dromaeo/cssquery-yui.html) 23:39:06 INFO - PROCESS | 6920 | RSS: Main: 158883840 23:39:06 INFO - PROCESS | 6920 | 23:42:09 INFO - PROCESS | 6920 | Cycle 1(1): loaded http://localhost:59051/tests/dromaeo/cssquery-yui.html (next: http://localhost:59051/tests/dromaeo/cssquery-dojo.html) 23:42:09 INFO - PROCESS | 6920 | RSS: Main: 159178752 23:42:09 INFO - PROCESS | 6920 | 23:42:09 INFO - PROCESS | 6920 | __start_tp_report 23:42:09 INFO - PROCESS | 6920 | _x_x_mozilla_page_load 23:42:09 INFO - PROCESS | 6920 | _x_x_mozilla_page_load_details 23:42:09 INFO - PROCESS | 6920 | |i|pagename|runs| 23:42:09 INFO - PROCESS | 6920 | |0;dojo.html;3314.2045908981845;3321.136504508827;3325.8503367348476;3340.131565792893;3349.2296771742513;5525.226468294437;5550.333959924805;5554.444555544444;5573.470520300565;5574.191742197384;5563.527100196478;5580.386157522669;5592.6085174037835;5601.131824567188;5601.887962240753;5113.411957624865;5127.128388174019;5194.63637545372;5196.272521846944;5213.530782229599;5044.949550504503;5079.339685840836;5154.5103215194495;5174.870628234286;5200.193969934648;5099.847004589868;5110.565601923841;5113.923291150636;5126.5898728101665;5172.9224061638915;5079.187330027196;5094.566961808232;5206.843794686166;5213.32226810516;5218.478152184789;5073.2643766654;5140.7172605506685;5203.947960520384;5210.583153347723;5227.163653815372;5344.545713614348;5427.592930530226;5428.511433970922;5517.420670829585;5538.556915446755;6000.8499787505225;6027.578069535134;6030.246219222598;6035.064564992389;6057.606255593372;5863.325717542494;6052.243469566304;6060.575759696823;6067.7572897084065;6070.939290607082;5541.307336582927;5626.943730562723;5638.661680299195;5638.661680299195;5672.773089076473;6150.78472253478;6176.7838125665385;6192.102145188923;6200.627962322275;6206.472449841724;5764.394738552392;5813.360530341659;5947.49446297061;5947.791827286024;5956.642601443928;5853.326867410217;5989.460948514655;5992.0712289595185;6009.008513595295;6024.789132380346;5888.970555147197;5954.225950626391;5977.372375900468;5992.161097446361;6003.399660034049;5853.64878107315;5858.47273745365;5910.99513082777;5976.760929562855;6012.218411606551;4590.839320623762;4591.494935557086;4605.9894771391;4606.262997920317;4620.699654522446;4092.242935057024;4100.405441211008;4105.322621767435;4110.547839737626;4150.024744185114;5721.199032135504;5760.481556659837;5768.134779782982;5841.766329346779;5846.41535846412;5896.498797602252;5924.081767326072;5952.642841429441;6003.969980150158;6033.668148251888;5787.189793428924;5788.479036886701;5807;5809.68046757424;5825.2135961644635;5052.34319538465;5053.343065401547;5062.974685126551;5105.795768169306;5161.458046905021;6218.378162183745;6280.685965701697;6282.748690052438;6294.590851594632;6297.905531416941;5839.678817664899;6019.42815432542;6076.361981992004;6077.939220607737;6088.025915853442;6132.049532322497;6147.200863887666;6171.691415429121;6230.376962303733;6264.21697287839;5885.735141918538;5892.440218179266;5897.911531326948;5932.822015339547;5934.762609495572;5864.618799778001;5914.172015917689;6017.518598512196;6021.578489505692;6029.065494848305;5804.535637148933;5860.765569377178;5862.032764593794;5889.646621202742;5923.289205295392;5812.912806307993;5832.825015249549;5863.853403664772;5880.059190529495;5882.352941176381;5564.777408903598;5745.683987380734;5766.048601980794;5779.479846813807;5787.652740835395;5907.9704601476715;5918.585699001029;5940.346561878277;5977.1034344846885;5981.790637327673;5828.0966450200285;5839.153322768259;5841.8539536510225;5847.94152058474;5858.2677165354335 23:42:09 INFO - PROCESS | 6920 | |1;ext.html;603.4357875386514;629.3611983836405;649.0977541217711;657.4378906035338;664.282574819195;46649.0670186596;48348.51651483484;48627.27059094117;48823.26765098526;51541.74229128858;49405.25892111621;49725.25412118821;49976.50023499764;50103.749481252635;50148;9196.356255062148;9291.210247129002;9327.347085704003;9336.113069258443;9350.719478415624;9113.954430227872;9242.722718318428;9283.72148835536;9292;9293.488858112802;9305.34862559621;9307.95346023269;9350.625974961027;9352.672656457025;9376.015518370576;9177.128172823572;9272.304577156707;9277.35058545902;9279.582418791137;9327.953360233156;9169.679061232891;9196.172344488961;9233.49215793131;9252.491112988782;9275.953620231923;44740.3288950666;45132.09735805298;45144.09711805778;45218.77390613026;45328.3200751989;3923.5487918889407;3932.4691166692414;3972.4239985201984;4088.284550203732;4370.191514569783;33959;34197.48703769445;34860.47709284363;35255.471167932505;35923.10192245189;4469.195544801934;4472.5303843096335;4481.193385190664;4528.479224889114;4605.194091034055;374818;385503;391921;393100;538275.999999996;68996.31003689898;69390;69682.30317696759;69771;69978;39877.40183897244;40698.796506017876;40821.79589102035;72290.27709722941;72709.63645181741;16741.07924064188;16749.581260468585;16811.075390853377;16864.241109150116;17004.234809433605;12444.253344799341;12521.874781252252;12593.811092833615;12604.117711760273;12659.430325635369;21313.25403610897;21423.143074277166;21532.56934861294;21565;21669.241576544744;7356.01246105919;7423;7528.473006889575;7567.772966811004;7653.081630204411;1082.2532452607675;1086.3536195963388;1129.9660810358594;1152.3949926288765;1174.1135442740676;33125;33267.66732332694;33705.83147084249;33746.66253337435;33784.49323260153;1168.5968340922368;1168.649405178443;1210.7154818617619;1216.4647555075737;1257.9371031448575;17539.91230043867;17823.46529604114;17927.820721792876;17941.282348705907;18004.279828806964;557362;588990;602219;812040;828674;63336.68331658404;63705;64061;64077;64147.35852641414;1423.7152569485936;1435.6339133520885;1436.899417040818;1438.0652575825588;1441.5603241011383;32099.35801284008;33123.83438082794;33512.49731253985;33780.831095845344;33955.3208935815;56517;56926.43073569211;56992.43007570037;57005;57204;458804;465953;465960;467418;469804;30909.845450772602;30927.381452370377;31540.842295788374;31562.684373155975;31674.841625791723;52051.21923171231;52195.246256314545;52779.47220527745;53070;53440.73279633577;42417.151656967304;44355;44542.77728611466;44997.77501112474;45317.54682453265;43242.56757432385;43456.782716086214;43544.782276088416;44606.3309050358;44868.775656121514;43923.34114988214;44195.337069943336;45322.77338613286;45789.542104578526;45921.31118033166;36292.81853590715;37633.2473350526;37977.81011094927;39187.6081239184;39336.6066339333;28739.856300718362;29908.252293692833;30221.848890755406;30297.848510757307;30356.84821575878 23:42:09 INFO - PROCESS | 6920 | |2;jquery.html;406.92471892699854;416.5230810721724;417.5052562713185;421.6542435203133;428.18217205138194;18626.90686546567;20061.99999999998;20742.688859667116;21279.57440851182;21392.465188370297;17330;17474.737878931825;17866.82133178668;17931.372401965902;17966.5508362291;5666;5682;5873.207117039187;5874.853128671774;5876.265466816648;5437.401885792559;5564.360098588653;5791.305043394798;5794.39158888317;5846.795362162326;5746.7413966371405;5812.651240925558;5834.212381328509;5850.853728656775;6222.813315600517;5898.675572843492;6281.309056003882;6306.905396419057;6348.333424990379;6369.681515924209;5792.710364481801;5818.0981947798155;5829.5919285650025;5852.853678658025;5854.2389489366105;14569.344379502947;14868.925655371762;21776.782232177633;22843.31470055901;22865.657015144785;2357.7877990980724;2372.0274687378264;2513.7360577139502;2615.790736741056;2954.8495812063284;10472.214583906161;10500.054995050483;10707.892921070768;10941.726456838564;10963;1983.5239542509837;1998.99000504998;2026.625074361248;2044.1516770540209;2048.1295449433933;81225.18774812235;81978.18021819765;82610;84864.57567712184;85810.57094714486;11217.270877392943;11524.423778811193;11595.478203480694;11632.651020469399;11894.82157767634;16306.347746090261;16410.671786564442;16474.588135296475;16502.504924852274;16550.586235343973;8116.431849770577;8221.54781487012;8309.293710034593;8364.958175209085;8409.369297302726;7819.335356494762;7842.098158711821;7843.37253019757;7924.603769811486;7984.281414672707;4917.754112294371;4967.155583550805;5011.599072074226;5079.1365467870555;5154.30416893722;1612.9354825806836;1667.8498935095656;1696;1711.4951089428648;1725.965480690379;985.8028394321165;1016.1718199667248;1020.285799940045;1025.4308858583408;1029.0327092532996;18907.243710251434;19288.22847086101;19300.517487062934;19364.128614212113;19909;1011.8633984412011;1025.610268098118;1025.8922813104666;1032.6643840751785;1038.4081073787868;10625.46872656364;10866.293690910066;10945.23383363157;11116.55533778656;11126.777464450828;521223;530353;531140;531832;533934.3303283459;94124.52937735405;95384.52307738418;98980.50509747406;99149.50425247972;100971.49514252528;1053.7892421515728;1067.1676092647747;1111.4053981120062;1121.8934201250868;1130.9604163854226;16983.405580804614;17037.744433833253;17320.740188897427;17391;17491.825081749528;38623;40949;42291.57708422876;42300.57699422966;44292.33561496516;53814.73092634512;58008.70995645164;59683;61079;61637.69181154066;6706.362895524917;8506;8828.911710882809;8865.778355541162;9199.908000919904;13180.736385272432;13846.65383365424;13920.303984800921;13998.860011399756;14071.929640351733;11163.832542511705;11651.76696466049;11772.882271177179;11934.045276377696;11981.700457488632;11894.940525297665;11940.223885447418;12020.519179232733;12039.337836419081;12223.0832687547;11613.941930290295;11719.945204931597;11765.52937882475;12357.382130893599;12643.620691379274;8907.599158037774;8935.463872167691;8985.056569060154;9091.409058411182;9203.355765096647;8471.872921906053;11465.770684586094;11494.885051149717;11520.193586448868;11645 23:42:09 INFO - PROCESS | 6920 | |3;mootools.html;1547.9071255724655;1549.4034796603307;1758.5515693498155;1899.3637131560927;1910.5032691500205;8648.091950345202;9309.069093090688;9352.672656457025;10038.29731918765;10094.747631309221;9709.563069661865;9711.708648740532;9758.804823903518;9789.657361992331;9826.21390288777;2491.58888783351;2534.3790771261065;2539.9492010159784;2542.7711505964458;2543.4785868896925;2406.626972819216;2510.460251046025;2524.583443731782;2544.7836933860644;2547.605121206216;2483.987580062106;2500.224930271622;2551.2346296111186;2553.3616595851036;2554.6678931738847;2312.433453803812;2331.80179684727;2336.906523739048;2406.566817972764;2412.7225369082603;2417.782399584046;2423.2730180945646;2428.5264373447185;2440.792532634728;2469.086438017927;9531.189848862856;9623.470709110996;9674.467904265262;9708.708738737778;9711.708648740549;5305.15117581189;5420.945790542083;5436.429174936614;5447.237386765856;5463.863403414946;3533.876314328986;3631.237440137574;3741.38267185914;3748.6813620842263;3776.9055773605605;1246.738184981155;1285.9935700321532;1286.0676009892845;2289.7710228977135;2365.432296248905;13388.464461421532;13426.798598021038;13450.865491345157;13501.2574308413;13557.389917453738;4896.216605343128;4907.607391408679;5042.3444952156715;5047.671901326402;5049.6465247432325;10548.841767373495;10646.307989980627;10700.090492308085;10700.571977120984;10715.249932504807;5429.53848922846;5430.484104010113;5476.507114359727;5492.340919089735;5539.224508568804;4552.704074235164;4853.247746599282;4906.58294045003;4936.876578085505;5013.523715247045;4031.838726450968;4079.755214687128;4202.390653355246;4203.600657937491;4209.052963083282;1271.1038717703996;1291.6318849127954;1302.4139137388213;1302.5671761062756;1311.2984553264148;1049.569676432659;1062.102523367753;1062.7927554127025;1068.5779117248644;1072.651388298806;6485.513586481033;6645.66771661415;6707.6981535831;6714.664266786641;6781.525293229525;472.6974736168855;473.03500858249475;473.76075082083327;474.2246427091661;484.007784042711;4597.747123908151;4622.237330840374;4656.208444564364;4678.345031695565;4692.061587682477;11842.171048026728;12067.637970860887;12094.213876098025;12180.451879665436;12251.081168912368;11506.424678766029;11938.104642151873;12005.459754310903;12238.571649992207;12386.62840114798;8924.464532128093;9000.23498002664;9056.320775941831;9066.818663626691;9073.047330030251;6711.597304161766;6780.898286525805;6926.411255043377;7033.191183014019;7051.647417628996;11089.390083545482;11306.94346528262;11321.377324247245;11450.969412752893;11460.197786155222;11453.713657158638;11480.598179063692;11527.365994870363;11584.015358694605;11586.88413115858;8436.578171091298;8581.914180858112;8700.086490918615;8702.912970870464;8707.042225355333;9108.863367049367;9187.08129187076;9248.537573121452;9291.349605527548;9306.348555601044;8390.202930721573;8413.957930210554;8434.746957591282;8446.915530844859;8580.570971451527;7985.321247694011;8034.67861285542;8052.355811535181;8126.471779334324;8140.308073813792;7523.172451030273;7593.810154746176;7626.847463050597;7640.770776876702;7658.846823063619;5583.162525621027;5750.252467179407;5800.45478118646;5846.824595262149;5908.025175845937;5852.736626851887;5866.208061911758;5902.704864756831;5916;5997.730102145501 23:42:09 INFO - PROCESS | 6920 | |4;prototype.html;350.2889135055836;355.68344173685415;355.8078637535731;364.03167574252495;366.74511214705774;5562.054450743373;5614.326280846304;5749.195112684228;5812.1862939188495;5813.389594092623;5568.693721845297;5577.581681373893;5627.099664053752;5641.379448260688;5654.123610840326;4393.604575588189;4443.667074785731;4465.4641443026885;4490.124425736983;4499.70751901127;4171.833126674929;4367.606915377615;4398.802053907566;4509.661775366861;4514.104076287967;4317.201317756225;4339.978300108495;4352.086061926999;4367.2575662137515;4388.780560971954;4354.673399495035;4377.4528183977;4383.64930805538;4384.99145196605;4394.714343567658;3767.9434808477895;3825.464434979105;3841.8463261469506;3845.8846234613006;3877.1470276539117;5442.455754424565;5447.319085114361;5449.4005659377435;5474.056709868019;5476.890462190734;4950.356453661037;4977.352944117241;5027.723475208862;5033.421156567005;5052.621053421009;5741.598088133832;5869.385918872302;5887.646741195542;5900.350961394243;5901.527877769811;4229.450171477688;4266.360045993095;4269.167512335096;4278.42241297424;4291.785410729451;6191.925704888868;6202.100695399187;6202.224721909762;6234.438900498977;6268.310485846599;4224.8732538023905;4372.584604462571;4385.7149285296355;4398.494173170063;4409.11817636474;4450.221211288012;4461.397711308931;4461.442319710036;4469.888252793706;4494.516809452873;5047;5100.7959681613065;5111.386633603991;5113.821016264413;5127.2052831811125;5746.856328591735;5833.533317334603;5907;6031.647657413612;6091.38578276757;1495.8952873298983;1510.735621266274;1515.9621009474631;1524.207412145678;1548.705745908274;953.3803028031834;960.2126256469628;968.2399316536626;969.9078587534173;981.9934567068811;5193.987172501402;5200.959808038408;5218.478152184751;5240.895182096413;5322.004248406847;5403;5481.890362192734;5490.56075513958;5593.972030139905;5595.048841696921;4879.707217566957;5194.6234947284565;5211.244369566468;5280.653433374465;5298.09932311508;2896.942061158807;2931.6188895443884;2952.291450052015;2959.926001849928;2960.7779416543412;5607.467290607386;5664.291963504562;5742.54059675225;5755.453231942959;5763.308402991668;5909.23179986599;6332.461740751995;6353.936460635335;6376.649284289409;6386.872262554816;6461.449252179537;6477.805665830033;6494.935050649433;6512.902306465407;6516.576422532615;5990.921634105903;6211.894052973514;6241.563090583797;6246.875062498633;6277.497800175884;6148.077788331786;6181.258249010148;6200.131981522681;6201.906971395342;6214.564980451506;6113.358097399887;6446.419822216023;6514.837129071811;6558.8360290993105;6563.835904102436;4347.500037495602;4367.868963931087;4376;4384.298512238154;4392.450943632046;5924.9703751480965;6046.818595442144;6183.288921773874;6226.1905952227735;6243.219597550306;6015.4586087252355;6026.849328766816;6040.0939859019745;6052.334243233153;6054.273487181566;5984.665980267786;5987.2815262168815;5997.430244126801;6037.00778743005;6057.969710151598;5617.129344951539;5914.905742437662;5936.3470018297085;5949.613275137102;5962.9105563415715;6017.849553761191;6024.698765061642;6032.939670603413;6040.939590604214;6046.848828779316;5635.971820140873;5873.765049398147;5902.5277977762535;5952.315483719428;5976.8804623908145 23:42:09 INFO - PROCESS | 6920 | |5;yui.html;785.0383280481411;789.7235967411403;793.0047790023519;808.644126873475;822.9506229626222;14377.281135943213;14410.207438590873;14684.853151468482;16159.515214543568;16377.672446551062;15907.522774316789;16202.189890505486;16204.108774017424;16245.431409900655;16285.267162977665;707.465863273228;828.6436832162168;846.2214762418558;851.0680804519072;852.8209076093997;847.0470720439506;852.3990586636406;857.2413414128509;858.1289990659454;859.3554833874595;894.6421431427449;900.918917297443;902.0979020979021;903.3947255338906;904.4934836491553;889.5152142082613;892.7411050795262;898.1781669772216;898.5058217980118;899.9910000900005;657.2343220148568;659.7789740436959;659.9736010559571;660.2044536333755;660.2934859700075;14090.506832260822;14094.718105637932;14202.50291239812;14257.287135643177;14257.857421425757;14212.218327991955;14228.786568201382;14235.644108897257;14311.141331520143;16508.25712842925;14421.711565768626;14552.563423097325;14607.415703371853;14691.118532887955;14896.776548351783;4766.38037055184;4770.212914869077;4774.594159496447;4802.927956080662;4824.710517368969;79744;80683.5965820173;80824.99999999942;80968;81341.59329203375;11749.88250117505;12071.3360765157;12079.09406794494;12248.38758062111;12300.261984280973;21670.674939875913;21697.240596579042;21721;21756.129754809946;21862.562748744935;9046;9092.818143637223;9150;9248.953755231181;9389.01415351392;4927.77824997876;4962.801487940442;4966.850994470099;5013.799448022039;5126.846194614168;3895.7857317847224;4032.9395059074136;4039.3940908863906;4060.7766572838777;4068.389741538793;672.8217022489044;706.8621618784288;743.9888401673871;757.7991832164481;763.8243204063097;634.5875181132301;751.1849643137257;795.9323457506061;800.6637212370819;804.8792681097882;10589.894101059044;11055.557777688964;11163.330200188015;11391.658250252505;11397;750.8535835512023;770.2297702297702;773.4663082473076;820.9466384684977;830.2942498876027;5190.792368305301;5331.920021199685;5332.173513105475;5418.322709661293;5435.266239057677;77238.6138069306;77383.22616773873;124108;124546;129385;101072;102126;103636;105418.47290763498;108162;96555.51722241484;96839.51580242053;97774;98339;100070.49964750276;10205.591776328863;10234.33476824004;10236.692899213036;10382.688519344432;10383.117435018108;57258.71370643287;57390;57728;58923.41076589179;59320.999999998276;76860;77733;85215;86044;86086.56956715176;13501.932490337485;13556.11885227457;13563.38964746569;13569.457221711022;13843.515476958259;13251.469941202244;13347.799783003069;13542.05205635596;13567.321633918462;13718.314084295545;14087.718245635235;14102.435902564193;14137.222452765196;14287.928560357132;14794;13839.723205536035;14018.509352172625;14179.574612761633;14267.286635668383;14369.712605748036;13572.93213533926;13919.721605567629;13956;13966.231857247543;14016.369263382969;10359.533820977924;10638.787224255317;10668.519916603927;10712;11100.61147859821;11456.885431145582;11627.47676354583;11956.461959211681;12373.505059797508;12626.810597841224 23:42:09 INFO - PROCESS | 6920 | __end_tp_report 23:42:09 INFO - PROCESS | 6920 | __start_cc_report 23:42:09 INFO - PROCESS | 6920 | _x_x_mozilla_cycle_collect,374 23:42:09 INFO - PROCESS | 6920 | __end_cc_report 23:42:09 INFO - PROCESS | 6920 | __startTimestamp1468478529497__endTimestamp 23:42:09 INFO - PROCESS | 6920 | 23:42:09 INFO - PROCESS | 6920 | ------- Summary: start ------- 23:42:09 INFO - PROCESS | 6920 | Number of tests: 6 23:42:09 INFO - PROCESS | 6920 | 23:42:09 INFO - PROCESS | 6920 | [#0] dojo.html Cycles:165 Average:5583.26 Median:5828.10 stddev:620.76 (10.7%) stddev-sans-first:596.59 23:42:09 INFO - PROCESS | 6920 | Values: 3314.2 3321.1 3325.9 3340.1 3349.2 5525.2 5550.3 5554.4 5573.5 5574.2 5563.5 5580.4 5592.6 5601.1 5601.9 5113.4 5127.1 5194.6 5196.3 5213.5 5044.9 5079.3 5154.5 5174.9 5200.2 5099.8 5110.6 5113.9 5126.6 5172.9 5079.2 5094.6 5206.8 5213.3 5218.5 5073.3 5140.7 5203.9 5210.6 5227.2 5344.5 5427.6 5428.5 5517.4 5538.6 6000.8 6027.6 6030.2 6035.1 6057.6 5863.3 6052.2 6060.6 6067.8 6070.9 5541.3 5626.9 5638.7 5638.7 5672.8 6150.8 6176.8 6192.1 6200.6 6206.5 5764.4 5813.4 5947.5 5947.8 5956.6 5853.3 5989.5 5992.1 6009.0 6024.8 5889.0 5954.2 5977.4 5992.2 6003.4 5853.6 5858.5 5911.0 5976.8 6012.2 4590.8 4591.5 4606.0 4606.3 4620.7 4092.2 4100.4 4105.3 4110.5 4150.0 5721.2 5760.5 5768.1 5841.8 5846.4 5896.5 5924.1 5952.6 6004.0 6033.7 5787.2 5788.5 5807.0 5809.7 5825.2 5052.3 5053.3 5063.0 5105.8 5161.5 6218.4 6280.7 6282.7 6294.6 6297.9 5839.7 6019.4 6076.4 6077.9 6088.0 6132.0 6147.2 6171.7 6230.4 6264.2 5885.7 5892.4 5897.9 5932.8 5934.8 5864.6 5914.2 6017.5 6021.6 6029.1 5804.5 5860.8 5862.0 5889.6 5923.3 5812.9 5832.8 5863.9 5880.1 5882.4 5564.8 5745.7 5766.0 5779.5 5787.7 5908.0 5918.6 5940.3 5977.1 5981.8 5828.1 5839.2 5841.9 5847.9 5858.3 23:42:09 INFO - PROCESS | 6920 | 23:42:09 INFO - PROCESS | 6920 | [#1] ext.html Cycles:180 Average:68615.89 Median:44933.28 stddev:143512.85 (319.4%) stddev-sans-first:143824.60 23:42:09 INFO - PROCESS | 6920 | Values: 603.4 629.4 649.1 657.4 664.3 46649.1 48348.5 48627.3 48823.3 51541.7 49405.3 49725.3 49976.5 50103.7 50148.0 9196.4 9291.2 9327.3 9336.1 9350.7 9114.0 9242.7 9283.7 9292.0 9293.5 9305.3 9308.0 9350.6 9352.7 9376.0 9177.1 9272.3 9277.4 9279.6 9328.0 9169.7 9196.2 9233.5 9252.5 9276.0 44740.3 45132.1 45144.1 45218.8 45328.3 3923.5 3932.5 3972.4 4088.3 4370.2 33959.0 34197.5 34860.5 35255.5 35923.1 4469.2 4472.5 4481.2 4528.5 4605.2 374818.0 385503.0 391921.0 393100.0 538276.0 68996.3 69390.0 69682.3 69771.0 69978.0 39877.4 40698.8 40821.8 72290.3 72709.6 16741.1 16749.6 16811.1 16864.2 17004.2 12444.3 12521.9 12593.8 12604.1 12659.4 21313.3 21423.1 21532.6 21565.0 21669.2 7356.0 7423.0 7528.5 7567.8 7653.1 1082.3 1086.4 1130.0 1152.4 1174.1 33125.0 33267.7 33705.8 33746.7 33784.5 1168.6 1168.6 1210.7 1216.5 1257.9 17539.9 17823.5 17927.8 17941.3 18004.3 557362.0 588990.0 602219.0 812040.0 828674.0 63336.7 63705.0 64061.0 64077.0 64147.4 1423.7 1435.6 1436.9 1438.1 1441.6 32099.4 33123.8 33512.5 33780.8 33955.3 56517.0 56926.4 56992.4 57005.0 57204.0 458804.0 465953.0 465960.0 467418.0 469804.0 30909.8 30927.4 31540.8 31562.7 31674.8 52051.2 52195.2 52779.5 53070.0 53440.7 42417.2 44355.0 44542.8 44997.8 45317.5 43242.6 43456.8 43544.8 44606.3 44868.8 43923.3 44195.3 45322.8 45789.5 45921.3 36292.8 37633.2 37977.8 39187.6 39336.6 28739.9 29908.3 30221.8 30297.8 30356.8 23:42:09 INFO - PROCESS | 6920 | 23:42:09 INFO - PROCESS | 6920 | [#2] jquery.html Cycles:180 Average:30372.80 Median:21584.62 stddev:87288.20 (404.4%) stddev-sans-first:87504.06 23:42:09 INFO - PROCESS | 6920 | Values: 406.9 416.5 417.5 421.7 428.2 18626.9 20062.0 20742.7 21279.6 21392.5 17330.0 17474.7 17866.8 17931.4 17966.6 5666.0 5682.0 5873.2 5874.9 5876.3 5437.4 5564.4 5791.3 5794.4 5846.8 5746.7 5812.7 5834.2 5850.9 6222.8 5898.7 6281.3 6306.9 6348.3 6369.7 5792.7 5818.1 5829.6 5852.9 5854.2 14569.3 14868.9 21776.8 22843.3 22865.7 2357.8 2372.0 2513.7 2615.8 2954.8 10472.2 10500.1 10707.9 10941.7 10963.0 1983.5 1999.0 2026.6 2044.2 2048.1 81225.2 81978.2 82610.0 84864.6 85810.6 11217.3 11524.4 11595.5 11632.7 11894.8 16306.3 16410.7 16474.6 16502.5 16550.6 8116.4 8221.5 8309.3 8365.0 8409.4 7819.3 7842.1 7843.4 7924.6 7984.3 4917.8 4967.2 5011.6 5079.1 5154.3 1612.9 1667.8 1696.0 1711.5 1726.0 985.8 1016.2 1020.3 1025.4 1029.0 18907.2 19288.2 19300.5 19364.1 19909.0 1011.9 1025.6 1025.9 1032.7 1038.4 10625.5 10866.3 10945.2 11116.6 11126.8 521223.0 530353.0 531140.0 531832.0 533934.3 94124.5 95384.5 98980.5 99149.5 100971.5 1053.8 1067.2 1111.4 1121.9 1131.0 16983.4 17037.7 17320.7 17391.0 17491.8 38623.0 40949.0 42291.6 42300.6 44292.3 53814.7 58008.7 59683.0 61079.0 61637.7 6706.4 8506.0 8828.9 8865.8 9199.9 13180.7 13846.7 13920.3 13998.9 14071.9 11163.8 11651.8 11772.9 11934.0 11981.7 11894.9 11940.2 12020.5 12039.3 12223.1 11613.9 11719.9 11765.5 12357.4 12643.6 8907.6 8935.5 8985.1 9091.4 9203.4 8471.9 11465.8 11494.9 11520.2 11645.0 23:42:09 INFO - PROCESS | 6920 | 23:42:09 INFO - PROCESS | 6920 | [#3] mootools.html Cycles:180 Average:6335.42 Median:4667.28 stddev:3647.40 (78.1%) stddev-sans-first:3639.89 23:42:09 INFO - PROCESS | 6920 | Values: 1547.9 1549.4 1758.6 1899.4 1910.5 8648.1 9309.1 9352.7 10038.3 10094.7 9709.6 9711.7 9758.8 9789.7 9826.2 2491.6 2534.4 2539.9 2542.8 2543.5 2406.6 2510.5 2524.6 2544.8 2547.6 2484.0 2500.2 2551.2 2553.4 2554.7 2312.4 2331.8 2336.9 2406.6 2412.7 2417.8 2423.3 2428.5 2440.8 2469.1 9531.2 9623.5 9674.5 9708.7 9711.7 5305.2 5420.9 5436.4 5447.2 5463.9 3533.9 3631.2 3741.4 3748.7 3776.9 1246.7 1286.0 1286.1 2289.8 2365.4 13388.5 13426.8 13450.9 13501.3 13557.4 4896.2 4907.6 5042.3 5047.7 5049.6 10548.8 10646.3 10700.1 10700.6 10715.2 5429.5 5430.5 5476.5 5492.3 5539.2 4552.7 4853.2 4906.6 4936.9 5013.5 4031.8 4079.8 4202.4 4203.6 4209.1 1271.1 1291.6 1302.4 1302.6 1311.3 1049.6 1062.1 1062.8 1068.6 1072.7 6485.5 6645.7 6707.7 6714.7 6781.5 472.7 473.0 473.8 474.2 484.0 4597.7 4622.2 4656.2 4678.3 4692.1 11842.2 12067.6 12094.2 12180.5 12251.1 11506.4 11938.1 12005.5 12238.6 12386.6 8924.5 9000.2 9056.3 9066.8 9073.0 6711.6 6780.9 6926.4 7033.2 7051.6 11089.4 11306.9 11321.4 11451.0 11460.2 11453.7 11480.6 11527.4 11584.0 11586.9 8436.6 8581.9 8700.1 8702.9 8707.0 9108.9 9187.1 9248.5 9291.3 9306.3 8390.2 8414.0 8434.7 8446.9 8580.6 7985.3 8034.7 8052.4 8126.5 8140.3 7523.2 7593.8 7626.8 7640.8 7658.8 5583.2 5750.3 5800.5 5846.8 5908.0 5852.7 5866.2 5902.7 5916.0 5997.7 23:42:09 INFO - PROCESS | 6920 | 23:42:09 INFO - PROCESS | 6920 | [#4] prototype.html Cycles:180 Average:4964.59 Median:5585.78 stddev:1481.13 (26.5%) stddev-sans-first:1444.23 23:42:09 INFO - PROCESS | 6920 | Values: 350.3 355.7 355.8 364.0 366.7 5562.1 5614.3 5749.2 5812.2 5813.4 5568.7 5577.6 5627.1 5641.4 5654.1 4393.6 4443.7 4465.5 4490.1 4499.7 4171.8 4367.6 4398.8 4509.7 4514.1 4317.2 4340.0 4352.1 4367.3 4388.8 4354.7 4377.5 4383.6 4385.0 4394.7 3767.9 3825.5 3841.8 3845.9 3877.1 5442.5 5447.3 5449.4 5474.1 5476.9 4950.4 4977.4 5027.7 5033.4 5052.6 5741.6 5869.4 5887.6 5900.4 5901.5 4229.5 4266.4 4269.2 4278.4 4291.8 6191.9 6202.1 6202.2 6234.4 6268.3 4224.9 4372.6 4385.7 4398.5 4409.1 4450.2 4461.4 4461.4 4469.9 4494.5 5047.0 5100.8 5111.4 5113.8 5127.2 5746.9 5833.5 5907.0 6031.6 6091.4 1495.9 1510.7 1516.0 1524.2 1548.7 953.4 960.2 968.2 969.9 982.0 5194.0 5201.0 5218.5 5240.9 5322.0 5403.0 5481.9 5490.6 5594.0 5595.0 4879.7 5194.6 5211.2 5280.7 5298.1 2896.9 2931.6 2952.3 2959.9 2960.8 5607.5 5664.3 5742.5 5755.5 5763.3 5909.2 6332.5 6353.9 6376.6 6386.9 6461.4 6477.8 6494.9 6512.9 6516.6 5990.9 6211.9 6241.6 6246.9 6277.5 6148.1 6181.3 6200.1 6201.9 6214.6 6113.4 6446.4 6514.8 6558.8 6563.8 4347.5 4367.9 4376.0 4384.3 4392.5 5925.0 6046.8 6183.3 6226.2 6243.2 6015.5 6026.8 6040.1 6052.3 6054.3 5984.7 5987.3 5997.4 6037.0 6058.0 5617.1 5914.9 5936.3 5949.6 5962.9 6017.8 6024.7 6032.9 6040.9 6046.8 5636.0 5873.8 5902.5 5952.3 5976.9 23:42:09 INFO - PROCESS | 6920 | 23:42:09 INFO - PROCESS | 6920 | [#5] yui.html Cycles:180 Average:21875.45 Median:4036.17 stddev:31357.40 (776.9%) stddev-sans-first:31405.37 23:42:09 INFO - PROCESS | 6920 | Values: 785.0 789.7 793.0 808.6 823.0 14377.3 14410.2 14684.9 16159.5 16377.7 15907.5 16202.2 16204.1 16245.4 16285.3 707.5 828.6 846.2 851.1 852.8 847.0 852.4 857.2 858.1 859.4 894.6 900.9 902.1 903.4 904.5 889.5 892.7 898.2 898.5 900.0 657.2 659.8 660.0 660.2 660.3 14090.5 14094.7 14202.5 14257.3 14257.9 14212.2 14228.8 14235.6 14311.1 16508.3 14421.7 14552.6 14607.4 14691.1 14896.8 4766.4 4770.2 4774.6 4802.9 4824.7 79744.0 80683.6 80825.0 80968.0 81341.6 11749.9 12071.3 12079.1 12248.4 12300.3 21670.7 21697.2 21721.0 21756.1 21862.6 9046.0 9092.8 9150.0 9249.0 9389.0 4927.8 4962.8 4966.9 5013.8 5126.8 3895.8 4032.9 4039.4 4060.8 4068.4 672.8 706.9 744.0 757.8 763.8 634.6 751.2 795.9 800.7 804.9 10589.9 11055.6 11163.3 11391.7 11397.0 750.9 770.2 773.5 820.9 830.3 5190.8 5331.9 5332.2 5418.3 5435.3 77238.6 77383.2 124108.0 124546.0 129385.0 101072.0 102126.0 103636.0 105418.5 108162.0 96555.5 96839.5 97774.0 98339.0 100070.5 10205.6 10234.3 10236.7 10382.7 10383.1 57258.7 57390.0 57728.0 58923.4 59321.0 76860.0 77733.0 85215.0 86044.0 86086.6 13501.9 13556.1 13563.4 13569.5 13843.5 13251.5 13347.8 13542.1 13567.3 13718.3 14087.7 14102.4 14137.2 14287.9 14794.0 13839.7 14018.5 14179.6 14267.3 14369.7 13572.9 13919.7 13956.0 13966.2 14016.4 10359.5 10638.8 10668.5 10712.0 11100.6 11456.9 11627.5 11956.5 12373.5 12626.8 23:42:09 INFO - PROCESS | 6920 | -------- Summary: end -------- 23:42:09 INFO - PROCESS | 6920 | 23:42:10 INFO - TEST-INFO | 6920: exit 0 23:42:10 INFO - TEST-OK | dromaeo_css | took 1110244ms 23:42:10 INFO - TEST-START | kraken 23:42:10 INFO - operating with platform_type : linux_ 23:42:10 INFO - Initialising browser for kraken test... 23:42:10 INFO - TEST-INFO | started process 7164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa9QHuZ/profile http://localhost:59051/getInfo.html) 23:42:14 INFO - PROCESS | 7164 | __metrics Screen width/height:1600/1200 23:42:14 INFO - PROCESS | 7164 | colorDepth:24 23:42:14 INFO - PROCESS | 7164 | Browser inner width/height: 1024/697 23:42:14 INFO - PROCESS | 7164 | __metrics 23:42:15 ERROR - PROCESS | 7164 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 23:42:16 INFO - TEST-INFO | 7164: exit 0 23:42:16 INFO - Browser initialized. 23:42:16 INFO - Running cycle 1/1 for kraken test... 23:42:16 INFO - TEST-INFO | started process 7292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa9QHuZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:42:28 INFO - PROCESS | 7292 | RSS: Main: 156254208 23:42:28 INFO - PROCESS | 7292 | 23:42:30 INFO - PROCESS | 7292 | Cycle 1(1): loaded http://localhost:59051/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59051/tests/kraken/driver.html?testName=audio-beat-detection) 23:42:31 INFO - PROCESS | 7292 | RSS: Main: 162127872 23:42:31 INFO - PROCESS | 7292 | 23:42:34 INFO - PROCESS | 7292 | Cycle 1(1): loaded http://localhost:59051/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59051/tests/kraken/driver.html?testName=audio-dft) 23:42:34 INFO - PROCESS | 7292 | RSS: Main: 160710656 23:42:34 INFO - PROCESS | 7292 | 23:42:37 INFO - PROCESS | 7292 | Cycle 1(1): loaded http://localhost:59051/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59051/tests/kraken/driver.html?testName=audio-fft) 23:42:38 INFO - PROCESS | 7292 | RSS: Main: 161812480 23:42:38 INFO - PROCESS | 7292 | 23:42:40 INFO - PROCESS | 7292 | Cycle 1(1): loaded http://localhost:59051/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59051/tests/kraken/driver.html?testName=audio-oscillator) 23:42:40 INFO - PROCESS | 7292 | RSS: Main: 161673216 23:42:40 INFO - PROCESS | 7292 | 23:42:43 INFO - PROCESS | 7292 | Cycle 1(1): loaded http://localhost:59051/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59051/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:42:43 INFO - PROCESS | 7292 | RSS: Main: 161034240 23:42:43 INFO - PROCESS | 7292 | 23:42:46 INFO - PROCESS | 7292 | Cycle 1(1): loaded http://localhost:59051/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59051/tests/kraken/driver.html?testName=imaging-darkroom) 23:42:47 INFO - PROCESS | 7292 | RSS: Main: 160923648 23:42:47 INFO - PROCESS | 7292 | 23:42:50 INFO - PROCESS | 7292 | Cycle 1(1): loaded http://localhost:59051/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59051/tests/kraken/driver.html?testName=imaging-desaturate) 23:42:51 INFO - PROCESS | 7292 | RSS: Main: 161538048 23:42:51 INFO - PROCESS | 7292 | 23:42:54 INFO - PROCESS | 7292 | Cycle 1(1): loaded http://localhost:59051/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59051/tests/kraken/driver.html?testName=json-parse-financial) 23:42:54 INFO - PROCESS | 7292 | RSS: Main: 160780288 23:42:54 INFO - PROCESS | 7292 | 23:42:56 INFO - PROCESS | 7292 | Cycle 1(1): loaded http://localhost:59051/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59051/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:42:57 INFO - PROCESS | 7292 | RSS: Main: 160952320 23:42:57 INFO - PROCESS | 7292 | 23:42:58 INFO - PROCESS | 7292 | Cycle 1(1): loaded http://localhost:59051/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59051/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:42:59 INFO - PROCESS | 7292 | RSS: Main: 160899072 23:42:59 INFO - PROCESS | 7292 | 23:43:01 INFO - PROCESS | 7292 | Cycle 1(1): loaded http://localhost:59051/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59051/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:43:02 INFO - PROCESS | 7292 | RSS: Main: 161308672 23:43:02 INFO - PROCESS | 7292 | 23:43:04 INFO - PROCESS | 7292 | Cycle 1(1): loaded http://localhost:59051/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59051/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:43:05 INFO - PROCESS | 7292 | RSS: Main: 161452032 23:43:05 INFO - PROCESS | 7292 | 23:43:07 INFO - PROCESS | 7292 | Cycle 1(1): loaded http://localhost:59051/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59051/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:43:08 INFO - PROCESS | 7292 | RSS: Main: 161734656 23:43:08 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | Cycle 1(1): loaded http://localhost:59051/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59051/tests/kraken/driver.html?testName=ai-astar) 23:43:10 INFO - PROCESS | 7292 | RSS: Main: 162263040 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | __start_tp_report 23:43:10 INFO - PROCESS | 7292 | _x_x_mozilla_page_load 23:43:10 INFO - PROCESS | 7292 | _x_x_mozilla_page_load_details 23:43:10 INFO - PROCESS | 7292 | |i|pagename|runs| 23:43:10 INFO - PROCESS | 7292 | |0;ai-astar;111;106;109;110;112;111;110;109;111;110 23:43:10 INFO - PROCESS | 7292 | |1;audio-beat-detection;151;125;158;175;126;154;156;128;191;127 23:43:10 INFO - PROCESS | 7292 | |2;audio-dft;163;161;163;162;162;169;163;164;163;164 23:43:10 INFO - PROCESS | 7292 | |3;audio-fft;75;74;75;186;76;76;75;75;177;76 23:43:10 INFO - PROCESS | 7292 | |4;audio-oscillator;86;84;148;85;84;85;144;84;86;142 23:43:10 INFO - PROCESS | 7292 | |5;imaging-gaussian-blur;118;117;118;119;118;117;118;118;117;117 23:43:10 INFO - PROCESS | 7292 | |6;imaging-darkroom;147;147;148;149;147;149;147;147;147;147 23:43:10 INFO - PROCESS | 7292 | |7;imaging-desaturate;99;96;98;96;95;96;96;95;100;95 23:43:10 INFO - PROCESS | 7292 | |8;json-parse-financial;52;55;54;52;53;53;52;52;54;53 23:43:10 INFO - PROCESS | 7292 | |9;json-stringify-tinderbox;59;60;60;59;60;60;60;59;59;59 23:43:10 INFO - PROCESS | 7292 | |10;stanford-crypto-aes;75;77;77;85;75;78;79;76;106;77 23:43:10 INFO - PROCESS | 7292 | |11;stanford-crypto-ccm;127;117;118;118;118;119;131;140;130;128 23:43:10 INFO - PROCESS | 7292 | |12;stanford-crypto-pbkdf2;154;152;155;153;154;150;156;152;152;158 23:43:10 INFO - PROCESS | 7292 | |13;stanford-crypto-sha256-iterative;65;68;61;61;61;61;62;61;61;59 23:43:10 INFO - PROCESS | 7292 | __end_tp_report 23:43:10 INFO - PROCESS | 7292 | __start_cc_report 23:43:10 INFO - PROCESS | 7292 | _x_x_mozilla_cycle_collect,851 23:43:10 INFO - PROCESS | 7292 | __end_cc_report 23:43:10 INFO - PROCESS | 7292 | __startTimestamp1468478590424__endTimestamp 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | ------- Summary: start ------- 23:43:10 INFO - PROCESS | 7292 | Number of tests: 14 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:1.66 (1.5%) stddev-sans-first:1.72 23:43:10 INFO - PROCESS | 7292 | Values: 111.0 106.0 109.0 110.0 112.0 111.0 110.0 109.0 111.0 110.0 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:155.00 stddev:22.68 (14.6%) stddev-sans-first:24.04 23:43:10 INFO - PROCESS | 7292 | Values: 151.0 125.0 158.0 175.0 126.0 154.0 156.0 128.0 191.0 127.0 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.17 (1.3%) stddev-sans-first:2.30 23:43:10 INFO - PROCESS | 7292 | Values: 163.0 161.0 163.0 162.0 162.0 169.0 163.0 164.0 163.0 164.0 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | [#3] audio-fft Cycles:10 Average:96.50 Median:75.00 stddev:44.85 (59.8%) stddev-sans-first:46.89 23:43:10 INFO - PROCESS | 7292 | Values: 75.0 74.0 75.0 186.0 76.0 76.0 75.0 75.0 177.0 76.0 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:84.50 stddev:28.94 (34.2%) stddev-sans-first:30.05 23:43:10 INFO - PROCESS | 7292 | Values: 86.0 84.0 148.0 85.0 84.0 85.0 144.0 84.0 86.0 142.0 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 23:43:10 INFO - PROCESS | 7292 | Values: 118.0 117.0 118.0 119.0 118.0 117.0 118.0 118.0 117.0 117.0 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 23:43:10 INFO - PROCESS | 7292 | Values: 147.0 147.0 148.0 149.0 147.0 149.0 147.0 147.0 147.0 147.0 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:1.78 (1.9%) stddev-sans-first:1.66 23:43:10 INFO - PROCESS | 7292 | Values: 99.0 96.0 98.0 96.0 95.0 96.0 96.0 95.0 100.0 95.0 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:1.05 (2.0%) stddev-sans-first:1.05 23:43:10 INFO - PROCESS | 7292 | Values: 52.0 55.0 54.0 52.0 53.0 53.0 52.0 52.0 54.0 53.0 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 23:43:10 INFO - PROCESS | 7292 | Values: 59.0 60.0 60.0 59.0 60.0 60.0 60.0 59.0 59.0 59.0 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:77.00 stddev:9.41 (12.2%) stddev-sans-first:9.77 23:43:10 INFO - PROCESS | 7292 | Values: 75.0 77.0 77.0 85.0 75.0 78.0 79.0 76.0 106.0 77.0 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:127.50 stddev:7.78 (6.1%) stddev-sans-first:8.20 23:43:10 INFO - PROCESS | 7292 | Values: 127.0 117.0 118.0 118.0 118.0 119.0 131.0 140.0 130.0 128.0 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:154.00 stddev:2.32 (1.5%) stddev-sans-first:2.46 23:43:10 INFO - PROCESS | 7292 | Values: 154.0 152.0 155.0 153.0 154.0 150.0 156.0 152.0 152.0 158.0 23:43:10 INFO - PROCESS | 7292 | 23:43:10 INFO - PROCESS | 7292 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:61.00 stddev:2.58 (4.2%) stddev-sans-first:2.50 23:43:10 INFO - PROCESS | 7292 | Values: 65.0 68.0 61.0 61.0 61.0 61.0 62.0 61.0 61.0 59.0 23:43:10 INFO - PROCESS | 7292 | -------- Summary: end -------- 23:43:10 INFO - PROCESS | 7292 | 23:43:11 INFO - TEST-INFO | 7292: exit 0 23:43:11 INFO - TEST-OK | kraken | took 61139ms 23:43:11 INFO - SUITE-END | took 1171s 23:43:11 INFO - Completed test suite (00:19:31) 23:43:11 INFO - javascript benchmark 23:43:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7665.154230621862, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.2045908981845, 3321.136504508827, 3325.8503367348476, 3340.131565792893, 3349.2296771742513, 5525.226468294437, 5550.333959924805, 5554.444555544444, 5573.470520300565, 5574.191742197384, 5563.527100196478, 5580.386157522669, 5592.6085174037835, 5601.131824567188, 5601.887962240753, 5113.411957624865, 5127.128388174019, 5194.63637545372, 5196.272521846944, 5213.530782229599, 5044.949550504503, 5079.339685840836, 5154.5103215194495, 5174.870628234286, 5200.193969934648, 5099.847004589868, 5110.565601923841, 5113.923291150636, 5126.5898728101665, 5172.9224061638915, 5079.187330027196, 5094.566961808232, 5206.843794686166, 5213.32226810516, 5218.478152184789, 5073.2643766654, 5140.7172605506685, 5203.947960520384, 5210.583153347723, 5227.163653815372, 5344.545713614348, 5427.592930530226, 5428.511433970922, 5517.420670829585, 5538.556915446755, 6000.8499787505225, 6027.578069535134, 6030.246219222598, 6035.064564992389, 6057.606255593372, 5863.325717542494, 6052.243469566304, 6060.575759696823, 6067.7572897084065, 6070.939290607082, 5541.307336582927, 5626.943730562723, 5638.661680299195, 5638.661680299195, 5672.773089076473, 6150.78472253478, 6176.7838125665385, 6192.102145188923, 6200.627962322275, 6206.472449841724, 5764.394738552392, 5813.360530341659, 5947.49446297061, 5947.791827286024, 5956.642601443928, 5853.326867410217, 5989.460948514655, 5992.0712289595185, 6009.008513595295, 6024.789132380346, 5888.970555147197, 5954.225950626391, 5977.372375900468, 5992.161097446361, 6003.399660034049, 5853.64878107315, 5858.47273745365, 5910.99513082777, 5976.760929562855, 6012.218411606551, 4590.839320623762, 4591.494935557086, 4605.9894771391, 4606.262997920317, 4620.699654522446, 4092.242935057024, 4100.405441211008, 4105.322621767435, 4110.547839737626, 4150.024744185114, 5721.199032135504, 5760.481556659837, 5768.134779782982, 5841.766329346779, 5846.41535846412, 5896.498797602252, 5924.081767326072, 5952.642841429441, 6003.969980150158, 6033.668148251888, 5787.189793428924, 5788.479036886701, 5807.0, 5809.68046757424, 5825.2135961644635, 5052.34319538465, 5053.343065401547, 5062.974685126551, 5105.795768169306, 5161.458046905021, 6218.378162183745, 6280.685965701697, 6282.748690052438, 6294.590851594632, 6297.905531416941, 5839.678817664899, 6019.42815432542, 6076.361981992004, 6077.939220607737, 6088.025915853442, 6132.049532322497, 6147.200863887666, 6171.691415429121, 6230.376962303733, 6264.21697287839, 5885.735141918538, 5892.440218179266, 5897.911531326948, 5932.822015339547, 5934.762609495572, 5864.618799778001, 5914.172015917689, 6017.518598512196, 6021.578489505692, 6029.065494848305, 5804.535637148933, 5860.765569377178, 5862.032764593794, 5889.646621202742, 5923.289205295392, 5812.912806307993, 5832.825015249549, 5863.853403664772, 5880.059190529495, 5882.352941176381, 5564.777408903598, 5745.683987380734, 5766.048601980794, 5779.479846813807, 5787.652740835395, 5907.9704601476715, 5918.585699001029, 5940.346561878277, 5977.1034344846885, 5981.790637327673, 5828.0966450200285, 5839.153322768259, 5841.8539536510225, 5847.94152058474, 5858.2677165354335], "value": 5542.579026867055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.4357875386514, 629.3611983836405, 649.0977541217711, 657.4378906035338, 664.282574819195, 46649.0670186596, 48348.51651483484, 48627.27059094117, 48823.26765098526, 51541.74229128858, 49405.25892111621, 49725.25412118821, 49976.50023499764, 50103.749481252635, 50148.0, 9196.356255062148, 9291.210247129002, 9327.347085704003, 9336.113069258443, 9350.719478415624, 9113.954430227872, 9242.722718318428, 9283.72148835536, 9292.0, 9293.488858112802, 9305.34862559621, 9307.95346023269, 9350.625974961027, 9352.672656457025, 9376.015518370576, 9177.128172823572, 9272.304577156707, 9277.35058545902, 9279.582418791137, 9327.953360233156, 9169.679061232891, 9196.172344488961, 9233.49215793131, 9252.491112988782, 9275.953620231923, 44740.3288950666, 45132.09735805298, 45144.09711805778, 45218.77390613026, 45328.3200751989, 3923.5487918889407, 3932.4691166692414, 3972.4239985201984, 4088.284550203732, 4370.191514569783, 33959.0, 34197.48703769445, 34860.47709284363, 35255.471167932505, 35923.10192245189, 4469.195544801934, 4472.5303843096335, 4481.193385190664, 4528.479224889114, 4605.194091034055, 374818.0, 385503.0, 391921.0, 393100.0, 538275.999999996, 68996.31003689898, 69390.0, 69682.30317696759, 69771.0, 69978.0, 39877.40183897244, 40698.796506017876, 40821.79589102035, 72290.27709722941, 72709.63645181741, 16741.07924064188, 16749.581260468585, 16811.075390853377, 16864.241109150116, 17004.234809433605, 12444.253344799341, 12521.874781252252, 12593.811092833615, 12604.117711760273, 12659.430325635369, 21313.25403610897, 21423.143074277166, 21532.56934861294, 21565.0, 21669.241576544744, 7356.01246105919, 7423.0, 7528.473006889575, 7567.772966811004, 7653.081630204411, 1082.2532452607675, 1086.3536195963388, 1129.9660810358594, 1152.3949926288765, 1174.1135442740676, 33125.0, 33267.66732332694, 33705.83147084249, 33746.66253337435, 33784.49323260153, 1168.5968340922368, 1168.649405178443, 1210.7154818617619, 1216.4647555075737, 1257.9371031448575, 17539.91230043867, 17823.46529604114, 17927.820721792876, 17941.282348705907, 18004.279828806964, 557362.0, 588990.0, 602219.0, 812040.0, 828674.0, 63336.68331658404, 63705.0, 64061.0, 64077.0, 64147.35852641414, 1423.7152569485936, 1435.6339133520885, 1436.899417040818, 1438.0652575825588, 1441.5603241011383, 32099.35801284008, 33123.83438082794, 33512.49731253985, 33780.831095845344, 33955.3208935815, 56517.0, 56926.43073569211, 56992.43007570037, 57005.0, 57204.0, 458804.0, 465953.0, 465960.0, 467418.0, 469804.0, 30909.845450772602, 30927.381452370377, 31540.842295788374, 31562.684373155975, 31674.841625791723, 52051.21923171231, 52195.246256314545, 52779.47220527745, 53070.0, 53440.73279633577, 42417.151656967304, 44355.0, 44542.77728611466, 44997.77501112474, 45317.54682453265, 43242.56757432385, 43456.782716086214, 43544.782276088416, 44606.3309050358, 44868.775656121514, 43923.34114988214, 44195.337069943336, 45322.77338613286, 45789.542104578526, 45921.31118033166, 36292.81853590715, 37633.2473350526, 37977.81011094927, 39187.6081239184, 39336.6066339333, 28739.856300718362, 29908.252293692833, 30221.848890755406, 30297.848510757307, 30356.84821575878], "value": 21651.32174513466, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.92471892699854, 416.5230810721724, 417.5052562713185, 421.6542435203133, 428.18217205138194, 18626.90686546567, 20061.99999999998, 20742.688859667116, 21279.57440851182, 21392.465188370297, 17330.0, 17474.737878931825, 17866.82133178668, 17931.372401965902, 17966.5508362291, 5666.0, 5682.0, 5873.207117039187, 5874.853128671774, 5876.265466816648, 5437.401885792559, 5564.360098588653, 5791.305043394798, 5794.39158888317, 5846.795362162326, 5746.7413966371405, 5812.651240925558, 5834.212381328509, 5850.853728656775, 6222.813315600517, 5898.675572843492, 6281.309056003882, 6306.905396419057, 6348.333424990379, 6369.681515924209, 5792.710364481801, 5818.0981947798155, 5829.5919285650025, 5852.853678658025, 5854.2389489366105, 14569.344379502947, 14868.925655371762, 21776.782232177633, 22843.31470055901, 22865.657015144785, 2357.7877990980724, 2372.0274687378264, 2513.7360577139502, 2615.790736741056, 2954.8495812063284, 10472.214583906161, 10500.054995050483, 10707.892921070768, 10941.726456838564, 10963.0, 1983.5239542509837, 1998.99000504998, 2026.625074361248, 2044.1516770540209, 2048.1295449433933, 81225.18774812235, 81978.18021819765, 82610.0, 84864.57567712184, 85810.57094714486, 11217.270877392943, 11524.423778811193, 11595.478203480694, 11632.651020469399, 11894.82157767634, 16306.347746090261, 16410.671786564442, 16474.588135296475, 16502.504924852274, 16550.586235343973, 8116.431849770577, 8221.54781487012, 8309.293710034593, 8364.958175209085, 8409.369297302726, 7819.335356494762, 7842.098158711821, 7843.37253019757, 7924.603769811486, 7984.281414672707, 4917.754112294371, 4967.155583550805, 5011.599072074226, 5079.1365467870555, 5154.30416893722, 1612.9354825806836, 1667.8498935095656, 1696.0, 1711.4951089428648, 1725.965480690379, 985.8028394321165, 1016.1718199667248, 1020.285799940045, 1025.4308858583408, 1029.0327092532996, 18907.243710251434, 19288.22847086101, 19300.517487062934, 19364.128614212113, 19909.0, 1011.8633984412011, 1025.610268098118, 1025.8922813104666, 1032.6643840751785, 1038.4081073787868, 10625.46872656364, 10866.293690910066, 10945.23383363157, 11116.55533778656, 11126.777464450828, 521223.0, 530353.0, 531140.0, 531832.0, 533934.3303283459, 94124.52937735405, 95384.52307738418, 98980.50509747406, 99149.50425247972, 100971.49514252528, 1053.7892421515728, 1067.1676092647747, 1111.4053981120062, 1121.8934201250868, 1130.9604163854226, 16983.405580804614, 17037.744433833253, 17320.740188897427, 17391.0, 17491.825081749528, 38623.0, 40949.0, 42291.57708422876, 42300.57699422966, 44292.33561496516, 53814.73092634512, 58008.70995645164, 59683.0, 61079.0, 61637.69181154066, 6706.362895524917, 8506.0, 8828.911710882809, 8865.778355541162, 9199.908000919904, 13180.736385272432, 13846.65383365424, 13920.303984800921, 13998.860011399756, 14071.929640351733, 11163.832542511705, 11651.76696466049, 11772.882271177179, 11934.045276377696, 11981.700457488632, 11894.940525297665, 11940.223885447418, 12020.519179232733, 12039.337836419081, 12223.0832687547, 11613.941930290295, 11719.945204931597, 11765.52937882475, 12357.382130893599, 12643.620691379274, 8907.599158037774, 8935.463872167691, 8985.056569060154, 9091.409058411182, 9203.355765096647, 8471.872921906053, 11465.770684586094, 11494.885051149717, 11520.193586448868, 11645.0], "value": 9390.583137145564, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1547.9071255724655, 1549.4034796603307, 1758.5515693498155, 1899.3637131560927, 1910.5032691500205, 8648.091950345202, 9309.069093090688, 9352.672656457025, 10038.29731918765, 10094.747631309221, 9709.563069661865, 9711.708648740532, 9758.804823903518, 9789.657361992331, 9826.21390288777, 2491.58888783351, 2534.3790771261065, 2539.9492010159784, 2542.7711505964458, 2543.4785868896925, 2406.626972819216, 2510.460251046025, 2524.583443731782, 2544.7836933860644, 2547.605121206216, 2483.987580062106, 2500.224930271622, 2551.2346296111186, 2553.3616595851036, 2554.6678931738847, 2312.433453803812, 2331.80179684727, 2336.906523739048, 2406.566817972764, 2412.7225369082603, 2417.782399584046, 2423.2730180945646, 2428.5264373447185, 2440.792532634728, 2469.086438017927, 9531.189848862856, 9623.470709110996, 9674.467904265262, 9708.708738737778, 9711.708648740549, 5305.15117581189, 5420.945790542083, 5436.429174936614, 5447.237386765856, 5463.863403414946, 3533.876314328986, 3631.237440137574, 3741.38267185914, 3748.6813620842263, 3776.9055773605605, 1246.738184981155, 1285.9935700321532, 1286.0676009892845, 2289.7710228977135, 2365.432296248905, 13388.464461421532, 13426.798598021038, 13450.865491345157, 13501.2574308413, 13557.389917453738, 4896.216605343128, 4907.607391408679, 5042.3444952156715, 5047.671901326402, 5049.6465247432325, 10548.841767373495, 10646.307989980627, 10700.090492308085, 10700.571977120984, 10715.249932504807, 5429.53848922846, 5430.484104010113, 5476.507114359727, 5492.340919089735, 5539.224508568804, 4552.704074235164, 4853.247746599282, 4906.58294045003, 4936.876578085505, 5013.523715247045, 4031.838726450968, 4079.755214687128, 4202.390653355246, 4203.600657937491, 4209.052963083282, 1271.1038717703996, 1291.6318849127954, 1302.4139137388213, 1302.5671761062756, 1311.2984553264148, 1049.569676432659, 1062.102523367753, 1062.7927554127025, 1068.5779117248644, 1072.651388298806, 6485.513586481033, 6645.66771661415, 6707.6981535831, 6714.664266786641, 6781.525293229525, 472.6974736168855, 473.03500858249475, 473.76075082083327, 474.2246427091661, 484.007784042711, 4597.747123908151, 4622.237330840374, 4656.208444564364, 4678.345031695565, 4692.061587682477, 11842.171048026728, 12067.637970860887, 12094.213876098025, 12180.451879665436, 12251.081168912368, 11506.424678766029, 11938.104642151873, 12005.459754310903, 12238.571649992207, 12386.62840114798, 8924.464532128093, 9000.23498002664, 9056.320775941831, 9066.818663626691, 9073.047330030251, 6711.597304161766, 6780.898286525805, 6926.411255043377, 7033.191183014019, 7051.647417628996, 11089.390083545482, 11306.94346528262, 11321.377324247245, 11450.969412752893, 11460.197786155222, 11453.713657158638, 11480.598179063692, 11527.365994870363, 11584.015358694605, 11586.88413115858, 8436.578171091298, 8581.914180858112, 8700.086490918615, 8702.912970870464, 8707.042225355333, 9108.863367049367, 9187.08129187076, 9248.537573121452, 9291.349605527548, 9306.348555601044, 8390.202930721573, 8413.957930210554, 8434.746957591282, 8446.915530844859, 8580.570971451527, 7985.321247694011, 8034.67861285542, 8052.355811535181, 8126.471779334324, 8140.308073813792, 7523.172451030273, 7593.810154746176, 7626.847463050597, 7640.770776876702, 7658.846823063619, 5583.162525621027, 5750.252467179407, 5800.45478118646, 5846.824595262149, 5908.025175845937, 5852.736626851887, 5866.208061911758, 5902.704864756831, 5916.0, 5997.730102145501], "value": 4983.52502169711, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.2889135055836, 355.68344173685415, 355.8078637535731, 364.03167574252495, 366.74511214705774, 5562.054450743373, 5614.326280846304, 5749.195112684228, 5812.1862939188495, 5813.389594092623, 5568.693721845297, 5577.581681373893, 5627.099664053752, 5641.379448260688, 5654.123610840326, 4393.604575588189, 4443.667074785731, 4465.4641443026885, 4490.124425736983, 4499.70751901127, 4171.833126674929, 4367.606915377615, 4398.802053907566, 4509.661775366861, 4514.104076287967, 4317.201317756225, 4339.978300108495, 4352.086061926999, 4367.2575662137515, 4388.780560971954, 4354.673399495035, 4377.4528183977, 4383.64930805538, 4384.99145196605, 4394.714343567658, 3767.9434808477895, 3825.464434979105, 3841.8463261469506, 3845.8846234613006, 3877.1470276539117, 5442.455754424565, 5447.319085114361, 5449.4005659377435, 5474.056709868019, 5476.890462190734, 4950.356453661037, 4977.352944117241, 5027.723475208862, 5033.421156567005, 5052.621053421009, 5741.598088133832, 5869.385918872302, 5887.646741195542, 5900.350961394243, 5901.527877769811, 4229.450171477688, 4266.360045993095, 4269.167512335096, 4278.42241297424, 4291.785410729451, 6191.925704888868, 6202.100695399187, 6202.224721909762, 6234.438900498977, 6268.310485846599, 4224.8732538023905, 4372.584604462571, 4385.7149285296355, 4398.494173170063, 4409.11817636474, 4450.221211288012, 4461.397711308931, 4461.442319710036, 4469.888252793706, 4494.516809452873, 5047.0, 5100.7959681613065, 5111.386633603991, 5113.821016264413, 5127.2052831811125, 5746.856328591735, 5833.533317334603, 5907.0, 6031.647657413612, 6091.38578276757, 1495.8952873298983, 1510.735621266274, 1515.9621009474631, 1524.207412145678, 1548.705745908274, 953.3803028031834, 960.2126256469628, 968.2399316536626, 969.9078587534173, 981.9934567068811, 5193.987172501402, 5200.959808038408, 5218.478152184751, 5240.895182096413, 5322.004248406847, 5403.0, 5481.890362192734, 5490.56075513958, 5593.972030139905, 5595.048841696921, 4879.707217566957, 5194.6234947284565, 5211.244369566468, 5280.653433374465, 5298.09932311508, 2896.942061158807, 2931.6188895443884, 2952.291450052015, 2959.926001849928, 2960.7779416543412, 5607.467290607386, 5664.291963504562, 5742.54059675225, 5755.453231942959, 5763.308402991668, 5909.23179986599, 6332.461740751995, 6353.936460635335, 6376.649284289409, 6386.872262554816, 6461.449252179537, 6477.805665830033, 6494.935050649433, 6512.902306465407, 6516.576422532615, 5990.921634105903, 6211.894052973514, 6241.563090583797, 6246.875062498633, 6277.497800175884, 6148.077788331786, 6181.258249010148, 6200.131981522681, 6201.906971395342, 6214.564980451506, 6113.358097399887, 6446.419822216023, 6514.837129071811, 6558.8360290993105, 6563.835904102436, 4347.500037495602, 4367.868963931087, 4376.0, 4384.298512238154, 4392.450943632046, 5924.9703751480965, 6046.818595442144, 6183.288921773874, 6226.1905952227735, 6243.219597550306, 6015.4586087252355, 6026.849328766816, 6040.0939859019745, 6052.334243233153, 6054.273487181566, 5984.665980267786, 5987.2815262168815, 5997.430244126801, 6037.00778743005, 6057.969710151598, 5617.129344951539, 5914.905742437662, 5936.3470018297085, 5949.613275137102, 5962.9105563415715, 6017.849553761191, 6024.698765061642, 6032.939670603413, 6040.939590604214, 6046.848828779316, 5635.971820140873, 5873.765049398147, 5902.5277977762535, 5952.315483719428, 5976.8804623908145], "value": 4492.351735080866, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.0383280481411, 789.7235967411403, 793.0047790023519, 808.644126873475, 822.9506229626222, 14377.281135943213, 14410.207438590873, 14684.853151468482, 16159.515214543568, 16377.672446551062, 15907.522774316789, 16202.189890505486, 16204.108774017424, 16245.431409900655, 16285.267162977665, 707.465863273228, 828.6436832162168, 846.2214762418558, 851.0680804519072, 852.8209076093997, 847.0470720439506, 852.3990586636406, 857.2413414128509, 858.1289990659454, 859.3554833874595, 894.6421431427449, 900.918917297443, 902.0979020979021, 903.3947255338906, 904.4934836491553, 889.5152142082613, 892.7411050795262, 898.1781669772216, 898.5058217980118, 899.9910000900005, 657.2343220148568, 659.7789740436959, 659.9736010559571, 660.2044536333755, 660.2934859700075, 14090.506832260822, 14094.718105637932, 14202.50291239812, 14257.287135643177, 14257.857421425757, 14212.218327991955, 14228.786568201382, 14235.644108897257, 14311.141331520143, 16508.25712842925, 14421.711565768626, 14552.563423097325, 14607.415703371853, 14691.118532887955, 14896.776548351783, 4766.38037055184, 4770.212914869077, 4774.594159496447, 4802.927956080662, 4824.710517368969, 79744.0, 80683.5965820173, 80824.99999999942, 80968.0, 81341.59329203375, 11749.88250117505, 12071.3360765157, 12079.09406794494, 12248.38758062111, 12300.261984280973, 21670.674939875913, 21697.240596579042, 21721.0, 21756.129754809946, 21862.562748744935, 9046.0, 9092.818143637223, 9150.0, 9248.953755231181, 9389.01415351392, 4927.77824997876, 4962.801487940442, 4966.850994470099, 5013.799448022039, 5126.846194614168, 3895.7857317847224, 4032.9395059074136, 4039.3940908863906, 4060.7766572838777, 4068.389741538793, 672.8217022489044, 706.8621618784288, 743.9888401673871, 757.7991832164481, 763.8243204063097, 634.5875181132301, 751.1849643137257, 795.9323457506061, 800.6637212370819, 804.8792681097882, 10589.894101059044, 11055.557777688964, 11163.330200188015, 11391.658250252505, 11397.0, 750.8535835512023, 770.2297702297702, 773.4663082473076, 820.9466384684977, 830.2942498876027, 5190.792368305301, 5331.920021199685, 5332.173513105475, 5418.322709661293, 5435.266239057677, 77238.6138069306, 77383.22616773873, 124108.0, 124546.0, 129385.0, 101072.0, 102126.0, 103636.0, 105418.47290763498, 108162.0, 96555.51722241484, 96839.51580242053, 97774.0, 98339.0, 100070.49964750276, 10205.591776328863, 10234.33476824004, 10236.692899213036, 10382.688519344432, 10383.117435018108, 57258.71370643287, 57390.0, 57728.0, 58923.41076589179, 59320.999999998276, 76860.0, 77733.0, 85215.0, 86044.0, 86086.56956715176, 13501.932490337485, 13556.11885227457, 13563.38964746569, 13569.457221711022, 13843.515476958259, 13251.469941202244, 13347.799783003069, 13542.05205635596, 13567.321633918462, 13718.314084295545, 14087.718245635235, 14102.435902564193, 14137.222452765196, 14287.928560357132, 14794.0, 13839.723205536035, 14018.509352172625, 14179.574612761633, 14267.286635668383, 14369.712605748036, 13572.93213533926, 13919.721605567629, 13956.0, 13966.231857247543, 14016.369263382969, 10359.533820977924, 10638.787224255317, 10668.519916603927, 10712.0, 11100.61147859821, 11456.885431145582, 11627.47676354583, 11956.461959211681, 12373.505059797508, 12626.810597841224], "value": 8038.658377798774, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 109.0, 110.0, 112.0, 111.0, 110.0, 109.0, 111.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 158.0, 175.0, 126.0, 154.0, 156.0, 128.0, 191.0, 127.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 162.0, 162.0, 169.0, 163.0, 164.0, 163.0, 164.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 186.0, 76.0, 76.0, 75.0, 75.0, 177.0, 76.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 148.0, 85.0, 84.0, 85.0, 144.0, 84.0, 86.0, 142.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 119.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 149.0, 147.0, 149.0, 147.0, 147.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 96.0, 98.0, 96.0, 95.0, 96.0, 96.0, 95.0, 100.0, 95.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 54.0, 52.0, 53.0, 53.0, 52.0, 52.0, 54.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 59.0, 59.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 85.0, 75.0, 78.0, 79.0, 76.0, 106.0, 77.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 117.0, 118.0, 118.0, 118.0, 119.0, 131.0, 140.0, 130.0, 128.0], "value": 124.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 155.0, 153.0, 154.0, 150.0, 156.0, 152.0, 152.0, 158.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 59.0], "value": 62.0, "unit": "score"}]}]} 23:43:11 INFO - Return code: 0 23:43:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:43:11 ERROR - # TBPL SUCCESS # 23:43:11 INFO - Running post-action listener: _resource_record_post_action 23:43:11 INFO - ##### 23:43:11 INFO - ##### Finished run-tests step (success) 23:43:11 INFO - ##### 23:43:11 INFO - Running post-run listener: _resource_record_post_run 23:43:11 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 508035072; Read time: 32; Write time: 505244 23:43:11 INFO - TinderboxPrint: CPU usage
13.4% 23:43:11 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 23:43:11 INFO - TinderboxPrint: I/O write bytes / time
508,035,072 / 505,244 23:43:11 INFO - TinderboxPrint: CPU idle
8,216.3 (86.6%) 23:43:11 INFO - TinderboxPrint: CPU user
1,213.5 (12.8%) 23:43:11 INFO - TinderboxPrint: Swap in / out
0 / 0 23:43:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 258871296; Read time: 0; Write time: 312944 23:43:11 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 246624256; Read time: 32; Write time: 192108 23:43:12 INFO - Running post-run listener: _upload_blobber_files 23:43:12 INFO - Blob upload gear active. 23:43:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:43:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:43:12 INFO - (blobuploader) - INFO - Open directory for files ... 23:43:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:43:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:13 INFO - (blobuploader) - INFO - Done attempting. 23:43:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:43:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:43:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:15 INFO - (blobuploader) - INFO - Done attempting. 23:43:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:43:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:43:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:19 INFO - (blobuploader) - INFO - Done attempting. 23:43:19 INFO - (blobuploader) - INFO - Iteration through files over. 23:43:19 INFO - Return code: 0 23:43:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:43:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:43:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abe3ea12e4a0d56dffff28c2e47c7b07fa1e74c6429535aa57ada08c9c1c3da35893aeb6c12e1a0a3bed224982f27321b9ceb1f4b69b3a8235a4f80c5b94efff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20970feced232ea9e0d73782eb49459442fbc7e3bc414caa2d5bd18cbea325a20eaa2dcfe6f70a7d26f43f002c4eeebf5547d5a1bbb8a4cd9683055423969eac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c17b2d56c1d63f6ae8b03d5cc73a0a15968a7eda2c0676c4d2ed4108156ab3fd0a7691610100431a92b501e7e9fa2dccc5a08df1714f1879845fbbfd91b156a"} 23:43:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:43:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:43:19 INFO - Contents: 23:43:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abe3ea12e4a0d56dffff28c2e47c7b07fa1e74c6429535aa57ada08c9c1c3da35893aeb6c12e1a0a3bed224982f27321b9ceb1f4b69b3a8235a4f80c5b94efff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20970feced232ea9e0d73782eb49459442fbc7e3bc414caa2d5bd18cbea325a20eaa2dcfe6f70a7d26f43f002c4eeebf5547d5a1bbb8a4cd9683055423969eac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c17b2d56c1d63f6ae8b03d5cc73a0a15968a7eda2c0676c4d2ed4108156ab3fd0a7691610100431a92b501e7e9fa2dccc5a08df1714f1879845fbbfd91b156a"} 23:43:19 INFO - Running post-run listener: copy_logs_to_upload_dir 23:43:19 INFO - Copying logs to upload dir... 23:43:19 INFO - mkdir: /builds/slave/test/build/upload/logs 23:43:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.596952 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-13 23:43:19.085024) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:19.088976) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abe3ea12e4a0d56dffff28c2e47c7b07fa1e74c6429535aa57ada08c9c1c3da35893aeb6c12e1a0a3bed224982f27321b9ceb1f4b69b3a8235a4f80c5b94efff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20970feced232ea9e0d73782eb49459442fbc7e3bc414caa2d5bd18cbea325a20eaa2dcfe6f70a7d26f43f002c4eeebf5547d5a1bbb8a4cd9683055423969eac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c17b2d56c1d63f6ae8b03d5cc73a0a15968a7eda2c0676c4d2ed4108156ab3fd0a7691610100431a92b501e7e9fa2dccc5a08df1714f1879845fbbfd91b156a"} build_url:https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abe3ea12e4a0d56dffff28c2e47c7b07fa1e74c6429535aa57ada08c9c1c3da35893aeb6c12e1a0a3bed224982f27321b9ceb1f4b69b3a8235a4f80c5b94efff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20970feced232ea9e0d73782eb49459442fbc7e3bc414caa2d5bd18cbea325a20eaa2dcfe6f70a7d26f43f002c4eeebf5547d5a1bbb8a4cd9683055423969eac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c17b2d56c1d63f6ae8b03d5cc73a0a15968a7eda2c0676c4d2ed4108156ab3fd0a7691610100431a92b501e7e9fa2dccc5a08df1714f1879845fbbfd91b156a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:19.114672) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:19.115049) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468477366.132220-1649769868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004372 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:19.197600) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:43:19.197943) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:43:19.198296) ========= ========= Total master_lag: 0.17 =========