builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1466241085.55 results: success (0) buildid: 20160617233003 builduid: 1c2b73f4bc20486abc510eb2e476775b revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.550211) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.550691) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.551007) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.590906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.591207) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-18 02:11:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 94.3M=0s 2016-06-18 02:11:27 (94.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110824 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.730205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.730536) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017712 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.789463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:25.789871) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3ce53bd1e25b93140484d3933c9339a829e0c1eb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3ce53bd1e25b93140484d3933c9339a829e0c1eb --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=a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-18 02:11:27,807 truncating revision to first 12 chars 2016-06-18 02:11:27,807 Setting DEBUG logging. 2016-06-18 02:11:27,807 attempt 1/10 2016-06-18 02:11:27,807 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3ce53bd1e25b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-18 02:11:28,143 unpacking tar archive at: fx-team-3ce53bd1e25b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.713616 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:26.518113) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:26.518430) ========= script_repo_revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:26.518879) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:26.519189) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 02:11:26.528231) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-18 02:11:26.528558) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:11:28 INFO - MultiFileLogger online at 20160618 02:11:28 in /builds/slave/test 02:11:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:11:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:11:28 INFO - {'append_to_log': False, 02:11:28 INFO - 'base_work_dir': '/builds/slave/test', 02:11:28 INFO - 'blob_upload_branch': 'Fx-Team', 02:11:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:11:28 INFO - 'branch': 'Fx-Team', 02:11:28 INFO - 'buildbot_json_path': 'buildprops.json', 02:11:28 INFO - 'config_files': ('talos/linux_config.py',), 02:11:28 INFO - 'default_actions': ('clobber', 02:11:28 INFO - 'read-buildbot-config', 02:11:28 INFO - 'download-and-extract', 02:11:28 INFO - 'populate-webroot', 02:11:28 INFO - 'create-virtualenv', 02:11:28 INFO - 'install', 02:11:28 INFO - 'run-tests'), 02:11:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:11:28 INFO - 'download_minidump_stackwalk': True, 02:11:28 INFO - 'download_symbols': 'ondemand', 02:11:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:11:28 INFO - 'tooltool.py': '/tools/tooltool.py', 02:11:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:11:28 INFO - '/tools/misc-python/virtualenv.py')}, 02:11:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:11:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:11:28 INFO - 'installer_path': 'installer.exe', 02:11:28 INFO - 'log_level': 'info', 02:11:28 INFO - 'log_name': 'talos', 02:11:28 INFO - 'log_to_console': True, 02:11:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:11:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:11:28 INFO - 'opt_config_files': (), 02:11:28 INFO - 'pip_index': False, 02:11:28 INFO - 'sps_profile': False, 02:11:28 INFO - 'sps_profile_interval': 0, 02:11:28 INFO - 'suite': 'dromaeojs-e10s', 02:11:28 INFO - 'system_bits': '32', 02:11:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:11:28 INFO - 'title': 'talos-linux64-ix-064', 02:11:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:11:28 INFO - 'use_talos_json': True, 02:11:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:11:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:11:28 INFO - 'work_dir': 'build'} 02:11:28 INFO - ##### 02:11:28 INFO - ##### Running clobber step. 02:11:28 INFO - ##### 02:11:28 INFO - Running pre-action listener: _resource_record_pre_action 02:11:28 INFO - Running main action method: clobber 02:11:28 INFO - rmtree: /builds/slave/test/build 02:11:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:11:29 INFO - Running post-action listener: _resource_record_post_action 02:11:29 INFO - ##### 02:11:29 INFO - ##### Finished clobber step (success) 02:11:29 INFO - ##### 02:11:29 INFO - ##### 02:11:29 INFO - ##### Running read-buildbot-config step. 02:11:29 INFO - ##### 02:11:29 INFO - Running pre-action listener: _resource_record_pre_action 02:11:29 INFO - Running main action method: read_buildbot_config 02:11:29 INFO - Using buildbot properties: 02:11:29 INFO - { 02:11:29 INFO - "project": "", 02:11:29 INFO - "product": "firefox", 02:11:29 INFO - "script_repo_revision": "production", 02:11:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:11:29 INFO - "repository": "", 02:11:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:11:29 INFO - "buildid": "20160617233003", 02:11:29 INFO - "pgo_build": "True", 02:11:29 INFO - "basedir": "/builds/slave/test", 02:11:29 INFO - "buildnumber": 487, 02:11:29 INFO - "slavename": "talos-linux64-ix-064", 02:11:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:11:29 INFO - "platform": "ubuntu64_hw", 02:11:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:11:29 INFO - "branch": "fx-team", 02:11:29 INFO - "repo_path": "integration/fx-team", 02:11:29 INFO - "revision": "3ce53bd1e25b93140484d3933c9339a829e0c1eb", 02:11:29 INFO - "stage_platform": "linux64-pgo", 02:11:29 INFO - "builduid": "1c2b73f4bc20486abc510eb2e476775b", 02:11:29 INFO - "slavebuilddir": "test" 02:11:29 INFO - } 02:11:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:11:29 INFO - Running post-action listener: _resource_record_post_action 02:11:29 INFO - ##### 02:11:29 INFO - ##### Finished read-buildbot-config step (success) 02:11:29 INFO - ##### 02:11:29 INFO - ##### 02:11:29 INFO - ##### Running download-and-extract step. 02:11:29 INFO - ##### 02:11:29 INFO - Running pre-action listener: _resource_record_pre_action 02:11:29 INFO - Running main action method: download_and_extract 02:11:29 INFO - mkdir: /builds/slave/test/build/tests 02:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:29 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:11:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:11:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:11:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:11:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:11:36 INFO - Downloaded 1361 bytes. 02:11:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:11:36 INFO - Using the following test package requirements: 02:11:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:11:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:11:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:11:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'jsshell-linux-x86_64.zip'], 02:11:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:11:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:11:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:11:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:11:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:11:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:11:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:11:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:36 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:11:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:11:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:11:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:11:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:11:41 INFO - Downloaded 24221020 bytes. 02:11:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:11:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:11:43 INFO - Return code: 0 02:11:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:11: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')]} 02:11:43 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:11:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:11:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:11:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:11:44 INFO - Downloaded 24221020 bytes. 02:11:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:11:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:11:45 INFO - Return code: 0 02:11: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')]} 02:11:45 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:11:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:11:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:11:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:11:46 INFO - Downloaded 14405384 bytes. 02:11:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:11:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:11:47 INFO - Return code: 0 02:11: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')]} 02:11:47 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:11:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:11:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:11:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:11:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:11:48 INFO - Downloaded 60128862 bytes. 02:11:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:11:48 INFO - mkdir: /builds/slave/test/properties 02:11:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:11:48 INFO - Writing to file /builds/slave/test/properties/build_url 02:11:48 INFO - Contents: 02:11:48 INFO - build_url:https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:11:49 INFO - Running post-action listener: _resource_record_post_action 02:11:49 INFO - Running post-action listener: set_extra_try_arguments 02:11:49 INFO - ##### 02:11:49 INFO - ##### Finished download-and-extract step (success) 02:11:49 INFO - ##### 02:11:49 INFO - ##### 02:11:49 INFO - ##### Running populate-webroot step. 02:11:49 INFO - ##### 02:11:49 INFO - Running pre-action listener: _resource_record_pre_action 02:11:49 INFO - Running main action method: populate_webroot 02:11:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:11:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:11:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:11:49 INFO - '--tppagecycles', 02:11:49 INFO - '7'], 02:11:49 INFO - 'tests': ['tsvgm']}}, 02:11:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:11:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:11:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:11:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:11:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:11:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:11:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:49 INFO - 'talos_options': ['--disable-e10s'], 02:11:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:11:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:11:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:49 INFO - 'talos_options': ['--disable-e10s'], 02:11:49 INFO - 'tests': ['damp', 'tps']}, 02:11:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:49 INFO - 'tests': ['damp', 'tps']}, 02:11:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:11:49 INFO - 'tests': ['dromaeo_dom']}, 02:11:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:11:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:11:49 INFO - 'tests': ['basic_compositor_video']}, 02:11:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:11:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:11:49 INFO - 'tests': ['a11yr', 02:11:49 INFO - 'ts_paint', 02:11:49 INFO - 'tpaint', 02:11:49 INFO - 'sessionrestore', 02:11:49 INFO - 'sessionrestore_no_auto_restore', 02:11:49 INFO - 'tabpaint']}, 02:11:49 INFO - 'other-e10s': {'tests': ['a11yr', 02:11:49 INFO - 'ts_paint', 02:11:49 INFO - 'tpaint', 02:11:49 INFO - 'sessionrestore', 02:11:49 INFO - 'sessionrestore_no_auto_restore', 02:11:49 INFO - 'tabpaint']}, 02:11:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:11:49 INFO - 'ts_paint', 02:11:49 INFO - 'tpaint', 02:11:49 INFO - 'sessionrestore', 02:11:49 INFO - 'sessionrestore_no_auto_restore', 02:11:49 INFO - 'tabpaint']}, 02:11:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:11:49 INFO - 'ts_paint', 02:11:49 INFO - 'tpaint', 02:11:49 INFO - 'sessionrestore', 02:11:49 INFO - 'sessionrestore_no_auto_restore', 02:11:49 INFO - 'tabpaint']}, 02:11:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:11:49 INFO - 'tests': ['a11yr', 02:11:49 INFO - 'ts_paint', 02:11:49 INFO - 'tpaint', 02:11:49 INFO - 'sessionrestore', 02:11:49 INFO - 'sessionrestore_no_auto_restore', 02:11:49 INFO - 'tabpaint']}, 02:11:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:11:49 INFO - 'tests': ['a11yr', 02:11:49 INFO - 'ts_paint', 02:11:49 INFO - 'tpaint', 02:11:49 INFO - 'sessionrestore', 02:11:49 INFO - 'sessionrestore_no_auto_restore', 02:11:49 INFO - 'tabpaint']}, 02:11:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:11:49 INFO - 'tests': ['tsvgx', 02:11:49 INFO - 'tsvgr_opacity', 02:11:49 INFO - 'tart', 02:11:49 INFO - 'tscrollx', 02:11:49 INFO - 'cart']}, 02:11:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:11:49 INFO - 'tsvgr_opacity', 02:11:49 INFO - 'tart', 02:11:49 INFO - 'tscrollx', 02:11:49 INFO - 'cart']}, 02:11:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:49 INFO - 'talos_options': ['--disable-e10s'], 02:11:49 INFO - 'tests': ['tp5o']}, 02:11:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:49 INFO - 'tests': ['tp5o']}, 02:11:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:49 INFO - 'talos_options': ['--disable-e10s', 02:11:49 INFO - '--xperf_path', 02:11:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:11:49 INFO - 'tests': ['tp5n']}, 02:11:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:49 INFO - 'talos_options': ['--xperf_path', 02:11:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:11:49 INFO - 'tests': ['tp5n']}}, 02:11:49 INFO - 'talos.zip': {'path': '', 02:11:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:11:49 INFO - Running post-action listener: _resource_record_post_action 02:11:49 INFO - ##### 02:11:49 INFO - ##### Finished populate-webroot step (success) 02:11:49 INFO - ##### 02:11:49 INFO - ##### 02:11:49 INFO - ##### Running create-virtualenv step. 02:11:49 INFO - ##### 02:11:49 INFO - Running pre-action listener: _resource_record_pre_action 02:11:49 INFO - Running main action method: create_virtualenv 02:11:49 INFO - Creating virtualenv /builds/slave/test/build/venv 02:11: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 02:11:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:11:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:11:49 INFO - Using real prefix '/usr' 02:11:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:11:49 INFO - Installing distribute.............................................................................................................................................................................................done. 02:11:51 INFO - Installing pip.................done. 02:11:51 INFO - Return code: 0 02:11:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:51 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 0x7f53adbe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2798350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28271c0>, '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 0x28280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2828550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', '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 02:11:51 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 02:11:51 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 02:11:51 INFO - Using env: {'DISPLAY': ':0', 02:11:51 INFO - 'HOME': '/home/cltbld', 02:11:51 INFO - 'LANG': 'en_US.UTF-8', 02:11:51 INFO - 'LANGUAGE': 'en_US:en', 02:11:51 INFO - 'LOGNAME': 'cltbld', 02:11:51 INFO - 'MAIL': '/var/mail/cltbld', 02:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:51 INFO - 'MOZ_NO_REMOTE': '1', 02:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:51 INFO - 'NO_EM_RESTART': '1', 02:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:51 INFO - 'PWD': '/builds/slave/test', 02:11:51 INFO - 'SHELL': '/bin/bash', 02:11:51 INFO - 'SHLVL': '1', 02:11:51 INFO - 'TERM': 'linux', 02:11:51 INFO - 'TMOUT': '86400', 02:11:51 INFO - 'USER': 'cltbld', 02:11:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', 02:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:51 INFO - '_': '/tools/buildbot/bin/python'} 02:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11: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 02:11:52 INFO - Cleaning up... 02:11:52 INFO - Return code: 0 02:11:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:11: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')]} 02:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11: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')]} 02:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11: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 0x7f53adbe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2798350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28271c0>, '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 0x28280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2828550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', '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 02:11: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 02:11: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 02:11:52 INFO - Using env: {'DISPLAY': ':0', 02:11:52 INFO - 'HOME': '/home/cltbld', 02:11:52 INFO - 'LANG': 'en_US.UTF-8', 02:11:52 INFO - 'LANGUAGE': 'en_US:en', 02:11:52 INFO - 'LOGNAME': 'cltbld', 02:11:52 INFO - 'MAIL': '/var/mail/cltbld', 02:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:52 INFO - 'MOZ_NO_REMOTE': '1', 02:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:52 INFO - 'NO_EM_RESTART': '1', 02:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:52 INFO - 'PWD': '/builds/slave/test', 02:11:52 INFO - 'SHELL': '/bin/bash', 02:11:52 INFO - 'SHLVL': '1', 02:11:52 INFO - 'TERM': 'linux', 02:11:52 INFO - 'TMOUT': '86400', 02:11:52 INFO - 'USER': 'cltbld', 02:11:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', 02:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:52 INFO - '_': '/tools/buildbot/bin/python'} 02:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:52 INFO - Downloading/unpacking psutil>=3.1.1 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:11:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:11:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:11:54 INFO - Installing collected packages: psutil 02:11:54 INFO - Running setup.py install for psutil 02:11:54 INFO - building 'psutil._psutil_linux' extension 02:11: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 02:11: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 02:11:54 INFO - building 'psutil._psutil_posix' extension 02:11: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 02:11: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 02:11:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:11:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:11:54 INFO - Successfully installed psutil 02:11:54 INFO - Cleaning up... 02:11:54 INFO - Return code: 0 02:11:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:54 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 0x7f53adbe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2798350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28271c0>, '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 0x28280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2828550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', '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 02:11:54 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 02:11:54 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 02:11:54 INFO - Using env: {'DISPLAY': ':0', 02:11:54 INFO - 'HOME': '/home/cltbld', 02:11:54 INFO - 'LANG': 'en_US.UTF-8', 02:11:54 INFO - 'LANGUAGE': 'en_US:en', 02:11:54 INFO - 'LOGNAME': 'cltbld', 02:11:54 INFO - 'MAIL': '/var/mail/cltbld', 02:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:54 INFO - 'MOZ_NO_REMOTE': '1', 02:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:54 INFO - 'NO_EM_RESTART': '1', 02:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:54 INFO - 'PWD': '/builds/slave/test', 02:11:54 INFO - 'SHELL': '/bin/bash', 02:11:54 INFO - 'SHLVL': '1', 02:11:54 INFO - 'TERM': 'linux', 02:11:54 INFO - 'TMOUT': '86400', 02:11:54 INFO - 'USER': 'cltbld', 02:11:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', 02:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:54 INFO - '_': '/tools/buildbot/bin/python'} 02:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:11:57 INFO - Installing collected packages: mozsystemmonitor 02:11:57 INFO - Running setup.py install for mozsystemmonitor 02:11:57 INFO - Successfully installed mozsystemmonitor 02:11:57 INFO - Cleaning up... 02:11:57 INFO - Return code: 0 02:11:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:11: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')]} 02:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11: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')]} 02:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11: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 0x7f53adbe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2798350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28271c0>, '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 0x28280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2828550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', '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 02:11: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 02:11: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 02:11:57 INFO - Using env: {'DISPLAY': ':0', 02:11:57 INFO - 'HOME': '/home/cltbld', 02:11:57 INFO - 'LANG': 'en_US.UTF-8', 02:11:57 INFO - 'LANGUAGE': 'en_US:en', 02:11:57 INFO - 'LOGNAME': 'cltbld', 02:11:57 INFO - 'MAIL': '/var/mail/cltbld', 02:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:57 INFO - 'MOZ_NO_REMOTE': '1', 02:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:57 INFO - 'NO_EM_RESTART': '1', 02:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:57 INFO - 'PWD': '/builds/slave/test', 02:11:57 INFO - 'SHELL': '/bin/bash', 02:11:57 INFO - 'SHLVL': '1', 02:11:57 INFO - 'TERM': 'linux', 02:11:57 INFO - 'TMOUT': '86400', 02:11:57 INFO - 'USER': 'cltbld', 02:11:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', 02:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:57 INFO - '_': '/tools/buildbot/bin/python'} 02:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:57 INFO - Downloading/unpacking jsonschema==2.5.1 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:11:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11:59 INFO - Downloading functools32-3.2.3-2.tar.gz 02:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:11:59 INFO - warning: no files found matching '*.txt' 02:11:59 INFO - no previously-included directories found matching 'build' 02:11:59 INFO - no previously-included directories found matching 'dist' 02:11:59 INFO - no previously-included directories found matching '.git*' 02:11:59 INFO - Installing collected packages: jsonschema, functools32 02:11:59 INFO - Running setup.py install for functools32 02:11:59 INFO - warning: no files found matching '*.txt' 02:11:59 INFO - no previously-included directories found matching 'build' 02:11:59 INFO - no previously-included directories found matching 'dist' 02:11:59 INFO - no previously-included directories found matching '.git*' 02:11:59 INFO - Successfully installed jsonschema functools32 02:11:59 INFO - Cleaning up... 02:11:59 INFO - Return code: 0 02:11:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f53adbe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2798350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28271c0>, '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 0x28280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2828550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', '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 02:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:11:59 INFO - Using env: {'DISPLAY': ':0', 02:11:59 INFO - 'HOME': '/home/cltbld', 02:11:59 INFO - 'LANG': 'en_US.UTF-8', 02:11:59 INFO - 'LANGUAGE': 'en_US:en', 02:11:59 INFO - 'LOGNAME': 'cltbld', 02:11:59 INFO - 'MAIL': '/var/mail/cltbld', 02:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:59 INFO - 'MOZ_NO_REMOTE': '1', 02:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:59 INFO - 'NO_EM_RESTART': '1', 02:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:59 INFO - 'PWD': '/builds/slave/test', 02:11:59 INFO - 'SHELL': '/bin/bash', 02:11:59 INFO - 'SHLVL': '1', 02:11:59 INFO - 'TERM': 'linux', 02:11:59 INFO - 'TMOUT': '86400', 02:11:59 INFO - 'USER': 'cltbld', 02:11:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', 02:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:59 INFO - '_': '/tools/buildbot/bin/python'} 02:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:59 INFO - Downloading/unpacking blobuploader==1.2.4 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:12:01 INFO - Downloading blobuploader-1.2.4.tar.gz 02:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:12:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:12:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:02 INFO - Downloading docopt-0.6.1.tar.gz 02:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:12:02 INFO - Installing collected packages: blobuploader, requests, docopt 02:12:02 INFO - Running setup.py install for blobuploader 02:12:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:12:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:12:02 INFO - Running setup.py install for requests 02:12:03 INFO - Running setup.py install for docopt 02:12:03 INFO - Successfully installed blobuploader requests docopt 02:12:03 INFO - Cleaning up... 02:12:03 INFO - Return code: 0 02:12:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12: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')]} 02:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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')]} 02:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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 0x7f53adbe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2798350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28271c0>, '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 0x28280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2828550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', '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 02:12: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 02:12: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 02:12:03 INFO - Using env: {'DISPLAY': ':0', 02:12:03 INFO - 'HOME': '/home/cltbld', 02:12:03 INFO - 'LANG': 'en_US.UTF-8', 02:12:03 INFO - 'LANGUAGE': 'en_US:en', 02:12:03 INFO - 'LOGNAME': 'cltbld', 02:12:03 INFO - 'MAIL': '/var/mail/cltbld', 02:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:03 INFO - 'MOZ_NO_REMOTE': '1', 02:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:03 INFO - 'NO_EM_RESTART': '1', 02:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:03 INFO - 'PWD': '/builds/slave/test', 02:12:03 INFO - 'SHELL': '/bin/bash', 02:12:03 INFO - 'SHLVL': '1', 02:12:03 INFO - 'TERM': 'linux', 02:12:03 INFO - 'TMOUT': '86400', 02:12:03 INFO - 'USER': 'cltbld', 02:12:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', 02:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:03 INFO - '_': '/tools/buildbot/bin/python'} 02:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:12:03 INFO - Running setup.py (path:/tmp/pip-fAufr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:12:03 INFO - Running setup.py (path:/tmp/pip-o8Efxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:12:03 INFO - Running setup.py (path:/tmp/pip-uYoXTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:12:03 INFO - Running setup.py (path:/tmp/pip-sYF3vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:12:03 INFO - Running setup.py (path:/tmp/pip-L1yBmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:12:03 INFO - Running setup.py (path:/tmp/pip-tBt0TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:12:03 INFO - Running setup.py (path:/tmp/pip-nLDp9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:12:03 INFO - Running setup.py (path:/tmp/pip-nZqtDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:12:04 INFO - Running setup.py (path:/tmp/pip-FPSEhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:12:04 INFO - Running setup.py (path:/tmp/pip-K2tl7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:12:04 INFO - Running setup.py (path:/tmp/pip-73Co4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:12:04 INFO - Running setup.py (path:/tmp/pip-GVWjM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:12:04 INFO - Running setup.py (path:/tmp/pip-_u0MMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:12:04 INFO - Running setup.py (path:/tmp/pip-PVO5Jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:04 INFO - Running setup.py (path:/tmp/pip-MFZqwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:12:04 INFO - Running setup.py (path:/tmp/pip-jsGnCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:12:04 INFO - Running setup.py (path:/tmp/pip-Srw4Cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:12:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:12:04 INFO - Running setup.py install for manifestparser 02:12:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:12:04 INFO - Running setup.py install for mozcrash 02:12:04 INFO - Running setup.py install for mozdebug 02:12:04 INFO - Running setup.py install for mozdevice 02:12:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:12:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:12:05 INFO - Running setup.py install for mozfile 02:12:05 INFO - Running setup.py install for mozhttpd 02:12:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:12:05 INFO - Running setup.py install for mozinfo 02:12:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:12:05 INFO - Running setup.py install for mozInstall 02:12:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:12:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:12:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:12:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:12:05 INFO - Running setup.py install for mozleak 02:12:05 INFO - Running setup.py install for mozlog 02:12:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:12:05 INFO - Running setup.py install for moznetwork 02:12:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:12:05 INFO - Running setup.py install for mozprocess 02:12:05 INFO - Running setup.py install for mozprofile 02:12:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:12:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:12:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:12:06 INFO - Running setup.py install for mozrunner 02:12:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:12:06 INFO - Running setup.py install for mozscreenshot 02:12:06 INFO - Running setup.py install for moztest 02:12:06 INFO - Running setup.py install for mozversion 02:12:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:12:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:12:06 INFO - Cleaning up... 02:12:06 INFO - Return code: 0 02:12:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12: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')]} 02:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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')]} 02:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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 0x7f53adbe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2798350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28271c0>, '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 0x28280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2828550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', '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 02:12: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 02:12: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 02:12:06 INFO - Using env: {'DISPLAY': ':0', 02:12:06 INFO - 'HOME': '/home/cltbld', 02:12:06 INFO - 'LANG': 'en_US.UTF-8', 02:12:06 INFO - 'LANGUAGE': 'en_US:en', 02:12:06 INFO - 'LOGNAME': 'cltbld', 02:12:06 INFO - 'MAIL': '/var/mail/cltbld', 02:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:06 INFO - 'MOZ_NO_REMOTE': '1', 02:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:06 INFO - 'NO_EM_RESTART': '1', 02:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:06 INFO - 'PWD': '/builds/slave/test', 02:12:06 INFO - 'SHELL': '/bin/bash', 02:12:06 INFO - 'SHLVL': '1', 02:12:06 INFO - 'TERM': 'linux', 02:12:06 INFO - 'TMOUT': '86400', 02:12:06 INFO - 'USER': 'cltbld', 02:12:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', 02:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:06 INFO - '_': '/tools/buildbot/bin/python'} 02:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:12:06 INFO - Running setup.py (path:/tmp/pip-QdojTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:12:06 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)) 02:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:12:06 INFO - Running setup.py (path:/tmp/pip-wRFDYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:12:06 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)) 02:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:12:06 INFO - Running setup.py (path:/tmp/pip-4_LNI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:12:06 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)) 02:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:12:06 INFO - Running setup.py (path:/tmp/pip-2uKyZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:12: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)) 02:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:12:07 INFO - Running setup.py (path:/tmp/pip-bC4urf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:12: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)) 02:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:12:07 INFO - Running setup.py (path:/tmp/pip-Z75Ind-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:12: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)) 02:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:12:07 INFO - Running setup.py (path:/tmp/pip-jsI6MY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:12: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)) 02:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:12:07 INFO - Running setup.py (path:/tmp/pip-PXmIpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:12: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)) 02:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:12:07 INFO - Running setup.py (path:/tmp/pip-LMP2pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:12: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)) 02:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:12:07 INFO - Running setup.py (path:/tmp/pip-w1Ae_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:12: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)) 02:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:12:07 INFO - Running setup.py (path:/tmp/pip-fcYRKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:12: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)) 02:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:12:07 INFO - Running setup.py (path:/tmp/pip-bXrl_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:12: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)) 02:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:12:07 INFO - Running setup.py (path:/tmp/pip-b0jJVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:12: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)) 02:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:12:07 INFO - Running setup.py (path:/tmp/pip-fnveri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:12:07 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)) 02:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:07 INFO - Running setup.py (path:/tmp/pip-6EXoyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:07 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)) 02:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:12:07 INFO - Running setup.py (path:/tmp/pip-b7ZLXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:12:07 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)) 02:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:12:07 INFO - Running setup.py (path:/tmp/pip-eT_k5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:12: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)) 02:12: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)) 02:12: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)) 02:12: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)) 02:12: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)) 02:12: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)) 02:12:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:10 INFO - Downloading blessings-1.6.tar.gz 02:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:12:10 INFO - Installing collected packages: blessings 02:12:10 INFO - Running setup.py install for blessings 02:12:10 INFO - Successfully installed blessings 02:12:10 INFO - Cleaning up... 02:12:10 INFO - Return code: 0 02:12:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:12:10 INFO - Reading from file tmpfile_stdout 02:12:10 INFO - Current package versions: 02:12:10 INFO - argparse == 1.2.1 02:12:10 INFO - blessings == 1.6 02:12:10 INFO - blobuploader == 1.2.4 02:12:10 INFO - docopt == 0.6.1 02:12:10 INFO - functools32 == 3.2.3-2 02:12:10 INFO - jsonschema == 2.5.1 02:12:10 INFO - manifestparser == 1.1 02:12:10 INFO - mozInstall == 1.12 02:12:10 INFO - mozcrash == 0.17 02:12:10 INFO - mozdebug == 0.1 02:12:10 INFO - mozdevice == 0.48 02:12:10 INFO - mozfile == 1.2 02:12:10 INFO - mozhttpd == 0.7 02:12:10 INFO - mozinfo == 0.9 02:12:10 INFO - mozleak == 0.1 02:12:10 INFO - mozlog == 3.2 02:12:10 INFO - moznetwork == 0.27 02:12:10 INFO - mozprocess == 0.22 02:12:10 INFO - mozprofile == 0.28 02:12:10 INFO - mozrunner == 6.11 02:12:10 INFO - mozscreenshot == 0.1 02:12:10 INFO - mozsystemmonitor == 0.3 02:12:10 INFO - moztest == 0.7 02:12:10 INFO - mozversion == 1.4 02:12:10 INFO - psutil == 3.1.1 02:12:10 INFO - requests == 1.2.3 02:12:10 INFO - wsgiref == 0.1.2 02:12:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12: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')]} 02:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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')]} 02:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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 0x7f53adbe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2798350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28271c0>, '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 0x28280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2828550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', '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 02:12: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 02:12: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 02:12:10 INFO - Using env: {'DISPLAY': ':0', 02:12:10 INFO - 'HOME': '/home/cltbld', 02:12:10 INFO - 'LANG': 'en_US.UTF-8', 02:12:10 INFO - 'LANGUAGE': 'en_US:en', 02:12:10 INFO - 'LOGNAME': 'cltbld', 02:12:10 INFO - 'MAIL': '/var/mail/cltbld', 02:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:10 INFO - 'MOZ_NO_REMOTE': '1', 02:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:10 INFO - 'NO_EM_RESTART': '1', 02:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:10 INFO - 'PWD': '/builds/slave/test', 02:12:10 INFO - 'SHELL': '/bin/bash', 02:12:10 INFO - 'SHLVL': '1', 02:12:10 INFO - 'TERM': 'linux', 02:12:10 INFO - 'TMOUT': '86400', 02:12:10 INFO - 'USER': 'cltbld', 02:12:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', 02:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:10 INFO - '_': '/tools/buildbot/bin/python'} 02:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12: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)) 02:12: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)) 02:12: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)) 02:12: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)) 02:12: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)) 02:12: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)) 02:12: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)) 02:12: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)) 02:12: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)) 02:12: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)) 02:12: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)) 02:12:10 INFO - Cleaning up... 02:12:10 INFO - Return code: 0 02:12:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:12: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')]} 02:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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')]} 02:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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 0x7f53adbe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2798350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28271c0>, '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 0x28280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2828550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', '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 02:12: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 02:12: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 02:12:10 INFO - Using env: {'DISPLAY': ':0', 02:12:10 INFO - 'HOME': '/home/cltbld', 02:12:10 INFO - 'LANG': 'en_US.UTF-8', 02:12:10 INFO - 'LANGUAGE': 'en_US:en', 02:12:10 INFO - 'LOGNAME': 'cltbld', 02:12:10 INFO - 'MAIL': '/var/mail/cltbld', 02:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:10 INFO - 'MOZ_NO_REMOTE': '1', 02:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:10 INFO - 'NO_EM_RESTART': '1', 02:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:10 INFO - 'PWD': '/builds/slave/test', 02:12:10 INFO - 'SHELL': '/bin/bash', 02:12:10 INFO - 'SHLVL': '1', 02:12:10 INFO - 'TERM': 'linux', 02:12:10 INFO - 'TMOUT': '86400', 02:12:10 INFO - 'USER': 'cltbld', 02:12:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', 02:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:10 INFO - '_': '/tools/buildbot/bin/python'} 02:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:12:10 INFO - Cleaning up... 02:12:10 INFO - Return code: 0 02:12:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:12: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')]} 02:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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')]} 02:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12: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 0x7f53adbe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2798350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28271c0>, '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 0x28280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2828550>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', '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 02:12: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 02:12: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 02:12:11 INFO - Using env: {'DISPLAY': ':0', 02:12:11 INFO - 'HOME': '/home/cltbld', 02:12:11 INFO - 'LANG': 'en_US.UTF-8', 02:12:11 INFO - 'LANGUAGE': 'en_US:en', 02:12:11 INFO - 'LOGNAME': 'cltbld', 02:12:11 INFO - 'MAIL': '/var/mail/cltbld', 02:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:11 INFO - 'MOZ_NO_REMOTE': '1', 02:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:11 INFO - 'NO_EM_RESTART': '1', 02:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:11 INFO - 'PWD': '/builds/slave/test', 02:12:11 INFO - 'SHELL': '/bin/bash', 02:12:11 INFO - 'SHLVL': '1', 02:12:11 INFO - 'TERM': 'linux', 02:12:11 INFO - 'TMOUT': '86400', 02:12:11 INFO - 'USER': 'cltbld', 02:12:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', 02:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:11 INFO - '_': '/tools/buildbot/bin/python'} 02:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:11 INFO - Downloading/unpacking flake8 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:12:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:12:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:12:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:12:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:12:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:12:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:12:13 INFO - no previously-included directories found matching 'docs/_build' 02:12:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:12:13 INFO - Running setup.py install for pep8 02:12:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:12:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:12:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:12:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:12:13 INFO - no previously-included directories found matching 'docs/_build' 02:12:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:12:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:12:13 INFO - Cleaning up... 02:12:14 INFO - Return code: 0 02:12:14 INFO - Running post-action listener: _resource_record_post_action 02:12:14 INFO - Running post-action listener: _start_resource_monitoring 02:12:14 INFO - Starting resource monitoring. 02:12:14 INFO - ##### 02:12:14 INFO - ##### Finished create-virtualenv step (success) 02:12:14 INFO - ##### 02:12:14 INFO - ##### 02:12:14 INFO - ##### Running install step. 02:12:14 INFO - ##### 02:12:14 INFO - Running pre-action listener: _resource_record_pre_action 02:12:14 INFO - Running main action method: install 02:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:12:14 INFO - Reading from file tmpfile_stdout 02:12:14 INFO - Detecting whether we're running mozinstall >=1.0... 02:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:12:14 INFO - Reading from file tmpfile_stdout 02:12:14 INFO - Output received: 02:12:14 INFO - Usage: mozinstall [options] installer 02:12:14 INFO - Options: 02:12:14 INFO - -h, --help show this help message and exit 02:12:14 INFO - -d DEST, --destination=DEST 02:12:14 INFO - Directory to install application into. [default: 02:12:14 INFO - "/builds/slave/test"] 02:12:14 INFO - --app=APP Application being installed. [default: firefox] 02:12:14 INFO - mkdir: /builds/slave/test/build/application 02:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:12:31 INFO - Reading from file tmpfile_stdout 02:12:31 INFO - Output received: 02:12:31 INFO - /builds/slave/test/build/application/firefox/firefox 02:12:31 INFO - Running post-action listener: _resource_record_post_action 02:12:31 INFO - ##### 02:12:31 INFO - ##### Finished install step (success) 02:12:31 INFO - ##### 02:12:31 INFO - ##### 02:12:31 INFO - ##### Running run-tests step. 02:12:31 INFO - ##### 02:12:31 INFO - Running pre-action listener: _resource_record_pre_action 02:12:31 INFO - Running main action method: run_tests 02:12:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:12:31 INFO - Python 2.7.3 02:12:31 INFO - Return code: 0 02:12:31 INFO - grabbing minidump binary from tooltool 02:12: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')]} 02:12: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 0x28271c0>, '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 0x28280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2828550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:12: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 02:12: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 02:12: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 02:12:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:12:31 INFO - Return code: 0 02:12:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:12:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:12:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:12:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:12:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:12:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:12:32 INFO - Return code: 0 02:12:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 02:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 02:12:32 INFO - Using env: {'DISPLAY': ':0', 02:12:32 INFO - 'HOME': '/home/cltbld', 02:12:32 INFO - 'LANG': 'en_US.UTF-8', 02:12:32 INFO - 'LANGUAGE': 'en_US:en', 02:12:32 INFO - 'LOGNAME': 'cltbld', 02:12:32 INFO - 'MAIL': '/var/mail/cltbld', 02:12:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:12:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:32 INFO - 'MOZ_NO_REMOTE': '1', 02:12:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:32 INFO - 'NO_EM_RESTART': '1', 02:12:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:32 INFO - 'PWD': '/builds/slave/test', 02:12:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:12:32 INFO - 'SHELL': '/bin/bash', 02:12:32 INFO - 'SHLVL': '1', 02:12:32 INFO - 'TERM': 'linux', 02:12:32 INFO - 'TMOUT': '86400', 02:12:32 INFO - 'USER': 'cltbld', 02:12:32 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126', 02:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:32 INFO - '_': '/tools/buildbot/bin/python'} 02:12:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 02:12:32 INFO - mozversion application_buildid: 20160617233003 02:12:32 INFO - mozversion application_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 02:12:32 INFO - mozversion application_display_name: Nightly 02:12:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:12:32 INFO - mozversion application_name: Firefox 02:12:32 INFO - mozversion application_remotingname: firefox 02:12:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:12:32 INFO - mozversion application_vendor: Mozilla 02:12:32 INFO - mozversion application_version: 50.0a1 02:12:32 INFO - mozversion platform_buildid: 20160617233003 02:12:32 INFO - mozversion platform_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 02:12:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:12:32 INFO - mozversion platform_version: 50.0a1 02:12:32 INFO - using testdate: 1466241152 02:12:32 INFO - actual date: 1466241152 02:12:32 INFO - starting webserver on 'localhost:41515' 02:12:32 INFO - SUITE-START | Running 2 tests 02:12:32 INFO - TEST-START | dromaeo_css 02:12:32 INFO - operating with platform_type : linux_ 02:12:32 INFO - Initialising browser for dromaeo_css test... 02:12:32 INFO - TEST-INFO | started process 9417 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTQtx7Y/profile http://localhost:41515/getInfo.html) 02:12:37 INFO - PROCESS | 9417 | __metrics Screen width/height:1600/1200 02:12:37 INFO - PROCESS | 9417 | colorDepth:24 02:12:37 INFO - PROCESS | 9417 | Browser inner width/height: 1024/697 02:12:37 INFO - PROCESS | 9417 | __metrics 02:12:38 ERROR - PROCESS | 9417 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:12:39 INFO - TEST-INFO | 9417: exit 0 02:12:39 INFO - Browser initialized. 02:12:39 INFO - Running cycle 1/1 for dromaeo_css test... 02:12:39 INFO - TEST-INFO | started process 9538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTQtx7Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:12:51 INFO - PROCESS | 9538 | RSS: Main: 184688640 02:12:51 INFO - PROCESS | 9538 | 02:13:41 INFO - PROCESS | 9538 | 1466241221218 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] 02:15:49 INFO - PROCESS | 9538 | Cycle 1(1): loaded http://localhost:41515/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41515/tests/dromaeo/cssquery-ext.html) 02:15:50 INFO - PROCESS | 9538 | RSS: Main: 188379136 02:15:50 INFO - PROCESS | 9538 | 02:18:52 INFO - PROCESS | 9538 | Cycle 1(1): loaded http://localhost:41515/tests/dromaeo/cssquery-ext.html (next: http://localhost:41515/tests/dromaeo/cssquery-jquery.html) 02:18:53 INFO - PROCESS | 9538 | RSS: Main: 187625472 02:18:53 INFO - PROCESS | 9538 | 02:21:54 INFO - PROCESS | 9538 | Cycle 1(1): loaded http://localhost:41515/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41515/tests/dromaeo/cssquery-mootools.html) 02:21:55 INFO - PROCESS | 9538 | RSS: Main: 189558784 02:21:55 INFO - PROCESS | 9538 | 02:24:57 INFO - PROCESS | 9538 | Cycle 1(1): loaded http://localhost:41515/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41515/tests/dromaeo/cssquery-prototype.html) 02:24:57 INFO - PROCESS | 9538 | RSS: Main: 186621952 02:24:57 INFO - PROCESS | 9538 | 02:28:00 INFO - PROCESS | 9538 | Cycle 1(1): loaded http://localhost:41515/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41515/tests/dromaeo/cssquery-yui.html) 02:28:00 INFO - PROCESS | 9538 | RSS: Main: 188837888 02:28:00 INFO - PROCESS | 9538 | 02:31:03 INFO - PROCESS | 9538 | Cycle 1(1): loaded http://localhost:41515/tests/dromaeo/cssquery-yui.html (next: http://localhost:41515/tests/dromaeo/cssquery-dojo.html) 02:31:03 INFO - PROCESS | 9538 | RSS: Main: 189652992 02:31:03 INFO - PROCESS | 9538 | 02:31:03 INFO - PROCESS | 9538 | __start_tp_report 02:31:03 INFO - PROCESS | 9538 | _x_x_mozilla_page_load 02:31:03 INFO - PROCESS | 9538 | _x_x_mozilla_page_load_details 02:31:03 INFO - PROCESS | 9538 | |i|pagename|runs| 02:31:03 INFO - PROCESS | 9538 | |0;dojo.html;3091.5362695595672;3106.6582675905647;3143.3713257348522;3156.7001134892175;3168.5722427472283;5455.18172274159;5477.561795056396;5504;5528.5024347808685;5541.27963364763;5396.379416367119;5486.259354987075;5507.146392309199;5520.447955204478;5558.6942718150485;4940.209566469374;4974.353334066566;5083.339165908426;5114.795408183668;5179.430262671103;739.2388233338874;4909.140900342443;4932.679375840559;5051.116054690433;5072.112380333445;4952.851414457536;4975.626827987898;4988.900221995576;4994.300797888299;4999.725015124167;5006.3992320921725;5021.698698078127;5024.974875125601;5029.723365214912;5066.392032956032;4947.876303092416;4979.975100124512;5002.974985125087;5026.874328141826;5045.293658887758;5472.398036216013;5536.141898005815;5539.224508568804;5561.694106824123;5632.887342253173;5712.171735098387;5820.534357251409;5878.441548052928;5882.470577648032;5898.056310990221;5931.021381472052;5950.107483877409;5998.910016349758;6028.638281703112;6078.149059131725;5493.752781124859;5524;5549.889002219973;5554.444555544454;5559.082751346023;5890.911636325459;5976.970115149396;6017.06735456005;6071.119687645355;6088.634681919099;5688.004599195125;5697.145428185722;5703.429657034263;5705.942940570624;5720.256366672306;5858.970705146532;5870.178175055496;5877.441643043904;5890.764369425261;5895;5764.164196191528;5806.738696758656;5830.038043722739;5839.124131380327;5875.735591898375;5842.386549412336;5896.675682837399;5905.379935106838;5916.497097746654;5921.3782552831335;4396.999999999936;4458.464984201916;4465.352523884018;4485.237509623372;4529.773511324486;3908.511436070491;3933.272344616255;3956.090099277125;3994.6205110514456;4001.799910004488;5587;5588.692621905753;5593.860153496195;5619.016672082369;5703.287089113861;5828.329742079631;5951.3751056139345;5955.910661340084;5967.433093856077;5968.820935371946;5552.666839989613;5570.192322113271;5627.887442251132;5653.802116925888;5654.575906807006;4742.57316841479;4763.04739052191;4770.141374552614;4780.665353425296;4812.470628230892;5958.910616340671;5994.670293133832;6100.298465676416;6107.572469927062;6123.08153776937;5901.527877769682;5926.318473375617;5929.555283353852;5932.762689492372;5947.553933454921;6023.247094113236;6023.6385816851125;6033.18551995475;6053.152558641706;6071.483923866521;5663.433656634304;5717.399673034438;5727.914081288701;5761.654300741969;5774.509166720875;5881;5884.440978107073;5914.58597898143;5926.051831706906;5965;5751.654900705971;5764.0201165802755;5764.481196692318;5767.509761670305;5768.307803063659;5630.239917611234;5651.265335506358;5739.225204597493;5747.626404283876;5805.448482394166;5718.199452076629;5757.625754325955;5776.740046697824;5778.191053252632;5784.334801497882;5832.795852145155;5838.912416313674;5872.823815285548;5898.705064746831;5906.26171728534;5602.131669591057;5659.830205093854;5705.201271822031;5713.257276554022;5768.971155144198 02:31:03 INFO - PROCESS | 9538 | |1;ext.html;568.4883604755719;613.1752792494095;613.9048447490637;634.9619022858627;655.7344275568396;39837.80081099594;40747;45095;45100.32349514756;45173.54826451735;46054;46338;46397.7680111599;46583.30125048127;46725.06549869009;8882.289416846654;9026.638934442615;9046.457212567268;9047.050059743731;9058.27533797298;8670.306375489945;8785.516796576187;8795.912040879573;8847.33644976626;8851.468911865277;8814.25078868297;8859.601317940676;8885.511296878669;8905;8911.15344042315;8758.47449153053;8806.4275822072;8887.155720206601;8893.599788009555;8897.510636914967;8822.426542274732;8934.151255630704;8935.597898094602;8949.55252237392;8961.641534338618;42897.57102428967;42980;43086.353704694455;43143.35284970728;43177.78411107924;3708.554973403182;3744.2885851688093;3802.752821066622;3805.562360328542;4181.963288108534;30098.699013010028;32599.83700081508;32923;33339;33820.83089584536;4033.455483509718;4415.735055896656;4517.141743068806;4526.2984237442915;4600.746958917258;353549;354372;355021;358198.9999999974;358226.9999999974;61359.6932015346;61977;62253.37746622566;62279;62348.06477902835;35786.8210658945;36554.80671159739;36769.63230367716;38510;67212;13815;13852.307384630729;13961.720765584632;14016.789748153786;14051.227182505061;10121.544530496145;10264.43545604984;10315.432651204255;10328.638497652546;10334.17326613869;19487.44100471959;19582.902085489768;19590.5102372439;19631.31290404829;19830.305939292342;7056.788296351117;7119.323664251888;7281.5995120267835;7357.952846921837;7401.85271282952;981.5681100315838;1017.8269694152012;1019.1286450085071;1077.0575746222055;1084.1272775415707;31062.45860082;32655.673443265263;32941.67058329434;32974.17564560857;33206.83396583002;1058.761249338276;1103.3545375954996;1103.4593049405732;1151.1769085104024;1210.2919791921825;16896;17391.304347826197;17552.473425797245;17564.824351756575;18141.183646735928;564164;566890;569885;572810;575306;60951.39048609546;61287.38712612906;61386;61402.692986534785;61458.69270653618;1261.9808306709192;1309.2602679486251;1310.2138716770053;1319.9472021119047;1326.263923522435;32654.836725817167;33636;33864.15339616529;33887.661123388454;34183.31633367368;52149;53174.202386965;53231;53275.20087198618;53360.466395337105;497202;499373;500151;500279;501147;28319;29036.419271614028;29480.55779163357;29531.40937181287;29552;47018.76490617525;48173.27740083831;48416.5158348412;49458.50541494683;49840.25239621481;40731;40837.79581102194;40907.59092409038;41633.37549936693;42371.7881410591;40570;41273;41389.37915931203;41524.3771343424;42384.576154239294;31314.373712526078;31928.605354598032;32209.67790322067;32323.838380807945;32336;33692;36124.27751445009;36980.44529332008;37126.44310335401;37324.25351493009;28097.297567560156;28162.155135345973;28389.716102839535;28560;28565 02:31:03 INFO - PROCESS | 9538 | |2;jquery.html;370.10434747910074;385.3064483928927;386.961303869613;394.5876558995849;406.21600311399004;17369.131543422827;19126.99999999998;19355.580552430947;19397.22411103556;19624.41126766196;11004;11466.656000320003;17578.736318955227;18579.535511612215;18654.347097851576;5252.3697156341195;5347.197920311945;5413.837584872441;5435.2934118564535;5438.021156191884;4021.1153546219784;5536.501714845663;5864.032434648299;5865.912011319812;5899.734511946951;5872.031114866042;5891.499222566087;5909.290885093795;5919.58562900595;6255.343188965161;6411.294757576663;6485.70814313357;6496.740130394778;6535.60786352818;6541;5737.627054241461;5762.164486149527;5762.510186634099;5793.710314484259;5807.361190269067;13001.414936327794;13214.86785132146;13427.060105792598;13513.256770877599;13592.38834252461;2211.4360837986374;2214.059024914421;2257.920972765962;2340.1224540797202;2547.210364786922;10245.692629221136;10372.63695770652;14080.22558759278;14321.069130506588;14377.712445751027;1924.8652594318403;1946.3674305850514;1950.2642648043252;1967.7146813712075;1984.9106790194476;79411;80957;81094.18905810926;81904;82981.58509207415;10774;10804.405757683402;10881.183911206534;10917.39954302521;10963.068139208257;14232.43070277198;14301.713965720628;14313.499027533986;14323.78514322286;14378;7110.786676399716;7385.9630701846145;7426.2945020223;7536.773896783106;7547.962260188664;6841.897371539431;6917.9308206917285;7063.04648872406;7065.646717664096;7084.539504932163;4546.749928753884;4650.627949764078;4727.787249573777;4824.372831531949;4831.106245344622;1758.6746451906183;1866.9439916802517;1969.9704504432445;1987.7316562264198;2048.6619707748055;1001.449202938381;1010.802893435773;1024.364893765855;1027.8766548014287;1093.5297821936645;18700.438986830417;18746.250149993848;19075.523111922037;19456;19607.90196049039;950.396498223633;952.6284748947916;952.9103470181825;965.1747755668943;984.9655262065793;10367.844482332772;10909.509072091774;10926.726831829268;11010.449477526092;11024.228304018801;489076;495384;495905;512571;518394;93594.53202733943;103286;104547;104906;106096;979.72567681048;982.4792859784326;1008.0977525115128;1017.1608423051013;1023.4729114506184;17665.823341766933;17765.733513997042;18193.81806181974;18221.908890455463;18323.54191145232;41376.37935430911;43527;43837.34243986279;44086.33870492009;44955.550444496446;61062.38937610567;62648.686756567746;62881;63084;63233;7593.202713714981;8567.871481927901;8630.870536941826;8747.737567872973;8881.111888811325;12932.806007909701;13322.866771332163;13353.53262635803;14043.859561404664;14075.929620352243;11773.52905883755;12031.097667674785;12145.39273036327;12287.56993505223;12302;12013.45939432745;12316.81524777147;12324.32216228116;12467.625971220878;12695.174813637084;10854.457277135954;11743.76512469763;11863.525458981889;12399.876001239872;12424.130310878152;7602.847943041219;7787.10448298453;7910.604469776603;7954.960225199068;8005.3995950305125;11279.492422840827;11624.244424112743;11781.941090294493;11805.23265987708;11850.822237666614 02:31:03 INFO - PROCESS | 9538 | |3;mootools.html;1474.7640377539597;1483.8293596236433;1609.4125644139885;1747.9825201747979;1757.2882982392136;7954.2841144297;8234.094249632535;8524.829503409936;9047.14052165044;9064.592093355799;8375.120612335708;8519.914800852006;8682.652693892236;8728.91271087289;8748.912510874889;2350.5416443793465;2423.200343886522;2426.2478631624253;2429.9392515187087;2439.2194497760725;2294.1855641247366;2310.353101131686;2328.604137296664;2379.2267513058237;2401.519696060786;2324.59319619066;2338.064774090369;2344.34358379654;2360.7403185649564;2404.9639255411184;2258.5144193998285;2271.4094335472732;2292.770722927702;2294.7016887804643;2326.4998025424616;2260.2202240227093;2260.9208677696365;2273.1589311954517;2277.180215122571;2280.486890449652;8775.473471591726;8821.647134114692;8864.202221800004;8871.733847984571;8879.556022198864;4973.726445045521;5012.538693624875;5113.207452844815;5115.18157094863;5118.488151184889;3354.7987120772586;3471.6528347165336;3525.806080665562;3557.1640664443835;3591.2637909228547;1095.315427857589;1146.7419830538145;1173.12015988009;1201.435325397062;1208.1844754790482;11989.64031079069;12197.146199765932;12217.083718721042;12217.93891030539;12237;4716.221823399101;4749.810007599657;4771.594414474739;4803;4845.394325709286;10383.376997380181;10389.94805025985;10411.271211015308;10414.271001030007;10451.425171615634;5136;5221.973890130525;5233.790648374023;5233.790648374099;5339.86650333737;4358.455193100863;4530.093981203772;4642.0019695764895;4647.488776234679;4801.279808028824;4004.439378487014;4025.5571887092397;4104.856330028435;4126.195391898551;4154.480689913761;1259.0808709642013;1299.2074834351038;1300.3303298801125;1306.6667999660217;1309.9803502947464;932.3007744191856;953.9236861051099;958.4393130018877;960.9903900960901;987.2842189412619;5665.858353541194;5783.9648210355;5896.675682837399;5904.498117659961;5957.324648455495;470.33212837770446;475.3535192138689;480.68034756886976;484.709174495307;486.7444591589444;3957.8021098944937;4088.1414902870138;4138.275801734684;4199.139176468817;4222.0500387412585;11258.605948791754;11339.829902551468;11359.261647992855;11501.13741469393;11515.424228788695;11343.943280283545;11387.430628468543;11389.487473063731;11393.601223957121;11408.543658253577;7767.766966990999;8139.104698483162;8156.429049966446;8259.174082591693;8306.418550701514;5921.940780592311;5943.748083220401;5979.431953964367;6190.597611155261;6193.969030154821;10256.794864102527;10475.109615682448;10486.318389304672;10487.213458990758;10487.685369438928;10297.53661085268;10328.586856525955;10682.786344273227;10715.249932504961;10739.409332486788;7126.358627723323;7535.058117735283;7617;7767.572783496736;8072.4349295548745;8522.74431767048;8559.700410485602;8588.098249683693;8628.78428039304;8663.696770612998;7596.316331529968;7861.25318094803;7935;8002.759917202493;8011.479253848481;7661;7774.92225077742;7810.648520816463;7824.64789084504;7855.018122734658;7093.964530177316;7108.928910710827;7191.065161529177;7204.3155900189395;7232.276772322936;4980;5130.358705161855;5244.868878277921;5296.099663057213;5384.138537834085;5142.408623008402;5181.171012637959;5186.948130518797;5204.583633309402;5351.973240133774 02:31:03 INFO - PROCESS | 9538 | |4;prototype.html;322.2025486919874;324.19276002753145;326.32288002395035;332;333.9515770213318;5572.715186773414;5620.803271885485;5676.262085928834;5687.573431992601;5735.225744524493;5531.0873705838485;5572.916406253909;5574.749136288867;5580.162975553669;5598.888022239553;4196.62230399264;4223.113146239293;4336.046069864625;4349.956500435002;4353.346997950302;4374;4374.4531933508315;4396.1427521633295;4421.712588681726;4450.443694538183;4383.890402739925;4395.274779661352;4395.780210989454;4400.955990440087;4401.757903315316;4287.721298115628;4329.458817647794;4358.542353052915;4361.498427680825;4363.956360436387;3858.305505009097;3859.7298189126773;3863.343231650626;3868.6324799144036;3877.4571559981623;5431.565474762009;5479.506844383985;5480.890382192374;5481.232627432163;5530.419305972855;4783.449903261135;4921.302150757982;4945.2829339745895;4949.851504454836;5018.749062546858;5828.446297601721;5838.678872662002;5839.357670656224;5857.150713146612;5861.824145275606;4210.642095421893;4228.640565551932;4232.76719780412;4253.574642535753;4258.297380932174;5965.70171491428;5985.760569577212;6006.879862402771;6006.948783962789;6055.333913269581;4322.762248076386;4334.1981733379425;4351.282038463618;4355.237833379146;4356.716813407118;4357.9782101089295;4364.803583838671;4378.846740364072;4391.275439552502;4396.966712822484;4635.814567417266;4887.902241955212;4910.288008238786;4915.16442204826;4935.75321233944;5938.2280303560265;5955.255593050869;5959.4934430573885;5961.5230781537375;5972.372900845436;1482.9332680029424;1499.265359973605;1501.6996600679909;1503.7894694742745;1505.1119839294868;934.2339281789003;953.5327689432268;979.5004547680734;988.2884323287221;1003.287665757306;5481.314835645544;5679.403662615448;5681.233033540502;5697.6296540724725;5711.685857277889;5984;5999.940000600025;6010.4891084258325;6054.576179667469;6070.362611925772;5440.782368705208;5631.352394474606;5680.460356266148;5699.287589051369;5737.340205876378;3203.7757356985253;3208.598925134358;3208.855601497938;3226.451503244454;3233.8706451742137;6089.269287685506;6124;6216.44052035319;6234.438900498886;6250;6130.47890929276;6136.325004249529;6158.753649853956;6171.074338849119;6201;6096.177016102769;6173.783917562864;6248.343923887926;6253.1245625612455;6278.937210627835;5871.6770577618645;5985.221921150222;6013.879722405615;6051.818445446644;6071.666058366655;5997.370276121119;6024.578279520391;6030.939690603038;6039.305479869696;6087.391260873877;6118.388161184024;6173.857836300299;6187.628742275478;6302.180716506825;6318.462930650762;4165.4584903962295;4257.9148417030865;4259.680523960654;4275.486941567032;4280.700350975527;5947.583669143119;6089.60417572874;6099.9390006099375;6120.479759220516;6125.571210015256;5792.623479473821;5843.970780146072;5893.5874488785375;5927.451195985767;5934.9406505934385;5811.651300921958;5815.738291776795;5875.383084776037;5900.144479050599;5946.375630558729;5234.869128271824;5775.220345253337;5803.912941305799;5861.648301101947;5897.705114744332;5878.823635290948;5889.734961926809;5891.734871930687;5916.437938395846;5945.346011938596;5534.723263836711;5769.644133628678;5805.448482394166;5822.563307752021;5831.70841457917 02:31:03 INFO - PROCESS | 9538 | |5;yui.html;740.8294894067374;753.2091304130662;767.8157242261856;814.4909431605247;840.6847432212923;13481.528146514875;14461.78307325391;14472;14491.130532168077;14584.416623335068;12881.291528965903;13468.393922273497;13499.055066145374;13501.392437340319;13505.594832155051;655.8262060553957;753.1075675324757;756.973505927294;763.5533213070361;773.8607050730866;762.3405754022758;762.744480599;764.1174443517746;768.2663056780789;770.5569297653872;791.2048391366698;798.4650284309497;799.448380617375;800.8918795962529;801.6953557648086;794.8608993426127;796.0208943000114;799.8920145780303;800.5076877720219;804.8792681097824;574.2104606166521;581.2501872584361;583.8160979291509;584.1617279204313;584.3309410724739;13552.864471355259;13586.184828910198;13700.725985480234;13713.862861371359;13716.382762775698;13451.932740336333;13692.383842727002;13694.726105477836;13902.582922512342;13962.092463989808;11449.942750286194;11582.247153934968;11778.88221117795;11883.168178227528;11935.761284774257;3673.3204357194004;3733.3653278942643;3786.659200671953;3872.2642697887595;3899.9220015599813;71979.64010179968;72243.63878180576;72484.63757681231;72735.03086113496;75393;9931.708877845835;9959.253056020683;10135.695929122137;10209.876913539505;10470.424126672953;18537.44387668372;18569;18607.627847442975;18629.534261643566;18732.531686707942;8135.877961830577;8308.335333173332;8316.085230624627;8324.375671824637;8398.034226063959;4348.304271316574;4413;4544.477385100689;4606.170889239969;4651.186042442559;3451.0682115829086;3471.2710330830305;3474.42671959129;3481.0079127448557;3571.3750093733493;621.6674079367517;622.8380621038472;625.2684359299631;629.0626965820894;631.7504585688719;677.3091446724313;704.7075463682617;721.1346384338815;722.8951801988683;722.9168645605822;8601.61292741828;8728.607212675444;8831.64673413069;9021.548922553977;9577.23382129428;642.887494688437;646.4182235987648;694.1496666583395;706.2744025266759;725.4740313272835;3980.735796646722;4082.7346222495444;4359.324304732708;4463.888402789891;4555.407796986437;89371.55314223518;111208.44395777969;113380.43309783399;114658;115273.4236328813;59009.40990590125;59342.10986835201;109307.45346273218;110001;112768.43615781868;92377;95541;97406.02593974111;97537.51231243799;98438;9428.245740340893;9569.61721531131;9703.563339649874;9852.753681158028;10030.498475076363;35607.643923560434;36452.27095458023;44336;48306.275405869645;49593;46673.65478686179;46798.76600616975;62332.68833655803;64434.03348949863;71230.6438467825;11806.409679515818;11977.760444791229;11999.820002699791;12213.45039473208;12583.119181657563;13524;13557.93221033928;13819.585412437644;13862.584122476343;14245.430182792987;12018;12073.698157546132;12201;12513.812292815797;12621.179623324455;12157.574484892986;12198.939005304917;12559.183653062522;12618.936905315415;12848.935755321163;12109.939450303045;12218.389080546114;12231.266124032587;12354.320512371905;12661.240325580495;9177.449353038839;9297.767555811159;9330;9445.48049857237;10045.196384289386;9421.293402994666;9512.524373781145;9634.566444509874;10123.797524049625;10253.58985640566 02:31:03 INFO - PROCESS | 9538 | __end_tp_report 02:31:03 INFO - PROCESS | 9538 | __start_cc_report 02:31:03 INFO - PROCESS | 9538 | _x_x_mozilla_cycle_collect,366 02:31:03 INFO - PROCESS | 9538 | __end_cc_report 02:31:03 INFO - PROCESS | 9538 | __startTimestamp1466242263631__endTimestamp 02:31:03 INFO - PROCESS | 9538 | 02:31:03 INFO - PROCESS | 9538 | ------- Summary: start ------- 02:31:03 INFO - PROCESS | 9538 | Number of tests: 6 02:31:03 INFO - PROCESS | 9538 | 02:31:03 INFO - PROCESS | 9538 | [#0] dojo.html Cycles:165 Average:5436.50 Median:5705.20 stddev:737.23 (12.9%) stddev-sans-first:716.17 02:31:03 INFO - PROCESS | 9538 | Values: 3091.5 3106.7 3143.4 3156.7 3168.6 5455.2 5477.6 5504.0 5528.5 5541.3 5396.4 5486.3 5507.1 5520.4 5558.7 4940.2 4974.4 5083.3 5114.8 5179.4 739.2 4909.1 4932.7 5051.1 5072.1 4952.9 4975.6 4988.9 4994.3 4999.7 5006.4 5021.7 5025.0 5029.7 5066.4 4947.9 4980.0 5003.0 5026.9 5045.3 5472.4 5536.1 5539.2 5561.7 5632.9 5712.2 5820.5 5878.4 5882.5 5898.1 5931.0 5950.1 5998.9 6028.6 6078.1 5493.8 5524.0 5549.9 5554.4 5559.1 5890.9 5977.0 6017.1 6071.1 6088.6 5688.0 5697.1 5703.4 5705.9 5720.3 5859.0 5870.2 5877.4 5890.8 5895.0 5764.2 5806.7 5830.0 5839.1 5875.7 5842.4 5896.7 5905.4 5916.5 5921.4 4397.0 4458.5 4465.4 4485.2 4529.8 3908.5 3933.3 3956.1 3994.6 4001.8 5587.0 5588.7 5593.9 5619.0 5703.3 5828.3 5951.4 5955.9 5967.4 5968.8 5552.7 5570.2 5627.9 5653.8 5654.6 4742.6 4763.0 4770.1 4780.7 4812.5 5958.9 5994.7 6100.3 6107.6 6123.1 5901.5 5926.3 5929.6 5932.8 5947.6 6023.2 6023.6 6033.2 6053.2 6071.5 5663.4 5717.4 5727.9 5761.7 5774.5 5881.0 5884.4 5914.6 5926.1 5965.0 5751.7 5764.0 5764.5 5767.5 5768.3 5630.2 5651.3 5739.2 5747.6 5805.4 5718.2 5757.6 5776.7 5778.2 5784.3 5832.8 5838.9 5872.8 5898.7 5906.3 5602.1 5659.8 5705.2 5713.3 5769.0 02:31:03 INFO - PROCESS | 9538 | 02:31:03 INFO - PROCESS | 9538 | [#1] ext.html Cycles:180 Average:62738.93 Median:41456.88 stddev:128603.22 (310.2%) stddev-sans-first:128879.27 02:31:03 INFO - PROCESS | 9538 | Values: 568.5 613.2 613.9 635.0 655.7 39837.8 40747.0 45095.0 45100.3 45173.5 46054.0 46338.0 46397.8 46583.3 46725.1 8882.3 9026.6 9046.5 9047.1 9058.3 8670.3 8785.5 8795.9 8847.3 8851.5 8814.3 8859.6 8885.5 8905.0 8911.2 8758.5 8806.4 8887.2 8893.6 8897.5 8822.4 8934.2 8935.6 8949.6 8961.6 42897.6 42980.0 43086.4 43143.4 43177.8 3708.6 3744.3 3802.8 3805.6 4182.0 30098.7 32599.8 32923.0 33339.0 33820.8 4033.5 4415.7 4517.1 4526.3 4600.7 353549.0 354372.0 355021.0 358199.0 358227.0 61359.7 61977.0 62253.4 62279.0 62348.1 35786.8 36554.8 36769.6 38510.0 67212.0 13815.0 13852.3 13961.7 14016.8 14051.2 10121.5 10264.4 10315.4 10328.6 10334.2 19487.4 19582.9 19590.5 19631.3 19830.3 7056.8 7119.3 7281.6 7358.0 7401.9 981.6 1017.8 1019.1 1077.1 1084.1 31062.5 32655.7 32941.7 32974.2 33206.8 1058.8 1103.4 1103.5 1151.2 1210.3 16896.0 17391.3 17552.5 17564.8 18141.2 564164.0 566890.0 569885.0 572810.0 575306.0 60951.4 61287.4 61386.0 61402.7 61458.7 1262.0 1309.3 1310.2 1319.9 1326.3 32654.8 33636.0 33864.2 33887.7 34183.3 52149.0 53174.2 53231.0 53275.2 53360.5 497202.0 499373.0 500151.0 500279.0 501147.0 28319.0 29036.4 29480.6 29531.4 29552.0 47018.8 48173.3 48416.5 49458.5 49840.3 40731.0 40837.8 40907.6 41633.4 42371.8 40570.0 41273.0 41389.4 41524.4 42384.6 31314.4 31928.6 32209.7 32323.8 32336.0 33692.0 36124.3 36980.4 37126.4 37324.3 28097.3 28162.2 28389.7 28560.0 28565.0 02:31:03 INFO - PROCESS | 9538 | 02:31:03 INFO - PROCESS | 9538 | [#2] jquery.html Cycles:180 Average:29483.86 Median:2018.20 stddev:83120.06 (4118.5%) stddev-sans-first:83324.48 02:31:03 INFO - PROCESS | 9538 | Values: 370.1 385.3 387.0 394.6 406.2 17369.1 19127.0 19355.6 19397.2 19624.4 11004.0 11466.7 17578.7 18579.5 18654.3 5252.4 5347.2 5413.8 5435.3 5438.0 4021.1 5536.5 5864.0 5865.9 5899.7 5872.0 5891.5 5909.3 5919.6 6255.3 6411.3 6485.7 6496.7 6535.6 6541.0 5737.6 5762.2 5762.5 5793.7 5807.4 13001.4 13214.9 13427.1 13513.3 13592.4 2211.4 2214.1 2257.9 2340.1 2547.2 10245.7 10372.6 14080.2 14321.1 14377.7 1924.9 1946.4 1950.3 1967.7 1984.9 79411.0 80957.0 81094.2 81904.0 82981.6 10774.0 10804.4 10881.2 10917.4 10963.1 14232.4 14301.7 14313.5 14323.8 14378.0 7110.8 7386.0 7426.3 7536.8 7548.0 6841.9 6917.9 7063.0 7065.6 7084.5 4546.7 4650.6 4727.8 4824.4 4831.1 1758.7 1866.9 1970.0 1987.7 2048.7 1001.4 1010.8 1024.4 1027.9 1093.5 18700.4 18746.3 19075.5 19456.0 19607.9 950.4 952.6 952.9 965.2 985.0 10367.8 10909.5 10926.7 11010.4 11024.2 489076.0 495384.0 495905.0 512571.0 518394.0 93594.5 103286.0 104547.0 104906.0 106096.0 979.7 982.5 1008.1 1017.2 1023.5 17665.8 17765.7 18193.8 18221.9 18323.5 41376.4 43527.0 43837.3 44086.3 44955.6 61062.4 62648.7 62881.0 63084.0 63233.0 7593.2 8567.9 8630.9 8747.7 8881.1 12932.8 13322.9 13353.5 14043.9 14075.9 11773.5 12031.1 12145.4 12287.6 12302.0 12013.5 12316.8 12324.3 12467.6 12695.2 10854.5 11743.8 11863.5 12399.9 12424.1 7602.8 7787.1 7910.6 7955.0 8005.4 11279.5 11624.2 11781.9 11805.2 11850.8 02:31:03 INFO - PROCESS | 9538 | 02:31:03 INFO - PROCESS | 9538 | [#3] mootools.html Cycles:180 Average:5844.84 Median:4733.02 stddev:3370.54 (71.2%) stddev-sans-first:3364.00 02:31:03 INFO - PROCESS | 9538 | Values: 1474.8 1483.8 1609.4 1748.0 1757.3 7954.3 8234.1 8524.8 9047.1 9064.6 8375.1 8519.9 8682.7 8728.9 8748.9 2350.5 2423.2 2426.2 2429.9 2439.2 2294.2 2310.4 2328.6 2379.2 2401.5 2324.6 2338.1 2344.3 2360.7 2405.0 2258.5 2271.4 2292.8 2294.7 2326.5 2260.2 2260.9 2273.2 2277.2 2280.5 8775.5 8821.6 8864.2 8871.7 8879.6 4973.7 5012.5 5113.2 5115.2 5118.5 3354.8 3471.7 3525.8 3557.2 3591.3 1095.3 1146.7 1173.1 1201.4 1208.2 11989.6 12197.1 12217.1 12217.9 12237.0 4716.2 4749.8 4771.6 4803.0 4845.4 10383.4 10389.9 10411.3 10414.3 10451.4 5136.0 5222.0 5233.8 5233.8 5339.9 4358.5 4530.1 4642.0 4647.5 4801.3 4004.4 4025.6 4104.9 4126.2 4154.5 1259.1 1299.2 1300.3 1306.7 1310.0 932.3 953.9 958.4 961.0 987.3 5665.9 5784.0 5896.7 5904.5 5957.3 470.3 475.4 480.7 484.7 486.7 3957.8 4088.1 4138.3 4199.1 4222.1 11258.6 11339.8 11359.3 11501.1 11515.4 11343.9 11387.4 11389.5 11393.6 11408.5 7767.8 8139.1 8156.4 8259.2 8306.4 5921.9 5943.7 5979.4 6190.6 6194.0 10256.8 10475.1 10486.3 10487.2 10487.7 10297.5 10328.6 10682.8 10715.2 10739.4 7126.4 7535.1 7617.0 7767.6 8072.4 8522.7 8559.7 8588.1 8628.8 8663.7 7596.3 7861.3 7935.0 8002.8 8011.5 7661.0 7774.9 7810.6 7824.6 7855.0 7094.0 7108.9 7191.1 7204.3 7232.3 4980.0 5130.4 5244.9 5296.1 5384.1 5142.4 5181.2 5186.9 5204.6 5352.0 02:31:03 INFO - PROCESS | 9538 | 02:31:03 INFO - PROCESS | 9538 | [#4] prototype.html Cycles:180 Average:4948.10 Median:5680.85 stddev:1460.40 (25.7%) stddev-sans-first:1422.63 02:31:03 INFO - PROCESS | 9538 | Values: 322.2 324.2 326.3 332.0 334.0 5572.7 5620.8 5676.3 5687.6 5735.2 5531.1 5572.9 5574.7 5580.2 5598.9 4196.6 4223.1 4336.0 4350.0 4353.3 4374.0 4374.5 4396.1 4421.7 4450.4 4383.9 4395.3 4395.8 4401.0 4401.8 4287.7 4329.5 4358.5 4361.5 4364.0 3858.3 3859.7 3863.3 3868.6 3877.5 5431.6 5479.5 5480.9 5481.2 5530.4 4783.4 4921.3 4945.3 4949.9 5018.7 5828.4 5838.7 5839.4 5857.2 5861.8 4210.6 4228.6 4232.8 4253.6 4258.3 5965.7 5985.8 6006.9 6006.9 6055.3 4322.8 4334.2 4351.3 4355.2 4356.7 4358.0 4364.8 4378.8 4391.3 4397.0 4635.8 4887.9 4910.3 4915.2 4935.8 5938.2 5955.3 5959.5 5961.5 5972.4 1482.9 1499.3 1501.7 1503.8 1505.1 934.2 953.5 979.5 988.3 1003.3 5481.3 5679.4 5681.2 5697.6 5711.7 5984.0 5999.9 6010.5 6054.6 6070.4 5440.8 5631.4 5680.5 5699.3 5737.3 3203.8 3208.6 3208.9 3226.5 3233.9 6089.3 6124.0 6216.4 6234.4 6250.0 6130.5 6136.3 6158.8 6171.1 6201.0 6096.2 6173.8 6248.3 6253.1 6278.9 5871.7 5985.2 6013.9 6051.8 6071.7 5997.4 6024.6 6030.9 6039.3 6087.4 6118.4 6173.9 6187.6 6302.2 6318.5 4165.5 4257.9 4259.7 4275.5 4280.7 5947.6 6089.6 6099.9 6120.5 6125.6 5792.6 5844.0 5893.6 5927.5 5934.9 5811.7 5815.7 5875.4 5900.1 5946.4 5234.9 5775.2 5803.9 5861.6 5897.7 5878.8 5889.7 5891.7 5916.4 5945.3 5534.7 5769.6 5805.4 5822.6 5831.7 02:31:03 INFO - PROCESS | 9538 | 02:31:03 INFO - PROCESS | 9538 | [#5] yui.html Cycles:180 Average:19349.22 Median:4628.68 stddev:28855.49 (623.4%) stddev-sans-first:28902.61 02:31:03 INFO - PROCESS | 9538 | Values: 740.8 753.2 767.8 814.5 840.7 13481.5 14461.8 14472.0 14491.1 14584.4 12881.3 13468.4 13499.1 13501.4 13505.6 655.8 753.1 757.0 763.6 773.9 762.3 762.7 764.1 768.3 770.6 791.2 798.5 799.4 800.9 801.7 794.9 796.0 799.9 800.5 804.9 574.2 581.3 583.8 584.2 584.3 13552.9 13586.2 13700.7 13713.9 13716.4 13451.9 13692.4 13694.7 13902.6 13962.1 11449.9 11582.2 11778.9 11883.2 11935.8 3673.3 3733.4 3786.7 3872.3 3899.9 71979.6 72243.6 72484.6 72735.0 75393.0 9931.7 9959.3 10135.7 10209.9 10470.4 18537.4 18569.0 18607.6 18629.5 18732.5 8135.9 8308.3 8316.1 8324.4 8398.0 4348.3 4413.0 4544.5 4606.2 4651.2 3451.1 3471.3 3474.4 3481.0 3571.4 621.7 622.8 625.3 629.1 631.8 677.3 704.7 721.1 722.9 722.9 8601.6 8728.6 8831.6 9021.5 9577.2 642.9 646.4 694.1 706.3 725.5 3980.7 4082.7 4359.3 4463.9 4555.4 89371.6 111208.4 113380.4 114658.0 115273.4 59009.4 59342.1 109307.5 110001.0 112768.4 92377.0 95541.0 97406.0 97537.5 98438.0 9428.2 9569.6 9703.6 9852.8 10030.5 35607.6 36452.3 44336.0 48306.3 49593.0 46673.7 46798.8 62332.7 64434.0 71230.6 11806.4 11977.8 11999.8 12213.5 12583.1 13524.0 13557.9 13819.6 13862.6 14245.4 12018.0 12073.7 12201.0 12513.8 12621.2 12157.6 12198.9 12559.2 12618.9 12848.9 12109.9 12218.4 12231.3 12354.3 12661.2 9177.4 9297.8 9330.0 9445.5 10045.2 9421.3 9512.5 9634.6 10123.8 10253.6 02:31:03 INFO - PROCESS | 9538 | -------- Summary: end -------- 02:31:03 INFO - PROCESS | 9538 | 02:31:04 INFO - TEST-INFO | 9538: exit 0 02:31:04 INFO - TEST-OK | dromaeo_css | took 1111730ms 02:31:04 INFO - TEST-START | kraken 02:31:04 INFO - operating with platform_type : linux_ 02:31:04 INFO - Initialising browser for kraken test... 02:31:04 INFO - TEST-INFO | started process 9773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxip1Yf/profile http://localhost:41515/getInfo.html) 02:31:09 INFO - PROCESS | 9773 | __metrics Screen width/height:1600/1200 02:31:09 INFO - PROCESS | 9773 | colorDepth:24 02:31:09 INFO - PROCESS | 9773 | Browser inner width/height: 1024/697 02:31:09 INFO - PROCESS | 9773 | __metrics 02:31:10 ERROR - PROCESS | 9773 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:31:11 INFO - TEST-INFO | 9773: exit 0 02:31:11 INFO - Browser initialized. 02:31:11 INFO - Running cycle 1/1 for kraken test... 02:31:11 INFO - TEST-INFO | started process 9895 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxip1Yf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:31:23 INFO - PROCESS | 9895 | RSS: Main: 185012224 02:31:23 INFO - PROCESS | 9895 | 02:31:25 INFO - PROCESS | 9895 | Cycle 1(1): loaded http://localhost:41515/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41515/tests/kraken/driver.html?testName=audio-beat-detection) 02:31:26 INFO - PROCESS | 9895 | RSS: Main: 189841408 02:31:26 INFO - PROCESS | 9895 | 02:31:29 INFO - PROCESS | 9895 | Cycle 1(1): loaded http://localhost:41515/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41515/tests/kraken/driver.html?testName=audio-dft) 02:31:29 INFO - PROCESS | 9895 | RSS: Main: 188555264 02:31:29 INFO - PROCESS | 9895 | 02:31:32 INFO - PROCESS | 9895 | Cycle 1(1): loaded http://localhost:41515/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41515/tests/kraken/driver.html?testName=audio-fft) 02:31:33 INFO - PROCESS | 9895 | RSS: Main: 184934400 02:31:33 INFO - PROCESS | 9895 | 02:31:35 INFO - PROCESS | 9895 | Cycle 1(1): loaded http://localhost:41515/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41515/tests/kraken/driver.html?testName=audio-oscillator) 02:31:36 INFO - PROCESS | 9895 | RSS: Main: 185753600 02:31:36 INFO - PROCESS | 9895 | 02:31:38 INFO - PROCESS | 9895 | Cycle 1(1): loaded http://localhost:41515/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41515/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:31:38 INFO - PROCESS | 9895 | RSS: Main: 186396672 02:31:38 INFO - PROCESS | 9895 | 02:31:41 INFO - PROCESS | 9895 | Cycle 1(1): loaded http://localhost:41515/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41515/tests/kraken/driver.html?testName=imaging-darkroom) 02:31:42 INFO - PROCESS | 9895 | RSS: Main: 186671104 02:31:42 INFO - PROCESS | 9895 | 02:31:46 INFO - PROCESS | 9895 | Cycle 1(1): loaded http://localhost:41515/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41515/tests/kraken/driver.html?testName=imaging-desaturate) 02:31:46 INFO - PROCESS | 9895 | RSS: Main: 183619584 02:31:46 INFO - PROCESS | 9895 | 02:31:49 INFO - PROCESS | 9895 | Cycle 1(1): loaded http://localhost:41515/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41515/tests/kraken/driver.html?testName=json-parse-financial) 02:31:50 INFO - PROCESS | 9895 | RSS: Main: 184692736 02:31:50 INFO - PROCESS | 9895 | 02:31:51 INFO - PROCESS | 9895 | Cycle 1(1): loaded http://localhost:41515/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41515/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:31:52 INFO - PROCESS | 9895 | RSS: Main: 184946688 02:31:52 INFO - PROCESS | 9895 | 02:31:54 INFO - PROCESS | 9895 | Cycle 1(1): loaded http://localhost:41515/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41515/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:31:54 INFO - PROCESS | 9895 | RSS: Main: 185434112 02:31:54 INFO - PROCESS | 9895 | 02:31:56 INFO - PROCESS | 9895 | Cycle 1(1): loaded http://localhost:41515/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41515/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:31:57 INFO - PROCESS | 9895 | RSS: Main: 185384960 02:31:57 INFO - PROCESS | 9895 | 02:32:00 INFO - PROCESS | 9895 | Cycle 1(1): loaded http://localhost:41515/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:32:00 INFO - PROCESS | 9895 | RSS: Main: 185516032 02:32:00 INFO - PROCESS | 9895 | 02:32:03 INFO - PROCESS | 9895 | Cycle 1(1): loaded http://localhost:41515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:32:04 INFO - PROCESS | 9895 | RSS: Main: 185577472 02:32:04 INFO - PROCESS | 9895 | 02:32:05 INFO - PROCESS | 9895 | Cycle 1(1): loaded http://localhost:41515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41515/tests/kraken/driver.html?testName=ai-astar) 02:32:06 INFO - PROCESS | 9895 | RSS: Main: 187379712 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | __start_tp_report 02:32:06 INFO - PROCESS | 9895 | _x_x_mozilla_page_load 02:32:06 INFO - PROCESS | 9895 | _x_x_mozilla_page_load_details 02:32:06 INFO - PROCESS | 9895 | |i|pagename|runs| 02:32:06 INFO - PROCESS | 9895 | |0;ai-astar;113;106;111;112;111;113;110;111;109;111 02:32:06 INFO - PROCESS | 9895 | |1;audio-beat-detection;154;128;158;183;129;164;155;127;187;131 02:32:06 INFO - PROCESS | 9895 | |2;audio-dft;162;163;166;164;175;166;162;163;162;162 02:32:06 INFO - PROCESS | 9895 | |3;audio-fft;75;75;75;160;77;76;79;75;184;75 02:32:06 INFO - PROCESS | 9895 | |4;audio-oscillator;84;86;146;85;84;84;129;84;86;148 02:32:06 INFO - PROCESS | 9895 | |5;imaging-gaussian-blur;118;118;120;118;117;117;117;117;118;117 02:32:06 INFO - PROCESS | 9895 | |6;imaging-darkroom;149;149;149;148;149;153;152;150;149;147 02:32:06 INFO - PROCESS | 9895 | |7;imaging-desaturate;96;95;97;95;96;95;95;97;96;95 02:32:06 INFO - PROCESS | 9895 | |8;json-parse-financial;56;57;61;62;58;58;56;57;57;56 02:32:06 INFO - PROCESS | 9895 | |9;json-stringify-tinderbox;61;62;62;61;62;61;62;62;61;63 02:32:06 INFO - PROCESS | 9895 | |10;stanford-crypto-aes;81;82;80;82;82;82;81;81;102;83 02:32:06 INFO - PROCESS | 9895 | |11;stanford-crypto-ccm;124;125;130;120;127;127;124;132;135;124 02:32:06 INFO - PROCESS | 9895 | |12;stanford-crypto-pbkdf2;159;160;168;162;160;161;161;159;160;158 02:32:06 INFO - PROCESS | 9895 | |13;stanford-crypto-sha256-iterative;64;66;66;63;65;65;64;64;62;63 02:32:06 INFO - PROCESS | 9895 | __end_tp_report 02:32:06 INFO - PROCESS | 9895 | __start_cc_report 02:32:06 INFO - PROCESS | 9895 | _x_x_mozilla_cycle_collect,914 02:32:06 INFO - PROCESS | 9895 | __end_cc_report 02:32:06 INFO - PROCESS | 9895 | __startTimestamp1466242326077__endTimestamp 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | ------- Summary: start ------- 02:32:06 INFO - PROCESS | 9895 | Number of tests: 14 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.06 (1.9%) stddev-sans-first:2.01 02:32:06 INFO - PROCESS | 9895 | Values: 113.0 106.0 111.0 112.0 111.0 113.0 110.0 111.0 109.0 111.0 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:156.50 stddev:22.48 (14.4%) stddev-sans-first:23.83 02:32:06 INFO - PROCESS | 9895 | Values: 154.0 128.0 158.0 183.0 129.0 164.0 155.0 127.0 187.0 131.0 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.50 stddev:4.01 (2.5%) stddev-sans-first:4.15 02:32:06 INFO - PROCESS | 9895 | Values: 162.0 163.0 166.0 164.0 175.0 166.0 162.0 163.0 162.0 162.0 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | [#3] audio-fft Cycles:10 Average:95.10 Median:75.00 stddev:40.94 (54.6%) stddev-sans-first:42.78 02:32:06 INFO - PROCESS | 9895 | Values: 75.0 75.0 75.0 160.0 77.0 76.0 79.0 75.0 184.0 75.0 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:84.00 stddev:27.64 (32.9%) stddev-sans-first:28.57 02:32:06 INFO - PROCESS | 9895 | Values: 84.0 86.0 146.0 85.0 84.0 84.0 129.0 84.0 86.0 148.0 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 02:32:06 INFO - PROCESS | 9895 | Values: 118.0 118.0 120.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:149.00 stddev:1.78 (1.2%) stddev-sans-first:1.88 02:32:06 INFO - PROCESS | 9895 | Values: 149.0 149.0 149.0 148.0 149.0 153.0 152.0 150.0 149.0 147.0 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 02:32:06 INFO - PROCESS | 9895 | Values: 96.0 95.0 97.0 95.0 96.0 95.0 95.0 97.0 96.0 95.0 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.50 stddev:2.10 (3.6%) stddev-sans-first:2.12 02:32:06 INFO - PROCESS | 9895 | Values: 56.0 57.0 61.0 62.0 58.0 58.0 56.0 57.0 57.0 56.0 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 02:32:06 INFO - PROCESS | 9895 | Values: 61.0 62.0 62.0 61.0 62.0 61.0 62.0 62.0 61.0 63.0 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:82.00 stddev:6.52 (7.9%) stddev-sans-first:6.85 02:32:06 INFO - PROCESS | 9895 | Values: 81.0 82.0 80.0 82.0 82.0 82.0 81.0 81.0 102.0 83.0 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:127.00 stddev:4.44 (3.5%) stddev-sans-first:4.59 02:32:06 INFO - PROCESS | 9895 | Values: 124.0 125.0 130.0 120.0 127.0 127.0 124.0 132.0 135.0 124.0 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:160.50 stddev:2.78 (1.7%) stddev-sans-first:2.87 02:32:06 INFO - PROCESS | 9895 | Values: 159.0 160.0 168.0 162.0 160.0 161.0 161.0 159.0 160.0 158.0 02:32:06 INFO - PROCESS | 9895 | 02:32:06 INFO - PROCESS | 9895 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:1.32 (2.0%) stddev-sans-first:1.39 02:32:06 INFO - PROCESS | 9895 | Values: 64.0 66.0 66.0 63.0 65.0 65.0 64.0 64.0 62.0 63.0 02:32:06 INFO - PROCESS | 9895 | -------- Summary: end -------- 02:32:06 INFO - PROCESS | 9895 | 02:32:07 INFO - TEST-INFO | 9895: exit 0 02:32:07 INFO - TEST-OK | kraken | took 62782ms 02:32:07 INFO - SUITE-END | took 1174s 02:32:07 INFO - Completed test suite (00:19:34) 02:32:07 INFO - javascript benchmark 02:32:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7226.598147500224, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3091.5362695595672, 3106.6582675905647, 3143.3713257348522, 3156.7001134892175, 3168.5722427472283, 5455.18172274159, 5477.561795056396, 5504.0, 5528.5024347808685, 5541.27963364763, 5396.379416367119, 5486.259354987075, 5507.146392309199, 5520.447955204478, 5558.6942718150485, 4940.209566469374, 4974.353334066566, 5083.339165908426, 5114.795408183668, 5179.430262671103, 739.2388233338874, 4909.140900342443, 4932.679375840559, 5051.116054690433, 5072.112380333445, 4952.851414457536, 4975.626827987898, 4988.900221995576, 4994.300797888299, 4999.725015124167, 5006.3992320921725, 5021.698698078127, 5024.974875125601, 5029.723365214912, 5066.392032956032, 4947.876303092416, 4979.975100124512, 5002.974985125087, 5026.874328141826, 5045.293658887758, 5472.398036216013, 5536.141898005815, 5539.224508568804, 5561.694106824123, 5632.887342253173, 5712.171735098387, 5820.534357251409, 5878.441548052928, 5882.470577648032, 5898.056310990221, 5931.021381472052, 5950.107483877409, 5998.910016349758, 6028.638281703112, 6078.149059131725, 5493.752781124859, 5524.0, 5549.889002219973, 5554.444555544454, 5559.082751346023, 5890.911636325459, 5976.970115149396, 6017.06735456005, 6071.119687645355, 6088.634681919099, 5688.004599195125, 5697.145428185722, 5703.429657034263, 5705.942940570624, 5720.256366672306, 5858.970705146532, 5870.178175055496, 5877.441643043904, 5890.764369425261, 5895.0, 5764.164196191528, 5806.738696758656, 5830.038043722739, 5839.124131380327, 5875.735591898375, 5842.386549412336, 5896.675682837399, 5905.379935106838, 5916.497097746654, 5921.3782552831335, 4396.999999999936, 4458.464984201916, 4465.352523884018, 4485.237509623372, 4529.773511324486, 3908.511436070491, 3933.272344616255, 3956.090099277125, 3994.6205110514456, 4001.799910004488, 5587.0, 5588.692621905753, 5593.860153496195, 5619.016672082369, 5703.287089113861, 5828.329742079631, 5951.3751056139345, 5955.910661340084, 5967.433093856077, 5968.820935371946, 5552.666839989613, 5570.192322113271, 5627.887442251132, 5653.802116925888, 5654.575906807006, 4742.57316841479, 4763.04739052191, 4770.141374552614, 4780.665353425296, 4812.470628230892, 5958.910616340671, 5994.670293133832, 6100.298465676416, 6107.572469927062, 6123.08153776937, 5901.527877769682, 5926.318473375617, 5929.555283353852, 5932.762689492372, 5947.553933454921, 6023.247094113236, 6023.6385816851125, 6033.18551995475, 6053.152558641706, 6071.483923866521, 5663.433656634304, 5717.399673034438, 5727.914081288701, 5761.654300741969, 5774.509166720875, 5881.0, 5884.440978107073, 5914.58597898143, 5926.051831706906, 5965.0, 5751.654900705971, 5764.0201165802755, 5764.481196692318, 5767.509761670305, 5768.307803063659, 5630.239917611234, 5651.265335506358, 5739.225204597493, 5747.626404283876, 5805.448482394166, 5718.199452076629, 5757.625754325955, 5776.740046697824, 5778.191053252632, 5784.334801497882, 5832.795852145155, 5838.912416313674, 5872.823815285548, 5898.705064746831, 5906.26171728534, 5602.131669591057, 5659.830205093854, 5705.201271822031, 5713.257276554022, 5768.971155144198], "value": 5386.771515961592, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.4883604755719, 613.1752792494095, 613.9048447490637, 634.9619022858627, 655.7344275568396, 39837.80081099594, 40747.0, 45095.0, 45100.32349514756, 45173.54826451735, 46054.0, 46338.0, 46397.7680111599, 46583.30125048127, 46725.06549869009, 8882.289416846654, 9026.638934442615, 9046.457212567268, 9047.050059743731, 9058.27533797298, 8670.306375489945, 8785.516796576187, 8795.912040879573, 8847.33644976626, 8851.468911865277, 8814.25078868297, 8859.601317940676, 8885.511296878669, 8905.0, 8911.15344042315, 8758.47449153053, 8806.4275822072, 8887.155720206601, 8893.599788009555, 8897.510636914967, 8822.426542274732, 8934.151255630704, 8935.597898094602, 8949.55252237392, 8961.641534338618, 42897.57102428967, 42980.0, 43086.353704694455, 43143.35284970728, 43177.78411107924, 3708.554973403182, 3744.2885851688093, 3802.752821066622, 3805.562360328542, 4181.963288108534, 30098.699013010028, 32599.83700081508, 32923.0, 33339.0, 33820.83089584536, 4033.455483509718, 4415.735055896656, 4517.141743068806, 4526.2984237442915, 4600.746958917258, 353549.0, 354372.0, 355021.0, 358198.9999999974, 358226.9999999974, 61359.6932015346, 61977.0, 62253.37746622566, 62279.0, 62348.06477902835, 35786.8210658945, 36554.80671159739, 36769.63230367716, 38510.0, 67212.0, 13815.0, 13852.307384630729, 13961.720765584632, 14016.789748153786, 14051.227182505061, 10121.544530496145, 10264.43545604984, 10315.432651204255, 10328.638497652546, 10334.17326613869, 19487.44100471959, 19582.902085489768, 19590.5102372439, 19631.31290404829, 19830.305939292342, 7056.788296351117, 7119.323664251888, 7281.5995120267835, 7357.952846921837, 7401.85271282952, 981.5681100315838, 1017.8269694152012, 1019.1286450085071, 1077.0575746222055, 1084.1272775415707, 31062.45860082, 32655.673443265263, 32941.67058329434, 32974.17564560857, 33206.83396583002, 1058.761249338276, 1103.3545375954996, 1103.4593049405732, 1151.1769085104024, 1210.2919791921825, 16896.0, 17391.304347826197, 17552.473425797245, 17564.824351756575, 18141.183646735928, 564164.0, 566890.0, 569885.0, 572810.0, 575306.0, 60951.39048609546, 61287.38712612906, 61386.0, 61402.692986534785, 61458.69270653618, 1261.9808306709192, 1309.2602679486251, 1310.2138716770053, 1319.9472021119047, 1326.263923522435, 32654.836725817167, 33636.0, 33864.15339616529, 33887.661123388454, 34183.31633367368, 52149.0, 53174.202386965, 53231.0, 53275.20087198618, 53360.466395337105, 497202.0, 499373.0, 500151.0, 500279.0, 501147.0, 28319.0, 29036.419271614028, 29480.55779163357, 29531.40937181287, 29552.0, 47018.76490617525, 48173.27740083831, 48416.5158348412, 49458.50541494683, 49840.25239621481, 40731.0, 40837.79581102194, 40907.59092409038, 41633.37549936693, 42371.7881410591, 40570.0, 41273.0, 41389.37915931203, 41524.3771343424, 42384.576154239294, 31314.373712526078, 31928.605354598032, 32209.67790322067, 32323.838380807945, 32336.0, 33692.0, 36124.27751445009, 36980.44529332008, 37126.44310335401, 37324.25351493009, 28097.297567560156, 28162.155135345973, 28389.716102839535, 28560.0, 28565.0], "value": 19998.387202032663, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.10434747910074, 385.3064483928927, 386.961303869613, 394.5876558995849, 406.21600311399004, 17369.131543422827, 19126.99999999998, 19355.580552430947, 19397.22411103556, 19624.41126766196, 11004.0, 11466.656000320003, 17578.736318955227, 18579.535511612215, 18654.347097851576, 5252.3697156341195, 5347.197920311945, 5413.837584872441, 5435.2934118564535, 5438.021156191884, 4021.1153546219784, 5536.501714845663, 5864.032434648299, 5865.912011319812, 5899.734511946951, 5872.031114866042, 5891.499222566087, 5909.290885093795, 5919.58562900595, 6255.343188965161, 6411.294757576663, 6485.70814313357, 6496.740130394778, 6535.60786352818, 6541.0, 5737.627054241461, 5762.164486149527, 5762.510186634099, 5793.710314484259, 5807.361190269067, 13001.414936327794, 13214.86785132146, 13427.060105792598, 13513.256770877599, 13592.38834252461, 2211.4360837986374, 2214.059024914421, 2257.920972765962, 2340.1224540797202, 2547.210364786922, 10245.692629221136, 10372.63695770652, 14080.22558759278, 14321.069130506588, 14377.712445751027, 1924.8652594318403, 1946.3674305850514, 1950.2642648043252, 1967.7146813712075, 1984.9106790194476, 79411.0, 80957.0, 81094.18905810926, 81904.0, 82981.58509207415, 10774.0, 10804.405757683402, 10881.183911206534, 10917.39954302521, 10963.068139208257, 14232.43070277198, 14301.713965720628, 14313.499027533986, 14323.78514322286, 14378.0, 7110.786676399716, 7385.9630701846145, 7426.2945020223, 7536.773896783106, 7547.962260188664, 6841.897371539431, 6917.9308206917285, 7063.04648872406, 7065.646717664096, 7084.539504932163, 4546.749928753884, 4650.627949764078, 4727.787249573777, 4824.372831531949, 4831.106245344622, 1758.6746451906183, 1866.9439916802517, 1969.9704504432445, 1987.7316562264198, 2048.6619707748055, 1001.449202938381, 1010.802893435773, 1024.364893765855, 1027.8766548014287, 1093.5297821936645, 18700.438986830417, 18746.250149993848, 19075.523111922037, 19456.0, 19607.90196049039, 950.396498223633, 952.6284748947916, 952.9103470181825, 965.1747755668943, 984.9655262065793, 10367.844482332772, 10909.509072091774, 10926.726831829268, 11010.449477526092, 11024.228304018801, 489076.0, 495384.0, 495905.0, 512571.0, 518394.0, 93594.53202733943, 103286.0, 104547.0, 104906.0, 106096.0, 979.72567681048, 982.4792859784326, 1008.0977525115128, 1017.1608423051013, 1023.4729114506184, 17665.823341766933, 17765.733513997042, 18193.81806181974, 18221.908890455463, 18323.54191145232, 41376.37935430911, 43527.0, 43837.34243986279, 44086.33870492009, 44955.550444496446, 61062.38937610567, 62648.686756567746, 62881.0, 63084.0, 63233.0, 7593.202713714981, 8567.871481927901, 8630.870536941826, 8747.737567872973, 8881.111888811325, 12932.806007909701, 13322.866771332163, 13353.53262635803, 14043.859561404664, 14075.929620352243, 11773.52905883755, 12031.097667674785, 12145.39273036327, 12287.56993505223, 12302.0, 12013.45939432745, 12316.81524777147, 12324.32216228116, 12467.625971220878, 12695.174813637084, 10854.457277135954, 11743.76512469763, 11863.525458981889, 12399.876001239872, 12424.130310878152, 7602.847943041219, 7787.10448298453, 7910.604469776603, 7954.960225199068, 8005.3995950305125, 11279.492422840827, 11624.244424112743, 11781.941090294493, 11805.23265987708, 11850.822237666614], "value": 9098.083453410387, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.7640377539597, 1483.8293596236433, 1609.4125644139885, 1747.9825201747979, 1757.2882982392136, 7954.2841144297, 8234.094249632535, 8524.829503409936, 9047.14052165044, 9064.592093355799, 8375.120612335708, 8519.914800852006, 8682.652693892236, 8728.91271087289, 8748.912510874889, 2350.5416443793465, 2423.200343886522, 2426.2478631624253, 2429.9392515187087, 2439.2194497760725, 2294.1855641247366, 2310.353101131686, 2328.604137296664, 2379.2267513058237, 2401.519696060786, 2324.59319619066, 2338.064774090369, 2344.34358379654, 2360.7403185649564, 2404.9639255411184, 2258.5144193998285, 2271.4094335472732, 2292.770722927702, 2294.7016887804643, 2326.4998025424616, 2260.2202240227093, 2260.9208677696365, 2273.1589311954517, 2277.180215122571, 2280.486890449652, 8775.473471591726, 8821.647134114692, 8864.202221800004, 8871.733847984571, 8879.556022198864, 4973.726445045521, 5012.538693624875, 5113.207452844815, 5115.18157094863, 5118.488151184889, 3354.7987120772586, 3471.6528347165336, 3525.806080665562, 3557.1640664443835, 3591.2637909228547, 1095.315427857589, 1146.7419830538145, 1173.12015988009, 1201.435325397062, 1208.1844754790482, 11989.64031079069, 12197.146199765932, 12217.083718721042, 12217.93891030539, 12237.0, 4716.221823399101, 4749.810007599657, 4771.594414474739, 4803.0, 4845.394325709286, 10383.376997380181, 10389.94805025985, 10411.271211015308, 10414.271001030007, 10451.425171615634, 5136.0, 5221.973890130525, 5233.790648374023, 5233.790648374099, 5339.86650333737, 4358.455193100863, 4530.093981203772, 4642.0019695764895, 4647.488776234679, 4801.279808028824, 4004.439378487014, 4025.5571887092397, 4104.856330028435, 4126.195391898551, 4154.480689913761, 1259.0808709642013, 1299.2074834351038, 1300.3303298801125, 1306.6667999660217, 1309.9803502947464, 932.3007744191856, 953.9236861051099, 958.4393130018877, 960.9903900960901, 987.2842189412619, 5665.858353541194, 5783.9648210355, 5896.675682837399, 5904.498117659961, 5957.324648455495, 470.33212837770446, 475.3535192138689, 480.68034756886976, 484.709174495307, 486.7444591589444, 3957.8021098944937, 4088.1414902870138, 4138.275801734684, 4199.139176468817, 4222.0500387412585, 11258.605948791754, 11339.829902551468, 11359.261647992855, 11501.13741469393, 11515.424228788695, 11343.943280283545, 11387.430628468543, 11389.487473063731, 11393.601223957121, 11408.543658253577, 7767.766966990999, 8139.104698483162, 8156.429049966446, 8259.174082591693, 8306.418550701514, 5921.940780592311, 5943.748083220401, 5979.431953964367, 6190.597611155261, 6193.969030154821, 10256.794864102527, 10475.109615682448, 10486.318389304672, 10487.213458990758, 10487.685369438928, 10297.53661085268, 10328.586856525955, 10682.786344273227, 10715.249932504961, 10739.409332486788, 7126.358627723323, 7535.058117735283, 7617.0, 7767.572783496736, 8072.4349295548745, 8522.74431767048, 8559.700410485602, 8588.098249683693, 8628.78428039304, 8663.696770612998, 7596.316331529968, 7861.25318094803, 7935.0, 8002.759917202493, 8011.479253848481, 7661.0, 7774.92225077742, 7810.648520816463, 7824.64789084504, 7855.018122734658, 7093.964530177316, 7108.928910710827, 7191.065161529177, 7204.3155900189395, 7232.276772322936, 4980.0, 5130.358705161855, 5244.868878277921, 5296.099663057213, 5384.138537834085, 5142.408623008402, 5181.171012637959, 5186.948130518797, 5204.583633309402, 5351.973240133774], "value": 4597.01362990099, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.2025486919874, 324.19276002753145, 326.32288002395035, 332.0, 333.9515770213318, 5572.715186773414, 5620.803271885485, 5676.262085928834, 5687.573431992601, 5735.225744524493, 5531.0873705838485, 5572.916406253909, 5574.749136288867, 5580.162975553669, 5598.888022239553, 4196.62230399264, 4223.113146239293, 4336.046069864625, 4349.956500435002, 4353.346997950302, 4374.0, 4374.4531933508315, 4396.1427521633295, 4421.712588681726, 4450.443694538183, 4383.890402739925, 4395.274779661352, 4395.780210989454, 4400.955990440087, 4401.757903315316, 4287.721298115628, 4329.458817647794, 4358.542353052915, 4361.498427680825, 4363.956360436387, 3858.305505009097, 3859.7298189126773, 3863.343231650626, 3868.6324799144036, 3877.4571559981623, 5431.565474762009, 5479.506844383985, 5480.890382192374, 5481.232627432163, 5530.419305972855, 4783.449903261135, 4921.302150757982, 4945.2829339745895, 4949.851504454836, 5018.749062546858, 5828.446297601721, 5838.678872662002, 5839.357670656224, 5857.150713146612, 5861.824145275606, 4210.642095421893, 4228.640565551932, 4232.76719780412, 4253.574642535753, 4258.297380932174, 5965.70171491428, 5985.760569577212, 6006.879862402771, 6006.948783962789, 6055.333913269581, 4322.762248076386, 4334.1981733379425, 4351.282038463618, 4355.237833379146, 4356.716813407118, 4357.9782101089295, 4364.803583838671, 4378.846740364072, 4391.275439552502, 4396.966712822484, 4635.814567417266, 4887.902241955212, 4910.288008238786, 4915.16442204826, 4935.75321233944, 5938.2280303560265, 5955.255593050869, 5959.4934430573885, 5961.5230781537375, 5972.372900845436, 1482.9332680029424, 1499.265359973605, 1501.6996600679909, 1503.7894694742745, 1505.1119839294868, 934.2339281789003, 953.5327689432268, 979.5004547680734, 988.2884323287221, 1003.287665757306, 5481.314835645544, 5679.403662615448, 5681.233033540502, 5697.6296540724725, 5711.685857277889, 5984.0, 5999.940000600025, 6010.4891084258325, 6054.576179667469, 6070.362611925772, 5440.782368705208, 5631.352394474606, 5680.460356266148, 5699.287589051369, 5737.340205876378, 3203.7757356985253, 3208.598925134358, 3208.855601497938, 3226.451503244454, 3233.8706451742137, 6089.269287685506, 6124.0, 6216.44052035319, 6234.438900498886, 6250.0, 6130.47890929276, 6136.325004249529, 6158.753649853956, 6171.074338849119, 6201.0, 6096.177016102769, 6173.783917562864, 6248.343923887926, 6253.1245625612455, 6278.937210627835, 5871.6770577618645, 5985.221921150222, 6013.879722405615, 6051.818445446644, 6071.666058366655, 5997.370276121119, 6024.578279520391, 6030.939690603038, 6039.305479869696, 6087.391260873877, 6118.388161184024, 6173.857836300299, 6187.628742275478, 6302.180716506825, 6318.462930650762, 4165.4584903962295, 4257.9148417030865, 4259.680523960654, 4275.486941567032, 4280.700350975527, 5947.583669143119, 6089.60417572874, 6099.9390006099375, 6120.479759220516, 6125.571210015256, 5792.623479473821, 5843.970780146072, 5893.5874488785375, 5927.451195985767, 5934.9406505934385, 5811.651300921958, 5815.738291776795, 5875.383084776037, 5900.144479050599, 5946.375630558729, 5234.869128271824, 5775.220345253337, 5803.912941305799, 5861.648301101947, 5897.705114744332, 5878.823635290948, 5889.734961926809, 5891.734871930687, 5916.437938395846, 5945.346011938596, 5534.723263836711, 5769.644133628678, 5805.448482394166, 5822.563307752021, 5831.70841457917], "value": 4473.000427710151, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.8294894067374, 753.2091304130662, 767.8157242261856, 814.4909431605247, 840.6847432212923, 13481.528146514875, 14461.78307325391, 14472.0, 14491.130532168077, 14584.416623335068, 12881.291528965903, 13468.393922273497, 13499.055066145374, 13501.392437340319, 13505.594832155051, 655.8262060553957, 753.1075675324757, 756.973505927294, 763.5533213070361, 773.8607050730866, 762.3405754022758, 762.744480599, 764.1174443517746, 768.2663056780789, 770.5569297653872, 791.2048391366698, 798.4650284309497, 799.448380617375, 800.8918795962529, 801.6953557648086, 794.8608993426127, 796.0208943000114, 799.8920145780303, 800.5076877720219, 804.8792681097824, 574.2104606166521, 581.2501872584361, 583.8160979291509, 584.1617279204313, 584.3309410724739, 13552.864471355259, 13586.184828910198, 13700.725985480234, 13713.862861371359, 13716.382762775698, 13451.932740336333, 13692.383842727002, 13694.726105477836, 13902.582922512342, 13962.092463989808, 11449.942750286194, 11582.247153934968, 11778.88221117795, 11883.168178227528, 11935.761284774257, 3673.3204357194004, 3733.3653278942643, 3786.659200671953, 3872.2642697887595, 3899.9220015599813, 71979.64010179968, 72243.63878180576, 72484.63757681231, 72735.03086113496, 75393.0, 9931.708877845835, 9959.253056020683, 10135.695929122137, 10209.876913539505, 10470.424126672953, 18537.44387668372, 18569.0, 18607.627847442975, 18629.534261643566, 18732.531686707942, 8135.877961830577, 8308.335333173332, 8316.085230624627, 8324.375671824637, 8398.034226063959, 4348.304271316574, 4413.0, 4544.477385100689, 4606.170889239969, 4651.186042442559, 3451.0682115829086, 3471.2710330830305, 3474.42671959129, 3481.0079127448557, 3571.3750093733493, 621.6674079367517, 622.8380621038472, 625.2684359299631, 629.0626965820894, 631.7504585688719, 677.3091446724313, 704.7075463682617, 721.1346384338815, 722.8951801988683, 722.9168645605822, 8601.61292741828, 8728.607212675444, 8831.64673413069, 9021.548922553977, 9577.23382129428, 642.887494688437, 646.4182235987648, 694.1496666583395, 706.2744025266759, 725.4740313272835, 3980.735796646722, 4082.7346222495444, 4359.324304732708, 4463.888402789891, 4555.407796986437, 89371.55314223518, 111208.44395777969, 113380.43309783399, 114658.0, 115273.4236328813, 59009.40990590125, 59342.10986835201, 109307.45346273218, 110001.0, 112768.43615781868, 92377.0, 95541.0, 97406.02593974111, 97537.51231243799, 98438.0, 9428.245740340893, 9569.61721531131, 9703.563339649874, 9852.753681158028, 10030.498475076363, 35607.643923560434, 36452.27095458023, 44336.0, 48306.275405869645, 49593.0, 46673.65478686179, 46798.76600616975, 62332.68833655803, 64434.03348949863, 71230.6438467825, 11806.409679515818, 11977.760444791229, 11999.820002699791, 12213.45039473208, 12583.119181657563, 13524.0, 13557.93221033928, 13819.585412437644, 13862.584122476343, 14245.430182792987, 12018.0, 12073.698157546132, 12201.0, 12513.812292815797, 12621.179623324455, 12157.574484892986, 12198.939005304917, 12559.183653062522, 12618.936905315415, 12848.935755321163, 12109.939450303045, 12218.389080546114, 12231.266124032587, 12354.320512371905, 12661.240325580495, 9177.449353038839, 9297.767555811159, 9330.0, 9445.48049857237, 10045.196384289386, 9421.293402994666, 9512.524373781145, 9634.566444509874, 10123.797524049625, 10253.58985640566], "value": 7066.636500137437, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 111.0, 112.0, 111.0, 113.0, 110.0, 111.0, 109.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 128.0, 158.0, 183.0, 129.0, 164.0, 155.0, 127.0, 187.0, 131.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 166.0, 164.0, 175.0, 166.0, 162.0, 163.0, 162.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 160.0, 77.0, 76.0, 79.0, 75.0, 184.0, 75.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 146.0, 85.0, 84.0, 84.0, 129.0, 84.0, 86.0, 148.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 120.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 148.0, 149.0, 153.0, 152.0, 150.0, 149.0, 147.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 95.0, 96.0, 95.0, 95.0, 97.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 61.0, 62.0, 58.0, 58.0, 56.0, 57.0, 57.0, 56.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0, 61.0, 63.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 80.0, 82.0, 82.0, 82.0, 81.0, 81.0, 102.0, 83.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 130.0, 120.0, 127.0, 127.0, 124.0, 132.0, 135.0, 124.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 168.0, 162.0, 160.0, 161.0, 161.0, 159.0, 160.0, 158.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 63.0, 65.0, 65.0, 64.0, 64.0, 62.0, 63.0], "value": 64.2, "unit": "score"}]}]} 02:32:07 INFO - Return code: 0 02:32:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:32:07 ERROR - # TBPL SUCCESS # 02:32:07 INFO - Running post-action listener: _resource_record_post_action 02:32:07 INFO - ##### 02:32:07 INFO - ##### Finished run-tests step (success) 02:32:07 INFO - ##### 02:32:07 INFO - Running post-run listener: _resource_record_post_run 02:32:07 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 551059456; Read time: 240; Write time: 698616 02:32:07 INFO - TinderboxPrint: CPU usage
13.5% 02:32:07 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 240 02:32:07 INFO - TinderboxPrint: I/O write bytes / time
551,059,456 / 698,616 02:32:07 INFO - TinderboxPrint: CPU idle
8,230.9 (86.5%) 02:32:07 INFO - TinderboxPrint: CPU user
1,225.1 (12.9%) 02:32:07 INFO - TinderboxPrint: Swap in / out
0 / 0 02:32:07 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 256598016; Read time: 0; Write time: 465180 02:32:07 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 12288; Write bytes: 294461440; Read time: 240; Write time: 233436 02:32:08 INFO - Running post-run listener: _upload_blobber_files 02:32:08 INFO - Blob upload gear active. 02:32:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:32:08 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 02:32:08 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:32:08 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:32:08 INFO - (blobuploader) - INFO - Open directory for files ... 02:32:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:32:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:32:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:32:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:32:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:32:09 INFO - (blobuploader) - INFO - Done attempting. 02:32:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:32:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:32:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:32:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:32:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:32:12 INFO - (blobuploader) - INFO - Done attempting. 02:32:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:32:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:32:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:32:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:32:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:32:13 INFO - (blobuploader) - INFO - Done attempting. 02:32:13 INFO - (blobuploader) - INFO - Iteration through files over. 02:32:13 INFO - Return code: 0 02:32:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:32:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:32:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92955a1be1df6ec488d6a17ede35bae4e0c5ba5be7bf9603b9f4142eca1e9abeef10f7ad8d6aedd1e76b851db5c05e8d27948254a244d8984abac678441b4058", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/87191e4ecfbdc65ef66d7e040c1ddaa4cc3322de8f2bd4ec8600ab23bdc2322783cfa2650565b693b9539dbf062a54241e95a0b739626465bbc03fe8df510e39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e87214507b04d97ffacf8d2ad5adb04b8336ce7f48c9caa53c4c11a028e11db99642442f2570c06c1a69ef638e017280236c8b5cba13b1c6aa6a46985ce788b1"} 02:32:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:32:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:32:13 INFO - Contents: 02:32:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92955a1be1df6ec488d6a17ede35bae4e0c5ba5be7bf9603b9f4142eca1e9abeef10f7ad8d6aedd1e76b851db5c05e8d27948254a244d8984abac678441b4058", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/87191e4ecfbdc65ef66d7e040c1ddaa4cc3322de8f2bd4ec8600ab23bdc2322783cfa2650565b693b9539dbf062a54241e95a0b739626465bbc03fe8df510e39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e87214507b04d97ffacf8d2ad5adb04b8336ce7f48c9caa53c4c11a028e11db99642442f2570c06c1a69ef638e017280236c8b5cba13b1c6aa6a46985ce788b1"} 02:32:13 INFO - Running post-run listener: copy_logs_to_upload_dir 02:32:13 INFO - Copying logs to upload dir... 02:32:13 INFO - mkdir: /builds/slave/test/build/upload/logs 02:32:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.348860 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-18 02:32:11.871188) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 02:32:11.874918) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126 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/Fx-Team/sha512/92955a1be1df6ec488d6a17ede35bae4e0c5ba5be7bf9603b9f4142eca1e9abeef10f7ad8d6aedd1e76b851db5c05e8d27948254a244d8984abac678441b4058", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/87191e4ecfbdc65ef66d7e040c1ddaa4cc3322de8f2bd4ec8600ab23bdc2322783cfa2650565b693b9539dbf062a54241e95a0b739626465bbc03fe8df510e39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e87214507b04d97ffacf8d2ad5adb04b8336ce7f48c9caa53c4c11a028e11db99642442f2570c06c1a69ef638e017280236c8b5cba13b1c6aa6a46985ce788b1"} build_url:https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011357 build_url: 'https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92955a1be1df6ec488d6a17ede35bae4e0c5ba5be7bf9603b9f4142eca1e9abeef10f7ad8d6aedd1e76b851db5c05e8d27948254a244d8984abac678441b4058", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/87191e4ecfbdc65ef66d7e040c1ddaa4cc3322de8f2bd4ec8600ab23bdc2322783cfa2650565b693b9539dbf062a54241e95a0b739626465bbc03fe8df510e39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e87214507b04d97ffacf8d2ad5adb04b8336ce7f48c9caa53c4c11a028e11db99642442f2570c06c1a69ef638e017280236c8b5cba13b1c6aa6a46985ce788b1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 02:32:11.900181) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:32:11.900525) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466237701.371744-626543126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:32:11.982648) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 02:32:11.982955) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 02:32:11.983232) ========= ========= Total master_lag: 0.17 =========