builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1466068705.74 results: success (0) buildid: 20160616004126 builduid: e49a9bb372a24e188b8730869d96f74e revision: 6b40db1565705c392042da04396d1ca83c0d017d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.743731) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.744200) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.744516) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.794094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.794387) ========= 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=eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 02:18:25-- 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% 46.6M=0s 2016-06-16 02:18:25 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.925229) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.925622) ========= 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=eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018305 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.975634) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:25.976016) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6b40db1565705c392042da04396d1ca83c0d017d --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 6b40db1565705c392042da04396d1ca83c0d017d --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=eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 02:18:26,103 truncating revision to first 12 chars 2016-06-16 02:18:26,103 Setting DEBUG logging. 2016-06-16 02:18:26,103 attempt 1/10 2016-06-16 02:18:26,103 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6b40db156570?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 02:18:26,415 unpacking tar archive at: fx-team-6b40db156570/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684984 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:26.674558) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:26.674983) ========= script_repo_revision: 6b40db1565705c392042da04396d1ca83c0d017d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:26.675455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:26.675792) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 02:18:26.686107) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-16 02:18:26.686528) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:18:26 INFO - MultiFileLogger online at 20160616 02:18:26 in /builds/slave/test 02:18:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:18:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:18:26 INFO - {'append_to_log': False, 02:18:26 INFO - 'base_work_dir': '/builds/slave/test', 02:18:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:18:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:18:26 INFO - 'branch': 'Fx-Team-Non-PGO', 02:18:26 INFO - 'buildbot_json_path': 'buildprops.json', 02:18:26 INFO - 'config_files': ('talos/linux_config.py',), 02:18:26 INFO - 'default_actions': ('clobber', 02:18:26 INFO - 'read-buildbot-config', 02:18:26 INFO - 'download-and-extract', 02:18:26 INFO - 'populate-webroot', 02:18:26 INFO - 'create-virtualenv', 02:18:26 INFO - 'install', 02:18:26 INFO - 'run-tests'), 02:18:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:18:26 INFO - 'download_minidump_stackwalk': True, 02:18:26 INFO - 'download_symbols': 'ondemand', 02:18:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:18:26 INFO - 'tooltool.py': '/tools/tooltool.py', 02:18:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:18:26 INFO - '/tools/misc-python/virtualenv.py')}, 02:18:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:18:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:18:26 INFO - 'installer_path': 'installer.exe', 02:18:26 INFO - 'log_level': 'info', 02:18:26 INFO - 'log_name': 'talos', 02:18:26 INFO - 'log_to_console': True, 02:18:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:18:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:18:26 INFO - 'opt_config_files': (), 02:18:26 INFO - 'pip_index': False, 02:18:26 INFO - 'sps_profile': False, 02:18:26 INFO - 'sps_profile_interval': 0, 02:18:26 INFO - 'suite': 'dromaeojs-e10s', 02:18:26 INFO - 'system_bits': '32', 02:18:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:18:26 INFO - 'title': 'talos-linux64-ix-010', 02:18:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:18:26 INFO - 'use_talos_json': True, 02:18:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:18:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:18:26 INFO - 'work_dir': 'build'} 02:18:26 INFO - ##### 02:18:26 INFO - ##### Running clobber step. 02:18:26 INFO - ##### 02:18:26 INFO - Running pre-action listener: _resource_record_pre_action 02:18:26 INFO - Running main action method: clobber 02:18:26 INFO - rmtree: /builds/slave/test/build 02:18:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:18:27 INFO - Running post-action listener: _resource_record_post_action 02:18:27 INFO - ##### 02:18:27 INFO - ##### Finished clobber step (success) 02:18:27 INFO - ##### 02:18:27 INFO - ##### 02:18:27 INFO - ##### Running read-buildbot-config step. 02:18:27 INFO - ##### 02:18:27 INFO - Running pre-action listener: _resource_record_pre_action 02:18:27 INFO - Running main action method: read_buildbot_config 02:18:27 INFO - Using buildbot properties: 02:18:27 INFO - { 02:18:27 INFO - "project": "", 02:18:27 INFO - "product": "firefox", 02:18:27 INFO - "script_repo_revision": "production", 02:18:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:18:27 INFO - "repository": "", 02:18:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:18:27 INFO - "buildid": "20160616004126", 02:18:27 INFO - "pgo_build": "False", 02:18:27 INFO - "basedir": "/builds/slave/test", 02:18:27 INFO - "buildnumber": 1372, 02:18:27 INFO - "slavename": "talos-linux64-ix-010", 02:18:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:18:27 INFO - "platform": "ubuntu64_hw", 02:18:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:18:27 INFO - "branch": "fx-team", 02:18:27 INFO - "repo_path": "integration/fx-team", 02:18:27 INFO - "revision": "6b40db1565705c392042da04396d1ca83c0d017d", 02:18:27 INFO - "stage_platform": "linux64", 02:18:27 INFO - "builduid": "e49a9bb372a24e188b8730869d96f74e", 02:18:27 INFO - "slavebuilddir": "test" 02:18:27 INFO - } 02:18:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:18:27 INFO - Running post-action listener: _resource_record_post_action 02:18:27 INFO - ##### 02:18:27 INFO - ##### Finished read-buildbot-config step (success) 02:18:27 INFO - ##### 02:18:27 INFO - ##### 02:18:27 INFO - ##### Running download-and-extract step. 02:18:27 INFO - ##### 02:18:27 INFO - Running pre-action listener: _resource_record_pre_action 02:18:27 INFO - Running main action method: download_and_extract 02:18:27 INFO - mkdir: /builds/slave/test/build/tests 02:18:27 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:18:27 INFO - https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:18:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:18:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:18:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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:18:37 INFO - Downloaded 1361 bytes. 02:18:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:18:37 INFO - Using the following test package requirements: 02:18:37 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:18:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:18:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:18:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:37 INFO - u'jsshell-linux-x86_64.zip'], 02:18:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:18:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:18:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:18:37 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:18:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:18:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:18:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:18:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:37 INFO - https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:18:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:18:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:18:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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:18:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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:18:43 INFO - Downloaded 22654315 bytes. 02:18:43 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:18:43 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:18:44 INFO - Return code: 0 02:18:44 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:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:44 INFO - https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:18:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:18:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:18:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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:18:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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:18:49 INFO - Downloaded 22654315 bytes. 02:18:49 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:18:49 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:18:50 INFO - Return code: 0 02:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:50 INFO - https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:18:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:18:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:18:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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:18:57 INFO - Downloaded 14405384 bytes. 02:18:57 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:18:57 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:18:58 INFO - Return code: 0 02:18:58 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:18:58 INFO - https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:18:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:18:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:18:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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:18:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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:18:59 INFO - Downloaded 55447192 bytes. 02:18:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:18:59 INFO - mkdir: /builds/slave/test/properties 02:18:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:18:59 INFO - Writing to file /builds/slave/test/properties/build_url 02:18:59 INFO - Contents: 02:18:59 INFO - build_url:https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:19:00 INFO - Running post-action listener: _resource_record_post_action 02:19:00 INFO - Running post-action listener: set_extra_try_arguments 02:19:00 INFO - ##### 02:19:00 INFO - ##### Finished download-and-extract step (success) 02:19:00 INFO - ##### 02:19:00 INFO - ##### 02:19:00 INFO - ##### Running populate-webroot step. 02:19:00 INFO - ##### 02:19:00 INFO - Running pre-action listener: _resource_record_pre_action 02:19:00 INFO - Running main action method: populate_webroot 02:19:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:19:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:19:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:19:00 INFO - '--tppagecycles', 02:19:00 INFO - '7'], 02:19:00 INFO - 'tests': ['tsvgm']}}, 02:19:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:19:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:19:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:19:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:19:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:19:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:19:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:00 INFO - 'talos_options': ['--disable-e10s'], 02:19:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:00 INFO - 'talos_options': ['--disable-e10s'], 02:19:00 INFO - 'tests': ['damp', 'tps']}, 02:19:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:00 INFO - 'tests': ['damp', 'tps']}, 02:19:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:19:00 INFO - 'tests': ['dromaeo_dom']}, 02:19:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:19:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:19:00 INFO - 'tests': ['basic_compositor_video']}, 02:19:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:19:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:19:00 INFO - 'tests': ['a11yr', 02:19:00 INFO - 'ts_paint', 02:19:00 INFO - 'tpaint', 02:19:00 INFO - 'sessionrestore', 02:19:00 INFO - 'sessionrestore_no_auto_restore', 02:19:00 INFO - 'tabpaint']}, 02:19:00 INFO - 'other-e10s': {'tests': ['a11yr', 02:19:00 INFO - 'ts_paint', 02:19:00 INFO - 'tpaint', 02:19:00 INFO - 'sessionrestore', 02:19:00 INFO - 'sessionrestore_no_auto_restore', 02:19:00 INFO - 'tabpaint']}, 02:19:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:19:00 INFO - 'ts_paint', 02:19:00 INFO - 'tpaint', 02:19:00 INFO - 'sessionrestore', 02:19:00 INFO - 'sessionrestore_no_auto_restore', 02:19:00 INFO - 'tabpaint']}, 02:19:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:19:00 INFO - 'ts_paint', 02:19:00 INFO - 'tpaint', 02:19:00 INFO - 'sessionrestore', 02:19:00 INFO - 'sessionrestore_no_auto_restore', 02:19:00 INFO - 'tabpaint']}, 02:19:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:19:00 INFO - 'tests': ['a11yr', 02:19:00 INFO - 'ts_paint', 02:19:00 INFO - 'tpaint', 02:19:00 INFO - 'sessionrestore', 02:19:00 INFO - 'sessionrestore_no_auto_restore', 02:19:00 INFO - 'tabpaint']}, 02:19:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:19:00 INFO - 'tests': ['a11yr', 02:19:00 INFO - 'ts_paint', 02:19:00 INFO - 'tpaint', 02:19:00 INFO - 'sessionrestore', 02:19:00 INFO - 'sessionrestore_no_auto_restore', 02:19:00 INFO - 'tabpaint']}, 02:19:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:19:00 INFO - 'tests': ['tsvgx', 02:19:00 INFO - 'tsvgr_opacity', 02:19:00 INFO - 'tart', 02:19:00 INFO - 'tscrollx', 02:19:00 INFO - 'cart']}, 02:19:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:19:00 INFO - 'tsvgr_opacity', 02:19:00 INFO - 'tart', 02:19:00 INFO - 'tscrollx', 02:19:00 INFO - 'cart']}, 02:19:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:00 INFO - 'talos_options': ['--disable-e10s'], 02:19:00 INFO - 'tests': ['tp5o']}, 02:19:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:00 INFO - 'tests': ['tp5o']}, 02:19:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:00 INFO - 'talos_options': ['--disable-e10s', 02:19:00 INFO - '--xperf_path', 02:19:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:00 INFO - 'tests': ['tp5n']}, 02:19:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:00 INFO - 'talos_options': ['--xperf_path', 02:19:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:00 INFO - 'tests': ['tp5n']}}, 02:19:00 INFO - 'talos.zip': {'path': '', 02:19:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:19:00 INFO - Running post-action listener: _resource_record_post_action 02:19:00 INFO - ##### 02:19:00 INFO - ##### Finished populate-webroot step (success) 02:19:00 INFO - ##### 02:19:00 INFO - ##### 02:19:00 INFO - ##### Running create-virtualenv step. 02:19:00 INFO - ##### 02:19:00 INFO - Running pre-action listener: _resource_record_pre_action 02:19:00 INFO - Running main action method: create_virtualenv 02:19:00 INFO - Creating virtualenv /builds/slave/test/build/venv 02:19:00 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:19:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:19:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:19:00 INFO - Using real prefix '/usr' 02:19:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:19:01 INFO - Installing distribute.............................................................................................................................................................................................done. 02:19:03 INFO - Installing pip.................done. 02:19:03 INFO - Return code: 0 02:19:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:19: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:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f68e9778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2596350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26251c0>, '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 0x26260c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2626550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', '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:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:19:03 INFO - Using env: {'DISPLAY': ':0', 02:19:03 INFO - 'HOME': '/home/cltbld', 02:19:03 INFO - 'LANG': 'en_US.UTF-8', 02:19:03 INFO - 'LANGUAGE': 'en_US:en', 02:19:03 INFO - 'LOGNAME': 'cltbld', 02:19:03 INFO - 'MAIL': '/var/mail/cltbld', 02:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:03 INFO - 'MOZ_NO_REMOTE': '1', 02:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:03 INFO - 'NO_EM_RESTART': '1', 02:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:03 INFO - 'PWD': '/builds/slave/test', 02:19:03 INFO - 'SHELL': '/bin/bash', 02:19:03 INFO - 'SHLVL': '1', 02:19:03 INFO - 'TERM': 'linux', 02:19:03 INFO - 'TMOUT': '86400', 02:19:03 INFO - 'USER': 'cltbld', 02:19:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', 02:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:03 INFO - '_': '/tools/buildbot/bin/python'} 02:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:03 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:19:03 INFO - Cleaning up... 02:19:03 INFO - Return code: 0 02:19:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:19: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:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f68e9778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2596350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26251c0>, '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 0x26260c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2626550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', '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:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:19:03 INFO - Using env: {'DISPLAY': ':0', 02:19:03 INFO - 'HOME': '/home/cltbld', 02:19:03 INFO - 'LANG': 'en_US.UTF-8', 02:19:03 INFO - 'LANGUAGE': 'en_US:en', 02:19:03 INFO - 'LOGNAME': 'cltbld', 02:19:03 INFO - 'MAIL': '/var/mail/cltbld', 02:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:03 INFO - 'MOZ_NO_REMOTE': '1', 02:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:03 INFO - 'NO_EM_RESTART': '1', 02:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:03 INFO - 'PWD': '/builds/slave/test', 02:19:03 INFO - 'SHELL': '/bin/bash', 02:19:03 INFO - 'SHLVL': '1', 02:19:03 INFO - 'TERM': 'linux', 02:19:03 INFO - 'TMOUT': '86400', 02:19:03 INFO - 'USER': 'cltbld', 02:19:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', 02:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:03 INFO - '_': '/tools/buildbot/bin/python'} 02:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:03 INFO - Downloading/unpacking psutil>=3.1.1 02:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:19:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:05 INFO - Installing collected packages: psutil 02:19:05 INFO - Running setup.py install for psutil 02:19:05 INFO - building 'psutil._psutil_linux' extension 02:19:05 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:19:05 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:19:05 INFO - building 'psutil._psutil_posix' extension 02:19:05 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:19:06 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:19:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:06 INFO - Successfully installed psutil 02:19:06 INFO - Cleaning up... 02:19:06 INFO - Return code: 0 02:19:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:19: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:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:06 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 0x7f68e9778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2596350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26251c0>, '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 0x26260c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2626550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', '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:19:06 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:19:06 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:19:06 INFO - Using env: {'DISPLAY': ':0', 02:19:06 INFO - 'HOME': '/home/cltbld', 02:19:06 INFO - 'LANG': 'en_US.UTF-8', 02:19:06 INFO - 'LANGUAGE': 'en_US:en', 02:19:06 INFO - 'LOGNAME': 'cltbld', 02:19:06 INFO - 'MAIL': '/var/mail/cltbld', 02:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:06 INFO - 'MOZ_NO_REMOTE': '1', 02:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:06 INFO - 'NO_EM_RESTART': '1', 02:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:06 INFO - 'PWD': '/builds/slave/test', 02:19:06 INFO - 'SHELL': '/bin/bash', 02:19:06 INFO - 'SHLVL': '1', 02:19:06 INFO - 'TERM': 'linux', 02:19:06 INFO - 'TMOUT': '86400', 02:19:06 INFO - 'USER': 'cltbld', 02:19:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', 02:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:06 INFO - '_': '/tools/buildbot/bin/python'} 02:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:19:08 INFO - Installing collected packages: mozsystemmonitor 02:19:08 INFO - Running setup.py install for mozsystemmonitor 02:19:08 INFO - Successfully installed mozsystemmonitor 02:19:08 INFO - Cleaning up... 02:19:08 INFO - Return code: 0 02:19:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f68e9778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2596350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26251c0>, '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 0x26260c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2626550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', '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:19:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:19:08 INFO - Using env: {'DISPLAY': ':0', 02:19:08 INFO - 'HOME': '/home/cltbld', 02:19:08 INFO - 'LANG': 'en_US.UTF-8', 02:19:08 INFO - 'LANGUAGE': 'en_US:en', 02:19:08 INFO - 'LOGNAME': 'cltbld', 02:19:08 INFO - 'MAIL': '/var/mail/cltbld', 02:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:08 INFO - 'MOZ_NO_REMOTE': '1', 02:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:08 INFO - 'NO_EM_RESTART': '1', 02:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:08 INFO - 'PWD': '/builds/slave/test', 02:19:08 INFO - 'SHELL': '/bin/bash', 02:19:08 INFO - 'SHLVL': '1', 02:19:08 INFO - 'TERM': 'linux', 02:19:08 INFO - 'TMOUT': '86400', 02:19:08 INFO - 'USER': 'cltbld', 02:19:08 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', 02:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:08 INFO - '_': '/tools/buildbot/bin/python'} 02:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:08 INFO - Downloading/unpacking jsonschema==2.5.1 02:19: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:19: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:19: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:19: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:19: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:19: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:19:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:19:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:10 INFO - Downloading functools32-3.2.3-2.tar.gz 02:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:19:10 INFO - warning: no files found matching '*.txt' 02:19:10 INFO - no previously-included directories found matching 'build' 02:19:10 INFO - no previously-included directories found matching 'dist' 02:19:10 INFO - no previously-included directories found matching '.git*' 02:19:10 INFO - Installing collected packages: jsonschema, functools32 02:19:11 INFO - Running setup.py install for functools32 02:19:11 INFO - warning: no files found matching '*.txt' 02:19:11 INFO - no previously-included directories found matching 'build' 02:19:11 INFO - no previously-included directories found matching 'dist' 02:19:11 INFO - no previously-included directories found matching '.git*' 02:19:11 INFO - Successfully installed jsonschema functools32 02:19:11 INFO - Cleaning up... 02:19:11 INFO - Return code: 0 02:19:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:19: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:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19: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', '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 0x7f68e9778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2596350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26251c0>, '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 0x26260c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2626550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', '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:19: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:19: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 blobuploader==1.2.4 02:19:11 INFO - Using env: {'DISPLAY': ':0', 02:19:11 INFO - 'HOME': '/home/cltbld', 02:19:11 INFO - 'LANG': 'en_US.UTF-8', 02:19:11 INFO - 'LANGUAGE': 'en_US:en', 02:19:11 INFO - 'LOGNAME': 'cltbld', 02:19:11 INFO - 'MAIL': '/var/mail/cltbld', 02:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:11 INFO - 'MOZ_NO_REMOTE': '1', 02:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:11 INFO - 'NO_EM_RESTART': '1', 02:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:11 INFO - 'PWD': '/builds/slave/test', 02:19:11 INFO - 'SHELL': '/bin/bash', 02:19:11 INFO - 'SHLVL': '1', 02:19:11 INFO - 'TERM': 'linux', 02:19:11 INFO - 'TMOUT': '86400', 02:19:11 INFO - 'USER': 'cltbld', 02:19:11 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', 02:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:11 INFO - '_': '/tools/buildbot/bin/python'} 02:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:11 INFO - Downloading/unpacking blobuploader==1.2.4 02:19: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:19: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:19: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:19: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:19: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:19: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:19:13 INFO - Downloading blobuploader-1.2.4.tar.gz 02:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:19:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:19: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:19: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:19: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:19: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:19: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:19: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:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:19:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:19: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:19: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:19: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:19: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:19: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:19: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:19:13 INFO - Downloading docopt-0.6.1.tar.gz 02:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:19:13 INFO - Installing collected packages: blobuploader, requests, docopt 02:19:13 INFO - Running setup.py install for blobuploader 02:19:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:19:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:19:14 INFO - Running setup.py install for requests 02:19:14 INFO - Running setup.py install for docopt 02:19:14 INFO - Successfully installed blobuploader requests docopt 02:19:14 INFO - Cleaning up... 02:19:14 INFO - Return code: 0 02:19:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:14 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 0x7f68e9778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2596350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26251c0>, '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 0x26260c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2626550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', '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:19:14 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:19:14 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:19:14 INFO - Using env: {'DISPLAY': ':0', 02:19:14 INFO - 'HOME': '/home/cltbld', 02:19:14 INFO - 'LANG': 'en_US.UTF-8', 02:19:14 INFO - 'LANGUAGE': 'en_US:en', 02:19:14 INFO - 'LOGNAME': 'cltbld', 02:19:14 INFO - 'MAIL': '/var/mail/cltbld', 02:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:14 INFO - 'MOZ_NO_REMOTE': '1', 02:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:14 INFO - 'NO_EM_RESTART': '1', 02:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:14 INFO - 'PWD': '/builds/slave/test', 02:19:14 INFO - 'SHELL': '/bin/bash', 02:19:14 INFO - 'SHLVL': '1', 02:19:14 INFO - 'TERM': 'linux', 02:19:14 INFO - 'TMOUT': '86400', 02:19:14 INFO - 'USER': 'cltbld', 02:19:14 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', 02:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:14 INFO - '_': '/tools/buildbot/bin/python'} 02:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:14 INFO - Running setup.py (path:/tmp/pip-6TImW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:14 INFO - Running setup.py (path:/tmp/pip-tkDimQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:14 INFO - Running setup.py (path:/tmp/pip-Bq4Mw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:15 INFO - Running setup.py (path:/tmp/pip-v4e7pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:15 INFO - Running setup.py (path:/tmp/pip-6DxCAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:15 INFO - Running setup.py (path:/tmp/pip-QKGw__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:15 INFO - Running setup.py (path:/tmp/pip-S2G2jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:15 INFO - Running setup.py (path:/tmp/pip-6JTnyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:15 INFO - Running setup.py (path:/tmp/pip-HhDWuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:15 INFO - Running setup.py (path:/tmp/pip-xOYZ3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:15 INFO - Running setup.py (path:/tmp/pip-9ix9dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:15 INFO - Running setup.py (path:/tmp/pip-GHi7fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:15 INFO - Running setup.py (path:/tmp/pip-jX1lFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:15 INFO - Running setup.py (path:/tmp/pip-PWVYhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:15 INFO - Running setup.py (path:/tmp/pip-nPn1sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:15 INFO - Running setup.py (path:/tmp/pip-FcnLcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:15 INFO - Running setup.py (path:/tmp/pip-rxlYm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:19:16 INFO - Running setup.py install for manifestparser 02:19:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Running setup.py install for mozcrash 02:19:16 INFO - Running setup.py install for mozdebug 02:19:16 INFO - Running setup.py install for mozdevice 02:19:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Running setup.py install for mozfile 02:19:16 INFO - Running setup.py install for mozhttpd 02:19:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Running setup.py install for mozinfo 02:19:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Running setup.py install for mozInstall 02:19:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Running setup.py install for mozleak 02:19:16 INFO - Running setup.py install for mozlog 02:19:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Running setup.py install for moznetwork 02:19:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Running setup.py install for mozprocess 02:19:17 INFO - Running setup.py install for mozprofile 02:19:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Running setup.py install for mozrunner 02:19:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Running setup.py install for mozscreenshot 02:19:17 INFO - Running setup.py install for moztest 02:19:17 INFO - Running setup.py install for mozversion 02:19:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:19:17 INFO - Cleaning up... 02:19:17 INFO - Return code: 0 02:19:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:17 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:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:17 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:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:17 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 0x7f68e9778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2596350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26251c0>, '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 0x26260c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2626550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', '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:19:17 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:19:17 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:19:17 INFO - Using env: {'DISPLAY': ':0', 02:19:17 INFO - 'HOME': '/home/cltbld', 02:19:17 INFO - 'LANG': 'en_US.UTF-8', 02:19:17 INFO - 'LANGUAGE': 'en_US:en', 02:19:17 INFO - 'LOGNAME': 'cltbld', 02:19:17 INFO - 'MAIL': '/var/mail/cltbld', 02:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:17 INFO - 'MOZ_NO_REMOTE': '1', 02:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:17 INFO - 'NO_EM_RESTART': '1', 02:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:17 INFO - 'PWD': '/builds/slave/test', 02:19:17 INFO - 'SHELL': '/bin/bash', 02:19:17 INFO - 'SHLVL': '1', 02:19:17 INFO - 'TERM': 'linux', 02:19:17 INFO - 'TMOUT': '86400', 02:19:17 INFO - 'USER': 'cltbld', 02:19:17 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', 02:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:17 INFO - '_': '/tools/buildbot/bin/python'} 02:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:18 INFO - Running setup.py (path:/tmp/pip-iZ2jVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:18 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:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:18 INFO - Running setup.py (path:/tmp/pip-xgDYWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:18 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:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:18 INFO - Running setup.py (path:/tmp/pip-8KsJj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:18 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:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:18 INFO - Running setup.py (path:/tmp/pip-F9Q70V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:18 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:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:18 INFO - Running setup.py (path:/tmp/pip-0IWwfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:18 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:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:18 INFO - Running setup.py (path:/tmp/pip-PK1Har-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:18 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:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:18 INFO - Running setup.py (path:/tmp/pip-7bq2mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:18 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:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:18 INFO - Running setup.py (path:/tmp/pip-sJv4OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:18 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:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:18 INFO - Running setup.py (path:/tmp/pip-WFFYnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:18 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:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:18 INFO - Running setup.py (path:/tmp/pip-tiZfpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:18 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:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:18 INFO - Running setup.py (path:/tmp/pip-vMtWJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:18 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:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:18 INFO - Running setup.py (path:/tmp/pip-CzrVzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:18 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:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:18 INFO - Running setup.py (path:/tmp/pip-lNCNDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:18 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:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:19 INFO - Running setup.py (path:/tmp/pip-yCHDaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:19 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:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:19 INFO - Running setup.py (path:/tmp/pip-c1gXEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:19 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:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:19 INFO - Running setup.py (path:/tmp/pip-1GJzuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:19 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:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:19 INFO - Running setup.py (path:/tmp/pip-OAC2Qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:19 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:19:19 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:19:19 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:19:19 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:19:19 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:19:19 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:19:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:21 INFO - Downloading blessings-1.6.tar.gz 02:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:19:21 INFO - Installing collected packages: blessings 02:19:21 INFO - Running setup.py install for blessings 02:19:21 INFO - Successfully installed blessings 02:19:21 INFO - Cleaning up... 02:19:22 INFO - Return code: 0 02:19:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:19:22 INFO - Reading from file tmpfile_stdout 02:19:22 INFO - Current package versions: 02:19:22 INFO - argparse == 1.2.1 02:19:22 INFO - blessings == 1.6 02:19:22 INFO - blobuploader == 1.2.4 02:19:22 INFO - docopt == 0.6.1 02:19:22 INFO - functools32 == 3.2.3-2 02:19:22 INFO - jsonschema == 2.5.1 02:19:22 INFO - manifestparser == 1.1 02:19:22 INFO - mozInstall == 1.12 02:19:22 INFO - mozcrash == 0.17 02:19:22 INFO - mozdebug == 0.1 02:19:22 INFO - mozdevice == 0.48 02:19:22 INFO - mozfile == 1.2 02:19:22 INFO - mozhttpd == 0.7 02:19:22 INFO - mozinfo == 0.9 02:19:22 INFO - mozleak == 0.1 02:19:22 INFO - mozlog == 3.2 02:19:22 INFO - moznetwork == 0.27 02:19:22 INFO - mozprocess == 0.22 02:19:22 INFO - mozprofile == 0.28 02:19:22 INFO - mozrunner == 6.11 02:19:22 INFO - mozscreenshot == 0.1 02:19:22 INFO - mozsystemmonitor == 0.3 02:19:22 INFO - moztest == 0.7 02:19:22 INFO - mozversion == 1.4 02:19:22 INFO - psutil == 3.1.1 02:19:22 INFO - requests == 1.2.3 02:19:22 INFO - wsgiref == 0.1.2 02:19:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:22 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:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:22 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:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:22 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 0x7f68e9778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2596350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26251c0>, '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 0x26260c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2626550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', '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:19:22 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:19:22 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:19:22 INFO - Using env: {'DISPLAY': ':0', 02:19:22 INFO - 'HOME': '/home/cltbld', 02:19:22 INFO - 'LANG': 'en_US.UTF-8', 02:19:22 INFO - 'LANGUAGE': 'en_US:en', 02:19:22 INFO - 'LOGNAME': 'cltbld', 02:19:22 INFO - 'MAIL': '/var/mail/cltbld', 02:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:22 INFO - 'MOZ_NO_REMOTE': '1', 02:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:22 INFO - 'NO_EM_RESTART': '1', 02:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:22 INFO - 'PWD': '/builds/slave/test', 02:19:22 INFO - 'SHELL': '/bin/bash', 02:19:22 INFO - 'SHLVL': '1', 02:19:22 INFO - 'TERM': 'linux', 02:19:22 INFO - 'TMOUT': '86400', 02:19:22 INFO - 'USER': 'cltbld', 02:19:22 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', 02:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:22 INFO - '_': '/tools/buildbot/bin/python'} 02:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:23 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:19:23 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:19:23 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:19:23 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:19:23 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:19:23 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:19:23 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:19:23 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:19:23 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:19:23 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:19:23 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:19:23 INFO - Cleaning up... 02:19:23 INFO - Return code: 0 02:19:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f68e9778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2596350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26251c0>, '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 0x26260c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2626550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', '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:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:19:23 INFO - Using env: {'DISPLAY': ':0', 02:19:23 INFO - 'HOME': '/home/cltbld', 02:19:23 INFO - 'LANG': 'en_US.UTF-8', 02:19:23 INFO - 'LANGUAGE': 'en_US:en', 02:19:23 INFO - 'LOGNAME': 'cltbld', 02:19:23 INFO - 'MAIL': '/var/mail/cltbld', 02:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:23 INFO - 'MOZ_NO_REMOTE': '1', 02:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:23 INFO - 'NO_EM_RESTART': '1', 02:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:23 INFO - 'PWD': '/builds/slave/test', 02:19:23 INFO - 'SHELL': '/bin/bash', 02:19:23 INFO - 'SHLVL': '1', 02:19:23 INFO - 'TERM': 'linux', 02:19:23 INFO - 'TMOUT': '86400', 02:19:23 INFO - 'USER': 'cltbld', 02:19:23 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', 02:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:23 INFO - '_': '/tools/buildbot/bin/python'} 02:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:19:23 INFO - Cleaning up... 02:19:23 INFO - Return code: 0 02:19:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f68e9778f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2596350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26251c0>, '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 0x26260c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2626550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', '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:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:19:23 INFO - Using env: {'DISPLAY': ':0', 02:19:23 INFO - 'HOME': '/home/cltbld', 02:19:23 INFO - 'LANG': 'en_US.UTF-8', 02:19:23 INFO - 'LANGUAGE': 'en_US:en', 02:19:23 INFO - 'LOGNAME': 'cltbld', 02:19:23 INFO - 'MAIL': '/var/mail/cltbld', 02:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:23 INFO - 'MOZ_NO_REMOTE': '1', 02:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:23 INFO - 'NO_EM_RESTART': '1', 02:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:23 INFO - 'PWD': '/builds/slave/test', 02:19:23 INFO - 'SHELL': '/bin/bash', 02:19:23 INFO - 'SHLVL': '1', 02:19:23 INFO - 'TERM': 'linux', 02:19:23 INFO - 'TMOUT': '86400', 02:19:23 INFO - 'USER': 'cltbld', 02:19:23 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', 02:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:23 INFO - '_': '/tools/buildbot/bin/python'} 02:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:23 INFO - Downloading/unpacking flake8 02:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:19:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:19:25 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:19:25 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:19:25 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:19:25 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:19:25 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:19:25 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:19:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:19:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:19:25 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:19:25 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:19:25 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:19:25 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:19:25 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:19:25 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:19:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:19:25 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:19:25 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:19:25 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:19:25 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:19:25 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:19:25 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:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:19:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:19:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:19:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:19:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:19:26 INFO - no previously-included directories found matching 'docs/_build' 02:19:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:19:26 INFO - Running setup.py install for pep8 02:19:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:19:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:19:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:19:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:19:26 INFO - no previously-included directories found matching 'docs/_build' 02:19:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:19:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:19:26 INFO - Cleaning up... 02:19:26 INFO - Return code: 0 02:19:26 INFO - Running post-action listener: _resource_record_post_action 02:19:26 INFO - Running post-action listener: _start_resource_monitoring 02:19:26 INFO - Starting resource monitoring. 02:19:26 INFO - ##### 02:19:26 INFO - ##### Finished create-virtualenv step (success) 02:19:26 INFO - ##### 02:19:26 INFO - ##### 02:19:26 INFO - ##### Running install step. 02:19:26 INFO - ##### 02:19:26 INFO - Running pre-action listener: _resource_record_pre_action 02:19:26 INFO - Running main action method: install 02:19:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:19:26 INFO - Reading from file tmpfile_stdout 02:19:26 INFO - Detecting whether we're running mozinstall >=1.0... 02:19:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:19:26 INFO - Reading from file tmpfile_stdout 02:19:26 INFO - Output received: 02:19:26 INFO - Usage: mozinstall [options] installer 02:19:26 INFO - Options: 02:19:26 INFO - -h, --help show this help message and exit 02:19:26 INFO - -d DEST, --destination=DEST 02:19:26 INFO - Directory to install application into. [default: 02:19:26 INFO - "/builds/slave/test"] 02:19:26 INFO - --app=APP Application being installed. [default: firefox] 02:19:26 INFO - mkdir: /builds/slave/test/build/application 02:19:26 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:19:26 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:19:42 INFO - Reading from file tmpfile_stdout 02:19:42 INFO - Output received: 02:19:42 INFO - /builds/slave/test/build/application/firefox/firefox 02:19:42 INFO - Running post-action listener: _resource_record_post_action 02:19:42 INFO - ##### 02:19:42 INFO - ##### Finished install step (success) 02:19:42 INFO - ##### 02:19:42 INFO - ##### 02:19:42 INFO - ##### Running run-tests step. 02:19:42 INFO - ##### 02:19:42 INFO - Running pre-action listener: _resource_record_pre_action 02:19:42 INFO - Running main action method: run_tests 02:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:19:42 INFO - Python 2.7.3 02:19:42 INFO - Return code: 0 02:19:42 INFO - grabbing minidump binary from tooltool 02:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:42 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 0x26251c0>, '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 0x26260c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2626550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:19:42 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:19:42 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:19:42 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:19:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:19:42 INFO - Return code: 0 02:19:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:19:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:19:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:19:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:19:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:19:43 INFO - Return code: 0 02:19:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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:19:43 INFO - Using env: {'DISPLAY': ':0', 02:19:43 INFO - 'HOME': '/home/cltbld', 02:19:43 INFO - 'LANG': 'en_US.UTF-8', 02:19:43 INFO - 'LANGUAGE': 'en_US:en', 02:19:43 INFO - 'LOGNAME': 'cltbld', 02:19:43 INFO - 'MAIL': '/var/mail/cltbld', 02:19:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:19:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:43 INFO - 'MOZ_NO_REMOTE': '1', 02:19:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:43 INFO - 'NO_EM_RESTART': '1', 02:19:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:43 INFO - 'PWD': '/builds/slave/test', 02:19:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:19:43 INFO - 'SHELL': '/bin/bash', 02:19:43 INFO - 'SHLVL': '1', 02:19:43 INFO - 'TERM': 'linux', 02:19:43 INFO - 'TMOUT': '86400', 02:19:43 INFO - 'USER': 'cltbld', 02:19:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414', 02:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:43 INFO - '_': '/tools/buildbot/bin/python'} 02:19:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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:19:43 INFO - mozversion application_buildid: 20160616004126 02:19:43 INFO - mozversion application_changeset: 6b40db1565705c392042da04396d1ca83c0d017d 02:19:43 INFO - mozversion application_display_name: Nightly 02:19:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:19:43 INFO - mozversion application_name: Firefox 02:19:43 INFO - mozversion application_remotingname: firefox 02:19:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:19:43 INFO - mozversion application_vendor: Mozilla 02:19:43 INFO - mozversion application_version: 50.0a1 02:19:43 INFO - mozversion platform_buildid: 20160616004126 02:19:43 INFO - mozversion platform_changeset: 6b40db1565705c392042da04396d1ca83c0d017d 02:19:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:19:43 INFO - mozversion platform_version: 50.0a1 02:19:43 INFO - using testdate: 1466068783 02:19:43 INFO - actual date: 1466068783 02:19:43 INFO - starting webserver on 'localhost:43975' 02:19:43 INFO - SUITE-START | Running 2 tests 02:19:43 INFO - TEST-START | dromaeo_css 02:19:43 INFO - operating with platform_type : linux_ 02:19:43 INFO - Initialising browser for dromaeo_css test... 02:19:43 INFO - TEST-INFO | started process 12684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfdXu2F/profile http://localhost:43975/getInfo.html) 02:19:49 INFO - PROCESS | 12684 | __metrics Screen width/height:1600/1200 02:19:49 INFO - PROCESS | 12684 | colorDepth:24 02:19:49 INFO - PROCESS | 12684 | Browser inner width/height: 1024/697 02:19:49 INFO - PROCESS | 12684 | __metrics 02:19:50 ERROR - PROCESS | 12684 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:19:51 INFO - TEST-INFO | 12684: exit 0 02:19:51 INFO - Browser initialized. 02:19:51 INFO - Running cycle 1/1 for dromaeo_css test... 02:19:51 INFO - TEST-INFO | started process 12802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfdXu2F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:20:03 INFO - PROCESS | 12802 | RSS: Main: 186241024 02:20:03 INFO - PROCESS | 12802 | 02:20:52 INFO - PROCESS | 12802 | 1466068852912 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:23:05 INFO - PROCESS | 12802 | Cycle 1(1): loaded http://localhost:43975/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43975/tests/dromaeo/cssquery-ext.html) 02:23:06 INFO - PROCESS | 12802 | RSS: Main: 189747200 02:23:06 INFO - PROCESS | 12802 | 02:26:09 INFO - PROCESS | 12802 | Cycle 1(1): loaded http://localhost:43975/tests/dromaeo/cssquery-ext.html (next: http://localhost:43975/tests/dromaeo/cssquery-jquery.html) 02:26:09 INFO - PROCESS | 12802 | RSS: Main: 188096512 02:26:09 INFO - PROCESS | 12802 | 02:29:11 INFO - PROCESS | 12802 | Cycle 1(1): loaded http://localhost:43975/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43975/tests/dromaeo/cssquery-mootools.html) 02:29:12 INFO - PROCESS | 12802 | RSS: Main: 189194240 02:29:12 INFO - PROCESS | 12802 | 02:32:14 INFO - PROCESS | 12802 | Cycle 1(1): loaded http://localhost:43975/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43975/tests/dromaeo/cssquery-prototype.html) 02:32:14 INFO - PROCESS | 12802 | RSS: Main: 187006976 02:32:14 INFO - PROCESS | 12802 | 02:35:17 INFO - PROCESS | 12802 | Cycle 1(1): loaded http://localhost:43975/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43975/tests/dromaeo/cssquery-yui.html) 02:35:18 INFO - PROCESS | 12802 | RSS: Main: 188674048 02:35:18 INFO - PROCESS | 12802 | 02:38:20 INFO - PROCESS | 12802 | Cycle 1(1): loaded http://localhost:43975/tests/dromaeo/cssquery-yui.html (next: http://localhost:43975/tests/dromaeo/cssquery-dojo.html) 02:38:20 INFO - PROCESS | 12802 | RSS: Main: 190332928 02:38:20 INFO - PROCESS | 12802 | 02:38:20 INFO - PROCESS | 12802 | __start_tp_report 02:38:20 INFO - PROCESS | 12802 | _x_x_mozilla_page_load 02:38:20 INFO - PROCESS | 12802 | _x_x_mozilla_page_load_details 02:38:20 INFO - PROCESS | 12802 | |i|pagename|runs| 02:38:20 INFO - PROCESS | 12802 | |0;dojo.html;2653.694825095114;2665.9333516662073;2690.3408664877106;2695.4609078184367;2702.243371855881;4769.356136921515;4798.736069516175;4819.59033482154;4875.24433712775;4939.28380384844;4771.045790841837;4856.660033797635;4867.2942423348595;4868.732219727923;4900.289458028584;4420.204363214628;4455.042165934324;4561.2245918193985;4568.611668008223;4589.0821835633005;559.3348128824326;4380.56194380561;4444.755538445384;4472.552744725518;4539.863804085882;4467.195904737162;4469.7541635210055;4501.684882058257;4506.707064040859;4533.591976722111;4504.684672072924;4535.319702044687;4544.977275113603;4560.087982403499;4586.334981427708;4379.4525684289465;4383.517813040563;4409;4472.619827314682;4543.591076803071;4847.927281090787;4864.148773964577;4873.415190177201;4886.315915771759;4931.038447502739;5192.1692529195525;5237.188235823453;5240.423553409122;5241.895162096775;5307.389650190239;5237.921431178535;5288.576913846883;5296.973515132399;5309.973450132763;5342.305500284977;4909.582685471739;4926.482719314492;4929.9014019720125;4937.728424936591;4952.603791696655;5252.579793616578;5291.708956007456;5295.126304159848;5342.2253773202665;5346.304980352607;5116.9744151279;5131.102057139986;5131.692098474104;5139.177731563007;5176.715280659525;5204.4014938281825;5221.582273418117;5234.371875374979;5234.607404444682;5271.4728527147745;5061.215511595708;5163.483651634881;5171.560417364491;5180.067587834226;5205.973970130125;5147.639665223398;5169.250458683545;5177.741112944413;5180.093483640348;5212.765425555859;4392.626626736699;4393.582609652142;4402.757848318373;4413.3821265022925;4446.844360447433;3773.981130094387;3793.1275806564645;3826.559945606235;3847.6921846252235;3890.766554006712;4498.280275156025;4513.052259025641;4521.050579378368;4568.931466028012;4642.489326174118;5317.8404647860625;5318.7074710891275;5327.840164795062;5331.973340133274;5333.466653334635;4431.047324825178;4502.617277531381;4503.054358584734;4530.728156310632;4542.341360502709;4636.235021221461;4637.211674015358;4674.719516828933;4682.806501024466;4727.149113159596;4818;4903.26451032348;4922.064807686528;4931.693101328079;4972.776225069881;5189.974050129726;5191.169412893919;5208.557272631869;5238.214267859851;5242;4905.975470122627;4912.70523768575;4916.287138364845;4934.259861020875;4951.603871690329;5044.243363495505;5093.974530127326;5145.3568303962;5155.484451554815;5164.302819119521;5181.611379146504;5206.2450944612065;5230.660007099526;5241.109011468136;5280.920786188287;5046.621503387188;5086.262491938722;5089.26205700164;5097.490250975021;5124.333836601218;5067.239914012927;5115.74421278942;5120.48795120485;5142.357205349332;5183.118869792069;4988;5035.219540971156;5044.8991020178655;5048.798048078036;5098.337216161875;5188.896222075462;5197.506236907488;5197.532222100029;5203.063448579292;5211.895762084813;4944.7033178008;5046.116929537389;5070.771815268248;5097.209932460474;5102.1326374515675 02:38:20 INFO - PROCESS | 12802 | |1;ext.html;541.3166217186317;578.4504720515512;578.7858492357827;608.51622959747;612.8069658057715;35886.28227435453;37393.065173370676;40599;40912.38631420531;40973.79513102438;40741;41190.58809411905;41427.17145657085;41712.374314385306;41841.58158418415;7884.172161923001;7932.127465978767;7937.960310198441;8038.115807261197;8041.276285134337;7929.850171725126;7982.401319901001;7982.880256796153;7988.480748751313;8025.277725004748;8004.559749213791;8023.197680231989;8054.7180848670305;8079.353651707849;8083;7970.08344040437;7989.920100798976;8010.07884093328;8043.195680431969;8045.95977020117;7818.45270831042;7922.445428819985;7923.405744569181;7975.960120199362;7987.600619969036;30322.84838575793;38162.80918595417;38272.617273827185;38395;38506.03734906622;2758.4069425073703;3107.207662046186;3245.3996010738088;3689.3728066228805;3725.4225595032544;27601.447971040467;27704.722952770415;28275.434491310058;29357.85321073402;29369.70630293691;3362.7477939154414;3405.404054290489;3409.539712138854;3430.1767575781882;3588.1926566522584;212962;213902;214801.99999999843;215124;215397;31434.685653143177;32355.838220808746;32507;32508.674913250565;34436.65563344384;33906.49140262898;34318;34416;34434.139146521535;34497.482537761956;11868.109891758153;11922.582709605296;11928.821067683992;11983.820242696367;12011.699707507207;10122.898771012344;10144.695659130239;10203.38779673222;10224.897751022543;10297.07326340633;7878.369730421553;7882.369410447151;7984.121746607869;8008.599570021475;8009.679612815422;3072.446959547303;3153.195935036551;3169.4611915974338;3177.7616678749187;3199.792013519114;862.9007664118582;904.2043002158059;914.3142643017736;950.9714708558754;991.7966816802539;28595.428091438054;28636;28727.281817954718;29243.85378073096;29362.706372935998;934.6121359635811;938.6714649872627;948.5487204577008;965.5558443116245;968.4383057826444;14339.354729037219;14531.709365812836;14707.41170353174;14764.926175369055;15159.621009474631;420026;420842;421710;422560;422946;49246.261306080436;49949.50050499521;49950.500494995315;49955.25067123996;50161.74919125381;1146.3866831245243;1175.2126075529416;1181.911356648255;1197.706561892342;1197.868234494205;25471;26608.7339126614;26769.464610708066;27355.452890942466;27364.179074627795;42768.358474622284;43021;43294.350584741886;43370;43541.78229108961;346325;347935;351447;351900;352524;23408.83980662657;23601.881990589936;23615.52768944646;23619.29142125739;23630.81845907732;41393.79303103465;41417;41735.58264417317;42348.36477452902;42454.36318455287;34928.65071349355;35335.46996794999;35357;35776.46335305025;36609;35312;36013.81993090018;36107.458388123676;36136.63863361333;36224.818875905454;35186.47220291646;35231.647683523865;35895.51829526664;36574;37401;31748.523772143897;33555.1891270676;33585.32829343448;33698.49452258169;33939;25625.487490250463;25716.614250786628;26047;26111.08611198599;26221.73778262193 02:38:20 INFO - PROCESS | 12802 | |2;jquery.html;365.90120667419797;370.22437992405906;372.5752641988134;379.78162556530003;386.8123959879458;15832.208389580519;16331.346746130155;17462.738058929095;17487.125643717827;17501.82498175018;16104.355825766985;16536.42122525712;17435.82564174358;17439.21523531441;17486;4963.553280204781;5196.532312091911;5198.92201616976;5272.973635131838;5279.891222843207;5130.9743451282875;5147.948520514803;5185.896282074356;5248.475152484759;5248.790048398078;5017.297578339036;5161.045206636765;5180.922286165711;5188.974055129719;5191.896162076756;5036.294918711384;5149.742512874342;5155.484451554852;5168.767405466744;5174.456682048369;4584.770761461914;4598.724076555417;4612.100640375128;4634.930476042862;4639.164950308943;20010.89994550018;20092.69860952087;20579.691304630443;20867;20987.685184722242;1917.8273955343946;1979.89110598917;2016.3446879764135;2080.781517940625;2360.221127028077;13424.395902184327;13884.722305553933;13911.79132313016;14028.92985535076;14083.929580352033;1747.9038652874087;1806.2865168258595;1806.825563383798;1869.8126689552096;1905.9809401905943;66849.3315066848;67564.32435675678;68142;68168.6591567039;69553.30446695519;9486.857697134548;9777.071178238057;9965.750856228653;9990.14195583602;10019.348742331871;13599.456021759019;13669.726605467835;13694.315284235749;13701.657458563417;13722.65693357674;6857.485688573377;6872.900335946325;6955.200151982485;7107.431405487549;7133.678984445713;6304.810855674337;6452.645104519296;6494.805155845333;6815;6851.520393572402;6179.907301390483;6273.341299163522;6315.778947736899;6351.428371446592;6380.585261957958;1764.2590112152927;1804.8465880400313;1808;1827.6070644811164;1876.4464482977555;835.3818174550788;863.6113748813059;909.5134103254727;912.6577533424966;944.5182956692137;15595.922020389826;17040.914795425942;17408.21663025167;17656.470305890845;17977.280908763503;866.9089745576624;867.0505796153202;871.4509858788922;892.9100570909321;916.619602864817;9982.600695972225;10154.695359139238;10263.486825658836;10317.587296508205;10341.793164136676;379265;382757;384917;387246;388052;38021.23957520889;46266.30600540995;52781;64082.35917640857;66895;883.885094937654;892.1168043636883;916.4592890194684;919.7424721078108;923.1875949164827;16432.83567164313;16508.75236871472;16607.169641518118;16625.833741662427;16792.916035419745;23699.40751481227;25950.74049259559;34459.4831077529;34761;36033.099172520895;42016.159676805684;43154.56845431506;46164.53835461737;47938.760306198245;48584.514154858;7470.252974702486;7839.9216007839195;7867.685292588461;7941.364690824605;8037.959810200911;8484.745457636282;11024.50389732448;11735.530578776754;11936.28382297065;12135.817962730744;10409.219308551737;10424.426656533964;10657.25399222078;10716.089132423831;10863.945680271549;10169.237307201842;10341.689749307532;10644.89355106439;10781.02970732638;10963.56145754161;5314.362276526842;9758.316917815968;10680.626178084041;10732.195085368472;10944.616938407118;6622.569532980341;7013.438924885895;7301.123865136217;7717.961410192913;7910.446268761131;9331.626734930527;10167.694969150938;10244.924282950184;10454.947725261325;10514.526846291783 02:38:20 INFO - PROCESS | 12802 | |3;mootools.html;1370.5888233529943;1411.322565168719;1465.5749832548554;1628.4463282483953;1651.2569343795287;6776.322367763221;7476.140243871956;7583.203763604824;8076.313513351365;8079.151689072643;7908.565028923421;7991.9600401997905;8030.558319292437;8040.758777236678;8044.8391032179325;2170.7395112586473;2208.4810069633622;2219.3341997400794;2223.9110435582556;2229.308914236584;2190.6494960806276;2206.415299945516;2231.0518029837335;2253.042456955787;2254.120892851789;2212.623853944833;2215.368619943308;2215.523662412581;2219.9001044952934;2228.821694264463;2155.299527653519;2167.6098302305577;2174.6629272462715;2176.0751680535786;2176.5973294940486;2182.74898386686;2183.727034120735;2186.529896072336;2189;2203.8567493112896;8008.879866802003;8125.3499720022255;8147.226013528705;8163.224493673091;8171.468854524437;4283.828646854122;4336.8265269389185;4343.630791382736;4355.825766969318;4381.25518661825;2747.4917140329103;2897.913062608125;2954.630671166104;2954.9409011819857;2970.1683528612025;895.8432274352027;898.5507246376811;926.1754343942423;928.475411392561;932.3613324872484;10851.457427128691;10939.671809845639;10958.397288149148;11052.336859788438;11067.778644427146;4003.5996400360314;4081.163361510883;4140.91718165641;4155.065110350147;4161.56303588125;9225.677101301557;9261.44431334122;9353.532323383804;9380.67167649129;9405.43567385959;4359.716618419856;4365.890852728708;4372.497162826252;4384.561543845653;4389.3415987601475;3539.752217344761;3873.9806300968316;3923.3722604383734;3999.6600288975765;4077.918441631151;3606.206634540397;3640.2719456108885;3724.925501490009;3756.511653485084;3816.713746469026;1173.9962332206012;1182.9704257393635;1186.9169158159018;1187.7980743273665;1195.8325834383193;691.8132104331802;783.1581050370875;795.1849354411659;802.5385403393072;803.1165717710471;4942.678725882806;4966.826161084345;5163.14808056674;5194.246834209019;5203.16749320107;376.472937886955;376.99623003769614;378.1208689796235;378.5684319875289;860.157046094818;3159.952600710991;3181.316017056344;3223.693749093832;3235.2558911450496;3270.8201048942537;9689.806203876024;9893.060159284856;9900.504974751233;9943.850842237227;10044.849327260097;9746.171575416169;9884.159846412991;9908.65319713821;9927.602895884083;9928.453935033642;7418.146913105062;7484.476086673881;7486.101667799899;7518.210587888302;7535.8116047099265;4921.360223170965;4974.154393752999;5046.1926091825135;5084.6440749147205;5092.541671249605;9154.679586214717;9207.907920920705;9220.354575179674;9223;9312.44125352481;9162.633494660138;9397.201237894855;9448.905510944802;9484.383515071499;9514.666986655433;5759.71201439918;6123.357047510125;6291.213598300213;6316.842078948063;6429.6142231466265;7749.380049595906;7800.024996875391;7829.217078292125;7844.09792873804;7861.685532578633;6772.221194562689;6967.268436814062;7001.229864714979;7065.399441047569;7225.63871806397;6804.21751498584;6854.828629284308;6882.414994725505;6946.16646002483;6980.895286570807;6267.843303917439;6281.842953926189;6283.5287353449585;6385.648789316447;6431;4400.097979914046;4482.305242687388;4505.797239124182;4538.819906824316;4560.315952607003;4457.219986502284;4470.910581788281;4492.101579684011;4554.111948170075;4602.516735742699 02:38:20 INFO - PROCESS | 12802 | |4;prototype.html;288.3900550336039;293.7415074734234;298.18297863853036;302.0907069720142;304.8490996956508;5112.693238405698;5131.743412829363;5137.7944882204665;5138.152204886194;5170.302009228753;5044.596432285409;5059.7976080956805;5084.57631863078;5110.488951104897;5117.1556693145585;3782.621737826216;3874.6319099685484;3979.9602003980026;3982.044309365746;3995.4805875236325;3928.6071392860626;3946.559505780384;3969.4641223434755;3986;3999.480067591224;3941.2314598653275;3961.900952476197;3981.2435637228978;3998.1403998140395;4007.318755811519;3694.5012423323046;3941.3102707026155;3959.703022273341;3987.80060996949;3997.3204555225534;3404.608470025954;3419.81191034493;3420.452727563603;3430.125318043908;3438.82805859706;5012.548870601627;5020.573251273646;5022.698638081727;5046.486054183731;5052.8231511897275;4238.321868501025;4460.754658493782;4498.730076195406;4510;4522.2086134926585;5345.625806193568;5349.769553002831;5374.7043912584795;5382.757775900094;5392.352917649907;3732.794696291703;3745.7190710696805;3754.554496518833;3761.6426439488205;3769.1142581493327;5318.234518050592;5552.3892371839065;5629.155626655994;5660.547156227533;5685.346185188673;3771.8114094295174;3776.8300426480873;3810.40938654509;3811.371123764548;3816.503854498953;3856.9614303857165;3862.304785138702;3863.9227215455535;3864.71014673895;3865.130345672201;4445.133199026223;4485.596296333346;4512.368268442421;4528.592426681615;4535.841245556389;5221.869453263623;5396.703181324986;5415.85686949484;5427.1316589345515;5468.48049435303;1335.5709390951783;1340.8189894364332;1344.3412727763325;1344.6436694276024;1346.9528566500126;837.535167981776;846.4413487098485;857.7341024282492;863.3869952333913;863.8229163021565;4643.976780116078;4655.906881862344;4674.345591617176;4676.205045142334;4682.765861706901;5404.189371594292;5499.917501237484;5499.945000550023;5500.834974950758;5516.448355164532;4527;4597.839075632337;4614.538546145426;4638.909856183795;4654.208784506642;2935.2661834541364;2936.9294647273623;2945.7937944344117;2952.675205727411;2968.495355789521;5141.460146684619;5154.768035438415;5156.819511317086;5160.354955630546;5160.7935682573025;5378.569714422837;5591.217229587861;5612.186232996192;5718.542516598745;5735.541156707453;5232.293640358503;5234.947650523446;5266.262723218752;5267.157254839208;5269.631125821233;5544.362398324244;5551.362348107399;5575.776968921197;5598.580106491948;5626.634268772516;5184.481551844936;5447.836564902901;5450.800823818753;5456.236126942152;5472.644278121909;5197.974010129925;5231.529162375405;5262.868428289324;5265.183896496049;5318.4149743527405;3850.3261929162845;3850.4801851749653;3852;3862.9034274142246;3879.1465877506903;5379.1662292344745;5556.777728890799;5560.138178582326;5598.21624972496;5601.495865372136;5326.6537675050995;5410.323709536308;5417.702026388586;5423.322084739408;5448.264484294569;5311.41574426805;5361.954418888279;5394.595405344537;5403.13549832025;5419.891602167856;5226.9215961761365;5265.815696450606;5266.526012658725;5283.207518872046;5287.471252874836;5153.453963810916;5272.393674727456;5438.510534051796;5444.237806707143;5473.534749546333;5320.52115309624;5350.705711185922;5352.785888564569;5360.839174824761;5365.3293338332705 02:38:20 INFO - PROCESS | 12802 | |5;yui.html;650.7299470719648;667.4126768443768;674.6660403100466;683.5591043776764;735.0848193998471;12877.162984406006;13655.248961307136;13998.230097344654;14058.086224395407;14086.013979021447;13447.924166066716;13604.31978401081;13623.795643065361;14173.29133543324;14784.334704938277;792.4769652029662;798.4690181029608;799.0092285565886;800.5516910530092;801.2068052627915;629.5530173576766;773.4933618479877;787.2167193642334;795.4272923495074;795.892554505143;815.0301141641457;821.8931538899934;822.1244374740882;823.6622984576325;824.3734761581181;811.8944537210125;814.2997022560593;814.9307308878723;814.9551774652392;819.7991492084448;596.0641792385956;597.6264834478451;597.7877853362037;597.8146774499919;598.2014011294926;13533.120347177402;13657.521986730517;13667.248301343423;13744.450221991108;13775.448982040707;13008.739825203538;13184.406701698446;13267.212593417104;13319.26744029078;13376.531821386303;10510.421926794023;10541.683749487527;10542.578296868116;10567.365958042543;10588.523516441779;3285.5235990781443;3328.051505320972;3341.2482191506715;3367.898963031113;3380.8647654093807;52206;59826.70086649583;60033.39966600366;60238;60312.39687603068;9732.07545283211;9970.551325190383;10086.193104551618;10100.595976160872;10155.136813370798;18576.349827755963;18632;18946.43160705181;18951.810481895005;18955.336563220222;6674.933250667431;6745.089412929192;6805.149356330458;6935.479839012094;6975.581465112008;3587.515685382492;3752.774833509998;3777.58446570877;3800.8669696560487;3904.941425878614;2943.3230357018006;3083.2908431060982;3084.4139613473367;3087.81473111614;3092.6134233220846;506.6124414822664;515.6210185513645;516.0272885610651;529.8172130614931;531.6305167908266;366.60956081772827;453.49208886047836;458.37660781337354;468.10358164115337;476.7949781593879;7691.384689224848;7808;7821;7829.882551761728;8045.919540804634;426.95090064642966;476.77114984807486;521;537;543.6873797566415;3562.287542491512;3639.1266096136737;3677.669009789132;3795.867144649924;3842.9231415371537;61026;86454;86536;86776.56611716902;87198;47516;47765;47943;48228.758856205495;49138;74204.25795742082;74736.62631686915;75139;75606;77040;7197.748078817426;7270.563766174047;7502.624868756649;7508.58702771331;7576.052993375828;42940.14119717525;44456.555434446534;44466.55533444624;44645.33032004457;46275;54610.726946365015;64568.677156613914;65538.67230663817;65883.34116658772;65930.34069659242;9030.909690903007;9151.383586595644;9331.626734930527;9351.672691455766;9368.906310937076;10473;10500.739911210703;10651.893481065401;10871.565137394417;13170.143940643828;12483.02589975104;12710.77561426728;12892.548760793326;12969.870301296865;13004;10509.684709458728;10660.466976650981;12386;12397.504099835905;12703.745925081263;12265.816012759995;12292.38538073075;12664.493420263087;12818.55135070268;12871.871281287442;8369.66521339164;9077.364584479286;9283.535823208947;9405.905940940504;9621.56702948383;9705.708828735149;9859.30984831055;9872.901270987486;10179.898201018192;10195.796084078129 02:38:20 INFO - PROCESS | 12802 | __end_tp_report 02:38:20 INFO - PROCESS | 12802 | __start_cc_report 02:38:20 INFO - PROCESS | 12802 | _x_x_mozilla_cycle_collect,391 02:38:20 INFO - PROCESS | 12802 | __end_cc_report 02:38:20 INFO - PROCESS | 12802 | __startTimestamp1466069900817__endTimestamp 02:38:20 INFO - PROCESS | 12802 | 02:38:20 INFO - PROCESS | 12802 | ------- Summary: start ------- 02:38:20 INFO - PROCESS | 12802 | Number of tests: 6 02:38:20 INFO - PROCESS | 12802 | 02:38:20 INFO - PROCESS | 12802 | [#0] dojo.html Cycles:165 Average:4806.25 Median:4951.60 stddev:614.64 (12.4%) stddev-sans-first:592.87 02:38:20 INFO - PROCESS | 12802 | Values: 2653.7 2665.9 2690.3 2695.5 2702.2 4769.4 4798.7 4819.6 4875.2 4939.3 4771.0 4856.7 4867.3 4868.7 4900.3 4420.2 4455.0 4561.2 4568.6 4589.1 559.3 4380.6 4444.8 4472.6 4539.9 4467.2 4469.8 4501.7 4506.7 4533.6 4504.7 4535.3 4545.0 4560.1 4586.3 4379.5 4383.5 4409.0 4472.6 4543.6 4847.9 4864.1 4873.4 4886.3 4931.0 5192.2 5237.2 5240.4 5241.9 5307.4 5237.9 5288.6 5297.0 5310.0 5342.3 4909.6 4926.5 4929.9 4937.7 4952.6 5252.6 5291.7 5295.1 5342.2 5346.3 5117.0 5131.1 5131.7 5139.2 5176.7 5204.4 5221.6 5234.4 5234.6 5271.5 5061.2 5163.5 5171.6 5180.1 5206.0 5147.6 5169.3 5177.7 5180.1 5212.8 4392.6 4393.6 4402.8 4413.4 4446.8 3774.0 3793.1 3826.6 3847.7 3890.8 4498.3 4513.1 4521.1 4568.9 4642.5 5317.8 5318.7 5327.8 5332.0 5333.5 4431.0 4502.6 4503.1 4530.7 4542.3 4636.2 4637.2 4674.7 4682.8 4727.1 4818.0 4903.3 4922.1 4931.7 4972.8 5190.0 5191.2 5208.6 5238.2 5242.0 4906.0 4912.7 4916.3 4934.3 4951.6 5044.2 5094.0 5145.4 5155.5 5164.3 5181.6 5206.2 5230.7 5241.1 5280.9 5046.6 5086.3 5089.3 5097.5 5124.3 5067.2 5115.7 5120.5 5142.4 5183.1 4988.0 5035.2 5044.9 5048.8 5098.3 5188.9 5197.5 5197.5 5203.1 5211.9 4944.7 5046.1 5070.8 5097.2 5102.1 02:38:20 INFO - PROCESS | 12802 | 02:38:20 INFO - PROCESS | 12802 | [#1] ext.html Cycles:180 Average:46612.01 Median:19737.24 stddev:90073.79 (456.4%) stddev-sans-first:90260.06 02:38:20 INFO - PROCESS | 12802 | Values: 541.3 578.5 578.8 608.5 612.8 35886.3 37393.1 40599.0 40912.4 40973.8 40741.0 41190.6 41427.2 41712.4 41841.6 7884.2 7932.1 7938.0 8038.1 8041.3 7929.9 7982.4 7982.9 7988.5 8025.3 8004.6 8023.2 8054.7 8079.4 8083.0 7970.1 7989.9 8010.1 8043.2 8046.0 7818.5 7922.4 7923.4 7976.0 7987.6 30322.8 38162.8 38272.6 38395.0 38506.0 2758.4 3107.2 3245.4 3689.4 3725.4 27601.4 27704.7 28275.4 29357.9 29369.7 3362.7 3405.4 3409.5 3430.2 3588.2 212962.0 213902.0 214802.0 215124.0 215397.0 31434.7 32355.8 32507.0 32508.7 34436.7 33906.5 34318.0 34416.0 34434.1 34497.5 11868.1 11922.6 11928.8 11983.8 12011.7 10122.9 10144.7 10203.4 10224.9 10297.1 7878.4 7882.4 7984.1 8008.6 8009.7 3072.4 3153.2 3169.5 3177.8 3199.8 862.9 904.2 914.3 951.0 991.8 28595.4 28636.0 28727.3 29243.9 29362.7 934.6 938.7 948.5 965.6 968.4 14339.4 14531.7 14707.4 14764.9 15159.6 420026.0 420842.0 421710.0 422560.0 422946.0 49246.3 49949.5 49950.5 49955.3 50161.7 1146.4 1175.2 1181.9 1197.7 1197.9 25471.0 26608.7 26769.5 27355.5 27364.2 42768.4 43021.0 43294.4 43370.0 43541.8 346325.0 347935.0 351447.0 351900.0 352524.0 23408.8 23601.9 23615.5 23619.3 23630.8 41393.8 41417.0 41735.6 42348.4 42454.4 34928.7 35335.5 35357.0 35776.5 36609.0 35312.0 36013.8 36107.5 36136.6 36224.8 35186.5 35231.6 35895.5 36574.0 37401.0 31748.5 33555.2 33585.3 33698.5 33939.0 25625.5 25716.6 26047.0 26111.1 26221.7 02:38:20 INFO - PROCESS | 12802 | 02:38:20 INFO - PROCESS | 12802 | [#2] jquery.html Cycles:180 Average:23316.00 Median:387649.00 stddev:62983.06 (16.2%) stddev-sans-first:63136.17 02:38:20 INFO - PROCESS | 12802 | Values: 365.9 370.2 372.6 379.8 386.8 15832.2 16331.3 17462.7 17487.1 17501.8 16104.4 16536.4 17435.8 17439.2 17486.0 4963.6 5196.5 5198.9 5273.0 5279.9 5131.0 5147.9 5185.9 5248.5 5248.8 5017.3 5161.0 5180.9 5189.0 5191.9 5036.3 5149.7 5155.5 5168.8 5174.5 4584.8 4598.7 4612.1 4634.9 4639.2 20010.9 20092.7 20579.7 20867.0 20987.7 1917.8 1979.9 2016.3 2080.8 2360.2 13424.4 13884.7 13911.8 14028.9 14083.9 1747.9 1806.3 1806.8 1869.8 1906.0 66849.3 67564.3 68142.0 68168.7 69553.3 9486.9 9777.1 9965.8 9990.1 10019.3 13599.5 13669.7 13694.3 13701.7 13722.7 6857.5 6872.9 6955.2 7107.4 7133.7 6304.8 6452.6 6494.8 6815.0 6851.5 6179.9 6273.3 6315.8 6351.4 6380.6 1764.3 1804.8 1808.0 1827.6 1876.4 835.4 863.6 909.5 912.7 944.5 15595.9 17040.9 17408.2 17656.5 17977.3 866.9 867.1 871.5 892.9 916.6 9982.6 10154.7 10263.5 10317.6 10341.8 379265.0 382757.0 384917.0 387246.0 388052.0 38021.2 46266.3 52781.0 64082.4 66895.0 883.9 892.1 916.5 919.7 923.2 16432.8 16508.8 16607.2 16625.8 16792.9 23699.4 25950.7 34459.5 34761.0 36033.1 42016.2 43154.6 46164.5 47938.8 48584.5 7470.3 7839.9 7867.7 7941.4 8038.0 8484.7 11024.5 11735.5 11936.3 12135.8 10409.2 10424.4 10657.3 10716.1 10863.9 10169.2 10341.7 10644.9 10781.0 10963.6 5314.4 9758.3 10680.6 10732.2 10944.6 6622.6 7013.4 7301.1 7718.0 7910.4 9331.6 10167.7 10244.9 10454.9 10514.5 02:38:20 INFO - PROCESS | 12802 | 02:38:20 INFO - PROCESS | 12802 | [#3] mootools.html Cycles:180 Average:5157.74 Median:4932.02 stddev:3003.32 (60.9%) stddev-sans-first:2998.26 02:38:20 INFO - PROCESS | 12802 | Values: 1370.6 1411.3 1465.6 1628.4 1651.3 6776.3 7476.1 7583.2 8076.3 8079.2 7908.6 7992.0 8030.6 8040.8 8044.8 2170.7 2208.5 2219.3 2223.9 2229.3 2190.6 2206.4 2231.1 2253.0 2254.1 2212.6 2215.4 2215.5 2219.9 2228.8 2155.3 2167.6 2174.7 2176.1 2176.6 2182.7 2183.7 2186.5 2189.0 2203.9 8008.9 8125.3 8147.2 8163.2 8171.5 4283.8 4336.8 4343.6 4355.8 4381.3 2747.5 2897.9 2954.6 2954.9 2970.2 895.8 898.6 926.2 928.5 932.4 10851.5 10939.7 10958.4 11052.3 11067.8 4003.6 4081.2 4140.9 4155.1 4161.6 9225.7 9261.4 9353.5 9380.7 9405.4 4359.7 4365.9 4372.5 4384.6 4389.3 3539.8 3874.0 3923.4 3999.7 4077.9 3606.2 3640.3 3724.9 3756.5 3816.7 1174.0 1183.0 1186.9 1187.8 1195.8 691.8 783.2 795.2 802.5 803.1 4942.7 4966.8 5163.1 5194.2 5203.2 376.5 377.0 378.1 378.6 860.2 3160.0 3181.3 3223.7 3235.3 3270.8 9689.8 9893.1 9900.5 9943.9 10044.8 9746.2 9884.2 9908.7 9927.6 9928.5 7418.1 7484.5 7486.1 7518.2 7535.8 4921.4 4974.2 5046.2 5084.6 5092.5 9154.7 9207.9 9220.4 9223.0 9312.4 9162.6 9397.2 9448.9 9484.4 9514.7 5759.7 6123.4 6291.2 6316.8 6429.6 7749.4 7800.0 7829.2 7844.1 7861.7 6772.2 6967.3 7001.2 7065.4 7225.6 6804.2 6854.8 6882.4 6946.2 6980.9 6267.8 6281.8 6283.5 6385.6 6431.0 4400.1 4482.3 4505.8 4538.8 4560.3 4457.2 4470.9 4492.1 4554.1 4602.5 02:38:20 INFO - PROCESS | 12802 | 02:38:20 INFO - PROCESS | 12802 | [#4] prototype.html Cycles:180 Average:4437.47 Median:5124.45 stddev:1313.74 (25.6%) stddev-sans-first:1279.98 02:38:20 INFO - PROCESS | 12802 | Values: 288.4 293.7 298.2 302.1 304.8 5112.7 5131.7 5137.8 5138.2 5170.3 5044.6 5059.8 5084.6 5110.5 5117.2 3782.6 3874.6 3980.0 3982.0 3995.5 3928.6 3946.6 3969.5 3986.0 3999.5 3941.2 3961.9 3981.2 3998.1 4007.3 3694.5 3941.3 3959.7 3987.8 3997.3 3404.6 3419.8 3420.5 3430.1 3438.8 5012.5 5020.6 5022.7 5046.5 5052.8 4238.3 4460.8 4498.7 4510.0 4522.2 5345.6 5349.8 5374.7 5382.8 5392.4 3732.8 3745.7 3754.6 3761.6 3769.1 5318.2 5552.4 5629.2 5660.5 5685.3 3771.8 3776.8 3810.4 3811.4 3816.5 3857.0 3862.3 3863.9 3864.7 3865.1 4445.1 4485.6 4512.4 4528.6 4535.8 5221.9 5396.7 5415.9 5427.1 5468.5 1335.6 1340.8 1344.3 1344.6 1347.0 837.5 846.4 857.7 863.4 863.8 4644.0 4655.9 4674.3 4676.2 4682.8 5404.2 5499.9 5499.9 5500.8 5516.4 4527.0 4597.8 4614.5 4638.9 4654.2 2935.3 2936.9 2945.8 2952.7 2968.5 5141.5 5154.8 5156.8 5160.4 5160.8 5378.6 5591.2 5612.2 5718.5 5735.5 5232.3 5234.9 5266.3 5267.2 5269.6 5544.4 5551.4 5575.8 5598.6 5626.6 5184.5 5447.8 5450.8 5456.2 5472.6 5198.0 5231.5 5262.9 5265.2 5318.4 3850.3 3850.5 3852.0 3862.9 3879.1 5379.2 5556.8 5560.1 5598.2 5601.5 5326.7 5410.3 5417.7 5423.3 5448.3 5311.4 5362.0 5394.6 5403.1 5419.9 5226.9 5265.8 5266.5 5283.2 5287.5 5153.5 5272.4 5438.5 5444.2 5473.5 5320.5 5350.7 5352.8 5360.8 5365.3 02:38:20 INFO - PROCESS | 12802 | 02:38:20 INFO - PROCESS | 12802 | [#5] yui.html Cycles:180 Average:16219.17 Median:48683.38 stddev:21865.94 (44.9%) stddev-sans-first:21896.03 02:38:20 INFO - PROCESS | 12802 | Values: 650.7 667.4 674.7 683.6 735.1 12877.2 13655.2 13998.2 14058.1 14086.0 13447.9 13604.3 13623.8 14173.3 14784.3 792.5 798.5 799.0 800.6 801.2 629.6 773.5 787.2 795.4 795.9 815.0 821.9 822.1 823.7 824.4 811.9 814.3 814.9 815.0 819.8 596.1 597.6 597.8 597.8 598.2 13533.1 13657.5 13667.2 13744.5 13775.4 13008.7 13184.4 13267.2 13319.3 13376.5 10510.4 10541.7 10542.6 10567.4 10588.5 3285.5 3328.1 3341.2 3367.9 3380.9 52206.0 59826.7 60033.4 60238.0 60312.4 9732.1 9970.6 10086.2 10100.6 10155.1 18576.3 18632.0 18946.4 18951.8 18955.3 6674.9 6745.1 6805.1 6935.5 6975.6 3587.5 3752.8 3777.6 3800.9 3904.9 2943.3 3083.3 3084.4 3087.8 3092.6 506.6 515.6 516.0 529.8 531.6 366.6 453.5 458.4 468.1 476.8 7691.4 7808.0 7821.0 7829.9 8045.9 427.0 476.8 521.0 537.0 543.7 3562.3 3639.1 3677.7 3795.9 3842.9 61026.0 86454.0 86536.0 86776.6 87198.0 47516.0 47765.0 47943.0 48228.8 49138.0 74204.3 74736.6 75139.0 75606.0 77040.0 7197.7 7270.6 7502.6 7508.6 7576.1 42940.1 44456.6 44466.6 44645.3 46275.0 54610.7 64568.7 65538.7 65883.3 65930.3 9030.9 9151.4 9331.6 9351.7 9368.9 10473.0 10500.7 10651.9 10871.6 13170.1 12483.0 12710.8 12892.5 12969.9 13004.0 10509.7 10660.5 12386.0 12397.5 12703.7 12265.8 12292.4 12664.5 12818.6 12871.9 8369.7 9077.4 9283.5 9405.9 9621.6 9705.7 9859.3 9872.9 10179.9 10195.8 02:38:20 INFO - PROCESS | 12802 | -------- Summary: end -------- 02:38:20 INFO - PROCESS | 12802 | 02:38:21 INFO - TEST-INFO | 12802: exit 0 02:38:21 INFO - TEST-OK | dromaeo_css | took 1117779ms 02:38:21 INFO - TEST-START | kraken 02:38:21 INFO - operating with platform_type : linux_ 02:38:21 INFO - Initialising browser for kraken test... 02:38:21 INFO - TEST-INFO | started process 13040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSSvhyn/profile http://localhost:43975/getInfo.html) 02:38:26 INFO - PROCESS | 13040 | __metrics Screen width/height:1600/1200 02:38:26 INFO - PROCESS | 13040 | colorDepth:24 02:38:26 INFO - PROCESS | 13040 | Browser inner width/height: 1024/697 02:38:26 INFO - PROCESS | 13040 | __metrics 02:38:27 ERROR - PROCESS | 13040 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:38:28 INFO - TEST-INFO | 13040: exit 0 02:38:28 INFO - Browser initialized. 02:38:28 INFO - Running cycle 1/1 for kraken test... 02:38:28 INFO - TEST-INFO | started process 13157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSSvhyn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:38:40 INFO - PROCESS | 13157 | RSS: Main: 186331136 02:38:40 INFO - PROCESS | 13157 | 02:38:43 INFO - PROCESS | 13157 | Cycle 1(1): loaded http://localhost:43975/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43975/tests/kraken/driver.html?testName=audio-beat-detection) 02:38:44 INFO - PROCESS | 13157 | RSS: Main: 191209472 02:38:44 INFO - PROCESS | 13157 | 02:38:47 INFO - PROCESS | 13157 | Cycle 1(1): loaded http://localhost:43975/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43975/tests/kraken/driver.html?testName=audio-dft) 02:38:47 INFO - PROCESS | 13157 | RSS: Main: 191467520 02:38:47 INFO - PROCESS | 13157 | 02:38:50 INFO - PROCESS | 13157 | Cycle 1(1): loaded http://localhost:43975/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43975/tests/kraken/driver.html?testName=audio-fft) 02:38:51 INFO - PROCESS | 13157 | RSS: Main: 186916864 02:38:51 INFO - PROCESS | 13157 | 02:38:53 INFO - PROCESS | 13157 | Cycle 1(1): loaded http://localhost:43975/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43975/tests/kraken/driver.html?testName=audio-oscillator) 02:38:54 INFO - PROCESS | 13157 | RSS: Main: 187387904 02:38:54 INFO - PROCESS | 13157 | 02:38:56 INFO - PROCESS | 13157 | Cycle 1(1): loaded http://localhost:43975/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43975/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:38:57 INFO - PROCESS | 13157 | RSS: Main: 188043264 02:38:57 INFO - PROCESS | 13157 | 02:39:00 INFO - PROCESS | 13157 | Cycle 1(1): loaded http://localhost:43975/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43975/tests/kraken/driver.html?testName=imaging-darkroom) 02:39:00 INFO - PROCESS | 13157 | RSS: Main: 188338176 02:39:00 INFO - PROCESS | 13157 | 02:39:04 INFO - PROCESS | 13157 | Cycle 1(1): loaded http://localhost:43975/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43975/tests/kraken/driver.html?testName=imaging-desaturate) 02:39:05 INFO - PROCESS | 13157 | RSS: Main: 185131008 02:39:05 INFO - PROCESS | 13157 | 02:39:08 INFO - PROCESS | 13157 | Cycle 1(1): loaded http://localhost:43975/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43975/tests/kraken/driver.html?testName=json-parse-financial) 02:39:08 INFO - PROCESS | 13157 | RSS: Main: 186761216 02:39:08 INFO - PROCESS | 13157 | 02:39:10 INFO - PROCESS | 13157 | Cycle 1(1): loaded http://localhost:43975/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43975/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:39:11 INFO - PROCESS | 13157 | RSS: Main: 186900480 02:39:11 INFO - PROCESS | 13157 | 02:39:12 INFO - PROCESS | 13157 | Cycle 1(1): loaded http://localhost:43975/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43975/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:39:13 INFO - PROCESS | 13157 | RSS: Main: 187478016 02:39:13 INFO - PROCESS | 13157 | 02:39:15 INFO - PROCESS | 13157 | Cycle 1(1): loaded http://localhost:43975/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43975/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:39:16 INFO - PROCESS | 13157 | RSS: Main: 187850752 02:39:16 INFO - PROCESS | 13157 | 02:39:19 INFO - PROCESS | 13157 | Cycle 1(1): loaded http://localhost:43975/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:39:19 INFO - PROCESS | 13157 | RSS: Main: 187355136 02:39:19 INFO - PROCESS | 13157 | 02:39:22 INFO - PROCESS | 13157 | Cycle 1(1): loaded http://localhost:43975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:39:23 INFO - PROCESS | 13157 | RSS: Main: 187355136 02:39:23 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | Cycle 1(1): loaded http://localhost:43975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43975/tests/kraken/driver.html?testName=ai-astar) 02:39:25 INFO - PROCESS | 13157 | RSS: Main: 188928000 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | __start_tp_report 02:39:25 INFO - PROCESS | 13157 | _x_x_mozilla_page_load 02:39:25 INFO - PROCESS | 13157 | _x_x_mozilla_page_load_details 02:39:25 INFO - PROCESS | 13157 | |i|pagename|runs| 02:39:25 INFO - PROCESS | 13157 | |0;ai-astar;114;110;113;116;116;114;112;111;113;113 02:39:25 INFO - PROCESS | 13157 | |1;audio-beat-detection;158;136;154;182;134;163;163;137;181;134 02:39:25 INFO - PROCESS | 13157 | |2;audio-dft;164;165;170;169;161;161;162;166;161;163 02:39:25 INFO - PROCESS | 13157 | |3;audio-fft;78;78;75;164;79;80;77;75;163;77 02:39:25 INFO - PROCESS | 13157 | |4;audio-oscillator;87;87;139;86;88;87;139;86;86;145 02:39:25 INFO - PROCESS | 13157 | |5;imaging-gaussian-blur;118;117;117;119;117;119;119;117;122;119 02:39:25 INFO - PROCESS | 13157 | |6;imaging-darkroom;147;149;150;148;148;149;148;149;149;147 02:39:25 INFO - PROCESS | 13157 | |7;imaging-desaturate;95;95;95;95;96;96;96;95;96;96 02:39:25 INFO - PROCESS | 13157 | |8;json-parse-financial;63;64;66;66;63;68;67;65;64;64 02:39:25 INFO - PROCESS | 13157 | |9;json-stringify-tinderbox;65;65;65;65;65;65;66;65;69;65 02:39:25 INFO - PROCESS | 13157 | |10;stanford-crypto-aes;84;84;85;85;87;85;86;85;113;87 02:39:25 INFO - PROCESS | 13157 | |11;stanford-crypto-ccm;137;137;133;140;145;135;138;141;150;134 02:39:25 INFO - PROCESS | 13157 | |12;stanford-crypto-pbkdf2;172;180;173;177;178;169;170;169;172;170 02:39:25 INFO - PROCESS | 13157 | |13;stanford-crypto-sha256-iterative;67;67;73;69;68;68;68;67;71;70 02:39:25 INFO - PROCESS | 13157 | __end_tp_report 02:39:25 INFO - PROCESS | 13157 | __start_cc_report 02:39:25 INFO - PROCESS | 13157 | _x_x_mozilla_cycle_collect,1006 02:39:25 INFO - PROCESS | 13157 | __end_cc_report 02:39:25 INFO - PROCESS | 13157 | __startTimestamp1466069965574__endTimestamp 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | ------- Summary: start ------- 02:39:25 INFO - PROCESS | 13157 | Number of tests: 14 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:1.93 (1.7%) stddev-sans-first:2.03 02:39:25 INFO - PROCESS | 13157 | Values: 114.0 110.0 113.0 116.0 116.0 114.0 112.0 111.0 113.0 113.0 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | [#1] audio-beat-detection Cycles:10 Average:154.20 Median:160.50 stddev:18.57 (11.6%) stddev-sans-first:19.65 02:39:25 INFO - PROCESS | 13157 | Values: 158.0 136.0 154.0 182.0 134.0 163.0 163.0 137.0 181.0 134.0 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.50 stddev:3.29 (2.0%) stddev-sans-first:3.49 02:39:25 INFO - PROCESS | 13157 | Values: 164.0 165.0 170.0 169.0 161.0 161.0 162.0 166.0 161.0 163.0 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | [#3] audio-fft Cycles:10 Average:94.60 Median:77.50 stddev:36.35 (46.9%) stddev-sans-first:38.05 02:39:25 INFO - PROCESS | 13157 | Values: 78.0 78.0 75.0 164.0 79.0 80.0 77.0 75.0 163.0 77.0 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:86.50 stddev:26.28 (30.4%) stddev-sans-first:27.23 02:39:25 INFO - PROCESS | 13157 | Values: 87.0 87.0 139.0 86.0 88.0 87.0 139.0 86.0 86.0 145.0 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:119.00 stddev:1.58 (1.3%) stddev-sans-first:1.67 02:39:25 INFO - PROCESS | 13157 | Values: 118.0 117.0 117.0 119.0 117.0 119.0 119.0 117.0 122.0 119.0 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 02:39:25 INFO - PROCESS | 13157 | Values: 147.0 149.0 150.0 148.0 148.0 149.0 148.0 149.0 149.0 147.0 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:39:25 INFO - PROCESS | 13157 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.50 stddev:1.70 (2.6%) stddev-sans-first:1.64 02:39:25 INFO - PROCESS | 13157 | Values: 63.0 64.0 66.0 66.0 63.0 68.0 67.0 65.0 64.0 64.0 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:1.27 (2.0%) stddev-sans-first:1.33 02:39:25 INFO - PROCESS | 13157 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 66.0 65.0 69.0 65.0 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:85.00 stddev:8.81 (10.4%) stddev-sans-first:9.22 02:39:25 INFO - PROCESS | 13157 | Values: 84.0 84.0 85.0 85.0 87.0 85.0 86.0 85.0 113.0 87.0 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:139.00 stddev:5.25 (3.8%) stddev-sans-first:5.52 02:39:25 INFO - PROCESS | 13157 | Values: 137.0 137.0 133.0 140.0 145.0 135.0 138.0 141.0 150.0 134.0 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:172.50 stddev:3.97 (2.3%) stddev-sans-first:4.20 02:39:25 INFO - PROCESS | 13157 | Values: 172.0 180.0 173.0 177.0 178.0 169.0 170.0 169.0 172.0 170.0 02:39:25 INFO - PROCESS | 13157 | 02:39:25 INFO - PROCESS | 13157 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:1.99 (2.9%) stddev-sans-first:2.00 02:39:25 INFO - PROCESS | 13157 | Values: 67.0 67.0 73.0 69.0 68.0 68.0 68.0 67.0 71.0 70.0 02:39:25 INFO - PROCESS | 13157 | -------- Summary: end -------- 02:39:25 INFO - PROCESS | 13157 | 02:39:26 INFO - TEST-INFO | 13157: exit 0 02:39:26 INFO - TEST-OK | kraken | took 65144ms 02:39:26 INFO - SUITE-END | took 1182s 02:39:27 INFO - Completed test suite (00:19:43) 02:39:27 INFO - javascript benchmark 02:39:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6346.059584306196, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2653.694825095114, 2665.9333516662073, 2690.3408664877106, 2695.4609078184367, 2702.243371855881, 4769.356136921515, 4798.736069516175, 4819.59033482154, 4875.24433712775, 4939.28380384844, 4771.045790841837, 4856.660033797635, 4867.2942423348595, 4868.732219727923, 4900.289458028584, 4420.204363214628, 4455.042165934324, 4561.2245918193985, 4568.611668008223, 4589.0821835633005, 559.3348128824326, 4380.56194380561, 4444.755538445384, 4472.552744725518, 4539.863804085882, 4467.195904737162, 4469.7541635210055, 4501.684882058257, 4506.707064040859, 4533.591976722111, 4504.684672072924, 4535.319702044687, 4544.977275113603, 4560.087982403499, 4586.334981427708, 4379.4525684289465, 4383.517813040563, 4409.0, 4472.619827314682, 4543.591076803071, 4847.927281090787, 4864.148773964577, 4873.415190177201, 4886.315915771759, 4931.038447502739, 5192.1692529195525, 5237.188235823453, 5240.423553409122, 5241.895162096775, 5307.389650190239, 5237.921431178535, 5288.576913846883, 5296.973515132399, 5309.973450132763, 5342.305500284977, 4909.582685471739, 4926.482719314492, 4929.9014019720125, 4937.728424936591, 4952.603791696655, 5252.579793616578, 5291.708956007456, 5295.126304159848, 5342.2253773202665, 5346.304980352607, 5116.9744151279, 5131.102057139986, 5131.692098474104, 5139.177731563007, 5176.715280659525, 5204.4014938281825, 5221.582273418117, 5234.371875374979, 5234.607404444682, 5271.4728527147745, 5061.215511595708, 5163.483651634881, 5171.560417364491, 5180.067587834226, 5205.973970130125, 5147.639665223398, 5169.250458683545, 5177.741112944413, 5180.093483640348, 5212.765425555859, 4392.626626736699, 4393.582609652142, 4402.757848318373, 4413.3821265022925, 4446.844360447433, 3773.981130094387, 3793.1275806564645, 3826.559945606235, 3847.6921846252235, 3890.766554006712, 4498.280275156025, 4513.052259025641, 4521.050579378368, 4568.931466028012, 4642.489326174118, 5317.8404647860625, 5318.7074710891275, 5327.840164795062, 5331.973340133274, 5333.466653334635, 4431.047324825178, 4502.617277531381, 4503.054358584734, 4530.728156310632, 4542.341360502709, 4636.235021221461, 4637.211674015358, 4674.719516828933, 4682.806501024466, 4727.149113159596, 4818.0, 4903.26451032348, 4922.064807686528, 4931.693101328079, 4972.776225069881, 5189.974050129726, 5191.169412893919, 5208.557272631869, 5238.214267859851, 5242.0, 4905.975470122627, 4912.70523768575, 4916.287138364845, 4934.259861020875, 4951.603871690329, 5044.243363495505, 5093.974530127326, 5145.3568303962, 5155.484451554815, 5164.302819119521, 5181.611379146504, 5206.2450944612065, 5230.660007099526, 5241.109011468136, 5280.920786188287, 5046.621503387188, 5086.262491938722, 5089.26205700164, 5097.490250975021, 5124.333836601218, 5067.239914012927, 5115.74421278942, 5120.48795120485, 5142.357205349332, 5183.118869792069, 4988.0, 5035.219540971156, 5044.8991020178655, 5048.798048078036, 5098.337216161875, 5188.896222075462, 5197.506236907488, 5197.532222100029, 5203.063448579292, 5211.895762084813, 4944.7033178008, 5046.116929537389, 5070.771815268248, 5097.209932460474, 5102.1326374515675], "value": 4767.85505850888, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.3166217186317, 578.4504720515512, 578.7858492357827, 608.51622959747, 612.8069658057715, 35886.28227435453, 37393.065173370676, 40599.0, 40912.38631420531, 40973.79513102438, 40741.0, 41190.58809411905, 41427.17145657085, 41712.374314385306, 41841.58158418415, 7884.172161923001, 7932.127465978767, 7937.960310198441, 8038.115807261197, 8041.276285134337, 7929.850171725126, 7982.401319901001, 7982.880256796153, 7988.480748751313, 8025.277725004748, 8004.559749213791, 8023.197680231989, 8054.7180848670305, 8079.353651707849, 8083.0, 7970.08344040437, 7989.920100798976, 8010.07884093328, 8043.195680431969, 8045.95977020117, 7818.45270831042, 7922.445428819985, 7923.405744569181, 7975.960120199362, 7987.600619969036, 30322.84838575793, 38162.80918595417, 38272.617273827185, 38395.0, 38506.03734906622, 2758.4069425073703, 3107.207662046186, 3245.3996010738088, 3689.3728066228805, 3725.4225595032544, 27601.447971040467, 27704.722952770415, 28275.434491310058, 29357.85321073402, 29369.70630293691, 3362.7477939154414, 3405.404054290489, 3409.539712138854, 3430.1767575781882, 3588.1926566522584, 212962.0, 213902.0, 214801.99999999843, 215124.0, 215397.0, 31434.685653143177, 32355.838220808746, 32507.0, 32508.674913250565, 34436.65563344384, 33906.49140262898, 34318.0, 34416.0, 34434.139146521535, 34497.482537761956, 11868.109891758153, 11922.582709605296, 11928.821067683992, 11983.820242696367, 12011.699707507207, 10122.898771012344, 10144.695659130239, 10203.38779673222, 10224.897751022543, 10297.07326340633, 7878.369730421553, 7882.369410447151, 7984.121746607869, 8008.599570021475, 8009.679612815422, 3072.446959547303, 3153.195935036551, 3169.4611915974338, 3177.7616678749187, 3199.792013519114, 862.9007664118582, 904.2043002158059, 914.3142643017736, 950.9714708558754, 991.7966816802539, 28595.428091438054, 28636.0, 28727.281817954718, 29243.85378073096, 29362.706372935998, 934.6121359635811, 938.6714649872627, 948.5487204577008, 965.5558443116245, 968.4383057826444, 14339.354729037219, 14531.709365812836, 14707.41170353174, 14764.926175369055, 15159.621009474631, 420026.0, 420842.0, 421710.0, 422560.0, 422946.0, 49246.261306080436, 49949.50050499521, 49950.500494995315, 49955.25067123996, 50161.74919125381, 1146.3866831245243, 1175.2126075529416, 1181.911356648255, 1197.706561892342, 1197.868234494205, 25471.0, 26608.7339126614, 26769.464610708066, 27355.452890942466, 27364.179074627795, 42768.358474622284, 43021.0, 43294.350584741886, 43370.0, 43541.78229108961, 346325.0, 347935.0, 351447.0, 351900.0, 352524.0, 23408.83980662657, 23601.881990589936, 23615.52768944646, 23619.29142125739, 23630.81845907732, 41393.79303103465, 41417.0, 41735.58264417317, 42348.36477452902, 42454.36318455287, 34928.65071349355, 35335.46996794999, 35357.0, 35776.46335305025, 36609.0, 35312.0, 36013.81993090018, 36107.458388123676, 36136.63863361333, 36224.818875905454, 35186.47220291646, 35231.647683523865, 35895.51829526664, 36574.0, 37401.0, 31748.523772143897, 33555.1891270676, 33585.32829343448, 33698.49452258169, 33939.0, 25625.487490250463, 25716.614250786628, 26047.0, 26111.08611198599, 26221.73778262193], "value": 16258.975288212847, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.90120667419797, 370.22437992405906, 372.5752641988134, 379.78162556530003, 386.8123959879458, 15832.208389580519, 16331.346746130155, 17462.738058929095, 17487.125643717827, 17501.82498175018, 16104.355825766985, 16536.42122525712, 17435.82564174358, 17439.21523531441, 17486.0, 4963.553280204781, 5196.532312091911, 5198.92201616976, 5272.973635131838, 5279.891222843207, 5130.9743451282875, 5147.948520514803, 5185.896282074356, 5248.475152484759, 5248.790048398078, 5017.297578339036, 5161.045206636765, 5180.922286165711, 5188.974055129719, 5191.896162076756, 5036.294918711384, 5149.742512874342, 5155.484451554852, 5168.767405466744, 5174.456682048369, 4584.770761461914, 4598.724076555417, 4612.100640375128, 4634.930476042862, 4639.164950308943, 20010.89994550018, 20092.69860952087, 20579.691304630443, 20867.0, 20987.685184722242, 1917.8273955343946, 1979.89110598917, 2016.3446879764135, 2080.781517940625, 2360.221127028077, 13424.395902184327, 13884.722305553933, 13911.79132313016, 14028.92985535076, 14083.929580352033, 1747.9038652874087, 1806.2865168258595, 1806.825563383798, 1869.8126689552096, 1905.9809401905943, 66849.3315066848, 67564.32435675678, 68142.0, 68168.6591567039, 69553.30446695519, 9486.857697134548, 9777.071178238057, 9965.750856228653, 9990.14195583602, 10019.348742331871, 13599.456021759019, 13669.726605467835, 13694.315284235749, 13701.657458563417, 13722.65693357674, 6857.485688573377, 6872.900335946325, 6955.200151982485, 7107.431405487549, 7133.678984445713, 6304.810855674337, 6452.645104519296, 6494.805155845333, 6815.0, 6851.520393572402, 6179.907301390483, 6273.341299163522, 6315.778947736899, 6351.428371446592, 6380.585261957958, 1764.2590112152927, 1804.8465880400313, 1808.0, 1827.6070644811164, 1876.4464482977555, 835.3818174550788, 863.6113748813059, 909.5134103254727, 912.6577533424966, 944.5182956692137, 15595.922020389826, 17040.914795425942, 17408.21663025167, 17656.470305890845, 17977.280908763503, 866.9089745576624, 867.0505796153202, 871.4509858788922, 892.9100570909321, 916.619602864817, 9982.600695972225, 10154.695359139238, 10263.486825658836, 10317.587296508205, 10341.793164136676, 379265.0, 382757.0, 384917.0, 387246.0, 388052.0, 38021.23957520889, 46266.30600540995, 52781.0, 64082.35917640857, 66895.0, 883.885094937654, 892.1168043636883, 916.4592890194684, 919.7424721078108, 923.1875949164827, 16432.83567164313, 16508.75236871472, 16607.169641518118, 16625.833741662427, 16792.916035419745, 23699.40751481227, 25950.74049259559, 34459.4831077529, 34761.0, 36033.099172520895, 42016.159676805684, 43154.56845431506, 46164.53835461737, 47938.760306198245, 48584.514154858, 7470.252974702486, 7839.9216007839195, 7867.685292588461, 7941.364690824605, 8037.959810200911, 8484.745457636282, 11024.50389732448, 11735.530578776754, 11936.28382297065, 12135.817962730744, 10409.219308551737, 10424.426656533964, 10657.25399222078, 10716.089132423831, 10863.945680271549, 10169.237307201842, 10341.689749307532, 10644.89355106439, 10781.02970732638, 10963.56145754161, 5314.362276526842, 9758.316917815968, 10680.626178084041, 10732.195085368472, 10944.616938407118, 6622.569532980341, 7013.438924885895, 7301.123865136217, 7717.961410192913, 7910.446268761131, 9331.626734930527, 10167.694969150938, 10244.924282950184, 10454.947725261325, 10514.526846291783], "value": 8193.073276057336, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.5888233529943, 1411.322565168719, 1465.5749832548554, 1628.4463282483953, 1651.2569343795287, 6776.322367763221, 7476.140243871956, 7583.203763604824, 8076.313513351365, 8079.151689072643, 7908.565028923421, 7991.9600401997905, 8030.558319292437, 8040.758777236678, 8044.8391032179325, 2170.7395112586473, 2208.4810069633622, 2219.3341997400794, 2223.9110435582556, 2229.308914236584, 2190.6494960806276, 2206.415299945516, 2231.0518029837335, 2253.042456955787, 2254.120892851789, 2212.623853944833, 2215.368619943308, 2215.523662412581, 2219.9001044952934, 2228.821694264463, 2155.299527653519, 2167.6098302305577, 2174.6629272462715, 2176.0751680535786, 2176.5973294940486, 2182.74898386686, 2183.727034120735, 2186.529896072336, 2189.0, 2203.8567493112896, 8008.879866802003, 8125.3499720022255, 8147.226013528705, 8163.224493673091, 8171.468854524437, 4283.828646854122, 4336.8265269389185, 4343.630791382736, 4355.825766969318, 4381.25518661825, 2747.4917140329103, 2897.913062608125, 2954.630671166104, 2954.9409011819857, 2970.1683528612025, 895.8432274352027, 898.5507246376811, 926.1754343942423, 928.475411392561, 932.3613324872484, 10851.457427128691, 10939.671809845639, 10958.397288149148, 11052.336859788438, 11067.778644427146, 4003.5996400360314, 4081.163361510883, 4140.91718165641, 4155.065110350147, 4161.56303588125, 9225.677101301557, 9261.44431334122, 9353.532323383804, 9380.67167649129, 9405.43567385959, 4359.716618419856, 4365.890852728708, 4372.497162826252, 4384.561543845653, 4389.3415987601475, 3539.752217344761, 3873.9806300968316, 3923.3722604383734, 3999.6600288975765, 4077.918441631151, 3606.206634540397, 3640.2719456108885, 3724.925501490009, 3756.511653485084, 3816.713746469026, 1173.9962332206012, 1182.9704257393635, 1186.9169158159018, 1187.7980743273665, 1195.8325834383193, 691.8132104331802, 783.1581050370875, 795.1849354411659, 802.5385403393072, 803.1165717710471, 4942.678725882806, 4966.826161084345, 5163.14808056674, 5194.246834209019, 5203.16749320107, 376.472937886955, 376.99623003769614, 378.1208689796235, 378.5684319875289, 860.157046094818, 3159.952600710991, 3181.316017056344, 3223.693749093832, 3235.2558911450496, 3270.8201048942537, 9689.806203876024, 9893.060159284856, 9900.504974751233, 9943.850842237227, 10044.849327260097, 9746.171575416169, 9884.159846412991, 9908.65319713821, 9927.602895884083, 9928.453935033642, 7418.146913105062, 7484.476086673881, 7486.101667799899, 7518.210587888302, 7535.8116047099265, 4921.360223170965, 4974.154393752999, 5046.1926091825135, 5084.6440749147205, 5092.541671249605, 9154.679586214717, 9207.907920920705, 9220.354575179674, 9223.0, 9312.44125352481, 9162.633494660138, 9397.201237894855, 9448.905510944802, 9484.383515071499, 9514.666986655433, 5759.71201439918, 6123.357047510125, 6291.213598300213, 6316.842078948063, 6429.6142231466265, 7749.380049595906, 7800.024996875391, 7829.217078292125, 7844.09792873804, 7861.685532578633, 6772.221194562689, 6967.268436814062, 7001.229864714979, 7065.399441047569, 7225.63871806397, 6804.21751498584, 6854.828629284308, 6882.414994725505, 6946.16646002483, 6980.895286570807, 6267.843303917439, 6281.842953926189, 6283.5287353449585, 6385.648789316447, 6431.0, 4400.097979914046, 4482.305242687388, 4505.797239124182, 4538.819906824316, 4560.315952607003, 4457.219986502284, 4470.910581788281, 4492.101579684011, 4554.111948170075, 4602.516735742699], "value": 4060.2890392642666, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.3900550336039, 293.7415074734234, 298.18297863853036, 302.0907069720142, 304.8490996956508, 5112.693238405698, 5131.743412829363, 5137.7944882204665, 5138.152204886194, 5170.302009228753, 5044.596432285409, 5059.7976080956805, 5084.57631863078, 5110.488951104897, 5117.1556693145585, 3782.621737826216, 3874.6319099685484, 3979.9602003980026, 3982.044309365746, 3995.4805875236325, 3928.6071392860626, 3946.559505780384, 3969.4641223434755, 3986.0, 3999.480067591224, 3941.2314598653275, 3961.900952476197, 3981.2435637228978, 3998.1403998140395, 4007.318755811519, 3694.5012423323046, 3941.3102707026155, 3959.703022273341, 3987.80060996949, 3997.3204555225534, 3404.608470025954, 3419.81191034493, 3420.452727563603, 3430.125318043908, 3438.82805859706, 5012.548870601627, 5020.573251273646, 5022.698638081727, 5046.486054183731, 5052.8231511897275, 4238.321868501025, 4460.754658493782, 4498.730076195406, 4510.0, 4522.2086134926585, 5345.625806193568, 5349.769553002831, 5374.7043912584795, 5382.757775900094, 5392.352917649907, 3732.794696291703, 3745.7190710696805, 3754.554496518833, 3761.6426439488205, 3769.1142581493327, 5318.234518050592, 5552.3892371839065, 5629.155626655994, 5660.547156227533, 5685.346185188673, 3771.8114094295174, 3776.8300426480873, 3810.40938654509, 3811.371123764548, 3816.503854498953, 3856.9614303857165, 3862.304785138702, 3863.9227215455535, 3864.71014673895, 3865.130345672201, 4445.133199026223, 4485.596296333346, 4512.368268442421, 4528.592426681615, 4535.841245556389, 5221.869453263623, 5396.703181324986, 5415.85686949484, 5427.1316589345515, 5468.48049435303, 1335.5709390951783, 1340.8189894364332, 1344.3412727763325, 1344.6436694276024, 1346.9528566500126, 837.535167981776, 846.4413487098485, 857.7341024282492, 863.3869952333913, 863.8229163021565, 4643.976780116078, 4655.906881862344, 4674.345591617176, 4676.205045142334, 4682.765861706901, 5404.189371594292, 5499.917501237484, 5499.945000550023, 5500.834974950758, 5516.448355164532, 4527.0, 4597.839075632337, 4614.538546145426, 4638.909856183795, 4654.208784506642, 2935.2661834541364, 2936.9294647273623, 2945.7937944344117, 2952.675205727411, 2968.495355789521, 5141.460146684619, 5154.768035438415, 5156.819511317086, 5160.354955630546, 5160.7935682573025, 5378.569714422837, 5591.217229587861, 5612.186232996192, 5718.542516598745, 5735.541156707453, 5232.293640358503, 5234.947650523446, 5266.262723218752, 5267.157254839208, 5269.631125821233, 5544.362398324244, 5551.362348107399, 5575.776968921197, 5598.580106491948, 5626.634268772516, 5184.481551844936, 5447.836564902901, 5450.800823818753, 5456.236126942152, 5472.644278121909, 5197.974010129925, 5231.529162375405, 5262.868428289324, 5265.183896496049, 5318.4149743527405, 3850.3261929162845, 3850.4801851749653, 3852.0, 3862.9034274142246, 3879.1465877506903, 5379.1662292344745, 5556.777728890799, 5560.138178582326, 5598.21624972496, 5601.495865372136, 5326.6537675050995, 5410.323709536308, 5417.702026388586, 5423.322084739408, 5448.264484294569, 5311.41574426805, 5361.954418888279, 5394.595405344537, 5403.13549832025, 5419.891602167856, 5226.9215961761365, 5265.815696450606, 5266.526012658725, 5283.207518872046, 5287.471252874836, 5153.453963810916, 5272.393674727456, 5438.510534051796, 5444.237806707143, 5473.534749546333, 5320.52115309624, 5350.705711185922, 5352.785888564569, 5360.839174824761, 5365.3293338332705], "value": 4010.440143019654, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.7299470719648, 667.4126768443768, 674.6660403100466, 683.5591043776764, 735.0848193998471, 12877.162984406006, 13655.248961307136, 13998.230097344654, 14058.086224395407, 14086.013979021447, 13447.924166066716, 13604.31978401081, 13623.795643065361, 14173.29133543324, 14784.334704938277, 792.4769652029662, 798.4690181029608, 799.0092285565886, 800.5516910530092, 801.2068052627915, 629.5530173576766, 773.4933618479877, 787.2167193642334, 795.4272923495074, 795.892554505143, 815.0301141641457, 821.8931538899934, 822.1244374740882, 823.6622984576325, 824.3734761581181, 811.8944537210125, 814.2997022560593, 814.9307308878723, 814.9551774652392, 819.7991492084448, 596.0641792385956, 597.6264834478451, 597.7877853362037, 597.8146774499919, 598.2014011294926, 13533.120347177402, 13657.521986730517, 13667.248301343423, 13744.450221991108, 13775.448982040707, 13008.739825203538, 13184.406701698446, 13267.212593417104, 13319.26744029078, 13376.531821386303, 10510.421926794023, 10541.683749487527, 10542.578296868116, 10567.365958042543, 10588.523516441779, 3285.5235990781443, 3328.051505320972, 3341.2482191506715, 3367.898963031113, 3380.8647654093807, 52206.0, 59826.70086649583, 60033.39966600366, 60238.0, 60312.39687603068, 9732.07545283211, 9970.551325190383, 10086.193104551618, 10100.595976160872, 10155.136813370798, 18576.349827755963, 18632.0, 18946.43160705181, 18951.810481895005, 18955.336563220222, 6674.933250667431, 6745.089412929192, 6805.149356330458, 6935.479839012094, 6975.581465112008, 3587.515685382492, 3752.774833509998, 3777.58446570877, 3800.8669696560487, 3904.941425878614, 2943.3230357018006, 3083.2908431060982, 3084.4139613473367, 3087.81473111614, 3092.6134233220846, 506.6124414822664, 515.6210185513645, 516.0272885610651, 529.8172130614931, 531.6305167908266, 366.60956081772827, 453.49208886047836, 458.37660781337354, 468.10358164115337, 476.7949781593879, 7691.384689224848, 7808.0, 7821.0, 7829.882551761728, 8045.919540804634, 426.95090064642966, 476.77114984807486, 521.0, 537.0, 543.6873797566415, 3562.287542491512, 3639.1266096136737, 3677.669009789132, 3795.867144649924, 3842.9231415371537, 61026.0, 86454.0, 86536.0, 86776.56611716902, 87198.0, 47516.0, 47765.0, 47943.0, 48228.758856205495, 49138.0, 74204.25795742082, 74736.62631686915, 75139.0, 75606.0, 77040.0, 7197.748078817426, 7270.563766174047, 7502.624868756649, 7508.58702771331, 7576.052993375828, 42940.14119717525, 44456.555434446534, 44466.55533444624, 44645.33032004457, 46275.0, 54610.726946365015, 64568.677156613914, 65538.67230663817, 65883.34116658772, 65930.34069659242, 9030.909690903007, 9151.383586595644, 9331.626734930527, 9351.672691455766, 9368.906310937076, 10473.0, 10500.739911210703, 10651.893481065401, 10871.565137394417, 13170.143940643828, 12483.02589975104, 12710.77561426728, 12892.548760793326, 12969.870301296865, 13004.0, 10509.684709458728, 10660.466976650981, 12386.0, 12397.504099835905, 12703.745925081263, 12265.816012759995, 12292.38538073075, 12664.493420263087, 12818.55135070268, 12871.871281287442, 8369.66521339164, 9077.364584479286, 9283.535823208947, 9405.905940940504, 9621.56702948383, 9705.708828735149, 9859.30984831055, 9872.901270987486, 10179.898201018192, 10195.796084078129], "value": 6314.93118258081, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 113.0, 116.0, 116.0, 114.0, 112.0, 111.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 136.0, 154.0, 182.0, 134.0, 163.0, 163.0, 137.0, 181.0, 134.0], "value": 154.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 170.0, 169.0, 161.0, 161.0, 162.0, 166.0, 161.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 75.0, 164.0, 79.0, 80.0, 77.0, 75.0, 163.0, 77.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 139.0, 86.0, 88.0, 87.0, 139.0, 86.0, 86.0, 145.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 119.0, 117.0, 119.0, 119.0, 117.0, 122.0, 119.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 150.0, 148.0, 148.0, 149.0, 148.0, 149.0, 149.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 66.0, 63.0, 68.0, 67.0, 65.0, 64.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 69.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 85.0, 87.0, 85.0, 86.0, 85.0, 113.0, 87.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 133.0, 140.0, 145.0, 135.0, 138.0, 141.0, 150.0, 134.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 180.0, 173.0, 177.0, 178.0, 169.0, 170.0, 169.0, 172.0, 170.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 73.0, 69.0, 68.0, 68.0, 68.0, 67.0, 71.0, 70.0], "value": 68.8, "unit": "score"}]}]} 02:39:27 INFO - Return code: 0 02:39:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:39:27 ERROR - # TBPL SUCCESS # 02:39:27 INFO - Running post-action listener: _resource_record_post_action 02:39:27 INFO - ##### 02:39:27 INFO - ##### Finished run-tests step (success) 02:39:27 INFO - ##### 02:39:27 INFO - Running post-run listener: _resource_record_post_run 02:39:27 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 408485888; Read time: 56; Write time: 343320 02:39:27 INFO - TinderboxPrint: CPU usage
13.4% 02:39:27 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 56 02:39:27 INFO - TinderboxPrint: I/O write bytes / time
408,485,888 / 343,320 02:39:27 INFO - TinderboxPrint: CPU idle
8,287.7 (86.6%) 02:39:27 INFO - TinderboxPrint: CPU user
1,229.9 (12.8%) 02:39:27 INFO - TinderboxPrint: Swap in / out
0 / 0 02:39:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106758144; Read time: 0; Write time: 134976 02:39:27 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290992128; Read time: 56; Write time: 206228 02:39:28 INFO - Running post-run listener: _upload_blobber_files 02:39:28 INFO - Blob upload gear active. 02:39:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:39:28 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:39:28 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:39:28 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:39:28 INFO - (blobuploader) - INFO - Open directory for files ... 02:39:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:39:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:39:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:32 INFO - (blobuploader) - INFO - Done attempting. 02:39:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:39:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:39:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:33 INFO - (blobuploader) - INFO - Done attempting. 02:39:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:39:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:39:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:34 INFO - (blobuploader) - INFO - Done attempting. 02:39:34 INFO - (blobuploader) - INFO - Iteration through files over. 02:39:34 INFO - Return code: 0 02:39:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:39:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:39:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8f51127ae85b5768a865c2952933c0609edae0ff9b675aa4815cfceb87d2b73515e038b105677fb5f6ddb87bcd98251499b7da9ca026a37b55bda10aa79ca13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b7f9d540b17b40db6869b7b8970f43b4babb5cafa5a448919866989698efd710a6af77c25d7cece13c0c84501b9ebf294716490bae173e99cb49a80841c4cd57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c367556fea31e26fb08b725f1c55fd67bcd610e8e5fdb708a2e3fc2eed1047a4cc5317af47c5b9dacd60afb1f7c0983208a7d2494bf87f725285e9f1b43a254"} 02:39:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:39:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:39:34 INFO - Contents: 02:39:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8f51127ae85b5768a865c2952933c0609edae0ff9b675aa4815cfceb87d2b73515e038b105677fb5f6ddb87bcd98251499b7da9ca026a37b55bda10aa79ca13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b7f9d540b17b40db6869b7b8970f43b4babb5cafa5a448919866989698efd710a6af77c25d7cece13c0c84501b9ebf294716490bae173e99cb49a80841c4cd57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c367556fea31e26fb08b725f1c55fd67bcd610e8e5fdb708a2e3fc2eed1047a4cc5317af47c5b9dacd60afb1f7c0983208a7d2494bf87f725285e9f1b43a254"} 02:39:34 INFO - Running post-run listener: copy_logs_to_upload_dir 02:39:34 INFO - Copying logs to upload dir... 02:39:34 INFO - mkdir: /builds/slave/test/build/upload/logs 02:39:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.403196 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-16 02:39:34.102191) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 02:39:34.105943) ========= 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=eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414 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-Non-PGO/sha512/e8f51127ae85b5768a865c2952933c0609edae0ff9b675aa4815cfceb87d2b73515e038b105677fb5f6ddb87bcd98251499b7da9ca026a37b55bda10aa79ca13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b7f9d540b17b40db6869b7b8970f43b4babb5cafa5a448919866989698efd710a6af77c25d7cece13c0c84501b9ebf294716490bae173e99cb49a80841c4cd57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c367556fea31e26fb08b725f1c55fd67bcd610e8e5fdb708a2e3fc2eed1047a4cc5317af47c5b9dacd60afb1f7c0983208a7d2494bf87f725285e9f1b43a254"} build_url:https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011386 build_url: 'https://queue.taskcluster.net/v1/task/WtGUE50SSDOwr5Dfi9GHPQ/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-Non-PGO/sha512/e8f51127ae85b5768a865c2952933c0609edae0ff9b675aa4815cfceb87d2b73515e038b105677fb5f6ddb87bcd98251499b7da9ca026a37b55bda10aa79ca13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b7f9d540b17b40db6869b7b8970f43b4babb5cafa5a448919866989698efd710a6af77c25d7cece13c0c84501b9ebf294716490bae173e99cb49a80841c4cd57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c367556fea31e26fb08b725f1c55fd67bcd610e8e5fdb708a2e3fc2eed1047a4cc5317af47c5b9dacd60afb1f7c0983208a7d2494bf87f725285e9f1b43a254"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 02:39:34.131257) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:39:34.131599) ========= 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=eca2ab57546de7b41f256b19000001ef-1466067837.417443-2115477414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:39:34.215838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 02:39:34.216189) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 02:39:34.216522) ========= ========= Total master_lag: 0.17 =========