builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1466682298.55 results: success (0) buildid: 20160623035624 builduid: 59198177c1bb4eb08d4eb98d356987bc revision: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 04:44:58.545720) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 04:44:58.546273) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 04:44:58.546589) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 04:44:58.562363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:44:58.562796) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 04:45:00-- 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 04:45:00 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114840 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:44:58.692388) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:44:58.692722) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017506 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:44:58.742456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:44:58.742808) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e --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 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e --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=e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 04:45:00,719 truncating revision to first 12 chars 2016-06-23 04:45:00,719 Setting DEBUG logging. 2016-06-23 04:45:00,719 attempt 1/10 2016-06-23 04:45:00,720 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3cdc8b1b2bb5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 04:45:01,023 unpacking tar archive at: fx-team-3cdc8b1b2bb5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628069 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:44:59.388127) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 04:44:59.388600) ========= script_repo_revision: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 04:44:59.389072) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 04:44:59.389384) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 04:44:59.400079) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-23 04:44:59.400384) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:45:01 INFO - MultiFileLogger online at 20160623 04:45:01 in /builds/slave/test 04:45:01 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 04:45:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:01 INFO - {'append_to_log': False, 04:45:01 INFO - 'base_work_dir': '/builds/slave/test', 04:45:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:45:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:01 INFO - 'branch': 'Fx-Team-Non-PGO', 04:45:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:01 INFO - 'config_files': ('talos/linux_config.py',), 04:45:01 INFO - 'default_actions': ('clobber', 04:45:01 INFO - 'read-buildbot-config', 04:45:01 INFO - 'download-and-extract', 04:45:01 INFO - 'populate-webroot', 04:45:01 INFO - 'create-virtualenv', 04:45:01 INFO - 'install', 04:45:01 INFO - 'run-tests'), 04:45:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:01 INFO - 'download_minidump_stackwalk': True, 04:45:01 INFO - 'download_symbols': 'ondemand', 04:45:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:01 INFO - 'installer_path': 'installer.exe', 04:45:01 INFO - 'log_level': 'info', 04:45:01 INFO - 'log_name': 'talos', 04:45:01 INFO - 'log_to_console': True, 04:45:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:45:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:45:01 INFO - 'opt_config_files': (), 04:45:01 INFO - 'pip_index': False, 04:45:01 INFO - 'sps_profile': False, 04:45:01 INFO - 'sps_profile_interval': 0, 04:45:01 INFO - 'suite': 'dromaeojs', 04:45:01 INFO - 'system_bits': '32', 04:45:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:01 INFO - 'title': 'talos-linux64-ix-067', 04:45:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:01 INFO - 'use_talos_json': True, 04:45:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:01 INFO - 'work_dir': 'build'} 04:45:01 INFO - ##### 04:45:01 INFO - ##### Running clobber step. 04:45:01 INFO - ##### 04:45:01 INFO - Running pre-action listener: _resource_record_pre_action 04:45:01 INFO - Running main action method: clobber 04:45:01 INFO - rmtree: /builds/slave/test/build 04:45:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:45:01 INFO - Running post-action listener: _resource_record_post_action 04:45:01 INFO - ##### 04:45:01 INFO - ##### Finished clobber step (success) 04:45:01 INFO - ##### 04:45:01 INFO - ##### 04:45:01 INFO - ##### Running read-buildbot-config step. 04:45:01 INFO - ##### 04:45:01 INFO - Running pre-action listener: _resource_record_pre_action 04:45:01 INFO - Running main action method: read_buildbot_config 04:45:01 INFO - Using buildbot properties: 04:45:01 INFO - { 04:45:01 INFO - "project": "", 04:45:01 INFO - "product": "firefox", 04:45:01 INFO - "script_repo_revision": "production", 04:45:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:45:01 INFO - "repository": "", 04:45:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:45:01 INFO - "buildid": "20160623035624", 04:45:01 INFO - "pgo_build": "False", 04:45:01 INFO - "basedir": "/builds/slave/test", 04:45:01 INFO - "buildnumber": 3108, 04:45:01 INFO - "slavename": "talos-linux64-ix-067", 04:45:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:45:01 INFO - "platform": "ubuntu64_hw", 04:45:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:45:01 INFO - "branch": "fx-team", 04:45:01 INFO - "repo_path": "integration/fx-team", 04:45:01 INFO - "revision": "3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e", 04:45:01 INFO - "stage_platform": "linux64", 04:45:01 INFO - "builduid": "59198177c1bb4eb08d4eb98d356987bc", 04:45:01 INFO - "slavebuilddir": "test" 04:45:01 INFO - } 04:45:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:45:01 INFO - Running post-action listener: _resource_record_post_action 04:45:01 INFO - ##### 04:45:01 INFO - ##### Finished read-buildbot-config step (success) 04:45:01 INFO - ##### 04:45:01 INFO - ##### 04:45:01 INFO - ##### Running download-and-extract step. 04:45:01 INFO - ##### 04:45:01 INFO - Running pre-action listener: _resource_record_pre_action 04:45:01 INFO - Running main action method: download_and_extract 04:45:01 INFO - mkdir: /builds/slave/test/build/tests 04:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:01 INFO - https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:45:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:45:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:45:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/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 04:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/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 04:45:02 INFO - Downloaded 1361 bytes. 04:45:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:45:02 INFO - Using the following test package requirements: 04:45:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:45:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:45:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:45:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:02 INFO - u'jsshell-linux-x86_64.zip'], 04:45:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:45:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:45:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:45:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:45:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:45:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:45:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:45:02 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')]} 04:45:02 INFO - https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:45:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:45:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:45:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/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 04:45:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/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 04:45:03 INFO - Downloaded 22709579 bytes. 04:45:03 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'] 04:45:03 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 04:45:05 INFO - Return code: 0 04:45:05 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 04:45:05 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')]} 04:45:05 INFO - https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:45:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:45:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:45:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/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 04:45:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/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 04:45:06 INFO - Downloaded 22709579 bytes. 04:45:06 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'] 04:45:06 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 04:45:07 INFO - Return code: 0 04:45:07 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')]} 04:45:07 INFO - https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:45:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:45:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:45:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/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 04:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/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 04:45:08 INFO - Downloaded 14405384 bytes. 04:45:08 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'] 04:45:08 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 04:45:08 INFO - Return code: 0 04:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:08 INFO - https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:45:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:45:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:45:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/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 04:45:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c8NxG4BHQBep-FfQsXvJnQ/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 04:45:13 INFO - Downloaded 56247220 bytes. 04:45:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:45:13 INFO - mkdir: /builds/slave/test/properties 04:45:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:45:13 INFO - Writing to file /builds/slave/test/properties/build_url 04:45:13 INFO - Contents: 04:45:13 INFO - build_url:https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:45:13 INFO - Running post-action listener: _resource_record_post_action 04:45:13 INFO - Running post-action listener: set_extra_try_arguments 04:45:13 INFO - ##### 04:45:13 INFO - ##### Finished download-and-extract step (success) 04:45:13 INFO - ##### 04:45:13 INFO - ##### 04:45:13 INFO - ##### Running populate-webroot step. 04:45:13 INFO - ##### 04:45:13 INFO - Running pre-action listener: _resource_record_pre_action 04:45:13 INFO - Running main action method: populate_webroot 04:45:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:45:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:45:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:45:13 INFO - '--tppagecycles', 04:45:13 INFO - '7'], 04:45:13 INFO - 'tests': ['tsvgm']}}, 04:45:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:45:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:45:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:45:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:45:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:45:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:45:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:13 INFO - 'talos_options': ['--disable-e10s'], 04:45:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:13 INFO - 'talos_options': ['--disable-e10s'], 04:45:13 INFO - 'tests': ['damp', 'tps']}, 04:45:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:13 INFO - 'tests': ['damp', 'tps']}, 04:45:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:45:13 INFO - 'tests': ['dromaeo_dom']}, 04:45:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:45:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:45:13 INFO - 'tests': ['basic_compositor_video']}, 04:45:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:45:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:45:13 INFO - 'tests': ['a11yr', 04:45:13 INFO - 'ts_paint', 04:45:13 INFO - 'tpaint', 04:45:13 INFO - 'sessionrestore', 04:45:13 INFO - 'sessionrestore_no_auto_restore', 04:45:13 INFO - 'tabpaint']}, 04:45:13 INFO - 'other-e10s': {'tests': ['a11yr', 04:45:13 INFO - 'ts_paint', 04:45:13 INFO - 'tpaint', 04:45:13 INFO - 'sessionrestore', 04:45:13 INFO - 'sessionrestore_no_auto_restore', 04:45:13 INFO - 'tabpaint']}, 04:45:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:45:13 INFO - 'ts_paint', 04:45:13 INFO - 'tpaint', 04:45:13 INFO - 'sessionrestore', 04:45:13 INFO - 'sessionrestore_no_auto_restore', 04:45:13 INFO - 'tabpaint']}, 04:45:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:45:13 INFO - 'ts_paint', 04:45:13 INFO - 'tpaint', 04:45:13 INFO - 'sessionrestore', 04:45:13 INFO - 'sessionrestore_no_auto_restore', 04:45:13 INFO - 'tabpaint']}, 04:45:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:45:13 INFO - 'tests': ['a11yr', 04:45:13 INFO - 'ts_paint', 04:45:13 INFO - 'tpaint', 04:45:13 INFO - 'sessionrestore', 04:45:13 INFO - 'sessionrestore_no_auto_restore', 04:45:13 INFO - 'tabpaint']}, 04:45:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:45:13 INFO - 'tests': ['a11yr', 04:45:13 INFO - 'ts_paint', 04:45:13 INFO - 'tpaint', 04:45:13 INFO - 'sessionrestore', 04:45:13 INFO - 'sessionrestore_no_auto_restore', 04:45:13 INFO - 'tabpaint']}, 04:45:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:45:13 INFO - 'tests': ['tsvgx', 04:45:13 INFO - 'tsvgr_opacity', 04:45:13 INFO - 'tart', 04:45:13 INFO - 'tscrollx', 04:45:13 INFO - 'cart']}, 04:45:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:45:13 INFO - 'tsvgr_opacity', 04:45:13 INFO - 'tart', 04:45:13 INFO - 'tscrollx', 04:45:13 INFO - 'cart']}, 04:45:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:13 INFO - 'talos_options': ['--disable-e10s'], 04:45:13 INFO - 'tests': ['tp5o']}, 04:45:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:13 INFO - 'tests': ['tp5o']}, 04:45:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:13 INFO - 'talos_options': ['--disable-e10s', 04:45:13 INFO - '--xperf_path', 04:45:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:13 INFO - 'tests': ['tp5n']}, 04:45:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:13 INFO - 'talos_options': ['--xperf_path', 04:45:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:13 INFO - 'tests': ['tp5n']}}, 04:45:13 INFO - 'talos.zip': {'path': '', 04:45:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:45:13 INFO - Running post-action listener: _resource_record_post_action 04:45:13 INFO - ##### 04:45:13 INFO - ##### Finished populate-webroot step (success) 04:45:13 INFO - ##### 04:45:13 INFO - ##### 04:45:13 INFO - ##### Running create-virtualenv step. 04:45:13 INFO - ##### 04:45:13 INFO - Running pre-action listener: _resource_record_pre_action 04:45:13 INFO - Running main action method: create_virtualenv 04:45:13 INFO - Creating virtualenv /builds/slave/test/build/venv 04:45:13 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 04:45:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:45:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:45:13 INFO - Using real prefix '/usr' 04:45:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:45:14 INFO - Installing distribute.............................................................................................................................................................................................done. 04:45:16 INFO - Installing pip.................done. 04:45:16 INFO - Return code: 0 04:45:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:16 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 0x7f832b704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e1c0>, '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 0x274f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', '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 04:45:16 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 04:45:16 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 04:45:16 INFO - Using env: {'DISPLAY': ':0', 04:45:16 INFO - 'HOME': '/home/cltbld', 04:45:16 INFO - 'LANG': 'en_US.UTF-8', 04:45:16 INFO - 'LANGUAGE': 'en_US:en', 04:45:16 INFO - 'LOGNAME': 'cltbld', 04:45:16 INFO - 'MAIL': '/var/mail/cltbld', 04:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:16 INFO - 'MOZ_NO_REMOTE': '1', 04:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:16 INFO - 'NO_EM_RESTART': '1', 04:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:16 INFO - 'PWD': '/builds/slave/test', 04:45:16 INFO - 'SHELL': '/bin/bash', 04:45:16 INFO - 'SHLVL': '1', 04:45:16 INFO - 'TERM': 'linux', 04:45:16 INFO - 'TMOUT': '86400', 04:45:16 INFO - 'USER': 'cltbld', 04:45:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', 04:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:16 INFO - '_': '/tools/buildbot/bin/python'} 04:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:16 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 04:45:16 INFO - Cleaning up... 04:45:16 INFO - Return code: 0 04:45:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:16 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 0x7f832b704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e1c0>, '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 0x274f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', '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 04:45:16 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 04:45:16 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 04:45:16 INFO - Using env: {'DISPLAY': ':0', 04:45:16 INFO - 'HOME': '/home/cltbld', 04:45:16 INFO - 'LANG': 'en_US.UTF-8', 04:45:16 INFO - 'LANGUAGE': 'en_US:en', 04:45:16 INFO - 'LOGNAME': 'cltbld', 04:45:16 INFO - 'MAIL': '/var/mail/cltbld', 04:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:16 INFO - 'MOZ_NO_REMOTE': '1', 04:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:16 INFO - 'NO_EM_RESTART': '1', 04:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:16 INFO - 'PWD': '/builds/slave/test', 04:45:16 INFO - 'SHELL': '/bin/bash', 04:45:16 INFO - 'SHLVL': '1', 04:45:16 INFO - 'TERM': 'linux', 04:45:16 INFO - 'TMOUT': '86400', 04:45:16 INFO - 'USER': 'cltbld', 04:45:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', 04:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:16 INFO - '_': '/tools/buildbot/bin/python'} 04:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:16 INFO - Downloading/unpacking psutil>=3.1.1 04:45:16 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 04:45:16 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 04:45:16 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 04:45:16 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 04:45:16 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 04:45:16 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 04:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:45:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:18 INFO - Installing collected packages: psutil 04:45:18 INFO - Running setup.py install for psutil 04:45:18 INFO - building 'psutil._psutil_linux' extension 04:45:18 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 04:45:19 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 04:45:19 INFO - building 'psutil._psutil_posix' extension 04:45:19 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 04:45:19 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 04:45:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:19 INFO - Successfully installed psutil 04:45:19 INFO - Cleaning up... 04:45:19 INFO - Return code: 0 04:45:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:45:19 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')]} 04:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:19 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')]} 04:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:19 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 0x7f832b704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e1c0>, '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 0x274f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', '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 04:45:19 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 04:45:19 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 04:45:19 INFO - Using env: {'DISPLAY': ':0', 04:45:19 INFO - 'HOME': '/home/cltbld', 04:45:19 INFO - 'LANG': 'en_US.UTF-8', 04:45:19 INFO - 'LANGUAGE': 'en_US:en', 04:45:19 INFO - 'LOGNAME': 'cltbld', 04:45:19 INFO - 'MAIL': '/var/mail/cltbld', 04:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:19 INFO - 'MOZ_NO_REMOTE': '1', 04:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:19 INFO - 'NO_EM_RESTART': '1', 04:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:19 INFO - 'PWD': '/builds/slave/test', 04:45:19 INFO - 'SHELL': '/bin/bash', 04:45:19 INFO - 'SHLVL': '1', 04:45:19 INFO - 'TERM': 'linux', 04:45:19 INFO - 'TMOUT': '86400', 04:45:19 INFO - 'USER': 'cltbld', 04:45:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', 04:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:19 INFO - '_': '/tools/buildbot/bin/python'} 04:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:45:21 INFO - Installing collected packages: mozsystemmonitor 04:45:21 INFO - Running setup.py install for mozsystemmonitor 04:45:21 INFO - Successfully installed mozsystemmonitor 04:45:21 INFO - Cleaning up... 04:45:21 INFO - Return code: 0 04:45:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:21 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 0x7f832b704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e1c0>, '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 0x274f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', '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 04:45:21 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 04:45:21 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 04:45:21 INFO - Using env: {'DISPLAY': ':0', 04:45:21 INFO - 'HOME': '/home/cltbld', 04:45:21 INFO - 'LANG': 'en_US.UTF-8', 04:45:21 INFO - 'LANGUAGE': 'en_US:en', 04:45:21 INFO - 'LOGNAME': 'cltbld', 04:45:21 INFO - 'MAIL': '/var/mail/cltbld', 04:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:21 INFO - 'MOZ_NO_REMOTE': '1', 04:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:21 INFO - 'NO_EM_RESTART': '1', 04:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:21 INFO - 'PWD': '/builds/slave/test', 04:45:21 INFO - 'SHELL': '/bin/bash', 04:45:21 INFO - 'SHLVL': '1', 04:45:21 INFO - 'TERM': 'linux', 04:45:21 INFO - 'TMOUT': '86400', 04:45:21 INFO - 'USER': 'cltbld', 04:45:21 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', 04:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:21 INFO - '_': '/tools/buildbot/bin/python'} 04:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:21 INFO - Downloading/unpacking jsonschema==2.5.1 04:45:21 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 04:45:21 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 04:45:21 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 04:45:21 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 04:45:21 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 04:45:21 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 04:45:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:45:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:24 INFO - Downloading functools32-3.2.3-2.tar.gz 04:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:45:24 INFO - warning: no files found matching '*.txt' 04:45:24 INFO - no previously-included directories found matching 'build' 04:45:24 INFO - no previously-included directories found matching 'dist' 04:45:24 INFO - no previously-included directories found matching '.git*' 04:45:24 INFO - Installing collected packages: jsonschema, functools32 04:45:24 INFO - Running setup.py install for functools32 04:45:24 INFO - warning: no files found matching '*.txt' 04:45:24 INFO - no previously-included directories found matching 'build' 04:45:24 INFO - no previously-included directories found matching 'dist' 04:45:24 INFO - no previously-included directories found matching '.git*' 04:45:24 INFO - Successfully installed jsonschema functools32 04:45:24 INFO - Cleaning up... 04:45:24 INFO - Return code: 0 04:45:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:45:24 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')]} 04:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:24 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')]} 04:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:24 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 0x7f832b704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e1c0>, '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 0x274f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', '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 04:45:24 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 04:45:24 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 04:45:24 INFO - Using env: {'DISPLAY': ':0', 04:45:24 INFO - 'HOME': '/home/cltbld', 04:45:24 INFO - 'LANG': 'en_US.UTF-8', 04:45:24 INFO - 'LANGUAGE': 'en_US:en', 04:45:24 INFO - 'LOGNAME': 'cltbld', 04:45:24 INFO - 'MAIL': '/var/mail/cltbld', 04:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:24 INFO - 'MOZ_NO_REMOTE': '1', 04:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:24 INFO - 'NO_EM_RESTART': '1', 04:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:24 INFO - 'PWD': '/builds/slave/test', 04:45:24 INFO - 'SHELL': '/bin/bash', 04:45:24 INFO - 'SHLVL': '1', 04:45:24 INFO - 'TERM': 'linux', 04:45:24 INFO - 'TMOUT': '86400', 04:45:24 INFO - 'USER': 'cltbld', 04:45:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', 04:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:24 INFO - '_': '/tools/buildbot/bin/python'} 04:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:24 INFO - Downloading/unpacking blobuploader==1.2.4 04:45:24 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 04:45:24 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 04:45:24 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 04:45:24 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 04:45:24 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 04:45:24 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 04:45:26 INFO - Downloading blobuploader-1.2.4.tar.gz 04:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:45:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:45:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:27 INFO - Downloading docopt-0.6.1.tar.gz 04:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:45:27 INFO - Installing collected packages: blobuploader, requests, docopt 04:45:27 INFO - Running setup.py install for blobuploader 04:45:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:45:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:45:27 INFO - Running setup.py install for requests 04:45:27 INFO - Running setup.py install for docopt 04:45:27 INFO - Successfully installed blobuploader requests docopt 04:45:27 INFO - Cleaning up... 04:45:27 INFO - Return code: 0 04:45:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:27 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 0x7f832b704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e1c0>, '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 0x274f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', '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 04:45:27 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 04:45:27 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 04:45:27 INFO - Using env: {'DISPLAY': ':0', 04:45:27 INFO - 'HOME': '/home/cltbld', 04:45:27 INFO - 'LANG': 'en_US.UTF-8', 04:45:27 INFO - 'LANGUAGE': 'en_US:en', 04:45:27 INFO - 'LOGNAME': 'cltbld', 04:45:27 INFO - 'MAIL': '/var/mail/cltbld', 04:45:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:27 INFO - 'MOZ_NO_REMOTE': '1', 04:45:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:27 INFO - 'NO_EM_RESTART': '1', 04:45:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:27 INFO - 'PWD': '/builds/slave/test', 04:45:27 INFO - 'SHELL': '/bin/bash', 04:45:27 INFO - 'SHLVL': '1', 04:45:27 INFO - 'TERM': 'linux', 04:45:27 INFO - 'TMOUT': '86400', 04:45:27 INFO - 'USER': 'cltbld', 04:45:27 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', 04:45:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:27 INFO - '_': '/tools/buildbot/bin/python'} 04:45:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:28 INFO - Running setup.py (path:/tmp/pip-BiXGwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:28 INFO - Running setup.py (path:/tmp/pip-facIm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:28 INFO - Running setup.py (path:/tmp/pip-5jQp6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:28 INFO - Running setup.py (path:/tmp/pip-p6htuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:28 INFO - Running setup.py (path:/tmp/pip-YIEQoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:28 INFO - Running setup.py (path:/tmp/pip-fqVOIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:28 INFO - Running setup.py (path:/tmp/pip-p1TPo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:28 INFO - Running setup.py (path:/tmp/pip-eNTSod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:28 INFO - Running setup.py (path:/tmp/pip-rAGBdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:28 INFO - Running setup.py (path:/tmp/pip-YXSaFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:28 INFO - Running setup.py (path:/tmp/pip-JtyqQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:28 INFO - Running setup.py (path:/tmp/pip-h5d73B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:28 INFO - Running setup.py (path:/tmp/pip-_SMC3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:28 INFO - Running setup.py (path:/tmp/pip-lrch0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:29 INFO - Running setup.py (path:/tmp/pip-UeJhny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:29 INFO - Running setup.py (path:/tmp/pip-rf76CO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:29 INFO - Running setup.py (path:/tmp/pip-BoqBUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:45:29 INFO - Running setup.py install for manifestparser 04:45:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:45:29 INFO - Running setup.py install for mozcrash 04:45:29 INFO - Running setup.py install for mozdebug 04:45:29 INFO - Running setup.py install for mozdevice 04:45:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:45:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:45:29 INFO - Running setup.py install for mozfile 04:45:29 INFO - Running setup.py install for mozhttpd 04:45:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:45:29 INFO - Running setup.py install for mozinfo 04:45:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:45:29 INFO - Running setup.py install for mozInstall 04:45:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:45:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:45:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:45:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:45:30 INFO - Running setup.py install for mozleak 04:45:30 INFO - Running setup.py install for mozlog 04:45:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:45:30 INFO - Running setup.py install for moznetwork 04:45:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:45:30 INFO - Running setup.py install for mozprocess 04:45:30 INFO - Running setup.py install for mozprofile 04:45:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:45:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:45:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:45:30 INFO - Running setup.py install for mozrunner 04:45:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:45:30 INFO - Running setup.py install for mozscreenshot 04:45:30 INFO - Running setup.py install for moztest 04:45:30 INFO - Running setup.py install for mozversion 04:45:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:45:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:45:30 INFO - Cleaning up... 04:45:31 INFO - Return code: 0 04:45:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:31 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 0x7f832b704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e1c0>, '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 0x274f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', '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 04:45:31 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 04:45:31 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 04:45:31 INFO - Using env: {'DISPLAY': ':0', 04:45:31 INFO - 'HOME': '/home/cltbld', 04:45:31 INFO - 'LANG': 'en_US.UTF-8', 04:45:31 INFO - 'LANGUAGE': 'en_US:en', 04:45:31 INFO - 'LOGNAME': 'cltbld', 04:45:31 INFO - 'MAIL': '/var/mail/cltbld', 04:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:31 INFO - 'MOZ_NO_REMOTE': '1', 04:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:31 INFO - 'NO_EM_RESTART': '1', 04:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:31 INFO - 'PWD': '/builds/slave/test', 04:45:31 INFO - 'SHELL': '/bin/bash', 04:45:31 INFO - 'SHLVL': '1', 04:45:31 INFO - 'TERM': 'linux', 04:45:31 INFO - 'TMOUT': '86400', 04:45:31 INFO - 'USER': 'cltbld', 04:45:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', 04:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:31 INFO - '_': '/tools/buildbot/bin/python'} 04:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:31 INFO - Running setup.py (path:/tmp/pip-zJiTV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:31 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)) 04:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:31 INFO - Running setup.py (path:/tmp/pip-Op91fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:31 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)) 04:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:31 INFO - Running setup.py (path:/tmp/pip-OibcH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:31 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)) 04:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:31 INFO - Running setup.py (path:/tmp/pip-9x01cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:31 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)) 04:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:31 INFO - Running setup.py (path:/tmp/pip-GBiMfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:31 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)) 04:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:31 INFO - Running setup.py (path:/tmp/pip-MkmVmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:31 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)) 04:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:31 INFO - Running setup.py (path:/tmp/pip-8lGHXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:31 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)) 04:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:31 INFO - Running setup.py (path:/tmp/pip-iEsVgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:31 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)) 04:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:31 INFO - Running setup.py (path:/tmp/pip-Szunzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:31 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)) 04:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:31 INFO - Running setup.py (path:/tmp/pip-nlnpy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:31 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)) 04:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:31 INFO - Running setup.py (path:/tmp/pip-FkAMcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:32 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)) 04:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:32 INFO - Running setup.py (path:/tmp/pip-70zp3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:32 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)) 04:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:32 INFO - Running setup.py (path:/tmp/pip-giR2li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:32 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)) 04:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:32 INFO - Running setup.py (path:/tmp/pip-AM8pCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:32 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)) 04:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:32 INFO - Running setup.py (path:/tmp/pip-uF0MYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:32 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)) 04:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:32 INFO - Running setup.py (path:/tmp/pip-BP2g2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:32 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)) 04:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:32 INFO - Running setup.py (path:/tmp/pip-bYp_5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:32 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)) 04:45:32 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)) 04:45:32 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)) 04:45:32 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)) 04:45:32 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)) 04:45:32 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)) 04:45:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:34 INFO - Downloading blessings-1.6.tar.gz 04:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:45:34 INFO - Installing collected packages: blessings 04:45:34 INFO - Running setup.py install for blessings 04:45:34 INFO - Successfully installed blessings 04:45:34 INFO - Cleaning up... 04:45:34 INFO - Return code: 0 04:45:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:34 INFO - Reading from file tmpfile_stdout 04:45:34 INFO - Current package versions: 04:45:34 INFO - argparse == 1.2.1 04:45:34 INFO - blessings == 1.6 04:45:34 INFO - blobuploader == 1.2.4 04:45:34 INFO - docopt == 0.6.1 04:45:34 INFO - functools32 == 3.2.3-2 04:45:34 INFO - jsonschema == 2.5.1 04:45:34 INFO - manifestparser == 1.1 04:45:34 INFO - mozInstall == 1.12 04:45:34 INFO - mozcrash == 0.17 04:45:34 INFO - mozdebug == 0.1 04:45:34 INFO - mozdevice == 0.48 04:45:34 INFO - mozfile == 1.2 04:45:34 INFO - mozhttpd == 0.7 04:45:34 INFO - mozinfo == 0.9 04:45:34 INFO - mozleak == 0.1 04:45:34 INFO - mozlog == 3.2 04:45:34 INFO - moznetwork == 0.27 04:45:34 INFO - mozprocess == 0.22 04:45:34 INFO - mozprofile == 0.28 04:45:34 INFO - mozrunner == 6.11 04:45:34 INFO - mozscreenshot == 0.1 04:45:34 INFO - mozsystemmonitor == 0.3 04:45:34 INFO - moztest == 0.7 04:45:34 INFO - mozversion == 1.4 04:45:34 INFO - psutil == 3.1.1 04:45:34 INFO - requests == 1.2.3 04:45:34 INFO - wsgiref == 0.1.2 04:45:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:34 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 0x7f832b704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e1c0>, '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 0x274f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', '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 04:45:34 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 04:45:34 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 04:45:34 INFO - Using env: {'DISPLAY': ':0', 04:45:34 INFO - 'HOME': '/home/cltbld', 04:45:34 INFO - 'LANG': 'en_US.UTF-8', 04:45:34 INFO - 'LANGUAGE': 'en_US:en', 04:45:34 INFO - 'LOGNAME': 'cltbld', 04:45:34 INFO - 'MAIL': '/var/mail/cltbld', 04:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:34 INFO - 'MOZ_NO_REMOTE': '1', 04:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:34 INFO - 'NO_EM_RESTART': '1', 04:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:34 INFO - 'PWD': '/builds/slave/test', 04:45:34 INFO - 'SHELL': '/bin/bash', 04:45:34 INFO - 'SHLVL': '1', 04:45:34 INFO - 'TERM': 'linux', 04:45:34 INFO - 'TMOUT': '86400', 04:45:34 INFO - 'USER': 'cltbld', 04:45:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', 04:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:34 INFO - '_': '/tools/buildbot/bin/python'} 04:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:35 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)) 04:45:35 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)) 04:45:35 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)) 04:45:35 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)) 04:45:35 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)) 04:45:35 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)) 04:45:35 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)) 04:45:35 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)) 04:45:35 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)) 04:45:35 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)) 04:45:35 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)) 04:45:35 INFO - Cleaning up... 04:45:35 INFO - Return code: 0 04:45:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f832b704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e1c0>, '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 0x274f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', '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 04:45: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', 'jsonschema'] in /builds/slave/test/build 04:45: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 jsonschema 04:45:35 INFO - Using env: {'DISPLAY': ':0', 04:45:35 INFO - 'HOME': '/home/cltbld', 04:45:35 INFO - 'LANG': 'en_US.UTF-8', 04:45:35 INFO - 'LANGUAGE': 'en_US:en', 04:45:35 INFO - 'LOGNAME': 'cltbld', 04:45:35 INFO - 'MAIL': '/var/mail/cltbld', 04:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:35 INFO - 'MOZ_NO_REMOTE': '1', 04:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:35 INFO - 'NO_EM_RESTART': '1', 04:45:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:35 INFO - 'PWD': '/builds/slave/test', 04:45:35 INFO - 'SHELL': '/bin/bash', 04:45:35 INFO - 'SHLVL': '1', 04:45:35 INFO - 'TERM': 'linux', 04:45:35 INFO - 'TMOUT': '86400', 04:45:35 INFO - 'USER': 'cltbld', 04:45:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', 04:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:35 INFO - '_': '/tools/buildbot/bin/python'} 04:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:45:35 INFO - Cleaning up... 04:45:35 INFO - Return code: 0 04:45:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f832b704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e1c0>, '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 0x274f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', '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 04:45: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', 'flake8'] in /builds/slave/test/build 04:45: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 flake8 04:45:35 INFO - Using env: {'DISPLAY': ':0', 04:45:35 INFO - 'HOME': '/home/cltbld', 04:45:35 INFO - 'LANG': 'en_US.UTF-8', 04:45:35 INFO - 'LANGUAGE': 'en_US:en', 04:45:35 INFO - 'LOGNAME': 'cltbld', 04:45:35 INFO - 'MAIL': '/var/mail/cltbld', 04:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:35 INFO - 'MOZ_NO_REMOTE': '1', 04:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:35 INFO - 'NO_EM_RESTART': '1', 04:45:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:35 INFO - 'PWD': '/builds/slave/test', 04:45:35 INFO - 'SHELL': '/bin/bash', 04:45:35 INFO - 'SHLVL': '1', 04:45:35 INFO - 'TERM': 'linux', 04:45:35 INFO - 'TMOUT': '86400', 04:45:35 INFO - 'USER': 'cltbld', 04:45:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', 04:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:35 INFO - '_': '/tools/buildbot/bin/python'} 04:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:35 INFO - Downloading/unpacking flake8 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:45:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:45:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:45:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:45:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:45:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:45:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:45:38 INFO - no previously-included directories found matching 'docs/_build' 04:45:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:45:38 INFO - Running setup.py install for pep8 04:45:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:45:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:45:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:45:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:45:38 INFO - no previously-included directories found matching 'docs/_build' 04:45:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:45:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:45:38 INFO - Cleaning up... 04:45:38 INFO - Return code: 0 04:45:38 INFO - Running post-action listener: _resource_record_post_action 04:45:38 INFO - Running post-action listener: _start_resource_monitoring 04:45:38 INFO - Starting resource monitoring. 04:45:38 INFO - ##### 04:45:38 INFO - ##### Finished create-virtualenv step (success) 04:45:38 INFO - ##### 04:45:38 INFO - ##### 04:45:38 INFO - ##### Running install step. 04:45:38 INFO - ##### 04:45:38 INFO - Running pre-action listener: _resource_record_pre_action 04:45:38 INFO - Running main action method: install 04:45:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:38 INFO - Reading from file tmpfile_stdout 04:45:38 INFO - Detecting whether we're running mozinstall >=1.0... 04:45:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:45:38 INFO - Reading from file tmpfile_stdout 04:45:38 INFO - Output received: 04:45:38 INFO - Usage: mozinstall [options] installer 04:45:38 INFO - Options: 04:45:38 INFO - -h, --help show this help message and exit 04:45:38 INFO - -d DEST, --destination=DEST 04:45:38 INFO - Directory to install application into. [default: 04:45:38 INFO - "/builds/slave/test"] 04:45:38 INFO - --app=APP Application being installed. [default: firefox] 04:45:38 INFO - mkdir: /builds/slave/test/build/application 04:45:38 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'] 04:45:38 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 04:45:54 INFO - Reading from file tmpfile_stdout 04:45:54 INFO - Output received: 04:45:54 INFO - /builds/slave/test/build/application/firefox/firefox 04:45:54 INFO - Running post-action listener: _resource_record_post_action 04:45:54 INFO - ##### 04:45:54 INFO - ##### Finished install step (success) 04:45:54 INFO - ##### 04:45:54 INFO - ##### 04:45:54 INFO - ##### Running run-tests step. 04:45:54 INFO - ##### 04:45:54 INFO - Running pre-action listener: _resource_record_pre_action 04:45:54 INFO - Running main action method: run_tests 04:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:45:54 INFO - Python 2.7.3 04:45:54 INFO - Return code: 0 04:45:54 INFO - grabbing minidump binary from tooltool 04:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:54 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 0x274e1c0>, '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 0x274f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:45:54 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 04:45:54 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 04:45:54 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 04:45:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:45:55 INFO - Return code: 0 04:45:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:45:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:45:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:45:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:45:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:45:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:45:55 INFO - Return code: 0 04:45:55 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/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 04:45:55 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/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 04:45:55 INFO - Using env: {'DISPLAY': ':0', 04:45:55 INFO - 'HOME': '/home/cltbld', 04:45:55 INFO - 'LANG': 'en_US.UTF-8', 04:45:55 INFO - 'LANGUAGE': 'en_US:en', 04:45:55 INFO - 'LOGNAME': 'cltbld', 04:45:55 INFO - 'MAIL': '/var/mail/cltbld', 04:45:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:45:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:55 INFO - 'MOZ_NO_REMOTE': '1', 04:45:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:55 INFO - 'NO_EM_RESTART': '1', 04:45:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:55 INFO - 'PWD': '/builds/slave/test', 04:45:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:45:55 INFO - 'SHELL': '/bin/bash', 04:45:55 INFO - 'SHLVL': '1', 04:45:55 INFO - 'TERM': 'linux', 04:45:55 INFO - 'TMOUT': '86400', 04:45:55 INFO - 'USER': 'cltbld', 04:45:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559', 04:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:55 INFO - '_': '/tools/buildbot/bin/python'} 04:45:55 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/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 04:45:56 INFO - mozversion application_buildid: 20160623035624 04:45:56 INFO - mozversion application_changeset: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e 04:45:56 INFO - mozversion application_display_name: Nightly 04:45:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:45:56 INFO - mozversion application_name: Firefox 04:45:56 INFO - mozversion application_remotingname: firefox 04:45:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:45:56 INFO - mozversion application_vendor: Mozilla 04:45:56 INFO - mozversion application_version: 50.0a1 04:45:56 INFO - mozversion platform_buildid: 20160623035624 04:45:56 INFO - mozversion platform_changeset: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e 04:45:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:45:56 INFO - mozversion platform_version: 50.0a1 04:45:56 INFO - using testdate: 1466682356 04:45:56 INFO - actual date: 1466682356 04:45:56 INFO - starting webserver on 'localhost:46764' 04:45:56 INFO - SUITE-START | Running 2 tests 04:45:56 INFO - TEST-START | dromaeo_css 04:45:56 INFO - operating with platform_type : linux_ 04:45:56 INFO - Initialising browser for dromaeo_css test... 04:45:56 INFO - TEST-INFO | started process 18538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEA4i48/profile http://localhost:46764/getInfo.html) 04:46:00 INFO - PROCESS | 18538 | __metrics Screen width/height:1600/1200 04:46:00 INFO - PROCESS | 18538 | colorDepth:24 04:46:00 INFO - PROCESS | 18538 | Browser inner width/height: 1024/697 04:46:00 INFO - PROCESS | 18538 | __metrics 04:46:00 INFO - PROCESS | 18538 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:46:01 INFO - TEST-INFO | 18538: exit 0 04:46:01 INFO - Browser initialized. 04:46:01 INFO - Running cycle 1/1 for dromaeo_css test... 04:46:01 INFO - TEST-INFO | started process 18620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEA4i48/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:14 INFO - PROCESS | 18620 | RSS: Main: 175616000 04:46:14 INFO - PROCESS | 18620 | 04:47:06 INFO - PROCESS | 18620 | 1466682426048 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] 04:49:17 INFO - PROCESS | 18620 | Cycle 1(1): loaded http://localhost:46764/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46764/tests/dromaeo/cssquery-ext.html) 04:49:18 INFO - PROCESS | 18620 | RSS: Main: 260300800 04:49:18 INFO - PROCESS | 18620 | 04:52:21 INFO - PROCESS | 18620 | Cycle 1(1): loaded http://localhost:46764/tests/dromaeo/cssquery-ext.html (next: http://localhost:46764/tests/dromaeo/cssquery-jquery.html) 04:52:21 INFO - PROCESS | 18620 | RSS: Main: 271015936 04:52:21 INFO - PROCESS | 18620 | 04:55:24 INFO - PROCESS | 18620 | Cycle 1(1): loaded http://localhost:46764/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46764/tests/dromaeo/cssquery-mootools.html) 04:55:24 INFO - PROCESS | 18620 | RSS: Main: 265158656 04:55:24 INFO - PROCESS | 18620 | 04:58:26 INFO - PROCESS | 18620 | Cycle 1(1): loaded http://localhost:46764/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46764/tests/dromaeo/cssquery-prototype.html) 04:58:27 INFO - PROCESS | 18620 | RSS: Main: 256974848 04:58:27 INFO - PROCESS | 18620 | 05:01:30 INFO - PROCESS | 18620 | Cycle 1(1): loaded http://localhost:46764/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46764/tests/dromaeo/cssquery-yui.html) 05:01:31 INFO - PROCESS | 18620 | RSS: Main: 242462720 05:01:31 INFO - PROCESS | 18620 | 05:04:33 INFO - PROCESS | 18620 | Cycle 1(1): loaded http://localhost:46764/tests/dromaeo/cssquery-yui.html (next: http://localhost:46764/tests/dromaeo/cssquery-dojo.html) 05:04:34 INFO - PROCESS | 18620 | RSS: Main: 294719488 05:04:34 INFO - PROCESS | 18620 | 05:04:34 INFO - PROCESS | 18620 | __start_tp_report 05:04:34 INFO - PROCESS | 18620 | _x_x_mozilla_page_load 05:04:34 INFO - PROCESS | 18620 | _x_x_mozilla_page_load_details 05:04:34 INFO - PROCESS | 18620 | |i|pagename|runs| 05:04:34 INFO - PROCESS | 18620 | |0;dojo.html;2606.3093280280723;2606.9087581934637;2647.510210611037;2660.4280079782857;2663.320853182438;4740.668153229271;4793.496682848303;4807.783649735761;4810.44679861816;4854.126257273694;4827.806887724496;4843.128236917353;4850.854474365766;4865.099956508039;4871.293662418947;4366.912661746763;4411.647068234533;4431.158079964796;4474.463064432256;4591.862244132664;4484.1031793641405;4517.299818528117;4538.410006699124;4539.500654927955;4567.155076310876;4320.589543993331;4359.193549193409;4367.3448982652535;4375.584319489643;4447.066116115588;4342.5874541918465;4358.934615980763;4362.192994296033;4469.195544801934;4493.146302202571;4372.1255748850035;4372.519022907478;4386.385905973167;4414.602685758265;4431.534688857688;4760.928586071212;4794.041191761627;4804.279358096279;4809.927851082237;4843.878903027417;5234.659747116425;5269.525742683139;5318.016167009116;5326.573874090102;5330.440303768088;5299.390570084451;5312.840614781563;5342;5342.332208473941;5350.063738845725;4739.66822322441;4760.809567617256;4787.952120478821;4891.070696567641;4903.313536104948;5235.05768961583;5237.921431178535;5275.920861187085;5284.630075894727;5294.2852714883;5004.574611158092;5011.223260394645;5043.445221025758;5058.241263810458;5072.644914855925;5070.138076527;5134.306868572695;5150.27896094547;5184.974075129676;5187.06632806091;5119.718415487184;5137.255098010767;5139.948600514022;5143.61422893277;5158.793648254103;5158.767855446514;5159;5160.174372100446;5164.32863727713;5197.376314842243;4348.9130217396105;4383.868483945486;4395.296752519582;4438.423005009393;4448.799804008828;3868.0909986153233;3892.8832135035996;3897.025743564109;3910.983144382481;3913.5695073541888;4411.801468933906;4427.026054268056;4444.799984000728;4445.555444455528;4448.421705178371;5232.581393488512;5239.423663397023;5242.449542797951;5242.9213561796605;5274.7890084396195;4447.555244475527;4452.220861349251;4458.8439404620685;4486.506484286726;4508.098380323949;4515.435570553681;4666.95333046672;4669;4707.952920470751;4725.64557658177;4890.266460030882;4892.902141957141;4895.437024742129;4923.704577725348;4940.382452193476;5154.329937108152;5214.739263036909;5218.243354713622;5218.765155567932;5224.05966925957;4788.090262850047;4826.61387089025;4831.299461577981;4872.731999739906;4877.3903262092235;5114.820981265638;5123.871903202301;5141;5144.845654630367;5194.844154675366;5189.091908916;5203.126874325316;5203.19350500673;5208;5211.1401618734;4944.48082951285;5020.3724534433195;5069.188929771219;5085.440601533903;5091.465396133501;5047.394312682502;5071.163258062378;5074.31496747949;5078.238264260391;5132.358455193101;4863.489333619919;4989.525995030466;5005.074061298671;5062.620303477328;5074.746262686925;5062.493750624908;5066.746662666926;5088.949110508847;5107.514786095315;5123.615728820428;5021.874453138555;5023.623228257822;5026.723530205873;5033.874153146055;5080.872978175576 05:04:34 INFO - PROCESS | 18620 | |1;ext.html;588.6762280745589;591.2402562706923;596.472122171878;598.1595857819761;606.1544145916446;38156;39557;39604.40593391098;43280.35079473811;43316.56683433165;39753.80123099388;40288.798556007256;40303;40375;40405.59594404055;7819.726309579166;7946.562939038351;7957.363410927141;7960.681572737083;7966.522008679469;7829.334506566948;7913.366930645535;7914.722984695537;7922.881156782653;7924.326432253265;7934.920650793505;7945.96027019867;7964.482308649948;7972.24263694951;7972.920270797275;7918.049834019926;7955.204479551999;7955.24425179607;7959.403044771636;7962.482438641469;7788.493747906425;7844.372450204027;7866.567338796364;7872.173421790687;7878.054633444023;38411.23177536461;38710.61289387098;38736.418953715714;38798.224035519415;38844.611553884664;2970.643522777259;3143.402753476832;3238.1095198820276;3369.629340772513;3376.0209539233592;28540;28971;29088;29282;30031;3160.668129846356;3185.649578546358;3200.1519597306733;3222.5166225066428;3250.626177989514;248680;249304;250584;250588;253199;52399.47600523946;52958.470415295356;53059;53130;53220.27458077975;48907;50469;60203.39796602065;61598;61603.6919815407;14988.550343489713;15105.773413398807;15157.393704251706;15188;15208.467703630542;10544.420056896945;10569.577216911392;10621.946890265499;10676.62631807883;10945.398003109905;15819.52541423759;16239.457251561083;16312.34750609986;16782;16854.662906741796;5943.31651860033;5991.760329586855;6095.299040610386;6158.1686472326555;6170.444659980623;864.5936409887343;883.1565854608962;894.7205496140451;965.0156840023137;1000.659775676259;26525.86737066302;27656.308592284953;27873.30316742057;28070.85964570164;28205;959.2853324273322;964.4117088575963;990.8513722941616;1027.0807627173638;1048.1091072588392;14603.342849571794;14971.635246612288;15043.548693539211;15183.772243416357;15202.847971520365;351619;353035;354606;354851;355445;49472.50527494679;49599.256011159865;49653.751731241115;49705.50294497081;49769.75115124401;1087.5541028178568;1107.1032463704425;1168.9181757276908;1188.494889671886;1213.8118591618313;26373.472530549665;27954.301142471602;28584.426946631673;29410.264743381587;29522.704772951995;43923.56076439195;46975;47532.7623361881;47671;47704.7614761924;339348;344076;345067;345906;346233;22814.543709126057;24935.251942441755;25065.373365666004;25860.741392585835;25906.870465647553;41855.37216941687;42282;42309.788451058776;43012.569874300854;43247;36465.535774101416;36615;36669.806290211105;36922.44616330703;36968.26063478662;36355;36534.26931461409;36679;36744.448833268056;37068.629313706515;35461.1134721634;35488.64511354853;35702.46446303256;35850.10374740652;36252.27495450129;31819.84090079535;32413;32798;32919.506207406426;32919.67080329166;24931.87534062318;25242;25372.74627253704;25399.473529103132;25619.23142305734 05:04:34 INFO - PROCESS | 18620 | |2;jquery.html;376.2944479101685;381.2089913429633;384.1510262320274;388.5279385546564;389.1477663916024;16032.759508607365;17051.658966820687;17491.212895419703;17556.20997055134;17672.20475078621;16554.503364899043;16758.83241167588;16841.32634694611;17044.659106817857;17055.82944170558;4743.644226682995;5058.266551350052;5086.804600918781;5093.2105523643895;5113.923291150636;3710.7402481826284;3912.2175564886993;5713.657180569158;5995.190649262359;5999.520038396918;5790.913136302937;6009.429104235112;6011.158437818709;6040.546958978072;6044.365341639109;5945.108233764949;5960.552958528085;5979.133025711291;5988.19159413478;5996.460318571328;3324.6675332466803;4970.304157417964;5226.189940559219;5236;5309.123994540896;20094.49763755903;20099;20265.696014559646;20760.480987975272;20804;1797.379903933141;2021.5350469391974;2148.258850696523;2158.9244376446904;2381.833271670984;9193.908060919372;9322;9444.716658500256;10865.945670271678;13651.453941842314;1721.638455924245;1729.5676080979756;1740.817214192517;1748.6764948484572;1769.539919620895;63386.68306658483;67662.3233767661;68929.65535172343;69895.01049895071;71684.6415767923;9909.108180263667;9930.453825039547;9965.501724913725;10085.193184545218;10770.569177232823;13808.654783630289;13902.791458128137;13905.721885562434;13928.094673846168;13929.791053134211;7154.678039488235;7227.9638601806655;7273;7287.8542429152185;7364.705411783576;6814.863702725917;6855.417289530346;7092.716291348392;7140.9285907140265;7156.856862862714;4297.935530967038;4367.759773212504;4432.113577284556;4447.2439685253585;4506.639468842484;1670.3986564836648;1752.9052781925477;1836.6969450040594;1885.9528511787314;1899.078946710844;740.8407192453649;822.5064961023338;854.4659587757651;893.0043002052794;926.6802952981211;16250.918745406434;16440.917795410947;16498.917505412395;16956.406525771537;17072.658546828992;832.7168762620738;863.326605247895;876.9824603508022;918.2103391083663;920.1718453392001;8948.284137269004;9051.954740226389;9661.275404344702;10080;10646.787064258671;386346;392950;400305;400437;400959;55820.16269755957;79206;80409;82943;84639;929.2612373163352;929.6049179098856;952.885653721544;957.8898426681021;959.0265880131533;14325.283735813377;14455.927720361751;15755.842441575438;15802;16576;32873.506897397034;33584.83207583946;37777.433338500494;38716.806415968866;39309;48655.75672121617;48766;50371.49628503668;50573.74713126411;50848.49151508437;7571.621418928921;7684.346830519245;7837.843243134991;7853.568053757098;8012.679492820455;10762.569497220024;11601.593944211912;11633;11900.642980710592;11980.820287695866;9496.192823609794;9498.287628427757;9648;9823.36148150368;9932.602695892372;6360.618362898241;9371.85942210881;10230.488475576043;10360.274780765576;10369.118624916664;9650;9969.716289448552;9980.201583873128;10143.289969702346;10167.542460589144;7715.305622494003;7763.301302882767;7773.689052438065;7842.764717058498;7870.527768333918;7568.243175682388;8724.869126963227;9564.091411315914;9723.611055557982;9774.413535187912 05:04:34 INFO - PROCESS | 18620 | |3;mootools.html;1245.2466257913957;1355.4916906160188;1396.5112210726245;1460.2917584971287;1668.1575804218876;6639.5020373472;7630.160682324939;7813.570253636048;7816.531008139508;7983.3214176795045;7721.575313357763;7870.921290787091;7879.80300492488;7888.1323054463965;7897.486663366877;2184.967225491619;2207.5143468437;2213.103693004336;2214.047959377467;2218.6671999200166;2189.868607883532;2214.689943407924;2215.5458131083087;2219.9556008879813;2220.200727738013;2169.2949791317806;2174.739031316244;2195.319450970196;2195.8682479051226;2225.9888700556476;2155.7520885098256;2158.6761985702115;2164.39396968849;2164.7726988666277;2164.956700865982;2092.225876425717;2163.372621939636;2164.8809315487642;2166.8374871884516;2171.1966572368324;7648.808779780495;7827.452078354518;7881.96059019707;7882.921170788276;7954.761357159295;4607.308903664443;4717.504662010508;4721.5750582447745;4727.479977202505;4727.787249573777;2792;2862.3845873137375;2899.9275018124504;2910.519764238898;2917.9270518237004;930.2557953637131;950.4677380666849;953.9840070325151;959.7024922274047;964.60933322004;10446.112080473169;10494.475276236157;10536.367817930948;10542.472876356229;10576;4040.3131467649982;4176.081262122329;4251.87244382669;4258.063226090255;4276.764777937181;8427.115152908978;8465.28045116172;8482.533460659599;8483.74548763538;8485.109063548362;4527.071950250191;4569.862904112882;4571.81712731487;4574.4739354973935;4580.152671755669;3770.2271034437877;3927.7643341399607;4009.67922566194;4188.329867221291;4208.957910420857;3390.813505257185;3443.2596991646915;3480.965190348064;3532.1346270163463;3565.53648025755;1048.208602505119;1075.887031861659;1090.7709381030072;1095.1622009162998;1100.7358234023777;775.1202385292621;776.5146783260462;779.1662920674823;808.0787901791962;812.7439856445201;4799.66402351832;4926;4931.5315045070665;4954.40547134339;5019.480292728197;411.28847094526634;414.98962525937094;419.36047527520776;424.36345481777334;424.51817187491804;3305.2067503799394;3455.3607582596796;3463.653634636516;3471.0975146461597;3556.5376501054698;9486.146246837818;9738.90261097394;9746.512674366253;9818.558164882597;9859.457729824786;9758.95120524407;9765.951170244245;9767.853482197772;9781.65764198264;9784.951075244579;7004;7313.670884810196;7426.480146389701;7513.060867391576;7520.774376768706;5240.89518209626;5293.655912365684;5299.178627312773;5317.069512835315;5417.5665946723375;8595.570221489026;8851.557422128997;8876.467411955304;8995.23540499065;9043.819123617359;8840.425372350777;9035.774105647148;9065.410748301603;9167.816643666956;9186.265098791948;6156.969215153896;6571.5399922005;6715.059891615276;6830.829229269308;6836.38472537474;7580.924190758022;7638.427117966064;7685.03937007874;7707.576083315472;7708.653110610148;6810.931890681228;6858.3141685831015;6996.930030699831;7079.504434689522;7098.112735908012;6834.282400347892;6873.0377747116445;6909.2745261746795;6930.3762661360715;6983.511154219156;6069.514438844793;6092.964196086765;6148.661823599566;6154.169187159676;6173.6913154343;4398.714083584557;4453.3320001999955;4484.529124442017;4525.185466616041;4530.207213737517;4423.690341676181;4497.04850031906;4559.38448309474;4560.475545312199;4561.680682352204 05:04:34 INFO - PROCESS | 18620 | |4;prototype.html;294.50376116244144;305.2201624848512;310.079065176426;312.35654551623645;313.7129526483268;4704.294355846625;4794.736289504076;4832.613390928726;4875.024995001005;4890.193118135508;4651.5348465153465;4808.869915569839;4815.229563269869;4828.324034635154;4836.419629644439;3806.676432503227;3807.409851473012;3813.694904407641;3818.618138186187;3826.7321287509885;3575.66031227033;3614.945775813365;3801.2397520495874;3812.8942606644177;3819.746349653704;3789.109559253573;3791.8862434127022;3815.8855234342877;3820.866269680562;3823.6426068745614;3771.2646034023514;3772.4152756322537;3775.9811200944096;3782;3815.637514436124;3391.304782519602;3396.0660818274923;3400.843713137545;3401.5407919930985;3424.931501369959;4594.989102397467;4674.883127921795;4680.782996420921;4688.507706690816;4755.524447555252;4344.391785150082;4350.7172033818015;4362.760048197348;4366.554729351542;4385.991222018922;5053.523773351031;5053.67151135175;5064.797408103708;5079.187330027215;5080.110980578421;3621.9315301985976;3649.908752281214;3705.5368078990127;3721.441783732435;3742.914554779111;5235.115358470947;5267.947320526822;5290.470952904717;5308.274810686504;5308.283381743492;3752.0864359177017;3777.773333599993;3780.8676696316047;3804.2201348723997;3818.217265460574;3837.6354246346555;3837.9232415351535;3845.250176215611;3849.825803130072;3869.5356557212754;4124.752514849119;4290.785460726951;4316.374125751749;4325.545817689097;4349.456317960255;5002.824901128443;5021.196608542688;5035.748212589356;5039.370078740158;5069.138246498104;1254.9435275412445;1276.8914642255327;1312.1405479411;1316.3813007886279;1320.531211419932;861.8707193920962;867.7830542364409;873.9119795854202;880.4811699817764;889.9466032037969;4020.8942540801513;4027.522569305742;4028.1742242840146;4033.5361433434946;4035.7376770509823;4598.609118224988;4600.884977875513;4625.884352891205;4627.329037289574;4630.58324750774;3939.684825213976;3987.843525377666;4020.7736640324983;4024.335984562573;4035.5875443594505;2350.9294721158394;2419.866907320079;2435.8660273684764;2436.878156092224;2445.5326803917505;4301.806418711166;4354.412154359121;4368.09987655371;4373.278409062533;4382.69321147523;4720.787564559603;4778.761061946889;4781.641376896747;4790.0419916016235;4795.904081918342;4105.938410923838;4372.846950356722;4379.189849877783;4411.977795210291;4422.557744225552;4546.954530454653;4548.909021819612;4555.382839092074;4582.129395414994;4641.953580464152;4514.61625761814;4574.130915126116;4584.793684284148;4592.5177856325945;4612.262038073892;4334.653227741836;4335.328024156261;4382.211201983673;4582.793774280232;4930.728809915489;3670.302642497917;3691.3171063352293;3698.519192504957;3699.759515631583;3701.722370822253;5036.370453693288;5256.342957130359;5262.236975638588;5262.684238945522;5326.201069839555;4974.626902982363;5060.721660308718;5093.821716239914;5109.062289183808;5119;5081.949180508148;5082.593392528663;5096.261042148942;5111.64218504716;5114.4629813869005;4824.758762061812;5016.8210470540125;5025.924611130763;5068.569171620454;5083.567896728671;5056.873578160576;5089.26205700164;5125.92311115341;5133.358330208724;5135.229715542699;4994.650374473752;4995.200767877122;5006.49935006511;5017.498250174954;5025.949740502694 05:04:34 INFO - PROCESS | 18620 | |5;yui.html;602.265236411578;618.1809102938602;707.441121514004;713.8322494213859;724.453037956343;12423.130380873332;12831.935840320786;13280;13329.133606315583;13362.933185334059;12369.381530923463;12414.875851241484;12419.937900310508;12434.813477797818;13521.121127126755;790.9090454597723;798.3413683710933;802.257911431926;804.2681160144269;805.3235282362814;796.6534557467492;798.2855344466699;798.664560884427;798.924102210292;799.013218674936;839.3159574946429;840.6007146605375;840.6217202258978;841.3437518735366;841.7011960753936;832.184459229955;835.908050114487;836.4981011393177;837.1210229259253;837.1921096142191;607.3653032580963;607.6384551192034;608.0392979093023;608.2822269721727;611.2390074357409;12350.5059797608;12361.07291953107;12497.56258530956;12516.937415312956;12524.561640342545;13628.86371136286;13634.386452609557;13682.110662806886;13755.31223438834;14018.789718154236;10761.83857242142;10788.622398216103;10816.945915270451;10845.349279043283;11000.174986876016;3376.2909788944353;3380.4422270325367;3409.556757621518;3418.1454636340914;3480.1647604574973;40091.7995410024;59741.10388344135;59755.40244597542;59876;59991.10013349803;7572.432067594842;10229;10348.22388320879;10497.947510262553;10566.471676416148;17626.383076592258;18011.459656210336;18764.81235187658;19007.33474328392;19042.90478547626;6791.252962174157;6931.722731090801;7116.110486189226;7126.536775109601;7215.458840586977;3844.884653460401;3897.3179693553516;3970.781607011584;3981.6814654827544;4086.4483294755423;2795.664520257582;2907.8109922854946;2910.8690108945148;2911.2867347499573;2914.577386278978;498.33223480536253;502.4222144533815;510.3110800419404;517.1621972404729;517.2577351500609;507.28979428799977;528.4451326107571;602.9879402411927;626.0921663587816;637.764027309889;7685.615719214017;7988.760337189894;8454.027786804596;8696.739097827076;8737.257333126756;619.6994457688018;626.7461678020318;635.329727137874;637.8182218067922;647.459371424856;3955.1891862168186;4068.145689405199;4088.7751173685137;4165.146145040259;4195.811188496525;97275.51362243143;97498;99846.5007674957;101088.49455752822;102241.48879255557;49603;86972.56513717391;87570;87795;89171;46970.82572935636;47746.52253477421;48547.271790923165;83616;84359;8891.866622000805;9260.814783704423;9277.350585458953;9325.906740932774;9414.764630884283;46773.06453870972;47356.763216183695;47447.52552474431;48309.03381932412;51052.48947510626;63779;73566.63216683883;75176;75233.6238318805;75857.62071189609;11362.54549817998;11431.314121152425;11490.08079353633;11711.824322634997;11999.460024298753;12337.938310308391;13145.802812958005;13563.728725425633;14195.787063194268;14363.784543232068;11249.550017999189;12347.3826308686;12422.875771242172;12468.438920248429;12510.812337815121;12143.02855771554;12579.496820127093;12861.356932153169;12971.09202355826;12978.221306721249;12793.424295906892;12951.870481295067;13098.803517947428;13165.802512962122;13558.11872228302;10186.541605627914;10344.431056291976;10587.629432969808;10856.402897840695;10966.725831854268;10324.896751032393;10538;10591.788164236827;10626.468676566295;10747.172980593474 05:04:34 INFO - PROCESS | 18620 | __end_tp_report 05:04:34 INFO - PROCESS | 18620 | __start_cc_report 05:04:34 INFO - PROCESS | 18620 | _x_x_mozilla_cycle_collect,951 05:04:34 INFO - PROCESS | 18620 | __end_cc_report 05:04:34 INFO - PROCESS | 18620 | __startTimestamp1466683474207__endTimestamp 05:04:34 INFO - PROCESS | 18620 | 05:04:34 INFO - PROCESS | 18620 | ------- Summary: start ------- 05:04:34 INFO - PROCESS | 18620 | Number of tests: 6 05:04:34 INFO - PROCESS | 18620 | 05:04:34 INFO - PROCESS | 18620 | [#0] dojo.html Cycles:165 Average:4791.18 Median:4895.44 stddev:517.99 (10.6%) stddev-sans-first:490.40 05:04:34 INFO - PROCESS | 18620 | Values: 2606.3 2606.9 2647.5 2660.4 2663.3 4740.7 4793.5 4807.8 4810.4 4854.1 4827.8 4843.1 4850.9 4865.1 4871.3 4366.9 4411.6 4431.2 4474.5 4591.9 4484.1 4517.3 4538.4 4539.5 4567.2 4320.6 4359.2 4367.3 4375.6 4447.1 4342.6 4358.9 4362.2 4469.2 4493.1 4372.1 4372.5 4386.4 4414.6 4431.5 4760.9 4794.0 4804.3 4809.9 4843.9 5234.7 5269.5 5318.0 5326.6 5330.4 5299.4 5312.8 5342.0 5342.3 5350.1 4739.7 4760.8 4788.0 4891.1 4903.3 5235.1 5237.9 5275.9 5284.6 5294.3 5004.6 5011.2 5043.4 5058.2 5072.6 5070.1 5134.3 5150.3 5185.0 5187.1 5119.7 5137.3 5139.9 5143.6 5158.8 5158.8 5159.0 5160.2 5164.3 5197.4 4348.9 4383.9 4395.3 4438.4 4448.8 3868.1 3892.9 3897.0 3911.0 3913.6 4411.8 4427.0 4444.8 4445.6 4448.4 5232.6 5239.4 5242.4 5242.9 5274.8 4447.6 4452.2 4458.8 4486.5 4508.1 4515.4 4667.0 4669.0 4708.0 4725.6 4890.3 4892.9 4895.4 4923.7 4940.4 5154.3 5214.7 5218.2 5218.8 5224.1 4788.1 4826.6 4831.3 4872.7 4877.4 5114.8 5123.9 5141.0 5144.8 5194.8 5189.1 5203.1 5203.2 5208.0 5211.1 4944.5 5020.4 5069.2 5085.4 5091.5 5047.4 5071.2 5074.3 5078.2 5132.4 4863.5 4989.5 5005.1 5062.6 5074.7 5062.5 5066.7 5088.9 5107.5 5123.6 5021.9 5023.6 5026.7 5033.9 5080.9 05:04:34 INFO - PROCESS | 18620 | 05:04:34 INFO - PROCESS | 18620 | [#1] ext.html Cycles:180 Average:47411.20 Median:36574.63 stddev:84018.11 (229.7%) stddev-sans-first:84180.25 05:04:34 INFO - PROCESS | 18620 | Values: 588.7 591.2 596.5 598.2 606.2 38156.0 39557.0 39604.4 43280.4 43316.6 39753.8 40288.8 40303.0 40375.0 40405.6 7819.7 7946.6 7957.4 7960.7 7966.5 7829.3 7913.4 7914.7 7922.9 7924.3 7934.9 7946.0 7964.5 7972.2 7972.9 7918.0 7955.2 7955.2 7959.4 7962.5 7788.5 7844.4 7866.6 7872.2 7878.1 38411.2 38710.6 38736.4 38798.2 38844.6 2970.6 3143.4 3238.1 3369.6 3376.0 28540.0 28971.0 29088.0 29282.0 30031.0 3160.7 3185.6 3200.2 3222.5 3250.6 248680.0 249304.0 250584.0 250588.0 253199.0 52399.5 52958.5 53059.0 53130.0 53220.3 48907.0 50469.0 60203.4 61598.0 61603.7 14988.6 15105.8 15157.4 15188.0 15208.5 10544.4 10569.6 10621.9 10676.6 10945.4 15819.5 16239.5 16312.3 16782.0 16854.7 5943.3 5991.8 6095.3 6158.2 6170.4 864.6 883.2 894.7 965.0 1000.7 26525.9 27656.3 27873.3 28070.9 28205.0 959.3 964.4 990.9 1027.1 1048.1 14603.3 14971.6 15043.5 15183.8 15202.8 351619.0 353035.0 354606.0 354851.0 355445.0 49472.5 49599.3 49653.8 49705.5 49769.8 1087.6 1107.1 1168.9 1188.5 1213.8 26373.5 27954.3 28584.4 29410.3 29522.7 43923.6 46975.0 47532.8 47671.0 47704.8 339348.0 344076.0 345067.0 345906.0 346233.0 22814.5 24935.3 25065.4 25860.7 25906.9 41855.4 42282.0 42309.8 43012.6 43247.0 36465.5 36615.0 36669.8 36922.4 36968.3 36355.0 36534.3 36679.0 36744.4 37068.6 35461.1 35488.6 35702.5 35850.1 36252.3 31819.8 32413.0 32798.0 32919.5 32919.7 24931.9 25242.0 25372.7 25399.5 25619.2 05:04:34 INFO - PROCESS | 18620 | 05:04:34 INFO - PROCESS | 18620 | [#2] jquery.html Cycles:180 Average:24375.95 Median:27953.38 stddev:65375.49 (233.9%) stddev-sans-first:65534.05 05:04:34 INFO - PROCESS | 18620 | Values: 376.3 381.2 384.2 388.5 389.1 16032.8 17051.7 17491.2 17556.2 17672.2 16554.5 16758.8 16841.3 17044.7 17055.8 4743.6 5058.3 5086.8 5093.2 5113.9 3710.7 3912.2 5713.7 5995.2 5999.5 5790.9 6009.4 6011.2 6040.5 6044.4 5945.1 5960.6 5979.1 5988.2 5996.5 3324.7 4970.3 5226.2 5236.0 5309.1 20094.5 20099.0 20265.7 20760.5 20804.0 1797.4 2021.5 2148.3 2158.9 2381.8 9193.9 9322.0 9444.7 10865.9 13651.5 1721.6 1729.6 1740.8 1748.7 1769.5 63386.7 67662.3 68929.7 69895.0 71684.6 9909.1 9930.5 9965.5 10085.2 10770.6 13808.7 13902.8 13905.7 13928.1 13929.8 7154.7 7228.0 7273.0 7287.9 7364.7 6814.9 6855.4 7092.7 7140.9 7156.9 4297.9 4367.8 4432.1 4447.2 4506.6 1670.4 1752.9 1836.7 1886.0 1899.1 740.8 822.5 854.5 893.0 926.7 16250.9 16440.9 16498.9 16956.4 17072.7 832.7 863.3 877.0 918.2 920.2 8948.3 9052.0 9661.3 10080.0 10646.8 386346.0 392950.0 400305.0 400437.0 400959.0 55820.2 79206.0 80409.0 82943.0 84639.0 929.3 929.6 952.9 957.9 959.0 14325.3 14455.9 15755.8 15802.0 16576.0 32873.5 33584.8 37777.4 38716.8 39309.0 48655.8 48766.0 50371.5 50573.7 50848.5 7571.6 7684.3 7837.8 7853.6 8012.7 10762.6 11601.6 11633.0 11900.6 11980.8 9496.2 9498.3 9648.0 9823.4 9932.6 6360.6 9371.9 10230.5 10360.3 10369.1 9650.0 9969.7 9980.2 10143.3 10167.5 7715.3 7763.3 7773.7 7842.8 7870.5 7568.2 8724.9 9564.1 9723.6 9774.4 05:04:34 INFO - PROCESS | 18620 | 05:04:34 INFO - PROCESS | 18620 | [#3] mootools.html Cycles:180 Average:5096.16 Median:4862.83 stddev:2898.28 (59.6%) stddev-sans-first:2891.96 05:04:34 INFO - PROCESS | 18620 | Values: 1245.2 1355.5 1396.5 1460.3 1668.2 6639.5 7630.2 7813.6 7816.5 7983.3 7721.6 7870.9 7879.8 7888.1 7897.5 2185.0 2207.5 2213.1 2214.0 2218.7 2189.9 2214.7 2215.5 2220.0 2220.2 2169.3 2174.7 2195.3 2195.9 2226.0 2155.8 2158.7 2164.4 2164.8 2165.0 2092.2 2163.4 2164.9 2166.8 2171.2 7648.8 7827.5 7882.0 7882.9 7954.8 4607.3 4717.5 4721.6 4727.5 4727.8 2792.0 2862.4 2899.9 2910.5 2917.9 930.3 950.5 954.0 959.7 964.6 10446.1 10494.5 10536.4 10542.5 10576.0 4040.3 4176.1 4251.9 4258.1 4276.8 8427.1 8465.3 8482.5 8483.7 8485.1 4527.1 4569.9 4571.8 4574.5 4580.2 3770.2 3927.8 4009.7 4188.3 4209.0 3390.8 3443.3 3481.0 3532.1 3565.5 1048.2 1075.9 1090.8 1095.2 1100.7 775.1 776.5 779.2 808.1 812.7 4799.7 4926.0 4931.5 4954.4 5019.5 411.3 415.0 419.4 424.4 424.5 3305.2 3455.4 3463.7 3471.1 3556.5 9486.1 9738.9 9746.5 9818.6 9859.5 9759.0 9766.0 9767.9 9781.7 9785.0 7004.0 7313.7 7426.5 7513.1 7520.8 5240.9 5293.7 5299.2 5317.1 5417.6 8595.6 8851.6 8876.5 8995.2 9043.8 8840.4 9035.8 9065.4 9167.8 9186.3 6157.0 6571.5 6715.1 6830.8 6836.4 7580.9 7638.4 7685.0 7707.6 7708.7 6810.9 6858.3 6996.9 7079.5 7098.1 6834.3 6873.0 6909.3 6930.4 6983.5 6069.5 6093.0 6148.7 6154.2 6173.7 4398.7 4453.3 4484.5 4525.2 4530.2 4423.7 4497.0 4559.4 4560.5 4561.7 05:04:34 INFO - PROCESS | 18620 | 05:04:34 INFO - PROCESS | 18620 | [#4] prototype.html Cycles:180 Average:4084.84 Median:4398.98 stddev:1169.59 (26.6%) stddev-sans-first:1137.75 05:04:34 INFO - PROCESS | 18620 | Values: 294.5 305.2 310.1 312.4 313.7 4704.3 4794.7 4832.6 4875.0 4890.2 4651.5 4808.9 4815.2 4828.3 4836.4 3806.7 3807.4 3813.7 3818.6 3826.7 3575.7 3614.9 3801.2 3812.9 3819.7 3789.1 3791.9 3815.9 3820.9 3823.6 3771.3 3772.4 3776.0 3782.0 3815.6 3391.3 3396.1 3400.8 3401.5 3424.9 4595.0 4674.9 4680.8 4688.5 4755.5 4344.4 4350.7 4362.8 4366.6 4386.0 5053.5 5053.7 5064.8 5079.2 5080.1 3621.9 3649.9 3705.5 3721.4 3742.9 5235.1 5267.9 5290.5 5308.3 5308.3 3752.1 3777.8 3780.9 3804.2 3818.2 3837.6 3837.9 3845.3 3849.8 3869.5 4124.8 4290.8 4316.4 4325.5 4349.5 5002.8 5021.2 5035.7 5039.4 5069.1 1254.9 1276.9 1312.1 1316.4 1320.5 861.9 867.8 873.9 880.5 889.9 4020.9 4027.5 4028.2 4033.5 4035.7 4598.6 4600.9 4625.9 4627.3 4630.6 3939.7 3987.8 4020.8 4024.3 4035.6 2350.9 2419.9 2435.9 2436.9 2445.5 4301.8 4354.4 4368.1 4373.3 4382.7 4720.8 4778.8 4781.6 4790.0 4795.9 4105.9 4372.8 4379.2 4412.0 4422.6 4547.0 4548.9 4555.4 4582.1 4642.0 4514.6 4574.1 4584.8 4592.5 4612.3 4334.7 4335.3 4382.2 4582.8 4930.7 3670.3 3691.3 3698.5 3699.8 3701.7 5036.4 5256.3 5262.2 5262.7 5326.2 4974.6 5060.7 5093.8 5109.1 5119.0 5081.9 5082.6 5096.3 5111.6 5114.5 4824.8 5016.8 5025.9 5068.6 5083.6 5056.9 5089.3 5125.9 5133.4 5135.2 4994.7 4995.2 5006.5 5017.5 5025.9 05:04:34 INFO - PROCESS | 18620 | 05:04:34 INFO - PROCESS | 18620 | [#5] yui.html Cycles:180 Average:17761.61 Median:4180.48 stddev:25215.72 (603.2%) stddev-sans-first:25253.54 05:04:34 INFO - PROCESS | 18620 | Values: 602.3 618.2 707.4 713.8 724.5 12423.1 12831.9 13280.0 13329.1 13362.9 12369.4 12414.9 12419.9 12434.8 13521.1 790.9 798.3 802.3 804.3 805.3 796.7 798.3 798.7 798.9 799.0 839.3 840.6 840.6 841.3 841.7 832.2 835.9 836.5 837.1 837.2 607.4 607.6 608.0 608.3 611.2 12350.5 12361.1 12497.6 12516.9 12524.6 13628.9 13634.4 13682.1 13755.3 14018.8 10761.8 10788.6 10816.9 10845.3 11000.2 3376.3 3380.4 3409.6 3418.1 3480.2 40091.8 59741.1 59755.4 59876.0 59991.1 7572.4 10229.0 10348.2 10497.9 10566.5 17626.4 18011.5 18764.8 19007.3 19042.9 6791.3 6931.7 7116.1 7126.5 7215.5 3844.9 3897.3 3970.8 3981.7 4086.4 2795.7 2907.8 2910.9 2911.3 2914.6 498.3 502.4 510.3 517.2 517.3 507.3 528.4 603.0 626.1 637.8 7685.6 7988.8 8454.0 8696.7 8737.3 619.7 626.7 635.3 637.8 647.5 3955.2 4068.1 4088.8 4165.1 4195.8 97275.5 97498.0 99846.5 101088.5 102241.5 49603.0 86972.6 87570.0 87795.0 89171.0 46970.8 47746.5 48547.3 83616.0 84359.0 8891.9 9260.8 9277.4 9325.9 9414.8 46773.1 47356.8 47447.5 48309.0 51052.5 63779.0 73566.6 75176.0 75233.6 75857.6 11362.5 11431.3 11490.1 11711.8 11999.5 12337.9 13145.8 13563.7 14195.8 14363.8 11249.6 12347.4 12422.9 12468.4 12510.8 12143.0 12579.5 12861.4 12971.1 12978.2 12793.4 12951.9 13098.8 13165.8 13558.1 10186.5 10344.4 10587.6 10856.4 10966.7 10324.9 10538.0 10591.8 10626.5 10747.2 05:04:34 INFO - PROCESS | 18620 | -------- Summary: end -------- 05:04:34 INFO - PROCESS | 18620 | 05:04:34 INFO - TEST-INFO | 18620: exit 0 05:04:34 INFO - TEST-OK | dromaeo_css | took 1118824ms 05:04:34 INFO - TEST-START | kraken 05:04:34 INFO - operating with platform_type : linux_ 05:04:34 INFO - Initialising browser for kraken test... 05:04:34 INFO - TEST-INFO | started process 18797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9aucKh/profile http://localhost:46764/getInfo.html) 05:04:38 INFO - PROCESS | 18797 | __metrics Screen width/height:1600/1200 05:04:38 INFO - PROCESS | 18797 | colorDepth:24 05:04:38 INFO - PROCESS | 18797 | Browser inner width/height: 1024/697 05:04:38 INFO - PROCESS | 18797 | __metrics 05:04:39 INFO - PROCESS | 18797 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:04:40 INFO - TEST-INFO | 18797: exit 0 05:04:40 INFO - Browser initialized. 05:04:40 INFO - Running cycle 1/1 for kraken test... 05:04:40 INFO - TEST-INFO | started process 18877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9aucKh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:52 INFO - PROCESS | 18877 | RSS: Main: 175185920 05:04:52 INFO - PROCESS | 18877 | 05:04:55 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:46764/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46764/tests/kraken/driver.html?testName=audio-beat-detection) 05:04:56 INFO - PROCESS | 18877 | RSS: Main: 233611264 05:04:56 INFO - PROCESS | 18877 | 05:04:59 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:46764/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46764/tests/kraken/driver.html?testName=audio-dft) 05:04:59 INFO - PROCESS | 18877 | RSS: Main: 220643328 05:04:59 INFO - PROCESS | 18877 | 05:05:03 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:46764/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46764/tests/kraken/driver.html?testName=audio-fft) 05:05:03 INFO - PROCESS | 18877 | RSS: Main: 288436224 05:05:03 INFO - PROCESS | 18877 | 05:05:06 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:46764/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46764/tests/kraken/driver.html?testName=audio-oscillator) 05:05:06 INFO - PROCESS | 18877 | RSS: Main: 198602752 05:05:06 INFO - PROCESS | 18877 | 05:05:08 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:46764/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46764/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:05:09 INFO - PROCESS | 18877 | RSS: Main: 203292672 05:05:09 INFO - PROCESS | 18877 | 05:05:12 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:46764/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46764/tests/kraken/driver.html?testName=imaging-darkroom) 05:05:13 INFO - PROCESS | 18877 | RSS: Main: 239640576 05:05:13 INFO - PROCESS | 18877 | 05:05:16 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:46764/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46764/tests/kraken/driver.html?testName=imaging-desaturate) 05:05:17 INFO - PROCESS | 18877 | RSS: Main: 234766336 05:05:17 INFO - PROCESS | 18877 | 05:05:20 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:46764/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46764/tests/kraken/driver.html?testName=json-parse-financial) 05:05:20 INFO - PROCESS | 18877 | RSS: Main: 237645824 05:05:20 INFO - PROCESS | 18877 | 05:05:22 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:46764/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46764/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:05:23 INFO - PROCESS | 18877 | RSS: Main: 225599488 05:05:23 INFO - PROCESS | 18877 | 05:05:25 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:46764/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46764/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:05:25 INFO - PROCESS | 18877 | RSS: Main: 231366656 05:05:25 INFO - PROCESS | 18877 | 05:05:27 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:46764/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46764/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:05:28 INFO - PROCESS | 18877 | RSS: Main: 237821952 05:05:28 INFO - PROCESS | 18877 | 05:05:31 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:46764/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:05:32 INFO - PROCESS | 18877 | RSS: Main: 240906240 05:05:32 INFO - PROCESS | 18877 | 05:05:34 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:46764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:05:35 INFO - PROCESS | 18877 | RSS: Main: 241872896 05:05:35 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:46764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46764/tests/kraken/driver.html?testName=ai-astar) 05:05:37 INFO - PROCESS | 18877 | RSS: Main: 284364800 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | __start_tp_report 05:05:37 INFO - PROCESS | 18877 | _x_x_mozilla_page_load 05:05:37 INFO - PROCESS | 18877 | _x_x_mozilla_page_load_details 05:05:37 INFO - PROCESS | 18877 | |i|pagename|runs| 05:05:37 INFO - PROCESS | 18877 | |0;ai-astar;105;117;116;114;115;113;115;113;114;112 05:05:37 INFO - PROCESS | 18877 | |1;audio-beat-detection;169;133;134;187;134;134;159;140;191;134 05:05:37 INFO - PROCESS | 18877 | |2;audio-dft;162;161;161;162;160;161;161;164;162;162 05:05:37 INFO - PROCESS | 18877 | |3;audio-fft;74;78;76;103;76;76;76;76;99;75 05:05:37 INFO - PROCESS | 18877 | |4;audio-oscillator;86;86;114;85;86;86;118;86;86;127 05:05:37 INFO - PROCESS | 18877 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;116;118 05:05:37 INFO - PROCESS | 18877 | |6;imaging-darkroom;147;146;145;147;147;147;147;148;148;147 05:05:37 INFO - PROCESS | 18877 | |7;imaging-desaturate;95;94;94;95;96;96;94;94;96;95 05:05:37 INFO - PROCESS | 18877 | |8;json-parse-financial;62;63;67;64;65;63;64;63;63;65 05:05:37 INFO - PROCESS | 18877 | |9;json-stringify-tinderbox;65;66;65;65;67;64;65;66;65;65 05:05:37 INFO - PROCESS | 18877 | |10;stanford-crypto-aes;82;82;82;83;89;84;84;83;106;83 05:05:37 INFO - PROCESS | 18877 | |11;stanford-crypto-ccm;139;131;142;132;136;127;136;131;135;131 05:05:37 INFO - PROCESS | 18877 | |12;stanford-crypto-pbkdf2;170;171;169;177;174;175;174;171;171;174 05:05:37 INFO - PROCESS | 18877 | |13;stanford-crypto-sha256-iterative;77;68;71;66;66;67;67;71;68;67 05:05:37 INFO - PROCESS | 18877 | __end_tp_report 05:05:37 INFO - PROCESS | 18877 | __start_cc_report 05:05:37 INFO - PROCESS | 18877 | _x_x_mozilla_cycle_collect,1922 05:05:37 INFO - PROCESS | 18877 | __end_cc_report 05:05:37 INFO - PROCESS | 18877 | __startTimestamp1466683537625__endTimestamp 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | ------- Summary: start ------- 05:05:37 INFO - PROCESS | 18877 | Number of tests: 14 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.50 stddev:3.31 (2.9%) stddev-sans-first:1.58 05:05:37 INFO - PROCESS | 18877 | Values: 105.0 117.0 116.0 114.0 115.0 113.0 115.0 113.0 114.0 112.0 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:149.50 stddev:23.29 (15.6%) stddev-sans-first:23.83 05:05:37 INFO - PROCESS | 18877 | Values: 169.0 133.0 134.0 187.0 134.0 134.0 159.0 140.0 191.0 134.0 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 05:05:37 INFO - PROCESS | 18877 | Values: 162.0 161.0 161.0 162.0 160.0 161.0 161.0 164.0 162.0 162.0 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:10.68 (14.1%) stddev-sans-first:11.03 05:05:37 INFO - PROCESS | 18877 | Values: 74.0 78.0 76.0 103.0 76.0 76.0 76.0 76.0 99.0 75.0 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:86.00 stddev:16.63 (19.3%) stddev-sans-first:17.24 05:05:37 INFO - PROCESS | 18877 | Values: 86.0 86.0 114.0 85.0 86.0 86.0 118.0 86.0 86.0 127.0 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:05:37 INFO - PROCESS | 18877 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 118.0 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 05:05:37 INFO - PROCESS | 18877 | Values: 147.0 146.0 145.0 147.0 147.0 147.0 147.0 148.0 148.0 147.0 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 05:05:37 INFO - PROCESS | 18877 | Values: 95.0 94.0 94.0 95.0 96.0 96.0 94.0 94.0 96.0 95.0 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:1.45 (2.3%) stddev-sans-first:1.36 05:05:37 INFO - PROCESS | 18877 | Values: 62.0 63.0 67.0 64.0 65.0 63.0 64.0 63.0 63.0 65.0 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 05:05:37 INFO - PROCESS | 18877 | Values: 65.0 66.0 65.0 65.0 67.0 64.0 65.0 66.0 65.0 65.0 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:83.00 stddev:7.39 (8.9%) stddev-sans-first:7.71 05:05:37 INFO - PROCESS | 18877 | Values: 82.0 82.0 82.0 83.0 89.0 84.0 84.0 83.0 106.0 83.0 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:135.50 stddev:4.45 (3.3%) stddev-sans-first:4.33 05:05:37 INFO - PROCESS | 18877 | Values: 139.0 131.0 142.0 132.0 136.0 127.0 136.0 131.0 135.0 131.0 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:174.00 stddev:2.55 (1.5%) stddev-sans-first:2.52 05:05:37 INFO - PROCESS | 18877 | Values: 170.0 171.0 169.0 177.0 174.0 175.0 174.0 171.0 171.0 174.0 05:05:37 INFO - PROCESS | 18877 | 05:05:37 INFO - PROCESS | 18877 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.00 stddev:3.39 (5.0%) stddev-sans-first:1.90 05:05:37 INFO - PROCESS | 18877 | Values: 77.0 68.0 71.0 66.0 66.0 67.0 67.0 71.0 68.0 67.0 05:05:37 INFO - PROCESS | 18877 | -------- Summary: end -------- 05:05:37 INFO - PROCESS | 18877 | 05:05:38 INFO - TEST-INFO | 18877: exit 0 05:05:38 INFO - TEST-OK | kraken | took 63755ms 05:05:38 INFO - SUITE-END | took 1182s 05:05:38 INFO - Completed test suite (00:19:42) 05:05:38 INFO - javascript benchmark 05:05:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2606.3093280280723, 2606.9087581934637, 2647.510210611037, 2660.4280079782857, 2663.320853182438, 4740.668153229271, 4793.496682848303, 4807.783649735761, 4810.44679861816, 4854.126257273694, 4827.806887724496, 4843.128236917353, 4850.854474365766, 4865.099956508039, 4871.293662418947, 4366.912661746763, 4411.647068234533, 4431.158079964796, 4474.463064432256, 4591.862244132664, 4484.1031793641405, 4517.299818528117, 4538.410006699124, 4539.500654927955, 4567.155076310876, 4320.589543993331, 4359.193549193409, 4367.3448982652535, 4375.584319489643, 4447.066116115588, 4342.5874541918465, 4358.934615980763, 4362.192994296033, 4469.195544801934, 4493.146302202571, 4372.1255748850035, 4372.519022907478, 4386.385905973167, 4414.602685758265, 4431.534688857688, 4760.928586071212, 4794.041191761627, 4804.279358096279, 4809.927851082237, 4843.878903027417, 5234.659747116425, 5269.525742683139, 5318.016167009116, 5326.573874090102, 5330.440303768088, 5299.390570084451, 5312.840614781563, 5342.0, 5342.332208473941, 5350.063738845725, 4739.66822322441, 4760.809567617256, 4787.952120478821, 4891.070696567641, 4903.313536104948, 5235.05768961583, 5237.921431178535, 5275.920861187085, 5284.630075894727, 5294.2852714883, 5004.574611158092, 5011.223260394645, 5043.445221025758, 5058.241263810458, 5072.644914855925, 5070.138076527, 5134.306868572695, 5150.27896094547, 5184.974075129676, 5187.06632806091, 5119.718415487184, 5137.255098010767, 5139.948600514022, 5143.61422893277, 5158.793648254103, 5158.767855446514, 5159.0, 5160.174372100446, 5164.32863727713, 5197.376314842243, 4348.9130217396105, 4383.868483945486, 4395.296752519582, 4438.423005009393, 4448.799804008828, 3868.0909986153233, 3892.8832135035996, 3897.025743564109, 3910.983144382481, 3913.5695073541888, 4411.801468933906, 4427.026054268056, 4444.799984000728, 4445.555444455528, 4448.421705178371, 5232.581393488512, 5239.423663397023, 5242.449542797951, 5242.9213561796605, 5274.7890084396195, 4447.555244475527, 4452.220861349251, 4458.8439404620685, 4486.506484286726, 4508.098380323949, 4515.435570553681, 4666.95333046672, 4669.0, 4707.952920470751, 4725.64557658177, 4890.266460030882, 4892.902141957141, 4895.437024742129, 4923.704577725348, 4940.382452193476, 5154.329937108152, 5214.739263036909, 5218.243354713622, 5218.765155567932, 5224.05966925957, 4788.090262850047, 4826.61387089025, 4831.299461577981, 4872.731999739906, 4877.3903262092235, 5114.820981265638, 5123.871903202301, 5141.0, 5144.845654630367, 5194.844154675366, 5189.091908916, 5203.126874325316, 5203.19350500673, 5208.0, 5211.1401618734, 4944.48082951285, 5020.3724534433195, 5069.188929771219, 5085.440601533903, 5091.465396133501, 5047.394312682502, 5071.163258062378, 5074.31496747949, 5078.238264260391, 5132.358455193101, 4863.489333619919, 4989.525995030466, 5005.074061298671, 5062.620303477328, 5074.746262686925, 5062.493750624908, 5066.746662666926, 5088.949110508847, 5107.514786095315, 5123.615728820428, 5021.874453138555, 5023.623228257822, 5026.723530205873, 5033.874153146055, 5080.872978175576], "value": 4756.720838170502, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.6762280745589, 591.2402562706923, 596.472122171878, 598.1595857819761, 606.1544145916446, 38156.0, 39557.0, 39604.40593391098, 43280.35079473811, 43316.56683433165, 39753.80123099388, 40288.798556007256, 40303.0, 40375.0, 40405.59594404055, 7819.726309579166, 7946.562939038351, 7957.363410927141, 7960.681572737083, 7966.522008679469, 7829.334506566948, 7913.366930645535, 7914.722984695537, 7922.881156782653, 7924.326432253265, 7934.920650793505, 7945.96027019867, 7964.482308649948, 7972.24263694951, 7972.920270797275, 7918.049834019926, 7955.204479551999, 7955.24425179607, 7959.403044771636, 7962.482438641469, 7788.493747906425, 7844.372450204027, 7866.567338796364, 7872.173421790687, 7878.054633444023, 38411.23177536461, 38710.61289387098, 38736.418953715714, 38798.224035519415, 38844.611553884664, 2970.643522777259, 3143.402753476832, 3238.1095198820276, 3369.629340772513, 3376.0209539233592, 28540.0, 28971.0, 29088.0, 29282.0, 30031.0, 3160.668129846356, 3185.649578546358, 3200.1519597306733, 3222.5166225066428, 3250.626177989514, 248680.0, 249304.0, 250584.0, 250588.0, 253199.0, 52399.47600523946, 52958.470415295356, 53059.0, 53130.0, 53220.27458077975, 48907.0, 50469.0, 60203.39796602065, 61598.0, 61603.6919815407, 14988.550343489713, 15105.773413398807, 15157.393704251706, 15188.0, 15208.467703630542, 10544.420056896945, 10569.577216911392, 10621.946890265499, 10676.62631807883, 10945.398003109905, 15819.52541423759, 16239.457251561083, 16312.34750609986, 16782.0, 16854.662906741796, 5943.31651860033, 5991.760329586855, 6095.299040610386, 6158.1686472326555, 6170.444659980623, 864.5936409887343, 883.1565854608962, 894.7205496140451, 965.0156840023137, 1000.659775676259, 26525.86737066302, 27656.308592284953, 27873.30316742057, 28070.85964570164, 28205.0, 959.2853324273322, 964.4117088575963, 990.8513722941616, 1027.0807627173638, 1048.1091072588392, 14603.342849571794, 14971.635246612288, 15043.548693539211, 15183.772243416357, 15202.847971520365, 351619.0, 353035.0, 354606.0, 354851.0, 355445.0, 49472.50527494679, 49599.256011159865, 49653.751731241115, 49705.50294497081, 49769.75115124401, 1087.5541028178568, 1107.1032463704425, 1168.9181757276908, 1188.494889671886, 1213.8118591618313, 26373.472530549665, 27954.301142471602, 28584.426946631673, 29410.264743381587, 29522.704772951995, 43923.56076439195, 46975.0, 47532.7623361881, 47671.0, 47704.7614761924, 339348.0, 344076.0, 345067.0, 345906.0, 346233.0, 22814.543709126057, 24935.251942441755, 25065.373365666004, 25860.741392585835, 25906.870465647553, 41855.37216941687, 42282.0, 42309.788451058776, 43012.569874300854, 43247.0, 36465.535774101416, 36615.0, 36669.806290211105, 36922.44616330703, 36968.26063478662, 36355.0, 36534.26931461409, 36679.0, 36744.448833268056, 37068.629313706515, 35461.1134721634, 35488.64511354853, 35702.46446303256, 35850.10374740652, 36252.27495450129, 31819.84090079535, 32413.0, 32798.0, 32919.506207406426, 32919.67080329166, 24931.87534062318, 25242.0, 25372.74627253704, 25399.473529103132, 25619.23142305734], "value": 17562.498078153705, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.2944479101685, 381.2089913429633, 384.1510262320274, 388.5279385546564, 389.1477663916024, 16032.759508607365, 17051.658966820687, 17491.212895419703, 17556.20997055134, 17672.20475078621, 16554.503364899043, 16758.83241167588, 16841.32634694611, 17044.659106817857, 17055.82944170558, 4743.644226682995, 5058.266551350052, 5086.804600918781, 5093.2105523643895, 5113.923291150636, 3710.7402481826284, 3912.2175564886993, 5713.657180569158, 5995.190649262359, 5999.520038396918, 5790.913136302937, 6009.429104235112, 6011.158437818709, 6040.546958978072, 6044.365341639109, 5945.108233764949, 5960.552958528085, 5979.133025711291, 5988.19159413478, 5996.460318571328, 3324.6675332466803, 4970.304157417964, 5226.189940559219, 5236.0, 5309.123994540896, 20094.49763755903, 20099.0, 20265.696014559646, 20760.480987975272, 20804.0, 1797.379903933141, 2021.5350469391974, 2148.258850696523, 2158.9244376446904, 2381.833271670984, 9193.908060919372, 9322.0, 9444.716658500256, 10865.945670271678, 13651.453941842314, 1721.638455924245, 1729.5676080979756, 1740.817214192517, 1748.6764948484572, 1769.539919620895, 63386.68306658483, 67662.3233767661, 68929.65535172343, 69895.01049895071, 71684.6415767923, 9909.108180263667, 9930.453825039547, 9965.501724913725, 10085.193184545218, 10770.569177232823, 13808.654783630289, 13902.791458128137, 13905.721885562434, 13928.094673846168, 13929.791053134211, 7154.678039488235, 7227.9638601806655, 7273.0, 7287.8542429152185, 7364.705411783576, 6814.863702725917, 6855.417289530346, 7092.716291348392, 7140.9285907140265, 7156.856862862714, 4297.935530967038, 4367.759773212504, 4432.113577284556, 4447.2439685253585, 4506.639468842484, 1670.3986564836648, 1752.9052781925477, 1836.6969450040594, 1885.9528511787314, 1899.078946710844, 740.8407192453649, 822.5064961023338, 854.4659587757651, 893.0043002052794, 926.6802952981211, 16250.918745406434, 16440.917795410947, 16498.917505412395, 16956.406525771537, 17072.658546828992, 832.7168762620738, 863.326605247895, 876.9824603508022, 918.2103391083663, 920.1718453392001, 8948.284137269004, 9051.954740226389, 9661.275404344702, 10080.0, 10646.787064258671, 386346.0, 392950.0, 400305.0, 400437.0, 400959.0, 55820.16269755957, 79206.0, 80409.0, 82943.0, 84639.0, 929.2612373163352, 929.6049179098856, 952.885653721544, 957.8898426681021, 959.0265880131533, 14325.283735813377, 14455.927720361751, 15755.842441575438, 15802.0, 16576.0, 32873.506897397034, 33584.83207583946, 37777.433338500494, 38716.806415968866, 39309.0, 48655.75672121617, 48766.0, 50371.49628503668, 50573.74713126411, 50848.49151508437, 7571.621418928921, 7684.346830519245, 7837.843243134991, 7853.568053757098, 8012.679492820455, 10762.569497220024, 11601.593944211912, 11633.0, 11900.642980710592, 11980.820287695866, 9496.192823609794, 9498.287628427757, 9648.0, 9823.36148150368, 9932.602695892372, 6360.618362898241, 9371.85942210881, 10230.488475576043, 10360.274780765576, 10369.118624916664, 9650.0, 9969.716289448552, 9980.201583873128, 10143.289969702346, 10167.542460589144, 7715.305622494003, 7763.301302882767, 7773.689052438065, 7842.764717058498, 7870.527768333918, 7568.243175682388, 8724.869126963227, 9564.091411315914, 9723.611055557982, 9774.413535187912], "value": 8211.851234650669, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1245.2466257913957, 1355.4916906160188, 1396.5112210726245, 1460.2917584971287, 1668.1575804218876, 6639.5020373472, 7630.160682324939, 7813.570253636048, 7816.531008139508, 7983.3214176795045, 7721.575313357763, 7870.921290787091, 7879.80300492488, 7888.1323054463965, 7897.486663366877, 2184.967225491619, 2207.5143468437, 2213.103693004336, 2214.047959377467, 2218.6671999200166, 2189.868607883532, 2214.689943407924, 2215.5458131083087, 2219.9556008879813, 2220.200727738013, 2169.2949791317806, 2174.739031316244, 2195.319450970196, 2195.8682479051226, 2225.9888700556476, 2155.7520885098256, 2158.6761985702115, 2164.39396968849, 2164.7726988666277, 2164.956700865982, 2092.225876425717, 2163.372621939636, 2164.8809315487642, 2166.8374871884516, 2171.1966572368324, 7648.808779780495, 7827.452078354518, 7881.96059019707, 7882.921170788276, 7954.761357159295, 4607.308903664443, 4717.504662010508, 4721.5750582447745, 4727.479977202505, 4727.787249573777, 2792.0, 2862.3845873137375, 2899.9275018124504, 2910.519764238898, 2917.9270518237004, 930.2557953637131, 950.4677380666849, 953.9840070325151, 959.7024922274047, 964.60933322004, 10446.112080473169, 10494.475276236157, 10536.367817930948, 10542.472876356229, 10576.0, 4040.3131467649982, 4176.081262122329, 4251.87244382669, 4258.063226090255, 4276.764777937181, 8427.115152908978, 8465.28045116172, 8482.533460659599, 8483.74548763538, 8485.109063548362, 4527.071950250191, 4569.862904112882, 4571.81712731487, 4574.4739354973935, 4580.152671755669, 3770.2271034437877, 3927.7643341399607, 4009.67922566194, 4188.329867221291, 4208.957910420857, 3390.813505257185, 3443.2596991646915, 3480.965190348064, 3532.1346270163463, 3565.53648025755, 1048.208602505119, 1075.887031861659, 1090.7709381030072, 1095.1622009162998, 1100.7358234023777, 775.1202385292621, 776.5146783260462, 779.1662920674823, 808.0787901791962, 812.7439856445201, 4799.66402351832, 4926.0, 4931.5315045070665, 4954.40547134339, 5019.480292728197, 411.28847094526634, 414.98962525937094, 419.36047527520776, 424.36345481777334, 424.51817187491804, 3305.2067503799394, 3455.3607582596796, 3463.653634636516, 3471.0975146461597, 3556.5376501054698, 9486.146246837818, 9738.90261097394, 9746.512674366253, 9818.558164882597, 9859.457729824786, 9758.95120524407, 9765.951170244245, 9767.853482197772, 9781.65764198264, 9784.951075244579, 7004.0, 7313.670884810196, 7426.480146389701, 7513.060867391576, 7520.774376768706, 5240.89518209626, 5293.655912365684, 5299.178627312773, 5317.069512835315, 5417.5665946723375, 8595.570221489026, 8851.557422128997, 8876.467411955304, 8995.23540499065, 9043.819123617359, 8840.425372350777, 9035.774105647148, 9065.410748301603, 9167.816643666956, 9186.265098791948, 6156.969215153896, 6571.5399922005, 6715.059891615276, 6830.829229269308, 6836.38472537474, 7580.924190758022, 7638.427117966064, 7685.03937007874, 7707.576083315472, 7708.653110610148, 6810.931890681228, 6858.3141685831015, 6996.930030699831, 7079.504434689522, 7098.112735908012, 6834.282400347892, 6873.0377747116445, 6909.2745261746795, 6930.3762661360715, 6983.511154219156, 6069.514438844793, 6092.964196086765, 6148.661823599566, 6154.169187159676, 6173.6913154343, 4398.714083584557, 4453.3320001999955, 4484.529124442017, 4525.185466616041, 4530.207213737517, 4423.690341676181, 4497.04850031906, 4559.38448309474, 4560.475545312199, 4561.680682352204], "value": 4019.7523480194986, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.50376116244144, 305.2201624848512, 310.079065176426, 312.35654551623645, 313.7129526483268, 4704.294355846625, 4794.736289504076, 4832.613390928726, 4875.024995001005, 4890.193118135508, 4651.5348465153465, 4808.869915569839, 4815.229563269869, 4828.324034635154, 4836.419629644439, 3806.676432503227, 3807.409851473012, 3813.694904407641, 3818.618138186187, 3826.7321287509885, 3575.66031227033, 3614.945775813365, 3801.2397520495874, 3812.8942606644177, 3819.746349653704, 3789.109559253573, 3791.8862434127022, 3815.8855234342877, 3820.866269680562, 3823.6426068745614, 3771.2646034023514, 3772.4152756322537, 3775.9811200944096, 3782.0, 3815.637514436124, 3391.304782519602, 3396.0660818274923, 3400.843713137545, 3401.5407919930985, 3424.931501369959, 4594.989102397467, 4674.883127921795, 4680.782996420921, 4688.507706690816, 4755.524447555252, 4344.391785150082, 4350.7172033818015, 4362.760048197348, 4366.554729351542, 4385.991222018922, 5053.523773351031, 5053.67151135175, 5064.797408103708, 5079.187330027215, 5080.110980578421, 3621.9315301985976, 3649.908752281214, 3705.5368078990127, 3721.441783732435, 3742.914554779111, 5235.115358470947, 5267.947320526822, 5290.470952904717, 5308.274810686504, 5308.283381743492, 3752.0864359177017, 3777.773333599993, 3780.8676696316047, 3804.2201348723997, 3818.217265460574, 3837.6354246346555, 3837.9232415351535, 3845.250176215611, 3849.825803130072, 3869.5356557212754, 4124.752514849119, 4290.785460726951, 4316.374125751749, 4325.545817689097, 4349.456317960255, 5002.824901128443, 5021.196608542688, 5035.748212589356, 5039.370078740158, 5069.138246498104, 1254.9435275412445, 1276.8914642255327, 1312.1405479411, 1316.3813007886279, 1320.531211419932, 861.8707193920962, 867.7830542364409, 873.9119795854202, 880.4811699817764, 889.9466032037969, 4020.8942540801513, 4027.522569305742, 4028.1742242840146, 4033.5361433434946, 4035.7376770509823, 4598.609118224988, 4600.884977875513, 4625.884352891205, 4627.329037289574, 4630.58324750774, 3939.684825213976, 3987.843525377666, 4020.7736640324983, 4024.335984562573, 4035.5875443594505, 2350.9294721158394, 2419.866907320079, 2435.8660273684764, 2436.878156092224, 2445.5326803917505, 4301.806418711166, 4354.412154359121, 4368.09987655371, 4373.278409062533, 4382.69321147523, 4720.787564559603, 4778.761061946889, 4781.641376896747, 4790.0419916016235, 4795.904081918342, 4105.938410923838, 4372.846950356722, 4379.189849877783, 4411.977795210291, 4422.557744225552, 4546.954530454653, 4548.909021819612, 4555.382839092074, 4582.129395414994, 4641.953580464152, 4514.61625761814, 4574.130915126116, 4584.793684284148, 4592.5177856325945, 4612.262038073892, 4334.653227741836, 4335.328024156261, 4382.211201983673, 4582.793774280232, 4930.728809915489, 3670.302642497917, 3691.3171063352293, 3698.519192504957, 3699.759515631583, 3701.722370822253, 5036.370453693288, 5256.342957130359, 5262.236975638588, 5262.684238945522, 5326.201069839555, 4974.626902982363, 5060.721660308718, 5093.821716239914, 5109.062289183808, 5119.0, 5081.949180508148, 5082.593392528663, 5096.261042148942, 5111.64218504716, 5114.4629813869005, 4824.758762061812, 5016.8210470540125, 5025.924611130763, 5068.569171620454, 5083.567896728671, 5056.873578160576, 5089.26205700164, 5125.92311115341, 5133.358330208724, 5135.229715542699, 4994.650374473752, 4995.200767877122, 5006.49935006511, 5017.498250174954, 5025.949740502694], "value": 3720.5547377648763, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.265236411578, 618.1809102938602, 707.441121514004, 713.8322494213859, 724.453037956343, 12423.130380873332, 12831.935840320786, 13280.0, 13329.133606315583, 13362.933185334059, 12369.381530923463, 12414.875851241484, 12419.937900310508, 12434.813477797818, 13521.121127126755, 790.9090454597723, 798.3413683710933, 802.257911431926, 804.2681160144269, 805.3235282362814, 796.6534557467492, 798.2855344466699, 798.664560884427, 798.924102210292, 799.013218674936, 839.3159574946429, 840.6007146605375, 840.6217202258978, 841.3437518735366, 841.7011960753936, 832.184459229955, 835.908050114487, 836.4981011393177, 837.1210229259253, 837.1921096142191, 607.3653032580963, 607.6384551192034, 608.0392979093023, 608.2822269721727, 611.2390074357409, 12350.5059797608, 12361.07291953107, 12497.56258530956, 12516.937415312956, 12524.561640342545, 13628.86371136286, 13634.386452609557, 13682.110662806886, 13755.31223438834, 14018.789718154236, 10761.83857242142, 10788.622398216103, 10816.945915270451, 10845.349279043283, 11000.174986876016, 3376.2909788944353, 3380.4422270325367, 3409.556757621518, 3418.1454636340914, 3480.1647604574973, 40091.7995410024, 59741.10388344135, 59755.40244597542, 59876.0, 59991.10013349803, 7572.432067594842, 10229.0, 10348.22388320879, 10497.947510262553, 10566.471676416148, 17626.383076592258, 18011.459656210336, 18764.81235187658, 19007.33474328392, 19042.90478547626, 6791.252962174157, 6931.722731090801, 7116.110486189226, 7126.536775109601, 7215.458840586977, 3844.884653460401, 3897.3179693553516, 3970.781607011584, 3981.6814654827544, 4086.4483294755423, 2795.664520257582, 2907.8109922854946, 2910.8690108945148, 2911.2867347499573, 2914.577386278978, 498.33223480536253, 502.4222144533815, 510.3110800419404, 517.1621972404729, 517.2577351500609, 507.28979428799977, 528.4451326107571, 602.9879402411927, 626.0921663587816, 637.764027309889, 7685.615719214017, 7988.760337189894, 8454.027786804596, 8696.739097827076, 8737.257333126756, 619.6994457688018, 626.7461678020318, 635.329727137874, 637.8182218067922, 647.459371424856, 3955.1891862168186, 4068.145689405199, 4088.7751173685137, 4165.146145040259, 4195.811188496525, 97275.51362243143, 97498.0, 99846.5007674957, 101088.49455752822, 102241.48879255557, 49603.0, 86972.56513717391, 87570.0, 87795.0, 89171.0, 46970.82572935636, 47746.52253477421, 48547.271790923165, 83616.0, 84359.0, 8891.866622000805, 9260.814783704423, 9277.350585458953, 9325.906740932774, 9414.764630884283, 46773.06453870972, 47356.763216183695, 47447.52552474431, 48309.03381932412, 51052.48947510626, 63779.0, 73566.63216683883, 75176.0, 75233.6238318805, 75857.62071189609, 11362.54549817998, 11431.314121152425, 11490.08079353633, 11711.824322634997, 11999.460024298753, 12337.938310308391, 13145.802812958005, 13563.728725425633, 14195.787063194268, 14363.784543232068, 11249.550017999189, 12347.3826308686, 12422.875771242172, 12468.438920248429, 12510.812337815121, 12143.02855771554, 12579.496820127093, 12861.356932153169, 12971.09202355826, 12978.221306721249, 12793.424295906892, 12951.870481295067, 13098.803517947428, 13165.802512962122, 13558.11872228302, 10186.541605627914, 10344.431056291976, 10587.629432969808, 10856.402897840695, 10966.725831854268, 10324.896751032393, 10538.0, 10591.788164236827, 10626.468676566295, 10747.172980593474], "value": 6710.617495307664, "unit": "score"}], "name": "dromaeo_css", "value": 6402.151986131236, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 116.0, 114.0, 115.0, 113.0, 115.0, 113.0, 114.0, 112.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 133.0, 134.0, 187.0, 134.0, 134.0, 159.0, 140.0, 191.0, 134.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 160.0, 161.0, 161.0, 164.0, 162.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 76.0, 103.0, 76.0, 76.0, 76.0, 76.0, 99.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 114.0, 85.0, 86.0, 86.0, 118.0, 86.0, 86.0, 127.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 96.0, 96.0, 94.0, 94.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 67.0, 64.0, 65.0, 63.0, 64.0, 63.0, 63.0, 65.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 67.0, 64.0, 65.0, 66.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 83.0, 89.0, 84.0, 84.0, 83.0, 106.0, 83.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 131.0, 142.0, 132.0, 136.0, 127.0, 136.0, 131.0, 135.0, 131.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 169.0, 177.0, 174.0, 175.0, 174.0, 171.0, 171.0, 174.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 68.0, 71.0, 66.0, 66.0, 67.0, 67.0, 71.0, 68.0, 67.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1552.4999999999998, "alertThreshold": 2.0}]} 05:05:38 INFO - Return code: 0 05:05:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:05:38 INFO - # TBPL SUCCESS # 05:05:38 INFO - Running post-action listener: _resource_record_post_action 05:05:38 INFO - ##### 05:05:38 INFO - ##### Finished run-tests step (success) 05:05:38 INFO - ##### 05:05:38 INFO - Running post-run listener: _resource_record_post_run 05:05:39 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 482738176; Read time: 8; Write time: 369912 05:05:39 INFO - TinderboxPrint: CPU usage
13.2% 05:05:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:05:39 INFO - TinderboxPrint: I/O write bytes / time
482,738,176 / 369,912 05:05:39 INFO - TinderboxPrint: CPU idle
8,308.3 (86.8%) 05:05:39 INFO - TinderboxPrint: CPU user
1,221.9 (12.8%) 05:05:39 INFO - TinderboxPrint: Swap in / out
0 / 0 05:05:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 199360512; Read time: 0; Write time: 166488 05:05:39 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283377664; Read time: 8; Write time: 203424 05:05:39 INFO - Running post-run listener: _upload_blobber_files 05:05:39 INFO - Blob upload gear active. 05:05:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:05:39 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 05:05:39 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'] 05:05:39 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 05:05:39 INFO - (blobuploader) - INFO - Open directory for files ... 05:05:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:05:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:05:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:43 INFO - (blobuploader) - INFO - Done attempting. 05:05:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:05:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:05:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:44 INFO - (blobuploader) - INFO - Done attempting. 05:05:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:05:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:05:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:44 INFO - (blobuploader) - INFO - Done attempting. 05:05:44 INFO - (blobuploader) - INFO - Iteration through files over. 05:05:44 INFO - Return code: 0 05:05:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:05:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:05:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5232b68f969497222aa9024cee83a985b32d6ccc87a29bdca701af1cd728b5eac1dfae218eb1e843b90ea2c146f3ee2761319b05fbeb9b4cbbda44015da22a58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/619b1d9a33f8858c87b506d53c8f5379dd6114cbcd38b73c537d0be41b717cbc8a9ebe562ec2d2a4aafbd78aaea3216213c3586b0d5d939153a0170c045a68c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7545a1b723e57bfe9c79b30e0a9a6439329ac8328e55d63a5b7868ec211af90892d89e77d82a291295ce670064b8f63c5715119b46b9545220703b0ed3692029"} 05:05:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:05:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:05:44 INFO - Contents: 05:05:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5232b68f969497222aa9024cee83a985b32d6ccc87a29bdca701af1cd728b5eac1dfae218eb1e843b90ea2c146f3ee2761319b05fbeb9b4cbbda44015da22a58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/619b1d9a33f8858c87b506d53c8f5379dd6114cbcd38b73c537d0be41b717cbc8a9ebe562ec2d2a4aafbd78aaea3216213c3586b0d5d939153a0170c045a68c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7545a1b723e57bfe9c79b30e0a9a6439329ac8328e55d63a5b7868ec211af90892d89e77d82a291295ce670064b8f63c5715119b46b9545220703b0ed3692029"} 05:05:44 INFO - Running post-run listener: copy_logs_to_upload_dir 05:05:44 INFO - Copying logs to upload dir... 05:05:44 INFO - mkdir: /builds/slave/test/build/upload/logs 05:05:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.572592 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-23 05:05:42.973990) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 05:05:42.977496) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559 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/5232b68f969497222aa9024cee83a985b32d6ccc87a29bdca701af1cd728b5eac1dfae218eb1e843b90ea2c146f3ee2761319b05fbeb9b4cbbda44015da22a58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/619b1d9a33f8858c87b506d53c8f5379dd6114cbcd38b73c537d0be41b717cbc8a9ebe562ec2d2a4aafbd78aaea3216213c3586b0d5d939153a0170c045a68c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7545a1b723e57bfe9c79b30e0a9a6439329ac8328e55d63a5b7868ec211af90892d89e77d82a291295ce670064b8f63c5715119b46b9545220703b0ed3692029"} build_url:https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/c8NxG4BHQBep-FfQsXvJnQ/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/5232b68f969497222aa9024cee83a985b32d6ccc87a29bdca701af1cd728b5eac1dfae218eb1e843b90ea2c146f3ee2761319b05fbeb9b4cbbda44015da22a58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/619b1d9a33f8858c87b506d53c8f5379dd6114cbcd38b73c537d0be41b717cbc8a9ebe562ec2d2a4aafbd78aaea3216213c3586b0d5d939153a0170c045a68c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7545a1b723e57bfe9c79b30e0a9a6439329ac8328e55d63a5b7868ec211af90892d89e77d82a291295ce670064b8f63c5715119b46b9545220703b0ed3692029"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 05:05:43.003189) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 05:05:43.003527) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466682299.771228-1593922559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 05:05:43.088190) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 05:05:43.088515) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 05:05:43.088829) ========= ========= Total master_lag: 0.16 =========