builder: larch_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1465013132.83 results: success (0) buildid: 20160603183004 builduid: b93ce3cff5bb4e859dac7e972975ca6a revision: 07dd3ddb164c04fe57db45301de69eb3d387eab8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 21:05:32.830757) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 21:05:32.831288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 21:05:32.831644) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 21:05:32.893285) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 21:05:32.893620) ========= 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=db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 21:05:33-- 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% 46.5M=0s 2016-06-03 21:05:33 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150670 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 21:05:33.062835) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 21:05:33.063171) ========= 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=db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020062 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 21:05:33.114120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 21:05:33.114506) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 07dd3ddb164c04fe57db45301de69eb3d387eab8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 07dd3ddb164c04fe57db45301de69eb3d387eab8 --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=db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 21:05:33,329 truncating revision to first 12 chars 2016-06-03 21:05:33,329 Setting DEBUG logging. 2016-06-03 21:05:33,329 attempt 1/10 2016-06-03 21:05:33,329 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/07dd3ddb164c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 21:05:34,316 unpacking tar archive at: larch-07dd3ddb164c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.336863 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 21:05:34.465795) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 21:05:34.466169) ========= script_repo_revision: 07dd3ddb164c04fe57db45301de69eb3d387eab8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 21:05:34.466668) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 21:05:34.467005) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 21:05:34.475915) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-03 21:05:34.476232) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 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', 'Larch', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] 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=db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:05:34 INFO - MultiFileLogger online at 20160603 21:05:34 in /builds/slave/test 21:05:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 21:05:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:05:34 INFO - {'append_to_log': False, 21:05:34 INFO - 'base_work_dir': '/builds/slave/test', 21:05:34 INFO - 'blob_upload_branch': 'Larch', 21:05:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:05:34 INFO - 'branch': 'Larch', 21:05:34 INFO - 'buildbot_json_path': 'buildprops.json', 21:05:34 INFO - 'config_files': ('talos/linux_config.py',), 21:05:34 INFO - 'default_actions': ('clobber', 21:05:34 INFO - 'read-buildbot-config', 21:05:34 INFO - 'download-and-extract', 21:05:34 INFO - 'populate-webroot', 21:05:34 INFO - 'create-virtualenv', 21:05:34 INFO - 'install', 21:05:34 INFO - 'run-tests'), 21:05:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:05:34 INFO - 'download_minidump_stackwalk': True, 21:05:34 INFO - 'download_symbols': 'ondemand', 21:05:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:05:34 INFO - 'tooltool.py': '/tools/tooltool.py', 21:05:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:05:34 INFO - '/tools/misc-python/virtualenv.py')}, 21:05:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:05:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:05:34 INFO - 'installer_path': 'installer.exe', 21:05:34 INFO - 'log_level': 'info', 21:05:34 INFO - 'log_name': 'talos', 21:05:34 INFO - 'log_to_console': True, 21:05:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:05:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:05:34 INFO - 'opt_config_files': (), 21:05:34 INFO - 'pip_index': False, 21:05:34 INFO - 'sps_profile': False, 21:05:34 INFO - 'sps_profile_interval': 0, 21:05:34 INFO - 'suite': 'dromaeojs-e10s', 21:05:34 INFO - 'system_bits': '32', 21:05:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:05:34 INFO - 'title': 'talos-linux64-ix-031', 21:05:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:05:34 INFO - 'use_talos_json': True, 21:05:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:05:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:05:34 INFO - 'work_dir': 'build'} 21:05:34 INFO - ##### 21:05:34 INFO - ##### Running clobber step. 21:05:34 INFO - ##### 21:05:34 INFO - Running pre-action listener: _resource_record_pre_action 21:05:34 INFO - Running main action method: clobber 21:05:34 INFO - rmtree: /builds/slave/test/build 21:05:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:05:35 INFO - Running post-action listener: _resource_record_post_action 21:05:35 INFO - ##### 21:05:35 INFO - ##### Finished clobber step (success) 21:05:35 INFO - ##### 21:05:35 INFO - ##### 21:05:35 INFO - ##### Running read-buildbot-config step. 21:05:35 INFO - ##### 21:05:35 INFO - Running pre-action listener: _resource_record_pre_action 21:05:35 INFO - Running main action method: read_buildbot_config 21:05:35 INFO - Using buildbot properties: 21:05:35 INFO - { 21:05:35 INFO - "project": "", 21:05:35 INFO - "product": "firefox", 21:05:35 INFO - "script_repo_revision": "production", 21:05:35 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs-e10s", 21:05:35 INFO - "repository": "", 21:05:35 INFO - "buildername": "Ubuntu HW 12.04 x64 larch pgo talos dromaeojs-e10s", 21:05:35 INFO - "buildid": "20160603183004", 21:05:35 INFO - "pgo_build": "True", 21:05:35 INFO - "basedir": "/builds/slave/test", 21:05:35 INFO - "buildnumber": 4, 21:05:35 INFO - "slavename": "talos-linux64-ix-031", 21:05:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:05:35 INFO - "platform": "ubuntu64_hw", 21:05:35 INFO - "scheduler": "tests-larch-linux64-pgo-talos", 21:05:35 INFO - "branch": "larch", 21:05:35 INFO - "repo_path": "projects/larch", 21:05:35 INFO - "revision": "07dd3ddb164c04fe57db45301de69eb3d387eab8", 21:05:35 INFO - "stage_platform": "linux64-pgo", 21:05:35 INFO - "builduid": "b93ce3cff5bb4e859dac7e972975ca6a", 21:05:35 INFO - "slavebuilddir": "test" 21:05:35 INFO - } 21:05:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 21:05:35 INFO - Running post-action listener: _resource_record_post_action 21:05:35 INFO - ##### 21:05:35 INFO - ##### Finished read-buildbot-config step (success) 21:05:35 INFO - ##### 21:05:35 INFO - ##### 21:05:35 INFO - ##### Running download-and-extract step. 21:05:35 INFO - ##### 21:05:35 INFO - Running pre-action listener: _resource_record_pre_action 21:05:35 INFO - Running main action method: download_and_extract 21:05:35 INFO - mkdir: /builds/slave/test/build/tests 21:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:35 INFO - https://queue.taskcluster.net/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:05:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:05:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:05:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:05:40 INFO - Downloaded 1361 bytes. 21:05:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:05:40 INFO - Using the following test package requirements: 21:05:40 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:05:40 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:05:40 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:05:40 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:40 INFO - u'jsshell-linux-x86_64.zip'], 21:05:40 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:05:40 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:05:40 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:05:40 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:05:40 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:05:40 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:05:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:40 INFO - https://queue.taskcluster.net/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:05:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:05:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:05:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:05:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:05:42 INFO - Downloaded 24441713 bytes. 21:05:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:05:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:05:43 INFO - Return code: 0 21:05:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:43 INFO - https://queue.taskcluster.net/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:05:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:05:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:05:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:05:44 INFO - Downloaded 24441713 bytes. 21:05:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:05:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:05:45 INFO - Return code: 0 21:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:45 INFO - https://queue.taskcluster.net/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:05:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:05:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:05:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:05:46 INFO - Downloaded 10833377 bytes. 21:05:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:05:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:05:47 INFO - Return code: 0 21:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:47 INFO - https://queue.taskcluster.net/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:05:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:05:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:05:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:05:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:05:48 INFO - Downloaded 59209784 bytes. 21:05:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:05:48 INFO - mkdir: /builds/slave/test/properties 21:05:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:05:48 INFO - Writing to file /builds/slave/test/properties/build_url 21:05:48 INFO - Contents: 21:05:48 INFO - build_url:https://queue.taskcluster.net/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:05:49 INFO - Running post-action listener: _resource_record_post_action 21:05:49 INFO - Running post-action listener: set_extra_try_arguments 21:05:49 INFO - ##### 21:05:49 INFO - ##### Finished download-and-extract step (success) 21:05:49 INFO - ##### 21:05:49 INFO - ##### 21:05:49 INFO - ##### Running populate-webroot step. 21:05:49 INFO - ##### 21:05:49 INFO - Running pre-action listener: _resource_record_pre_action 21:05:49 INFO - Running main action method: populate_webroot 21:05:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:05:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:05:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:05:49 INFO - '--tppagecycles', 21:05:49 INFO - '7'], 21:05:49 INFO - 'tests': ['tsvgm']}}, 21:05:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:05:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:05:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:05:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:05:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:05:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:05:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:49 INFO - 'talos_options': ['--disable-e10s'], 21:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:05:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:05:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:49 INFO - 'talos_options': ['--disable-e10s'], 21:05:49 INFO - 'tests': ['damp', 'tps']}, 21:05:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:49 INFO - 'tests': ['damp', 'tps']}, 21:05:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:05:49 INFO - 'tests': ['dromaeo_dom']}, 21:05:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:05:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:05:49 INFO - 'tests': ['a11yr', 21:05:49 INFO - 'ts_paint', 21:05:49 INFO - 'tpaint', 21:05:49 INFO - 'sessionrestore', 21:05:49 INFO - 'sessionrestore_no_auto_restore', 21:05:49 INFO - 'tabpaint']}, 21:05:49 INFO - 'other-e10s': {'tests': ['a11yr', 21:05:49 INFO - 'ts_paint', 21:05:49 INFO - 'tpaint', 21:05:49 INFO - 'sessionrestore', 21:05:49 INFO - 'sessionrestore_no_auto_restore', 21:05:49 INFO - 'tabpaint']}, 21:05:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:05:49 INFO - 'ts_paint', 21:05:49 INFO - 'tpaint', 21:05:49 INFO - 'sessionrestore', 21:05:49 INFO - 'sessionrestore_no_auto_restore', 21:05:49 INFO - 'tabpaint']}, 21:05:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:05:49 INFO - 'ts_paint', 21:05:49 INFO - 'tpaint', 21:05:49 INFO - 'sessionrestore', 21:05:49 INFO - 'sessionrestore_no_auto_restore', 21:05:49 INFO - 'tabpaint']}, 21:05:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:05:49 INFO - 'tests': ['a11yr', 21:05:49 INFO - 'ts_paint', 21:05:49 INFO - 'tpaint', 21:05:49 INFO - 'sessionrestore', 21:05:49 INFO - 'sessionrestore_no_auto_restore', 21:05:49 INFO - 'tabpaint']}, 21:05:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:05:49 INFO - 'tests': ['a11yr', 21:05:49 INFO - 'ts_paint', 21:05:49 INFO - 'tpaint', 21:05:49 INFO - 'sessionrestore', 21:05:49 INFO - 'sessionrestore_no_auto_restore', 21:05:49 INFO - 'tabpaint']}, 21:05:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:05:49 INFO - 'tests': ['tsvgx', 21:05:49 INFO - 'tsvgr_opacity', 21:05:49 INFO - 'tart', 21:05:49 INFO - 'tscrollx', 21:05:49 INFO - 'cart']}, 21:05:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:05:49 INFO - 'tsvgr_opacity', 21:05:49 INFO - 'tart', 21:05:49 INFO - 'tscrollx', 21:05:49 INFO - 'cart']}, 21:05:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:49 INFO - 'talos_options': ['--disable-e10s'], 21:05:49 INFO - 'tests': ['tp5o']}, 21:05:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:49 INFO - 'tests': ['tp5o']}, 21:05:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:49 INFO - 'talos_options': ['--disable-e10s', 21:05:49 INFO - '--xperf_path', 21:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:05:49 INFO - 'tests': ['tp5n']}, 21:05:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:05:49 INFO - 'talos_options': ['--xperf_path', 21:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:05:49 INFO - 'tests': ['tp5n']}}, 21:05:49 INFO - 'talos.zip': {'path': '', 21:05:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:05:49 INFO - Running post-action listener: _resource_record_post_action 21:05:49 INFO - ##### 21:05:49 INFO - ##### Finished populate-webroot step (success) 21:05:49 INFO - ##### 21:05:49 INFO - ##### 21:05:49 INFO - ##### Running create-virtualenv step. 21:05:49 INFO - ##### 21:05:49 INFO - Running pre-action listener: _resource_record_pre_action 21:05:49 INFO - Running main action method: create_virtualenv 21:05:49 INFO - Creating virtualenv /builds/slave/test/build/venv 21:05:49 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 21:05:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:05:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:05:49 INFO - Using real prefix '/usr' 21:05:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:05:50 INFO - Installing distribute.............................................................................................................................................................................................done. 21:05:52 INFO - Installing pip.................done. 21:05:52 INFO - Return code: 0 21:05:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93af46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1c0>, '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 0x25ac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ac550>, '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': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', '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 21:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:05:52 INFO - Using env: {'DISPLAY': ':0', 21:05:52 INFO - 'HOME': '/home/cltbld', 21:05:52 INFO - 'LANG': 'en_US.UTF-8', 21:05:52 INFO - 'LANGUAGE': 'en_US:en', 21:05:52 INFO - 'LOGNAME': 'cltbld', 21:05:52 INFO - 'MAIL': '/var/mail/cltbld', 21:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:52 INFO - 'MOZ_NO_REMOTE': '1', 21:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:52 INFO - 'NO_EM_RESTART': '1', 21:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:52 INFO - 'PWD': '/builds/slave/test', 21:05:52 INFO - 'SHELL': '/bin/bash', 21:05:52 INFO - 'SHLVL': '1', 21:05:52 INFO - 'TERM': 'linux', 21:05:52 INFO - 'TMOUT': '86400', 21:05:52 INFO - 'USER': 'cltbld', 21:05:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', 21:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:52 INFO - '_': '/tools/buildbot/bin/python'} 21:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:52 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 21:05:52 INFO - Cleaning up... 21:05:52 INFO - Return code: 0 21:05:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa93af46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1c0>, '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 0x25ac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ac550>, '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': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', '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 21:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:05:52 INFO - Using env: {'DISPLAY': ':0', 21:05:52 INFO - 'HOME': '/home/cltbld', 21:05:52 INFO - 'LANG': 'en_US.UTF-8', 21:05:52 INFO - 'LANGUAGE': 'en_US:en', 21:05:52 INFO - 'LOGNAME': 'cltbld', 21:05:52 INFO - 'MAIL': '/var/mail/cltbld', 21:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:52 INFO - 'MOZ_NO_REMOTE': '1', 21:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:52 INFO - 'NO_EM_RESTART': '1', 21:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:52 INFO - 'PWD': '/builds/slave/test', 21:05:52 INFO - 'SHELL': '/bin/bash', 21:05:52 INFO - 'SHLVL': '1', 21:05:52 INFO - 'TERM': 'linux', 21:05:52 INFO - 'TMOUT': '86400', 21:05:52 INFO - 'USER': 'cltbld', 21:05:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', 21:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:52 INFO - '_': '/tools/buildbot/bin/python'} 21:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:52 INFO - Downloading/unpacking psutil>=3.1.1 21:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:05:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:05:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:05:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:05:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:05:54 INFO - Installing collected packages: psutil 21:05:54 INFO - Running setup.py install for psutil 21:05:54 INFO - building 'psutil._psutil_linux' extension 21:05:54 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 21:05:54 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 21:05:54 INFO - building 'psutil._psutil_posix' extension 21:05:54 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 21:05:54 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 21:05:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:05:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:05:55 INFO - Successfully installed psutil 21:05:55 INFO - Cleaning up... 21:05:55 INFO - Return code: 0 21:05:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:55 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 0x7fa93af46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1c0>, '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 0x25ac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ac550>, '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': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', '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 21:05:55 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 21:05:55 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 21:05:55 INFO - Using env: {'DISPLAY': ':0', 21:05:55 INFO - 'HOME': '/home/cltbld', 21:05:55 INFO - 'LANG': 'en_US.UTF-8', 21:05:55 INFO - 'LANGUAGE': 'en_US:en', 21:05:55 INFO - 'LOGNAME': 'cltbld', 21:05:55 INFO - 'MAIL': '/var/mail/cltbld', 21:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:55 INFO - 'MOZ_NO_REMOTE': '1', 21:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:55 INFO - 'NO_EM_RESTART': '1', 21:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:55 INFO - 'PWD': '/builds/slave/test', 21:05:55 INFO - 'SHELL': '/bin/bash', 21:05:55 INFO - 'SHLVL': '1', 21:05:55 INFO - 'TERM': 'linux', 21:05:55 INFO - 'TMOUT': '86400', 21:05:55 INFO - 'USER': 'cltbld', 21:05:55 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', 21:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:55 INFO - '_': '/tools/buildbot/bin/python'} 21:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:05:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:05:57 INFO - Installing collected packages: mozsystemmonitor 21:05:57 INFO - Running setup.py install for mozsystemmonitor 21:05:57 INFO - Successfully installed mozsystemmonitor 21:05:57 INFO - Cleaning up... 21:05:57 INFO - Return code: 0 21:05:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:05:57 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')]} 21:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:57 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')]} 21:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:05:57 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 0x7fa93af46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1c0>, '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 0x25ac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ac550>, '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': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', '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 21:05:57 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 21:05:57 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 21:05:57 INFO - Using env: {'DISPLAY': ':0', 21:05:57 INFO - 'HOME': '/home/cltbld', 21:05:57 INFO - 'LANG': 'en_US.UTF-8', 21:05:57 INFO - 'LANGUAGE': 'en_US:en', 21:05:57 INFO - 'LOGNAME': 'cltbld', 21:05:57 INFO - 'MAIL': '/var/mail/cltbld', 21:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:05:57 INFO - 'MOZ_NO_REMOTE': '1', 21:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:05:57 INFO - 'NO_EM_RESTART': '1', 21:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:05:57 INFO - 'PWD': '/builds/slave/test', 21:05:57 INFO - 'SHELL': '/bin/bash', 21:05:57 INFO - 'SHLVL': '1', 21:05:57 INFO - 'TERM': 'linux', 21:05:57 INFO - 'TMOUT': '86400', 21:05:57 INFO - 'USER': 'cltbld', 21:05:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', 21:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:05:57 INFO - '_': '/tools/buildbot/bin/python'} 21:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:05:57 INFO - Downloading/unpacking jsonschema==2.5.1 21:05:57 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 21:05:57 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 21:05:57 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 21:05:57 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 21:05:57 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 21:05:57 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 21:05:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:05:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:05:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:05:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:05:59 INFO - Downloading functools32-3.2.3-2.tar.gz 21:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:05:59 INFO - warning: no files found matching '*.txt' 21:05:59 INFO - no previously-included directories found matching 'build' 21:05:59 INFO - no previously-included directories found matching 'dist' 21:05:59 INFO - no previously-included directories found matching '.git*' 21:05:59 INFO - Installing collected packages: jsonschema, functools32 21:05:59 INFO - Running setup.py install for functools32 21:06:00 INFO - warning: no files found matching '*.txt' 21:06:00 INFO - no previously-included directories found matching 'build' 21:06:00 INFO - no previously-included directories found matching 'dist' 21:06:00 INFO - no previously-included directories found matching '.git*' 21:06:00 INFO - Successfully installed jsonschema functools32 21:06:00 INFO - Cleaning up... 21:06:00 INFO - Return code: 0 21:06:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa93af46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1c0>, '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 0x25ac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ac550>, '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': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', '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 21:06:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:06:00 INFO - Using env: {'DISPLAY': ':0', 21:06:00 INFO - 'HOME': '/home/cltbld', 21:06:00 INFO - 'LANG': 'en_US.UTF-8', 21:06:00 INFO - 'LANGUAGE': 'en_US:en', 21:06:00 INFO - 'LOGNAME': 'cltbld', 21:06:00 INFO - 'MAIL': '/var/mail/cltbld', 21:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:00 INFO - 'MOZ_NO_REMOTE': '1', 21:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:00 INFO - 'NO_EM_RESTART': '1', 21:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:00 INFO - 'PWD': '/builds/slave/test', 21:06:00 INFO - 'SHELL': '/bin/bash', 21:06:00 INFO - 'SHLVL': '1', 21:06:00 INFO - 'TERM': 'linux', 21:06:00 INFO - 'TMOUT': '86400', 21:06:00 INFO - 'USER': 'cltbld', 21:06:00 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', 21:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:00 INFO - '_': '/tools/buildbot/bin/python'} 21:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:00 INFO - Downloading/unpacking blobuploader==1.2.4 21:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:02 INFO - Downloading blobuploader-1.2.4.tar.gz 21:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:06:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:06:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:02 INFO - Downloading docopt-0.6.1.tar.gz 21:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:06:02 INFO - Installing collected packages: blobuploader, requests, docopt 21:06:02 INFO - Running setup.py install for blobuploader 21:06:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:06:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:06:03 INFO - Running setup.py install for requests 21:06:03 INFO - Running setup.py install for docopt 21:06:03 INFO - Successfully installed blobuploader requests docopt 21:06:03 INFO - Cleaning up... 21:06:03 INFO - Return code: 0 21:06:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:03 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 0x7fa93af46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1c0>, '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 0x25ac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ac550>, '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': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', '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 21:06:03 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 21:06:03 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 21:06:03 INFO - Using env: {'DISPLAY': ':0', 21:06:03 INFO - 'HOME': '/home/cltbld', 21:06:03 INFO - 'LANG': 'en_US.UTF-8', 21:06:03 INFO - 'LANGUAGE': 'en_US:en', 21:06:03 INFO - 'LOGNAME': 'cltbld', 21:06:03 INFO - 'MAIL': '/var/mail/cltbld', 21:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:03 INFO - 'MOZ_NO_REMOTE': '1', 21:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:03 INFO - 'NO_EM_RESTART': '1', 21:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:03 INFO - 'PWD': '/builds/slave/test', 21:06:03 INFO - 'SHELL': '/bin/bash', 21:06:03 INFO - 'SHLVL': '1', 21:06:03 INFO - 'TERM': 'linux', 21:06:03 INFO - 'TMOUT': '86400', 21:06:03 INFO - 'USER': 'cltbld', 21:06:03 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', 21:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:03 INFO - '_': '/tools/buildbot/bin/python'} 21:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:06:03 INFO - Running setup.py (path:/tmp/pip-ZMctSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:06:03 INFO - Running setup.py (path:/tmp/pip-aBa7kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:06:03 INFO - Running setup.py (path:/tmp/pip-q0rXFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:06:04 INFO - Running setup.py (path:/tmp/pip-39A__e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:06:04 INFO - Running setup.py (path:/tmp/pip-ZsOIme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:06:04 INFO - Running setup.py (path:/tmp/pip-iSo88E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:06:04 INFO - Running setup.py (path:/tmp/pip-z23IcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:06:04 INFO - Running setup.py (path:/tmp/pip-MFN267-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:06:04 INFO - Running setup.py (path:/tmp/pip-aQ_DtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:06:04 INFO - Running setup.py (path:/tmp/pip-RLS6yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:06:04 INFO - Running setup.py (path:/tmp/pip-6_PlNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:06:04 INFO - Running setup.py (path:/tmp/pip-DF8t5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:06:04 INFO - Running setup.py (path:/tmp/pip-NFSPdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:06:04 INFO - Running setup.py (path:/tmp/pip-ILbd0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:06:04 INFO - Running setup.py (path:/tmp/pip-GvYAXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:06:04 INFO - Running setup.py (path:/tmp/pip-PlmBsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:06:04 INFO - Running setup.py (path:/tmp/pip-Odjqzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:06:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:06:05 INFO - Running setup.py install for manifestparser 21:06:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:06:05 INFO - Running setup.py install for mozcrash 21:06:05 INFO - Running setup.py install for mozdebug 21:06:05 INFO - Running setup.py install for mozdevice 21:06:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:06:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:06:05 INFO - Running setup.py install for mozfile 21:06:05 INFO - Running setup.py install for mozhttpd 21:06:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:06:05 INFO - Running setup.py install for mozinfo 21:06:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:06:05 INFO - Running setup.py install for mozInstall 21:06:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:06:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:06:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:06:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:06:05 INFO - Running setup.py install for mozleak 21:06:05 INFO - Running setup.py install for mozlog 21:06:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:06:06 INFO - Running setup.py install for moznetwork 21:06:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:06:06 INFO - Running setup.py install for mozprocess 21:06:06 INFO - Running setup.py install for mozprofile 21:06:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:06:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:06:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:06:06 INFO - Running setup.py install for mozrunner 21:06:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:06:06 INFO - Running setup.py install for mozscreenshot 21:06:06 INFO - Running setup.py install for moztest 21:06:06 INFO - Running setup.py install for mozversion 21:06:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:06:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:06:06 INFO - Cleaning up... 21:06:06 INFO - Return code: 0 21:06:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:06:06 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')]} 21:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:06 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')]} 21:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:06 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 0x7fa93af46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1c0>, '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 0x25ac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ac550>, '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': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', '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 21:06:06 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 21:06:06 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 21:06:06 INFO - Using env: {'DISPLAY': ':0', 21:06:06 INFO - 'HOME': '/home/cltbld', 21:06:06 INFO - 'LANG': 'en_US.UTF-8', 21:06:06 INFO - 'LANGUAGE': 'en_US:en', 21:06:06 INFO - 'LOGNAME': 'cltbld', 21:06:06 INFO - 'MAIL': '/var/mail/cltbld', 21:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:06 INFO - 'MOZ_NO_REMOTE': '1', 21:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:06 INFO - 'NO_EM_RESTART': '1', 21:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:06 INFO - 'PWD': '/builds/slave/test', 21:06:06 INFO - 'SHELL': '/bin/bash', 21:06:06 INFO - 'SHLVL': '1', 21:06:06 INFO - 'TERM': 'linux', 21:06:06 INFO - 'TMOUT': '86400', 21:06:06 INFO - 'USER': 'cltbld', 21:06:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', 21:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:06 INFO - '_': '/tools/buildbot/bin/python'} 21:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:06:07 INFO - Running setup.py (path:/tmp/pip-zgb3Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:06:07 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)) 21:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:06:07 INFO - Running setup.py (path:/tmp/pip-955RJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:06:07 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)) 21:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:06:07 INFO - Running setup.py (path:/tmp/pip-bqJxDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:06:07 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)) 21:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:06:07 INFO - Running setup.py (path:/tmp/pip-IAK8DD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:06:07 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)) 21:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:06:07 INFO - Running setup.py (path:/tmp/pip-VQeB4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:06:07 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)) 21:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:06:07 INFO - Running setup.py (path:/tmp/pip-MiAjy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:06:07 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)) 21:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:06:07 INFO - Running setup.py (path:/tmp/pip-EYbM5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:06:07 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)) 21:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:06:07 INFO - Running setup.py (path:/tmp/pip-rpmd5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:06:07 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)) 21:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:06:07 INFO - Running setup.py (path:/tmp/pip-238L_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:06:07 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)) 21:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:06:07 INFO - Running setup.py (path:/tmp/pip-AdwlPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:06:07 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)) 21:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:06:07 INFO - Running setup.py (path:/tmp/pip-AkSnKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:06:07 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)) 21:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:06:07 INFO - Running setup.py (path:/tmp/pip-C16NAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:06:07 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)) 21:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:06:07 INFO - Running setup.py (path:/tmp/pip-BDh3Y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:06:07 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)) 21:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:06:07 INFO - Running setup.py (path:/tmp/pip-Tf9d6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:06:08 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)) 21:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:06:08 INFO - Running setup.py (path:/tmp/pip-UeJeiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:06:08 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)) 21:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:06:08 INFO - Running setup.py (path:/tmp/pip-orKznO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:06:08 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)) 21:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:06:08 INFO - Running setup.py (path:/tmp/pip-AL957p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:06:08 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)) 21:06:08 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)) 21:06:08 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)) 21:06:08 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)) 21:06:08 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)) 21:06:08 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)) 21:06:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:10 INFO - Downloading blessings-1.6.tar.gz 21:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:06:10 INFO - Installing collected packages: blessings 21:06:10 INFO - Running setup.py install for blessings 21:06:10 INFO - Successfully installed blessings 21:06:10 INFO - Cleaning up... 21:06:10 INFO - Return code: 0 21:06:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:06:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:06:10 INFO - Reading from file tmpfile_stdout 21:06:10 INFO - Current package versions: 21:06:10 INFO - argparse == 1.2.1 21:06:10 INFO - blessings == 1.6 21:06:10 INFO - blobuploader == 1.2.4 21:06:10 INFO - docopt == 0.6.1 21:06:10 INFO - functools32 == 3.2.3-2 21:06:10 INFO - jsonschema == 2.5.1 21:06:10 INFO - manifestparser == 1.1 21:06:10 INFO - mozInstall == 1.12 21:06:10 INFO - mozcrash == 0.17 21:06:10 INFO - mozdebug == 0.1 21:06:10 INFO - mozdevice == 0.48 21:06:10 INFO - mozfile == 1.2 21:06:10 INFO - mozhttpd == 0.7 21:06:10 INFO - mozinfo == 0.9 21:06:10 INFO - mozleak == 0.1 21:06:10 INFO - mozlog == 3.2 21:06:10 INFO - moznetwork == 0.27 21:06:10 INFO - mozprocess == 0.22 21:06:10 INFO - mozprofile == 0.28 21:06:10 INFO - mozrunner == 6.11 21:06:10 INFO - mozscreenshot == 0.1 21:06:10 INFO - mozsystemmonitor == 0.3 21:06:10 INFO - moztest == 0.7 21:06:10 INFO - mozversion == 1.4 21:06:10 INFO - psutil == 3.1.1 21:06:10 INFO - requests == 1.2.3 21:06:10 INFO - wsgiref == 0.1.2 21:06:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:06:10 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')]} 21:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:10 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')]} 21:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:10 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 0x7fa93af46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1c0>, '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 0x25ac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ac550>, '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': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', '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 21:06:10 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 21:06:10 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 21:06:10 INFO - Using env: {'DISPLAY': ':0', 21:06:10 INFO - 'HOME': '/home/cltbld', 21:06:10 INFO - 'LANG': 'en_US.UTF-8', 21:06:10 INFO - 'LANGUAGE': 'en_US:en', 21:06:10 INFO - 'LOGNAME': 'cltbld', 21:06:10 INFO - 'MAIL': '/var/mail/cltbld', 21:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:10 INFO - 'MOZ_NO_REMOTE': '1', 21:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:10 INFO - 'NO_EM_RESTART': '1', 21:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:10 INFO - 'PWD': '/builds/slave/test', 21:06:10 INFO - 'SHELL': '/bin/bash', 21:06:10 INFO - 'SHLVL': '1', 21:06:10 INFO - 'TERM': 'linux', 21:06:10 INFO - 'TMOUT': '86400', 21:06:10 INFO - 'USER': 'cltbld', 21:06:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', 21:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:10 INFO - '_': '/tools/buildbot/bin/python'} 21:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:10 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)) 21:06:10 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)) 21:06:10 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)) 21:06:10 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)) 21:06:10 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)) 21:06:10 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)) 21:06:10 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)) 21:06:10 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)) 21:06:10 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)) 21:06:10 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)) 21:06:10 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)) 21:06:10 INFO - Cleaning up... 21:06:10 INFO - Return code: 0 21:06:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:06:10 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')]} 21:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:10 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')]} 21:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:10 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 0x7fa93af46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1c0>, '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 0x25ac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ac550>, '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': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', '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 21:06:10 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 21:06:10 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 21:06:10 INFO - Using env: {'DISPLAY': ':0', 21:06:10 INFO - 'HOME': '/home/cltbld', 21:06:10 INFO - 'LANG': 'en_US.UTF-8', 21:06:10 INFO - 'LANGUAGE': 'en_US:en', 21:06:10 INFO - 'LOGNAME': 'cltbld', 21:06:10 INFO - 'MAIL': '/var/mail/cltbld', 21:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:10 INFO - 'MOZ_NO_REMOTE': '1', 21:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:10 INFO - 'NO_EM_RESTART': '1', 21:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:10 INFO - 'PWD': '/builds/slave/test', 21:06:10 INFO - 'SHELL': '/bin/bash', 21:06:10 INFO - 'SHLVL': '1', 21:06:10 INFO - 'TERM': 'linux', 21:06:10 INFO - 'TMOUT': '86400', 21:06:10 INFO - 'USER': 'cltbld', 21:06:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', 21:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:10 INFO - '_': '/tools/buildbot/bin/python'} 21:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:06:11 INFO - Cleaning up... 21:06:11 INFO - Return code: 0 21:06:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:06: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')]} 21:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06: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')]} 21:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:11 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 0x7fa93af46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab1c0>, '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 0x25ac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ac550>, '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': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', '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 21:06:11 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 21:06:11 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 21:06:11 INFO - Using env: {'DISPLAY': ':0', 21:06:11 INFO - 'HOME': '/home/cltbld', 21:06:11 INFO - 'LANG': 'en_US.UTF-8', 21:06:11 INFO - 'LANGUAGE': 'en_US:en', 21:06:11 INFO - 'LOGNAME': 'cltbld', 21:06:11 INFO - 'MAIL': '/var/mail/cltbld', 21:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:11 INFO - 'MOZ_NO_REMOTE': '1', 21:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:11 INFO - 'NO_EM_RESTART': '1', 21:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:11 INFO - 'PWD': '/builds/slave/test', 21:06:11 INFO - 'SHELL': '/bin/bash', 21:06:11 INFO - 'SHLVL': '1', 21:06:11 INFO - 'TERM': 'linux', 21:06:11 INFO - 'TMOUT': '86400', 21:06:11 INFO - 'USER': 'cltbld', 21:06:11 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', 21:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:11 INFO - '_': '/tools/buildbot/bin/python'} 21:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:11 INFO - Downloading/unpacking flake8 21:06:11 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 21:06:11 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 21:06:11 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 21:06:11 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 21:06:11 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 21:06:11 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 21:06:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:06:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:06:13 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 21:06:13 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 21:06:13 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 21:06:13 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 21:06:13 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 21:06:13 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 21:06:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:06:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:06:13 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 21:06:13 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 21:06:13 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 21:06:13 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 21:06:13 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 21:06:13 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 21:06:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:06:13 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 21:06:13 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 21:06:13 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 21:06:13 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 21:06:13 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 21:06:13 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 21:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:06:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:06:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:06:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:06:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:06:13 INFO - no previously-included directories found matching 'docs/_build' 21:06:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:06:13 INFO - Running setup.py install for pep8 21:06:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:06:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:06:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:06:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:06:14 INFO - no previously-included directories found matching 'docs/_build' 21:06:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:06:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:06:14 INFO - Cleaning up... 21:06:14 INFO - Return code: 0 21:06:14 INFO - Running post-action listener: _resource_record_post_action 21:06:14 INFO - Running post-action listener: _start_resource_monitoring 21:06:14 INFO - Starting resource monitoring. 21:06:14 INFO - ##### 21:06:14 INFO - ##### Finished create-virtualenv step (success) 21:06:14 INFO - ##### 21:06:14 INFO - ##### 21:06:14 INFO - ##### Running install step. 21:06:14 INFO - ##### 21:06:14 INFO - Running pre-action listener: _resource_record_pre_action 21:06:14 INFO - Running main action method: install 21:06:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:06:14 INFO - Reading from file tmpfile_stdout 21:06:14 INFO - Detecting whether we're running mozinstall >=1.0... 21:06:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:06:14 INFO - Reading from file tmpfile_stdout 21:06:14 INFO - Output received: 21:06:14 INFO - Usage: mozinstall [options] installer 21:06:14 INFO - Options: 21:06:14 INFO - -h, --help show this help message and exit 21:06:14 INFO - -d DEST, --destination=DEST 21:06:14 INFO - Directory to install application into. [default: 21:06:14 INFO - "/builds/slave/test"] 21:06:14 INFO - --app=APP Application being installed. [default: firefox] 21:06:14 INFO - mkdir: /builds/slave/test/build/application 21:06:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:06:31 INFO - Reading from file tmpfile_stdout 21:06:31 INFO - Output received: 21:06:31 INFO - /builds/slave/test/build/application/firefox/firefox 21:06:31 INFO - Running post-action listener: _resource_record_post_action 21:06:31 INFO - ##### 21:06:31 INFO - ##### Finished install step (success) 21:06:31 INFO - ##### 21:06:31 INFO - ##### 21:06:31 INFO - ##### Running run-tests step. 21:06:31 INFO - ##### 21:06:31 INFO - Running pre-action listener: _resource_record_pre_action 21:06:31 INFO - Running main action method: run_tests 21:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:06:31 INFO - Python 2.7.3 21:06:31 INFO - Return code: 0 21:06:31 INFO - grabbing minidump binary from tooltool 21:06: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')]} 21:06:31 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 0x25ab1c0>, '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 0x25ac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ac550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:06:31 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 21:06:31 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 21:06:31 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 21:06:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:06:31 INFO - Return code: 0 21:06:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:06:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:06:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:06:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:06:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:06:32 INFO - Return code: 0 21:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 21:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 21:06:32 INFO - Using env: {'DISPLAY': ':0', 21:06:32 INFO - 'HOME': '/home/cltbld', 21:06:32 INFO - 'LANG': 'en_US.UTF-8', 21:06:32 INFO - 'LANGUAGE': 'en_US:en', 21:06:32 INFO - 'LOGNAME': 'cltbld', 21:06:32 INFO - 'MAIL': '/var/mail/cltbld', 21:06:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:06:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:32 INFO - 'MOZ_NO_REMOTE': '1', 21:06:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:32 INFO - 'NO_EM_RESTART': '1', 21:06:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:32 INFO - 'PWD': '/builds/slave/test', 21:06:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:06:32 INFO - 'SHELL': '/bin/bash', 21:06:32 INFO - 'SHLVL': '1', 21:06:32 INFO - 'TERM': 'linux', 21:06:32 INFO - 'TMOUT': '86400', 21:06:32 INFO - 'USER': 'cltbld', 21:06:32 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745', 21:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:32 INFO - '_': '/tools/buildbot/bin/python'} 21:06:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 21:06:32 INFO - mozversion application_buildid: 20160603183004 21:06:32 INFO - mozversion application_changeset: 07dd3ddb164c04fe57db45301de69eb3d387eab8 21:06:32 INFO - mozversion application_display_name: Nightly 21:06:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:06:32 INFO - mozversion application_name: Firefox 21:06:32 INFO - mozversion application_remotingname: firefox 21:06:32 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 21:06:32 INFO - mozversion application_vendor: Mozilla 21:06:32 INFO - mozversion application_version: 49.0a1 21:06:32 INFO - mozversion platform_buildid: 20160603183004 21:06:32 INFO - mozversion platform_changeset: 07dd3ddb164c04fe57db45301de69eb3d387eab8 21:06:32 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 21:06:32 INFO - mozversion platform_version: 49.0a1 21:06:32 INFO - using testdate: 1465013192 21:06:32 INFO - actual date: 1465013192 21:06:32 INFO - starting webserver on 'localhost:49983' 21:06:32 INFO - SUITE-START | Running 2 tests 21:06:32 INFO - TEST-START | dromaeo_css 21:06:32 INFO - operating with platform_type : linux_ 21:06:32 INFO - Initialising browser for dromaeo_css test... 21:06:32 INFO - TEST-INFO | started process 27666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnaMmEx/profile http://localhost:49983/getInfo.html) 21:06:37 INFO - PROCESS | 27666 | __metrics Screen width/height:1600/1200 21:06:37 INFO - PROCESS | 27666 | colorDepth:24 21:06:37 INFO - PROCESS | 27666 | Browser inner width/height: 1024/697 21:06:37 INFO - PROCESS | 27666 | __metrics 21:06:37 ERROR - PROCESS | 27666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 21:06:38 INFO - TEST-INFO | 27666: exit 0 21:06:38 INFO - Browser initialized. 21:06:38 INFO - Running cycle 1/1 for dromaeo_css test... 21:06:38 INFO - TEST-INFO | started process 27785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnaMmEx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:06:50 INFO - PROCESS | 27785 | RSS: Main: 167235584 21:06:50 INFO - PROCESS | 27785 | 21:07:40 INFO - PROCESS | 27785 | 1465013260158 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] 21:09:47 INFO - PROCESS | 27785 | Cycle 1(1): loaded http://localhost:49983/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49983/tests/dromaeo/cssquery-ext.html) 21:09:48 INFO - PROCESS | 27785 | RSS: Main: 170360832 21:09:48 INFO - PROCESS | 27785 | 21:12:50 INFO - PROCESS | 27785 | Cycle 1(1): loaded http://localhost:49983/tests/dromaeo/cssquery-ext.html (next: http://localhost:49983/tests/dromaeo/cssquery-jquery.html) 21:12:51 INFO - PROCESS | 27785 | RSS: Main: 170332160 21:12:51 INFO - PROCESS | 27785 | 21:15:53 INFO - PROCESS | 27785 | Cycle 1(1): loaded http://localhost:49983/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49983/tests/dromaeo/cssquery-mootools.html) 21:15:53 INFO - PROCESS | 27785 | RSS: Main: 171323392 21:15:53 INFO - PROCESS | 27785 | 21:18:55 INFO - PROCESS | 27785 | Cycle 1(1): loaded http://localhost:49983/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49983/tests/dromaeo/cssquery-prototype.html) 21:18:56 INFO - PROCESS | 27785 | RSS: Main: 169283584 21:18:56 INFO - PROCESS | 27785 | 21:21:58 INFO - PROCESS | 27785 | Cycle 1(1): loaded http://localhost:49983/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49983/tests/dromaeo/cssquery-yui.html) 21:21:59 INFO - PROCESS | 27785 | RSS: Main: 170950656 21:21:59 INFO - PROCESS | 27785 | 21:25:02 INFO - PROCESS | 27785 | Cycle 1(1): loaded http://localhost:49983/tests/dromaeo/cssquery-yui.html (next: http://localhost:49983/tests/dromaeo/cssquery-dojo.html) 21:25:02 INFO - PROCESS | 27785 | RSS: Main: 172363776 21:25:02 INFO - PROCESS | 27785 | 21:25:02 INFO - PROCESS | 27785 | __start_tp_report 21:25:02 INFO - PROCESS | 27785 | _x_x_mozilla_page_load 21:25:02 INFO - PROCESS | 27785 | _x_x_mozilla_page_load_details 21:25:02 INFO - PROCESS | 27785 | |i|pagename|runs| 21:25:02 INFO - PROCESS | 27785 | |0;dojo.html;3092.876284948602;3130.6086739157604;3154.637216720077;3154.8422578871064;3163.699448552387;5421.349438067433;5443.074677304858;5459.7816087356505;5474.315710536183;5485.807996720116;5340.385855626604;5438.184272359148;5451.972740136303;5489.505944464997;5500.642458240211;4860.270959356089;4936.876578085541;5042.82350117746;5046.21783623539;5100.591952643798;855.1884896516083;4839.7338146401935;4891.755412229374;4964.429090654567;5023.321851550048;4872.025594881038;4924.950750492485;4939.382577177853;4950.009998000396;4950.108980383529;4960.305557221992;4960.677555958851;4970.925436118461;4973.52751488608;4978.6017118630425;4870.902581948377;4943.159662857287;4957.553820156168;4961.5286547777905;4979.07887040895;5396.91904621431;5416.891662166774;5421.376541697677;5443.047466693313;5454.209139674765;5711.514521265697;5736.770529178828;5784.392638772911;5821.50517206038;5827.650340979555;5898.616589921684;5939.881202375928;5941.524678025748;5957.702114894238;6015.608985415934;5542.695151766651;5550.084236101038;5553.805616803433;5558.638688485235;5570.275864137636;5892.528597712173;5919.378465261086;5984.401559843981;6049.5462840287155;6068.241469816273;5723.971380143073;5725.713714314351;5739.799107031234;5740.799072032459;5747.8563035924435;5890.52875769946;5907.9704601476715;5908.3205431375945;5920.851978700567;5931.288245410578;5698.971505142531;5754.769809207669;5795.88408231833;5801.6519008859605;5877.5591830612875;5648.745806438638;5702.31572211329;5739.311282646109;5749.080147176432;5762.9135562966585;4368.257396242647;4378.474583050054;4392.253316936129;4418.359337895987;4459.710118842265;3883.436901649245;3885.8834234972996;3891.591382904811;3937.370020796659;3939.0152461884527;5544.085225937675;5603;5623.831285061455;5673.914891276634;5674.773009079673;5782.913256301159;5892.587518873724;5923.318818335946;5928.703564821828;5943.524518038546;5568.693721845257;5572.60991730575;5623.493885550321;5626.381098079208;5648.915266271009;5046.949530504721;5049.368828896388;5058.342415486037;5061.367329083864;5142.357205349332;5967.1347654589845;6114.755409783648;6123.877522449615;6125.295591007091;6137.232845894263;5847.883042339129;5914.7338369774325;5930.525557955267;5936.970315148569;5944.4352786485215;6096.268447786294;6099.695015249308;6113.266408031065;6141.3551577085545;6165.136880836776;5650.208970744017;5736.856578585569;5800.1299805029585;5804.448577385142;5858.974679431168;5859.56053296013;5881.382454842351;5945.316288626863;5956.463918247378;6011.549133814894;5740.311162660508;5777.162311464898;5794.507466865363;5808.796692115756;5818.679972601548;5566.721663916707;5617.662940223599;5669.121286200645;5768.394318596487;5778.595498315246;5577.637453565505;5594.188842617717;5604.159376093456;5612.354579223442;5636.267285252891;5726.2269593606;5738.598298119092;5769.971150144391;5781.046127389102;5790.218320526844;5502.862428439321;5570.2201691762375;5571.303587051619;5612.7754889803955;5685.488306052475 21:25:02 INFO - PROCESS | 27785 | |1;ext.html;589.5165963909593;627.6924307089527;635.2123367024888;652.7519542573823;656.1109696361427;42955.57044429555;43949.36303821773;44026.55973440265;44069.11861762763;44092.33861492072;44817;44983.32525012128;45193;45427.31859022109;45489.31766023504;8632.093630168836;8781.692640757576;8836.602352894135;8845.380823342368;8885.822283554326;8744.912550874506;8800.8679869802;8818.162274583905;8818.955905220464;8836.116388361144;8805.911940880605;8828.470291782482;8856.114388561156;8867.467951922874;8890.955545222265;8755.649774009033;8781.7804554886;8785.428947118417;8787.121287871225;8804.8679269811;8758.343124265706;8832.205101540829;8840.734777956672;8849.911500884973;8863.113688631085;41880.58119418797;42200.78899605513;42418;42565.57434425647;42665.36001959942;3406.863725450979;3515.2090779574646;3542.36237477254;3638.43604241343;3744.101415660222;32731.836340818383;33274;33425;33765.662343376745;34706;4428.419175871783;4460.665450091256;4472.127935052666;4497.527759585262;4562.817487300504;380955;381673;382018;382702;386278;62191;62678.37321626816;62725.372746271954;62763.6861815688;62807.6859615699;36569.45145822815;37127.62872371242;37419.81290093532;39228.411573826415;63375.683121584094;17456;17567.472975810746;17605.119744012747;17662;17750.28998840058;12596.370181490889;12721.491140354283;12726;12737.426815793311;12756.936215318863;20120.59758804845;20252.291169808985;20256;20408.897955510423;20426.38720838377;7270.236625154388;7401.740939067106;7451.739189128354;7537.736179233701;7557.6221188940335;1001.8647482589903;1023.9436830974367;1045.7699306152633;1113.7939481196004;1114.570890207276;34010.31979360399;34085.48871766926;34218;34289.828550857084;34364.65635343615;1106.6126855600637;1123.2193625430248;1160.3560024186656;1234.962951111468;1247.8315427417365;17475.56311092233;17632.294708211528;17773;17943.73084403735;17956.461306160574;536896;539921.003949801;543179;547222;547331;59132.40867591355;60764.69617651883;60887.39112608906;61147.6942615293;61155;1331.12811108722;1387.6114687887407;1389.4720006397504;1405.9507917222847;1409.7110092431233;32373.676263237066;33148;33372;33527.16182095467;33976.163174536516;53079.734601326745;53302.46697532975;53521;53732.46267537274;53809.730951344995;374382;374498;377698;377892;378231;28449.43101137924;28622.85688571544;29511.26221844471;29580.260493487836;31028.844855775576;49344.75327623339;49454.50545494499;50022.49977500179;50203.74898125632;51208.23187652114;40509.56942583455;41997.1600567993;42980.785096074316;43070.138597227255;43223.13553728971;41630.16739665129;41742;42066.57933420627;42513.574864250964;42591.57408426;41886.79056604698;42910;43838;44036;46215;36787.264254715294;38303.272814142954;38673.12953491152;38688.6131138685;39196.21607567776;29046.564301535072;29233.15691034253;29407.11778646644;29442.822287108276;29461.410771784875 21:25:02 INFO - PROCESS | 27785 | |2;jquery.html;394.5305086946534;396.90871099647063;397.08868147601237;400.6794564348521;422.05670326819575;15475.45835895744;18041;18516.351927682535;19758.506037349074;19885.99999999998;15071.397144114222;15236.542903712878;15769.684606307866;17567.385141520048;17585.120743962816;5712.400197979215;5729.914051289224;5826.941730582704;5887.116932460122;5931.110333449996;5677.063284558064;5734.79928202513;5772.797952071678;5789.421057894219;5823.155642431845;5251;5515.09001014832;5525.972370138144;5732.340780810197;5746.051901436258;5583.8604034899045;5597.412271711472;5626.549876009909;5701.344345400291;6179.691015449254;5598.188262701886;5598.58010649203;5605.887882242373;5619.522340601054;5645.689487078209;13163.670908227276;13241.668958276025;13258.40337184829;13279.269640169883;13749.106308089942;2105.4420578546697;2334.731505876829;2351.75306592807;2542.6694529711203;2730.1263595649402;9577.712668619952;10408.947955260252;13024.674383140402;14000.579982600539;14607.342669579895;1762.9118544072874;1804.6571151481307;1808.0598088993781;1819.954501137469;1831.359024341483;80780.59609701972;83504.58247708784;83891.5805420969;84300.57849710774;85213;10834.512446939907;11093.944530277297;11150.553977840958;11193.16051296156;11374.31754094757;13178.868211317764;14013.789793153112;15425.305861236271;15440.536783896501;15520.301586428637;7496.6251687415415;7564.357029652431;7845.843083138419;7997.5601341925585;8044.2760151586635;6967.233604303523;7075.2570980047385;7204.4956853019785;7388;7585.393168546503;4736.4316282046375;4740;4749.1926372516755;4757.95242047582;4816.710997340101;1991.1836147179588;2014.5870096630156;2015.6371853066296;2068.6586713192155;2072.533679922036;882.770479675289;969.9854502182473;993.3543196922059;1016.7102375822855;1073.2455223360587;18420;18836.717449238273;18934;19071.141798619097;19257.80742192588;1019.4953498018529;1028.303299555739;1053.2311412668794;1070.673444599389;1082.7076689293847;10193.796124077477;10709.571617135227;10736;10760.085392741548;10779.946100269606;510453;512629;514894;515484;517052;95235;95287.52356238312;96545;98140;99733;1017.064300843226;1023.2785885950536;1042.7862288230895;1045.4668119259234;1069.6523629820183;16465.176741163134;16867.409640662518;16927.15364231808;17152.399666011628;17223.13884305805;42567.3614895783;42850.14299713926;43191;43241.13517729565;43472.56527434812;57574.42425575691;59170.40829591649;61296;61801.690991544754;62006.37993620006;8273.710420135267;8302.875456868273;8388.916110838814;8460.873086903579;8477.74566762998;12453.377331133226;12814.167079139826;12963.22220666763;13713.657158571115;13854.376553054935;11668.70828229301;11765.176437649283;11772.587959421378;11952.223105498115;11992.160548761853;10892.727681808019;11163.832542511705;11449.713757156138;11746.530138794353;11917.582884598998;11989.520419183134;12031.338276394532;12215.572454964034;12289.631311060682;12305.200161989442;7250.9637451814515;7773.261540153676;7776.766696999099;7818.491798033109;8673.739787806377;10762;11252.26860254081;11335.319880807177;11389.715257118638;11408.486618102039 21:25:02 INFO - PROCESS | 27785 | |3;mootools.html;1521.155758554003;1536.2088524409928;1627.6409198319402;1756.6486702659472;1757.815429379915;7167.458996315791;8038.638261278242;8186.79533011675;8603.526806025666;8640.827183456335;8278.544680042596;8317.833643327145;8341.582920853964;8351.4989100654;8353.582320883961;2248.516568937682;2289.645105008726;2290.0954123121355;2290.7365652949957;2293.3693234360517;2233.36349140495;2257.16484900587;2280.8859557022083;2287.63397856343;2294.0594356313914;2271.182374345243;2279.0655831109248;2296.2307626944994;2296.6899468571696;2304.2050492580115;2194.264921251383;2208.8895555222257;2215.634420320645;2216.157860013193;2218.1792736687366;2151.774063723318;2206.0403724379785;2230.10795681727;2230.810381117607;2232.2410380470556;8110.797230069236;8167.264946154874;8179.71371002018;8190.7133250335955;8202.835943281101;4801.447833499157;4944.381952255968;4954.826581069681;4961.603071754251;4963.329950456714;3344.6320904700465;3362.4788157835574;3546.680798728127;3549.5563054618174;3588.138846676805;1152.3143729480946;1153.9019183369423;1169.830374595679;1233.3463264469844;1245.3773113443278;11245.437728113644;11263.999999999918;11374.146938979527;11391.886081139166;11393.54425822966;4391.714538554984;4462.1075784842515;4539.388517076456;4554.886127846764;4562.1788078146255;9754.46350450718;9763.609455621696;9763.951180244054;9765.853512197322;9769.316147869724;4963.950360496348;4971.130052240844;5013.49865013503;5025.572826309804;5026.070177017264;3935.2719746846924;4549.454065512094;4641.048585040058;4647.604953578983;4681.625469962395;3831.5593706723525;3840.4815349927962;3876.9532226298743;3923.941140882889;3929.9017524562114;1227.220714846079;1232.6979889927024;1243.937803109859;1258.0564576567574;1262.8926541243914;927.4388994658135;935.7239614313794;949.2263804998904;952.8332541805156;963.1620490173594;5896.174535565025;5919.4080591940465;5984.581079324493;6049.939500604937;6125;458.5941441823943;463.17785929974565;470.89640279138536;471.83014114918603;475.39624676660446;4271;4295.742255464682;4313.654907607447;4324.718893271927;4343;10093.343932644355;10387.37675739443;10472.371657700562;10472.947635261928;10506.317089389166;9639.084286992724;10046.19630429564;10214.285000050073;10236.33463824849;10348.844767328346;7803.946467226965;7891.644875980594;7935.523868567904;7945.48354356965;7973.521588704696;5853.09277062056;6048.84877878039;6086.878262434815;6137.048757442603;6201.906971395523;9166.129217724305;9581.904180958101;9647.855282170633;9657.661981830603;9683.9031609683;9639.469829159183;9811.509424528602;9815.460149691835;9924.950375248078;9938.652147175104;6493.480521558358;7229.891551626835;7262.636868156465;7326.6702998364135;7579.355754760907;8289.668413263402;8298.502089874626;8309.542975136426;8372.120927302789;8398;7207.531510451804;7299.306565876233;7429.962850185714;7582.582957937367;7666.233376662289;6969.372756451944;7311.305425984523;7319.670614822452;7331;7485;6774.187097548129;6812.489063320171;6842.076319696777;6888.552244104118;6893.655317234018;5064.772085256246;5189.872152417491;5245.868853278698;5315.123004704181;5368.570514358764;5118.257852611276;5122.8975420492125;5136.9726054789935;5143.6399452039495;5161.174212126042 21:25:02 INFO - PROCESS | 27785 | |4;prototype.html;339.8631577373685;346.27628256942984;346.96356882527334;347.8573784748254;349.55082718706467;5642.576806739496;5689.0044242257645;5694.772209111636;5730.770769169233;5760.855978600537;5554.000279949608;5574.721263936807;5579.832605021846;5581.325602319298;5643.351014633308;4119.176164767051;4198.1393814268;4307.203167414023;4326.329418940054;4349.064951035527;4329.523752387235;4353.608175264226;4365.934510982338;4366.978165109186;4382.364557139213;4358.629516491102;4363.694541382105;4368.58498442649;4377.496587892385;4386.407834942273;4271.78641067947;4290.570942905716;4326.394304797331;4332.458442694663;4343.978280108611;3805.2009078093633;3807.333716599584;3809.8855135400117;3811.6378944000276;3822.866199682998;5417.968261901787;5450.337647017658;5469.948769211545;5528.336599608033;5538.307711536058;4891.437484689235;4944.604431645495;4947.431045429786;4959.8016079356785;5027.170516864713;5785.132230165466;5851.736671849734;5875.559333050039;5888.440598143169;5900.20347253124;4178.749275043507;4195.559466256061;4216.156768646283;4217.536071032184;4219.767912764797;6028.156058151862;6041.516678665696;6097.817065487998;6115.1744514490865;6115.266168059817;4242.363645453145;4256.191323648497;4271.124419493996;4299.376590394375;4312.094460163338;4308.3968244445805;4359.302511598129;4360.302351623725;4360.934585981213;4371.453568303962;4713.656607866741;4962.238405366115;4962.404511458576;4975.527324904128;4977.278294647256;5927.429231253721;5961.433663801932;5975.671338076448;5991.910121348184;5995.160677505153;1498.8126484189477;1507.7889095526634;1525.4737115695068;1527.1982209339963;1535.8788084698233;957.8515330123842;999.3604093380243;1017.4861694844204;1028.665683652816;1035.8135535603665;5708;5720.942790572124;5761.251037365199;5762.481376676119;5763.357443128688;5989.790357337472;6025.9096113558335;6064.241969753781;6101.542384321194;6144.354842741537;5558.722063896789;5677.432256774289;5725.456081672234;5735.369109397963;5744.109663002241;3218.5976752905885;3231.822249776285;3234.514822776602;3240;3247.6589958054537;6034.9094763577705;6181.598196117238;6201.286852011986;6254.530910181755;6258.249010118815;6043.7884674036195;6072;6135.9079613805825;6150.292716337589;6153.1693221415435;5945.3757355477055;6136.8772624547255;6143.354947730513;6214.285357183981;6265.8120256392385;5901.852453688693;5976.910346344721;5995.880082398415;6018.939810601838;6021.668808215415;5903.557233207613;5958.867815115114;5998.820035398945;6004.819855404345;6046.5767396281835;6006.357202830741;6208.25500939872;6210.875782484235;6221.004639257697;6247.68761561911;4265.402843601836;4276.3799249109325;4290.785460727014;4297.806598703003;4298.548652391454;5869.970650146893;6008.87982240344;6051.668632900754;6052.576319657758;6065.332813390435;5793.91309130355;5830.2129212555765;5834.737436815269;5869.647821130746;5874.5887787854435;5829.067349224104;5839.591228613956;5858.7070646466655;5860.472557469848;5887.764489420375;5213.374395072616;5720.599558030898;5750.769969201185;5776.451237132465;5777.884442311046;5951.345352011189;5951.821445356646;5981;6008.339082700987;6021.54838387114;5649.293838270216;5808.970955145197;5860.443257890493;5870.618409803349;5875.383084776208 21:25:02 INFO - PROCESS | 27785 | |5;yui.html;724.1599744296614;742.8068702137442;745.5079647432692;804.1476035402472;854.2013217641505;14322.785158222621;15649.139297338641;15818.76271855923;15835.445759398423;15838.049717016973;13067.673308167301;14302.71394572108;14616.342264598092;14779.482718104868;14817.629559261024;808.8544062068826;817.2562967699365;817.9345652347798;820.6184124382161;823.5223570329194;810.2100452059254;810.8743144812563;811.119934870666;811.2050190813006;812.5815205169342;855.3969451536652;856.1566856646199;859.1537335724306;860.423516244118;862.3187681731424;852.4544291653347;852.4757274276276;853.9829203415959;854.5556310718423;857.0229937870832;619.5415392609436;621.9160413344185;622.2843729710869;623.2396476298908;623.6725718997517;15033.744938259239;15205.923970380078;15285.770713439308;15307.234638268043;15675.686486270324;15394.769078463833;15448.691026179526;15469;15801.130937798416;15809.683806323808;12375.690607734789;12409.689757756129;12511.874881251253;12526.123171378007;12663.176893501894;3890.105275786585;3915.530136383624;3938.4879965604287;3954.130091379892;4079.143379890197;51425.228621570706;63230.683846580476;67907.98138027983;67927.66036169836;71439;12200;12403.875961240452;12407.007439404826;12640.810387844189;12683.936580317224;20352.18591256333;21038.684419733716;21167.25914592982;22061.779382206292;22065.227717029826;8767.517786521803;8906.332025098143;9014.729558113268;9088.954555227314;9378.718638440858;4852.417709874838;4911.361523001987;4938.703677779345;4941.209406494943;4992.750362481861;3714.2200137971327;3785.981070094687;3793.5827059024036;3816.5038544988975;3822.1591249925527;665.3147258323934;668.6556423441931;677.376813331736;686.2177118085386;687.3744892148121;683.2791405067701;700.3661686174021;726.7093162734948;752.9849403011909;777.739457281817;10603.151747860153;10855.348679079281;10888.67333979966;11037.39294338803;11128;647.0876064748682;658.5127006015514;732.4835990626596;756.7124492692742;764.5259938837845;5003.24951257307;5122.206058060932;5181.300524429229;5195.19474481456;5272.841814745487;72550.63724681448;73877.6306118466;93604;119716.40141799235;120510.3974480122;93730;99318;100333.48165850803;100949.49525252474;101380.49309753404;76372.23627763652;76694.61652691812;77382.22617773863;86540.56729716437;88541.55729221442;10509.789804204025;10775.040675081886;10840.349579025284;10848.566057357617;10954.890451095387;44135.77932110319;45361.09277814491;51415.48584514107;53971;55771.163432547735;52091;53458.4654153469;62268.06597900944;72859.08563657607;73417;13609.863901361256;13686;13793.862061379257;13961.650958726113;14316.498922537661;14147.080439771382;15079.849201507845;15117;15299.770503442234;15812.288447019682;14441;14888.478903238334;14932.328045237773;14992;15301.693966120838;14418.783718244444;14535.491257805927;14656.193909335088;14727.55817325482;14867.776983345475;13890.30548472552;13992.580222593338;14039.929800351341;14411.42354305816;14606.780898286323;11262.380569068451;11687;12044.879551204725;12179.573714919936;12199;12047.518099276282;12060.638180854588;12397.194182378116;12398.380080995734;12445.813312800496 21:25:02 INFO - PROCESS | 27785 | __end_tp_report 21:25:02 INFO - PROCESS | 27785 | __start_cc_report 21:25:02 INFO - PROCESS | 27785 | _x_x_mozilla_cycle_collect,356 21:25:02 INFO - PROCESS | 27785 | __end_cc_report 21:25:02 INFO - PROCESS | 27785 | __startTimestamp1465014302271__endTimestamp 21:25:02 INFO - PROCESS | 27785 | 21:25:02 INFO - PROCESS | 27785 | ------- Summary: start ------- 21:25:02 INFO - PROCESS | 27785 | Number of tests: 6 21:25:02 INFO - PROCESS | 27785 | 21:25:02 INFO - PROCESS | 27785 | [#0] dojo.html Cycles:165 Average:5412.13 Median:5648.75 stddev:730.33 (12.9%) stddev-sans-first:709.54 21:25:02 INFO - PROCESS | 27785 | Values: 3092.9 3130.6 3154.6 3154.8 3163.7 5421.3 5443.1 5459.8 5474.3 5485.8 5340.4 5438.2 5452.0 5489.5 5500.6 4860.3 4936.9 5042.8 5046.2 5100.6 855.2 4839.7 4891.8 4964.4 5023.3 4872.0 4925.0 4939.4 4950.0 4950.1 4960.3 4960.7 4970.9 4973.5 4978.6 4870.9 4943.2 4957.6 4961.5 4979.1 5396.9 5416.9 5421.4 5443.0 5454.2 5711.5 5736.8 5784.4 5821.5 5827.7 5898.6 5939.9 5941.5 5957.7 6015.6 5542.7 5550.1 5553.8 5558.6 5570.3 5892.5 5919.4 5984.4 6049.5 6068.2 5724.0 5725.7 5739.8 5740.8 5747.9 5890.5 5908.0 5908.3 5920.9 5931.3 5699.0 5754.8 5795.9 5801.7 5877.6 5648.7 5702.3 5739.3 5749.1 5762.9 4368.3 4378.5 4392.3 4418.4 4459.7 3883.4 3885.9 3891.6 3937.4 3939.0 5544.1 5603.0 5623.8 5673.9 5674.8 5782.9 5892.6 5923.3 5928.7 5943.5 5568.7 5572.6 5623.5 5626.4 5648.9 5046.9 5049.4 5058.3 5061.4 5142.4 5967.1 6114.8 6123.9 6125.3 6137.2 5847.9 5914.7 5930.5 5937.0 5944.4 6096.3 6099.7 6113.3 6141.4 6165.1 5650.2 5736.9 5800.1 5804.4 5859.0 5859.6 5881.4 5945.3 5956.5 6011.5 5740.3 5777.2 5794.5 5808.8 5818.7 5566.7 5617.7 5669.1 5768.4 5778.6 5577.6 5594.2 5604.2 5612.4 5636.3 5726.2 5738.6 5770.0 5781.0 5790.2 5502.9 5570.2 5571.3 5612.8 5685.5 21:25:02 INFO - PROCESS | 27785 | 21:25:02 INFO - PROCESS | 27785 | [#1] ext.html Cycles:180 Average:60044.73 Median:42133.68 stddev:116712.95 (277.0%) stddev-sans-first:116954.99 21:25:02 INFO - PROCESS | 27785 | Values: 589.5 627.7 635.2 652.8 656.1 42955.6 43949.4 44026.6 44069.1 44092.3 44817.0 44983.3 45193.0 45427.3 45489.3 8632.1 8781.7 8836.6 8845.4 8885.8 8744.9 8800.9 8818.2 8819.0 8836.1 8805.9 8828.5 8856.1 8867.5 8891.0 8755.6 8781.8 8785.4 8787.1 8804.9 8758.3 8832.2 8840.7 8849.9 8863.1 41880.6 42200.8 42418.0 42565.6 42665.4 3406.9 3515.2 3542.4 3638.4 3744.1 32731.8 33274.0 33425.0 33765.7 34706.0 4428.4 4460.7 4472.1 4497.5 4562.8 380955.0 381673.0 382018.0 382702.0 386278.0 62191.0 62678.4 62725.4 62763.7 62807.7 36569.5 37127.6 37419.8 39228.4 63375.7 17456.0 17567.5 17605.1 17662.0 17750.3 12596.4 12721.5 12726.0 12737.4 12756.9 20120.6 20252.3 20256.0 20408.9 20426.4 7270.2 7401.7 7451.7 7537.7 7557.6 1001.9 1023.9 1045.8 1113.8 1114.6 34010.3 34085.5 34218.0 34289.8 34364.7 1106.6 1123.2 1160.4 1235.0 1247.8 17475.6 17632.3 17773.0 17943.7 17956.5 536896.0 539921.0 543179.0 547222.0 547331.0 59132.4 60764.7 60887.4 61147.7 61155.0 1331.1 1387.6 1389.5 1406.0 1409.7 32373.7 33148.0 33372.0 33527.2 33976.2 53079.7 53302.5 53521.0 53732.5 53809.7 374382.0 374498.0 377698.0 377892.0 378231.0 28449.4 28622.9 29511.3 29580.3 31028.8 49344.8 49454.5 50022.5 50203.7 51208.2 40509.6 41997.2 42980.8 43070.1 43223.1 41630.2 41742.0 42066.6 42513.6 42591.6 41886.8 42910.0 43838.0 44036.0 46215.0 36787.3 38303.3 38673.1 38688.6 39196.2 29046.6 29233.2 29407.1 29442.8 29461.4 21:25:02 INFO - PROCESS | 27785 | 21:25:02 INFO - PROCESS | 27785 | [#2] jquery.html Cycles:180 Average:29574.58 Median:2088.99 stddev:84878.08 (4063.1%) stddev-sans-first:85087.90 21:25:02 INFO - PROCESS | 27785 | Values: 394.5 396.9 397.1 400.7 422.1 15475.5 18041.0 18516.4 19758.5 19886.0 15071.4 15236.5 15769.7 17567.4 17585.1 5712.4 5729.9 5826.9 5887.1 5931.1 5677.1 5734.8 5772.8 5789.4 5823.2 5251.0 5515.1 5526.0 5732.3 5746.1 5583.9 5597.4 5626.5 5701.3 6179.7 5598.2 5598.6 5605.9 5619.5 5645.7 13163.7 13241.7 13258.4 13279.3 13749.1 2105.4 2334.7 2351.8 2542.7 2730.1 9577.7 10408.9 13024.7 14000.6 14607.3 1762.9 1804.7 1808.1 1820.0 1831.4 80780.6 83504.6 83891.6 84300.6 85213.0 10834.5 11093.9 11150.6 11193.2 11374.3 13178.9 14013.8 15425.3 15440.5 15520.3 7496.6 7564.4 7845.8 7997.6 8044.3 6967.2 7075.3 7204.5 7388.0 7585.4 4736.4 4740.0 4749.2 4758.0 4816.7 1991.2 2014.6 2015.6 2068.7 2072.5 882.8 970.0 993.4 1016.7 1073.2 18420.0 18836.7 18934.0 19071.1 19257.8 1019.5 1028.3 1053.2 1070.7 1082.7 10193.8 10709.6 10736.0 10760.1 10779.9 510453.0 512629.0 514894.0 515484.0 517052.0 95235.0 95287.5 96545.0 98140.0 99733.0 1017.1 1023.3 1042.8 1045.5 1069.7 16465.2 16867.4 16927.2 17152.4 17223.1 42567.4 42850.1 43191.0 43241.1 43472.6 57574.4 59170.4 61296.0 61801.7 62006.4 8273.7 8302.9 8388.9 8460.9 8477.7 12453.4 12814.2 12963.2 13713.7 13854.4 11668.7 11765.2 11772.6 11952.2 11992.2 10892.7 11163.8 11449.7 11746.5 11917.6 11989.5 12031.3 12215.6 12289.6 12305.2 7251.0 7773.3 7776.8 7818.5 8673.7 10762.0 11252.3 11335.3 11389.7 11408.5 21:25:02 INFO - PROCESS | 27785 | 21:25:02 INFO - PROCESS | 27785 | [#3] mootools.html Cycles:180 Average:5564.96 Median:4992.31 stddev:3091.77 (61.9%) stddev-sans-first:3085.51 21:25:02 INFO - PROCESS | 27785 | Values: 1521.2 1536.2 1627.6 1756.6 1757.8 7167.5 8038.6 8186.8 8603.5 8640.8 8278.5 8317.8 8341.6 8351.5 8353.6 2248.5 2289.6 2290.1 2290.7 2293.4 2233.4 2257.2 2280.9 2287.6 2294.1 2271.2 2279.1 2296.2 2296.7 2304.2 2194.3 2208.9 2215.6 2216.2 2218.2 2151.8 2206.0 2230.1 2230.8 2232.2 8110.8 8167.3 8179.7 8190.7 8202.8 4801.4 4944.4 4954.8 4961.6 4963.3 3344.6 3362.5 3546.7 3549.6 3588.1 1152.3 1153.9 1169.8 1233.3 1245.4 11245.4 11264.0 11374.1 11391.9 11393.5 4391.7 4462.1 4539.4 4554.9 4562.2 9754.5 9763.6 9764.0 9765.9 9769.3 4964.0 4971.1 5013.5 5025.6 5026.1 3935.3 4549.5 4641.0 4647.6 4681.6 3831.6 3840.5 3877.0 3923.9 3929.9 1227.2 1232.7 1243.9 1258.1 1262.9 927.4 935.7 949.2 952.8 963.2 5896.2 5919.4 5984.6 6049.9 6125.0 458.6 463.2 470.9 471.8 475.4 4271.0 4295.7 4313.7 4324.7 4343.0 10093.3 10387.4 10472.4 10472.9 10506.3 9639.1 10046.2 10214.3 10236.3 10348.8 7803.9 7891.6 7935.5 7945.5 7973.5 5853.1 6048.8 6086.9 6137.0 6201.9 9166.1 9581.9 9647.9 9657.7 9683.9 9639.5 9811.5 9815.5 9925.0 9938.7 6493.5 7229.9 7262.6 7326.7 7579.4 8289.7 8298.5 8309.5 8372.1 8398.0 7207.5 7299.3 7430.0 7582.6 7666.2 6969.4 7311.3 7319.7 7331.0 7485.0 6774.2 6812.5 6842.1 6888.6 6893.7 5064.8 5189.9 5245.9 5315.1 5368.6 5118.3 5122.9 5137.0 5143.6 5161.2 21:25:02 INFO - PROCESS | 27785 | 21:25:02 INFO - PROCESS | 27785 | [#4] prototype.html Cycles:180 Average:4947.89 Median:5714.30 stddev:1457.46 (25.5%) stddev-sans-first:1419.92 21:25:02 INFO - PROCESS | 27785 | Values: 339.9 346.3 347.0 347.9 349.6 5642.6 5689.0 5694.8 5730.8 5760.9 5554.0 5574.7 5579.8 5581.3 5643.4 4119.2 4198.1 4307.2 4326.3 4349.1 4329.5 4353.6 4365.9 4367.0 4382.4 4358.6 4363.7 4368.6 4377.5 4386.4 4271.8 4290.6 4326.4 4332.5 4344.0 3805.2 3807.3 3809.9 3811.6 3822.9 5418.0 5450.3 5469.9 5528.3 5538.3 4891.4 4944.6 4947.4 4959.8 5027.2 5785.1 5851.7 5875.6 5888.4 5900.2 4178.7 4195.6 4216.2 4217.5 4219.8 6028.2 6041.5 6097.8 6115.2 6115.3 4242.4 4256.2 4271.1 4299.4 4312.1 4308.4 4359.3 4360.3 4360.9 4371.5 4713.7 4962.2 4962.4 4975.5 4977.3 5927.4 5961.4 5975.7 5991.9 5995.2 1498.8 1507.8 1525.5 1527.2 1535.9 957.9 999.4 1017.5 1028.7 1035.8 5708.0 5720.9 5761.3 5762.5 5763.4 5989.8 6025.9 6064.2 6101.5 6144.4 5558.7 5677.4 5725.5 5735.4 5744.1 3218.6 3231.8 3234.5 3240.0 3247.7 6034.9 6181.6 6201.3 6254.5 6258.2 6043.8 6072.0 6135.9 6150.3 6153.2 5945.4 6136.9 6143.4 6214.3 6265.8 5901.9 5976.9 5995.9 6018.9 6021.7 5903.6 5958.9 5998.8 6004.8 6046.6 6006.4 6208.3 6210.9 6221.0 6247.7 4265.4 4276.4 4290.8 4297.8 4298.5 5870.0 6008.9 6051.7 6052.6 6065.3 5793.9 5830.2 5834.7 5869.6 5874.6 5829.1 5839.6 5858.7 5860.5 5887.8 5213.4 5720.6 5750.8 5776.5 5777.9 5951.3 5951.8 5981.0 6008.3 6021.5 5649.3 5809.0 5860.4 5870.6 5875.4 21:25:02 INFO - PROCESS | 27785 | 21:25:02 INFO - PROCESS | 27785 | [#5] yui.html Cycles:180 Average:19802.27 Median:3902.82 stddev:27050.65 (693.1%) stddev-sans-first:27088.60 21:25:02 INFO - PROCESS | 27785 | Values: 724.2 742.8 745.5 804.1 854.2 14322.8 15649.1 15818.8 15835.4 15838.0 13067.7 14302.7 14616.3 14779.5 14817.6 808.9 817.3 817.9 820.6 823.5 810.2 810.9 811.1 811.2 812.6 855.4 856.2 859.2 860.4 862.3 852.5 852.5 854.0 854.6 857.0 619.5 621.9 622.3 623.2 623.7 15033.7 15205.9 15285.8 15307.2 15675.7 15394.8 15448.7 15469.0 15801.1 15809.7 12375.7 12409.7 12511.9 12526.1 12663.2 3890.1 3915.5 3938.5 3954.1 4079.1 51425.2 63230.7 67908.0 67927.7 71439.0 12200.0 12403.9 12407.0 12640.8 12683.9 20352.2 21038.7 21167.3 22061.8 22065.2 8767.5 8906.3 9014.7 9089.0 9378.7 4852.4 4911.4 4938.7 4941.2 4992.8 3714.2 3786.0 3793.6 3816.5 3822.2 665.3 668.7 677.4 686.2 687.4 683.3 700.4 726.7 753.0 777.7 10603.2 10855.3 10888.7 11037.4 11128.0 647.1 658.5 732.5 756.7 764.5 5003.2 5122.2 5181.3 5195.2 5272.8 72550.6 73877.6 93604.0 119716.4 120510.4 93730.0 99318.0 100333.5 100949.5 101380.5 76372.2 76694.6 77382.2 86540.6 88541.6 10509.8 10775.0 10840.3 10848.6 10954.9 44135.8 45361.1 51415.5 53971.0 55771.2 52091.0 53458.5 62268.1 72859.1 73417.0 13609.9 13686.0 13793.9 13961.7 14316.5 14147.1 15079.8 15117.0 15299.8 15812.3 14441.0 14888.5 14932.3 14992.0 15301.7 14418.8 14535.5 14656.2 14727.6 14867.8 13890.3 13992.6 14039.9 14411.4 14606.8 11262.4 11687.0 12044.9 12179.6 12199.0 12047.5 12060.6 12397.2 12398.4 12445.8 21:25:02 INFO - PROCESS | 27785 | -------- Summary: end -------- 21:25:02 INFO - PROCESS | 27785 | 21:25:02 INFO - TEST-INFO | 27785: exit 0 21:25:02 INFO - TEST-OK | dromaeo_css | took 1110320ms 21:25:02 INFO - TEST-START | kraken 21:25:02 INFO - operating with platform_type : linux_ 21:25:02 INFO - Initialising browser for kraken test... 21:25:02 INFO - TEST-INFO | started process 28018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkOEWaM/profile http://localhost:49983/getInfo.html) 21:25:07 INFO - PROCESS | 28018 | __metrics Screen width/height:1600/1200 21:25:07 INFO - PROCESS | 28018 | colorDepth:24 21:25:07 INFO - PROCESS | 28018 | Browser inner width/height: 1024/697 21:25:07 INFO - PROCESS | 28018 | __metrics 21:25:08 ERROR - PROCESS | 28018 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 21:25:08 INFO - TEST-INFO | 28018: exit 0 21:25:08 INFO - Browser initialized. 21:25:08 INFO - Running cycle 1/1 for kraken test... 21:25:08 INFO - TEST-INFO | started process 28138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkOEWaM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:25:20 INFO - PROCESS | 28138 | RSS: Main: 167157760 21:25:20 INFO - PROCESS | 28138 | 21:25:23 INFO - PROCESS | 28138 | Cycle 1(1): loaded http://localhost:49983/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49983/tests/kraken/driver.html?testName=audio-beat-detection) 21:25:24 INFO - PROCESS | 28138 | RSS: Main: 172273664 21:25:24 INFO - PROCESS | 28138 | 21:25:26 INFO - PROCESS | 28138 | Cycle 1(1): loaded http://localhost:49983/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49983/tests/kraken/driver.html?testName=audio-dft) 21:25:27 INFO - PROCESS | 28138 | RSS: Main: 171921408 21:25:27 INFO - PROCESS | 28138 | 21:25:30 INFO - PROCESS | 28138 | Cycle 1(1): loaded http://localhost:49983/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49983/tests/kraken/driver.html?testName=audio-fft) 21:25:30 INFO - PROCESS | 28138 | RSS: Main: 166383616 21:25:30 INFO - PROCESS | 28138 | 21:25:33 INFO - PROCESS | 28138 | Cycle 1(1): loaded http://localhost:49983/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49983/tests/kraken/driver.html?testName=audio-oscillator) 21:25:33 INFO - PROCESS | 28138 | RSS: Main: 167399424 21:25:33 INFO - PROCESS | 28138 | 21:25:35 INFO - PROCESS | 28138 | Cycle 1(1): loaded http://localhost:49983/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49983/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:25:36 INFO - PROCESS | 28138 | RSS: Main: 167841792 21:25:36 INFO - PROCESS | 28138 | 21:25:39 INFO - PROCESS | 28138 | Cycle 1(1): loaded http://localhost:49983/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49983/tests/kraken/driver.html?testName=imaging-darkroom) 21:25:40 INFO - PROCESS | 28138 | RSS: Main: 168038400 21:25:40 INFO - PROCESS | 28138 | 21:25:43 INFO - PROCESS | 28138 | Cycle 1(1): loaded http://localhost:49983/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49983/tests/kraken/driver.html?testName=imaging-desaturate) 21:25:44 INFO - PROCESS | 28138 | RSS: Main: 165994496 21:25:44 INFO - PROCESS | 28138 | 21:25:47 INFO - PROCESS | 28138 | Cycle 1(1): loaded http://localhost:49983/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49983/tests/kraken/driver.html?testName=json-parse-financial) 21:25:47 INFO - PROCESS | 28138 | RSS: Main: 167190528 21:25:47 INFO - PROCESS | 28138 | 21:25:49 INFO - PROCESS | 28138 | Cycle 1(1): loaded http://localhost:49983/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49983/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:25:49 INFO - PROCESS | 28138 | RSS: Main: 167477248 21:25:49 INFO - PROCESS | 28138 | 21:25:51 INFO - PROCESS | 28138 | Cycle 1(1): loaded http://localhost:49983/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49983/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:25:52 INFO - PROCESS | 28138 | RSS: Main: 167342080 21:25:52 INFO - PROCESS | 28138 | 21:25:54 INFO - PROCESS | 28138 | Cycle 1(1): loaded http://localhost:49983/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49983/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:25:55 INFO - PROCESS | 28138 | RSS: Main: 167821312 21:25:55 INFO - PROCESS | 28138 | 21:25:57 INFO - PROCESS | 28138 | Cycle 1(1): loaded http://localhost:49983/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49983/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:25:58 INFO - PROCESS | 28138 | RSS: Main: 167792640 21:25:58 INFO - PROCESS | 28138 | 21:26:01 INFO - PROCESS | 28138 | Cycle 1(1): loaded http://localhost:49983/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49983/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:26:01 INFO - PROCESS | 28138 | RSS: Main: 167792640 21:26:01 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | Cycle 1(1): loaded http://localhost:49983/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49983/tests/kraken/driver.html?testName=ai-astar) 21:26:03 INFO - PROCESS | 28138 | RSS: Main: 168378368 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | __start_tp_report 21:26:03 INFO - PROCESS | 28138 | _x_x_mozilla_page_load 21:26:03 INFO - PROCESS | 28138 | _x_x_mozilla_page_load_details 21:26:03 INFO - PROCESS | 28138 | |i|pagename|runs| 21:26:03 INFO - PROCESS | 28138 | |0;ai-astar;112;106;111;111;111;112;112;112;111;111 21:26:03 INFO - PROCESS | 28138 | |1;audio-beat-detection;169;126;154;191;126;153;154;131;185;129 21:26:03 INFO - PROCESS | 28138 | |2;audio-dft;161;162;162;160;163;166;169;164;161;162 21:26:03 INFO - PROCESS | 28138 | |3;audio-fft;74;76;74;158;74;74;75;74;182;76 21:26:03 INFO - PROCESS | 28138 | |4;audio-oscillator;86;86;145;86;85;85;132;85;86;134 21:26:03 INFO - PROCESS | 28138 | |5;imaging-gaussian-blur;117;118;118;118;117;118;117;120;117;117 21:26:03 INFO - PROCESS | 28138 | |6;imaging-darkroom;147;147;147;147;147;147;148;147;147;147 21:26:03 INFO - PROCESS | 28138 | |7;imaging-desaturate;96;96;96;96;96;95;96;96;95;96 21:26:03 INFO - PROCESS | 28138 | |8;json-parse-financial;55;54;53;54;57;55;53;55;65;53 21:26:03 INFO - PROCESS | 28138 | |9;json-stringify-tinderbox;62;62;64;62;62;62;62;62;62;62 21:26:03 INFO - PROCESS | 28138 | |10;stanford-crypto-aes;79;80;79;80;86;84;81;81;107;78 21:26:03 INFO - PROCESS | 28138 | |11;stanford-crypto-ccm;130;123;134;135;122;126;134;135;134;127 21:26:03 INFO - PROCESS | 28138 | |12;stanford-crypto-pbkdf2;162;165;158;161;160;162;156;155;163;161 21:26:03 INFO - PROCESS | 28138 | |13;stanford-crypto-sha256-iterative;67;65;65;67;65;63;67;66;61;62 21:26:03 INFO - PROCESS | 28138 | __end_tp_report 21:26:03 INFO - PROCESS | 28138 | __start_cc_report 21:26:03 INFO - PROCESS | 28138 | _x_x_mozilla_cycle_collect,867 21:26:03 INFO - PROCESS | 28138 | __end_cc_report 21:26:03 INFO - PROCESS | 28138 | __startTimestamp1465014363581__endTimestamp 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | ------- Summary: start ------- 21:26:03 INFO - PROCESS | 28138 | Number of tests: 14 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:1.79 (1.6%) stddev-sans-first:1.86 21:26:03 INFO - PROCESS | 28138 | Values: 112.0 106.0 111.0 111.0 111.0 112.0 112.0 112.0 111.0 111.0 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:154.00 stddev:24.11 (15.7%) stddev-sans-first:24.75 21:26:03 INFO - PROCESS | 28138 | Values: 169.0 126.0 154.0 191.0 126.0 153.0 154.0 131.0 185.0 129.0 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:2.71 (1.7%) stddev-sans-first:2.77 21:26:03 INFO - PROCESS | 28138 | Values: 161.0 162.0 162.0 160.0 163.0 166.0 169.0 164.0 161.0 162.0 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | [#3] audio-fft Cycles:10 Average:93.70 Median:74.00 stddev:40.62 (54.9%) stddev-sans-first:42.45 21:26:03 INFO - PROCESS | 28138 | Values: 74.0 76.0 74.0 158.0 74.0 74.0 75.0 74.0 182.0 76.0 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | [#4] audio-oscillator Cycles:10 Average:101.00 Median:85.50 stddev:25.06 (29.3%) stddev-sans-first:25.99 21:26:03 INFO - PROCESS | 28138 | Values: 86.0 86.0 145.0 86.0 85.0 85.0 132.0 85.0 86.0 134.0 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 21:26:03 INFO - PROCESS | 28138 | Values: 117.0 118.0 118.0 118.0 117.0 118.0 117.0 120.0 117.0 117.0 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 21:26:03 INFO - PROCESS | 28138 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:26:03 INFO - PROCESS | 28138 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:3.60 (6.5%) stddev-sans-first:3.81 21:26:03 INFO - PROCESS | 28138 | Values: 55.0 54.0 53.0 54.0 57.0 55.0 53.0 55.0 65.0 53.0 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 21:26:03 INFO - PROCESS | 28138 | Values: 62.0 62.0 64.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:80.50 stddev:8.61 (10.7%) stddev-sans-first:8.97 21:26:03 INFO - PROCESS | 28138 | Values: 79.0 80.0 79.0 80.0 86.0 84.0 81.0 81.0 107.0 78.0 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:134.00 stddev:5.12 (3.8%) stddev-sans-first:5.43 21:26:03 INFO - PROCESS | 28138 | Values: 130.0 123.0 134.0 135.0 122.0 126.0 134.0 135.0 134.0 127.0 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:161.50 stddev:3.13 (1.9%) stddev-sans-first:3.26 21:26:03 INFO - PROCESS | 28138 | Values: 162.0 165.0 158.0 161.0 160.0 162.0 156.0 155.0 163.0 161.0 21:26:03 INFO - PROCESS | 28138 | 21:26:03 INFO - PROCESS | 28138 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.50 stddev:2.15 (3.3%) stddev-sans-first:2.13 21:26:03 INFO - PROCESS | 28138 | Values: 67.0 65.0 65.0 67.0 65.0 63.0 67.0 66.0 61.0 62.0 21:26:03 INFO - PROCESS | 28138 | -------- Summary: end -------- 21:26:03 INFO - PROCESS | 28138 | 21:26:04 INFO - TEST-INFO | 28138: exit 0 21:26:04 INFO - TEST-OK | kraken | took 61570ms 21:26:04 INFO - SUITE-END | took 1171s 21:26:04 INFO - Completed test suite (00:19:32) 21:26:04 INFO - javascript benchmark 21:26:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7309.087859321363, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.876284948602, 3130.6086739157604, 3154.637216720077, 3154.8422578871064, 3163.699448552387, 5421.349438067433, 5443.074677304858, 5459.7816087356505, 5474.315710536183, 5485.807996720116, 5340.385855626604, 5438.184272359148, 5451.972740136303, 5489.505944464997, 5500.642458240211, 4860.270959356089, 4936.876578085541, 5042.82350117746, 5046.21783623539, 5100.591952643798, 855.1884896516083, 4839.7338146401935, 4891.755412229374, 4964.429090654567, 5023.321851550048, 4872.025594881038, 4924.950750492485, 4939.382577177853, 4950.009998000396, 4950.108980383529, 4960.305557221992, 4960.677555958851, 4970.925436118461, 4973.52751488608, 4978.6017118630425, 4870.902581948377, 4943.159662857287, 4957.553820156168, 4961.5286547777905, 4979.07887040895, 5396.91904621431, 5416.891662166774, 5421.376541697677, 5443.047466693313, 5454.209139674765, 5711.514521265697, 5736.770529178828, 5784.392638772911, 5821.50517206038, 5827.650340979555, 5898.616589921684, 5939.881202375928, 5941.524678025748, 5957.702114894238, 6015.608985415934, 5542.695151766651, 5550.084236101038, 5553.805616803433, 5558.638688485235, 5570.275864137636, 5892.528597712173, 5919.378465261086, 5984.401559843981, 6049.5462840287155, 6068.241469816273, 5723.971380143073, 5725.713714314351, 5739.799107031234, 5740.799072032459, 5747.8563035924435, 5890.52875769946, 5907.9704601476715, 5908.3205431375945, 5920.851978700567, 5931.288245410578, 5698.971505142531, 5754.769809207669, 5795.88408231833, 5801.6519008859605, 5877.5591830612875, 5648.745806438638, 5702.31572211329, 5739.311282646109, 5749.080147176432, 5762.9135562966585, 4368.257396242647, 4378.474583050054, 4392.253316936129, 4418.359337895987, 4459.710118842265, 3883.436901649245, 3885.8834234972996, 3891.591382904811, 3937.370020796659, 3939.0152461884527, 5544.085225937675, 5603.0, 5623.831285061455, 5673.914891276634, 5674.773009079673, 5782.913256301159, 5892.587518873724, 5923.318818335946, 5928.703564821828, 5943.524518038546, 5568.693721845257, 5572.60991730575, 5623.493885550321, 5626.381098079208, 5648.915266271009, 5046.949530504721, 5049.368828896388, 5058.342415486037, 5061.367329083864, 5142.357205349332, 5967.1347654589845, 6114.755409783648, 6123.877522449615, 6125.295591007091, 6137.232845894263, 5847.883042339129, 5914.7338369774325, 5930.525557955267, 5936.970315148569, 5944.4352786485215, 6096.268447786294, 6099.695015249308, 6113.266408031065, 6141.3551577085545, 6165.136880836776, 5650.208970744017, 5736.856578585569, 5800.1299805029585, 5804.448577385142, 5858.974679431168, 5859.56053296013, 5881.382454842351, 5945.316288626863, 5956.463918247378, 6011.549133814894, 5740.311162660508, 5777.162311464898, 5794.507466865363, 5808.796692115756, 5818.679972601548, 5566.721663916707, 5617.662940223599, 5669.121286200645, 5768.394318596487, 5778.595498315246, 5577.637453565505, 5594.188842617717, 5604.159376093456, 5612.354579223442, 5636.267285252891, 5726.2269593606, 5738.598298119092, 5769.971150144391, 5781.046127389102, 5790.218320526844, 5502.862428439321, 5570.2201691762375, 5571.303587051619, 5612.7754889803955, 5685.488306052475], "value": 5362.6569962291005, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.5165963909593, 627.6924307089527, 635.2123367024888, 652.7519542573823, 656.1109696361427, 42955.57044429555, 43949.36303821773, 44026.55973440265, 44069.11861762763, 44092.33861492072, 44817.0, 44983.32525012128, 45193.0, 45427.31859022109, 45489.31766023504, 8632.093630168836, 8781.692640757576, 8836.602352894135, 8845.380823342368, 8885.822283554326, 8744.912550874506, 8800.8679869802, 8818.162274583905, 8818.955905220464, 8836.116388361144, 8805.911940880605, 8828.470291782482, 8856.114388561156, 8867.467951922874, 8890.955545222265, 8755.649774009033, 8781.7804554886, 8785.428947118417, 8787.121287871225, 8804.8679269811, 8758.343124265706, 8832.205101540829, 8840.734777956672, 8849.911500884973, 8863.113688631085, 41880.58119418797, 42200.78899605513, 42418.0, 42565.57434425647, 42665.36001959942, 3406.863725450979, 3515.2090779574646, 3542.36237477254, 3638.43604241343, 3744.101415660222, 32731.836340818383, 33274.0, 33425.0, 33765.662343376745, 34706.0, 4428.419175871783, 4460.665450091256, 4472.127935052666, 4497.527759585262, 4562.817487300504, 380955.0, 381673.0, 382018.0, 382702.0, 386278.0, 62191.0, 62678.37321626816, 62725.372746271954, 62763.6861815688, 62807.6859615699, 36569.45145822815, 37127.62872371242, 37419.81290093532, 39228.411573826415, 63375.683121584094, 17456.0, 17567.472975810746, 17605.119744012747, 17662.0, 17750.28998840058, 12596.370181490889, 12721.491140354283, 12726.0, 12737.426815793311, 12756.936215318863, 20120.59758804845, 20252.291169808985, 20256.0, 20408.897955510423, 20426.38720838377, 7270.236625154388, 7401.740939067106, 7451.739189128354, 7537.736179233701, 7557.6221188940335, 1001.8647482589903, 1023.9436830974367, 1045.7699306152633, 1113.7939481196004, 1114.570890207276, 34010.31979360399, 34085.48871766926, 34218.0, 34289.828550857084, 34364.65635343615, 1106.6126855600637, 1123.2193625430248, 1160.3560024186656, 1234.962951111468, 1247.8315427417365, 17475.56311092233, 17632.294708211528, 17773.0, 17943.73084403735, 17956.461306160574, 536896.0, 539921.003949801, 543179.0, 547222.0, 547331.0, 59132.40867591355, 60764.69617651883, 60887.39112608906, 61147.6942615293, 61155.0, 1331.12811108722, 1387.6114687887407, 1389.4720006397504, 1405.9507917222847, 1409.7110092431233, 32373.676263237066, 33148.0, 33372.0, 33527.16182095467, 33976.163174536516, 53079.734601326745, 53302.46697532975, 53521.0, 53732.46267537274, 53809.730951344995, 374382.0, 374498.0, 377698.0, 377892.0, 378231.0, 28449.43101137924, 28622.85688571544, 29511.26221844471, 29580.260493487836, 31028.844855775576, 49344.75327623339, 49454.50545494499, 50022.49977500179, 50203.74898125632, 51208.23187652114, 40509.56942583455, 41997.1600567993, 42980.785096074316, 43070.138597227255, 43223.13553728971, 41630.16739665129, 41742.0, 42066.57933420627, 42513.574864250964, 42591.57408426, 41886.79056604698, 42910.0, 43838.0, 44036.0, 46215.0, 36787.264254715294, 38303.272814142954, 38673.12953491152, 38688.6131138685, 39196.21607567776, 29046.564301535072, 29233.15691034253, 29407.11778646644, 29442.822287108276, 29461.410771784875], "value": 20464.98998443334, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.5305086946534, 396.90871099647063, 397.08868147601237, 400.6794564348521, 422.05670326819575, 15475.45835895744, 18041.0, 18516.351927682535, 19758.506037349074, 19885.99999999998, 15071.397144114222, 15236.542903712878, 15769.684606307866, 17567.385141520048, 17585.120743962816, 5712.400197979215, 5729.914051289224, 5826.941730582704, 5887.116932460122, 5931.110333449996, 5677.063284558064, 5734.79928202513, 5772.797952071678, 5789.421057894219, 5823.155642431845, 5251.0, 5515.09001014832, 5525.972370138144, 5732.340780810197, 5746.051901436258, 5583.8604034899045, 5597.412271711472, 5626.549876009909, 5701.344345400291, 6179.691015449254, 5598.188262701886, 5598.58010649203, 5605.887882242373, 5619.522340601054, 5645.689487078209, 13163.670908227276, 13241.668958276025, 13258.40337184829, 13279.269640169883, 13749.106308089942, 2105.4420578546697, 2334.731505876829, 2351.75306592807, 2542.6694529711203, 2730.1263595649402, 9577.712668619952, 10408.947955260252, 13024.674383140402, 14000.579982600539, 14607.342669579895, 1762.9118544072874, 1804.6571151481307, 1808.0598088993781, 1819.954501137469, 1831.359024341483, 80780.59609701972, 83504.58247708784, 83891.5805420969, 84300.57849710774, 85213.0, 10834.512446939907, 11093.944530277297, 11150.553977840958, 11193.16051296156, 11374.31754094757, 13178.868211317764, 14013.789793153112, 15425.305861236271, 15440.536783896501, 15520.301586428637, 7496.6251687415415, 7564.357029652431, 7845.843083138419, 7997.5601341925585, 8044.2760151586635, 6967.233604303523, 7075.2570980047385, 7204.4956853019785, 7388.0, 7585.393168546503, 4736.4316282046375, 4740.0, 4749.1926372516755, 4757.95242047582, 4816.710997340101, 1991.1836147179588, 2014.5870096630156, 2015.6371853066296, 2068.6586713192155, 2072.533679922036, 882.770479675289, 969.9854502182473, 993.3543196922059, 1016.7102375822855, 1073.2455223360587, 18420.0, 18836.717449238273, 18934.0, 19071.141798619097, 19257.80742192588, 1019.4953498018529, 1028.303299555739, 1053.2311412668794, 1070.673444599389, 1082.7076689293847, 10193.796124077477, 10709.571617135227, 10736.0, 10760.085392741548, 10779.946100269606, 510453.0, 512629.0, 514894.0, 515484.0, 517052.0, 95235.0, 95287.52356238312, 96545.0, 98140.0, 99733.0, 1017.064300843226, 1023.2785885950536, 1042.7862288230895, 1045.4668119259234, 1069.6523629820183, 16465.176741163134, 16867.409640662518, 16927.15364231808, 17152.399666011628, 17223.13884305805, 42567.3614895783, 42850.14299713926, 43191.0, 43241.13517729565, 43472.56527434812, 57574.42425575691, 59170.40829591649, 61296.0, 61801.690991544754, 62006.37993620006, 8273.710420135267, 8302.875456868273, 8388.916110838814, 8460.873086903579, 8477.74566762998, 12453.377331133226, 12814.167079139826, 12963.22220666763, 13713.657158571115, 13854.376553054935, 11668.70828229301, 11765.176437649283, 11772.587959421378, 11952.223105498115, 11992.160548761853, 10892.727681808019, 11163.832542511705, 11449.713757156138, 11746.530138794353, 11917.582884598998, 11989.520419183134, 12031.338276394532, 12215.572454964034, 12289.631311060682, 12305.200161989442, 7250.9637451814515, 7773.261540153676, 7776.766696999099, 7818.491798033109, 8673.739787806377, 10762.0, 11252.26860254081, 11335.319880807177, 11389.715257118638, 11408.486618102039], "value": 9067.183464510656, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1521.155758554003, 1536.2088524409928, 1627.6409198319402, 1756.6486702659472, 1757.815429379915, 7167.458996315791, 8038.638261278242, 8186.79533011675, 8603.526806025666, 8640.827183456335, 8278.544680042596, 8317.833643327145, 8341.582920853964, 8351.4989100654, 8353.582320883961, 2248.516568937682, 2289.645105008726, 2290.0954123121355, 2290.7365652949957, 2293.3693234360517, 2233.36349140495, 2257.16484900587, 2280.8859557022083, 2287.63397856343, 2294.0594356313914, 2271.182374345243, 2279.0655831109248, 2296.2307626944994, 2296.6899468571696, 2304.2050492580115, 2194.264921251383, 2208.8895555222257, 2215.634420320645, 2216.157860013193, 2218.1792736687366, 2151.774063723318, 2206.0403724379785, 2230.10795681727, 2230.810381117607, 2232.2410380470556, 8110.797230069236, 8167.264946154874, 8179.71371002018, 8190.7133250335955, 8202.835943281101, 4801.447833499157, 4944.381952255968, 4954.826581069681, 4961.603071754251, 4963.329950456714, 3344.6320904700465, 3362.4788157835574, 3546.680798728127, 3549.5563054618174, 3588.138846676805, 1152.3143729480946, 1153.9019183369423, 1169.830374595679, 1233.3463264469844, 1245.3773113443278, 11245.437728113644, 11263.999999999918, 11374.146938979527, 11391.886081139166, 11393.54425822966, 4391.714538554984, 4462.1075784842515, 4539.388517076456, 4554.886127846764, 4562.1788078146255, 9754.46350450718, 9763.609455621696, 9763.951180244054, 9765.853512197322, 9769.316147869724, 4963.950360496348, 4971.130052240844, 5013.49865013503, 5025.572826309804, 5026.070177017264, 3935.2719746846924, 4549.454065512094, 4641.048585040058, 4647.604953578983, 4681.625469962395, 3831.5593706723525, 3840.4815349927962, 3876.9532226298743, 3923.941140882889, 3929.9017524562114, 1227.220714846079, 1232.6979889927024, 1243.937803109859, 1258.0564576567574, 1262.8926541243914, 927.4388994658135, 935.7239614313794, 949.2263804998904, 952.8332541805156, 963.1620490173594, 5896.174535565025, 5919.4080591940465, 5984.581079324493, 6049.939500604937, 6125.0, 458.5941441823943, 463.17785929974565, 470.89640279138536, 471.83014114918603, 475.39624676660446, 4271.0, 4295.742255464682, 4313.654907607447, 4324.718893271927, 4343.0, 10093.343932644355, 10387.37675739443, 10472.371657700562, 10472.947635261928, 10506.317089389166, 9639.084286992724, 10046.19630429564, 10214.285000050073, 10236.33463824849, 10348.844767328346, 7803.946467226965, 7891.644875980594, 7935.523868567904, 7945.48354356965, 7973.521588704696, 5853.09277062056, 6048.84877878039, 6086.878262434815, 6137.048757442603, 6201.906971395523, 9166.129217724305, 9581.904180958101, 9647.855282170633, 9657.661981830603, 9683.9031609683, 9639.469829159183, 9811.509424528602, 9815.460149691835, 9924.950375248078, 9938.652147175104, 6493.480521558358, 7229.891551626835, 7262.636868156465, 7326.6702998364135, 7579.355754760907, 8289.668413263402, 8298.502089874626, 8309.542975136426, 8372.120927302789, 8398.0, 7207.531510451804, 7299.306565876233, 7429.962850185714, 7582.582957937367, 7666.233376662289, 6969.372756451944, 7311.305425984523, 7319.670614822452, 7331.0, 7485.0, 6774.187097548129, 6812.489063320171, 6842.076319696777, 6888.552244104118, 6893.655317234018, 5064.772085256246, 5189.872152417491, 5245.868853278698, 5315.123004704181, 5368.570514358764, 5118.257852611276, 5122.8975420492125, 5136.9726054789935, 5143.6399452039495, 5161.174212126042], "value": 4430.565473045428, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.8631577373685, 346.27628256942984, 346.96356882527334, 347.8573784748254, 349.55082718706467, 5642.576806739496, 5689.0044242257645, 5694.772209111636, 5730.770769169233, 5760.855978600537, 5554.000279949608, 5574.721263936807, 5579.832605021846, 5581.325602319298, 5643.351014633308, 4119.176164767051, 4198.1393814268, 4307.203167414023, 4326.329418940054, 4349.064951035527, 4329.523752387235, 4353.608175264226, 4365.934510982338, 4366.978165109186, 4382.364557139213, 4358.629516491102, 4363.694541382105, 4368.58498442649, 4377.496587892385, 4386.407834942273, 4271.78641067947, 4290.570942905716, 4326.394304797331, 4332.458442694663, 4343.978280108611, 3805.2009078093633, 3807.333716599584, 3809.8855135400117, 3811.6378944000276, 3822.866199682998, 5417.968261901787, 5450.337647017658, 5469.948769211545, 5528.336599608033, 5538.307711536058, 4891.437484689235, 4944.604431645495, 4947.431045429786, 4959.8016079356785, 5027.170516864713, 5785.132230165466, 5851.736671849734, 5875.559333050039, 5888.440598143169, 5900.20347253124, 4178.749275043507, 4195.559466256061, 4216.156768646283, 4217.536071032184, 4219.767912764797, 6028.156058151862, 6041.516678665696, 6097.817065487998, 6115.1744514490865, 6115.266168059817, 4242.363645453145, 4256.191323648497, 4271.124419493996, 4299.376590394375, 4312.094460163338, 4308.3968244445805, 4359.302511598129, 4360.302351623725, 4360.934585981213, 4371.453568303962, 4713.656607866741, 4962.238405366115, 4962.404511458576, 4975.527324904128, 4977.278294647256, 5927.429231253721, 5961.433663801932, 5975.671338076448, 5991.910121348184, 5995.160677505153, 1498.8126484189477, 1507.7889095526634, 1525.4737115695068, 1527.1982209339963, 1535.8788084698233, 957.8515330123842, 999.3604093380243, 1017.4861694844204, 1028.665683652816, 1035.8135535603665, 5708.0, 5720.942790572124, 5761.251037365199, 5762.481376676119, 5763.357443128688, 5989.790357337472, 6025.9096113558335, 6064.241969753781, 6101.542384321194, 6144.354842741537, 5558.722063896789, 5677.432256774289, 5725.456081672234, 5735.369109397963, 5744.109663002241, 3218.5976752905885, 3231.822249776285, 3234.514822776602, 3240.0, 3247.6589958054537, 6034.9094763577705, 6181.598196117238, 6201.286852011986, 6254.530910181755, 6258.249010118815, 6043.7884674036195, 6072.0, 6135.9079613805825, 6150.292716337589, 6153.1693221415435, 5945.3757355477055, 6136.8772624547255, 6143.354947730513, 6214.285357183981, 6265.8120256392385, 5901.852453688693, 5976.910346344721, 5995.880082398415, 6018.939810601838, 6021.668808215415, 5903.557233207613, 5958.867815115114, 5998.820035398945, 6004.819855404345, 6046.5767396281835, 6006.357202830741, 6208.25500939872, 6210.875782484235, 6221.004639257697, 6247.68761561911, 4265.402843601836, 4276.3799249109325, 4290.785460727014, 4297.806598703003, 4298.548652391454, 5869.970650146893, 6008.87982240344, 6051.668632900754, 6052.576319657758, 6065.332813390435, 5793.91309130355, 5830.2129212555765, 5834.737436815269, 5869.647821130746, 5874.5887787854435, 5829.067349224104, 5839.591228613956, 5858.7070646466655, 5860.472557469848, 5887.764489420375, 5213.374395072616, 5720.599558030898, 5750.769969201185, 5776.451237132465, 5777.884442311046, 5951.345352011189, 5951.821445356646, 5981.0, 6008.339082700987, 6021.54838387114, 5649.293838270216, 5808.970955145197, 5860.443257890493, 5870.618409803349, 5875.383084776208], "value": 4482.967483785961, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.1599744296614, 742.8068702137442, 745.5079647432692, 804.1476035402472, 854.2013217641505, 14322.785158222621, 15649.139297338641, 15818.76271855923, 15835.445759398423, 15838.049717016973, 13067.673308167301, 14302.71394572108, 14616.342264598092, 14779.482718104868, 14817.629559261024, 808.8544062068826, 817.2562967699365, 817.9345652347798, 820.6184124382161, 823.5223570329194, 810.2100452059254, 810.8743144812563, 811.119934870666, 811.2050190813006, 812.5815205169342, 855.3969451536652, 856.1566856646199, 859.1537335724306, 860.423516244118, 862.3187681731424, 852.4544291653347, 852.4757274276276, 853.9829203415959, 854.5556310718423, 857.0229937870832, 619.5415392609436, 621.9160413344185, 622.2843729710869, 623.2396476298908, 623.6725718997517, 15033.744938259239, 15205.923970380078, 15285.770713439308, 15307.234638268043, 15675.686486270324, 15394.769078463833, 15448.691026179526, 15469.0, 15801.130937798416, 15809.683806323808, 12375.690607734789, 12409.689757756129, 12511.874881251253, 12526.123171378007, 12663.176893501894, 3890.105275786585, 3915.530136383624, 3938.4879965604287, 3954.130091379892, 4079.143379890197, 51425.228621570706, 63230.683846580476, 67907.98138027983, 67927.66036169836, 71439.0, 12200.0, 12403.875961240452, 12407.007439404826, 12640.810387844189, 12683.936580317224, 20352.18591256333, 21038.684419733716, 21167.25914592982, 22061.779382206292, 22065.227717029826, 8767.517786521803, 8906.332025098143, 9014.729558113268, 9088.954555227314, 9378.718638440858, 4852.417709874838, 4911.361523001987, 4938.703677779345, 4941.209406494943, 4992.750362481861, 3714.2200137971327, 3785.981070094687, 3793.5827059024036, 3816.5038544988975, 3822.1591249925527, 665.3147258323934, 668.6556423441931, 677.376813331736, 686.2177118085386, 687.3744892148121, 683.2791405067701, 700.3661686174021, 726.7093162734948, 752.9849403011909, 777.739457281817, 10603.151747860153, 10855.348679079281, 10888.67333979966, 11037.39294338803, 11128.0, 647.0876064748682, 658.5127006015514, 732.4835990626596, 756.7124492692742, 764.5259938837845, 5003.24951257307, 5122.206058060932, 5181.300524429229, 5195.19474481456, 5272.841814745487, 72550.63724681448, 73877.6306118466, 93604.0, 119716.40141799235, 120510.3974480122, 93730.0, 99318.0, 100333.48165850803, 100949.49525252474, 101380.49309753404, 76372.23627763652, 76694.61652691812, 77382.22617773863, 86540.56729716437, 88541.55729221442, 10509.789804204025, 10775.040675081886, 10840.349579025284, 10848.566057357617, 10954.890451095387, 44135.77932110319, 45361.09277814491, 51415.48584514107, 53971.0, 55771.163432547735, 52091.0, 53458.4654153469, 62268.06597900944, 72859.08563657607, 73417.0, 13609.863901361256, 13686.0, 13793.862061379257, 13961.650958726113, 14316.498922537661, 14147.080439771382, 15079.849201507845, 15117.0, 15299.770503442234, 15812.288447019682, 14441.0, 14888.478903238334, 14932.328045237773, 14992.0, 15301.693966120838, 14418.783718244444, 14535.491257805927, 14656.193909335088, 14727.55817325482, 14867.776983345475, 13890.30548472552, 13992.580222593338, 14039.929800351341, 14411.42354305816, 14606.780898286323, 11262.380569068451, 11687.0, 12044.879551204725, 12179.573714919936, 12199.0, 12047.518099276282, 12060.638180854588, 12397.194182378116, 12398.380080995734, 12445.813312800496], "value": 7713.3955525280935, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 111.0, 111.0, 112.0, 112.0, 112.0, 111.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 126.0, 154.0, 191.0, 126.0, 153.0, 154.0, 131.0, 185.0, 129.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 160.0, 163.0, 166.0, 169.0, 164.0, 161.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 158.0, 74.0, 74.0, 75.0, 74.0, 182.0, 76.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 145.0, 86.0, 85.0, 85.0, 132.0, 85.0, 86.0, 134.0], "value": 101.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 120.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 54.0, 57.0, 55.0, 53.0, 55.0, 65.0, 53.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 64.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 80.0, 86.0, 84.0, 81.0, 81.0, 107.0, 78.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 123.0, 134.0, 135.0, 122.0, 126.0, 134.0, 135.0, 134.0, 127.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 158.0, 161.0, 160.0, 162.0, 156.0, 155.0, 163.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 67.0, 65.0, 63.0, 67.0, 66.0, 61.0, 62.0], "value": 64.8, "unit": "score"}]}]} 21:26:04 INFO - Return code: 0 21:26:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:26:04 ERROR - # TBPL SUCCESS # 21:26:04 INFO - Running post-action listener: _resource_record_post_action 21:26:04 INFO - ##### 21:26:04 INFO - ##### Finished run-tests step (success) 21:26:04 INFO - ##### 21:26:04 INFO - Running post-run listener: _resource_record_post_run 21:26:04 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 542752768; Read time: 168; Write time: 534088 21:26:04 INFO - TinderboxPrint: CPU usage
13.4% 21:26:04 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 168 21:26:04 INFO - TinderboxPrint: I/O write bytes / time
542,752,768 / 534,088 21:26:04 INFO - TinderboxPrint: CPU idle
8,217.5 (86.5%) 21:26:04 INFO - TinderboxPrint: CPU user
1,222.5 (12.9%) 21:26:04 INFO - TinderboxPrint: Swap in / out
0 / 0 21:26:04 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248410112; Read time: 0; Write time: 361196 21:26:04 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294342656; Read time: 168; Write time: 172892 21:26:05 INFO - Running post-run listener: _upload_blobber_files 21:26:05 INFO - Blob upload gear active. 21:26:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:26:05 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 21:26:05 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:26:05 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:26:05 INFO - (blobuploader) - INFO - Open directory for files ... 21:26:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:26:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:26:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:26:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:26:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:26:06 INFO - (blobuploader) - INFO - Done attempting. 21:26:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:26:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:26:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:26:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:26:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:26:10 INFO - (blobuploader) - INFO - Done attempting. 21:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:26:11 INFO - (blobuploader) - INFO - Done attempting. 21:26:11 INFO - (blobuploader) - INFO - Iteration through files over. 21:26:11 INFO - Return code: 0 21:26:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:26:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:26:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b606e0f3bfaa6984703f4087e960c0352651ffa9308f55336711d59111eb2610f8d8e2fde51e28fbd5d8454a3c8d72ca9dd611c6dea4481234870c2aadd4e5da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/4d0caeab4a6c538f310092bacba3fd3cd8937105005cafcb1b078991fa48fc3d7569189f64ed26bf312f35abd1e8dda772ed3889bfa06c3cc54d0e81360a0a7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/f38bb20a5ff0862db086f5ca8965bec78e278e61f296da63cc0f15df94638c2b6e0642fd50b782d38de8e31352de747c3543f75bf25f0cd654085fe4833cbe85"} 21:26:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:26:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:26:11 INFO - Contents: 21:26:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b606e0f3bfaa6984703f4087e960c0352651ffa9308f55336711d59111eb2610f8d8e2fde51e28fbd5d8454a3c8d72ca9dd611c6dea4481234870c2aadd4e5da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/4d0caeab4a6c538f310092bacba3fd3cd8937105005cafcb1b078991fa48fc3d7569189f64ed26bf312f35abd1e8dda772ed3889bfa06c3cc54d0e81360a0a7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/f38bb20a5ff0862db086f5ca8965bec78e278e61f296da63cc0f15df94638c2b6e0642fd50b782d38de8e31352de747c3543f75bf25f0cd654085fe4833cbe85"} 21:26:11 INFO - Running post-run listener: copy_logs_to_upload_dir 21:26:11 INFO - Copying logs to upload dir... 21:26:11 INFO - mkdir: /builds/slave/test/build/upload/logs 21:26:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.115269 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-03 21:26:11.614582) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 21:26:11.617862) ========= 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=db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745 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/Larch/sha512/b606e0f3bfaa6984703f4087e960c0352651ffa9308f55336711d59111eb2610f8d8e2fde51e28fbd5d8454a3c8d72ca9dd611c6dea4481234870c2aadd4e5da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/4d0caeab4a6c538f310092bacba3fd3cd8937105005cafcb1b078991fa48fc3d7569189f64ed26bf312f35abd1e8dda772ed3889bfa06c3cc54d0e81360a0a7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/f38bb20a5ff0862db086f5ca8965bec78e278e61f296da63cc0f15df94638c2b6e0642fd50b782d38de8e31352de747c3543f75bf25f0cd654085fe4833cbe85"} build_url:https://queue.taskcluster.net/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/bvR-SOyuQke1NpYqgB2DQw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b606e0f3bfaa6984703f4087e960c0352651ffa9308f55336711d59111eb2610f8d8e2fde51e28fbd5d8454a3c8d72ca9dd611c6dea4481234870c2aadd4e5da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/4d0caeab4a6c538f310092bacba3fd3cd8937105005cafcb1b078991fa48fc3d7569189f64ed26bf312f35abd1e8dda772ed3889bfa06c3cc54d0e81360a0a7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/f38bb20a5ff0862db086f5ca8965bec78e278e61f296da63cc0f15df94638c2b6e0642fd50b782d38de8e31352de747c3543f75bf25f0cd654085fe4833cbe85"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 21:26:11.643234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 21:26:11.643592) ========= 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=db0483c52d987ecb441a263b000001ad-1465007197.501377-771774745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 21:26:11.726563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 21:26:11.726985) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 21:26:11.727367) ========= ========= Total master_lag: 0.18 =========