builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1466692513.41 results: success (0) buildid: 20160623061527 builduid: e3c26f3b32d64c27b2893dcb1ae7ed73 revision: 3c54e4e048dcd7b1a7a54a8fbc4a68962a8fdce4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 07:35:13.413685) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 07:35:13.414142) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 07:35:13.414426) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 07:35:13.428830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:35:13.429124) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 07:35:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-23 07:35:13 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100438 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:35:13.543119) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:35:13.543435) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018693 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:35:13.592674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 07:35:13.593005) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3c54e4e048dcd7b1a7a54a8fbc4a68962a8fdce4 --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 3c54e4e048dcd7b1a7a54a8fbc4a68962a8fdce4 --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=97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 07:35:13,809 truncating revision to first 12 chars 2016-06-23 07:35:13,809 Setting DEBUG logging. 2016-06-23 07:35:13,809 attempt 1/10 2016-06-23 07:35:13,809 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3c54e4e048dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 07:35:14,798 unpacking tar archive at: fx-team-3c54e4e048dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.312963 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 07:35:14.920459) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 07:35:14.920840) ========= script_repo_revision: 3c54e4e048dcd7b1a7a54a8fbc4a68962a8fdce4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 07:35:14.921260) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 07:35:14.921585) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 07:35:14.931852) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-23 07:35:14.932180) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:35:15 INFO - MultiFileLogger online at 20160623 07:35:15 in /builds/slave/test 07:35:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 07:35:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:35:15 INFO - {'append_to_log': False, 07:35:15 INFO - 'base_work_dir': '/builds/slave/test', 07:35:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:35:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:35:15 INFO - 'branch': 'Fx-Team-Non-PGO', 07:35:15 INFO - 'buildbot_json_path': 'buildprops.json', 07:35:15 INFO - 'config_files': ('talos/linux_config.py',), 07:35:15 INFO - 'default_actions': ('clobber', 07:35:15 INFO - 'read-buildbot-config', 07:35:15 INFO - 'download-and-extract', 07:35:15 INFO - 'populate-webroot', 07:35:15 INFO - 'create-virtualenv', 07:35:15 INFO - 'install', 07:35:15 INFO - 'run-tests'), 07:35:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:35:15 INFO - 'download_minidump_stackwalk': True, 07:35:15 INFO - 'download_symbols': 'ondemand', 07:35:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:35:15 INFO - 'tooltool.py': '/tools/tooltool.py', 07:35:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:35:15 INFO - '/tools/misc-python/virtualenv.py')}, 07:35:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:35:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:35:15 INFO - 'installer_path': 'installer.exe', 07:35:15 INFO - 'log_level': 'info', 07:35:15 INFO - 'log_name': 'talos', 07:35:15 INFO - 'log_to_console': True, 07:35:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:35:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:35:15 INFO - 'opt_config_files': (), 07:35:15 INFO - 'pip_index': False, 07:35:15 INFO - 'sps_profile': False, 07:35:15 INFO - 'sps_profile_interval': 0, 07:35:15 INFO - 'suite': 'dromaeojs', 07:35:15 INFO - 'system_bits': '32', 07:35:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:35:15 INFO - 'title': 'talos-linux64-ix-068', 07:35:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:35:15 INFO - 'use_talos_json': True, 07:35:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:35:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:35:15 INFO - 'work_dir': 'build'} 07:35:15 INFO - ##### 07:35:15 INFO - ##### Running clobber step. 07:35:15 INFO - ##### 07:35:15 INFO - Running pre-action listener: _resource_record_pre_action 07:35:15 INFO - Running main action method: clobber 07:35:15 INFO - rmtree: /builds/slave/test/build 07:35:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:35:15 INFO - Running post-action listener: _resource_record_post_action 07:35:15 INFO - ##### 07:35:15 INFO - ##### Finished clobber step (success) 07:35:15 INFO - ##### 07:35:15 INFO - ##### 07:35:15 INFO - ##### Running read-buildbot-config step. 07:35:15 INFO - ##### 07:35:15 INFO - Running pre-action listener: _resource_record_pre_action 07:35:15 INFO - Running main action method: read_buildbot_config 07:35:15 INFO - Using buildbot properties: 07:35:15 INFO - { 07:35:15 INFO - "project": "", 07:35:15 INFO - "product": "firefox", 07:35:15 INFO - "script_repo_revision": "production", 07:35:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:35:15 INFO - "repository": "", 07:35:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:35:15 INFO - "buildid": "20160623061527", 07:35:15 INFO - "pgo_build": "False", 07:35:15 INFO - "basedir": "/builds/slave/test", 07:35:15 INFO - "buildnumber": 3109, 07:35:15 INFO - "slavename": "talos-linux64-ix-068", 07:35:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:35:15 INFO - "platform": "ubuntu64_hw", 07:35:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:35:15 INFO - "branch": "fx-team", 07:35:15 INFO - "repo_path": "integration/fx-team", 07:35:15 INFO - "revision": "3c54e4e048dcd7b1a7a54a8fbc4a68962a8fdce4", 07:35:15 INFO - "stage_platform": "linux64", 07:35:15 INFO - "builduid": "e3c26f3b32d64c27b2893dcb1ae7ed73", 07:35:15 INFO - "slavebuilddir": "test" 07:35:15 INFO - } 07:35:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:35:15 INFO - Running post-action listener: _resource_record_post_action 07:35:15 INFO - ##### 07:35:15 INFO - ##### Finished read-buildbot-config step (success) 07:35:15 INFO - ##### 07:35:15 INFO - ##### 07:35:15 INFO - ##### Running download-and-extract step. 07:35:15 INFO - ##### 07:35:15 INFO - Running pre-action listener: _resource_record_pre_action 07:35:15 INFO - Running main action method: download_and_extract 07:35:15 INFO - mkdir: /builds/slave/test/build/tests 07:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:15 INFO - https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:35:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:35:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:35:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/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 07:35:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/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 07:35:16 INFO - Downloaded 1361 bytes. 07:35:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:35:16 INFO - Using the following test package requirements: 07:35:16 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:35:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:35:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:35:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:16 INFO - u'jsshell-linux-x86_64.zip'], 07:35:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:35:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:35:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:35:16 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:35:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:35:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:35:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:16 INFO - https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:35:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:35:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:35:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/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 07:35:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/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 07:35:17 INFO - Downloaded 22709646 bytes. 07:35:17 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'] 07:35:17 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 07:35:18 INFO - Return code: 0 07:35:18 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 07:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:18 INFO - https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:35:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:35:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:35:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/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 07:35:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/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 07:35:19 INFO - Downloaded 22709646 bytes. 07:35:19 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'] 07:35:19 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 07:35:21 INFO - Return code: 0 07:35:21 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')]} 07:35:21 INFO - https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:35:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:35:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:35:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/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 07:35:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/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 07:35:22 INFO - Downloaded 14405384 bytes. 07:35:22 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'] 07:35:22 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 07:35:22 INFO - Return code: 0 07:35: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')]} 07:35:22 INFO - https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:35:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:35:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:35:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/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 07:35:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/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 07:35:23 INFO - Downloaded 56253978 bytes. 07:35:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:35:23 INFO - mkdir: /builds/slave/test/properties 07:35:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:35:23 INFO - Writing to file /builds/slave/test/properties/build_url 07:35:23 INFO - Contents: 07:35:23 INFO - build_url:https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:35:24 INFO - Running post-action listener: _resource_record_post_action 07:35:24 INFO - Running post-action listener: set_extra_try_arguments 07:35:24 INFO - ##### 07:35:24 INFO - ##### Finished download-and-extract step (success) 07:35:24 INFO - ##### 07:35:24 INFO - ##### 07:35:24 INFO - ##### Running populate-webroot step. 07:35:24 INFO - ##### 07:35:24 INFO - Running pre-action listener: _resource_record_pre_action 07:35:24 INFO - Running main action method: populate_webroot 07:35:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:35:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:35:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:35:24 INFO - '--tppagecycles', 07:35:24 INFO - '7'], 07:35:24 INFO - 'tests': ['tsvgm']}}, 07:35:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:35:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:35:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:35:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:35:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:35:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:35:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:24 INFO - 'talos_options': ['--disable-e10s'], 07:35:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:24 INFO - 'talos_options': ['--disable-e10s'], 07:35:24 INFO - 'tests': ['damp', 'tps']}, 07:35:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:24 INFO - 'tests': ['damp', 'tps']}, 07:35:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:35:24 INFO - 'tests': ['dromaeo_dom']}, 07:35:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:35:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:35:24 INFO - 'tests': ['basic_compositor_video']}, 07:35:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:35:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:35:24 INFO - 'tests': ['a11yr', 07:35:24 INFO - 'ts_paint', 07:35:24 INFO - 'tpaint', 07:35:24 INFO - 'sessionrestore', 07:35:24 INFO - 'sessionrestore_no_auto_restore', 07:35:24 INFO - 'tabpaint']}, 07:35:24 INFO - 'other-e10s': {'tests': ['a11yr', 07:35:24 INFO - 'ts_paint', 07:35:24 INFO - 'tpaint', 07:35:24 INFO - 'sessionrestore', 07:35:24 INFO - 'sessionrestore_no_auto_restore', 07:35:24 INFO - 'tabpaint']}, 07:35:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:35:24 INFO - 'ts_paint', 07:35:24 INFO - 'tpaint', 07:35:24 INFO - 'sessionrestore', 07:35:24 INFO - 'sessionrestore_no_auto_restore', 07:35:24 INFO - 'tabpaint']}, 07:35:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:35:24 INFO - 'ts_paint', 07:35:24 INFO - 'tpaint', 07:35:24 INFO - 'sessionrestore', 07:35:24 INFO - 'sessionrestore_no_auto_restore', 07:35:24 INFO - 'tabpaint']}, 07:35:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:35:24 INFO - 'tests': ['a11yr', 07:35:24 INFO - 'ts_paint', 07:35:24 INFO - 'tpaint', 07:35:24 INFO - 'sessionrestore', 07:35:24 INFO - 'sessionrestore_no_auto_restore', 07:35:24 INFO - 'tabpaint']}, 07:35:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:35:24 INFO - 'tests': ['a11yr', 07:35:24 INFO - 'ts_paint', 07:35:24 INFO - 'tpaint', 07:35:24 INFO - 'sessionrestore', 07:35:24 INFO - 'sessionrestore_no_auto_restore', 07:35:24 INFO - 'tabpaint']}, 07:35:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:35:24 INFO - 'tests': ['tsvgx', 07:35:24 INFO - 'tsvgr_opacity', 07:35:24 INFO - 'tart', 07:35:24 INFO - 'tscrollx', 07:35:24 INFO - 'cart']}, 07:35:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:35:24 INFO - 'tsvgr_opacity', 07:35:24 INFO - 'tart', 07:35:24 INFO - 'tscrollx', 07:35:24 INFO - 'cart']}, 07:35:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:24 INFO - 'talos_options': ['--disable-e10s'], 07:35:24 INFO - 'tests': ['tp5o']}, 07:35:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:24 INFO - 'tests': ['tp5o']}, 07:35:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:24 INFO - 'talos_options': ['--disable-e10s', 07:35:24 INFO - '--xperf_path', 07:35:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:24 INFO - 'tests': ['tp5n']}, 07:35:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:24 INFO - 'talos_options': ['--xperf_path', 07:35:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:24 INFO - 'tests': ['tp5n']}}, 07:35:24 INFO - 'talos.zip': {'path': '', 07:35:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:35:24 INFO - Running post-action listener: _resource_record_post_action 07:35:24 INFO - ##### 07:35:24 INFO - ##### Finished populate-webroot step (success) 07:35:24 INFO - ##### 07:35:24 INFO - ##### 07:35:24 INFO - ##### Running create-virtualenv step. 07:35:24 INFO - ##### 07:35:24 INFO - Running pre-action listener: _resource_record_pre_action 07:35:24 INFO - Running main action method: create_virtualenv 07:35:24 INFO - Creating virtualenv /builds/slave/test/build/venv 07:35:24 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 07:35:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:35:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:35:24 INFO - Using real prefix '/usr' 07:35:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:35:25 INFO - Installing distribute.............................................................................................................................................................................................done. 07:35:27 INFO - Installing pip.................done. 07:35:27 INFO - Return code: 0 07:35:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:27 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 0x7fd0b26c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', '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 07:35:27 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 07:35:27 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 07:35:27 INFO - Using env: {'DISPLAY': ':0', 07:35:27 INFO - 'HOME': '/home/cltbld', 07:35:27 INFO - 'LANG': 'en_US.UTF-8', 07:35:27 INFO - 'LANGUAGE': 'en_US:en', 07:35:27 INFO - 'LOGNAME': 'cltbld', 07:35:27 INFO - 'MAIL': '/var/mail/cltbld', 07:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:27 INFO - 'MOZ_NO_REMOTE': '1', 07:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:27 INFO - 'NO_EM_RESTART': '1', 07:35:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:27 INFO - 'PWD': '/builds/slave/test', 07:35:27 INFO - 'SHELL': '/bin/bash', 07:35:27 INFO - 'SHLVL': '1', 07:35:27 INFO - 'TERM': 'linux', 07:35:27 INFO - 'TMOUT': '86400', 07:35:27 INFO - 'USER': 'cltbld', 07:35:27 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', 07:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:27 INFO - '_': '/tools/buildbot/bin/python'} 07:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:27 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 07:35:27 INFO - Cleaning up... 07:35:27 INFO - Return code: 0 07:35:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:27 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 0x7fd0b26c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', '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 07:35:27 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 07:35:27 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 07:35:27 INFO - Using env: {'DISPLAY': ':0', 07:35:27 INFO - 'HOME': '/home/cltbld', 07:35:27 INFO - 'LANG': 'en_US.UTF-8', 07:35:27 INFO - 'LANGUAGE': 'en_US:en', 07:35:27 INFO - 'LOGNAME': 'cltbld', 07:35:27 INFO - 'MAIL': '/var/mail/cltbld', 07:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:27 INFO - 'MOZ_NO_REMOTE': '1', 07:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:27 INFO - 'NO_EM_RESTART': '1', 07:35:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:27 INFO - 'PWD': '/builds/slave/test', 07:35:27 INFO - 'SHELL': '/bin/bash', 07:35:27 INFO - 'SHLVL': '1', 07:35:27 INFO - 'TERM': 'linux', 07:35:27 INFO - 'TMOUT': '86400', 07:35:27 INFO - 'USER': 'cltbld', 07:35:27 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', 07:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:27 INFO - '_': '/tools/buildbot/bin/python'} 07:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:27 INFO - Downloading/unpacking psutil>=3.1.1 07:35:27 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 07:35:27 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 07:35:27 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 07:35:27 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 07:35:27 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 07:35:27 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 07:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:35:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:29 INFO - Installing collected packages: psutil 07:35:29 INFO - Running setup.py install for psutil 07:35:29 INFO - building 'psutil._psutil_linux' extension 07:35:29 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 07:35:29 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 07:35:29 INFO - building 'psutil._psutil_posix' extension 07:35:29 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 07:35:30 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 07:35:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:30 INFO - Successfully installed psutil 07:35:30 INFO - Cleaning up... 07:35:30 INFO - Return code: 0 07:35:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:35:30 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')]} 07:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:30 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')]} 07:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:30 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 0x7fd0b26c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', '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 07:35:30 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 07:35:30 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 07:35:30 INFO - Using env: {'DISPLAY': ':0', 07:35:30 INFO - 'HOME': '/home/cltbld', 07:35:30 INFO - 'LANG': 'en_US.UTF-8', 07:35:30 INFO - 'LANGUAGE': 'en_US:en', 07:35:30 INFO - 'LOGNAME': 'cltbld', 07:35:30 INFO - 'MAIL': '/var/mail/cltbld', 07:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:30 INFO - 'MOZ_NO_REMOTE': '1', 07:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:30 INFO - 'NO_EM_RESTART': '1', 07:35:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:30 INFO - 'PWD': '/builds/slave/test', 07:35:30 INFO - 'SHELL': '/bin/bash', 07:35:30 INFO - 'SHLVL': '1', 07:35:30 INFO - 'TERM': 'linux', 07:35:30 INFO - 'TMOUT': '86400', 07:35:30 INFO - 'USER': 'cltbld', 07:35:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', 07:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:30 INFO - '_': '/tools/buildbot/bin/python'} 07:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:35:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:35:32 INFO - Installing collected packages: mozsystemmonitor 07:35:32 INFO - Running setup.py install for mozsystemmonitor 07:35:32 INFO - Successfully installed mozsystemmonitor 07:35:32 INFO - Cleaning up... 07:35:32 INFO - Return code: 0 07:35:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:35:32 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')]} 07:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:32 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')]} 07:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:32 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 0x7fd0b26c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', '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 07:35:32 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 07:35:32 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 07:35:32 INFO - Using env: {'DISPLAY': ':0', 07:35:32 INFO - 'HOME': '/home/cltbld', 07:35:32 INFO - 'LANG': 'en_US.UTF-8', 07:35:32 INFO - 'LANGUAGE': 'en_US:en', 07:35:32 INFO - 'LOGNAME': 'cltbld', 07:35:32 INFO - 'MAIL': '/var/mail/cltbld', 07:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:32 INFO - 'MOZ_NO_REMOTE': '1', 07:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:32 INFO - 'NO_EM_RESTART': '1', 07:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:32 INFO - 'PWD': '/builds/slave/test', 07:35:32 INFO - 'SHELL': '/bin/bash', 07:35:32 INFO - 'SHLVL': '1', 07:35:32 INFO - 'TERM': 'linux', 07:35:32 INFO - 'TMOUT': '86400', 07:35:32 INFO - 'USER': 'cltbld', 07:35:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', 07:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:32 INFO - '_': '/tools/buildbot/bin/python'} 07:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:32 INFO - Downloading/unpacking jsonschema==2.5.1 07:35:32 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 07:35:32 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 07:35:32 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 07:35:32 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 07:35:32 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 07:35:32 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 07:35:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:35:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:35:34 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 07:35:34 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 07:35:34 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 07:35:34 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 07:35:34 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 07:35:34 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 07:35:34 INFO - Downloading functools32-3.2.3-2.tar.gz 07:35:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:35:34 INFO - warning: no files found matching '*.txt' 07:35:34 INFO - no previously-included directories found matching 'build' 07:35:34 INFO - no previously-included directories found matching 'dist' 07:35:34 INFO - no previously-included directories found matching '.git*' 07:35:34 INFO - Installing collected packages: jsonschema, functools32 07:35:35 INFO - Running setup.py install for functools32 07:35:35 INFO - warning: no files found matching '*.txt' 07:35:35 INFO - no previously-included directories found matching 'build' 07:35:35 INFO - no previously-included directories found matching 'dist' 07:35:35 INFO - no previously-included directories found matching '.git*' 07:35:35 INFO - Successfully installed jsonschema functools32 07:35:35 INFO - Cleaning up... 07:35:35 INFO - Return code: 0 07:35:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:35 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 0x7fd0b26c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', '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 07:35:35 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 07:35:35 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 07:35:35 INFO - Using env: {'DISPLAY': ':0', 07:35:35 INFO - 'HOME': '/home/cltbld', 07:35:35 INFO - 'LANG': 'en_US.UTF-8', 07:35:35 INFO - 'LANGUAGE': 'en_US:en', 07:35:35 INFO - 'LOGNAME': 'cltbld', 07:35:35 INFO - 'MAIL': '/var/mail/cltbld', 07:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:35 INFO - 'MOZ_NO_REMOTE': '1', 07:35:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:35 INFO - 'NO_EM_RESTART': '1', 07:35:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:35 INFO - 'PWD': '/builds/slave/test', 07:35:35 INFO - 'SHELL': '/bin/bash', 07:35:35 INFO - 'SHLVL': '1', 07:35:35 INFO - 'TERM': 'linux', 07:35:35 INFO - 'TMOUT': '86400', 07:35:35 INFO - 'USER': 'cltbld', 07:35:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', 07:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:35 INFO - '_': '/tools/buildbot/bin/python'} 07:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:35 INFO - Downloading/unpacking blobuploader==1.2.4 07:35:35 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 07:35:35 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 07:35:35 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 07:35:35 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 07:35:35 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 07:35:35 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 07:35:37 INFO - Downloading blobuploader-1.2.4.tar.gz 07:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:35:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:35:37 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 07:35:37 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 07:35:37 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 07:35:37 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 07:35:37 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 07:35:37 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 07:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:35:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:35:37 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 07:35:37 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 07:35:37 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 07:35:37 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 07:35:37 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 07:35:37 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 07:35:38 INFO - Downloading docopt-0.6.1.tar.gz 07:35:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:35:38 INFO - Installing collected packages: blobuploader, requests, docopt 07:35:38 INFO - Running setup.py install for blobuploader 07:35:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:35:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:35:38 INFO - Running setup.py install for requests 07:35:38 INFO - Running setup.py install for docopt 07:35:38 INFO - Successfully installed blobuploader requests docopt 07:35:38 INFO - Cleaning up... 07:35:38 INFO - Return code: 0 07:35:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:38 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 0x7fd0b26c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', '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 07:35:38 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 07:35:38 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 07:35:38 INFO - Using env: {'DISPLAY': ':0', 07:35:38 INFO - 'HOME': '/home/cltbld', 07:35:38 INFO - 'LANG': 'en_US.UTF-8', 07:35:38 INFO - 'LANGUAGE': 'en_US:en', 07:35:38 INFO - 'LOGNAME': 'cltbld', 07:35:38 INFO - 'MAIL': '/var/mail/cltbld', 07:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:38 INFO - 'MOZ_NO_REMOTE': '1', 07:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:38 INFO - 'NO_EM_RESTART': '1', 07:35:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:38 INFO - 'PWD': '/builds/slave/test', 07:35:38 INFO - 'SHELL': '/bin/bash', 07:35:38 INFO - 'SHLVL': '1', 07:35:38 INFO - 'TERM': 'linux', 07:35:38 INFO - 'TMOUT': '86400', 07:35:38 INFO - 'USER': 'cltbld', 07:35:38 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', 07:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:38 INFO - '_': '/tools/buildbot/bin/python'} 07:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:38 INFO - Running setup.py (path:/tmp/pip-TvERVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:39 INFO - Running setup.py (path:/tmp/pip-VeBXNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:39 INFO - Running setup.py (path:/tmp/pip-NmpzDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:39 INFO - Running setup.py (path:/tmp/pip-JXJK22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:39 INFO - Running setup.py (path:/tmp/pip-nj83Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:39 INFO - Running setup.py (path:/tmp/pip-FrnxMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:39 INFO - Running setup.py (path:/tmp/pip-s0fzrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:39 INFO - Running setup.py (path:/tmp/pip-bLI6y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:39 INFO - Running setup.py (path:/tmp/pip-oWO9qR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:39 INFO - Running setup.py (path:/tmp/pip-wEzu6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:39 INFO - Running setup.py (path:/tmp/pip-EZNliV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:39 INFO - Running setup.py (path:/tmp/pip-hSm93x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:39 INFO - Running setup.py (path:/tmp/pip-D6MrlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:39 INFO - Running setup.py (path:/tmp/pip-UivEEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:39 INFO - Running setup.py (path:/tmp/pip-XaKM81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:40 INFO - Running setup.py (path:/tmp/pip-4wrecI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:40 INFO - Running setup.py (path:/tmp/pip-jlzldu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:35:40 INFO - Running setup.py install for manifestparser 07:35:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:35:40 INFO - Running setup.py install for mozcrash 07:35:40 INFO - Running setup.py install for mozdebug 07:35:40 INFO - Running setup.py install for mozdevice 07:35:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:35:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:35:40 INFO - Running setup.py install for mozfile 07:35:40 INFO - Running setup.py install for mozhttpd 07:35:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:35:40 INFO - Running setup.py install for mozinfo 07:35:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:35:40 INFO - Running setup.py install for mozInstall 07:35:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:35:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:35:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:35:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:35:40 INFO - Running setup.py install for mozleak 07:35:41 INFO - Running setup.py install for mozlog 07:35:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:35:41 INFO - Running setup.py install for moznetwork 07:35:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:35:41 INFO - Running setup.py install for mozprocess 07:35:41 INFO - Running setup.py install for mozprofile 07:35:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:35:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:35:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:35:41 INFO - Running setup.py install for mozrunner 07:35:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:35:41 INFO - Running setup.py install for mozscreenshot 07:35:41 INFO - Running setup.py install for moztest 07:35:41 INFO - Running setup.py install for mozversion 07:35:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:35:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:35:41 INFO - Cleaning up... 07:35:41 INFO - Return code: 0 07:35:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:41 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 0x7fd0b26c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', '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 07:35:41 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 07:35:41 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 07:35:41 INFO - Using env: {'DISPLAY': ':0', 07:35:41 INFO - 'HOME': '/home/cltbld', 07:35:41 INFO - 'LANG': 'en_US.UTF-8', 07:35:41 INFO - 'LANGUAGE': 'en_US:en', 07:35:41 INFO - 'LOGNAME': 'cltbld', 07:35:41 INFO - 'MAIL': '/var/mail/cltbld', 07:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:41 INFO - 'MOZ_NO_REMOTE': '1', 07:35:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:41 INFO - 'NO_EM_RESTART': '1', 07:35:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:41 INFO - 'PWD': '/builds/slave/test', 07:35:41 INFO - 'SHELL': '/bin/bash', 07:35:41 INFO - 'SHLVL': '1', 07:35:41 INFO - 'TERM': 'linux', 07:35:41 INFO - 'TMOUT': '86400', 07:35:41 INFO - 'USER': 'cltbld', 07:35:41 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', 07:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:41 INFO - '_': '/tools/buildbot/bin/python'} 07:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:42 INFO - Running setup.py (path:/tmp/pip-CrqH9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:42 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)) 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:42 INFO - Running setup.py (path:/tmp/pip-i9Iosh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:42 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)) 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:42 INFO - Running setup.py (path:/tmp/pip-OFj7Ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:42 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)) 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:42 INFO - Running setup.py (path:/tmp/pip-8tXZs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:42 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)) 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:42 INFO - Running setup.py (path:/tmp/pip-WW_hYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:42 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)) 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:42 INFO - Running setup.py (path:/tmp/pip-if4aNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:42 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)) 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:42 INFO - Running setup.py (path:/tmp/pip-1XGz11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:42 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)) 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:42 INFO - Running setup.py (path:/tmp/pip-0SdOni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:42 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)) 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:42 INFO - Running setup.py (path:/tmp/pip-sP7JVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:42 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)) 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:42 INFO - Running setup.py (path:/tmp/pip-vdkHqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:42 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)) 07:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:42 INFO - Running setup.py (path:/tmp/pip-xah9S5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:43 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)) 07:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:43 INFO - Running setup.py (path:/tmp/pip-Uduswr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:43 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)) 07:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:43 INFO - Running setup.py (path:/tmp/pip-uB8qwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:43 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)) 07:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:43 INFO - Running setup.py (path:/tmp/pip-hdhVUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:43 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)) 07:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:43 INFO - Running setup.py (path:/tmp/pip-w9EX_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:43 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)) 07:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:43 INFO - Running setup.py (path:/tmp/pip-ve7tJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:43 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)) 07:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:43 INFO - Running setup.py (path:/tmp/pip-HG0A8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:43 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)) 07:35:43 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)) 07:35:43 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)) 07:35:43 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)) 07:35:43 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)) 07:35:43 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)) 07:35:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:35:43 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 07:35:43 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 07:35:43 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 07:35:43 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 07:35:43 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 07:35:43 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 07:35:45 INFO - Downloading blessings-1.6.tar.gz 07:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:35:45 INFO - Installing collected packages: blessings 07:35:45 INFO - Running setup.py install for blessings 07:35:45 INFO - Successfully installed blessings 07:35:45 INFO - Cleaning up... 07:35:45 INFO - Return code: 0 07:35:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:35:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:45 INFO - Reading from file tmpfile_stdout 07:35:45 INFO - Current package versions: 07:35:45 INFO - argparse == 1.2.1 07:35:45 INFO - blessings == 1.6 07:35:45 INFO - blobuploader == 1.2.4 07:35:45 INFO - docopt == 0.6.1 07:35:45 INFO - functools32 == 3.2.3-2 07:35:45 INFO - jsonschema == 2.5.1 07:35:45 INFO - manifestparser == 1.1 07:35:45 INFO - mozInstall == 1.12 07:35:45 INFO - mozcrash == 0.17 07:35:45 INFO - mozdebug == 0.1 07:35:45 INFO - mozdevice == 0.48 07:35:45 INFO - mozfile == 1.2 07:35:45 INFO - mozhttpd == 0.7 07:35:45 INFO - mozinfo == 0.9 07:35:45 INFO - mozleak == 0.1 07:35:45 INFO - mozlog == 3.2 07:35:45 INFO - moznetwork == 0.27 07:35:45 INFO - mozprocess == 0.22 07:35:45 INFO - mozprofile == 0.28 07:35:45 INFO - mozrunner == 6.11 07:35:45 INFO - mozscreenshot == 0.1 07:35:45 INFO - mozsystemmonitor == 0.3 07:35:45 INFO - moztest == 0.7 07:35:45 INFO - mozversion == 1.4 07:35:45 INFO - psutil == 3.1.1 07:35:45 INFO - requests == 1.2.3 07:35:45 INFO - wsgiref == 0.1.2 07:35:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:45 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 0x7fd0b26c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', '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 07:35:45 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 07:35:45 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 07:35:45 INFO - Using env: {'DISPLAY': ':0', 07:35:45 INFO - 'HOME': '/home/cltbld', 07:35:45 INFO - 'LANG': 'en_US.UTF-8', 07:35:45 INFO - 'LANGUAGE': 'en_US:en', 07:35:45 INFO - 'LOGNAME': 'cltbld', 07:35:45 INFO - 'MAIL': '/var/mail/cltbld', 07:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:45 INFO - 'MOZ_NO_REMOTE': '1', 07:35:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:45 INFO - 'NO_EM_RESTART': '1', 07:35:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:45 INFO - 'PWD': '/builds/slave/test', 07:35:45 INFO - 'SHELL': '/bin/bash', 07:35:45 INFO - 'SHLVL': '1', 07:35:45 INFO - 'TERM': 'linux', 07:35:45 INFO - 'TMOUT': '86400', 07:35:45 INFO - 'USER': 'cltbld', 07:35:45 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', 07:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:45 INFO - '_': '/tools/buildbot/bin/python'} 07:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:46 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)) 07:35:46 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)) 07:35:46 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)) 07:35:46 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)) 07:35:46 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)) 07:35:46 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)) 07:35:46 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)) 07:35:46 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)) 07:35:46 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)) 07:35:46 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)) 07:35:46 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)) 07:35:46 INFO - Cleaning up... 07:35:46 INFO - Return code: 0 07:35:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:35:46 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')]} 07:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:46 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')]} 07:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:46 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 0x7fd0b26c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', '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 07:35:46 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 07:35:46 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 07:35:46 INFO - Using env: {'DISPLAY': ':0', 07:35:46 INFO - 'HOME': '/home/cltbld', 07:35:46 INFO - 'LANG': 'en_US.UTF-8', 07:35:46 INFO - 'LANGUAGE': 'en_US:en', 07:35:46 INFO - 'LOGNAME': 'cltbld', 07:35:46 INFO - 'MAIL': '/var/mail/cltbld', 07:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:46 INFO - 'MOZ_NO_REMOTE': '1', 07:35:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:46 INFO - 'NO_EM_RESTART': '1', 07:35:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:46 INFO - 'PWD': '/builds/slave/test', 07:35:46 INFO - 'SHELL': '/bin/bash', 07:35:46 INFO - 'SHLVL': '1', 07:35:46 INFO - 'TERM': 'linux', 07:35:46 INFO - 'TMOUT': '86400', 07:35:46 INFO - 'USER': 'cltbld', 07:35:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', 07:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:46 INFO - '_': '/tools/buildbot/bin/python'} 07:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:35:46 INFO - Cleaning up... 07:35:46 INFO - Return code: 0 07:35:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:35:46 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')]} 07:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:46 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')]} 07:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:46 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 0x7fd0b26c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', '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 07:35:46 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 07:35:46 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 07:35:46 INFO - Using env: {'DISPLAY': ':0', 07:35:46 INFO - 'HOME': '/home/cltbld', 07:35:46 INFO - 'LANG': 'en_US.UTF-8', 07:35:46 INFO - 'LANGUAGE': 'en_US:en', 07:35:46 INFO - 'LOGNAME': 'cltbld', 07:35:46 INFO - 'MAIL': '/var/mail/cltbld', 07:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:46 INFO - 'MOZ_NO_REMOTE': '1', 07:35:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:35:46 INFO - 'NO_EM_RESTART': '1', 07:35:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:46 INFO - 'PWD': '/builds/slave/test', 07:35:46 INFO - 'SHELL': '/bin/bash', 07:35:46 INFO - 'SHLVL': '1', 07:35:46 INFO - 'TERM': 'linux', 07:35:46 INFO - 'TMOUT': '86400', 07:35:46 INFO - 'USER': 'cltbld', 07:35:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', 07:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:46 INFO - '_': '/tools/buildbot/bin/python'} 07:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:46 INFO - Downloading/unpacking flake8 07:35:46 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 07:35:46 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 07:35:46 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 07:35:46 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 07:35:46 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 07:35:46 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 07:35:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:35:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:35:48 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 07:35:48 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 07:35:48 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 07:35:48 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 07:35:48 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 07:35:48 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 07:35:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:35:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:35:48 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 07:35:48 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 07:35:48 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 07:35:48 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 07:35:48 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 07:35:48 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 07:35:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:35:49 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 07:35:49 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 07:35:49 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 07:35:49 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 07:35:49 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 07:35:49 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 07:35:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:35:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:35:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:35:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:35:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:35:49 INFO - no previously-included directories found matching 'docs/_build' 07:35:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:35:49 INFO - Running setup.py install for pep8 07:35:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:35:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:35:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:35:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:35:49 INFO - no previously-included directories found matching 'docs/_build' 07:35:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:35:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:35:49 INFO - Cleaning up... 07:35:49 INFO - Return code: 0 07:35:49 INFO - Running post-action listener: _resource_record_post_action 07:35:49 INFO - Running post-action listener: _start_resource_monitoring 07:35:49 INFO - Starting resource monitoring. 07:35:49 INFO - ##### 07:35:49 INFO - ##### Finished create-virtualenv step (success) 07:35:49 INFO - ##### 07:35:49 INFO - ##### 07:35:49 INFO - ##### Running install step. 07:35:49 INFO - ##### 07:35:49 INFO - Running pre-action listener: _resource_record_pre_action 07:35:49 INFO - Running main action method: install 07:35:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:49 INFO - Reading from file tmpfile_stdout 07:35:49 INFO - Detecting whether we're running mozinstall >=1.0... 07:35:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:35:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:35:49 INFO - Reading from file tmpfile_stdout 07:35:49 INFO - Output received: 07:35:49 INFO - Usage: mozinstall [options] installer 07:35:49 INFO - Options: 07:35:49 INFO - -h, --help show this help message and exit 07:35:49 INFO - -d DEST, --destination=DEST 07:35:49 INFO - Directory to install application into. [default: 07:35:49 INFO - "/builds/slave/test"] 07:35:49 INFO - --app=APP Application being installed. [default: firefox] 07:35:49 INFO - mkdir: /builds/slave/test/build/application 07:35:49 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'] 07:35:49 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 07:36:06 INFO - Reading from file tmpfile_stdout 07:36:06 INFO - Output received: 07:36:06 INFO - /builds/slave/test/build/application/firefox/firefox 07:36:06 INFO - Running post-action listener: _resource_record_post_action 07:36:06 INFO - ##### 07:36:06 INFO - ##### Finished install step (success) 07:36:06 INFO - ##### 07:36:06 INFO - ##### 07:36:06 INFO - ##### Running run-tests step. 07:36:06 INFO - ##### 07:36:06 INFO - Running pre-action listener: _resource_record_pre_action 07:36:06 INFO - Running main action method: run_tests 07:36:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:36:06 INFO - Python 2.7.3 07:36:06 INFO - Return code: 0 07:36:06 INFO - grabbing minidump binary from tooltool 07:36: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')]} 07:36:06 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 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:36:06 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 07:36:06 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 07:36:06 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 07:36:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:36:06 INFO - Return code: 0 07:36:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:36:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:36:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:36:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:36:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:36:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:36:07 INFO - Return code: 0 07:36:07 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:36:07 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:36:07 INFO - Using env: {'DISPLAY': ':0', 07:36:07 INFO - 'HOME': '/home/cltbld', 07:36:07 INFO - 'LANG': 'en_US.UTF-8', 07:36:07 INFO - 'LANGUAGE': 'en_US:en', 07:36:07 INFO - 'LOGNAME': 'cltbld', 07:36:07 INFO - 'MAIL': '/var/mail/cltbld', 07:36:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:36:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:07 INFO - 'MOZ_NO_REMOTE': '1', 07:36:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:07 INFO - 'NO_EM_RESTART': '1', 07:36:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:07 INFO - 'PWD': '/builds/slave/test', 07:36:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:36:07 INFO - 'SHELL': '/bin/bash', 07:36:07 INFO - 'SHLVL': '1', 07:36:07 INFO - 'TERM': 'linux', 07:36:07 INFO - 'TMOUT': '86400', 07:36:07 INFO - 'USER': 'cltbld', 07:36:07 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156', 07:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:07 INFO - '_': '/tools/buildbot/bin/python'} 07:36:07 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:36:07 INFO - mozversion application_buildid: 20160623061527 07:36:07 INFO - mozversion application_changeset: 3c54e4e048dcd7b1a7a54a8fbc4a68962a8fdce4 07:36:07 INFO - mozversion application_display_name: Nightly 07:36:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:36:07 INFO - mozversion application_name: Firefox 07:36:07 INFO - mozversion application_remotingname: firefox 07:36:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:36:07 INFO - mozversion application_vendor: Mozilla 07:36:07 INFO - mozversion application_version: 50.0a1 07:36:07 INFO - mozversion platform_buildid: 20160623061527 07:36:07 INFO - mozversion platform_changeset: 3c54e4e048dcd7b1a7a54a8fbc4a68962a8fdce4 07:36:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:36:07 INFO - mozversion platform_version: 50.0a1 07:36:07 INFO - using testdate: 1466692567 07:36:07 INFO - actual date: 1466692567 07:36:07 INFO - starting webserver on 'localhost:43127' 07:36:07 INFO - SUITE-START | Running 2 tests 07:36:07 INFO - TEST-START | dromaeo_css 07:36:07 INFO - operating with platform_type : linux_ 07:36:07 INFO - Initialising browser for dromaeo_css test... 07:36:07 INFO - TEST-INFO | started process 8696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzvy50v/profile http://localhost:43127/getInfo.html) 07:36:11 INFO - PROCESS | 8696 | __metrics Screen width/height:1600/1200 07:36:11 INFO - PROCESS | 8696 | colorDepth:24 07:36:11 INFO - PROCESS | 8696 | Browser inner width/height: 1024/697 07:36:11 INFO - PROCESS | 8696 | __metrics 07:36:13 INFO - PROCESS | 8696 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:36:14 INFO - TEST-INFO | 8696: exit 0 07:36:14 INFO - Browser initialized. 07:36:14 INFO - Running cycle 1/1 for dromaeo_css test... 07:36:14 INFO - TEST-INFO | started process 8777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzvy50v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:26 INFO - PROCESS | 8777 | RSS: Main: 175902720 07:36:26 INFO - PROCESS | 8777 | 07:37:17 INFO - PROCESS | 8777 | 1466692637388 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] 07:39:30 INFO - PROCESS | 8777 | Cycle 1(1): loaded http://localhost:43127/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43127/tests/dromaeo/cssquery-ext.html) 07:39:31 INFO - PROCESS | 8777 | RSS: Main: 263368704 07:39:31 INFO - PROCESS | 8777 | 07:42:34 INFO - PROCESS | 8777 | Cycle 1(1): loaded http://localhost:43127/tests/dromaeo/cssquery-ext.html (next: http://localhost:43127/tests/dromaeo/cssquery-jquery.html) 07:42:34 INFO - PROCESS | 8777 | RSS: Main: 261943296 07:42:34 INFO - PROCESS | 8777 | 07:45:37 INFO - PROCESS | 8777 | Cycle 1(1): loaded http://localhost:43127/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43127/tests/dromaeo/cssquery-mootools.html) 07:45:37 INFO - PROCESS | 8777 | RSS: Main: 258678784 07:45:37 INFO - PROCESS | 8777 | 07:48:39 INFO - PROCESS | 8777 | Cycle 1(1): loaded http://localhost:43127/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43127/tests/dromaeo/cssquery-prototype.html) 07:48:40 INFO - PROCESS | 8777 | RSS: Main: 262008832 07:48:40 INFO - PROCESS | 8777 | 07:51:43 INFO - PROCESS | 8777 | Cycle 1(1): loaded http://localhost:43127/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43127/tests/dromaeo/cssquery-yui.html) 07:51:43 INFO - PROCESS | 8777 | RSS: Main: 231022592 07:51:43 INFO - PROCESS | 8777 | 07:54:46 INFO - PROCESS | 8777 | Cycle 1(1): loaded http://localhost:43127/tests/dromaeo/cssquery-yui.html (next: http://localhost:43127/tests/dromaeo/cssquery-dojo.html) 07:54:47 INFO - PROCESS | 8777 | RSS: Main: 283246592 07:54:47 INFO - PROCESS | 8777 | 07:54:47 INFO - PROCESS | 8777 | __start_tp_report 07:54:47 INFO - PROCESS | 8777 | _x_x_mozilla_page_load 07:54:47 INFO - PROCESS | 8777 | _x_x_mozilla_page_load_details 07:54:47 INFO - PROCESS | 8777 | |i|pagename|runs| 07:54:47 INFO - PROCESS | 8777 | |0;dojo.html;2620.1091628846193;2631.8026148038903;2661.095227622608;2668.0128352509573;2673.705892351841;4609.216433206355;4640.09518143962;4715.905681886365;4782.306565547998;4803.039392121576;4714.9057018859685;4725.078609671115;4745.644076694244;4771.570558649721;4781.617470602352;4129.587041295877;4276.615104640582;4364.061726728753;4388.75861827601;4484.551544845522;4412.0955204183065;4445.377647129404;4456.17560751262;4462.843800466984;4488.371627972087;4226.746395216297;4269.935950960738;4272.060146767706;4312.504062032875;4327.675424343187;4311.353297005474;4321.697481176319;4324.610785029363;4360.193364227596;4383.956160438387;4344.89137771555;4358.019445624741;4366;4394.71434356769;4412.360207769888;4586.977065114686;4663.253879379283;4715.693479923794;4730.314104454869;4750.572448479654;5084.288199652052;5101.770420331094;5125.3080834087295;5158.535731784157;5201.635885488017;5197.168453047494;5227.921581176285;5230.320058392384;5231.738413079369;5236.476352364771;4639.095376401637;4655.557722016403;4727.149113159596;4734.384530011145;4807.254875494234;5234.319538459976;5261.815836445706;5263.815766448232;5265.9736701317015;5269.446708095671;4829.9034019319415;4999.550040496373;5046.016026874724;5047.293378926953;5053.444121146671;5009.223570346602;5054.9241761373605;5057.544820966131;5116.692998420107;5142.5628821549835;5030.647854650139;5036.974815125901;5041.092603331363;5041.747912604428;5091.363579552556;5002.974985125051;5008.799648014112;5017.974910125426;5020.3724534433195;5025.949740502621;4226.936595951063;4259.574042595716;4261;4316.093620339764;4324.048709283952;3764.604716504782;3793.1275806564645;3805.5813860475328;3809.466674665549;3810.599887011879;4292.313229883203;4300.333448315516;4305.311150216013;4312.935305970413;4364.738115713068;5063.594912406998;5076.644634875597;5078.97460512695;5080.339555857715;5128.512791284822;4321.330193819963;4331.0904710011255;4331.285337919208;4333.15503476819;4341.240282950471;4408.4269045024585;4463.553644635575;4578.793954272066;4592.2422800238255;4620.1221767864;4773.212419950669;4780.163471392492;4795.20879054952;4795.496472870298;4820.855374338776;5117.2068329409;5119.846404607868;5130.179171332569;5130.204818253177;5183.870403239949;4637.118947399983;4709.3642358281195;4716.882077948078;4759.76201189946;4782.450018247946;4990.301357809982;5014.566787723995;5017.37282839645;5020.447750747488;5063.8480845574695;4887.535684110146;5090.490950905028;5101.183810590288;5103.693778373309;5157.226416037474;4935;4957.157283261782;4985.1276026695905;4986.850394488171;5008.799648014038;4999.975000124976;5006.949930500648;5009.624278179078;5009.899802004013;5061.822836200715;4727.3854398927915;4823.252395878644;4938.827141050046;4950.554450099508;4981.925271121008;4937.185364414831;4984.352034235526;5001.399832020181;5007.499250074963;5060.418051924076;4891.5353041461;4892.633052521004;4901.877453063702;4908.656394052525;4949.727764972817 07:54:47 INFO - PROCESS | 8777 | |1;ext.html;539.8021667451719;574.8534123798431;586.4428792646986;588.3645662684302;598.3119412675422;27550.724492755093;41110.17779644409;42008.579914200884;42045;42083.15833683324;41675.79162104193;42316.36525452113;42316.788416057956;42343;42380.57619423805;7568.848623027564;7712.4215683823795;7759;7768.456208065438;7908.52548847071;7628.6567104480155;10065.597376104946;10346.844797328045;10359.27485076045;10684.03843654071;10039.196864250878;10052.346597471178;10074.194064474861;10089.394636321844;10113.544890479947;7630.694772209105;10147.289689721723;10250.282480226388;10338.586456541729;10341.06930376266;9725.319227654067;10036.347637403545;10036.799264014751;10037.447940363278;10050.246231532592;38855.41716874249;39042.21915561673;39132.41301380481;39134.804325978475;39153.80423097866;3185.6336521300113;3224.871005159791;3229.9192520187185;3429.005588379367;3725.5343082114737;30191.245218869703;30267.394652106836;30426.239344016354;30722.23194420135;30752.692473075207;3535.876244331436;3540.6636369544854;3574.231540218839;3596;3635.72732045095;253079;253409;253935;254569;254611;27194.728052719616;27646.585301220097;27761.722382775915;54215.72892135514;54769;31680.524792128137;32165.678343216736;32207.677923220468;32286.19284517859;32378;13349;13509.121907076009;13518.59444216675;13526.053176277566;13526.729465410637;9849.60601575929;11229.66311010671;11308.660740177807;11331;11515.30908145514;7934.880976785353;7957.204279571996;8013.919860801434;8036.196380361917;8079.919200807916;3035.165329534396;3070.1096681962426;3129.499280115216;3131.3580715953176;3137.5607414961923;891.3047822698176;907.6414816147585;945.8864936207561;948.4641177734558;1015.5430056474615;28515.57226641602;29202.561961570595;29447.454171081543;29867.10398688043;29867.253318667208;939.5020639061308;949.5442187749919;952.0764858087643;1024.8206563851297;1071.5820829876354;15112.848871511364;15209.239538023054;15267.312970916113;15335.61660958485;15664.530064098095;422023;425543;426818;427583;427593;50286.49713502891;51117.488825112014;51150.23274650883;51306.48693513017;51370.22944655833;1078.3745427651943;1105.6130354375905;1109.5062697099875;1191.3566673996118;1209.0327737809716;24063.398415039064;31239.375212496077;31372.529412059295;31512.68487315189;31765.682343177195;47585.286220706024;47987;48122.518774811804;48204.27693584669;48299.275510868065;353056;354629;354820;354967;355108;24998.125065622615;25070.22297963401;25858;25894.611580825927;25935;42787.7860610695;42877;42908.35637465503;43113.56886431095;43986;36595.63404365922;37069.4439583401;37087.629123708415;37128.257434851694;37488.43767343547;35616.287674245854;36471.27057458889;36607.63392366149;36653.26693466063;37115.44326835153;36100.09749756277;36113.27773444569;36409.63590364062;36635.45046824247;36876;32029.35941281208;32289.192770180933;32800.83599581987;32961.1277828181;33527.16182095467;25482;25593.360165995255;25605;25807.225783226535;26113.608295875958 07:54:47 INFO - PROCESS | 8777 | |2;jquery.html;380.6783268138423;382.7492992090182;384.36387778227044;392.6838894689774;400.9919801603968;15863.841361586381;17819.73270400945;18008.729869051975;18009;18009.54976125596;16727;17152.485425437226;17323.39368122116;17533;17607.383741569047;4918.065567542165;5109.054824857413;5147.81982630608;5152.896942061157;5172.327597412331;3769.5853456119803;3860.5946375630574;3923.3722604383306;6095.878082438348;6096;6114;6139.8772024559485;6161;6162.044883043135;6169;5914.201582786333;6056.60632058917;6059.909101363483;6060.757569697207;6075.149479072933;3429.5713035870517;5020.723860187688;5336.359636843565;5338.97330513345;5364.034473794715;20004.89997550003;20875;20904;20936;20968.89515552428;1916.6645836978473;2058.3516192399347;2074.6576814825535;2246.3597874605657;2434.0993832281993;9005.144511271485;9178.86231706525;9576.952115239379;9744.853827192597;12842.871571284355;1704.8891822031528;1717.1671739206474;1724.2154819557072;1808.9366872159542;1833.1659095111693;50662.453380617;57184;63124.684376577825;63175;63938;9991.550380232908;10161.288709790244;10187.898121018696;10297.279190456597;10300.639477618248;13689.31553422325;13735.313234338442;13995.930020350037;14009.649758756113;14015.719685606231;7150.5352152109945;7281.854362912712;7349.154847192534;7350.7427240046345;7421.962890185515;6906.930930690729;7055.118110236221;7085.53943993649;7121.786346409616;7172.246914074051;4385.780710964503;4408.867733967986;4460.955390446119;4529.456465224128;4538.819906824184;1801.8378345948927;1811.9728204076948;1814.5917168637216;1857.4149143019906;1893.2616279650947;821.256762629821;821.6754382019188;890.973270801877;891.9286457083417;894.2220268366563;17308;17370.39203627867;17453.389131380594;17468.12659367052;17790.199441025186;809.8218391953878;812.4191203289677;814.9755507334789;844.3161039557978;855.5080828523623;9552.616629625574;9744.464054477072;9856.162226210852;9890.554925028391;9960.252981026308;305183;308709;392262;394598;394908;49812;64223.678881605294;72562;83026.58486707527;86981;875.9824803503894;903.8734577159203;927.8005228875824;928.3872644054892;930.7207837648814;15900.681986359976;16126.596835079217;16135.919320403324;16241.756373654642;16298.348066077224;26661.866690666422;27228;36983.63016369802;37382.25235495329;38042.239155216186;52255.477445225064;53182.73408632932;53466;54477.45522544882;54592.727036364566;7529.58587277705;7637.274458926393;7665.578393188428;7708.922910770821;7834.451588388758;11595.362255076052;11608.071354291467;11662.53349865996;11969.700757481132;11984.10119241043;10060.849087263843;10210.948945255226;10277.588896444058;10391.792164156523;10510.1066409353;9163.129502697233;10311.845322320021;10336.379817210991;10541.104006159563;10552.208584356358;10036.347637403545;10107.7473063174;10177.542010609688;10207.387556746618;10318.329308594917;6719.496037797087;7598.35413989795;7634.580098094658;7680.270374314431;7951.324137448381;8630.611622477129;9270.44377337362;9978.301518893608;10042.69871903844;10235.84646230322 07:54:47 INFO - PROCESS | 8777 | |3;mootools.html;1158.4786845919339;1317.440087962616;1355.4984655677397;1397.8881689464845;1662.4430815676749;6631.237407698116;7527.096748390194;7776.300132988037;7783.844323113534;7995.640196191171;7701.691932322715;7840.607969601526;7853.450258481908;7854.450188486809;7858.646360913758;2163.859349142305;2171.240065976903;2174.0542863854193;2181.8472706910525;2192.725909261342;2149.1296025109855;2185.1914791527156;2188.9452763680956;2192.583409152256;2193.320070778056;2165.2746329979477;2179.727534058243;2185.25701261571;2190.5837890800776;2195.3413975807275;2123.7451505819245;2126.5959467701086;2126.914923403062;2130.1585873579847;2132.2110818996916;2066.73132492775;2105.610462064523;2108.746950365966;2111.68324751287;2112.4824418017683;7608.31525162738;7826.608669566499;7866.213378662145;7868;7888.447808653396;4533.6146427553695;4640.582347588699;4666.813327466897;4683.859484215479;4689.765511724434;2769.2661444717164;2947.882084716609;3015.020118461487;3030.5454181872674;3038.225252560605;938.9108034736689;950.8573713942894;963.6771681486711;969.6412327438823;976.3702411944328;10583.788324233548;10702.197335199891;10706.73233169177;10708;10735.892641073646;4099.9180016400105;4180.602842729936;4192.413062171298;4346.913061738747;4361.433013708261;8087.757367278991;8135.75592732219;8148.307393871587;8164.306033987177;8166.060902996112;4681.882952926204;4683.297505374153;4683.414573178353;4683.859484215411;4688.413948256468;3647.3070116677745;3647.635236476331;4327.3725309830525;4373.409589705413;4373.606375426227;3405.267867408519;3491.650834916488;3492.353914525821;3525.506429099928;3561.8041007744305;1027.1782573940818;1068.2468859454066;1070.7055559721139;1074.521837782195;1076.6016573867719;757.8863170524465;776.7359097906626;787.4291138924349;797.960101994898;805.8428606421692;4800.615950723934;5022.673526220857;5046.697198168122;5077.619178561623;5113;418.2742940997367;430.1139652316176;433.2785911457388;438.9451318585177;443.2265696359873;3221.5811944447073;3322.667733226658;3379.391709492315;3432.982835085809;3494.2487365216602;9495.90504094964;9773;9783.461909594898;9847.55685994132;9864.309498335191;9590.280728945358;9882.308238423386;9883.555240014217;9890.703278901645;9892.307538472238;7350.485466017434;7360.926390736131;7442.590657513889;7461.962690186514;7542.170361260257;4973.47778483254;4988.351514303263;5061.9493805061475;5077.933633936915;5105.846824595268;8847.778805529913;9024.052474490083;9150.63397464094;9155.404898681565;9196;9169.312301577274;9263.258939284706;9378.859317110386;9391.530423478662;9441.433513988908;5658.321001479849;5901.3213480448585;5901.3213480450295;6031.7587296507645;6233.719482623203;7497.137829149718;7595.506292090997;7596.164421913474;7598.658060387185;7599.316061554487;6510.0885875976455;6695.196576410862;6706.128203333536;6747.6626168692355;6881.4494840413645;6753.1220941277315;6788.389044985975;6810.318968103348;6837.247902730596;6920.273371295942;5846.503047241032;5855.121731740102;5909.881802364014;5930.911036334544;5947.643141411356;4336.284513055437;4338.219120558204;4450.510443851239;4458.152950939311;4510.887227819331;4300.892477688083;4357.9782101089295;4382.5179230284;4441.311596702516;4499.987502811972 07:54:47 INFO - PROCESS | 8777 | |4;prototype.html;293.9088882446441;298.36001776190074;299.8905399529172;303.4552977405557;304.57968004154264;4867.9533900211445;4905.3132561441425;4928.778204980776;4934.5080734229205;4938.728369939652;4849.418069831625;4866.1484240257905;4881.682690625107;4891.144049791281;4894.2413925841465;3578.4095624221973;3713.740038197327;3743.5133432653715;3774.6602805747475;3796.278707045666;3758.8308526116252;3807.438950030488;3810.1808111256073;3812.2184952084895;3815.3323168445413;3768.3028639701743;3768.660820526166;3769.4157405602177;3780.395136778116;3787.3561494545993;3544.4860495228177;3710.628937106295;3795.4686343911876;3810.894840496253;3842.3275926712995;3358.9496157557655;3372.106391806173;3375.6455572164814;3390.4066788312193;3410.5054767058887;4724.622030237572;4743.905121897577;4755.358026666425;4776.976115119437;4791.496892826272;4193.322670931651;4387.62705170061;4420.4253447052;4429.029082058485;4463.263561512346;5126.410462796752;5153.845384638467;5156.5561642740095;5173.560247378978;5174.689518628894;3763.5671897731563;3766.868159614428;3772.3021241070214;3774;3774.6602805747616;5116.692998420107;5368.892622147574;5397.595180361489;5404.702741349224;5409.810656627039;3810.4279611262286;3829.368154254517;3832.674222691047;3840.347140986039;3842.1739326045035;3850.403187505941;3893.9097052824686;3894.532656081288;3902.8829135125993;3914.9233960660476;4365.236083685342;4375.78121093944;4380.3210502372185;4397.296432570837;4422.402975598253;4851.975740121276;5123.538881500683;5133.101707201225;5136.486351364833;5143.794248230104;1295.4688577683105;1301.7852054411105;1301.99746195429;1308.7905935050346;1314.612189404128;784.4626430894855;805.7663277649533;808.2160304504621;827.5489858027389;837.3468694418364;4386.18855511725;4508.436445444319;4510.188166130062;4524.2082635538645;4525.230710779176;5268.235141227655;5277.498637629419;5308.522232998971;5313.459096861944;5319.468053194727;4492.573205545468;4498.280275156025;4506.662000349987;4512.548745125527;4512.9774351128035;2650.787936965038;2831.830090194595;2852.6434195725533;2862.8997985070837;2865.140457862633;4937.21004639256;4954.5540901319055;4967.5032496750755;4995.8526128539515;4999.475055119233;5261.894762104736;5436.238926550286;5441.238226648273;5460.5085542301385;5464.371597266365;4979.825706100269;4982.081898469116;4991.3511243538105;4997.7251251180805;5009.924851127236;5333.173358129496;5333.639921819911;5343.332083489564;5345.262789593476;5348.545373643284;4914.287428322945;5138.332016837787;5218.791248350023;5223.869403264949;5224.190250511177;4930.728809915346;4963.776630051584;4967.975160124176;4969.204927211629;4971.726555039508;3418.3505134024454;3466.561377028505;3470.340635279289;3470.670286322795;3473.6552826842285;4579.473360563577;4711.693739906895;4712.858614241578;4733.337332773345;4749.738764367993;4582.625212436323;4648.65135114861;4649.953500465087;4671.252599584051;4680.268300728752;4560.931586026146;4606.355110284496;4611.884702882455;4621.69958952667;4622.838200662961;4230.5769423057445;4548.658850586286;4549.294859296814;4563.475200351869;4568.862934111982;4602.941323495548;4925.8029678812445;4933.013397320622;5196.480351964925;5212.635115541876;5081.450157701936;5082.33929589151;5094.363204599425;5095.87260318495;5096.362954630671 07:54:47 INFO - PROCESS | 8777 | |5;yui.html;629.288903539001;651.0429668387469;681.4344094401644;736.9742059027935;752.6179641434858;12097.334646594434;13017.02372322076;13026.218426894393;14974.475893343735;15596;14619.853801461983;14772.926135369307;14862.554123376316;14871;14875.107493550395;624.4723208888482;771.7761849063764;791.1416113516826;800.5156880087551;802.7832485228985;787.6180052674448;788.7160622176012;791.89309443225;793.0364607002491;793.2900054451262;810.1857633078747;812.6302532347797;813.1461964936822;813.5078277642031;813.6216659253446;654.6170490263202;670.2225418514499;672.2067959807425;672.4183581202274;809.3767798794925;588.6762280745572;599.7271241585069;601.2664549249909;604.4076804731344;605.0108073300142;13038.282894440801;13051;13059;13070.477180912752;13219.669508262274;11476.71308217293;12022;12292;12343.691407714789;12387.93806030973;9909.306348555603;10078.546465409074;10078.899211007869;10101.747456313651;10128.392296462236;4150.128473020669;4172.666186705087;4178.435911152016;4242.957570424287;4277.850275240352;59489.10766338508;59667;59888;60294.698526507964;60311.69844150751;9175.265978721687;9262.212711919563;9334.253259739204;9727.951360243154;9747.805043899083;16057.437989670305;16119.27463264156;16121.193940302937;16158.353665853234;16365.263563139688;6665.200175978816;6793.5244532882225;6804.183497980274;6810.727570897108;6829.351211634887;3775.9244815103543;3787.9431808522895;3789.1853251550497;3823.2162406706557;3930.685545156438;2804.1587523743206;2875.61179240804;2904.0126357038707;2904.9854750726113;2907.88368465259;481.52569718826925;486.55237181792126;487.28369297133156;492.4804331430304;493.0188924041132;464.83963032753644;482.15141351222104;491.5183120541889;498.27003439960635;509.8368522072901;7253.5647861127445;7354.227806080392;8313.625886835107;9016.504092274856;9387.29595280343;561.581621691834;574.6523353371234;598.3478008970243;625.1778910732372;626.1671976271548;3804.1630841214887;3837.884863454101;3966.7223294369696;3999.8600048998146;4183.205191013698;91521;94053.52973235227;94307.52846235862;94525.5273723627;94528.52735736415;76774.616126919;77702.61148694334;79694.60152699199;80208;80829;59102.70448647729;60712.69643651754;69619;70092;70595;8075.273225409741;8104.635291411782;8106.189381061847;8169.2647661710735;8224.83550329002;39294.607053929096;40252.3962140574;41877.79061104675;42938.57061429346;44489;35423;39619.603803962746;45285.77357113325;60940.39059609347;61757;10120.190384769348;10260.794784104426;10316.17470602365;10629.415382154055;10712.571497140027;13061.804072939103;13213;13285.003624727991;13305.866941330463;13424.865751342362;11646.35945022998;12003.75992480163;12087.818682719942;12468.875311246771;12859.742805144031;10894.836577451502;11085.334879906908;11218.382988935688;11610.12924030718;11977.161598688008;10490.475476226311;10718.517666704862;10745.140388768723;10856.728581785519;11111.611093611686;9822.312438129262;9949.493446055149;9975.203332671974;10326.277160598986;10674.89325106739;9486.810263794823;9896.950515247378;10092.545835437277;10139.391636501834;10224.488775561043 07:54:47 INFO - PROCESS | 8777 | __end_tp_report 07:54:47 INFO - PROCESS | 8777 | __start_cc_report 07:54:47 INFO - PROCESS | 8777 | _x_x_mozilla_cycle_collect,870 07:54:47 INFO - PROCESS | 8777 | __end_cc_report 07:54:47 INFO - PROCESS | 8777 | __startTimestamp1466693687014__endTimestamp 07:54:47 INFO - PROCESS | 8777 | 07:54:47 INFO - PROCESS | 8777 | ------- Summary: start ------- 07:54:47 INFO - PROCESS | 8777 | Number of tests: 6 07:54:47 INFO - PROCESS | 8777 | 07:54:47 INFO - PROCESS | 8777 | [#0] dojo.html Cycles:165 Average:4694.11 Median:4795.50 stddev:504.51 (10.5%) stddev-sans-first:479.11 07:54:47 INFO - PROCESS | 8777 | Values: 2620.1 2631.8 2661.1 2668.0 2673.7 4609.2 4640.1 4715.9 4782.3 4803.0 4714.9 4725.1 4745.6 4771.6 4781.6 4129.6 4276.6 4364.1 4388.8 4484.6 4412.1 4445.4 4456.2 4462.8 4488.4 4226.7 4269.9 4272.1 4312.5 4327.7 4311.4 4321.7 4324.6 4360.2 4384.0 4344.9 4358.0 4366.0 4394.7 4412.4 4587.0 4663.3 4715.7 4730.3 4750.6 5084.3 5101.8 5125.3 5158.5 5201.6 5197.2 5227.9 5230.3 5231.7 5236.5 4639.1 4655.6 4727.1 4734.4 4807.3 5234.3 5261.8 5263.8 5266.0 5269.4 4829.9 4999.6 5046.0 5047.3 5053.4 5009.2 5054.9 5057.5 5116.7 5142.6 5030.6 5037.0 5041.1 5041.7 5091.4 5003.0 5008.8 5018.0 5020.4 5025.9 4226.9 4259.6 4261.0 4316.1 4324.0 3764.6 3793.1 3805.6 3809.5 3810.6 4292.3 4300.3 4305.3 4312.9 4364.7 5063.6 5076.6 5079.0 5080.3 5128.5 4321.3 4331.1 4331.3 4333.2 4341.2 4408.4 4463.6 4578.8 4592.2 4620.1 4773.2 4780.2 4795.2 4795.5 4820.9 5117.2 5119.8 5130.2 5130.2 5183.9 4637.1 4709.4 4716.9 4759.8 4782.5 4990.3 5014.6 5017.4 5020.4 5063.8 4887.5 5090.5 5101.2 5103.7 5157.2 4935.0 4957.2 4985.1 4986.9 5008.8 5000.0 5006.9 5009.6 5009.9 5061.8 4727.4 4823.3 4938.8 4950.6 4981.9 4937.2 4984.4 5001.4 5007.5 5060.4 4891.5 4892.6 4901.9 4908.7 4949.7 07:54:47 INFO - PROCESS | 8777 | 07:54:47 INFO - PROCESS | 8777 | [#1] ext.html Cycles:180 Average:48888.30 Median:18478.08 stddev:93061.52 (503.6%) stddev-sans-first:93251.78 07:54:47 INFO - PROCESS | 8777 | Values: 539.8 574.9 586.4 588.4 598.3 27550.7 41110.2 42008.6 42045.0 42083.2 41675.8 42316.4 42316.8 42343.0 42380.6 7568.8 7712.4 7759.0 7768.5 7908.5 7628.7 10065.6 10346.8 10359.3 10684.0 10039.2 10052.3 10074.2 10089.4 10113.5 7630.7 10147.3 10250.3 10338.6 10341.1 9725.3 10036.3 10036.8 10037.4 10050.2 38855.4 39042.2 39132.4 39134.8 39153.8 3185.6 3224.9 3229.9 3429.0 3725.5 30191.2 30267.4 30426.2 30722.2 30752.7 3535.9 3540.7 3574.2 3596.0 3635.7 253079.0 253409.0 253935.0 254569.0 254611.0 27194.7 27646.6 27761.7 54215.7 54769.0 31680.5 32165.7 32207.7 32286.2 32378.0 13349.0 13509.1 13518.6 13526.1 13526.7 9849.6 11229.7 11308.7 11331.0 11515.3 7934.9 7957.2 8013.9 8036.2 8079.9 3035.2 3070.1 3129.5 3131.4 3137.6 891.3 907.6 945.9 948.5 1015.5 28515.6 29202.6 29447.5 29867.1 29867.3 939.5 949.5 952.1 1024.8 1071.6 15112.8 15209.2 15267.3 15335.6 15664.5 422023.0 425543.0 426818.0 427583.0 427593.0 50286.5 51117.5 51150.2 51306.5 51370.2 1078.4 1105.6 1109.5 1191.4 1209.0 24063.4 31239.4 31372.5 31512.7 31765.7 47585.3 47987.0 48122.5 48204.3 48299.3 353056.0 354629.0 354820.0 354967.0 355108.0 24998.1 25070.2 25858.0 25894.6 25935.0 42787.8 42877.0 42908.4 43113.6 43986.0 36595.6 37069.4 37087.6 37128.3 37488.4 35616.3 36471.3 36607.6 36653.3 37115.4 36100.1 36113.3 36409.6 36635.5 36876.0 32029.4 32289.2 32800.8 32961.1 33527.2 25482.0 25593.4 25605.0 25807.2 26113.6 07:54:47 INFO - PROCESS | 8777 | 07:54:47 INFO - PROCESS | 8777 | [#2] jquery.html Cycles:180 Average:23104.82 Median:4397.32 stddev:59671.53 (1357.0%) stddev-sans-first:59814.53 07:54:47 INFO - PROCESS | 8777 | Values: 380.7 382.7 384.4 392.7 401.0 15863.8 17819.7 18008.7 18009.0 18009.5 16727.0 17152.5 17323.4 17533.0 17607.4 4918.1 5109.1 5147.8 5152.9 5172.3 3769.6 3860.6 3923.4 6095.9 6096.0 6114.0 6139.9 6161.0 6162.0 6169.0 5914.2 6056.6 6059.9 6060.8 6075.1 3429.6 5020.7 5336.4 5339.0 5364.0 20004.9 20875.0 20904.0 20936.0 20968.9 1916.7 2058.4 2074.7 2246.4 2434.1 9005.1 9178.9 9577.0 9744.9 12842.9 1704.9 1717.2 1724.2 1808.9 1833.2 50662.5 57184.0 63124.7 63175.0 63938.0 9991.6 10161.3 10187.9 10297.3 10300.6 13689.3 13735.3 13995.9 14009.6 14015.7 7150.5 7281.9 7349.2 7350.7 7422.0 6906.9 7055.1 7085.5 7121.8 7172.2 4385.8 4408.9 4461.0 4529.5 4538.8 1801.8 1812.0 1814.6 1857.4 1893.3 821.3 821.7 891.0 891.9 894.2 17308.0 17370.4 17453.4 17468.1 17790.2 809.8 812.4 815.0 844.3 855.5 9552.6 9744.5 9856.2 9890.6 9960.3 305183.0 308709.0 392262.0 394598.0 394908.0 49812.0 64223.7 72562.0 83026.6 86981.0 876.0 903.9 927.8 928.4 930.7 15900.7 16126.6 16135.9 16241.8 16298.3 26661.9 27228.0 36983.6 37382.3 38042.2 52255.5 53182.7 53466.0 54477.5 54592.7 7529.6 7637.3 7665.6 7708.9 7834.5 11595.4 11608.1 11662.5 11969.7 11984.1 10060.8 10210.9 10277.6 10391.8 10510.1 9163.1 10311.8 10336.4 10541.1 10552.2 10036.3 10107.7 10177.5 10207.4 10318.3 6719.5 7598.4 7634.6 7680.3 7951.3 8630.6 9270.4 9978.3 10042.7 10235.8 07:54:47 INFO - PROCESS | 8777 | 07:54:47 INFO - PROCESS | 8777 | [#3] mootools.html Cycles:180 Average:5058.13 Median:4887.05 stddev:2905.59 (59.5%) stddev-sans-first:2898.97 07:54:47 INFO - PROCESS | 8777 | Values: 1158.5 1317.4 1355.5 1397.9 1662.4 6631.2 7527.1 7776.3 7783.8 7995.6 7701.7 7840.6 7853.5 7854.5 7858.6 2163.9 2171.2 2174.1 2181.8 2192.7 2149.1 2185.2 2188.9 2192.6 2193.3 2165.3 2179.7 2185.3 2190.6 2195.3 2123.7 2126.6 2126.9 2130.2 2132.2 2066.7 2105.6 2108.7 2111.7 2112.5 7608.3 7826.6 7866.2 7868.0 7888.4 4533.6 4640.6 4666.8 4683.9 4689.8 2769.3 2947.9 3015.0 3030.5 3038.2 938.9 950.9 963.7 969.6 976.4 10583.8 10702.2 10706.7 10708.0 10735.9 4099.9 4180.6 4192.4 4346.9 4361.4 8087.8 8135.8 8148.3 8164.3 8166.1 4681.9 4683.3 4683.4 4683.9 4688.4 3647.3 3647.6 4327.4 4373.4 4373.6 3405.3 3491.7 3492.4 3525.5 3561.8 1027.2 1068.2 1070.7 1074.5 1076.6 757.9 776.7 787.4 798.0 805.8 4800.6 5022.7 5046.7 5077.6 5113.0 418.3 430.1 433.3 438.9 443.2 3221.6 3322.7 3379.4 3433.0 3494.2 9495.9 9773.0 9783.5 9847.6 9864.3 9590.3 9882.3 9883.6 9890.7 9892.3 7350.5 7360.9 7442.6 7462.0 7542.2 4973.5 4988.4 5061.9 5077.9 5105.8 8847.8 9024.1 9150.6 9155.4 9196.0 9169.3 9263.3 9378.9 9391.5 9441.4 5658.3 5901.3 5901.3 6031.8 6233.7 7497.1 7595.5 7596.2 7598.7 7599.3 6510.1 6695.2 6706.1 6747.7 6881.4 6753.1 6788.4 6810.3 6837.2 6920.3 5846.5 5855.1 5909.9 5930.9 5947.6 4336.3 4338.2 4450.5 4458.2 4510.9 4300.9 4358.0 4382.5 4441.3 4500.0 07:54:47 INFO - PROCESS | 8777 | 07:54:47 INFO - PROCESS | 8777 | [#4] prototype.html Cycles:180 Average:4197.56 Median:4616.79 stddev:1214.81 (26.3%) stddev-sans-first:1182.35 07:54:47 INFO - PROCESS | 8777 | Values: 293.9 298.4 299.9 303.5 304.6 4868.0 4905.3 4928.8 4934.5 4938.7 4849.4 4866.1 4881.7 4891.1 4894.2 3578.4 3713.7 3743.5 3774.7 3796.3 3758.8 3807.4 3810.2 3812.2 3815.3 3768.3 3768.7 3769.4 3780.4 3787.4 3544.5 3710.6 3795.5 3810.9 3842.3 3358.9 3372.1 3375.6 3390.4 3410.5 4724.6 4743.9 4755.4 4777.0 4791.5 4193.3 4387.6 4420.4 4429.0 4463.3 5126.4 5153.8 5156.6 5173.6 5174.7 3763.6 3766.9 3772.3 3774.0 3774.7 5116.7 5368.9 5397.6 5404.7 5409.8 3810.4 3829.4 3832.7 3840.3 3842.2 3850.4 3893.9 3894.5 3902.9 3914.9 4365.2 4375.8 4380.3 4397.3 4422.4 4852.0 5123.5 5133.1 5136.5 5143.8 1295.5 1301.8 1302.0 1308.8 1314.6 784.5 805.8 808.2 827.5 837.3 4386.2 4508.4 4510.2 4524.2 4525.2 5268.2 5277.5 5308.5 5313.5 5319.5 4492.6 4498.3 4506.7 4512.5 4513.0 2650.8 2831.8 2852.6 2862.9 2865.1 4937.2 4954.6 4967.5 4995.9 4999.5 5261.9 5436.2 5441.2 5460.5 5464.4 4979.8 4982.1 4991.4 4997.7 5009.9 5333.2 5333.6 5343.3 5345.3 5348.5 4914.3 5138.3 5218.8 5223.9 5224.2 4930.7 4963.8 4968.0 4969.2 4971.7 3418.4 3466.6 3470.3 3470.7 3473.7 4579.5 4711.7 4712.9 4733.3 4749.7 4582.6 4648.7 4650.0 4671.3 4680.3 4560.9 4606.4 4611.9 4621.7 4622.8 4230.6 4548.7 4549.3 4563.5 4568.9 4602.9 4925.8 4933.0 5196.5 5212.6 5081.5 5082.3 5094.4 5095.9 5096.4 07:54:47 INFO - PROCESS | 8777 | 07:54:47 INFO - PROCESS | 8777 | [#5] yui.html Cycles:180 Average:16685.36 Median:486.92 stddev:23358.03 (4797.1%) stddev-sans-first:23392.44 07:54:47 INFO - PROCESS | 8777 | Values: 629.3 651.0 681.4 737.0 752.6 12097.3 13017.0 13026.2 14974.5 15596.0 14619.9 14772.9 14862.6 14871.0 14875.1 624.5 771.8 791.1 800.5 802.8 787.6 788.7 791.9 793.0 793.3 810.2 812.6 813.1 813.5 813.6 654.6 670.2 672.2 672.4 809.4 588.7 599.7 601.3 604.4 605.0 13038.3 13051.0 13059.0 13070.5 13219.7 11476.7 12022.0 12292.0 12343.7 12387.9 9909.3 10078.5 10078.9 10101.7 10128.4 4150.1 4172.7 4178.4 4243.0 4277.9 59489.1 59667.0 59888.0 60294.7 60311.7 9175.3 9262.2 9334.3 9728.0 9747.8 16057.4 16119.3 16121.2 16158.4 16365.3 6665.2 6793.5 6804.2 6810.7 6829.4 3775.9 3787.9 3789.2 3823.2 3930.7 2804.2 2875.6 2904.0 2905.0 2907.9 481.5 486.6 487.3 492.5 493.0 464.8 482.2 491.5 498.3 509.8 7253.6 7354.2 8313.6 9016.5 9387.3 561.6 574.7 598.3 625.2 626.2 3804.2 3837.9 3966.7 3999.9 4183.2 91521.0 94053.5 94307.5 94525.5 94528.5 76774.6 77702.6 79694.6 80208.0 80829.0 59102.7 60712.7 69619.0 70092.0 70595.0 8075.3 8104.6 8106.2 8169.3 8224.8 39294.6 40252.4 41877.8 42938.6 44489.0 35423.0 39619.6 45285.8 60940.4 61757.0 10120.2 10260.8 10316.2 10629.4 10712.6 13061.8 13213.0 13285.0 13305.9 13424.9 11646.4 12003.8 12087.8 12468.9 12859.7 10894.8 11085.3 11218.4 11610.1 11977.2 10490.5 10718.5 10745.1 10856.7 11111.6 9822.3 9949.5 9975.2 10326.3 10674.9 9486.8 9897.0 10092.5 10139.4 10224.5 07:54:47 INFO - PROCESS | 8777 | -------- Summary: end -------- 07:54:47 INFO - PROCESS | 8777 | 07:54:47 INFO - TEST-INFO | 8777: exit 0 07:54:47 INFO - TEST-OK | dromaeo_css | took 1120388ms 07:54:47 INFO - TEST-START | kraken 07:54:47 INFO - operating with platform_type : linux_ 07:54:47 INFO - Initialising browser for kraken test... 07:54:47 INFO - TEST-INFO | started process 8956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1UVvr2/profile http://localhost:43127/getInfo.html) 07:54:52 INFO - PROCESS | 8956 | __metrics Screen width/height:1600/1200 07:54:52 INFO - PROCESS | 8956 | colorDepth:24 07:54:52 INFO - PROCESS | 8956 | Browser inner width/height: 1024/697 07:54:52 INFO - PROCESS | 8956 | __metrics 07:54:53 INFO - PROCESS | 8956 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:54:54 INFO - TEST-INFO | 8956: exit 0 07:54:54 INFO - Browser initialized. 07:54:54 INFO - Running cycle 1/1 for kraken test... 07:54:54 INFO - TEST-INFO | started process 9036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1UVvr2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:06 INFO - PROCESS | 9036 | RSS: Main: 175091712 07:55:06 INFO - PROCESS | 9036 | 07:55:08 INFO - PROCESS | 9036 | Cycle 1(1): loaded http://localhost:43127/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43127/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:09 INFO - PROCESS | 9036 | RSS: Main: 233902080 07:55:09 INFO - PROCESS | 9036 | 07:55:12 INFO - PROCESS | 9036 | Cycle 1(1): loaded http://localhost:43127/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43127/tests/kraken/driver.html?testName=audio-dft) 07:55:13 INFO - PROCESS | 9036 | RSS: Main: 221319168 07:55:13 INFO - PROCESS | 9036 | 07:55:16 INFO - PROCESS | 9036 | Cycle 1(1): loaded http://localhost:43127/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43127/tests/kraken/driver.html?testName=audio-fft) 07:55:17 INFO - PROCESS | 9036 | RSS: Main: 288845824 07:55:17 INFO - PROCESS | 9036 | 07:55:19 INFO - PROCESS | 9036 | Cycle 1(1): loaded http://localhost:43127/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43127/tests/kraken/driver.html?testName=audio-oscillator) 07:55:19 INFO - PROCESS | 9036 | RSS: Main: 199372800 07:55:19 INFO - PROCESS | 9036 | 07:55:22 INFO - PROCESS | 9036 | Cycle 1(1): loaded http://localhost:43127/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43127/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:55:22 INFO - PROCESS | 9036 | RSS: Main: 203079680 07:55:22 INFO - PROCESS | 9036 | 07:55:25 INFO - PROCESS | 9036 | Cycle 1(1): loaded http://localhost:43127/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43127/tests/kraken/driver.html?testName=imaging-darkroom) 07:55:26 INFO - PROCESS | 9036 | RSS: Main: 239669248 07:55:26 INFO - PROCESS | 9036 | 07:55:29 INFO - PROCESS | 9036 | Cycle 1(1): loaded http://localhost:43127/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43127/tests/kraken/driver.html?testName=imaging-desaturate) 07:55:30 INFO - PROCESS | 9036 | RSS: Main: 235216896 07:55:30 INFO - PROCESS | 9036 | 07:55:33 INFO - PROCESS | 9036 | Cycle 1(1): loaded http://localhost:43127/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43127/tests/kraken/driver.html?testName=json-parse-financial) 07:55:34 INFO - PROCESS | 9036 | RSS: Main: 238182400 07:55:34 INFO - PROCESS | 9036 | 07:55:35 INFO - PROCESS | 9036 | Cycle 1(1): loaded http://localhost:43127/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43127/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:55:36 INFO - PROCESS | 9036 | RSS: Main: 225132544 07:55:36 INFO - PROCESS | 9036 | 07:55:38 INFO - PROCESS | 9036 | Cycle 1(1): loaded http://localhost:43127/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43127/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:55:38 INFO - PROCESS | 9036 | RSS: Main: 229347328 07:55:38 INFO - PROCESS | 9036 | 07:55:41 INFO - PROCESS | 9036 | Cycle 1(1): loaded http://localhost:43127/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43127/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:55:41 INFO - PROCESS | 9036 | RSS: Main: 236744704 07:55:41 INFO - PROCESS | 9036 | 07:55:44 INFO - PROCESS | 9036 | Cycle 1(1): loaded http://localhost:43127/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:55:45 INFO - PROCESS | 9036 | RSS: Main: 238931968 07:55:45 INFO - PROCESS | 9036 | 07:55:48 INFO - PROCESS | 9036 | Cycle 1(1): loaded http://localhost:43127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:55:48 INFO - PROCESS | 9036 | RSS: Main: 238092288 07:55:48 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | Cycle 1(1): loaded http://localhost:43127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43127/tests/kraken/driver.html?testName=ai-astar) 07:55:50 INFO - PROCESS | 9036 | RSS: Main: 281415680 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | __start_tp_report 07:55:50 INFO - PROCESS | 9036 | _x_x_mozilla_page_load 07:55:50 INFO - PROCESS | 9036 | _x_x_mozilla_page_load_details 07:55:50 INFO - PROCESS | 9036 | |i|pagename|runs| 07:55:50 INFO - PROCESS | 9036 | |0;ai-astar;103;115;113;114;113;114;113;115;113;113 07:55:50 INFO - PROCESS | 9036 | |1;audio-beat-detection;173;131;129;180;137;137;155;130;161;136 07:55:50 INFO - PROCESS | 9036 | |2;audio-dft;165;162;162;163;162;163;162;162;162;162 07:55:50 INFO - PROCESS | 9036 | |3;audio-fft;75;75;76;101;75;75;75;75;105;75 07:55:50 INFO - PROCESS | 9036 | |4;audio-oscillator;87;86;115;86;86;86;119;86;86;124 07:55:50 INFO - PROCESS | 9036 | |5;imaging-gaussian-blur;117;117;116;116;116;117;117;116;117;117 07:55:50 INFO - PROCESS | 9036 | |6;imaging-darkroom;145;146;146;146;146;145;145;145;145;145 07:55:50 INFO - PROCESS | 9036 | |7;imaging-desaturate;95;95;95;95;94;95;95;94;95;95 07:55:50 INFO - PROCESS | 9036 | |8;json-parse-financial;64;64;65;63;63;65;63;65;65;65 07:55:50 INFO - PROCESS | 9036 | |9;json-stringify-tinderbox;65;65;65;74;67;66;66;65;66;65 07:55:50 INFO - PROCESS | 9036 | |10;stanford-crypto-aes;84;88;82;82;82;84;84;83;119;91 07:55:50 INFO - PROCESS | 9036 | |11;stanford-crypto-ccm;136;144;128;134;134;140;128;133;141;130 07:55:50 INFO - PROCESS | 9036 | |12;stanford-crypto-pbkdf2;170;168;167;169;166;164;165;178;172;174 07:55:50 INFO - PROCESS | 9036 | |13;stanford-crypto-sha256-iterative;70;68;68;67;68;70;69;67;66;66 07:55:50 INFO - PROCESS | 9036 | __end_tp_report 07:55:50 INFO - PROCESS | 9036 | __start_cc_report 07:55:50 INFO - PROCESS | 9036 | _x_x_mozilla_cycle_collect,1876 07:55:50 INFO - PROCESS | 9036 | __end_cc_report 07:55:50 INFO - PROCESS | 9036 | __startTimestamp1466693750789__endTimestamp 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | ------- Summary: start ------- 07:55:50 INFO - PROCESS | 9036 | Number of tests: 14 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.50 stddev:3.47 (3.1%) stddev-sans-first:0.87 07:55:50 INFO - PROCESS | 9036 | Values: 103.0 115.0 113.0 114.0 113.0 114.0 113.0 115.0 113.0 113.0 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:146.00 stddev:18.90 (12.9%) stddev-sans-first:17.53 07:55:50 INFO - PROCESS | 9036 | Values: 173.0 131.0 129.0 180.0 137.0 137.0 155.0 130.0 161.0 136.0 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:0.44 07:55:50 INFO - PROCESS | 9036 | Values: 165.0 162.0 162.0 163.0 162.0 163.0 162.0 162.0 162.0 162.0 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:11.80 (15.7%) stddev-sans-first:12.33 07:55:50 INFO - PROCESS | 9036 | Values: 75.0 75.0 76.0 101.0 75.0 75.0 75.0 75.0 105.0 75.0 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:86.00 stddev:16.18 (18.8%) stddev-sans-first:16.82 07:55:50 INFO - PROCESS | 9036 | Values: 87.0 86.0 115.0 86.0 86.0 86.0 119.0 86.0 86.0 124.0 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:55:50 INFO - PROCESS | 9036 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:55:50 INFO - PROCESS | 9036 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:55:50 INFO - PROCESS | 9036 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 07:55:50 INFO - PROCESS | 9036 | Values: 64.0 64.0 65.0 63.0 63.0 65.0 63.0 65.0 65.0 65.0 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:2.76 (4.2%) stddev-sans-first:2.88 07:55:50 INFO - PROCESS | 9036 | Values: 65.0 65.0 65.0 74.0 67.0 66.0 66.0 65.0 66.0 65.0 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:84.00 stddev:11.31 (13.5%) stddev-sans-first:11.91 07:55:50 INFO - PROCESS | 9036 | Values: 84.0 88.0 82.0 82.0 82.0 84.0 84.0 83.0 119.0 91.0 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:135.00 stddev:5.49 (4.1%) stddev-sans-first:5.81 07:55:50 INFO - PROCESS | 9036 | Values: 136.0 144.0 128.0 134.0 134.0 140.0 128.0 133.0 141.0 130.0 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.50 stddev:4.35 (2.6%) stddev-sans-first:4.60 07:55:50 INFO - PROCESS | 9036 | Values: 170.0 168.0 167.0 169.0 166.0 164.0 165.0 178.0 172.0 174.0 07:55:50 INFO - PROCESS | 9036 | 07:55:50 INFO - PROCESS | 9036 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.45 (2.1%) stddev-sans-first:1.32 07:55:50 INFO - PROCESS | 9036 | Values: 70.0 68.0 68.0 67.0 68.0 70.0 69.0 67.0 66.0 66.0 07:55:50 INFO - PROCESS | 9036 | -------- Summary: end -------- 07:55:50 INFO - PROCESS | 9036 | 07:55:51 INFO - TEST-INFO | 9036: exit 0 07:55:51 INFO - TEST-OK | kraken | took 64149ms 07:55:51 INFO - SUITE-END | took 1184s 07:55:51 INFO - Completed test suite (00:19:44) 07:55:51 INFO - javascript benchmark 07:55:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2620.1091628846193, 2631.8026148038903, 2661.095227622608, 2668.0128352509573, 2673.705892351841, 4609.216433206355, 4640.09518143962, 4715.905681886365, 4782.306565547998, 4803.039392121576, 4714.9057018859685, 4725.078609671115, 4745.644076694244, 4771.570558649721, 4781.617470602352, 4129.587041295877, 4276.615104640582, 4364.061726728753, 4388.75861827601, 4484.551544845522, 4412.0955204183065, 4445.377647129404, 4456.17560751262, 4462.843800466984, 4488.371627972087, 4226.746395216297, 4269.935950960738, 4272.060146767706, 4312.504062032875, 4327.675424343187, 4311.353297005474, 4321.697481176319, 4324.610785029363, 4360.193364227596, 4383.956160438387, 4344.89137771555, 4358.019445624741, 4366.0, 4394.71434356769, 4412.360207769888, 4586.977065114686, 4663.253879379283, 4715.693479923794, 4730.314104454869, 4750.572448479654, 5084.288199652052, 5101.770420331094, 5125.3080834087295, 5158.535731784157, 5201.635885488017, 5197.168453047494, 5227.921581176285, 5230.320058392384, 5231.738413079369, 5236.476352364771, 4639.095376401637, 4655.557722016403, 4727.149113159596, 4734.384530011145, 4807.254875494234, 5234.319538459976, 5261.815836445706, 5263.815766448232, 5265.9736701317015, 5269.446708095671, 4829.9034019319415, 4999.550040496373, 5046.016026874724, 5047.293378926953, 5053.444121146671, 5009.223570346602, 5054.9241761373605, 5057.544820966131, 5116.692998420107, 5142.5628821549835, 5030.647854650139, 5036.974815125901, 5041.092603331363, 5041.747912604428, 5091.363579552556, 5002.974985125051, 5008.799648014112, 5017.974910125426, 5020.3724534433195, 5025.949740502621, 4226.936595951063, 4259.574042595716, 4261.0, 4316.093620339764, 4324.048709283952, 3764.604716504782, 3793.1275806564645, 3805.5813860475328, 3809.466674665549, 3810.599887011879, 4292.313229883203, 4300.333448315516, 4305.311150216013, 4312.935305970413, 4364.738115713068, 5063.594912406998, 5076.644634875597, 5078.97460512695, 5080.339555857715, 5128.512791284822, 4321.330193819963, 4331.0904710011255, 4331.285337919208, 4333.15503476819, 4341.240282950471, 4408.4269045024585, 4463.553644635575, 4578.793954272066, 4592.2422800238255, 4620.1221767864, 4773.212419950669, 4780.163471392492, 4795.20879054952, 4795.496472870298, 4820.855374338776, 5117.2068329409, 5119.846404607868, 5130.179171332569, 5130.204818253177, 5183.870403239949, 4637.118947399983, 4709.3642358281195, 4716.882077948078, 4759.76201189946, 4782.450018247946, 4990.301357809982, 5014.566787723995, 5017.37282839645, 5020.447750747488, 5063.8480845574695, 4887.535684110146, 5090.490950905028, 5101.183810590288, 5103.693778373309, 5157.226416037474, 4935.0, 4957.157283261782, 4985.1276026695905, 4986.850394488171, 5008.799648014038, 4999.975000124976, 5006.949930500648, 5009.624278179078, 5009.899802004013, 5061.822836200715, 4727.3854398927915, 4823.252395878644, 4938.827141050046, 4950.554450099508, 4981.925271121008, 4937.185364414831, 4984.352034235526, 5001.399832020181, 5007.499250074963, 5060.418051924076, 4891.5353041461, 4892.633052521004, 4901.877453063702, 4908.656394052525, 4949.727764972817], "value": 4661.460792691765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.8021667451719, 574.8534123798431, 586.4428792646986, 588.3645662684302, 598.3119412675422, 27550.724492755093, 41110.17779644409, 42008.579914200884, 42045.0, 42083.15833683324, 41675.79162104193, 42316.36525452113, 42316.788416057956, 42343.0, 42380.57619423805, 7568.848623027564, 7712.4215683823795, 7759.0, 7768.456208065438, 7908.52548847071, 7628.6567104480155, 10065.597376104946, 10346.844797328045, 10359.27485076045, 10684.03843654071, 10039.196864250878, 10052.346597471178, 10074.194064474861, 10089.394636321844, 10113.544890479947, 7630.694772209105, 10147.289689721723, 10250.282480226388, 10338.586456541729, 10341.06930376266, 9725.319227654067, 10036.347637403545, 10036.799264014751, 10037.447940363278, 10050.246231532592, 38855.41716874249, 39042.21915561673, 39132.41301380481, 39134.804325978475, 39153.80423097866, 3185.6336521300113, 3224.871005159791, 3229.9192520187185, 3429.005588379367, 3725.5343082114737, 30191.245218869703, 30267.394652106836, 30426.239344016354, 30722.23194420135, 30752.692473075207, 3535.876244331436, 3540.6636369544854, 3574.231540218839, 3596.0, 3635.72732045095, 253079.0, 253409.0, 253935.0, 254569.0, 254611.0, 27194.728052719616, 27646.585301220097, 27761.722382775915, 54215.72892135514, 54769.0, 31680.524792128137, 32165.678343216736, 32207.677923220468, 32286.19284517859, 32378.0, 13349.0, 13509.121907076009, 13518.59444216675, 13526.053176277566, 13526.729465410637, 9849.60601575929, 11229.66311010671, 11308.660740177807, 11331.0, 11515.30908145514, 7934.880976785353, 7957.204279571996, 8013.919860801434, 8036.196380361917, 8079.919200807916, 3035.165329534396, 3070.1096681962426, 3129.499280115216, 3131.3580715953176, 3137.5607414961923, 891.3047822698176, 907.6414816147585, 945.8864936207561, 948.4641177734558, 1015.5430056474615, 28515.57226641602, 29202.561961570595, 29447.454171081543, 29867.10398688043, 29867.253318667208, 939.5020639061308, 949.5442187749919, 952.0764858087643, 1024.8206563851297, 1071.5820829876354, 15112.848871511364, 15209.239538023054, 15267.312970916113, 15335.61660958485, 15664.530064098095, 422023.0, 425543.0, 426818.0, 427583.0, 427593.0, 50286.49713502891, 51117.488825112014, 51150.23274650883, 51306.48693513017, 51370.22944655833, 1078.3745427651943, 1105.6130354375905, 1109.5062697099875, 1191.3566673996118, 1209.0327737809716, 24063.398415039064, 31239.375212496077, 31372.529412059295, 31512.68487315189, 31765.682343177195, 47585.286220706024, 47987.0, 48122.518774811804, 48204.27693584669, 48299.275510868065, 353056.0, 354629.0, 354820.0, 354967.0, 355108.0, 24998.125065622615, 25070.22297963401, 25858.0, 25894.611580825927, 25935.0, 42787.7860610695, 42877.0, 42908.35637465503, 43113.56886431095, 43986.0, 36595.63404365922, 37069.4439583401, 37087.629123708415, 37128.257434851694, 37488.43767343547, 35616.287674245854, 36471.27057458889, 36607.63392366149, 36653.26693466063, 37115.44326835153, 36100.09749756277, 36113.27773444569, 36409.63590364062, 36635.45046824247, 36876.0, 32029.35941281208, 32289.192770180933, 32800.83599581987, 32961.1277828181, 33527.16182095467, 25482.0, 25593.360165995255, 25605.0, 25807.225783226535, 26113.608295875958], "value": 17172.059063947774, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.6783268138423, 382.7492992090182, 384.36387778227044, 392.6838894689774, 400.9919801603968, 15863.841361586381, 17819.73270400945, 18008.729869051975, 18009.0, 18009.54976125596, 16727.0, 17152.485425437226, 17323.39368122116, 17533.0, 17607.383741569047, 4918.065567542165, 5109.054824857413, 5147.81982630608, 5152.896942061157, 5172.327597412331, 3769.5853456119803, 3860.5946375630574, 3923.3722604383306, 6095.878082438348, 6096.0, 6114.0, 6139.8772024559485, 6161.0, 6162.044883043135, 6169.0, 5914.201582786333, 6056.60632058917, 6059.909101363483, 6060.757569697207, 6075.149479072933, 3429.5713035870517, 5020.723860187688, 5336.359636843565, 5338.97330513345, 5364.034473794715, 20004.89997550003, 20875.0, 20904.0, 20936.0, 20968.89515552428, 1916.6645836978473, 2058.3516192399347, 2074.6576814825535, 2246.3597874605657, 2434.0993832281993, 9005.144511271485, 9178.86231706525, 9576.952115239379, 9744.853827192597, 12842.871571284355, 1704.8891822031528, 1717.1671739206474, 1724.2154819557072, 1808.9366872159542, 1833.1659095111693, 50662.453380617, 57184.0, 63124.684376577825, 63175.0, 63938.0, 9991.550380232908, 10161.288709790244, 10187.898121018696, 10297.279190456597, 10300.639477618248, 13689.31553422325, 13735.313234338442, 13995.930020350037, 14009.649758756113, 14015.719685606231, 7150.5352152109945, 7281.854362912712, 7349.154847192534, 7350.7427240046345, 7421.962890185515, 6906.930930690729, 7055.118110236221, 7085.53943993649, 7121.786346409616, 7172.246914074051, 4385.780710964503, 4408.867733967986, 4460.955390446119, 4529.456465224128, 4538.819906824184, 1801.8378345948927, 1811.9728204076948, 1814.5917168637216, 1857.4149143019906, 1893.2616279650947, 821.256762629821, 821.6754382019188, 890.973270801877, 891.9286457083417, 894.2220268366563, 17308.0, 17370.39203627867, 17453.389131380594, 17468.12659367052, 17790.199441025186, 809.8218391953878, 812.4191203289677, 814.9755507334789, 844.3161039557978, 855.5080828523623, 9552.616629625574, 9744.464054477072, 9856.162226210852, 9890.554925028391, 9960.252981026308, 305183.0, 308709.0, 392262.0, 394598.0, 394908.0, 49812.0, 64223.678881605294, 72562.0, 83026.58486707527, 86981.0, 875.9824803503894, 903.8734577159203, 927.8005228875824, 928.3872644054892, 930.7207837648814, 15900.681986359976, 16126.596835079217, 16135.919320403324, 16241.756373654642, 16298.348066077224, 26661.866690666422, 27228.0, 36983.63016369802, 37382.25235495329, 38042.239155216186, 52255.477445225064, 53182.73408632932, 53466.0, 54477.45522544882, 54592.727036364566, 7529.58587277705, 7637.274458926393, 7665.578393188428, 7708.922910770821, 7834.451588388758, 11595.362255076052, 11608.071354291467, 11662.53349865996, 11969.700757481132, 11984.10119241043, 10060.849087263843, 10210.948945255226, 10277.588896444058, 10391.792164156523, 10510.1066409353, 9163.129502697233, 10311.845322320021, 10336.379817210991, 10541.104006159563, 10552.208584356358, 10036.347637403545, 10107.7473063174, 10177.542010609688, 10207.387556746618, 10318.329308594917, 6719.496037797087, 7598.35413989795, 7634.580098094658, 7680.270374314431, 7951.324137448381, 8630.611622477129, 9270.44377337362, 9978.301518893608, 10042.69871903844, 10235.84646230322], "value": 8214.584976938557, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1158.4786845919339, 1317.440087962616, 1355.4984655677397, 1397.8881689464845, 1662.4430815676749, 6631.237407698116, 7527.096748390194, 7776.300132988037, 7783.844323113534, 7995.640196191171, 7701.691932322715, 7840.607969601526, 7853.450258481908, 7854.450188486809, 7858.646360913758, 2163.859349142305, 2171.240065976903, 2174.0542863854193, 2181.8472706910525, 2192.725909261342, 2149.1296025109855, 2185.1914791527156, 2188.9452763680956, 2192.583409152256, 2193.320070778056, 2165.2746329979477, 2179.727534058243, 2185.25701261571, 2190.5837890800776, 2195.3413975807275, 2123.7451505819245, 2126.5959467701086, 2126.914923403062, 2130.1585873579847, 2132.2110818996916, 2066.73132492775, 2105.610462064523, 2108.746950365966, 2111.68324751287, 2112.4824418017683, 7608.31525162738, 7826.608669566499, 7866.213378662145, 7868.0, 7888.447808653396, 4533.6146427553695, 4640.582347588699, 4666.813327466897, 4683.859484215479, 4689.765511724434, 2769.2661444717164, 2947.882084716609, 3015.020118461487, 3030.5454181872674, 3038.225252560605, 938.9108034736689, 950.8573713942894, 963.6771681486711, 969.6412327438823, 976.3702411944328, 10583.788324233548, 10702.197335199891, 10706.73233169177, 10708.0, 10735.892641073646, 4099.9180016400105, 4180.602842729936, 4192.413062171298, 4346.913061738747, 4361.433013708261, 8087.757367278991, 8135.75592732219, 8148.307393871587, 8164.306033987177, 8166.060902996112, 4681.882952926204, 4683.297505374153, 4683.414573178353, 4683.859484215411, 4688.413948256468, 3647.3070116677745, 3647.635236476331, 4327.3725309830525, 4373.409589705413, 4373.606375426227, 3405.267867408519, 3491.650834916488, 3492.353914525821, 3525.506429099928, 3561.8041007744305, 1027.1782573940818, 1068.2468859454066, 1070.7055559721139, 1074.521837782195, 1076.6016573867719, 757.8863170524465, 776.7359097906626, 787.4291138924349, 797.960101994898, 805.8428606421692, 4800.615950723934, 5022.673526220857, 5046.697198168122, 5077.619178561623, 5113.0, 418.2742940997367, 430.1139652316176, 433.2785911457388, 438.9451318585177, 443.2265696359873, 3221.5811944447073, 3322.667733226658, 3379.391709492315, 3432.982835085809, 3494.2487365216602, 9495.90504094964, 9773.0, 9783.461909594898, 9847.55685994132, 9864.309498335191, 9590.280728945358, 9882.308238423386, 9883.555240014217, 9890.703278901645, 9892.307538472238, 7350.485466017434, 7360.926390736131, 7442.590657513889, 7461.962690186514, 7542.170361260257, 4973.47778483254, 4988.351514303263, 5061.9493805061475, 5077.933633936915, 5105.846824595268, 8847.778805529913, 9024.052474490083, 9150.63397464094, 9155.404898681565, 9196.0, 9169.312301577274, 9263.258939284706, 9378.859317110386, 9391.530423478662, 9441.433513988908, 5658.321001479849, 5901.3213480448585, 5901.3213480450295, 6031.7587296507645, 6233.719482623203, 7497.137829149718, 7595.506292090997, 7596.164421913474, 7598.658060387185, 7599.316061554487, 6510.0885875976455, 6695.196576410862, 6706.128203333536, 6747.6626168692355, 6881.4494840413645, 6753.1220941277315, 6788.389044985975, 6810.318968103348, 6837.247902730596, 6920.273371295942, 5846.503047241032, 5855.121731740102, 5909.881802364014, 5930.911036334544, 5947.643141411356, 4336.284513055437, 4338.219120558204, 4450.510443851239, 4458.152950939311, 4510.887227819331, 4300.892477688083, 4357.9782101089295, 4382.5179230284, 4441.311596702516, 4499.987502811972], "value": 3987.10078961959, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.9088882446441, 298.36001776190074, 299.8905399529172, 303.4552977405557, 304.57968004154264, 4867.9533900211445, 4905.3132561441425, 4928.778204980776, 4934.5080734229205, 4938.728369939652, 4849.418069831625, 4866.1484240257905, 4881.682690625107, 4891.144049791281, 4894.2413925841465, 3578.4095624221973, 3713.740038197327, 3743.5133432653715, 3774.6602805747475, 3796.278707045666, 3758.8308526116252, 3807.438950030488, 3810.1808111256073, 3812.2184952084895, 3815.3323168445413, 3768.3028639701743, 3768.660820526166, 3769.4157405602177, 3780.395136778116, 3787.3561494545993, 3544.4860495228177, 3710.628937106295, 3795.4686343911876, 3810.894840496253, 3842.3275926712995, 3358.9496157557655, 3372.106391806173, 3375.6455572164814, 3390.4066788312193, 3410.5054767058887, 4724.622030237572, 4743.905121897577, 4755.358026666425, 4776.976115119437, 4791.496892826272, 4193.322670931651, 4387.62705170061, 4420.4253447052, 4429.029082058485, 4463.263561512346, 5126.410462796752, 5153.845384638467, 5156.5561642740095, 5173.560247378978, 5174.689518628894, 3763.5671897731563, 3766.868159614428, 3772.3021241070214, 3774.0, 3774.6602805747616, 5116.692998420107, 5368.892622147574, 5397.595180361489, 5404.702741349224, 5409.810656627039, 3810.4279611262286, 3829.368154254517, 3832.674222691047, 3840.347140986039, 3842.1739326045035, 3850.403187505941, 3893.9097052824686, 3894.532656081288, 3902.8829135125993, 3914.9233960660476, 4365.236083685342, 4375.78121093944, 4380.3210502372185, 4397.296432570837, 4422.402975598253, 4851.975740121276, 5123.538881500683, 5133.101707201225, 5136.486351364833, 5143.794248230104, 1295.4688577683105, 1301.7852054411105, 1301.99746195429, 1308.7905935050346, 1314.612189404128, 784.4626430894855, 805.7663277649533, 808.2160304504621, 827.5489858027389, 837.3468694418364, 4386.18855511725, 4508.436445444319, 4510.188166130062, 4524.2082635538645, 4525.230710779176, 5268.235141227655, 5277.498637629419, 5308.522232998971, 5313.459096861944, 5319.468053194727, 4492.573205545468, 4498.280275156025, 4506.662000349987, 4512.548745125527, 4512.9774351128035, 2650.787936965038, 2831.830090194595, 2852.6434195725533, 2862.8997985070837, 2865.140457862633, 4937.21004639256, 4954.5540901319055, 4967.5032496750755, 4995.8526128539515, 4999.475055119233, 5261.894762104736, 5436.238926550286, 5441.238226648273, 5460.5085542301385, 5464.371597266365, 4979.825706100269, 4982.081898469116, 4991.3511243538105, 4997.7251251180805, 5009.924851127236, 5333.173358129496, 5333.639921819911, 5343.332083489564, 5345.262789593476, 5348.545373643284, 4914.287428322945, 5138.332016837787, 5218.791248350023, 5223.869403264949, 5224.190250511177, 4930.728809915346, 4963.776630051584, 4967.975160124176, 4969.204927211629, 4971.726555039508, 3418.3505134024454, 3466.561377028505, 3470.340635279289, 3470.670286322795, 3473.6552826842285, 4579.473360563577, 4711.693739906895, 4712.858614241578, 4733.337332773345, 4749.738764367993, 4582.625212436323, 4648.65135114861, 4649.953500465087, 4671.252599584051, 4680.268300728752, 4560.931586026146, 4606.355110284496, 4611.884702882455, 4621.69958952667, 4622.838200662961, 4230.5769423057445, 4548.658850586286, 4549.294859296814, 4563.475200351869, 4568.862934111982, 4602.941323495548, 4925.8029678812445, 4933.013397320622, 5196.480351964925, 5212.635115541876, 5081.450157701936, 5082.33929589151, 5094.363204599425, 5095.87260318495, 5096.362954630671], "value": 3808.8502008409173, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.288903539001, 651.0429668387469, 681.4344094401644, 736.9742059027935, 752.6179641434858, 12097.334646594434, 13017.02372322076, 13026.218426894393, 14974.475893343735, 15596.0, 14619.853801461983, 14772.926135369307, 14862.554123376316, 14871.0, 14875.107493550395, 624.4723208888482, 771.7761849063764, 791.1416113516826, 800.5156880087551, 802.7832485228985, 787.6180052674448, 788.7160622176012, 791.89309443225, 793.0364607002491, 793.2900054451262, 810.1857633078747, 812.6302532347797, 813.1461964936822, 813.5078277642031, 813.6216659253446, 654.6170490263202, 670.2225418514499, 672.2067959807425, 672.4183581202274, 809.3767798794925, 588.6762280745572, 599.7271241585069, 601.2664549249909, 604.4076804731344, 605.0108073300142, 13038.282894440801, 13051.0, 13059.0, 13070.477180912752, 13219.669508262274, 11476.71308217293, 12022.0, 12292.0, 12343.691407714789, 12387.93806030973, 9909.306348555603, 10078.546465409074, 10078.899211007869, 10101.747456313651, 10128.392296462236, 4150.128473020669, 4172.666186705087, 4178.435911152016, 4242.957570424287, 4277.850275240352, 59489.10766338508, 59667.0, 59888.0, 60294.698526507964, 60311.69844150751, 9175.265978721687, 9262.212711919563, 9334.253259739204, 9727.951360243154, 9747.805043899083, 16057.437989670305, 16119.27463264156, 16121.193940302937, 16158.353665853234, 16365.263563139688, 6665.200175978816, 6793.5244532882225, 6804.183497980274, 6810.727570897108, 6829.351211634887, 3775.9244815103543, 3787.9431808522895, 3789.1853251550497, 3823.2162406706557, 3930.685545156438, 2804.1587523743206, 2875.61179240804, 2904.0126357038707, 2904.9854750726113, 2907.88368465259, 481.52569718826925, 486.55237181792126, 487.28369297133156, 492.4804331430304, 493.0188924041132, 464.83963032753644, 482.15141351222104, 491.5183120541889, 498.27003439960635, 509.8368522072901, 7253.5647861127445, 7354.227806080392, 8313.625886835107, 9016.504092274856, 9387.29595280343, 561.581621691834, 574.6523353371234, 598.3478008970243, 625.1778910732372, 626.1671976271548, 3804.1630841214887, 3837.884863454101, 3966.7223294369696, 3999.8600048998146, 4183.205191013698, 91521.0, 94053.52973235227, 94307.52846235862, 94525.5273723627, 94528.52735736415, 76774.616126919, 77702.61148694334, 79694.60152699199, 80208.0, 80829.0, 59102.70448647729, 60712.69643651754, 69619.0, 70092.0, 70595.0, 8075.273225409741, 8104.635291411782, 8106.189381061847, 8169.2647661710735, 8224.83550329002, 39294.607053929096, 40252.3962140574, 41877.79061104675, 42938.57061429346, 44489.0, 35423.0, 39619.603803962746, 45285.77357113325, 60940.39059609347, 61757.0, 10120.190384769348, 10260.794784104426, 10316.17470602365, 10629.415382154055, 10712.571497140027, 13061.804072939103, 13213.0, 13285.003624727991, 13305.866941330463, 13424.865751342362, 11646.35945022998, 12003.75992480163, 12087.818682719942, 12468.875311246771, 12859.742805144031, 10894.836577451502, 11085.334879906908, 11218.382988935688, 11610.12924030718, 11977.161598688008, 10490.475476226311, 10718.517666704862, 10745.140388768723, 10856.728581785519, 11111.611093611686, 9822.312438129262, 9949.493446055149, 9975.203332671974, 10326.277160598986, 10674.89325106739, 9486.810263794823, 9896.950515247378, 10092.545835437277, 10139.391636501834, 10224.488775561043], "value": 6397.95548622333, "unit": "score"}], "name": "dromaeo_css", "value": 6322.838115305731, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 113.0, 114.0, 113.0, 114.0, 113.0, 115.0, 113.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 131.0, 129.0, 180.0, 137.0, 137.0, 155.0, 130.0, 161.0, 136.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 163.0, 162.0, 163.0, 162.0, 162.0, 162.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 101.0, 75.0, 75.0, 75.0, 75.0, 105.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 115.0, 86.0, 86.0, 86.0, 119.0, 86.0, 86.0, 124.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 63.0, 63.0, 65.0, 63.0, 65.0, 65.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 74.0, 67.0, 66.0, 66.0, 65.0, 66.0, 65.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 82.0, 82.0, 82.0, 84.0, 84.0, 83.0, 119.0, 91.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 144.0, 128.0, 134.0, 134.0, 140.0, 128.0, 133.0, 141.0, 130.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 167.0, 169.0, 166.0, 164.0, 165.0, 178.0, 172.0, 174.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 67.0, 68.0, 70.0, 69.0, 67.0, 66.0, 66.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1546.1000000000001, "alertThreshold": 2.0}]} 07:55:52 INFO - Return code: 0 07:55:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:55:52 INFO - # TBPL SUCCESS # 07:55:52 INFO - Running post-action listener: _resource_record_post_action 07:55:52 INFO - ##### 07:55:52 INFO - ##### Finished run-tests step (success) 07:55:52 INFO - ##### 07:55:52 INFO - Running post-run listener: _resource_record_post_run 07:55:52 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 538779648; Read time: 216; Write time: 704448 07:55:52 INFO - TinderboxPrint: CPU usage
13.2% 07:55:52 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 216 07:55:52 INFO - TinderboxPrint: I/O write bytes / time
538,779,648 / 704,448 07:55:52 INFO - TinderboxPrint: CPU idle
8,321.2 (86.7%) 07:55:52 INFO - TinderboxPrint: CPU user
1,220.4 (12.7%) 07:55:52 INFO - TinderboxPrint: Swap in / out
0 / 0 07:55:52 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 244092928; Read time: 0; Write time: 436128 07:55:52 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288546816; Read time: 216; Write time: 256988 07:55:52 INFO - Running post-run listener: _upload_blobber_files 07:55:52 INFO - Blob upload gear active. 07:55:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:55:52 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 07:55:52 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'] 07:55:52 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 07:55:53 INFO - (blobuploader) - INFO - Open directory for files ... 07:55:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:55:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:55:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:58 INFO - (blobuploader) - INFO - Done attempting. 07:55:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:55:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:55:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:59 INFO - (blobuploader) - INFO - Done attempting. 07:55:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:55:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:56:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:00 INFO - (blobuploader) - INFO - Done attempting. 07:56:00 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:00 INFO - Return code: 0 07:56:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d4e74e52894a226e86703928866e411700ca5244886bdd12dd0d7814393caac34c6bd7bf16697ebed06916fdd48668c65e5b18cd7a99653581c1adc81d0f5ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/524e1a0616d7cb6028c581656ada2c47a2c6915c7120289a0e9f07b49efbf31f11634435fe7b34ad6f2fa2676c8f443228e98b54752d725baa13500fd49d6e6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79be1368976f1fd8c84cd0b28cc3f68fb508607c8af8be14a559b23817899d0477bb3ea71dac725d60d8bb94bccba45ffc2292d31cc7fa24766fd7200e4b4b25"} 07:56:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:00 INFO - Contents: 07:56:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d4e74e52894a226e86703928866e411700ca5244886bdd12dd0d7814393caac34c6bd7bf16697ebed06916fdd48668c65e5b18cd7a99653581c1adc81d0f5ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/524e1a0616d7cb6028c581656ada2c47a2c6915c7120289a0e9f07b49efbf31f11634435fe7b34ad6f2fa2676c8f443228e98b54752d725baa13500fd49d6e6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79be1368976f1fd8c84cd0b28cc3f68fb508607c8af8be14a559b23817899d0477bb3ea71dac725d60d8bb94bccba45ffc2292d31cc7fa24766fd7200e4b4b25"} 07:56:00 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:00 INFO - Copying logs to upload dir... 07:56:00 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.142289 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-23 07:56:00.090527) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 07:56:00.094856) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d4e74e52894a226e86703928866e411700ca5244886bdd12dd0d7814393caac34c6bd7bf16697ebed06916fdd48668c65e5b18cd7a99653581c1adc81d0f5ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/524e1a0616d7cb6028c581656ada2c47a2c6915c7120289a0e9f07b49efbf31f11634435fe7b34ad6f2fa2676c8f443228e98b54752d725baa13500fd49d6e6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79be1368976f1fd8c84cd0b28cc3f68fb508607c8af8be14a559b23817899d0477bb3ea71dac725d60d8bb94bccba45ffc2292d31cc7fa24766fd7200e4b4b25"} build_url:https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d4e74e52894a226e86703928866e411700ca5244886bdd12dd0d7814393caac34c6bd7bf16697ebed06916fdd48668c65e5b18cd7a99653581c1adc81d0f5ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/524e1a0616d7cb6028c581656ada2c47a2c6915c7120289a0e9f07b49efbf31f11634435fe7b34ad6f2fa2676c8f443228e98b54752d725baa13500fd49d6e6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79be1368976f1fd8c84cd0b28cc3f68fb508607c8af8be14a559b23817899d0477bb3ea71dac725d60d8bb94bccba45ffc2292d31cc7fa24766fd7200e4b4b25"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 07:56:00.128215) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:56:00.128840) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466692512.809201-1114774156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:56:00.211614) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 07:56:00.211996) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 07:56:00.212447) ========= ========= Total master_lag: 0.18 =========