builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1465508888.97 results: success (0) buildid: 20160609124436 builduid: d65f4cb840b34b3c9d6edf43a31ec54b revision: f8bdceb55c9d191380176ab25e2385737bd9e1ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 14:48:08.966551) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 14:48:08.967314) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 14:48:08.967767) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 14:48:08.990420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:48:08.990816) ========= 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=32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 14:48:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|: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-06-09 14:48:09 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127356 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:48:09.132089) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:48:09.132417) ========= 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=32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018612 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:48:09.184410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:48:09.184761) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f8bdceb55c9d191380176ab25e2385737bd9e1ab --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev f8bdceb55c9d191380176ab25e2385737bd9e1ab --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=32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 14:48:09,561 truncating revision to first 12 chars 2016-06-09 14:48:09,561 Setting DEBUG logging. 2016-06-09 14:48:09,561 attempt 1/10 2016-06-09 14:48:09,561 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f8bdceb55c9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 14:48:09,870 unpacking tar archive at: autoland-f8bdceb55c9d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656850 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:48:09.855125) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 14:48:09.855458) ========= script_repo_revision: f8bdceb55c9d191380176ab25e2385737bd9e1ab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 14:48:09.855830) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 14:48:09.856096) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 14:48:09.866800) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-09 14:48:09.867065) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:48:10 INFO - MultiFileLogger online at 20160609 14:48:10 in /builds/slave/test 14:48:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 14:48:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:48:10 INFO - {'append_to_log': False, 14:48:10 INFO - 'base_work_dir': '/builds/slave/test', 14:48:10 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 14:48:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:48:10 INFO - 'branch': 'Autoland-Non-PGO', 14:48:10 INFO - 'buildbot_json_path': 'buildprops.json', 14:48:10 INFO - 'config_files': ('talos/linux_config.py',), 14:48:10 INFO - 'default_actions': ('clobber', 14:48:10 INFO - 'read-buildbot-config', 14:48:10 INFO - 'download-and-extract', 14:48:10 INFO - 'populate-webroot', 14:48:10 INFO - 'create-virtualenv', 14:48:10 INFO - 'install', 14:48:10 INFO - 'run-tests'), 14:48:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:48:10 INFO - 'download_minidump_stackwalk': True, 14:48:10 INFO - 'download_symbols': 'ondemand', 14:48:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:48:10 INFO - 'tooltool.py': '/tools/tooltool.py', 14:48:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:48:10 INFO - '/tools/misc-python/virtualenv.py')}, 14:48:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:48:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:48:10 INFO - 'installer_path': 'installer.exe', 14:48:10 INFO - 'log_level': 'info', 14:48:10 INFO - 'log_name': 'talos', 14:48:10 INFO - 'log_to_console': True, 14:48:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:48:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:48:10 INFO - 'opt_config_files': (), 14:48:10 INFO - 'pip_index': False, 14:48:10 INFO - 'sps_profile': False, 14:48:10 INFO - 'sps_profile_interval': 0, 14:48:10 INFO - 'suite': 'dromaeojs-e10s', 14:48:10 INFO - 'system_bits': '32', 14:48:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:48:10 INFO - 'title': 'talos-linux64-ix-008', 14:48:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:48:10 INFO - 'use_talos_json': True, 14:48:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:48:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:48:10 INFO - 'work_dir': 'build'} 14:48:10 INFO - ##### 14:48:10 INFO - ##### Running clobber step. 14:48:10 INFO - ##### 14:48:10 INFO - Running pre-action listener: _resource_record_pre_action 14:48:10 INFO - Running main action method: clobber 14:48:10 INFO - rmtree: /builds/slave/test/build 14:48:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:48:11 INFO - Running post-action listener: _resource_record_post_action 14:48:11 INFO - ##### 14:48:11 INFO - ##### Finished clobber step (success) 14:48:11 INFO - ##### 14:48:11 INFO - ##### 14:48:11 INFO - ##### Running read-buildbot-config step. 14:48:11 INFO - ##### 14:48:11 INFO - Running pre-action listener: _resource_record_pre_action 14:48:11 INFO - Running main action method: read_buildbot_config 14:48:11 INFO - Using buildbot properties: 14:48:11 INFO - { 14:48:11 INFO - "project": "", 14:48:11 INFO - "product": "firefox", 14:48:11 INFO - "script_repo_revision": "production", 14:48:11 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 14:48:11 INFO - "repository": "", 14:48:11 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 14:48:11 INFO - "buildid": "20160609124436", 14:48:11 INFO - "pgo_build": "False", 14:48:11 INFO - "basedir": "/builds/slave/test", 14:48:11 INFO - "buildnumber": 4, 14:48:11 INFO - "slavename": "talos-linux64-ix-008", 14:48:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:48:11 INFO - "platform": "ubuntu64_hw", 14:48:11 INFO - "scheduler": "tests-autoland-linux64-talos", 14:48:11 INFO - "branch": "autoland", 14:48:11 INFO - "repo_path": "integration/autoland", 14:48:11 INFO - "revision": "f8bdceb55c9d191380176ab25e2385737bd9e1ab", 14:48:11 INFO - "stage_platform": "linux64", 14:48:11 INFO - "builduid": "d65f4cb840b34b3c9d6edf43a31ec54b", 14:48:11 INFO - "slavebuilddir": "test" 14:48:11 INFO - } 14:48:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:48:11 INFO - Running post-action listener: _resource_record_post_action 14:48:11 INFO - ##### 14:48:11 INFO - ##### Finished read-buildbot-config step (success) 14:48:11 INFO - ##### 14:48:11 INFO - ##### 14:48:11 INFO - ##### Running download-and-extract step. 14:48:11 INFO - ##### 14:48:11 INFO - Running pre-action listener: _resource_record_pre_action 14:48:11 INFO - Running main action method: download_and_extract 14:48:11 INFO - mkdir: /builds/slave/test/build/tests 14:48: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')]} 14:48:11 INFO - https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:48:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:48:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:48:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:48:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:48:12 INFO - Downloaded 1361 bytes. 14:48:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:48:12 INFO - Using the following test package requirements: 14:48:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:48:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:48:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:48:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:12 INFO - u'jsshell-linux-x86_64.zip'], 14:48:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:48:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:48:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:48:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:48:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:48:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:48:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:48:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:48:12 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')]} 14:48:12 INFO - https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:48:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:48:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:48:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:48:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:48:13 INFO - Downloaded 22879070 bytes. 14:48:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:48:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:48:14 INFO - Return code: 0 14:48:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:14 INFO - https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:48:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:48:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:48:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:48:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:48:15 INFO - Downloaded 22879070 bytes. 14:48:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:48:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:48:16 INFO - Return code: 0 14:48:16 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')]} 14:48:16 INFO - https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:48:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:48:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:48:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:48:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:48:17 INFO - Downloaded 10833369 bytes. 14:48:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:48:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:48:18 INFO - Return code: 0 14:48: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')]} 14:48:18 INFO - https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:48:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:48:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:48:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:48:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:48:19 INFO - Downloaded 55335849 bytes. 14:48:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:48:19 INFO - mkdir: /builds/slave/test/properties 14:48:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:48:19 INFO - Writing to file /builds/slave/test/properties/build_url 14:48:19 INFO - Contents: 14:48:19 INFO - build_url:https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:48:20 INFO - Running post-action listener: _resource_record_post_action 14:48:20 INFO - Running post-action listener: set_extra_try_arguments 14:48:20 INFO - ##### 14:48:20 INFO - ##### Finished download-and-extract step (success) 14:48:20 INFO - ##### 14:48:20 INFO - ##### 14:48:20 INFO - ##### Running populate-webroot step. 14:48:20 INFO - ##### 14:48:20 INFO - Running pre-action listener: _resource_record_pre_action 14:48:20 INFO - Running main action method: populate_webroot 14:48:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:48:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:48:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:48:20 INFO - '--tppagecycles', 14:48:20 INFO - '7'], 14:48:20 INFO - 'tests': ['tsvgm']}}, 14:48:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:48:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:48:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:48:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:48:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:48:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:48:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:20 INFO - 'talos_options': ['--disable-e10s'], 14:48:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:48:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:48:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:20 INFO - 'talos_options': ['--disable-e10s'], 14:48:20 INFO - 'tests': ['damp', 'tps']}, 14:48:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:20 INFO - 'tests': ['damp', 'tps']}, 14:48:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:48:20 INFO - 'tests': ['dromaeo_dom']}, 14:48:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:48:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:48:20 INFO - 'tests': ['a11yr', 14:48:20 INFO - 'ts_paint', 14:48:20 INFO - 'tpaint', 14:48:20 INFO - 'sessionrestore', 14:48:20 INFO - 'sessionrestore_no_auto_restore', 14:48:20 INFO - 'tabpaint']}, 14:48:20 INFO - 'other-e10s': {'tests': ['a11yr', 14:48:20 INFO - 'ts_paint', 14:48:20 INFO - 'tpaint', 14:48:20 INFO - 'sessionrestore', 14:48:20 INFO - 'sessionrestore_no_auto_restore', 14:48:20 INFO - 'tabpaint']}, 14:48:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:48:20 INFO - 'ts_paint', 14:48:20 INFO - 'tpaint', 14:48:20 INFO - 'sessionrestore', 14:48:20 INFO - 'sessionrestore_no_auto_restore', 14:48:20 INFO - 'tabpaint']}, 14:48:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:48:20 INFO - 'ts_paint', 14:48:20 INFO - 'tpaint', 14:48:20 INFO - 'sessionrestore', 14:48:20 INFO - 'sessionrestore_no_auto_restore', 14:48:20 INFO - 'tabpaint']}, 14:48:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:48:20 INFO - 'tests': ['a11yr', 14:48:20 INFO - 'ts_paint', 14:48:20 INFO - 'tpaint', 14:48:20 INFO - 'sessionrestore', 14:48:20 INFO - 'sessionrestore_no_auto_restore', 14:48:20 INFO - 'tabpaint']}, 14:48:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:48:20 INFO - 'tests': ['a11yr', 14:48:20 INFO - 'ts_paint', 14:48:20 INFO - 'tpaint', 14:48:20 INFO - 'sessionrestore', 14:48:20 INFO - 'sessionrestore_no_auto_restore', 14:48:20 INFO - 'tabpaint']}, 14:48:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:48:20 INFO - 'tests': ['tsvgx', 14:48:20 INFO - 'tsvgr_opacity', 14:48:20 INFO - 'tart', 14:48:20 INFO - 'tscrollx', 14:48:20 INFO - 'cart']}, 14:48:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:48:20 INFO - 'tsvgr_opacity', 14:48:20 INFO - 'tart', 14:48:20 INFO - 'tscrollx', 14:48:20 INFO - 'cart']}, 14:48:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:20 INFO - 'talos_options': ['--disable-e10s'], 14:48:20 INFO - 'tests': ['tp5o']}, 14:48:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:20 INFO - 'tests': ['tp5o']}, 14:48:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:20 INFO - 'talos_options': ['--disable-e10s', 14:48:20 INFO - '--xperf_path', 14:48:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:48:20 INFO - 'tests': ['tp5n']}, 14:48:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:20 INFO - 'talos_options': ['--xperf_path', 14:48:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:48:20 INFO - 'tests': ['tp5n']}}, 14:48:20 INFO - 'talos.zip': {'path': '', 14:48:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:48:20 INFO - Running post-action listener: _resource_record_post_action 14:48:20 INFO - ##### 14:48:20 INFO - ##### Finished populate-webroot step (success) 14:48:20 INFO - ##### 14:48:20 INFO - ##### 14:48:20 INFO - ##### Running create-virtualenv step. 14:48:20 INFO - ##### 14:48:20 INFO - Running pre-action listener: _resource_record_pre_action 14:48:20 INFO - Running main action method: create_virtualenv 14:48:20 INFO - Creating virtualenv /builds/slave/test/build/venv 14:48:20 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 14:48:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:48:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:48:20 INFO - Using real prefix '/usr' 14:48:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:48:21 INFO - Installing distribute.............................................................................................................................................................................................done. 14:48:23 INFO - Installing pip.................done. 14:48:23 INFO - Return code: 0 14:48:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:23 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 0x7f60cd292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28da020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c2e0>, '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 0x28d8140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d85d0>, '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': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', '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 14:48:23 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 14:48:23 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 14:48:23 INFO - Using env: {'DISPLAY': ':0', 14:48:23 INFO - 'HOME': '/home/cltbld', 14:48:23 INFO - 'LANG': 'en_US.UTF-8', 14:48:23 INFO - 'LANGUAGE': 'en_US:en', 14:48:23 INFO - 'LOGNAME': 'cltbld', 14:48:23 INFO - 'MAIL': '/var/mail/cltbld', 14:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:23 INFO - 'MOZ_NO_REMOTE': '1', 14:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:23 INFO - 'NO_EM_RESTART': '1', 14:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:23 INFO - 'PWD': '/builds/slave/test', 14:48:23 INFO - 'SHELL': '/bin/bash', 14:48:23 INFO - 'SHLVL': '1', 14:48:23 INFO - 'TERM': 'linux', 14:48:23 INFO - 'TMOUT': '86400', 14:48:23 INFO - 'USER': 'cltbld', 14:48:23 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', 14:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:23 INFO - '_': '/tools/buildbot/bin/python'} 14:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:23 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 14:48:23 INFO - Cleaning up... 14:48:23 INFO - Return code: 0 14:48:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:23 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 0x7f60cd292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28da020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c2e0>, '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 0x28d8140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d85d0>, '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': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', '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 14:48:23 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 14:48:23 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 14:48:23 INFO - Using env: {'DISPLAY': ':0', 14:48:23 INFO - 'HOME': '/home/cltbld', 14:48:23 INFO - 'LANG': 'en_US.UTF-8', 14:48:23 INFO - 'LANGUAGE': 'en_US:en', 14:48:23 INFO - 'LOGNAME': 'cltbld', 14:48:23 INFO - 'MAIL': '/var/mail/cltbld', 14:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:23 INFO - 'MOZ_NO_REMOTE': '1', 14:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:23 INFO - 'NO_EM_RESTART': '1', 14:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:23 INFO - 'PWD': '/builds/slave/test', 14:48:23 INFO - 'SHELL': '/bin/bash', 14:48:23 INFO - 'SHLVL': '1', 14:48:23 INFO - 'TERM': 'linux', 14:48:23 INFO - 'TMOUT': '86400', 14:48:23 INFO - 'USER': 'cltbld', 14:48:23 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', 14:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:23 INFO - '_': '/tools/buildbot/bin/python'} 14:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:23 INFO - Downloading/unpacking psutil>=3.1.1 14:48:23 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 14:48:23 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 14:48:23 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 14:48:23 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 14:48:23 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 14:48:23 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 14:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:48:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:25 INFO - Installing collected packages: psutil 14:48:25 INFO - Running setup.py install for psutil 14:48:25 INFO - building 'psutil._psutil_linux' extension 14:48:25 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 14:48:26 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 14:48:26 INFO - building 'psutil._psutil_posix' extension 14:48:26 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 14:48:26 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 14:48:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:26 INFO - Successfully installed psutil 14:48:26 INFO - Cleaning up... 14:48:26 INFO - Return code: 0 14:48:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:26 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 0x7f60cd292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28da020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c2e0>, '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 0x28d8140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d85d0>, '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': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', '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 14:48:26 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 14:48:26 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 14:48:26 INFO - Using env: {'DISPLAY': ':0', 14:48:26 INFO - 'HOME': '/home/cltbld', 14:48:26 INFO - 'LANG': 'en_US.UTF-8', 14:48:26 INFO - 'LANGUAGE': 'en_US:en', 14:48:26 INFO - 'LOGNAME': 'cltbld', 14:48:26 INFO - 'MAIL': '/var/mail/cltbld', 14:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:26 INFO - 'MOZ_NO_REMOTE': '1', 14:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:26 INFO - 'NO_EM_RESTART': '1', 14:48:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:26 INFO - 'PWD': '/builds/slave/test', 14:48:26 INFO - 'SHELL': '/bin/bash', 14:48:26 INFO - 'SHLVL': '1', 14:48:26 INFO - 'TERM': 'linux', 14:48:26 INFO - 'TMOUT': '86400', 14:48:26 INFO - 'USER': 'cltbld', 14:48:26 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', 14:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:26 INFO - '_': '/tools/buildbot/bin/python'} 14:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:48:26 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 14:48:26 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 14:48:26 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 14:48:26 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 14:48:26 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 14:48:26 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 14:48:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:48:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:48:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:48:28 INFO - Installing collected packages: mozsystemmonitor 14:48:28 INFO - Running setup.py install for mozsystemmonitor 14:48:28 INFO - Successfully installed mozsystemmonitor 14:48:28 INFO - Cleaning up... 14:48:28 INFO - Return code: 0 14:48:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:48:28 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')]} 14:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:28 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')]} 14:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:28 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 0x7f60cd292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28da020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c2e0>, '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 0x28d8140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d85d0>, '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': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', '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 14:48:28 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 14:48:28 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 14:48:28 INFO - Using env: {'DISPLAY': ':0', 14:48:28 INFO - 'HOME': '/home/cltbld', 14:48:28 INFO - 'LANG': 'en_US.UTF-8', 14:48:28 INFO - 'LANGUAGE': 'en_US:en', 14:48:28 INFO - 'LOGNAME': 'cltbld', 14:48:28 INFO - 'MAIL': '/var/mail/cltbld', 14:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:28 INFO - 'MOZ_NO_REMOTE': '1', 14:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:28 INFO - 'NO_EM_RESTART': '1', 14:48:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:28 INFO - 'PWD': '/builds/slave/test', 14:48:28 INFO - 'SHELL': '/bin/bash', 14:48:28 INFO - 'SHLVL': '1', 14:48:28 INFO - 'TERM': 'linux', 14:48:28 INFO - 'TMOUT': '86400', 14:48:28 INFO - 'USER': 'cltbld', 14:48:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', 14:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:28 INFO - '_': '/tools/buildbot/bin/python'} 14:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:28 INFO - Downloading/unpacking jsonschema==2.5.1 14:48:28 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 14:48:28 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 14:48:28 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 14:48:28 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 14:48:28 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 14:48:28 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 14:48:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:48:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:48:30 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 14:48:30 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 14:48:30 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 14:48:30 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 14:48:30 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 14:48:30 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 14:48:30 INFO - Downloading functools32-3.2.3-2.tar.gz 14:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:48:30 INFO - warning: no files found matching '*.txt' 14:48:30 INFO - no previously-included directories found matching 'build' 14:48:30 INFO - no previously-included directories found matching 'dist' 14:48:30 INFO - no previously-included directories found matching '.git*' 14:48:30 INFO - Installing collected packages: jsonschema, functools32 14:48:31 INFO - Running setup.py install for functools32 14:48:31 INFO - warning: no files found matching '*.txt' 14:48:31 INFO - no previously-included directories found matching 'build' 14:48:31 INFO - no previously-included directories found matching 'dist' 14:48:31 INFO - no previously-included directories found matching '.git*' 14:48:31 INFO - Successfully installed jsonschema functools32 14:48:31 INFO - Cleaning up... 14:48:31 INFO - Return code: 0 14:48:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:48:31 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')]} 14:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:31 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')]} 14:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:31 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 0x7f60cd292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28da020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c2e0>, '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 0x28d8140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d85d0>, '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': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', '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 14:48:31 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 14:48:31 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 14:48:31 INFO - Using env: {'DISPLAY': ':0', 14:48:31 INFO - 'HOME': '/home/cltbld', 14:48:31 INFO - 'LANG': 'en_US.UTF-8', 14:48:31 INFO - 'LANGUAGE': 'en_US:en', 14:48:31 INFO - 'LOGNAME': 'cltbld', 14:48:31 INFO - 'MAIL': '/var/mail/cltbld', 14:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:31 INFO - 'MOZ_NO_REMOTE': '1', 14:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:31 INFO - 'NO_EM_RESTART': '1', 14:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:31 INFO - 'PWD': '/builds/slave/test', 14:48:31 INFO - 'SHELL': '/bin/bash', 14:48:31 INFO - 'SHLVL': '1', 14:48:31 INFO - 'TERM': 'linux', 14:48:31 INFO - 'TMOUT': '86400', 14:48:31 INFO - 'USER': 'cltbld', 14:48:31 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', 14:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:31 INFO - '_': '/tools/buildbot/bin/python'} 14:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:31 INFO - Downloading/unpacking blobuploader==1.2.4 14:48:31 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 14:48:31 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 14:48:31 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 14:48:31 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 14:48:31 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 14:48:31 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 14:48:33 INFO - Downloading blobuploader-1.2.4.tar.gz 14:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:48:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:48:33 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 14:48:33 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 14:48:33 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 14:48:33 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 14:48:33 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 14:48:33 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 14:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:48:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:48:33 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 14:48:33 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 14:48:33 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 14:48:33 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 14:48:33 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 14:48:33 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 14:48:33 INFO - Downloading docopt-0.6.1.tar.gz 14:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:48:34 INFO - Installing collected packages: blobuploader, requests, docopt 14:48:34 INFO - Running setup.py install for blobuploader 14:48:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:48:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:48:34 INFO - Running setup.py install for requests 14:48:34 INFO - Running setup.py install for docopt 14:48:34 INFO - Successfully installed blobuploader requests docopt 14:48:34 INFO - Cleaning up... 14:48:34 INFO - Return code: 0 14:48:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:34 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 0x7f60cd292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28da020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c2e0>, '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 0x28d8140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d85d0>, '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': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', '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 14:48:34 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 14:48:34 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 14:48:34 INFO - Using env: {'DISPLAY': ':0', 14:48:34 INFO - 'HOME': '/home/cltbld', 14:48:34 INFO - 'LANG': 'en_US.UTF-8', 14:48:34 INFO - 'LANGUAGE': 'en_US:en', 14:48:34 INFO - 'LOGNAME': 'cltbld', 14:48:34 INFO - 'MAIL': '/var/mail/cltbld', 14:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:34 INFO - 'MOZ_NO_REMOTE': '1', 14:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:34 INFO - 'NO_EM_RESTART': '1', 14:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:34 INFO - 'PWD': '/builds/slave/test', 14:48:34 INFO - 'SHELL': '/bin/bash', 14:48:34 INFO - 'SHLVL': '1', 14:48:34 INFO - 'TERM': 'linux', 14:48:34 INFO - 'TMOUT': '86400', 14:48:34 INFO - 'USER': 'cltbld', 14:48:34 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', 14:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:34 INFO - '_': '/tools/buildbot/bin/python'} 14:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:48:34 INFO - Running setup.py (path:/tmp/pip-0JDexK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:48:34 INFO - Running setup.py (path:/tmp/pip-nQMOP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:48:35 INFO - Running setup.py (path:/tmp/pip-wyLfb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:48:35 INFO - Running setup.py (path:/tmp/pip-NbQ66E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:48:35 INFO - Running setup.py (path:/tmp/pip-aDNNjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:48:35 INFO - Running setup.py (path:/tmp/pip-RdaHjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:48:35 INFO - Running setup.py (path:/tmp/pip-A1YeMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:48:35 INFO - Running setup.py (path:/tmp/pip-T75tC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:48:35 INFO - Running setup.py (path:/tmp/pip-HukxMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:48:35 INFO - Running setup.py (path:/tmp/pip-8740oS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:48:35 INFO - Running setup.py (path:/tmp/pip-eGlIZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:48:35 INFO - Running setup.py (path:/tmp/pip-e1tktS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:48:35 INFO - Running setup.py (path:/tmp/pip-YGgoHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:48:35 INFO - Running setup.py (path:/tmp/pip-a0TWGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:35 INFO - Running setup.py (path:/tmp/pip-vnKAIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:48:35 INFO - Running setup.py (path:/tmp/pip-2rfiW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:48:36 INFO - Running setup.py (path:/tmp/pip-tzoB7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:48:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:48:36 INFO - Running setup.py install for manifestparser 14:48:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:48:36 INFO - Running setup.py install for mozcrash 14:48:36 INFO - Running setup.py install for mozdebug 14:48:36 INFO - Running setup.py install for mozdevice 14:48:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:48:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:48:36 INFO - Running setup.py install for mozfile 14:48:36 INFO - Running setup.py install for mozhttpd 14:48:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:48:36 INFO - Running setup.py install for mozinfo 14:48:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:48:36 INFO - Running setup.py install for mozInstall 14:48:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:48:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:48:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:48:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:48:36 INFO - Running setup.py install for mozleak 14:48:37 INFO - Running setup.py install for mozlog 14:48:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:48:37 INFO - Running setup.py install for moznetwork 14:48:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:48:37 INFO - Running setup.py install for mozprocess 14:48:37 INFO - Running setup.py install for mozprofile 14:48:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:48:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:48:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:48:37 INFO - Running setup.py install for mozrunner 14:48:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:48:37 INFO - Running setup.py install for mozscreenshot 14:48:37 INFO - Running setup.py install for moztest 14:48:37 INFO - Running setup.py install for mozversion 14:48:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:48:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:48:37 INFO - Cleaning up... 14:48:37 INFO - Return code: 0 14:48:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:37 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')]} 14:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:37 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')]} 14:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:37 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 0x7f60cd292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28da020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c2e0>, '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 0x28d8140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d85d0>, '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': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', '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 14:48:37 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 14:48:37 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 14:48:37 INFO - Using env: {'DISPLAY': ':0', 14:48:37 INFO - 'HOME': '/home/cltbld', 14:48:37 INFO - 'LANG': 'en_US.UTF-8', 14:48:37 INFO - 'LANGUAGE': 'en_US:en', 14:48:37 INFO - 'LOGNAME': 'cltbld', 14:48:37 INFO - 'MAIL': '/var/mail/cltbld', 14:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:37 INFO - 'MOZ_NO_REMOTE': '1', 14:48:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:37 INFO - 'NO_EM_RESTART': '1', 14:48:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:37 INFO - 'PWD': '/builds/slave/test', 14:48:37 INFO - 'SHELL': '/bin/bash', 14:48:37 INFO - 'SHLVL': '1', 14:48:37 INFO - 'TERM': 'linux', 14:48:37 INFO - 'TMOUT': '86400', 14:48:37 INFO - 'USER': 'cltbld', 14:48:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', 14:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:37 INFO - '_': '/tools/buildbot/bin/python'} 14:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:48:38 INFO - Running setup.py (path:/tmp/pip-klG5Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:48:38 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)) 14:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:48:38 INFO - Running setup.py (path:/tmp/pip-ImeVMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:48:38 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)) 14:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:48:38 INFO - Running setup.py (path:/tmp/pip-8Nj3Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:48:38 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)) 14:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:48:38 INFO - Running setup.py (path:/tmp/pip-Mtpzxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:48:38 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)) 14:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:48:38 INFO - Running setup.py (path:/tmp/pip-n8Dkz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:48:38 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)) 14:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:48:38 INFO - Running setup.py (path:/tmp/pip-p6KNOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:48:38 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)) 14:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:48:38 INFO - Running setup.py (path:/tmp/pip-BRs7gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:48:38 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)) 14:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:48:38 INFO - Running setup.py (path:/tmp/pip-aqunym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:48:38 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)) 14:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:48:38 INFO - Running setup.py (path:/tmp/pip-a0nQXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:48:38 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)) 14:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:48:38 INFO - Running setup.py (path:/tmp/pip-kgDUC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:48:38 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)) 14:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:48:38 INFO - Running setup.py (path:/tmp/pip-S952de-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:48:38 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)) 14:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:48:38 INFO - Running setup.py (path:/tmp/pip-BnoU5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:48:39 INFO - Running setup.py (path:/tmp/pip-emUK3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:48:39 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)) 14:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:48:39 INFO - Running setup.py (path:/tmp/pip-3rOIiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:39 INFO - Running setup.py (path:/tmp/pip-DKwciM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:39 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)) 14:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:48:39 INFO - Running setup.py (path:/tmp/pip-sGAmGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:48:39 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)) 14:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:48:39 INFO - Running setup.py (path:/tmp/pip-jDwDIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:48:39 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)) 14:48:39 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)) 14:48:39 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)) 14:48:39 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)) 14:48:39 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)) 14:48:39 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)) 14:48:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:48:39 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 14:48:39 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 14:48:39 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 14:48:39 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 14:48:39 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 14:48:39 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 14:48:41 INFO - Downloading blessings-1.6.tar.gz 14:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:48:41 INFO - Installing collected packages: blessings 14:48:41 INFO - Running setup.py install for blessings 14:48:41 INFO - Successfully installed blessings 14:48:41 INFO - Cleaning up... 14:48:41 INFO - Return code: 0 14:48:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:48:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:48:41 INFO - Reading from file tmpfile_stdout 14:48:41 INFO - Current package versions: 14:48:41 INFO - argparse == 1.2.1 14:48:41 INFO - blessings == 1.6 14:48:41 INFO - blobuploader == 1.2.4 14:48:41 INFO - docopt == 0.6.1 14:48:41 INFO - functools32 == 3.2.3-2 14:48:41 INFO - jsonschema == 2.5.1 14:48:41 INFO - manifestparser == 1.1 14:48:41 INFO - mozInstall == 1.12 14:48:41 INFO - mozcrash == 0.17 14:48:41 INFO - mozdebug == 0.1 14:48:41 INFO - mozdevice == 0.48 14:48:41 INFO - mozfile == 1.2 14:48:41 INFO - mozhttpd == 0.7 14:48:41 INFO - mozinfo == 0.9 14:48:41 INFO - mozleak == 0.1 14:48:41 INFO - mozlog == 3.2 14:48:41 INFO - moznetwork == 0.27 14:48:41 INFO - mozprocess == 0.22 14:48:41 INFO - mozprofile == 0.28 14:48:41 INFO - mozrunner == 6.11 14:48:41 INFO - mozscreenshot == 0.1 14:48:41 INFO - mozsystemmonitor == 0.3 14:48:41 INFO - moztest == 0.7 14:48:41 INFO - mozversion == 1.4 14:48:41 INFO - psutil == 3.1.1 14:48:41 INFO - requests == 1.2.3 14:48:41 INFO - wsgiref == 0.1.2 14:48:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:41 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')]} 14:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:41 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')]} 14:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:41 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 0x7f60cd292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28da020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c2e0>, '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 0x28d8140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d85d0>, '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': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', '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 14:48:41 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 14:48:41 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 14:48:41 INFO - Using env: {'DISPLAY': ':0', 14:48:41 INFO - 'HOME': '/home/cltbld', 14:48:41 INFO - 'LANG': 'en_US.UTF-8', 14:48:41 INFO - 'LANGUAGE': 'en_US:en', 14:48:41 INFO - 'LOGNAME': 'cltbld', 14:48:41 INFO - 'MAIL': '/var/mail/cltbld', 14:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:41 INFO - 'MOZ_NO_REMOTE': '1', 14:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:41 INFO - 'NO_EM_RESTART': '1', 14:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:41 INFO - 'PWD': '/builds/slave/test', 14:48:41 INFO - 'SHELL': '/bin/bash', 14:48:41 INFO - 'SHLVL': '1', 14:48:41 INFO - 'TERM': 'linux', 14:48:41 INFO - 'TMOUT': '86400', 14:48:41 INFO - 'USER': 'cltbld', 14:48:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', 14:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:41 INFO - '_': '/tools/buildbot/bin/python'} 14:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 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)) 14:48:41 INFO - Cleaning up... 14:48:41 INFO - Return code: 0 14:48:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:48:41 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')]} 14:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:41 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')]} 14:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:41 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 0x7f60cd292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28da020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c2e0>, '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 0x28d8140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d85d0>, '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': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', '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 14:48:41 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 14:48:41 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 14:48:41 INFO - Using env: {'DISPLAY': ':0', 14:48:41 INFO - 'HOME': '/home/cltbld', 14:48:41 INFO - 'LANG': 'en_US.UTF-8', 14:48:41 INFO - 'LANGUAGE': 'en_US:en', 14:48:41 INFO - 'LOGNAME': 'cltbld', 14:48:41 INFO - 'MAIL': '/var/mail/cltbld', 14:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:41 INFO - 'MOZ_NO_REMOTE': '1', 14:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:41 INFO - 'NO_EM_RESTART': '1', 14:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:41 INFO - 'PWD': '/builds/slave/test', 14:48:41 INFO - 'SHELL': '/bin/bash', 14:48:41 INFO - 'SHLVL': '1', 14:48:41 INFO - 'TERM': 'linux', 14:48:41 INFO - 'TMOUT': '86400', 14:48:41 INFO - 'USER': 'cltbld', 14:48:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', 14:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:41 INFO - '_': '/tools/buildbot/bin/python'} 14:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:48:42 INFO - Cleaning up... 14:48:42 INFO - Return code: 0 14:48:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:48:42 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')]} 14:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:42 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')]} 14:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:42 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 0x7f60cd292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28da020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c2e0>, '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 0x28d8140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d85d0>, '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': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', '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 14:48:42 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 14:48:42 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 14:48:42 INFO - Using env: {'DISPLAY': ':0', 14:48:42 INFO - 'HOME': '/home/cltbld', 14:48:42 INFO - 'LANG': 'en_US.UTF-8', 14:48:42 INFO - 'LANGUAGE': 'en_US:en', 14:48:42 INFO - 'LOGNAME': 'cltbld', 14:48:42 INFO - 'MAIL': '/var/mail/cltbld', 14:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:42 INFO - 'MOZ_NO_REMOTE': '1', 14:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:42 INFO - 'NO_EM_RESTART': '1', 14:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:42 INFO - 'PWD': '/builds/slave/test', 14:48:42 INFO - 'SHELL': '/bin/bash', 14:48:42 INFO - 'SHLVL': '1', 14:48:42 INFO - 'TERM': 'linux', 14:48:42 INFO - 'TMOUT': '86400', 14:48:42 INFO - 'USER': 'cltbld', 14:48:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', 14:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:42 INFO - '_': '/tools/buildbot/bin/python'} 14:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:42 INFO - Downloading/unpacking flake8 14:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:48:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:48:44 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 14:48:44 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 14:48:44 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 14:48:44 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 14:48:44 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 14:48:44 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 14:48:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:48:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:48:44 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 14:48:44 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 14:48:44 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 14:48:44 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 14:48:44 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 14:48:44 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 14:48:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:48:44 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 14:48:44 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 14:48:44 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 14:48:44 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 14:48:44 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 14:48:44 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 14:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:48:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:48:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:48:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:48:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:48:44 INFO - no previously-included directories found matching 'docs/_build' 14:48:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:48:45 INFO - Running setup.py install for pep8 14:48:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:48:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:48:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:48:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:48:45 INFO - no previously-included directories found matching 'docs/_build' 14:48:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:48:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:48:45 INFO - Cleaning up... 14:48:45 INFO - Return code: 0 14:48:45 INFO - Running post-action listener: _resource_record_post_action 14:48:45 INFO - Running post-action listener: _start_resource_monitoring 14:48:45 INFO - Starting resource monitoring. 14:48:45 INFO - ##### 14:48:45 INFO - ##### Finished create-virtualenv step (success) 14:48:45 INFO - ##### 14:48:45 INFO - ##### 14:48:45 INFO - ##### Running install step. 14:48:45 INFO - ##### 14:48:45 INFO - Running pre-action listener: _resource_record_pre_action 14:48:45 INFO - Running main action method: install 14:48:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:48:45 INFO - Reading from file tmpfile_stdout 14:48:45 INFO - Detecting whether we're running mozinstall >=1.0... 14:48:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:48:45 INFO - Reading from file tmpfile_stdout 14:48:45 INFO - Output received: 14:48:45 INFO - Usage: mozinstall [options] installer 14:48:45 INFO - Options: 14:48:45 INFO - -h, --help show this help message and exit 14:48:45 INFO - -d DEST, --destination=DEST 14:48:45 INFO - Directory to install application into. [default: 14:48:45 INFO - "/builds/slave/test"] 14:48:45 INFO - --app=APP Application being installed. [default: firefox] 14:48:45 INFO - mkdir: /builds/slave/test/build/application 14:48:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:49:01 INFO - Reading from file tmpfile_stdout 14:49:01 INFO - Output received: 14:49:01 INFO - /builds/slave/test/build/application/firefox/firefox 14:49:01 INFO - Running post-action listener: _resource_record_post_action 14:49:01 INFO - ##### 14:49:01 INFO - ##### Finished install step (success) 14:49:01 INFO - ##### 14:49:01 INFO - ##### 14:49:01 INFO - ##### Running run-tests step. 14:49:01 INFO - ##### 14:49:01 INFO - Running pre-action listener: _resource_record_pre_action 14:49:01 INFO - Running main action method: run_tests 14:49:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:49:01 INFO - Python 2.7.3 14:49:01 INFO - Return code: 0 14:49:01 INFO - grabbing minidump binary from tooltool 14:49:01 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')]} 14:49:01 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 0x296c2e0>, '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 0x28d8140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d85d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:49:01 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 14:49:01 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 14:49:01 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 14:49:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:49:01 INFO - Return code: 0 14:49:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:49:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:49:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:49:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:49:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:49:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:49:02 INFO - Return code: 0 14:49:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 14:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 14:49:02 INFO - Using env: {'DISPLAY': ':0', 14:49:02 INFO - 'HOME': '/home/cltbld', 14:49:02 INFO - 'LANG': 'en_US.UTF-8', 14:49:02 INFO - 'LANGUAGE': 'en_US:en', 14:49:02 INFO - 'LOGNAME': 'cltbld', 14:49:02 INFO - 'MAIL': '/var/mail/cltbld', 14:49:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:49:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:02 INFO - 'MOZ_NO_REMOTE': '1', 14:49:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:02 INFO - 'NO_EM_RESTART': '1', 14:49:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:02 INFO - 'PWD': '/builds/slave/test', 14:49:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:49:02 INFO - 'SHELL': '/bin/bash', 14:49:02 INFO - 'SHLVL': '1', 14:49:02 INFO - 'TERM': 'linux', 14:49:02 INFO - 'TMOUT': '86400', 14:49:02 INFO - 'USER': 'cltbld', 14:49:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505', 14:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:02 INFO - '_': '/tools/buildbot/bin/python'} 14:49:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 14:49:02 INFO - mozversion application_buildid: 20160609124436 14:49:02 INFO - mozversion application_changeset: f8bdceb55c9d191380176ab25e2385737bd9e1ab 14:49:02 INFO - mozversion application_display_name: Nightly 14:49:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:49:02 INFO - mozversion application_name: Firefox 14:49:02 INFO - mozversion application_remotingname: firefox 14:49:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:49:02 INFO - mozversion application_vendor: Mozilla 14:49:02 INFO - mozversion application_version: 50.0a1 14:49:02 INFO - mozversion platform_buildid: 20160609124436 14:49:02 INFO - mozversion platform_changeset: f8bdceb55c9d191380176ab25e2385737bd9e1ab 14:49:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:49:02 INFO - mozversion platform_version: 50.0a1 14:49:02 INFO - using testdate: 1465508942 14:49:02 INFO - actual date: 1465508942 14:49:02 INFO - starting webserver on 'localhost:37223' 14:49:02 INFO - SUITE-START | Running 2 tests 14:49:02 INFO - TEST-START | dromaeo_css 14:49:02 INFO - operating with platform_type : linux_ 14:49:02 INFO - Initialising browser for dromaeo_css test... 14:49:02 INFO - TEST-INFO | started process 24164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_2Tx94/profile http://localhost:37223/getInfo.html) 14:49:07 INFO - PROCESS | 24164 | __metrics Screen width/height:1600/1200 14:49:07 INFO - PROCESS | 24164 | colorDepth:24 14:49:07 INFO - PROCESS | 24164 | Browser inner width/height: 1024/697 14:49:07 INFO - PROCESS | 24164 | __metrics 14:49:08 ERROR - PROCESS | 24164 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:49:09 INFO - TEST-INFO | 24164: exit 0 14:49:09 INFO - Browser initialized. 14:49:09 INFO - Running cycle 1/1 for dromaeo_css test... 14:49:09 INFO - TEST-INFO | started process 24282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_2Tx94/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:49:21 INFO - PROCESS | 24282 | RSS: Main: 168374272 14:49:21 INFO - PROCESS | 24282 | 14:50:10 INFO - PROCESS | 24282 | 1465509010869 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] 14:52:22 INFO - PROCESS | 24282 | Cycle 1(1): loaded http://localhost:37223/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37223/tests/dromaeo/cssquery-ext.html) 14:52:23 INFO - PROCESS | 24282 | RSS: Main: 171044864 14:52:23 INFO - PROCESS | 24282 | 14:55:25 INFO - PROCESS | 24282 | Cycle 1(1): loaded http://localhost:37223/tests/dromaeo/cssquery-ext.html (next: http://localhost:37223/tests/dromaeo/cssquery-jquery.html) 14:55:26 INFO - PROCESS | 24282 | RSS: Main: 170745856 14:55:26 INFO - PROCESS | 24282 | 14:58:28 INFO - PROCESS | 24282 | Cycle 1(1): loaded http://localhost:37223/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37223/tests/dromaeo/cssquery-mootools.html) 14:58:28 INFO - PROCESS | 24282 | RSS: Main: 171581440 14:58:28 INFO - PROCESS | 24282 | 15:01:30 INFO - PROCESS | 24282 | Cycle 1(1): loaded http://localhost:37223/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37223/tests/dromaeo/cssquery-prototype.html) 15:01:31 INFO - PROCESS | 24282 | RSS: Main: 169689088 15:01:31 INFO - PROCESS | 24282 | 15:04:34 INFO - PROCESS | 24282 | Cycle 1(1): loaded http://localhost:37223/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37223/tests/dromaeo/cssquery-yui.html) 15:04:34 INFO - PROCESS | 24282 | RSS: Main: 171028480 15:04:34 INFO - PROCESS | 24282 | 15:07:37 INFO - PROCESS | 24282 | Cycle 1(1): loaded http://localhost:37223/tests/dromaeo/cssquery-yui.html (next: http://localhost:37223/tests/dromaeo/cssquery-dojo.html) 15:07:37 INFO - PROCESS | 24282 | RSS: Main: 172638208 15:07:37 INFO - PROCESS | 24282 | 15:07:37 INFO - PROCESS | 24282 | __start_tp_report 15:07:37 INFO - PROCESS | 24282 | _x_x_mozilla_page_load 15:07:37 INFO - PROCESS | 24282 | _x_x_mozilla_page_load_details 15:07:37 INFO - PROCESS | 24282 | |i|pagename|runs| 15:07:37 INFO - PROCESS | 24282 | |0;dojo.html;2652.0585192256744;2670.9999999999995;2678.1563807400667;2680.8525531095784;2697.029069534967;4636.374089497916;4645.233536466479;4676.064787042596;4677.859664210075;4764.571188593026;4529.864104076874;4671.649626278034;4688.882777930554;4696.483386827446;4772.880677983044;4259.063006138645;4277.337012763019;4294.334378171388;4384.364267181257;4408.691391602573;4311.805968731399;4423.66822488313;4433.7118087324225;4464.352668863013;4475.686701930867;4193.308104162809;4308.892277693051;4321.935170972438;4373.387725718402;4390.165868484994;4239.809208585591;4279.807408666617;4288.185244803477;4308.159908817782;4317.222899878052;4279.700420970534;4303.203907277164;4303.33298338758;4318.352247162919;4349.543297953701;4559.293309537027;4610.5389461053965;4641.767911604406;4651.023285110131;4651.465081515601;5067.189249720064;5075.720835354054;5099.847004589831;5102.36220472441;5150;5111.948880511184;5134.589232861362;5147.485251474823;5152.613553983429;5159.380874295071;4627.282771170474;4678.883027924261;4679.859604211879;4683.601893838993;4694.319323698079;5100.6429549931145;5106.234064890296;5109.540141387293;5120.564751996048;5125.923111153261;4794.856154315376;4884.804607815648;4908.288298196741;4927.187014142698;4951.059298733229;5057.924131138036;5098.59211263098;5112.156494178494;5143.331366922276;5162.9741851291255;4893.755312234374;4911.68074075184;4947.233178857283;4976.328195693607;4982.427020892571;4934.4572097069295;4944.505549445027;4947.90104197914;4951.034548263126;4975.651704380659;4122.505299364096;4169.228692691801;4187.288161012635;4191.8532851350055;4198.748075115503;3691.6862066724093;3693.9815300923324;3701.2227432239533;3707.888763337104;3715.3869611513796;4335.891602709894;4445.622122119591;4447.710898791568;4461.219286624828;4467.24056910326;5042.294078828967;5123.154679477844;5124.8206312778875;5126.2054381570915;5144.074066668036;4451.910961780746;4478.149151661174;4509.458864936163;4515.209838278288;4522.412086428809;4330.047389574289;4481.663875209372;4551.772411379484;4555.134524440412;4566.26939689648;4780.067886762048;4822.493638168082;4833.468318484894;4839.491853355487;4896.608271338285;5121.667091639031;5124.154514505065;5128.435872054146;5130;5157.535821776059;4688.859334219979;4696.412948381452;4731.550502702238;4818.036392721399;4886.096072226649;4921.876953076202;4923.975380123076;4927.310176575211;4931.778069986931;4980.05378977993;4999.9750051240135;5001.549860512571;5001.824936127218;5004.3494345734825;5045.066662667418;4822;4897.681650692693;4956.529129732669;4980.9501904981935;5022.648414611088;4829.879253018703;4894.216925291937;4904.141775189256;4949.356583644103;4965.056639238677;4864.659473836798;4876.975615121902;4888.266759986031;4889.682170658896;4939.703617782944;4794.59245964083;4873.634477414279;4881.365422495053;4927.039227350632;4994.750262486934;4862.878428039327;4866.829660961849;4879.048585525788;4886.53577910098;4897.461279259207 15:07:37 INFO - PROCESS | 24282 | |1;ext.html;534.3184736332304;565.7369323264681;584.7982446056109;588.4233451217805;605.8485378655337;35188.12029699256;39885.80057099714;40077;40104.19791604166;40158;41094.79452602741;41213;41578;41590.37614435778;41600.16799664005;7744.574048427348;7805.37556995439;7852.803679908019;7853.842923141534;7866.763997080068;7556.47104702671;7734.883976740353;7741.148473667892;7754.224577542257;7754.7673569793;7778.599852026633;7784.844303113934;7816.53100813953;7816.609169541529;7832.373410127205;7727.4204434667345;7750.186230445835;7751.651175697107;7753.108392534874;7753.922460775405;7690.307872291521;7755.650995705207;7790.688372465094;7837.843243135162;7841.764747057598;29960.400791984037;37750.62249377499;37946.430803537965;38011;38032.42951355732;3026.046795259508;3093.891713790029;3115.0810510899114;3187.585613870205;3242.691944265291;27151.728482715116;30237;30376.240593985105;30429.087127386214;31289.217769555944;3506.579210494757;3559.3262384956906;3610.288324407336;3644.1982763791925;3646.2889736501393;259208;264879;265516;265646.9999999981;266410;58583;59246.70376648089;59513.404865951656;59538;59699.40300596938;34334.31331373358;34954.12614684653;34959;37443;37573.81213093917;15985.920070399574;16071.839281607034;16112;16154.515364539082;16201.918990404973;12180.756384872253;12325.445354959049;12341.876581234252;12346.506139754309;12389.75220495585;19792.307269245506;20094.39716808498;20141.597168056556;20145.395638130878;20260.59478810445;7287.396772709995;7523.510971786816;7529.548227106282;7535.849283014309;7579.1662917079075;832.2717622080679;852.6887685994691;908.881845360099;973.8101070291225;1000.8198524265703;27312.590311145348;27400.725992740216;27972;27983.300417489318;28059.57910631342;958.5590628310915;976.1946394224793;995.581855620641;1004.8743907011624;1075.983860242097;14434.711305773826;14801.925990369979;14892.851071489364;15012.62468438276;15077.54767356981;379220;381969;382894;386197;387089;50730;51231.74384128056;51450;51518.22722659163;51578.74210628923;1146;1181.8345431639577;1188.197966372695;1192.4335940428055;1200.699825043739;26598.867005664848;27226.5916011256;27393.726062739916;27532.579020657566;27654.585181221897;42059.579404206794;42599.7870010648;42604.573954260064;42754.78622606867;42840;329670;333945;334911;335431;336224;24275;25906.740932590434;25988;25991.350216244744;26011.47977040411;43614.12771744611;44320;44370.33444498399;48190.27714584214;49157.75421122871;38218.617813821504;38370.84887453381;38543.03642408962;38763.41854872236;39758.403623946244;37019.62980370162;37515.81242093772;37639;37774;37868;31543.36913261676;34716;35087.64912350844;36301;36872.44691329578;31691.20771980719;33595.664043359255;33680.32639347248;34094.65905340915;34207.315853683285;25778.613320800578;25862;26168.73831261663;26313.21060368192;26616.201513954613 15:07:37 INFO - PROCESS | 24282 | |2;jquery.html;350.30289723450323;352.8712020112659;355.8718861209964;370.09511743786453;377.2793963529659;15605.84394156058;15967.281472333743;17086.145692715345;17161.227744751486;17163.656726865454;14183.787243191335;15286.31211595478;15304.923475382608;15311;15335.69328613427;4810.086083644105;5059.4181669107975;5374.193870919355;5389;5462.7268636568215;4921.507849215068;5255.684658920458;5356.651817631841;5375.247465354853;5390.434004429537;5289.100852855024;5289.603279754015;5296.708681022542;5329.280547126146;5336.919946200791;5249.527542521172;5605.523530499892;5613.07384281593;5622.381538030834;5646.20953066571;5232.73836308183;5397.055515284848;5413.810516631938;5445.9727701361635;5449.700266485342;12280.201786883914;12355.38223088851;12399.25604463726;12490.188137771107;12503.374831258401;1799.8290162434678;1846.9907650461796;1858.7955324914249;1879.7462342583713;1930.845532357408;8906.198442140174;9118.316126290554;9310.068993100704;11654.941725291319;11991.220570662967;1699.7167138810244;1708.470374184007;1714.9657006859918;1734.2889415339775;1752.2264139659724;65222;69118.65440672764;69870;70612;71016.28983710149;9998.80014398277;10137.695869123938;10181.083702466814;10223.079922806983;10385;13894.027418080637;13963.232022238875;13986.090904091201;13986.230757308242;13990;7371.631418429057;7381.335679788845;7449.664765085584;7491.213422590658;7562.621868906533;6969.47728920333;7086.078809754699;7192.3886469649615;7217.350438460564;7218.314260145278;4223.831046758157;4321.546237645065;4353.608175264241;4358.4769827620885;4427.313766366218;1779.395005698043;1794.23744908416;1861.2741030997922;1865.8973756443527;1875.9062046897873;853.8804567360575;878.1218781218781;893.2362829780574;911.6262332443666;962.8748262725801;16147.273372698257;16232.107234102;16466.83533164677;16668.58328541796;17183.656326873643;814.2752949874616;884.6947803007952;895.3240303570763;920.2316066084894;936.321167153808;9373.765655858659;9379.437233765859;9543;9573.090556397132;9695.757606059764;354296;354950;356137;356213;367202;60067;70377;75919.62040189764;78270.21729782743;78862.60568697234;909.1999040844015;918.4581097152712;922.6816748221987;934.4019827310527;941.228192881844;15480.303386347867;15480.5355839325;15541;15606.765898511305;16024;25433.10984115547;33075;35186.824065879504;35989.92030239097;36639.816800915825;47309.52690473051;48695.5130448691;49362;49939.50060499348;50750.49249507458;6927.549709268881;7001.509894307554;7068.964655176691;7096.787096387116;7247.4926755126635;7913.9604301978125;10142.797144056929;10609.9469502652;10676.14590832716;10760.246782725135;9091.727248182566;9154.771130721785;9266.351355405326;9466.621335146518;9588.520573971413;10221.642242521477;10330;10426.530806113591;10435.426051566934;10450.372977621368;10074.496275186064;10344.27590068688;10346.37921724699;10380.688579342632;10474.319169253975;7582.469227154046;7611.3530349920875;7826.373890088893;7850.921490785019;7883.64523596451;9413.717588472357;9468.431894086378;9964.402135871871;9992.700218993441;10232.283740138118 15:07:37 INFO - PROCESS | 24282 | |3;mootools.html;1394.595567285487;1444.010852565992;1502.932368043438;1666.5167101540553;1692.568395059259;6695.56478828877;7428.480006399554;7590.468667193299;8258.669653213872;8270.090290068096;7451.068616422947;7734.38124950004;7810.609469526529;7827.099883513398;7829.6085195740125;2109.5886302171084;2148.4521447030984;2155.2564365293947;2156.148321413049;2159.654455287154;2149.8602590831624;2174.608570457317;2184.541246338271;2184.6941428200066;2187.529681118559;2130.9041093150845;2131.2221039320693;2144.238795227695;2148.5380643161716;2153.12798316682;2127.2767259131892;2128.2444732120107;2131.3179782469615;2132.296342207068;2135.220644464759;2026.0578830843729;2094.968575471369;2108.692610581449;2117.12139462123;2121.480237341861;7703.8844417333785;7713.498622589514;7741.109772376192;7742.187070357644;7798.688052477894;4459.910801783979;4579.656525760548;4582.152301824173;4589.632829373675;4591.035882464653;2772.5286701260834;2889.3787835615235;2898.4927637663536;2913.5775312579767;2922.576226447153;895.6999405199201;914.6935776514875;943.2595412601075;946.8106378724214;946.9431834089977;10641.201909856793;10716.249862509549;10752.139828813755;10778.299410538368;10792.73018174544;3996.260691771973;4056.087380339459;4118.19695159447;4121.732087414309;4160.771157586301;9137.817243655223;9209.309301802257;9239.353245272901;9252.398594091363;9294.163525282622;4592.242280023758;4626.352310676508;4636.258198688193;4646.3495110684535;4681.485036645966;3451.3787518246454;4024.9597504024587;4123.299039163349;4234.957650423518;4250.596193361687;3605.441156620728;3641.344557979589;3708.0915175781565;3741.663250307485;3764.79293638847;1115.7378016166194;1151.9078473722082;1153.1870031627682;1156.1213477756964;1156.306216270248;694.5589550635282;749.6663984526942;800.7077416742846;889.106448019749;891.3136884598823;5162.225666150108;5187.740612969412;5409.945900540944;5592.5805564582815;5635.408282130399;877.8332116897897;882.7572417585216;894.4052205283414;907.0385391485047;918.7550868573121;3589.802560859178;3652.4886515887797;3671.4859919611276;3851.094992676719;3932.941005884914;9481.241500680067;9665.371750836173;9851.655192068387;9857.75355616101;9860.359076659994;9613.615455381707;9682.854757178648;9683.9031609683;9712.3201375903;9722.076402741728;7038.718451261994;7329.083864516935;7337.486375953738;7411.110666720028;7513.436492263102;5110.9233361500355;5323.414424413389;5434.157705555645;5442.727863606883;5491.341039075336;9000.099990000948;9148.63405463774;9155.725328240163;9173.220276276325;9175.587098580714;8706.869396958924;8930.73207803741;8993.730188094367;9144.817103657757;9223.677171299241;5928.258967629046;6659.833504162241;6801.863962720817;6896.931030689629;7073.1865835427525;7494.3629791466155;7494.400447964259;7553.093628764584;7604.809879752829;7605.391568674382;6733.730650773914;6747.696353663999;6758.7296508139125;6913.654317284217;7096.396806271318;6663.100481435138;6705.798826035227;6790.32096790317;6833.521653484208;7047.894281585883;6061.6666083365835;6064.818055458343;6120.173776540289;6132.325444201045;6177.505799536116;4528.117017181618;4644.2801365788355;4657.091867086021;4742.5731684148595;4751.7861696224445;4596.862094137181;4621.768911554476;4639.0721855628335;4686.625069994324;4728.763561821964 15:07:37 INFO - PROCESS | 24282 | |4;prototype.html;276.7136014225277;277.38697478572357;278.17105027019477;283.14772534670635;284.63708771316556;4937.259411088334;4994.67534610251;4999.150314383679;5007.599392048636;5011.248312753089;4861.878453038676;4867.707937523751;4877.585405240558;4904.828331008406;4905.288733133693;3583.910402239945;3673.540807399075;3752.099496120925;3775.4903088083033;3786.2238241160635;3782.149016471286;3782.243551289739;3787.7159213058994;3805.0867791729925;3807.276617442677;3760.736748427611;3762.341590221714;3775.924481510368;3789.071677439031;3796.3925771876507;3506.68439840413;3714.294284086042;3786.3941769316775;3789.5073640426845;3812.542494900602;3209.8876539321245;3214.8553315100876;3225.5646986525257;3227.564278822376;3259.559959405474;4715.528447155291;4720.693154944952;4726.747411935839;4728.598069164125;4754.738489383082;4275.183047204925;4275.40144379787;4283.250431174563;4306.590873867009;4325.632321252666;5024.19612861944;5084.618653600995;5093;5106.719130447824;5106.872328191825;3539.185987222953;3539.787612743218;3545.2732189901008;3560.537130173061;3561.893143205708;5396.271503347037;5410.702411367373;5417.891642167174;5418.729063546846;5425.267588875491;3367.8821241256437;3568.125809176768;3576.678098971105;3605.7295702822394;3613.9638603614153;3565.607783143852;3589.4615807629066;3594.155373487228;3626.5104210931713;3640.344737947195;4192.140611174702;4195.04930207455;4204.70567060309;4206.095689426788;4223.282042052859;5059.19052951526;5139.897202056013;5153.5361817436615;5174.870628234249;5179.559737422362;1256.6921104329315;1258.4022589270023;1263.25467973894;1264.5890085722176;1265.544404014554;772.8879312499769;779.5478622399108;792.2552800367636;802.5987006496752;806.137432946753;4509.1658043262105;4559.54404559548;4579.702319349231;4580.862574122782;4593.150267200579;5331.600129990266;5338.359396872323;5345.679259244458;5346;5371.57027437804;4396.230659634552;4553.977230113828;4613.146567884952;4615.146197953322;4653.325267836212;2760.544510155842;2811.8594070296404;2818.8167769094944;2822.8849604406146;2864.496139526765;4969.527894849984;5012.7994880205115;5016.297718319438;5046.192609182586;5059.696418214919;5210.505002024802;5330.307060082165;5349.251104845324;5367.731613419313;5526.834194974157;5012.699238045729;5029.371328584;5056.84829455117;5073.441921388644;5080.517350851663;5296.655717378358;5337;5338.572914166935;5375.650582712111;5445.264889239902;5163.199704045879;5230.8169214077325;5260.842174734764;5292.894142117213;5312.787488500571;5096.745162741922;5100;5126.615503837153;5135.512126347991;5136.512031357015;3583.674040604993;3645.744797864124;3668.2846844864994;3671;3671.9082022948573;5085.262636917701;5309.283246761792;5312.601554883322;5352.260515332455;5416.891662166813;5164.715940623151;5175.715335656575;5201.219817027476;5238.476152384731;5239.869003274948;5178.792848286026;5181.248718935809;5185.936882939064;5200.479952004769;5212.947870521246;4905.5094490550655;5127.589912774017;5144.536991670768;5153.433122356612;5156.587473002226;4999.350084488993;5079.746012699424;5193.350831146106;5198.636095473281;5252.947470525246;5062;5068.163752980864;5074.238864170256;5107.6169287302855;5123.538881500683 15:07:37 INFO - PROCESS | 24282 | |5;yui.html;638.2181827261608;639.9840003999902;722.5484072454716;727.7125535413512;759.589821496392;12686.365681715912;13164.210147391163;13167.670808229786;13206.405711742971;13327.933360333209;14401.13593184407;14573.92713036436;15056.473023444181;15091.471798487055;15107.848921510782;616.134331264574;795.2802713544252;811.5658122904248;818.8607936650753;819.0171793847377;778.8247644280049;803.5821372886096;804.4811096842533;805.5086397297644;808.9474184178039;820.8932838730957;830.8172202115525;833.3832963606917;833.754042557444;835.064727505195;824.542378979669;828.8300898315831;828.958552072397;832.0680837462021;832.966681332752;607.2257871214238;608.7260732670316;609.9329073801878;611.6849822341497;611.7705860302386;12983.09118361715;13027.869721302855;13038.478460861648;13071.673208169777;13080.934595326962;13591.864081359257;13997.370118344597;14004.579862604138;14127.293635318192;14205.076670016417;10511.52698128586;10516.158707303473;10523.579056837718;10617.150627949746;10758.892411075945;3444.225049363898;3455.1534873956043;3455.3953058214965;3456.844442000091;3508.701760350373;63306.683466582836;64053.35946640521;64580.67709661469;65616.67191664058;66045.00932486016;10345.394818828401;10407.843882341771;10412.68761937143;10465.9476702616;10529.105026072717;20528.692069618966;20549.075291611913;20567.4858128545;20595.279165229145;20831.270905518235;7073.292670732885;7095.467839912028;7107.680154393065;7141.678624461912;7161.498695091398;3748.9437658435145;3895;3908.2378936107752;3908.6677632400997;3923.6861051115843;2908.2438565972575;3012.9246768830517;3021.56187352837;3025.8184508929535;3041.4373340931998;462.07354254719075;478.38288607696376;491.9016196760662;494.98267560635924;496.07234471538453;570.8087790590116;587.5487151081153;594.2037669522861;597.5518361229078;611.2939554814196;8231.42380033392;8444.113368096261;8481.236688698047;8494.235518803338;8708.869366959501;566.8809549994464;575.2722805650855;578.6094386289238;590.1413443439785;609.0863704443335;3788.6590206881515;3965.504311961005;3983.123712783241;4052.8176232069627;4091.5294741105154;95416.52291738497;100822;101720.33656802592;102824.48587757163;103107;38548.42177367342;48855.26717099246;49892.25161622579;50057.74971125194;50889;78530.6073469629;79707.60146199347;79940.60029699931;80259.17149113593;80327.59836200898;7711.421643376882;7724.536527808349;7929.484583502284;7943.046834379911;7970.442069055111;48069;48259.03481930272;48697;49123.26315105348;49432.50567494279;35409.82295088611;36191.81904090463;36563.45154822733;55469;71348;9998.750031249278;10156.39061656303;10388.37669739818;10443.634472793416;10700.732481687708;11250.887491124984;11494.540218391505;11582.71043223926;11587.42062896835;11955.103367247317;10893.291936024134;10915.672529824118;11145.665630031112;11256.437178141225;11420.543178272776;11033.613823516138;11182.161337899854;11299.603322361503;11315.20793544444;11434.19960602783;10226.335288206243;10345.844812327972;10362.274640775375;10807.13542916549;11141.387223702774;8825.823483530421;9050.728478145666;9162.633494660138;9356.251499879858;9447.102525260088;8658.78353041179;8888.33337499703;9012.143846334588;9029.729108126767;9032.548372581214 15:07:37 INFO - PROCESS | 24282 | __end_tp_report 15:07:37 INFO - PROCESS | 24282 | __start_cc_report 15:07:37 INFO - PROCESS | 24282 | _x_x_mozilla_cycle_collect,393 15:07:37 INFO - PROCESS | 24282 | __end_cc_report 15:07:37 INFO - PROCESS | 24282 | __startTimestamp1465510057600__endTimestamp 15:07:37 INFO - PROCESS | 24282 | 15:07:37 INFO - PROCESS | 24282 | ------- Summary: start ------- 15:07:37 INFO - PROCESS | 24282 | Number of tests: 6 15:07:37 INFO - PROCESS | 24282 | 15:07:37 INFO - PROCESS | 24282 | [#0] dojo.html Cycles:165 Average:4661.78 Median:4822.00 stddev:488.52 (10.1%) stddev-sans-first:463.88 15:07:37 INFO - PROCESS | 24282 | Values: 2652.1 2671.0 2678.2 2680.9 2697.0 4636.4 4645.2 4676.1 4677.9 4764.6 4529.9 4671.6 4688.9 4696.5 4772.9 4259.1 4277.3 4294.3 4384.4 4408.7 4311.8 4423.7 4433.7 4464.4 4475.7 4193.3 4308.9 4321.9 4373.4 4390.2 4239.8 4279.8 4288.2 4308.2 4317.2 4279.7 4303.2 4303.3 4318.4 4349.5 4559.3 4610.5 4641.8 4651.0 4651.5 5067.2 5075.7 5099.8 5102.4 5150.0 5111.9 5134.6 5147.5 5152.6 5159.4 4627.3 4678.9 4679.9 4683.6 4694.3 5100.6 5106.2 5109.5 5120.6 5125.9 4794.9 4884.8 4908.3 4927.2 4951.1 5057.9 5098.6 5112.2 5143.3 5163.0 4893.8 4911.7 4947.2 4976.3 4982.4 4934.5 4944.5 4947.9 4951.0 4975.7 4122.5 4169.2 4187.3 4191.9 4198.7 3691.7 3694.0 3701.2 3707.9 3715.4 4335.9 4445.6 4447.7 4461.2 4467.2 5042.3 5123.2 5124.8 5126.2 5144.1 4451.9 4478.1 4509.5 4515.2 4522.4 4330.0 4481.7 4551.8 4555.1 4566.3 4780.1 4822.5 4833.5 4839.5 4896.6 5121.7 5124.2 5128.4 5130.0 5157.5 4688.9 4696.4 4731.6 4818.0 4886.1 4921.9 4924.0 4927.3 4931.8 4980.1 5000.0 5001.5 5001.8 5004.3 5045.1 4822.0 4897.7 4956.5 4981.0 5022.6 4829.9 4894.2 4904.1 4949.4 4965.1 4864.7 4877.0 4888.3 4889.7 4939.7 4794.6 4873.6 4881.4 4927.0 4994.8 4862.9 4866.8 4879.0 4886.5 4897.5 15:07:37 INFO - PROCESS | 24282 | 15:07:37 INFO - PROCESS | 24282 | [#1] ext.html Cycles:180 Average:48197.89 Median:37544.81 stddev:87046.75 (231.8%) stddev-sans-first:87217.37 15:07:37 INFO - PROCESS | 24282 | Values: 534.3 565.7 584.8 588.4 605.8 35188.1 39885.8 40077.0 40104.2 40158.0 41094.8 41213.0 41578.0 41590.4 41600.2 7744.6 7805.4 7852.8 7853.8 7866.8 7556.5 7734.9 7741.1 7754.2 7754.8 7778.6 7784.8 7816.5 7816.6 7832.4 7727.4 7750.2 7751.7 7753.1 7753.9 7690.3 7755.7 7790.7 7837.8 7841.8 29960.4 37750.6 37946.4 38011.0 38032.4 3026.0 3093.9 3115.1 3187.6 3242.7 27151.7 30237.0 30376.2 30429.1 31289.2 3506.6 3559.3 3610.3 3644.2 3646.3 259208.0 264879.0 265516.0 265647.0 266410.0 58583.0 59246.7 59513.4 59538.0 59699.4 34334.3 34954.1 34959.0 37443.0 37573.8 15985.9 16071.8 16112.0 16154.5 16201.9 12180.8 12325.4 12341.9 12346.5 12389.8 19792.3 20094.4 20141.6 20145.4 20260.6 7287.4 7523.5 7529.5 7535.8 7579.2 832.3 852.7 908.9 973.8 1000.8 27312.6 27400.7 27972.0 27983.3 28059.6 958.6 976.2 995.6 1004.9 1076.0 14434.7 14801.9 14892.9 15012.6 15077.5 379220.0 381969.0 382894.0 386197.0 387089.0 50730.0 51231.7 51450.0 51518.2 51578.7 1146.0 1181.8 1188.2 1192.4 1200.7 26598.9 27226.6 27393.7 27532.6 27654.6 42059.6 42599.8 42604.6 42754.8 42840.0 329670.0 333945.0 334911.0 335431.0 336224.0 24275.0 25906.7 25988.0 25991.4 26011.5 43614.1 44320.0 44370.3 48190.3 49157.8 38218.6 38370.8 38543.0 38763.4 39758.4 37019.6 37515.8 37639.0 37774.0 37868.0 31543.4 34716.0 35087.6 36301.0 36872.4 31691.2 33595.7 33680.3 34094.7 34207.3 25778.6 25862.0 26168.7 26313.2 26616.2 15:07:37 INFO - PROCESS | 24282 | 15:07:37 INFO - PROCESS | 24282 | [#2] jquery.html Cycles:180 Average:22806.21 Median:49650.75 stddev:59212.60 (119.3%) stddev-sans-first:59354.71 15:07:37 INFO - PROCESS | 24282 | Values: 350.3 352.9 355.9 370.1 377.3 15605.8 15967.3 17086.1 17161.2 17163.7 14183.8 15286.3 15304.9 15311.0 15335.7 4810.1 5059.4 5374.2 5389.0 5462.7 4921.5 5255.7 5356.7 5375.2 5390.4 5289.1 5289.6 5296.7 5329.3 5336.9 5249.5 5605.5 5613.1 5622.4 5646.2 5232.7 5397.1 5413.8 5446.0 5449.7 12280.2 12355.4 12399.3 12490.2 12503.4 1799.8 1847.0 1858.8 1879.7 1930.8 8906.2 9118.3 9310.1 11654.9 11991.2 1699.7 1708.5 1715.0 1734.3 1752.2 65222.0 69118.7 69870.0 70612.0 71016.3 9998.8 10137.7 10181.1 10223.1 10385.0 13894.0 13963.2 13986.1 13986.2 13990.0 7371.6 7381.3 7449.7 7491.2 7562.6 6969.5 7086.1 7192.4 7217.4 7218.3 4223.8 4321.5 4353.6 4358.5 4427.3 1779.4 1794.2 1861.3 1865.9 1875.9 853.9 878.1 893.2 911.6 962.9 16147.3 16232.1 16466.8 16668.6 17183.7 814.3 884.7 895.3 920.2 936.3 9373.8 9379.4 9543.0 9573.1 9695.8 354296.0 354950.0 356137.0 356213.0 367202.0 60067.0 70377.0 75919.6 78270.2 78862.6 909.2 918.5 922.7 934.4 941.2 15480.3 15480.5 15541.0 15606.8 16024.0 25433.1 33075.0 35186.8 35989.9 36639.8 47309.5 48695.5 49362.0 49939.5 50750.5 6927.5 7001.5 7069.0 7096.8 7247.5 7914.0 10142.8 10609.9 10676.1 10760.2 9091.7 9154.8 9266.4 9466.6 9588.5 10221.6 10330.0 10426.5 10435.4 10450.4 10074.5 10344.3 10346.4 10380.7 10474.3 7582.5 7611.4 7826.4 7850.9 7883.6 9413.7 9468.4 9964.4 9992.7 10232.3 15:07:37 INFO - PROCESS | 24282 | 15:07:37 INFO - PROCESS | 24282 | [#3] mootools.html Cycles:180 Average:5157.10 Median:5438.44 stddev:2904.81 (53.4%) stddev-sans-first:2899.19 15:07:37 INFO - PROCESS | 24282 | Values: 1394.6 1444.0 1502.9 1666.5 1692.6 6695.6 7428.5 7590.5 8258.7 8270.1 7451.1 7734.4 7810.6 7827.1 7829.6 2109.6 2148.5 2155.3 2156.1 2159.7 2149.9 2174.6 2184.5 2184.7 2187.5 2130.9 2131.2 2144.2 2148.5 2153.1 2127.3 2128.2 2131.3 2132.3 2135.2 2026.1 2095.0 2108.7 2117.1 2121.5 7703.9 7713.5 7741.1 7742.2 7798.7 4459.9 4579.7 4582.2 4589.6 4591.0 2772.5 2889.4 2898.5 2913.6 2922.6 895.7 914.7 943.3 946.8 946.9 10641.2 10716.2 10752.1 10778.3 10792.7 3996.3 4056.1 4118.2 4121.7 4160.8 9137.8 9209.3 9239.4 9252.4 9294.2 4592.2 4626.4 4636.3 4646.3 4681.5 3451.4 4025.0 4123.3 4235.0 4250.6 3605.4 3641.3 3708.1 3741.7 3764.8 1115.7 1151.9 1153.2 1156.1 1156.3 694.6 749.7 800.7 889.1 891.3 5162.2 5187.7 5409.9 5592.6 5635.4 877.8 882.8 894.4 907.0 918.8 3589.8 3652.5 3671.5 3851.1 3932.9 9481.2 9665.4 9851.7 9857.8 9860.4 9613.6 9682.9 9683.9 9712.3 9722.1 7038.7 7329.1 7337.5 7411.1 7513.4 5110.9 5323.4 5434.2 5442.7 5491.3 9000.1 9148.6 9155.7 9173.2 9175.6 8706.9 8930.7 8993.7 9144.8 9223.7 5928.3 6659.8 6801.9 6896.9 7073.2 7494.4 7494.4 7553.1 7604.8 7605.4 6733.7 6747.7 6758.7 6913.7 7096.4 6663.1 6705.8 6790.3 6833.5 7047.9 6061.7 6064.8 6120.2 6132.3 6177.5 4528.1 4644.3 4657.1 4742.6 4751.8 4596.9 4621.8 4639.1 4686.6 4728.8 15:07:37 INFO - PROCESS | 24282 | 15:07:37 INFO - PROCESS | 24282 | [#4] prototype.html Cycles:180 Average:4253.43 Median:4921.38 stddev:1279.46 (26.0%) stddev-sans-first:1247.74 15:07:37 INFO - PROCESS | 24282 | Values: 276.7 277.4 278.2 283.1 284.6 4937.3 4994.7 4999.2 5007.6 5011.2 4861.9 4867.7 4877.6 4904.8 4905.3 3583.9 3673.5 3752.1 3775.5 3786.2 3782.1 3782.2 3787.7 3805.1 3807.3 3760.7 3762.3 3775.9 3789.1 3796.4 3506.7 3714.3 3786.4 3789.5 3812.5 3209.9 3214.9 3225.6 3227.6 3259.6 4715.5 4720.7 4726.7 4728.6 4754.7 4275.2 4275.4 4283.3 4306.6 4325.6 5024.2 5084.6 5093.0 5106.7 5106.9 3539.2 3539.8 3545.3 3560.5 3561.9 5396.3 5410.7 5417.9 5418.7 5425.3 3367.9 3568.1 3576.7 3605.7 3614.0 3565.6 3589.5 3594.2 3626.5 3640.3 4192.1 4195.0 4204.7 4206.1 4223.3 5059.2 5139.9 5153.5 5174.9 5179.6 1256.7 1258.4 1263.3 1264.6 1265.5 772.9 779.5 792.3 802.6 806.1 4509.2 4559.5 4579.7 4580.9 4593.2 5331.6 5338.4 5345.7 5346.0 5371.6 4396.2 4554.0 4613.1 4615.1 4653.3 2760.5 2811.9 2818.8 2822.9 2864.5 4969.5 5012.8 5016.3 5046.2 5059.7 5210.5 5330.3 5349.3 5367.7 5526.8 5012.7 5029.4 5056.8 5073.4 5080.5 5296.7 5337.0 5338.6 5375.7 5445.3 5163.2 5230.8 5260.8 5292.9 5312.8 5096.7 5100.0 5126.6 5135.5 5136.5 3583.7 3645.7 3668.3 3671.0 3671.9 5085.3 5309.3 5312.6 5352.3 5416.9 5164.7 5175.7 5201.2 5238.5 5239.9 5178.8 5181.2 5185.9 5200.5 5212.9 4905.5 5127.6 5144.5 5153.4 5156.6 4999.4 5079.7 5193.4 5198.6 5252.9 5062.0 5068.2 5074.2 5107.6 5123.5 15:07:37 INFO - PROCESS | 24282 | 15:07:37 INFO - PROCESS | 24282 | [#5] yui.html Cycles:180 Average:16726.43 Median:48478.02 stddev:23714.53 (48.9%) stddev-sans-first:23750.28 15:07:37 INFO - PROCESS | 24282 | Values: 638.2 640.0 722.5 727.7 759.6 12686.4 13164.2 13167.7 13206.4 13327.9 14401.1 14573.9 15056.5 15091.5 15107.8 616.1 795.3 811.6 818.9 819.0 778.8 803.6 804.5 805.5 808.9 820.9 830.8 833.4 833.8 835.1 824.5 828.8 829.0 832.1 833.0 607.2 608.7 609.9 611.7 611.8 12983.1 13027.9 13038.5 13071.7 13080.9 13591.9 13997.4 14004.6 14127.3 14205.1 10511.5 10516.2 10523.6 10617.2 10758.9 3444.2 3455.2 3455.4 3456.8 3508.7 63306.7 64053.4 64580.7 65616.7 66045.0 10345.4 10407.8 10412.7 10465.9 10529.1 20528.7 20549.1 20567.5 20595.3 20831.3 7073.3 7095.5 7107.7 7141.7 7161.5 3748.9 3895.0 3908.2 3908.7 3923.7 2908.2 3012.9 3021.6 3025.8 3041.4 462.1 478.4 491.9 495.0 496.1 570.8 587.5 594.2 597.6 611.3 8231.4 8444.1 8481.2 8494.2 8708.9 566.9 575.3 578.6 590.1 609.1 3788.7 3965.5 3983.1 4052.8 4091.5 95416.5 100822.0 101720.3 102824.5 103107.0 38548.4 48855.3 49892.3 50057.7 50889.0 78530.6 79707.6 79940.6 80259.2 80327.6 7711.4 7724.5 7929.5 7943.0 7970.4 48069.0 48259.0 48697.0 49123.3 49432.5 35409.8 36191.8 36563.5 55469.0 71348.0 9998.8 10156.4 10388.4 10443.6 10700.7 11250.9 11494.5 11582.7 11587.4 11955.1 10893.3 10915.7 11145.7 11256.4 11420.5 11033.6 11182.2 11299.6 11315.2 11434.2 10226.3 10345.8 10362.3 10807.1 11141.4 8825.8 9050.7 9162.6 9356.3 9447.1 8658.8 8888.3 9012.1 9029.7 9032.5 15:07:37 INFO - PROCESS | 24282 | -------- Summary: end -------- 15:07:37 INFO - PROCESS | 24282 | 15:07:38 INFO - TEST-INFO | 24282: exit 0 15:07:38 INFO - TEST-OK | dromaeo_css | took 1115631ms 15:07:38 INFO - TEST-START | kraken 15:07:38 INFO - operating with platform_type : linux_ 15:07:38 INFO - Initialising browser for kraken test... 15:07:38 INFO - TEST-INFO | started process 24514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK6MYgx/profile http://localhost:37223/getInfo.html) 15:07:43 INFO - PROCESS | 24514 | __metrics Screen width/height:1600/1200 15:07:43 INFO - PROCESS | 24514 | colorDepth:24 15:07:43 INFO - PROCESS | 24514 | Browser inner width/height: 1024/697 15:07:43 INFO - PROCESS | 24514 | __metrics 15:07:43 ERROR - PROCESS | 24514 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 15:07:44 INFO - TEST-INFO | 24514: exit 0 15:07:44 INFO - Browser initialized. 15:07:44 INFO - Running cycle 1/1 for kraken test... 15:07:44 INFO - TEST-INFO | started process 24631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK6MYgx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:07:56 INFO - PROCESS | 24631 | RSS: Main: 168222720 15:07:56 INFO - PROCESS | 24631 | 15:07:59 INFO - PROCESS | 24631 | Cycle 1(1): loaded http://localhost:37223/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37223/tests/kraken/driver.html?testName=audio-beat-detection) 15:08:00 INFO - PROCESS | 24631 | RSS: Main: 173113344 15:08:00 INFO - PROCESS | 24631 | 15:08:03 INFO - PROCESS | 24631 | Cycle 1(1): loaded http://localhost:37223/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37223/tests/kraken/driver.html?testName=audio-dft) 15:08:03 INFO - PROCESS | 24631 | RSS: Main: 172879872 15:08:03 INFO - PROCESS | 24631 | 15:08:06 INFO - PROCESS | 24631 | Cycle 1(1): loaded http://localhost:37223/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37223/tests/kraken/driver.html?testName=audio-fft) 15:08:07 INFO - PROCESS | 24631 | RSS: Main: 167645184 15:08:07 INFO - PROCESS | 24631 | 15:08:09 INFO - PROCESS | 24631 | Cycle 1(1): loaded http://localhost:37223/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37223/tests/kraken/driver.html?testName=audio-oscillator) 15:08:10 INFO - PROCESS | 24631 | RSS: Main: 168300544 15:08:10 INFO - PROCESS | 24631 | 15:08:12 INFO - PROCESS | 24631 | Cycle 1(1): loaded http://localhost:37223/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37223/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:08:13 INFO - PROCESS | 24631 | RSS: Main: 168734720 15:08:13 INFO - PROCESS | 24631 | 15:08:16 INFO - PROCESS | 24631 | Cycle 1(1): loaded http://localhost:37223/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37223/tests/kraken/driver.html?testName=imaging-darkroom) 15:08:16 INFO - PROCESS | 24631 | RSS: Main: 169041920 15:08:16 INFO - PROCESS | 24631 | 15:08:20 INFO - PROCESS | 24631 | Cycle 1(1): loaded http://localhost:37223/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37223/tests/kraken/driver.html?testName=imaging-desaturate) 15:08:21 INFO - PROCESS | 24631 | RSS: Main: 166768640 15:08:21 INFO - PROCESS | 24631 | 15:08:24 INFO - PROCESS | 24631 | Cycle 1(1): loaded http://localhost:37223/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37223/tests/kraken/driver.html?testName=json-parse-financial) 15:08:24 INFO - PROCESS | 24631 | RSS: Main: 168558592 15:08:24 INFO - PROCESS | 24631 | 15:08:26 INFO - PROCESS | 24631 | Cycle 1(1): loaded http://localhost:37223/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37223/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:08:27 INFO - PROCESS | 24631 | RSS: Main: 169172992 15:08:27 INFO - PROCESS | 24631 | 15:08:28 INFO - PROCESS | 24631 | Cycle 1(1): loaded http://localhost:37223/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37223/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:08:29 INFO - PROCESS | 24631 | RSS: Main: 169447424 15:08:29 INFO - PROCESS | 24631 | 15:08:31 INFO - PROCESS | 24631 | Cycle 1(1): loaded http://localhost:37223/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37223/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:08:32 INFO - PROCESS | 24631 | RSS: Main: 169517056 15:08:32 INFO - PROCESS | 24631 | 15:08:35 INFO - PROCESS | 24631 | Cycle 1(1): loaded http://localhost:37223/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:08:36 INFO - PROCESS | 24631 | RSS: Main: 169394176 15:08:36 INFO - PROCESS | 24631 | 15:08:38 INFO - PROCESS | 24631 | Cycle 1(1): loaded http://localhost:37223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:08:39 INFO - PROCESS | 24631 | RSS: Main: 169365504 15:08:39 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | Cycle 1(1): loaded http://localhost:37223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37223/tests/kraken/driver.html?testName=ai-astar) 15:08:41 INFO - PROCESS | 24631 | RSS: Main: 169893888 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | __start_tp_report 15:08:41 INFO - PROCESS | 24631 | _x_x_mozilla_page_load 15:08:41 INFO - PROCESS | 24631 | _x_x_mozilla_page_load_details 15:08:41 INFO - PROCESS | 24631 | |i|pagename|runs| 15:08:41 INFO - PROCESS | 24631 | |0;ai-astar;115;111;117;114;116;115;115;113;112;114 15:08:41 INFO - PROCESS | 24631 | |1;audio-beat-detection;166;133;155;189;147;164;160;134;188;142 15:08:41 INFO - PROCESS | 24631 | |2;audio-dft;165;163;167;167;163;165;165;165;163;162 15:08:41 INFO - PROCESS | 24631 | |3;audio-fft;77;77;77;159;78;76;77;75;161;76 15:08:41 INFO - PROCESS | 24631 | |4;audio-oscillator;87;86;159;88;86;86;142;85;87;136 15:08:41 INFO - PROCESS | 24631 | |5;imaging-gaussian-blur;117;118;119;117;118;117;118;118;120;117 15:08:41 INFO - PROCESS | 24631 | |6;imaging-darkroom;149;150;147;148;148;147;148;147;148;148 15:08:41 INFO - PROCESS | 24631 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;96 15:08:41 INFO - PROCESS | 24631 | |8;json-parse-financial;63;63;64;64;65;65;65;65;65;65 15:08:41 INFO - PROCESS | 24631 | |9;json-stringify-tinderbox;65;66;65;65;65;65;66;65;66;65 15:08:41 INFO - PROCESS | 24631 | |10;stanford-crypto-aes;85;91;88;84;86;86;93;85;121;88 15:08:41 INFO - PROCESS | 24631 | |11;stanford-crypto-ccm;143;136;140;149;139;148;131;136;135;137 15:08:41 INFO - PROCESS | 24631 | |12;stanford-crypto-pbkdf2;170;172;172;171;175;174;172;169;169;169 15:08:41 INFO - PROCESS | 24631 | |13;stanford-crypto-sha256-iterative;73;67;67;68;69;67;65;67;67;66 15:08:41 INFO - PROCESS | 24631 | __end_tp_report 15:08:41 INFO - PROCESS | 24631 | __start_cc_report 15:08:41 INFO - PROCESS | 24631 | _x_x_mozilla_cycle_collect,977 15:08:41 INFO - PROCESS | 24631 | __end_cc_report 15:08:41 INFO - PROCESS | 24631 | __startTimestamp1465510121548__endTimestamp 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | ------- Summary: start ------- 15:08:41 INFO - PROCESS | 24631 | Number of tests: 14 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:1.81 (1.6%) stddev-sans-first:1.90 15:08:41 INFO - PROCESS | 24631 | Values: 115.0 111.0 117.0 114.0 116.0 115.0 115.0 113.0 112.0 114.0 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | [#1] audio-beat-detection Cycles:10 Average:157.80 Median:162.00 stddev:19.87 (12.3%) stddev-sans-first:20.85 15:08:41 INFO - PROCESS | 24631 | Values: 166.0 133.0 155.0 189.0 147.0 164.0 160.0 134.0 188.0 142.0 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | [#2] audio-dft Cycles:10 Average:164.50 Median:165.00 stddev:1.72 (1.0%) stddev-sans-first:1.81 15:08:41 INFO - PROCESS | 24631 | Values: 165.0 163.0 167.0 167.0 163.0 165.0 165.0 165.0 163.0 162.0 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | [#3] audio-fft Cycles:10 Average:93.30 Median:77.00 stddev:35.17 (45.7%) stddev-sans-first:36.80 15:08:41 INFO - PROCESS | 24631 | Values: 77.0 77.0 77.0 159.0 78.0 76.0 77.0 75.0 161.0 76.0 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:86.00 stddev:29.17 (33.9%) stddev-sans-first:30.27 15:08:41 INFO - PROCESS | 24631 | Values: 87.0 86.0 159.0 88.0 86.0 86.0 142.0 85.0 87.0 136.0 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:1.00 15:08:41 INFO - PROCESS | 24631 | Values: 117.0 118.0 119.0 117.0 118.0 117.0 118.0 118.0 120.0 117.0 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 15:08:41 INFO - PROCESS | 24631 | Values: 149.0 150.0 147.0 148.0 148.0 147.0 148.0 147.0 148.0 148.0 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:08:41 INFO - PROCESS | 24631 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:65.00 stddev:0.84 (1.3%) stddev-sans-first:0.73 15:08:41 INFO - PROCESS | 24631 | Values: 63.0 63.0 64.0 64.0 65.0 65.0 65.0 65.0 65.0 65.0 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 15:08:41 INFO - PROCESS | 24631 | Values: 65.0 66.0 65.0 65.0 65.0 65.0 66.0 65.0 66.0 65.0 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:87.00 stddev:11.02 (12.7%) stddev-sans-first:11.49 15:08:41 INFO - PROCESS | 24631 | Values: 85.0 91.0 88.0 84.0 86.0 86.0 93.0 85.0 121.0 88.0 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:139.50 stddev:5.76 (4.1%) stddev-sans-first:5.96 15:08:41 INFO - PROCESS | 24631 | Values: 143.0 136.0 140.0 149.0 139.0 148.0 131.0 136.0 135.0 137.0 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:172.00 stddev:2.11 (1.2%) stddev-sans-first:2.19 15:08:41 INFO - PROCESS | 24631 | Values: 170.0 172.0 172.0 171.0 175.0 174.0 172.0 169.0 169.0 169.0 15:08:41 INFO - PROCESS | 24631 | 15:08:41 INFO - PROCESS | 24631 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:2.17 (3.2%) stddev-sans-first:1.12 15:08:41 INFO - PROCESS | 24631 | Values: 73.0 67.0 67.0 68.0 69.0 67.0 65.0 67.0 67.0 66.0 15:08:41 INFO - PROCESS | 24631 | -------- Summary: end -------- 15:08:41 INFO - PROCESS | 24631 | 15:08:42 INFO - TEST-INFO | 24631: exit 0 15:08:42 INFO - TEST-OK | kraken | took 64161ms 15:08:42 INFO - SUITE-END | took 1179s 15:08:42 INFO - Completed test suite (00:19:39) 15:08:42 INFO - javascript benchmark 15:08:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6375.906717056049, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2652.0585192256744, 2670.9999999999995, 2678.1563807400667, 2680.8525531095784, 2697.029069534967, 4636.374089497916, 4645.233536466479, 4676.064787042596, 4677.859664210075, 4764.571188593026, 4529.864104076874, 4671.649626278034, 4688.882777930554, 4696.483386827446, 4772.880677983044, 4259.063006138645, 4277.337012763019, 4294.334378171388, 4384.364267181257, 4408.691391602573, 4311.805968731399, 4423.66822488313, 4433.7118087324225, 4464.352668863013, 4475.686701930867, 4193.308104162809, 4308.892277693051, 4321.935170972438, 4373.387725718402, 4390.165868484994, 4239.809208585591, 4279.807408666617, 4288.185244803477, 4308.159908817782, 4317.222899878052, 4279.700420970534, 4303.203907277164, 4303.33298338758, 4318.352247162919, 4349.543297953701, 4559.293309537027, 4610.5389461053965, 4641.767911604406, 4651.023285110131, 4651.465081515601, 5067.189249720064, 5075.720835354054, 5099.847004589831, 5102.36220472441, 5150.0, 5111.948880511184, 5134.589232861362, 5147.485251474823, 5152.613553983429, 5159.380874295071, 4627.282771170474, 4678.883027924261, 4679.859604211879, 4683.601893838993, 4694.319323698079, 5100.6429549931145, 5106.234064890296, 5109.540141387293, 5120.564751996048, 5125.923111153261, 4794.856154315376, 4884.804607815648, 4908.288298196741, 4927.187014142698, 4951.059298733229, 5057.924131138036, 5098.59211263098, 5112.156494178494, 5143.331366922276, 5162.9741851291255, 4893.755312234374, 4911.68074075184, 4947.233178857283, 4976.328195693607, 4982.427020892571, 4934.4572097069295, 4944.505549445027, 4947.90104197914, 4951.034548263126, 4975.651704380659, 4122.505299364096, 4169.228692691801, 4187.288161012635, 4191.8532851350055, 4198.748075115503, 3691.6862066724093, 3693.9815300923324, 3701.2227432239533, 3707.888763337104, 3715.3869611513796, 4335.891602709894, 4445.622122119591, 4447.710898791568, 4461.219286624828, 4467.24056910326, 5042.294078828967, 5123.154679477844, 5124.8206312778875, 5126.2054381570915, 5144.074066668036, 4451.910961780746, 4478.149151661174, 4509.458864936163, 4515.209838278288, 4522.412086428809, 4330.047389574289, 4481.663875209372, 4551.772411379484, 4555.134524440412, 4566.26939689648, 4780.067886762048, 4822.493638168082, 4833.468318484894, 4839.491853355487, 4896.608271338285, 5121.667091639031, 5124.154514505065, 5128.435872054146, 5130.0, 5157.535821776059, 4688.859334219979, 4696.412948381452, 4731.550502702238, 4818.036392721399, 4886.096072226649, 4921.876953076202, 4923.975380123076, 4927.310176575211, 4931.778069986931, 4980.05378977993, 4999.9750051240135, 5001.549860512571, 5001.824936127218, 5004.3494345734825, 5045.066662667418, 4822.0, 4897.681650692693, 4956.529129732669, 4980.9501904981935, 5022.648414611088, 4829.879253018703, 4894.216925291937, 4904.141775189256, 4949.356583644103, 4965.056639238677, 4864.659473836798, 4876.975615121902, 4888.266759986031, 4889.682170658896, 4939.703617782944, 4794.59245964083, 4873.634477414279, 4881.365422495053, 4927.039227350632, 4994.750262486934, 4862.878428039327, 4866.829660961849, 4879.048585525788, 4886.53577910098, 4897.461279259207], "value": 4630.922233178022, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.3184736332304, 565.7369323264681, 584.7982446056109, 588.4233451217805, 605.8485378655337, 35188.12029699256, 39885.80057099714, 40077.0, 40104.19791604166, 40158.0, 41094.79452602741, 41213.0, 41578.0, 41590.37614435778, 41600.16799664005, 7744.574048427348, 7805.37556995439, 7852.803679908019, 7853.842923141534, 7866.763997080068, 7556.47104702671, 7734.883976740353, 7741.148473667892, 7754.224577542257, 7754.7673569793, 7778.599852026633, 7784.844303113934, 7816.53100813953, 7816.609169541529, 7832.373410127205, 7727.4204434667345, 7750.186230445835, 7751.651175697107, 7753.108392534874, 7753.922460775405, 7690.307872291521, 7755.650995705207, 7790.688372465094, 7837.843243135162, 7841.764747057598, 29960.400791984037, 37750.62249377499, 37946.430803537965, 38011.0, 38032.42951355732, 3026.046795259508, 3093.891713790029, 3115.0810510899114, 3187.585613870205, 3242.691944265291, 27151.728482715116, 30237.0, 30376.240593985105, 30429.087127386214, 31289.217769555944, 3506.579210494757, 3559.3262384956906, 3610.288324407336, 3644.1982763791925, 3646.2889736501393, 259208.0, 264879.0, 265516.0, 265646.9999999981, 266410.0, 58583.0, 59246.70376648089, 59513.404865951656, 59538.0, 59699.40300596938, 34334.31331373358, 34954.12614684653, 34959.0, 37443.0, 37573.81213093917, 15985.920070399574, 16071.839281607034, 16112.0, 16154.515364539082, 16201.918990404973, 12180.756384872253, 12325.445354959049, 12341.876581234252, 12346.506139754309, 12389.75220495585, 19792.307269245506, 20094.39716808498, 20141.597168056556, 20145.395638130878, 20260.59478810445, 7287.396772709995, 7523.510971786816, 7529.548227106282, 7535.849283014309, 7579.1662917079075, 832.2717622080679, 852.6887685994691, 908.881845360099, 973.8101070291225, 1000.8198524265703, 27312.590311145348, 27400.725992740216, 27972.0, 27983.300417489318, 28059.57910631342, 958.5590628310915, 976.1946394224793, 995.581855620641, 1004.8743907011624, 1075.983860242097, 14434.711305773826, 14801.925990369979, 14892.851071489364, 15012.62468438276, 15077.54767356981, 379220.0, 381969.0, 382894.0, 386197.0, 387089.0, 50730.0, 51231.74384128056, 51450.0, 51518.22722659163, 51578.74210628923, 1146.0, 1181.8345431639577, 1188.197966372695, 1192.4335940428055, 1200.699825043739, 26598.867005664848, 27226.5916011256, 27393.726062739916, 27532.579020657566, 27654.585181221897, 42059.579404206794, 42599.7870010648, 42604.573954260064, 42754.78622606867, 42840.0, 329670.0, 333945.0, 334911.0, 335431.0, 336224.0, 24275.0, 25906.740932590434, 25988.0, 25991.350216244744, 26011.47977040411, 43614.12771744611, 44320.0, 44370.33444498399, 48190.27714584214, 49157.75421122871, 38218.617813821504, 38370.84887453381, 38543.03642408962, 38763.41854872236, 39758.403623946244, 37019.62980370162, 37515.81242093772, 37639.0, 37774.0, 37868.0, 31543.36913261676, 34716.0, 35087.64912350844, 36301.0, 36872.44691329578, 31691.20771980719, 33595.664043359255, 33680.32639347248, 34094.65905340915, 34207.315853683285, 25778.613320800578, 25862.0, 26168.73831261663, 26313.21060368192, 26616.201513954613], "value": 17768.158927218992, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.30289723450323, 352.8712020112659, 355.8718861209964, 370.09511743786453, 377.2793963529659, 15605.84394156058, 15967.281472333743, 17086.145692715345, 17161.227744751486, 17163.656726865454, 14183.787243191335, 15286.31211595478, 15304.923475382608, 15311.0, 15335.69328613427, 4810.086083644105, 5059.4181669107975, 5374.193870919355, 5389.0, 5462.7268636568215, 4921.507849215068, 5255.684658920458, 5356.651817631841, 5375.247465354853, 5390.434004429537, 5289.100852855024, 5289.603279754015, 5296.708681022542, 5329.280547126146, 5336.919946200791, 5249.527542521172, 5605.523530499892, 5613.07384281593, 5622.381538030834, 5646.20953066571, 5232.73836308183, 5397.055515284848, 5413.810516631938, 5445.9727701361635, 5449.700266485342, 12280.201786883914, 12355.38223088851, 12399.25604463726, 12490.188137771107, 12503.374831258401, 1799.8290162434678, 1846.9907650461796, 1858.7955324914249, 1879.7462342583713, 1930.845532357408, 8906.198442140174, 9118.316126290554, 9310.068993100704, 11654.941725291319, 11991.220570662967, 1699.7167138810244, 1708.470374184007, 1714.9657006859918, 1734.2889415339775, 1752.2264139659724, 65222.0, 69118.65440672764, 69870.0, 70612.0, 71016.28983710149, 9998.80014398277, 10137.695869123938, 10181.083702466814, 10223.079922806983, 10385.0, 13894.027418080637, 13963.232022238875, 13986.090904091201, 13986.230757308242, 13990.0, 7371.631418429057, 7381.335679788845, 7449.664765085584, 7491.213422590658, 7562.621868906533, 6969.47728920333, 7086.078809754699, 7192.3886469649615, 7217.350438460564, 7218.314260145278, 4223.831046758157, 4321.546237645065, 4353.608175264241, 4358.4769827620885, 4427.313766366218, 1779.395005698043, 1794.23744908416, 1861.2741030997922, 1865.8973756443527, 1875.9062046897873, 853.8804567360575, 878.1218781218781, 893.2362829780574, 911.6262332443666, 962.8748262725801, 16147.273372698257, 16232.107234102, 16466.83533164677, 16668.58328541796, 17183.656326873643, 814.2752949874616, 884.6947803007952, 895.3240303570763, 920.2316066084894, 936.321167153808, 9373.765655858659, 9379.437233765859, 9543.0, 9573.090556397132, 9695.757606059764, 354296.0, 354950.0, 356137.0, 356213.0, 367202.0, 60067.0, 70377.0, 75919.62040189764, 78270.21729782743, 78862.60568697234, 909.1999040844015, 918.4581097152712, 922.6816748221987, 934.4019827310527, 941.228192881844, 15480.303386347867, 15480.5355839325, 15541.0, 15606.765898511305, 16024.0, 25433.10984115547, 33075.0, 35186.824065879504, 35989.92030239097, 36639.816800915825, 47309.52690473051, 48695.5130448691, 49362.0, 49939.50060499348, 50750.49249507458, 6927.549709268881, 7001.509894307554, 7068.964655176691, 7096.787096387116, 7247.4926755126635, 7913.9604301978125, 10142.797144056929, 10609.9469502652, 10676.14590832716, 10760.246782725135, 9091.727248182566, 9154.771130721785, 9266.351355405326, 9466.621335146518, 9588.520573971413, 10221.642242521477, 10330.0, 10426.530806113591, 10435.426051566934, 10450.372977621368, 10074.496275186064, 10344.27590068688, 10346.37921724699, 10380.688579342632, 10474.319169253975, 7582.469227154046, 7611.3530349920875, 7826.373890088893, 7850.921490785019, 7883.64523596451, 9413.717588472357, 9468.431894086378, 9964.402135871871, 9992.700218993441, 10232.283740138118], "value": 7966.731321142501, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.595567285487, 1444.010852565992, 1502.932368043438, 1666.5167101540553, 1692.568395059259, 6695.56478828877, 7428.480006399554, 7590.468667193299, 8258.669653213872, 8270.090290068096, 7451.068616422947, 7734.38124950004, 7810.609469526529, 7827.099883513398, 7829.6085195740125, 2109.5886302171084, 2148.4521447030984, 2155.2564365293947, 2156.148321413049, 2159.654455287154, 2149.8602590831624, 2174.608570457317, 2184.541246338271, 2184.6941428200066, 2187.529681118559, 2130.9041093150845, 2131.2221039320693, 2144.238795227695, 2148.5380643161716, 2153.12798316682, 2127.2767259131892, 2128.2444732120107, 2131.3179782469615, 2132.296342207068, 2135.220644464759, 2026.0578830843729, 2094.968575471369, 2108.692610581449, 2117.12139462123, 2121.480237341861, 7703.8844417333785, 7713.498622589514, 7741.109772376192, 7742.187070357644, 7798.688052477894, 4459.910801783979, 4579.656525760548, 4582.152301824173, 4589.632829373675, 4591.035882464653, 2772.5286701260834, 2889.3787835615235, 2898.4927637663536, 2913.5775312579767, 2922.576226447153, 895.6999405199201, 914.6935776514875, 943.2595412601075, 946.8106378724214, 946.9431834089977, 10641.201909856793, 10716.249862509549, 10752.139828813755, 10778.299410538368, 10792.73018174544, 3996.260691771973, 4056.087380339459, 4118.19695159447, 4121.732087414309, 4160.771157586301, 9137.817243655223, 9209.309301802257, 9239.353245272901, 9252.398594091363, 9294.163525282622, 4592.242280023758, 4626.352310676508, 4636.258198688193, 4646.3495110684535, 4681.485036645966, 3451.3787518246454, 4024.9597504024587, 4123.299039163349, 4234.957650423518, 4250.596193361687, 3605.441156620728, 3641.344557979589, 3708.0915175781565, 3741.663250307485, 3764.79293638847, 1115.7378016166194, 1151.9078473722082, 1153.1870031627682, 1156.1213477756964, 1156.306216270248, 694.5589550635282, 749.6663984526942, 800.7077416742846, 889.106448019749, 891.3136884598823, 5162.225666150108, 5187.740612969412, 5409.945900540944, 5592.5805564582815, 5635.408282130399, 877.8332116897897, 882.7572417585216, 894.4052205283414, 907.0385391485047, 918.7550868573121, 3589.802560859178, 3652.4886515887797, 3671.4859919611276, 3851.094992676719, 3932.941005884914, 9481.241500680067, 9665.371750836173, 9851.655192068387, 9857.75355616101, 9860.359076659994, 9613.615455381707, 9682.854757178648, 9683.9031609683, 9712.3201375903, 9722.076402741728, 7038.718451261994, 7329.083864516935, 7337.486375953738, 7411.110666720028, 7513.436492263102, 5110.9233361500355, 5323.414424413389, 5434.157705555645, 5442.727863606883, 5491.341039075336, 9000.099990000948, 9148.63405463774, 9155.725328240163, 9173.220276276325, 9175.587098580714, 8706.869396958924, 8930.73207803741, 8993.730188094367, 9144.817103657757, 9223.677171299241, 5928.258967629046, 6659.833504162241, 6801.863962720817, 6896.931030689629, 7073.1865835427525, 7494.3629791466155, 7494.400447964259, 7553.093628764584, 7604.809879752829, 7605.391568674382, 6733.730650773914, 6747.696353663999, 6758.7296508139125, 6913.654317284217, 7096.396806271318, 6663.100481435138, 6705.798826035227, 6790.32096790317, 6833.521653484208, 7047.894281585883, 6061.6666083365835, 6064.818055458343, 6120.173776540289, 6132.325444201045, 6177.505799536116, 4528.117017181618, 4644.2801365788355, 4657.091867086021, 4742.5731684148595, 4751.7861696224445, 4596.862094137181, 4621.768911554476, 4639.0721855628335, 4686.625069994324, 4728.763561821964], "value": 4144.910722794442, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.7136014225277, 277.38697478572357, 278.17105027019477, 283.14772534670635, 284.63708771316556, 4937.259411088334, 4994.67534610251, 4999.150314383679, 5007.599392048636, 5011.248312753089, 4861.878453038676, 4867.707937523751, 4877.585405240558, 4904.828331008406, 4905.288733133693, 3583.910402239945, 3673.540807399075, 3752.099496120925, 3775.4903088083033, 3786.2238241160635, 3782.149016471286, 3782.243551289739, 3787.7159213058994, 3805.0867791729925, 3807.276617442677, 3760.736748427611, 3762.341590221714, 3775.924481510368, 3789.071677439031, 3796.3925771876507, 3506.68439840413, 3714.294284086042, 3786.3941769316775, 3789.5073640426845, 3812.542494900602, 3209.8876539321245, 3214.8553315100876, 3225.5646986525257, 3227.564278822376, 3259.559959405474, 4715.528447155291, 4720.693154944952, 4726.747411935839, 4728.598069164125, 4754.738489383082, 4275.183047204925, 4275.40144379787, 4283.250431174563, 4306.590873867009, 4325.632321252666, 5024.19612861944, 5084.618653600995, 5093.0, 5106.719130447824, 5106.872328191825, 3539.185987222953, 3539.787612743218, 3545.2732189901008, 3560.537130173061, 3561.893143205708, 5396.271503347037, 5410.702411367373, 5417.891642167174, 5418.729063546846, 5425.267588875491, 3367.8821241256437, 3568.125809176768, 3576.678098971105, 3605.7295702822394, 3613.9638603614153, 3565.607783143852, 3589.4615807629066, 3594.155373487228, 3626.5104210931713, 3640.344737947195, 4192.140611174702, 4195.04930207455, 4204.70567060309, 4206.095689426788, 4223.282042052859, 5059.19052951526, 5139.897202056013, 5153.5361817436615, 5174.870628234249, 5179.559737422362, 1256.6921104329315, 1258.4022589270023, 1263.25467973894, 1264.5890085722176, 1265.544404014554, 772.8879312499769, 779.5478622399108, 792.2552800367636, 802.5987006496752, 806.137432946753, 4509.1658043262105, 4559.54404559548, 4579.702319349231, 4580.862574122782, 4593.150267200579, 5331.600129990266, 5338.359396872323, 5345.679259244458, 5346.0, 5371.57027437804, 4396.230659634552, 4553.977230113828, 4613.146567884952, 4615.146197953322, 4653.325267836212, 2760.544510155842, 2811.8594070296404, 2818.8167769094944, 2822.8849604406146, 2864.496139526765, 4969.527894849984, 5012.7994880205115, 5016.297718319438, 5046.192609182586, 5059.696418214919, 5210.505002024802, 5330.307060082165, 5349.251104845324, 5367.731613419313, 5526.834194974157, 5012.699238045729, 5029.371328584, 5056.84829455117, 5073.441921388644, 5080.517350851663, 5296.655717378358, 5337.0, 5338.572914166935, 5375.650582712111, 5445.264889239902, 5163.199704045879, 5230.8169214077325, 5260.842174734764, 5292.894142117213, 5312.787488500571, 5096.745162741922, 5100.0, 5126.615503837153, 5135.512126347991, 5136.512031357015, 3583.674040604993, 3645.744797864124, 3668.2846844864994, 3671.0, 3671.9082022948573, 5085.262636917701, 5309.283246761792, 5312.601554883322, 5352.260515332455, 5416.891662166813, 5164.715940623151, 5175.715335656575, 5201.219817027476, 5238.476152384731, 5239.869003274948, 5178.792848286026, 5181.248718935809, 5185.936882939064, 5200.479952004769, 5212.947870521246, 4905.5094490550655, 5127.589912774017, 5144.536991670768, 5153.433122356612, 5156.587473002226, 4999.350084488993, 5079.746012699424, 5193.350831146106, 5198.636095473281, 5252.947470525246, 5062.0, 5068.163752980864, 5074.238864170256, 5107.6169287302855, 5123.538881500683], "value": 3833.599402002471, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.2181827261608, 639.9840003999902, 722.5484072454716, 727.7125535413512, 759.589821496392, 12686.365681715912, 13164.210147391163, 13167.670808229786, 13206.405711742971, 13327.933360333209, 14401.13593184407, 14573.92713036436, 15056.473023444181, 15091.471798487055, 15107.848921510782, 616.134331264574, 795.2802713544252, 811.5658122904248, 818.8607936650753, 819.0171793847377, 778.8247644280049, 803.5821372886096, 804.4811096842533, 805.5086397297644, 808.9474184178039, 820.8932838730957, 830.8172202115525, 833.3832963606917, 833.754042557444, 835.064727505195, 824.542378979669, 828.8300898315831, 828.958552072397, 832.0680837462021, 832.966681332752, 607.2257871214238, 608.7260732670316, 609.9329073801878, 611.6849822341497, 611.7705860302386, 12983.09118361715, 13027.869721302855, 13038.478460861648, 13071.673208169777, 13080.934595326962, 13591.864081359257, 13997.370118344597, 14004.579862604138, 14127.293635318192, 14205.076670016417, 10511.52698128586, 10516.158707303473, 10523.579056837718, 10617.150627949746, 10758.892411075945, 3444.225049363898, 3455.1534873956043, 3455.3953058214965, 3456.844442000091, 3508.701760350373, 63306.683466582836, 64053.35946640521, 64580.67709661469, 65616.67191664058, 66045.00932486016, 10345.394818828401, 10407.843882341771, 10412.68761937143, 10465.9476702616, 10529.105026072717, 20528.692069618966, 20549.075291611913, 20567.4858128545, 20595.279165229145, 20831.270905518235, 7073.292670732885, 7095.467839912028, 7107.680154393065, 7141.678624461912, 7161.498695091398, 3748.9437658435145, 3895.0, 3908.2378936107752, 3908.6677632400997, 3923.6861051115843, 2908.2438565972575, 3012.9246768830517, 3021.56187352837, 3025.8184508929535, 3041.4373340931998, 462.07354254719075, 478.38288607696376, 491.9016196760662, 494.98267560635924, 496.07234471538453, 570.8087790590116, 587.5487151081153, 594.2037669522861, 597.5518361229078, 611.2939554814196, 8231.42380033392, 8444.113368096261, 8481.236688698047, 8494.235518803338, 8708.869366959501, 566.8809549994464, 575.2722805650855, 578.6094386289238, 590.1413443439785, 609.0863704443335, 3788.6590206881515, 3965.504311961005, 3983.123712783241, 4052.8176232069627, 4091.5294741105154, 95416.52291738497, 100822.0, 101720.33656802592, 102824.48587757163, 103107.0, 38548.42177367342, 48855.26717099246, 49892.25161622579, 50057.74971125194, 50889.0, 78530.6073469629, 79707.60146199347, 79940.60029699931, 80259.17149113593, 80327.59836200898, 7711.421643376882, 7724.536527808349, 7929.484583502284, 7943.046834379911, 7970.442069055111, 48069.0, 48259.03481930272, 48697.0, 49123.26315105348, 49432.50567494279, 35409.82295088611, 36191.81904090463, 36563.45154822733, 55469.0, 71348.0, 9998.750031249278, 10156.39061656303, 10388.37669739818, 10443.634472793416, 10700.732481687708, 11250.887491124984, 11494.540218391505, 11582.71043223926, 11587.42062896835, 11955.103367247317, 10893.291936024134, 10915.672529824118, 11145.665630031112, 11256.437178141225, 11420.543178272776, 11033.613823516138, 11182.161337899854, 11299.603322361503, 11315.20793544444, 11434.19960602783, 10226.335288206243, 10345.844812327972, 10362.274640775375, 10807.13542916549, 11141.387223702774, 8825.823483530421, 9050.728478145666, 9162.633494660138, 9356.251499879858, 9447.102525260088, 8658.78353041179, 8888.33337499703, 9012.143846334588, 9029.729108126767, 9032.548372581214], "value": 6448.968987868128, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 117.0, 114.0, 116.0, 115.0, 115.0, 113.0, 112.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 133.0, 155.0, 189.0, 147.0, 164.0, 160.0, 134.0, 188.0, 142.0], "value": 157.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 167.0, 167.0, 163.0, 165.0, 165.0, 165.0, 163.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 159.0, 78.0, 76.0, 77.0, 75.0, 161.0, 76.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 159.0, 88.0, 86.0, 86.0, 142.0, 85.0, 87.0, 136.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 119.0, 117.0, 118.0, 117.0, 118.0, 118.0, 120.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 91.0, 88.0, 84.0, 86.0, 86.0, 93.0, 85.0, 121.0, 88.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 136.0, 140.0, 149.0, 139.0, 148.0, 131.0, 136.0, 135.0, 137.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 172.0, 171.0, 175.0, 174.0, 172.0, 169.0, 169.0, 169.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 67.0, 67.0, 68.0, 69.0, 67.0, 65.0, 67.0, 67.0, 66.0], "value": 67.6, "unit": "score"}]}]} 15:08:42 INFO - Return code: 0 15:08:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:08:42 ERROR - # TBPL SUCCESS # 15:08:42 INFO - Running post-action listener: _resource_record_post_action 15:08:42 INFO - ##### 15:08:42 INFO - ##### Finished run-tests step (success) 15:08:42 INFO - ##### 15:08:42 INFO - Running post-run listener: _resource_record_post_run 15:08:42 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 525217792; Read time: 12; Write time: 590232 15:08:42 INFO - TinderboxPrint: CPU usage
13.4% 15:08:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:08:42 INFO - TinderboxPrint: I/O write bytes / time
525,217,792 / 590,232 15:08:42 INFO - TinderboxPrint: CPU idle
8,267.4 (86.5%) 15:08:42 INFO - TinderboxPrint: CPU user
1,228.9 (12.9%) 15:08:42 INFO - TinderboxPrint: Swap in / out
0 / 0 15:08:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238084096; Read time: 0; Write time: 401736 15:08:42 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286547968; Read time: 12; Write time: 188108 15:08:43 INFO - Running post-run listener: _upload_blobber_files 15:08:43 INFO - Blob upload gear active. 15:08:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:08:43 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 15:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:08:43 INFO - (blobuploader) - INFO - Open directory for files ... 15:08:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:08:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:08:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:47 INFO - (blobuploader) - INFO - Done attempting. 15:08:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:08:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:08:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:48 INFO - (blobuploader) - INFO - Done attempting. 15:08:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:08:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:08:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:49 INFO - (blobuploader) - INFO - Done attempting. 15:08:49 INFO - (blobuploader) - INFO - Iteration through files over. 15:08:49 INFO - Return code: 0 15:08:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:08:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:08:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4f28145eb892b683b9455c39332c4540b11f6bf9968073ba1addd88e5b45cf6f1008bf8f19935470d3944ff6f38ae82eb1f6964aae2d19071fbb03b000d6e351", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0cac6273fa5a6573396f99ea51d8dbab24f7090878e86e4e291847ce20237de34af180a65a2e4c7c641959d5fb438a146eed9d17b5326fca3b089a625c054b4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/41a11ca6ad4d06982831e7153b4b48b4a2cd215211c17ab7dcb2d03e5ba93243603802aa0baf9f4c830d0c0941577236f0d7f665209fb535dbf5d892648472b8"} 15:08:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:08:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:08:49 INFO - Contents: 15:08:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4f28145eb892b683b9455c39332c4540b11f6bf9968073ba1addd88e5b45cf6f1008bf8f19935470d3944ff6f38ae82eb1f6964aae2d19071fbb03b000d6e351", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0cac6273fa5a6573396f99ea51d8dbab24f7090878e86e4e291847ce20237de34af180a65a2e4c7c641959d5fb438a146eed9d17b5326fca3b089a625c054b4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/41a11ca6ad4d06982831e7153b4b48b4a2cd215211c17ab7dcb2d03e5ba93243603802aa0baf9f4c830d0c0941577236f0d7f665209fb535dbf5d892648472b8"} 15:08:49 INFO - Running post-run listener: copy_logs_to_upload_dir 15:08:49 INFO - Copying logs to upload dir... 15:08:49 INFO - mkdir: /builds/slave/test/build/upload/logs 15:08:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.847557 ========= master_lag: 0.54 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-09 15:08:49.259337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 15:08:49.262719) ========= 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=32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4f28145eb892b683b9455c39332c4540b11f6bf9968073ba1addd88e5b45cf6f1008bf8f19935470d3944ff6f38ae82eb1f6964aae2d19071fbb03b000d6e351", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0cac6273fa5a6573396f99ea51d8dbab24f7090878e86e4e291847ce20237de34af180a65a2e4c7c641959d5fb438a146eed9d17b5326fca3b089a625c054b4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/41a11ca6ad4d06982831e7153b4b48b4a2cd215211c17ab7dcb2d03e5ba93243603802aa0baf9f4c830d0c0941577236f0d7f665209fb535dbf5d892648472b8"} build_url:https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010365 build_url: 'https://queue.taskcluster.net/v1/task/GeaLcsf7RouQ4y3_QoyVrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4f28145eb892b683b9455c39332c4540b11f6bf9968073ba1addd88e5b45cf6f1008bf8f19935470d3944ff6f38ae82eb1f6964aae2d19071fbb03b000d6e351", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0cac6273fa5a6573396f99ea51d8dbab24f7090878e86e4e291847ce20237de34af180a65a2e4c7c641959d5fb438a146eed9d17b5326fca3b089a625c054b4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/41a11ca6ad4d06982831e7153b4b48b4a2cd215211c17ab7dcb2d03e5ba93243603802aa0baf9f4c830d0c0941577236f0d7f665209fb535dbf5d892648472b8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 15:08:49.288673) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 15:08:49.289073) ========= 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=32c5991c409366f7fec8a718000001d2-1465508888.372451-1134940505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.31 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 15:08:49.607862) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 15:08:49.608261) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 15:08:49.608647) ========= ========= Total master_lag: 0.94 =========